builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1467872074.38 results: success (0) buildid: 20160706203028 builduid: be9b689bfcd54ee09c53b8d67e5131cb revision: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.378541) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.379548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.380284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.421721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.422017) ========= 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-1467871944.48709-291881478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 23:14:34-- 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% 228M=0s 2016-07-06 23:14:34 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147078 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.592138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.592470) ========= 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-1467871944.48709-291881478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016071 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.644959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:34.645728) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 --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 c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 --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-1467871944.48709-291881478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 23:14:34,695 truncating revision to first 12 chars 2016-07-06 23:14:34,696 Setting DEBUG logging. 2016-07-06 23:14:34,696 attempt 1/10 2016-07-06 23:14:34,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c0e2702226bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 23:14:34,997 unpacking tar archive at: fx-team-c0e2702226bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667065 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:35.329254) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:35.329607) ========= script_repo_revision: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:35.330076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:35.330409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:14:35.340522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-06 23:14:35.340834) ========= /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-1467871944.48709-291881478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:14:35 INFO - MultiFileLogger online at 20160706 23:14:35 in /builds/slave/test 23:14:35 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 23:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:14:35 INFO - {'append_to_log': False, 23:14:35 INFO - 'base_work_dir': '/builds/slave/test', 23:14:35 INFO - 'blob_upload_branch': 'Fx-Team', 23:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:14:35 INFO - 'branch': 'Fx-Team', 23:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 23:14:35 INFO - 'config_files': ('talos/linux_config.py',), 23:14:35 INFO - 'default_actions': ('clobber', 23:14:35 INFO - 'read-buildbot-config', 23:14:35 INFO - 'download-and-extract', 23:14:35 INFO - 'populate-webroot', 23:14:35 INFO - 'create-virtualenv', 23:14:35 INFO - 'install', 23:14:35 INFO - 'run-tests'), 23:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:14:35 INFO - 'download_minidump_stackwalk': True, 23:14:35 INFO - 'download_symbols': 'ondemand', 23:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 23:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 23:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:14:35 INFO - 'installer_path': 'installer.exe', 23:14:35 INFO - 'log_level': 'info', 23:14:35 INFO - 'log_name': 'talos', 23:14:35 INFO - 'log_to_console': True, 23:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:14:35 INFO - 'opt_config_files': (), 23:14:35 INFO - 'pip_index': False, 23:14:35 INFO - 'sps_profile': False, 23:14:35 INFO - 'sps_profile_interval': 0, 23:14:35 INFO - 'suite': 'dromaeojs', 23:14:35 INFO - 'system_bits': '32', 23:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:14:35 INFO - 'title': 'talos-linux64-ix-037', 23:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:14:35 INFO - 'use_talos_json': True, 23:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:14:35 INFO - 'work_dir': 'build'} 23:14:35 INFO - ##### 23:14:35 INFO - ##### Running clobber step. 23:14:35 INFO - ##### 23:14:35 INFO - Running pre-action listener: _resource_record_pre_action 23:14:35 INFO - Running main action method: clobber 23:14:35 INFO - rmtree: /builds/slave/test/build 23:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:14:35 INFO - Running post-action listener: _resource_record_post_action 23:14:35 INFO - ##### 23:14:35 INFO - ##### Finished clobber step (success) 23:14:35 INFO - ##### 23:14:35 INFO - ##### 23:14:35 INFO - ##### Running read-buildbot-config step. 23:14:35 INFO - ##### 23:14:35 INFO - Running pre-action listener: _resource_record_pre_action 23:14:35 INFO - Running main action method: read_buildbot_config 23:14:35 INFO - Using buildbot properties: 23:14:35 INFO - { 23:14:35 INFO - "project": "", 23:14:35 INFO - "product": "firefox", 23:14:35 INFO - "script_repo_revision": "production", 23:14:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:14:35 INFO - "repository": "", 23:14:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:14:35 INFO - "buildid": "20160706203028", 23:14:35 INFO - "pgo_build": "True", 23:14:35 INFO - "basedir": "/builds/slave/test", 23:14:35 INFO - "buildnumber": 863, 23:14:35 INFO - "slavename": "talos-linux64-ix-037", 23:14:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:14:35 INFO - "platform": "ubuntu64_hw", 23:14:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:14:35 INFO - "branch": "fx-team", 23:14:35 INFO - "repo_path": "integration/fx-team", 23:14:35 INFO - "revision": "c0e2702226bbb18cc6f907e0a6c41e2bc3727e74", 23:14:35 INFO - "stage_platform": "linux64-pgo", 23:14:35 INFO - "builduid": "be9b689bfcd54ee09c53b8d67e5131cb", 23:14:35 INFO - "slavebuilddir": "test" 23:14:35 INFO - } 23:14:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:14:35 INFO - Running post-action listener: _resource_record_post_action 23:14:35 INFO - ##### 23:14:35 INFO - ##### Finished read-buildbot-config step (success) 23:14:35 INFO - ##### 23:14:35 INFO - ##### 23:14:35 INFO - ##### Running download-and-extract step. 23:14:35 INFO - ##### 23:14:35 INFO - Running pre-action listener: _resource_record_pre_action 23:14:35 INFO - Running main action method: download_and_extract 23:14:35 INFO - mkdir: /builds/slave/test/build/tests 23:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:35 INFO - https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:14:41 INFO - Downloaded 1361 bytes. 23:14:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:14:41 INFO - Using the following test package requirements: 23:14:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:14:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:14:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:14:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'jsshell-linux-x86_64.zip'], 23:14:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:14:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:14:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:14:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:14:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:14:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:14:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:41 INFO - https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:14:42 INFO - Downloaded 24302274 bytes. 23:14: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'] 23:14: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 23:14:44 INFO - Return code: 0 23:14:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:14: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')]} 23:14:44 INFO - https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:14:47 INFO - Downloaded 24302274 bytes. 23:14:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:14:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:14:48 INFO - Return code: 0 23:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:48 INFO - https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:14:50 INFO - Downloaded 14403333 bytes. 23:14:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:14:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:14:50 INFO - Return code: 0 23:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:50 INFO - https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:14:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:14:51 INFO - Downloaded 60386105 bytes. 23:14:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:51 INFO - mkdir: /builds/slave/test/properties 23:14:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:14:51 INFO - Writing to file /builds/slave/test/properties/build_url 23:14:51 INFO - Contents: 23:14:51 INFO - build_url:https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:14:52 INFO - Running post-action listener: _resource_record_post_action 23:14:52 INFO - Running post-action listener: set_extra_try_arguments 23:14:52 INFO - ##### 23:14:52 INFO - ##### Finished download-and-extract step (success) 23:14:52 INFO - ##### 23:14:52 INFO - ##### 23:14:52 INFO - ##### Running populate-webroot step. 23:14:52 INFO - ##### 23:14:52 INFO - Running pre-action listener: _resource_record_pre_action 23:14:52 INFO - Running main action method: populate_webroot 23:14:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:14:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:14:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:14:52 INFO - '--tppagecycles', 23:14:52 INFO - '7'], 23:14:52 INFO - 'tests': ['tsvgm']}}, 23:14:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:14:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:14:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:14:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:14:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:14:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:14:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['damp', 'tps']}, 23:14:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'tests': ['damp', 'tps']}, 23:14:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['dromaeo_dom']}, 23:14:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:14:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['basic_compositor_video']}, 23:14:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:14:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['a11yr', 23:14:52 INFO - 'ts_paint', 23:14:52 INFO - 'tpaint', 23:14:52 INFO - 'sessionrestore', 23:14:52 INFO - 'sessionrestore_no_auto_restore', 23:14:52 INFO - 'tabpaint']}, 23:14:52 INFO - 'other-e10s': {'tests': ['a11yr', 23:14:52 INFO - 'ts_paint', 23:14:52 INFO - 'tpaint', 23:14:52 INFO - 'sessionrestore', 23:14:52 INFO - 'sessionrestore_no_auto_restore', 23:14:52 INFO - 'tabpaint']}, 23:14:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:14:52 INFO - 'ts_paint', 23:14:52 INFO - 'tpaint', 23:14:52 INFO - 'sessionrestore', 23:14:52 INFO - 'sessionrestore_no_auto_restore', 23:14:52 INFO - 'tabpaint']}, 23:14:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:14:52 INFO - 'ts_paint', 23:14:52 INFO - 'tpaint', 23:14:52 INFO - 'sessionrestore', 23:14:52 INFO - 'sessionrestore_no_auto_restore', 23:14:52 INFO - 'tabpaint']}, 23:14:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['a11yr', 23:14:52 INFO - 'ts_paint', 23:14:52 INFO - 'tpaint', 23:14:52 INFO - 'sessionrestore', 23:14:52 INFO - 'sessionrestore_no_auto_restore', 23:14:52 INFO - 'tabpaint']}, 23:14:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['a11yr', 23:14:52 INFO - 'ts_paint', 23:14:52 INFO - 'tpaint', 23:14:52 INFO - 'sessionrestore', 23:14:52 INFO - 'sessionrestore_no_auto_restore', 23:14:52 INFO - 'tabpaint']}, 23:14:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['tsvgx', 23:14:52 INFO - 'tsvgr_opacity', 23:14:52 INFO - 'tart', 23:14:52 INFO - 'tscrollx', 23:14:52 INFO - 'cart']}, 23:14:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:14:52 INFO - 'tsvgr_opacity', 23:14:52 INFO - 'tart', 23:14:52 INFO - 'tscrollx', 23:14:52 INFO - 'cart']}, 23:14:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'talos_options': ['--disable-e10s'], 23:14:52 INFO - 'tests': ['tp5o']}, 23:14:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'tests': ['tp5o']}, 23:14:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'talos_options': ['--disable-e10s', 23:14:52 INFO - '--xperf_path', 23:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:14:52 INFO - 'tests': ['tp5n']}, 23:14:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:52 INFO - 'talos_options': ['--xperf_path', 23:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:14:52 INFO - 'tests': ['tp5n']}}, 23:14:52 INFO - 'talos.zip': {'path': '', 23:14:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:14:52 INFO - Running post-action listener: _resource_record_post_action 23:14:52 INFO - ##### 23:14:52 INFO - ##### Finished populate-webroot step (success) 23:14:52 INFO - ##### 23:14:52 INFO - ##### 23:14:52 INFO - ##### Running create-virtualenv step. 23:14:52 INFO - ##### 23:14:52 INFO - Running pre-action listener: _resource_record_pre_action 23:14:52 INFO - Running main action method: create_virtualenv 23:14:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:14:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:14:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:14:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:14:52 INFO - Using real prefix '/usr' 23:14:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:14:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:14:55 INFO - Installing pip.................done. 23:14:55 INFO - Return code: 0 23:14:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:14: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')]} 23:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14: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')]} 23:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:14: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', 'pip>=1.5'] in /builds/slave/test/build 23:14: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 pip>=1.5 23:14:55 INFO - Using env: {'DISPLAY': ':0', 23:14:55 INFO - 'HOME': '/home/cltbld', 23:14:55 INFO - 'LANG': 'en_US.UTF-8', 23:14:55 INFO - 'LANGUAGE': 'en_US:en', 23:14:55 INFO - 'LOGNAME': 'cltbld', 23:14:55 INFO - 'MAIL': '/var/mail/cltbld', 23:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:55 INFO - 'MOZ_NO_REMOTE': '1', 23:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:55 INFO - 'NO_EM_RESTART': '1', 23:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:55 INFO - 'PWD': '/builds/slave/test', 23:14:55 INFO - 'SHELL': '/bin/bash', 23:14:55 INFO - 'SHLVL': '1', 23:14:55 INFO - 'TERM': 'linux', 23:14:55 INFO - 'TMOUT': '86400', 23:14:55 INFO - 'USER': 'cltbld', 23:14:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:55 INFO - '_': '/tools/buildbot/bin/python'} 23:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:14:56 INFO - Cleaning up... 23:14:56 INFO - Return code: 0 23:14:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:56 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 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:14:56 INFO - Using env: {'DISPLAY': ':0', 23:14:56 INFO - 'HOME': '/home/cltbld', 23:14:56 INFO - 'LANG': 'en_US.UTF-8', 23:14:56 INFO - 'LANGUAGE': 'en_US:en', 23:14:56 INFO - 'LOGNAME': 'cltbld', 23:14:56 INFO - 'MAIL': '/var/mail/cltbld', 23:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:56 INFO - 'MOZ_NO_REMOTE': '1', 23:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:56 INFO - 'NO_EM_RESTART': '1', 23:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:56 INFO - 'PWD': '/builds/slave/test', 23:14:56 INFO - 'SHELL': '/bin/bash', 23:14:56 INFO - 'SHLVL': '1', 23:14:56 INFO - 'TERM': 'linux', 23:14:56 INFO - 'TMOUT': '86400', 23:14:56 INFO - 'USER': 'cltbld', 23:14:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:56 INFO - '_': '/tools/buildbot/bin/python'} 23:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:56 INFO - Downloading/unpacking psutil>=3.1.1 23:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:14:58 INFO - Installing collected packages: psutil 23:14:58 INFO - Running setup.py install for psutil 23:14:58 INFO - building 'psutil._psutil_linux' extension 23:14:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:14:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:14:59 INFO - building 'psutil._psutil_posix' extension 23:14:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:15:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:15:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:15:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:15:00 INFO - Successfully installed psutil 23:15:00 INFO - Cleaning up... 23:15:00 INFO - Return code: 0 23:15:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:00 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 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:15:00 INFO - Using env: {'DISPLAY': ':0', 23:15:00 INFO - 'HOME': '/home/cltbld', 23:15:00 INFO - 'LANG': 'en_US.UTF-8', 23:15:00 INFO - 'LANGUAGE': 'en_US:en', 23:15:00 INFO - 'LOGNAME': 'cltbld', 23:15:00 INFO - 'MAIL': '/var/mail/cltbld', 23:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:00 INFO - 'MOZ_NO_REMOTE': '1', 23:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:00 INFO - 'NO_EM_RESTART': '1', 23:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:00 INFO - 'PWD': '/builds/slave/test', 23:15:00 INFO - 'SHELL': '/bin/bash', 23:15:00 INFO - 'SHLVL': '1', 23:15:00 INFO - 'TERM': 'linux', 23:15:00 INFO - 'TMOUT': '86400', 23:15:00 INFO - 'USER': 'cltbld', 23:15:00 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:00 INFO - '_': '/tools/buildbot/bin/python'} 23:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:15: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 23:15: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 23:15: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 23:15: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 23:15: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 23:15: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 23:15:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:15:02 INFO - Installing collected packages: mozsystemmonitor 23:15:02 INFO - Running setup.py install for mozsystemmonitor 23:15:02 INFO - Successfully installed mozsystemmonitor 23:15:02 INFO - Cleaning up... 23:15:02 INFO - Return code: 0 23:15:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:15:02 INFO - Using env: {'DISPLAY': ':0', 23:15:02 INFO - 'HOME': '/home/cltbld', 23:15:02 INFO - 'LANG': 'en_US.UTF-8', 23:15:02 INFO - 'LANGUAGE': 'en_US:en', 23:15:02 INFO - 'LOGNAME': 'cltbld', 23:15:02 INFO - 'MAIL': '/var/mail/cltbld', 23:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:02 INFO - 'MOZ_NO_REMOTE': '1', 23:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:02 INFO - 'NO_EM_RESTART': '1', 23:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:02 INFO - 'PWD': '/builds/slave/test', 23:15:02 INFO - 'SHELL': '/bin/bash', 23:15:02 INFO - 'SHLVL': '1', 23:15:02 INFO - 'TERM': 'linux', 23:15:02 INFO - 'TMOUT': '86400', 23:15:02 INFO - 'USER': 'cltbld', 23:15:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:02 INFO - '_': '/tools/buildbot/bin/python'} 23:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:02 INFO - Downloading/unpacking jsonschema==2.5.1 23:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:15:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:04 INFO - Downloading functools32-3.2.3-2.tar.gz 23:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:15:04 INFO - warning: no files found matching '*.txt' 23:15:04 INFO - no previously-included directories found matching 'build' 23:15:04 INFO - no previously-included directories found matching 'dist' 23:15:04 INFO - no previously-included directories found matching '.git*' 23:15:04 INFO - Installing collected packages: jsonschema, functools32 23:15:04 INFO - Running setup.py install for functools32 23:15:05 INFO - warning: no files found matching '*.txt' 23:15:05 INFO - no previously-included directories found matching 'build' 23:15:05 INFO - no previously-included directories found matching 'dist' 23:15:05 INFO - no previously-included directories found matching '.git*' 23:15:05 INFO - Successfully installed jsonschema functools32 23:15:05 INFO - Cleaning up... 23:15:05 INFO - Return code: 0 23:15:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:15:05 INFO - Using env: {'DISPLAY': ':0', 23:15:05 INFO - 'HOME': '/home/cltbld', 23:15:05 INFO - 'LANG': 'en_US.UTF-8', 23:15:05 INFO - 'LANGUAGE': 'en_US:en', 23:15:05 INFO - 'LOGNAME': 'cltbld', 23:15:05 INFO - 'MAIL': '/var/mail/cltbld', 23:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:05 INFO - 'MOZ_NO_REMOTE': '1', 23:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:05 INFO - 'NO_EM_RESTART': '1', 23:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:05 INFO - 'PWD': '/builds/slave/test', 23:15:05 INFO - 'SHELL': '/bin/bash', 23:15:05 INFO - 'SHLVL': '1', 23:15:05 INFO - 'TERM': 'linux', 23:15:05 INFO - 'TMOUT': '86400', 23:15:05 INFO - 'USER': 'cltbld', 23:15:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:05 INFO - '_': '/tools/buildbot/bin/python'} 23:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:05 INFO - Downloading/unpacking blobuploader==1.2.4 23:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:07 INFO - Downloading blobuploader-1.2.4.tar.gz 23:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:15:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:15:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:07 INFO - Downloading docopt-0.6.1.tar.gz 23:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:15:08 INFO - Installing collected packages: blobuploader, requests, docopt 23:15:08 INFO - Running setup.py install for blobuploader 23:15:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:15:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:15:08 INFO - Running setup.py install for requests 23:15:08 INFO - Running setup.py install for docopt 23:15:08 INFO - Successfully installed blobuploader requests docopt 23:15:08 INFO - Cleaning up... 23:15:08 INFO - Return code: 0 23:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:08 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 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:15:08 INFO - Using env: {'DISPLAY': ':0', 23:15:08 INFO - 'HOME': '/home/cltbld', 23:15:08 INFO - 'LANG': 'en_US.UTF-8', 23:15:08 INFO - 'LANGUAGE': 'en_US:en', 23:15:08 INFO - 'LOGNAME': 'cltbld', 23:15:08 INFO - 'MAIL': '/var/mail/cltbld', 23:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:08 INFO - 'MOZ_NO_REMOTE': '1', 23:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:08 INFO - 'NO_EM_RESTART': '1', 23:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:08 INFO - 'PWD': '/builds/slave/test', 23:15:08 INFO - 'SHELL': '/bin/bash', 23:15:08 INFO - 'SHLVL': '1', 23:15:08 INFO - 'TERM': 'linux', 23:15:08 INFO - 'TMOUT': '86400', 23:15:08 INFO - 'USER': 'cltbld', 23:15:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:08 INFO - '_': '/tools/buildbot/bin/python'} 23:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:08 INFO - Running setup.py (path:/tmp/pip-vsK4t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:08 INFO - Running setup.py (path:/tmp/pip-Yz5DVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:08 INFO - Running setup.py (path:/tmp/pip-xfvLB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:09 INFO - Running setup.py (path:/tmp/pip-lX8gAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:09 INFO - Running setup.py (path:/tmp/pip-HHwBIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:09 INFO - Running setup.py (path:/tmp/pip-PZLMWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:09 INFO - Running setup.py (path:/tmp/pip-pVXgNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:09 INFO - Running setup.py (path:/tmp/pip-AT4z3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:09 INFO - Running setup.py (path:/tmp/pip-E6U7t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:09 INFO - Running setup.py (path:/tmp/pip-oqt6Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:09 INFO - Running setup.py (path:/tmp/pip-LvdMab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:09 INFO - Running setup.py (path:/tmp/pip-rYvU1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:09 INFO - Running setup.py (path:/tmp/pip-INCylF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:09 INFO - Running setup.py (path:/tmp/pip-iednZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:09 INFO - Running setup.py (path:/tmp/pip-7dCCKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:09 INFO - Running setup.py (path:/tmp/pip-6bAsPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:09 INFO - Running setup.py (path:/tmp/pip-o84CD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:15:10 INFO - Running setup.py install for manifestparser 23:15:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Running setup.py install for mozcrash 23:15:10 INFO - Running setup.py install for mozdebug 23:15:10 INFO - Running setup.py install for mozdevice 23:15:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Running setup.py install for mozfile 23:15:10 INFO - Running setup.py install for mozhttpd 23:15:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Running setup.py install for mozinfo 23:15:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Running setup.py install for mozInstall 23:15:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:15:10 INFO - Running setup.py install for mozleak 23:15:10 INFO - Running setup.py install for mozlog 23:15:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:15:11 INFO - Running setup.py install for moznetwork 23:15:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:15:11 INFO - Running setup.py install for mozprocess 23:15:11 INFO - Running setup.py install for mozprofile 23:15:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:15:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:15:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:15:11 INFO - Running setup.py install for mozrunner 23:15:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:15:11 INFO - Running setup.py install for mozscreenshot 23:15:11 INFO - Running setup.py install for moztest 23:15:11 INFO - Running setup.py install for mozversion 23:15:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:15:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:15:11 INFO - Cleaning up... 23:15:11 INFO - Return code: 0 23:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:11 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 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:15:11 INFO - Using env: {'DISPLAY': ':0', 23:15:11 INFO - 'HOME': '/home/cltbld', 23:15:11 INFO - 'LANG': 'en_US.UTF-8', 23:15:11 INFO - 'LANGUAGE': 'en_US:en', 23:15:11 INFO - 'LOGNAME': 'cltbld', 23:15:11 INFO - 'MAIL': '/var/mail/cltbld', 23:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:11 INFO - 'MOZ_NO_REMOTE': '1', 23:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:11 INFO - 'NO_EM_RESTART': '1', 23:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:11 INFO - 'PWD': '/builds/slave/test', 23:15:11 INFO - 'SHELL': '/bin/bash', 23:15:11 INFO - 'SHLVL': '1', 23:15:11 INFO - 'TERM': 'linux', 23:15:11 INFO - 'TMOUT': '86400', 23:15:11 INFO - 'USER': 'cltbld', 23:15:11 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:11 INFO - '_': '/tools/buildbot/bin/python'} 23:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:12 INFO - Running setup.py (path:/tmp/pip-AUY_ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:12 INFO - Running setup.py (path:/tmp/pip-v2cF80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:12 INFO - Running setup.py (path:/tmp/pip-W0MN1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:12 INFO - Running setup.py (path:/tmp/pip-nFSQu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:12 INFO - Running setup.py (path:/tmp/pip-rlGatf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:12 INFO - Running setup.py (path:/tmp/pip-pbJAQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:12 INFO - Running setup.py (path:/tmp/pip-7b7uDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:12 INFO - Running setup.py (path:/tmp/pip-K6sXcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:12 INFO - Running setup.py (path:/tmp/pip-Wz44cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:12 INFO - Running setup.py (path:/tmp/pip-u_O7A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:12 INFO - Running setup.py (path:/tmp/pip-4nL4Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:12 INFO - Running setup.py (path:/tmp/pip-MkJe5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:12 INFO - Running setup.py (path:/tmp/pip-YSw8aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:12 INFO - Running setup.py (path:/tmp/pip-0YjDZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:13 INFO - Running setup.py (path:/tmp/pip-Nj2HK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:13 INFO - Running setup.py (path:/tmp/pip-XDKVWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:13 INFO - Running setup.py (path:/tmp/pip-4XD3CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:15 INFO - Downloading blessings-1.6.tar.gz 23:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:15:15 INFO - Installing collected packages: blessings 23:15:15 INFO - Running setup.py install for blessings 23:15:15 INFO - Successfully installed blessings 23:15:15 INFO - Cleaning up... 23:15:15 INFO - Return code: 0 23:15:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:15 INFO - Reading from file tmpfile_stdout 23:15:15 INFO - Current package versions: 23:15:15 INFO - argparse == 1.2.1 23:15:15 INFO - blessings == 1.6 23:15:15 INFO - blobuploader == 1.2.4 23:15:15 INFO - docopt == 0.6.1 23:15:15 INFO - functools32 == 3.2.3-2 23:15:15 INFO - jsonschema == 2.5.1 23:15:15 INFO - manifestparser == 1.1 23:15:15 INFO - mozInstall == 1.12 23:15:15 INFO - mozcrash == 0.17 23:15:15 INFO - mozdebug == 0.1 23:15:15 INFO - mozdevice == 0.48 23:15:15 INFO - mozfile == 1.2 23:15:15 INFO - mozhttpd == 0.7 23:15:15 INFO - mozinfo == 0.9 23:15:15 INFO - mozleak == 0.1 23:15:15 INFO - mozlog == 3.2 23:15:15 INFO - moznetwork == 0.27 23:15:15 INFO - mozprocess == 0.23 23:15:15 INFO - mozprofile == 0.28 23:15:15 INFO - mozrunner == 6.12 23:15:15 INFO - mozscreenshot == 0.1 23:15:15 INFO - mozsystemmonitor == 0.3 23:15:15 INFO - moztest == 0.7 23:15:15 INFO - mozversion == 1.4 23:15:15 INFO - psutil == 3.1.1 23:15:15 INFO - requests == 1.2.3 23:15:15 INFO - wsgiref == 0.1.2 23:15:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:15 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 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:15:15 INFO - Using env: {'DISPLAY': ':0', 23:15:15 INFO - 'HOME': '/home/cltbld', 23:15:15 INFO - 'LANG': 'en_US.UTF-8', 23:15:15 INFO - 'LANGUAGE': 'en_US:en', 23:15:15 INFO - 'LOGNAME': 'cltbld', 23:15:15 INFO - 'MAIL': '/var/mail/cltbld', 23:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:15 INFO - 'MOZ_NO_REMOTE': '1', 23:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:15 INFO - 'NO_EM_RESTART': '1', 23:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:15 INFO - 'PWD': '/builds/slave/test', 23:15:15 INFO - 'SHELL': '/bin/bash', 23:15:15 INFO - 'SHLVL': '1', 23:15:15 INFO - 'TERM': 'linux', 23:15:15 INFO - 'TMOUT': '86400', 23:15:15 INFO - 'USER': 'cltbld', 23:15:15 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:15 INFO - '_': '/tools/buildbot/bin/python'} 23:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:15:15 INFO - Cleaning up... 23:15:15 INFO - Return code: 0 23:15:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:15 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 0xe31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, '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-1467871944.48709-291881478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:15:15 INFO - Using env: {'DISPLAY': ':0', 23:15:15 INFO - 'HOME': '/home/cltbld', 23:15:15 INFO - 'LANG': 'en_US.UTF-8', 23:15:15 INFO - 'LANGUAGE': 'en_US:en', 23:15:15 INFO - 'LOGNAME': 'cltbld', 23:15:15 INFO - 'MAIL': '/var/mail/cltbld', 23:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:15 INFO - 'MOZ_NO_REMOTE': '1', 23:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:15 INFO - 'NO_EM_RESTART': '1', 23:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:15 INFO - 'PWD': '/builds/slave/test', 23:15:15 INFO - 'SHELL': '/bin/bash', 23:15:15 INFO - 'SHLVL': '1', 23:15:15 INFO - 'TERM': 'linux', 23:15:15 INFO - 'TMOUT': '86400', 23:15:15 INFO - 'USER': 'cltbld', 23:15:15 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:15 INFO - '_': '/tools/buildbot/bin/python'} 23:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:15:16 INFO - Cleaning up... 23:15:16 INFO - Return code: 0 23:15:16 INFO - Running post-action listener: _resource_record_post_action 23:15:16 INFO - Running post-action listener: _start_resource_monitoring 23:15:16 INFO - Starting resource monitoring. 23:15:16 INFO - ##### 23:15:16 INFO - ##### Finished create-virtualenv step (success) 23:15:16 INFO - ##### 23:15:16 INFO - ##### 23:15:16 INFO - ##### Running install step. 23:15:16 INFO - ##### 23:15:16 INFO - Running pre-action listener: _resource_record_pre_action 23:15:16 INFO - Running main action method: install 23:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:16 INFO - Reading from file tmpfile_stdout 23:15:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:15:16 INFO - Reading from file tmpfile_stdout 23:15:16 INFO - Output received: 23:15:16 INFO - Usage: mozinstall [options] installer 23:15:16 INFO - Options: 23:15:16 INFO - -h, --help show this help message and exit 23:15:16 INFO - -d DEST, --destination=DEST 23:15:16 INFO - Directory to install application into. [default: 23:15:16 INFO - "/builds/slave/test"] 23:15:16 INFO - --app=APP Application being installed. [default: firefox] 23:15:16 INFO - mkdir: /builds/slave/test/build/application 23:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:15:33 INFO - Reading from file tmpfile_stdout 23:15:33 INFO - Output received: 23:15:33 INFO - /builds/slave/test/build/application/firefox/firefox 23:15:33 INFO - Running post-action listener: _resource_record_post_action 23:15:33 INFO - ##### 23:15:33 INFO - ##### Finished install step (success) 23:15:33 INFO - ##### 23:15:33 INFO - ##### 23:15:33 INFO - ##### Running run-tests step. 23:15:33 INFO - ##### 23:15:33 INFO - Running pre-action listener: _resource_record_pre_action 23:15:33 INFO - Running main action method: run_tests 23:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:15:33 INFO - Python 2.7.3 23:15:33 INFO - Return code: 0 23:15:33 INFO - grabbing minidump binary from tooltool 23:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:33 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 0x10f03b0>, '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 0x10f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:15:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:15:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:15:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:15:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:15:33 INFO - Return code: 0 23:15:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:15:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:15:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:15:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:15:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:15:33 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/AT_xGFrbR8O4pfz6D2IXag/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 23:15:33 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/AT_xGFrbR8O4pfz6D2IXag/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 23:15:33 INFO - Using env: {'DISPLAY': ':0', 23:15:33 INFO - 'HOME': '/home/cltbld', 23:15:33 INFO - 'LANG': 'en_US.UTF-8', 23:15:33 INFO - 'LANGUAGE': 'en_US:en', 23:15:33 INFO - 'LOGNAME': 'cltbld', 23:15:33 INFO - 'MAIL': '/var/mail/cltbld', 23:15:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:15:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:33 INFO - 'MOZ_NO_REMOTE': '1', 23:15:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:33 INFO - 'NO_EM_RESTART': '1', 23:15:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:33 INFO - 'PWD': '/builds/slave/test', 23:15:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:15:33 INFO - 'SHELL': '/bin/bash', 23:15:33 INFO - 'SHLVL': '1', 23:15:33 INFO - 'TERM': 'linux', 23:15:33 INFO - 'TMOUT': '86400', 23:15:33 INFO - 'USER': 'cltbld', 23:15:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467871944.48709-291881478', 23:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:33 INFO - '_': '/tools/buildbot/bin/python'} 23:15:33 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/AT_xGFrbR8O4pfz6D2IXag/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 23:15:33 INFO - mozversion application_buildid: 20160706203028 23:15:33 INFO - mozversion application_changeset: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 23:15:33 INFO - mozversion application_display_name: Nightly 23:15:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:15:33 INFO - mozversion application_name: Firefox 23:15:33 INFO - mozversion application_remotingname: firefox 23:15:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:15:33 INFO - mozversion application_vendor: Mozilla 23:15:33 INFO - mozversion application_version: 50.0a1 23:15:33 INFO - mozversion platform_buildid: 20160706203028 23:15:33 INFO - mozversion platform_changeset: c0e2702226bbb18cc6f907e0a6c41e2bc3727e74 23:15:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:15:33 INFO - mozversion platform_version: 50.0a1 23:15:33 INFO - using testdate: 1467872133 23:15:33 INFO - actual date: 1467872133 23:15:33 INFO - starting webserver on 'localhost:48733' 23:15:33 INFO - SUITE-START | Running 2 tests 23:15:33 INFO - TEST-START | dromaeo_css 23:15:33 INFO - operating with platform_type : linux_ 23:15:33 INFO - Initialising browser for dromaeo_css test... 23:15:33 INFO - TEST-INFO | started process 3309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqzl6Iv/profile http://localhost:48733/getInfo.html) 23:15:39 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 23:15:39 INFO - PROCESS | 3309 | colorDepth:24 23:15:39 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 23:15:39 INFO - PROCESS | 3309 | __metrics 23:15:40 INFO - PROCESS | 3309 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:15:40 INFO - PROCESS | 3309 | console.error: PushService: 23:15:40 INFO - PROCESS | 3309 | stateChangeProcessEnqueue: Error transitioning state 23:15:40 INFO - PROCESS | 3309 | UnknownError 23:15:41 INFO - TEST-INFO | 3309: exit 0 23:15:41 INFO - Browser initialized. 23:15:41 INFO - Running cycle 1/1 for dromaeo_css test... 23:15:41 INFO - TEST-INFO | started process 3393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqzl6Iv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:15:53 INFO - PROCESS | 3393 | RSS: Main: 156655616 23:15:53 INFO - PROCESS | 3393 | 23:16:43 INFO - PROCESS | 3393 | 1467872203809 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:18:52 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:48733/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48733/tests/dromaeo/cssquery-ext.html) 23:18:53 INFO - PROCESS | 3393 | RSS: Main: 252096512 23:18:53 INFO - PROCESS | 3393 | 23:21:56 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:48733/tests/dromaeo/cssquery-ext.html (next: http://localhost:48733/tests/dromaeo/cssquery-jquery.html) 23:21:56 INFO - PROCESS | 3393 | RSS: Main: 244506624 23:21:56 INFO - PROCESS | 3393 | 23:24:58 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:48733/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48733/tests/dromaeo/cssquery-mootools.html) 23:24:59 INFO - PROCESS | 3393 | RSS: Main: 241655808 23:24:59 INFO - PROCESS | 3393 | 23:28:01 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:48733/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48733/tests/dromaeo/cssquery-prototype.html) 23:28:01 INFO - PROCESS | 3393 | RSS: Main: 239923200 23:28:01 INFO - PROCESS | 3393 | 23:31:04 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:48733/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48733/tests/dromaeo/cssquery-yui.html) 23:31:05 INFO - PROCESS | 3393 | RSS: Main: 223436800 23:31:05 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:48733/tests/dromaeo/cssquery-yui.html (next: http://localhost:48733/tests/dromaeo/cssquery-dojo.html) 23:34:08 INFO - PROCESS | 3393 | RSS: Main: 275337216 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | __start_tp_report 23:34:08 INFO - PROCESS | 3393 | _x_x_mozilla_page_load 23:34:08 INFO - PROCESS | 3393 | _x_x_mozilla_page_load_details 23:34:08 INFO - PROCESS | 3393 | |i|pagename|runs| 23:34:08 INFO - PROCESS | 3393 | |0;dojo.html;3095.5047192449206;3107.285324375395;3120.500719884819;3137.796043257189;3156.6054243219596;5145.279660847485;5255.395629502608;5267.841964741055;5340.572754179666;5342.839714808557;5350.785968561253;5357.732113394334;5366.195070739391;5370.140777475604;5410.431904650014;4847.103285892122;4853.077915196119;4919.975400122994;4938.037082768861;5029.170186919154;4926.581240594536;4936.753162341886;4967.205247160455;4981.427135879384;4989.750512474362;4714.952850471503;4770.30830529573;4844.442889067767;4906.362172917497;4919.065377578248;4889.217725163992;4898.853034408973;4907.2639104134305;4968.324437571714;5021.62337824661;4932.876678083041;4937.259411088329;4969.428515720666;4978.203487442028;5005.299258103868;5153.974230128825;5229.08491014071;5329.920051199235;5335.493128152819;5388.892222155574;5721.599488035839;5744.425557444222;5744.712764361765;5751.05107657236;5753.050746626802;5564.33228012637;5741.827745167651;5786.929418057631;5799.855003624901;5800.535957123462;5272.393674727417;5327.760250788724;5333.973330133324;5360;5409.134538473864;5873.735681894325;5883.970580147157;5894.646321220741;5900.085486749561;5903.734331955073;5449.073657478239;5499.615026948155;5726.026575482178;5777.971110144423;5783.8554036149435;5594.552435805207;5711.942880571224;5716.256886604798;5718.857028574235;5723.341815691166;5624.831255062355;5630.239917611152;5634.070378387521;5637.351704553947;5638.154276858504;5438.075527160392;5641.435856414326;5655.179998900218;5671.404502527258;5723.54211663066;4358.956410435919;4376.387305777193;4386.320120381346;4423.424954755861;4429.069895322018;3893.610638936084;3912.667423268997;3915.9608403915595;3940.704447166474;3958.188571342868;5247.790088396498;5262.052830490548;5392.703401312887;5440.510354068153;5443.972780136153;5733.598648094593;5760.049591817303;5766.452187042224;5772.94227057724;5822.912656310159;5464.890702186013;5466.234727138204;5468.234447177399;5468.507834294853;5471.23402723619;4811.759412029384;4891.804327826847;4948.678335908155;4960.727160006162;5024.171011783088;5936.8812623748145;5938.228030356113;5939.881202376015;5940.673262970492;5942.3166335871065;5750.7987220447085;5762.8847423050465;5763.596548241583;5764.711764411679;5766.019776637898;5645.266115404971;5788.421157884178;5821.505172060253;5826.533877289891;5859.648421094748;5554.222408862682;5558.972205138948;5572.164175373727;5575.135853942646;5579.497845193952;5450.291462109901;5629.88740225185;5687.232223649754;5692.345380281321;5694.202811606296;5486.369067557282;5554.6944918028275;5561.332640083216;5574.91637625444;5585.748641311069;5556.666600004012;5561.749721262472;5568.860778480571;5569.832905012856;5570;5359;5432.158015507603;5476.698781567052;5541.722913854211;5583.106702927512;5575.944240557705;5595.35653399848;5613.831585052455;5638.661680299195;5660.943390566042;5515.61390702663;5522.116461366162;5526.336839579276;5526.696031718294;5531.612787104864 23:34:08 INFO - PROCESS | 3393 | |1;ext.html;592.5111782779205;608.276151379858;611.5199568338853;616.6022915219684;627.4541149200196;32781.83609081954;35180.648193518056;35506.46740298898;35510.2897942041;43694.7815260924;41774.58225417745;46255;46362.768186159105;46397.53602463975;46407.30389044167;9041.186293233624;9214.354995150343;9217.078292170763;9218.723438296862;9227.261819054493;9002.819943601124;9092.318076144316;9097.044810294923;9099.727008189764;9102.681406150787;9066.274698024175;9099.909000909973;9125.863112053292;9139.086091390842;9147.771305717344;9081.954590227073;9088.727338179831;9106.681266155685;9135.13216244459;9141.405808622418;8962.327825413055;9027;9028.277737780962;9031.051739567316;9031.81936361269;42798.78600606977;43103;43150.56849431497;43162;43164.784176079236;3397.915052123692;3406.744494162948;3481.8781342652887;3591.497190393347;4009.498812648419;32306.367387982264;33058.17354566131;33290.667093329;33335.16662083443;33633.66366336354;4107.815148318303;4108.4864391951005;4135.193637240739;4202.600752928497;4207.221663992141;364501;364989;365212;365348;365551.1722441397;57409;57546;57655;57686.134707979414;57709.13436298459;35552.822235888656;35889.461658075146;35949.82025089858;37747.81126094352;37755.24489510195;17750.644987100186;17896.46310610684;17967.910160449115;17986;17986.55033624144;13620.727585448434;13794.93102534481;13799.51701690436;13800.102993305403;13803.861961380459;19528.51178720515;19558.315458958867;19643.60712785736;19723;19808.60382792336;6843.452523798084;6987.790366289019;7014.964925175342;7066.328698773608;7067;949.2121539122512;978.5400861595039;1012.2863381316155;1018.9286749927434;1088.6298658456162;32748.672513274563;32803.835980819946;32949.83525082359;33002.66997330044;33115.50326745101;1099.263493459384;1107.479484642217;1131.971700707489;1150.9079273658087;1186.128195776104;16791.748123778154;17093;17276;17466.65066698659;17520.123993800258;555950;585707;587259;589644;589692;58243.12635310474;58514.41485585175;59022;59066;59066.40933590695;1211.3337664284609;1329.2821876186945;1346.9865301347056;1349.1500354776624;1353.1678018018847;29971.400571988;33886.322273554884;34165.487517687754;34251.657483424846;34589.65410345864;50556.49443505665;50726.49273507218;51191;51215.743921280155;51238.231426529375;324968;325796;326050;326142;326265;27364;28561.42877142487;28628.71371286344;28633.28416789597;28647;47436.288455672504;49397.25904111513;49702.751486242334;49704.75147624239;49923.75038124786;41893.1621367577;41925.79037104795;42174;42661;43718;41726.79136604298;41888;42468;42602.14795704006;42715.78642106769;40759.592404076764;41399;42301.03892727479;42355.576444235165;42371.57628423676;34291.65708342884;36414;36985.44521832228;37359.626403735616;37421.81289093537;28052.797107549934;28190.71809281881;28354.2911427216;28392.716072839008;29828.254293642833 23:34:08 INFO - PROCESS | 3393 | |2;jquery.html;352.56634339762076;378.31713756669217;379.09018355945733;392.284081551169;394.9901252468688;15613.453529126482;17624.911875440637;18227.303110132492;19764.70352944707;20564.48588785281;17744.645107097884;17853.285868565243;17976.4607061788;17987.820121798777;18474;5659.66042037477;5845.181674565564;5862.706864656771;5889;5893.263342082239;5444.455554444564;5765.855853603673;5772.797952071678;5826.475617194452;5832.504237139849;5554.638948468337;5743.167240750089;5777.191193232929;5792.739326730307;5794.942050579503;5757.453041961007;5803.738831752581;5849.444302791249;5855.151003104568;5858.062709966428;5541.168824676331;5548;5635.718214089279;5638.577106716972;5653.773849046033;13884.6604945973;13955.860441395558;14153.646158846112;14165.858341416557;14284.714305713931;2300.5398920216026;2365.503244318695;2382.3448551648435;2383;2910.185148158519;9705.12653861156;10228.284020118595;10511.054005139575;10575;10609.681709548726;1942.1454559993558;2003.1486618187212;2012.4968757810548;2066.2974588639936;2104.2109209046607;75867;81821;81838.18161818365;82109.58945205236;82343;10392.740181495523;10614.628488003038;10647;10693.732656683489;10998.34009959389;14065.789013164811;14092.224927628873;14120.576382708536;14140.43438262458;14169.079009864327;8188.50868947865;8562.272206862363;8590.613422396007;8606.87089693655;8636.093210212963;8301.211384918422;8352.12302708219;8511.659533618586;8578.485290882567;8590.269827064769;4687.39063921688;4720.433547974265;4756.17902471614;4810.302506136591;4858.198397264412;1918.7601549806275;1933.980660193408;1966.3314473078935;1977.2684106880547;1990.9800901990795;861.6251930410292;986.9407835529747;994.5524513968743;1016.9338992965434;1025.1542477456128;19513.902430487757;19835.900820495805;20331.288404905757;20362.89113266044;20392;986.1322036607883;986.921046316293;987.8962708915604;990.0990099009866;1001.5392919257223;10533.534767224633;10934.945325273482;11144.60993865211;11217.214794964437;11312.943435282936;479620;486007;489361;492540;493744;73404.63297683478;83662.58168709239;91413.54293228491;94636;96475;972.0716715536646;985.2561316206219;1005.1556692378583;1007.6019972110975;1007.8913195485054;18171.54571135732;18296.176672049525;18718.344857929907;18752.249910003993;18986.43040708781;43758.12483750371;44844.775776120914;45710.54289457063;46036.76981615071;46236;61608.69195653993;62540.68729656505;63421;64168.67915660392;65042;7453.813654658677;8461.450005749606;8500.489970601784;8522.91477085246;9229.630814767334;12253.326067066397;13979.370928308048;14089.084209526349;14399.568012959628;14585.197814120325;12479.87520124787;12554.435050422935;12572.371381430708;12595.87404125947;12664.556740514037;11523.250988685708;12044.638660840188;12184.51261949512;12267.815982760087;12352.4441400139;12522.561710340095;12765.808512872129;12781.233126012468;12824.29466379358;12834.165779224693;8072.39457040736;8106.351491880518;8230.300424463987;8238.052623948322;8378.120297368932;11555.537778489102;12122.454489547816;12531.812022819482;12922;13022.02334824873 23:34:08 INFO - PROCESS | 3393 | |3;mootools.html;1394.6304229379216;1464.289819437573;1530.2119408504623;1745.075110191599;1774.1750086209918;8354.874676879845;8887.866681999774;8942.016378198394;8943.865842012367;8948.463092214455;7411;8304.46021008634;8458.069612342653;8537.530435826027;8542.91457085429;2216.9556608867815;2243.371855880356;2244.2033078257227;2244.5062086340977;2246.6854640350284;1807.8011418743927;2274.5678321119017;2276.226083131735;2317.281642690763;2318.5594737;2202.570498752744;2265.524239909621;2276.3739971507803;2293.6674182243564;2296.1389478945393;2245.14684419921;2253.504229069602;2266.3767463947383;2287.359539328974;2295.827812914038;2224;2239.9328020159423;2240.283109404991;2250.246167533862;2281.851679640818;8854.070322616097;8890.86663700045;8921.15249051339;8953.059928707456;8984.640614375417;5073.949260507385;5209.947900520984;5220.164773636238;5221.634485586011;5243.711595862264;3137.215696075981;3200.631927328364;3250.479923212298;3259.788113772597;3279.737620990315;1029.1560920045565;1051.3376572759112;1063.2025980514613;1095.6712986104137;1097.1058587251443;12337.444814983257;12438.689032774162;12453.813192802025;12471.688207794878;12480.563180288736;4396.824127034947;4446.644268458515;4652.581267685924;4654;4661.347411362412;10337.173026157889;10368.948155259175;10375.94812025935;10377.429241391645;10435;5228.581713462914;5263.421023687391;5266.47335266478;5267.868303292448;5269.947300526946;4780.282957556325;4820.204666230033;4830.903381932341;4831.73425461596;4867.294242334841;3793.336166170909;3805.8667946621736;3835.7314987951136;3839.827207775657;3928.862489812843;1050.9527071281811;1161.6805378520974;1200.2978257719158;1200.7418405042959;1205.1262834444958;898.6270697660398;951.5670369981642;967.1102585621245;972.5331840716354;991.0337421014598;5810.564207684441;5864.824055278348;6047.213862197974;6061.575689701678;6111.724972376253;957.5978089202551;971.2763990826738;974.2546951582045;1000.5147503460815;1020.9591616335412;4133;4189.853355132555;4216.3464662977285;4219.472565929259;4223.366495025771;10614.628488002883;11028.889711102947;11160.776784464266;11178.049865761339;11179.385133817717;9271.351005429555;10110.595576177018;10580.629677961235;10992.725181870517;10995.780084398268;8116.75649730509;8201.548914809624;8277.58612069394;8281;8291.129431409616;5990.850228744316;6212.285587157354;6216.968915155395;6245.843853903507;6301.4643755279485;10042.14641755459;10121.089101980562;10161.745956351151;10179.49102544855;10213.897861021294;9589.808203836024;10008.749781255527;10047.547860346156;10194.57275981378;10244.129249013917;7438.776836694908;7518;7534.623268836646;7549.7357592483995;7555.282248186413;8260.876086858822;8301.169883011651;8308.584570771558;8334.833303333779;8349.666013359398;6192.97815860378;6360.49116070704;7116.146062472537;7136.678849451683;7535.208803075599;7159;7216.819579510554;7256.4194864411775;7372.631368431665;7402.185759566336;6610.338966103352;6718.395344419026;6741.898871517029;6745.494087943326;6756.932430675827;4863.003084367767;4951.851444456672;4978.228374601942;5014.974925125497;5100.38795344561;5054.848354549369;5127.46161653021;5130.897382052263;5188.221766734869;5328.333958255218 23:34:08 INFO - PROCESS | 3393 | |4;prototype.html;317.2322978392292;325.201629998354;331.3753574512045;334.0329745387106;335.7918090783713;5396.622236443451;5402.567794576435;5434.945650543494;5435.347758269008;5454.072807622703;5046.21783623538;5173.586113110951;5321.388040375358;5330.440303768107;5375.81184658537;4162.43807086044;4227.8097485613225;4233.407322974786;4242.321228603431;4244.978775106136;4212.641925436326;4235.957640423587;4250.234957707611;4254.680898932577;4256.1913236485125;3994.980025099885;4065.512138543364;4074.409210664452;4151.526208196092;4155.750654960697;4142.91714165718;4168.624823765876;4176.812043458051;4177.958220417788;4181.289180839264;3671.522702048743;3686.8340924658455;3689.4834723138783;3690.0959264979983;3692.984429281942;5094.6433749637545;5159.890623515925;5178.223266510016;5213.191955246943;5269.841904742864;4747.1486120413065;4755.548222918817;4758.928616070727;4772.880677983044;4783.7129772213775;5545.223668686387;5564.360098588633;5610.597350662334;5622.690752008638;5633.971830140864;3829;4010.7593544387137;4012.7191096623246;4021.698372622036;4054.0878302382025;5801.274840644919;5813.651180929158;5836.416358364172;5853.209816674737;5903.79336723217;4156.771377574202;4156.916861662749;4159.230542349675;4160.271952408317;4161.729487583298;4075;4115;4116;4141.813618387119;4203.4115223868685;4688.320193571981;4746.247176637542;4752.120857641278;4759.428868535798;4762.738049407316;5621.8594535136135;5663;5684.175794509855;5684.459976302244;5693.658380497101;1383.8546952570036;1403.8245219347582;1428.6285565752978;1442.502336693839;1448.797498076594;997.586001809241;1011.7925825205815;1018.4551265073151;1030.5877648940334;1036.445332001997;5307.310049693592;5318.803269264385;5349.22436246742;5370.301860758076;5379.67721936685;5674.120511320752;5674.2339784129435;5679.346875109332;5686.829395118153;5694.4590263924865;5131.923021154611;5347.572194224531;5352.4915133062295;5363.410024897258;5401.756920938567;3006.1432491739747;3031.863566139529;3032.0297504798255;3035.6357237131688;3050.34417600217;5822.301323841081;5866.501347385435;5868.471837534642;5886.852828679232;5908.14331921869;5612.859678507988;5830.883382332329;5917.881642367214;5939.732712027882;5951.494122999594;5933.970330148408;5956.821295361146;5962.0460726284455;5966.671833049224;5992.760289588367;5616.522595579258;5814.674130347895;5835.824925252249;5839.854003649943;5841.32824725162;5758.683272420057;5778.335491418541;5788;5795.015566982923;5797.594168408171;6019.879602408015;6039.577229593886;6049.092636104443;6054.576179667381;6069.453749162597;3898.902527436837;4018.9397159043224;4099.8975025624595;4139.793010349531;4151.8339266429;5806.44838740319;5821.330546986981;5832.883342333044;5839.883202336015;5849.356570777126;5454.181872719124;5538.307711536058;5632.436756324335;5650.915236271541;5660.660360378391;5555.666660000413;5611.699203326616;5629.605927585029;5649.661020338793;5663.575231857545;5314.202869569595;5526.834194974157;5568.638038527482;5572.384008637449;5587.49137732818;5630.718464076862;5657.660540367591;5662.858428539154;5670.177824215548;5674.262345895172;5508.807191748269;5526.47498487643;5533.612647114664;5540.584456165884;5544.584156188383 23:34:08 INFO - PROCESS | 3393 | |5;yui.html;690.5097380859589;717.7631381644057;754.8528037032777;778.7663700889733;806.9717559885402;15441.845581544181;16727.563541848904;16912.661746765087;17091.82908170918;17140;15175.92412037941;15228.771568426482;15294.694106117871;15344.156071416068;15384.538463846075;650.3983814971157;665.8834703926817;666.3902529185789;785.2343964634479;805.1827395193883;647.0165348670018;782.2334112569686;806.3226889412892;816.1185919207271;822.4653974916292;858.3390789092426;860.2000139869918;860.5181098584782;861.8750281209221;862.1292494580456;686.6086330791451;855.6791203298794;855.6962278391206;855.9429105055252;855.9614817333204;599.4544964082708;611.7155522681929;613.101805854421;613.1814028272262;615.5414216408759;14836.406543738238;14925.328360223815;14926.62683432912;14939.103653780809;14973.925130374388;13871;14544.345504452325;14569.125852448888;14603.342849571794;14766.926165369105;12798.872011279862;13001;13021.0234232432;13110.737785244337;13195.60413187606;4565.657575681837;4576.977115114403;4586.495485496593;4589.655775816827;4592.357070010201;67129.32870671329;69836;70050;75733;82116;10854.18593605467;10913.017828395483;10945.726356841144;11614.419279036183;12454.688632784071;19422.611547768967;20239.4940126498;20260;21176.25883094115;21239;8729.258013068833;8839.513826739463;8871.955640221757;9060.909390906138;9215;4850.7817148227705;4990.151674215392;5079.6698214615935;5104.3874735031295;5175.870603234874;3287.539744435781;3402.4045791986305;3405.557277553902;3405.8126803025575;3406.9488957665653;633.1642232253381;641.4547634510628;648.2901223160632;649.3506493506494;650.0898741761572;668.2982867988593;737.1044181319722;750.9962450187824;803.2048272210586;805.642477524467;9960.900390996143;10170.351396383985;10289.53697083633;10296.22778291631;10761.515731792088;642.2613993907045;663.9402453779087;714.6319645382632;724.485615213194;729.3545212486881;4999.900002000012;5027.8548751022845;5029.497050295015;5045.192769156917;5082.644214904921;120593;121285;121565.78434215544;123119.38440307921;123783;103025.48487257515;103841.48079259555;104846.47576762068;106335;106674.46662766636;77707;82252;86797;88069;90201;9895.356801807859;9980.991431215874;9991.150752186146;10073.496325183565;10329.74175645615;51374;51461.48538514716;53079.469205307454;53101.46898530965;54171.729141354044;71311.64344178246;80225.59887200527;80701.59649201951;80784.19215807767;81146.56560303201;12398.752024959631;12564;12746.745065098461;13310.068295219242;13312.134711243738;14079.0848594841;14113.08264962774;14200.857991420367;15169.469068582988;15661.138637374597;14554.636134096732;14666.34001469915;15210.695786084438;15567.844321557093;15586;14439.422423102958;14481.131132132106;14548.345324460637;14551.126932384092;14650.487232946796;14097.647558811112;14182.290885455479;14378;14838.258087095386;14866.554003379915;11462.312261264351;11932.568091829036;12084.395780210778;12548.560800372308;12561.371931403575;11155.107591392507;11421.31472111676;11446.885531144582;11557.595484158013;11562.190646654653 23:34:08 INFO - PROCESS | 3393 | __end_tp_report 23:34:08 INFO - PROCESS | 3393 | __start_cc_report 23:34:08 INFO - PROCESS | 3393 | _x_x_mozilla_cycle_collect,826 23:34:08 INFO - PROCESS | 3393 | __end_cc_report 23:34:08 INFO - PROCESS | 3393 | __startTimestamp1467873248309__endTimestamp 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | ------- Summary: start ------- 23:34:08 INFO - PROCESS | 3393 | Number of tests: 6 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | [#0] dojo.html Cycles:165 Average:5310.45 Median:5499.62 stddev:586.14 (10.7%) stddev-sans-first:561.59 23:34:08 INFO - PROCESS | 3393 | Values: 3095.5 3107.3 3120.5 3137.8 3156.6 5145.3 5255.4 5267.8 5340.6 5342.8 5350.8 5357.7 5366.2 5370.1 5410.4 4847.1 4853.1 4920.0 4938.0 5029.2 4926.6 4936.8 4967.2 4981.4 4989.8 4715.0 4770.3 4844.4 4906.4 4919.1 4889.2 4898.9 4907.3 4968.3 5021.6 4932.9 4937.3 4969.4 4978.2 5005.3 5154.0 5229.1 5329.9 5335.5 5388.9 5721.6 5744.4 5744.7 5751.1 5753.1 5564.3 5741.8 5786.9 5799.9 5800.5 5272.4 5327.8 5334.0 5360.0 5409.1 5873.7 5884.0 5894.6 5900.1 5903.7 5449.1 5499.6 5726.0 5778.0 5783.9 5594.6 5711.9 5716.3 5718.9 5723.3 5624.8 5630.2 5634.1 5637.4 5638.2 5438.1 5641.4 5655.2 5671.4 5723.5 4359.0 4376.4 4386.3 4423.4 4429.1 3893.6 3912.7 3916.0 3940.7 3958.2 5247.8 5262.1 5392.7 5440.5 5444.0 5733.6 5760.0 5766.5 5772.9 5822.9 5464.9 5466.2 5468.2 5468.5 5471.2 4811.8 4891.8 4948.7 4960.7 5024.2 5936.9 5938.2 5939.9 5940.7 5942.3 5750.8 5762.9 5763.6 5764.7 5766.0 5645.3 5788.4 5821.5 5826.5 5859.6 5554.2 5559.0 5572.2 5575.1 5579.5 5450.3 5629.9 5687.2 5692.3 5694.2 5486.4 5554.7 5561.3 5574.9 5585.7 5556.7 5561.7 5568.9 5569.8 5570.0 5359.0 5432.2 5476.7 5541.7 5583.1 5575.9 5595.4 5613.8 5638.7 5660.9 5515.6 5522.1 5526.3 5526.7 5531.6 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | [#1] ext.html Cycles:180 Average:58420.92 Median:22767.10 stddev:116609.45 (512.2%) stddev-sans-first:116855.74 23:34:08 INFO - PROCESS | 3393 | Values: 592.5 608.3 611.5 616.6 627.5 32781.8 35180.6 35506.5 35510.3 43694.8 41774.6 46255.0 46362.8 46397.5 46407.3 9041.2 9214.4 9217.1 9218.7 9227.3 9002.8 9092.3 9097.0 9099.7 9102.7 9066.3 9099.9 9125.9 9139.1 9147.8 9082.0 9088.7 9106.7 9135.1 9141.4 8962.3 9027.0 9028.3 9031.1 9031.8 42798.8 43103.0 43150.6 43162.0 43164.8 3397.9 3406.7 3481.9 3591.5 4009.5 32306.4 33058.2 33290.7 33335.2 33633.7 4107.8 4108.5 4135.2 4202.6 4207.2 364501.0 364989.0 365212.0 365348.0 365551.2 57409.0 57546.0 57655.0 57686.1 57709.1 35552.8 35889.5 35949.8 37747.8 37755.2 17750.6 17896.5 17967.9 17986.0 17986.6 13620.7 13794.9 13799.5 13800.1 13803.9 19528.5 19558.3 19643.6 19723.0 19808.6 6843.5 6987.8 7015.0 7066.3 7067.0 949.2 978.5 1012.3 1018.9 1088.6 32748.7 32803.8 32949.8 33002.7 33115.5 1099.3 1107.5 1132.0 1150.9 1186.1 16791.7 17093.0 17276.0 17466.7 17520.1 555950.0 585707.0 587259.0 589644.0 589692.0 58243.1 58514.4 59022.0 59066.0 59066.4 1211.3 1329.3 1347.0 1349.2 1353.2 29971.4 33886.3 34165.5 34251.7 34589.7 50556.5 50726.5 51191.0 51215.7 51238.2 324968.0 325796.0 326050.0 326142.0 326265.0 27364.0 28561.4 28628.7 28633.3 28647.0 47436.3 49397.3 49702.8 49704.8 49923.8 41893.2 41925.8 42174.0 42661.0 43718.0 41726.8 41888.0 42468.0 42602.1 42715.8 40759.6 41399.0 42301.0 42355.6 42371.6 34291.7 36414.0 36985.4 37359.6 37421.8 28052.8 28190.7 28354.3 28392.7 29828.3 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | [#2] jquery.html Cycles:180 Average:28930.51 Median:365.44 stddev:80526.95 (22035.5%) stddev-sans-first:80724.26 23:34:08 INFO - PROCESS | 3393 | Values: 352.6 378.3 379.1 392.3 395.0 15613.5 17624.9 18227.3 19764.7 20564.5 17744.6 17853.3 17976.5 17987.8 18474.0 5659.7 5845.2 5862.7 5889.0 5893.3 5444.5 5765.9 5772.8 5826.5 5832.5 5554.6 5743.2 5777.2 5792.7 5794.9 5757.5 5803.7 5849.4 5855.2 5858.1 5541.2 5548.0 5635.7 5638.6 5653.8 13884.7 13955.9 14153.6 14165.9 14284.7 2300.5 2365.5 2382.3 2383.0 2910.2 9705.1 10228.3 10511.1 10575.0 10609.7 1942.1 2003.1 2012.5 2066.3 2104.2 75867.0 81821.0 81838.2 82109.6 82343.0 10392.7 10614.6 10647.0 10693.7 10998.3 14065.8 14092.2 14120.6 14140.4 14169.1 8188.5 8562.3 8590.6 8606.9 8636.1 8301.2 8352.1 8511.7 8578.5 8590.3 4687.4 4720.4 4756.2 4810.3 4858.2 1918.8 1934.0 1966.3 1977.3 1991.0 861.6 986.9 994.6 1016.9 1025.2 19513.9 19835.9 20331.3 20362.9 20392.0 986.1 986.9 987.9 990.1 1001.5 10533.5 10934.9 11144.6 11217.2 11312.9 479620.0 486007.0 489361.0 492540.0 493744.0 73404.6 83662.6 91413.5 94636.0 96475.0 972.1 985.3 1005.2 1007.6 1007.9 18171.5 18296.2 18718.3 18752.2 18986.4 43758.1 44844.8 45710.5 46036.8 46236.0 61608.7 62540.7 63421.0 64168.7 65042.0 7453.8 8461.5 8500.5 8522.9 9229.6 12253.3 13979.4 14089.1 14399.6 14585.2 12479.9 12554.4 12572.4 12595.9 12664.6 11523.3 12044.6 12184.5 12267.8 12352.4 12522.6 12765.8 12781.2 12824.3 12834.2 8072.4 8106.4 8230.3 8238.1 8378.1 11555.5 12122.5 12531.8 12922.0 13022.0 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | [#3] mootools.html Cycles:180 Average:5714.27 Median:4800.24 stddev:3275.95 (68.2%) stddev-sans-first:3269.06 23:34:08 INFO - PROCESS | 3393 | Values: 1394.6 1464.3 1530.2 1745.1 1774.2 8354.9 8887.9 8942.0 8943.9 8948.5 7411.0 8304.5 8458.1 8537.5 8542.9 2217.0 2243.4 2244.2 2244.5 2246.7 1807.8 2274.6 2276.2 2317.3 2318.6 2202.6 2265.5 2276.4 2293.7 2296.1 2245.1 2253.5 2266.4 2287.4 2295.8 2224.0 2239.9 2240.3 2250.2 2281.9 8854.1 8890.9 8921.2 8953.1 8984.6 5073.9 5209.9 5220.2 5221.6 5243.7 3137.2 3200.6 3250.5 3259.8 3279.7 1029.2 1051.3 1063.2 1095.7 1097.1 12337.4 12438.7 12453.8 12471.7 12480.6 4396.8 4446.6 4652.6 4654.0 4661.3 10337.2 10368.9 10375.9 10377.4 10435.0 5228.6 5263.4 5266.5 5267.9 5269.9 4780.3 4820.2 4830.9 4831.7 4867.3 3793.3 3805.9 3835.7 3839.8 3928.9 1051.0 1161.7 1200.3 1200.7 1205.1 898.6 951.6 967.1 972.5 991.0 5810.6 5864.8 6047.2 6061.6 6111.7 957.6 971.3 974.3 1000.5 1021.0 4133.0 4189.9 4216.3 4219.5 4223.4 10614.6 11028.9 11160.8 11178.0 11179.4 9271.4 10110.6 10580.6 10992.7 10995.8 8116.8 8201.5 8277.6 8281.0 8291.1 5990.9 6212.3 6217.0 6245.8 6301.5 10042.1 10121.1 10161.7 10179.5 10213.9 9589.8 10008.7 10047.5 10194.6 10244.1 7438.8 7518.0 7534.6 7549.7 7555.3 8260.9 8301.2 8308.6 8334.8 8349.7 6193.0 6360.5 7116.1 7136.7 7535.2 7159.0 7216.8 7256.4 7372.6 7402.2 6610.3 6718.4 6741.9 6745.5 6756.9 4863.0 4951.9 4978.2 5015.0 5100.4 5054.8 5127.5 5130.9 5188.2 5328.3 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | [#4] prototype.html Cycles:180 Average:4733.54 Median:5366.86 stddev:1392.63 (25.9%) stddev-sans-first:1356.51 23:34:08 INFO - PROCESS | 3393 | Values: 317.2 325.2 331.4 334.0 335.8 5396.6 5402.6 5434.9 5435.3 5454.1 5046.2 5173.6 5321.4 5330.4 5375.8 4162.4 4227.8 4233.4 4242.3 4245.0 4212.6 4236.0 4250.2 4254.7 4256.2 3995.0 4065.5 4074.4 4151.5 4155.8 4142.9 4168.6 4176.8 4178.0 4181.3 3671.5 3686.8 3689.5 3690.1 3693.0 5094.6 5159.9 5178.2 5213.2 5269.8 4747.1 4755.5 4758.9 4772.9 4783.7 5545.2 5564.4 5610.6 5622.7 5634.0 3829.0 4010.8 4012.7 4021.7 4054.1 5801.3 5813.7 5836.4 5853.2 5903.8 4156.8 4156.9 4159.2 4160.3 4161.7 4075.0 4115.0 4116.0 4141.8 4203.4 4688.3 4746.2 4752.1 4759.4 4762.7 5621.9 5663.0 5684.2 5684.5 5693.7 1383.9 1403.8 1428.6 1442.5 1448.8 997.6 1011.8 1018.5 1030.6 1036.4 5307.3 5318.8 5349.2 5370.3 5379.7 5674.1 5674.2 5679.3 5686.8 5694.5 5131.9 5347.6 5352.5 5363.4 5401.8 3006.1 3031.9 3032.0 3035.6 3050.3 5822.3 5866.5 5868.5 5886.9 5908.1 5612.9 5830.9 5917.9 5939.7 5951.5 5934.0 5956.8 5962.0 5966.7 5992.8 5616.5 5814.7 5835.8 5839.9 5841.3 5758.7 5778.3 5788.0 5795.0 5797.6 6019.9 6039.6 6049.1 6054.6 6069.5 3898.9 4018.9 4099.9 4139.8 4151.8 5806.4 5821.3 5832.9 5839.9 5849.4 5454.2 5538.3 5632.4 5650.9 5660.7 5555.7 5611.7 5629.6 5649.7 5663.6 5314.2 5526.8 5568.6 5572.4 5587.5 5630.7 5657.7 5662.9 5670.2 5674.3 5508.8 5526.5 5533.6 5540.6 5544.6 23:34:08 INFO - PROCESS | 3393 | 23:34:08 INFO - PROCESS | 3393 | [#5] yui.html Cycles:180 Average:21438.69 Median:3986.30 stddev:30961.05 (776.7%) stddev-sans-first:31008.71 23:34:08 INFO - PROCESS | 3393 | Values: 690.5 717.8 754.9 778.8 807.0 15441.8 16727.6 16912.7 17091.8 17140.0 15175.9 15228.8 15294.7 15344.2 15384.5 650.4 665.9 666.4 785.2 805.2 647.0 782.2 806.3 816.1 822.5 858.3 860.2 860.5 861.9 862.1 686.6 855.7 855.7 855.9 856.0 599.5 611.7 613.1 613.2 615.5 14836.4 14925.3 14926.6 14939.1 14973.9 13871.0 14544.3 14569.1 14603.3 14766.9 12798.9 13001.0 13021.0 13110.7 13195.6 4565.7 4577.0 4586.5 4589.7 4592.4 67129.3 69836.0 70050.0 75733.0 82116.0 10854.2 10913.0 10945.7 11614.4 12454.7 19422.6 20239.5 20260.0 21176.3 21239.0 8729.3 8839.5 8872.0 9060.9 9215.0 4850.8 4990.2 5079.7 5104.4 5175.9 3287.5 3402.4 3405.6 3405.8 3406.9 633.2 641.5 648.3 649.4 650.1 668.3 737.1 751.0 803.2 805.6 9960.9 10170.4 10289.5 10296.2 10761.5 642.3 663.9 714.6 724.5 729.4 4999.9 5027.9 5029.5 5045.2 5082.6 120593.0 121285.0 121565.8 123119.4 123783.0 103025.5 103841.5 104846.5 106335.0 106674.5 77707.0 82252.0 86797.0 88069.0 90201.0 9895.4 9981.0 9991.2 10073.5 10329.7 51374.0 51461.5 53079.5 53101.5 54171.7 71311.6 80225.6 80701.6 80784.2 81146.6 12398.8 12564.0 12746.7 13310.1 13312.1 14079.1 14113.1 14200.9 15169.5 15661.1 14554.6 14666.3 15210.7 15567.8 15586.0 14439.4 14481.1 14548.3 14551.1 14650.5 14097.6 14182.3 14378.0 14838.3 14866.6 11462.3 11932.6 12084.4 12548.6 12561.4 11155.1 11421.3 11446.9 11557.6 11562.2 23:34:08 INFO - PROCESS | 3393 | -------- Summary: end -------- 23:34:08 INFO - PROCESS | 3393 | 23:34:09 INFO - TEST-INFO | 3393: exit 0 23:34:09 INFO - TEST-OK | dromaeo_css | took 1115184ms 23:34:09 INFO - TEST-START | kraken 23:34:09 INFO - operating with platform_type : linux_ 23:34:09 INFO - Initialising browser for kraken test... 23:34:09 INFO - TEST-INFO | started process 3585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJ4DZ6/profile http://localhost:48733/getInfo.html) 23:34:13 INFO - PROCESS | 3585 | __metrics Screen width/height:1600/1200 23:34:13 INFO - PROCESS | 3585 | colorDepth:24 23:34:13 INFO - PROCESS | 3585 | Browser inner width/height: 1024/697 23:34:13 INFO - PROCESS | 3585 | __metrics 23:34:14 INFO - PROCESS | 3585 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:34:15 INFO - TEST-INFO | 3585: exit 0 23:34:15 INFO - Browser initialized. 23:34:15 INFO - Running cycle 1/1 for kraken test... 23:34:15 INFO - TEST-INFO | started process 3669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJ4DZ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:34:27 INFO - PROCESS | 3669 | RSS: Main: 158044160 23:34:27 INFO - PROCESS | 3669 | 23:34:29 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48733/tests/kraken/driver.html?testName=audio-beat-detection) 23:34:30 INFO - PROCESS | 3669 | RSS: Main: 215638016 23:34:30 INFO - PROCESS | 3669 | 23:34:33 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48733/tests/kraken/driver.html?testName=audio-dft) 23:34:33 INFO - PROCESS | 3669 | RSS: Main: 203370496 23:34:33 INFO - PROCESS | 3669 | 23:34:36 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48733/tests/kraken/driver.html?testName=audio-fft) 23:34:37 INFO - PROCESS | 3669 | RSS: Main: 269443072 23:34:37 INFO - PROCESS | 3669 | 23:34:39 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48733/tests/kraken/driver.html?testName=audio-oscillator) 23:34:39 INFO - PROCESS | 3669 | RSS: Main: 180826112 23:34:39 INFO - PROCESS | 3669 | 23:34:42 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48733/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:34:42 INFO - PROCESS | 3669 | RSS: Main: 185102336 23:34:42 INFO - PROCESS | 3669 | 23:34:45 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48733/tests/kraken/driver.html?testName=imaging-darkroom) 23:34:46 INFO - PROCESS | 3669 | RSS: Main: 219152384 23:34:46 INFO - PROCESS | 3669 | 23:34:49 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48733/tests/kraken/driver.html?testName=imaging-desaturate) 23:34:50 INFO - PROCESS | 3669 | RSS: Main: 220868608 23:34:50 INFO - PROCESS | 3669 | 23:34:53 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48733/tests/kraken/driver.html?testName=json-parse-financial) 23:34:53 INFO - PROCESS | 3669 | RSS: Main: 220819456 23:34:53 INFO - PROCESS | 3669 | 23:34:55 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48733/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:34:55 INFO - PROCESS | 3669 | RSS: Main: 209055744 23:34:55 INFO - PROCESS | 3669 | 23:34:57 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:34:58 INFO - PROCESS | 3669 | RSS: Main: 212877312 23:34:58 INFO - PROCESS | 3669 | 23:35:00 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:35:00 INFO - PROCESS | 3669 | RSS: Main: 211529728 23:35:00 INFO - PROCESS | 3669 | 23:35:03 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:35:03 INFO - PROCESS | 3669 | RSS: Main: 224718848 23:35:03 INFO - PROCESS | 3669 | 23:35:06 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:35:07 INFO - PROCESS | 3669 | RSS: Main: 223567872 23:35:07 INFO - PROCESS | 3669 | 23:35:08 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:48733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48733/tests/kraken/driver.html?testName=ai-astar) 23:35:09 INFO - PROCESS | 3669 | RSS: Main: 266473472 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | __start_tp_report 23:35:09 INFO - PROCESS | 3669 | _x_x_mozilla_page_load 23:35:09 INFO - PROCESS | 3669 | _x_x_mozilla_page_load_details 23:35:09 INFO - PROCESS | 3669 | |i|pagename|runs| 23:35:09 INFO - PROCESS | 3669 | |0;ai-astar;101;110;110;111;111;111;111;111;110;110 23:35:09 INFO - PROCESS | 3669 | |1;audio-beat-detection;145;120;128;171;121;120;149;116;164;119 23:35:09 INFO - PROCESS | 3669 | |2;audio-dft;158;161;159;160;159;159;159;161;160;161 23:35:09 INFO - PROCESS | 3669 | |3;audio-fft;76;76;74;122;75;75;79;75;105;76 23:35:09 INFO - PROCESS | 3669 | |4;audio-oscillator;83;83;113;83;84;83;118;85;83;120 23:35:09 INFO - PROCESS | 3669 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 23:35:09 INFO - PROCESS | 3669 | |6;imaging-darkroom;145;145;145;146;145;146;145;145;146;145 23:35:09 INFO - PROCESS | 3669 | |7;imaging-desaturate;97;96;95;96;96;96;96;95;95;94 23:35:09 INFO - PROCESS | 3669 | |8;json-parse-financial;53;52;51;53;52;53;53;52;52;53 23:35:09 INFO - PROCESS | 3669 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;63;61 23:35:09 INFO - PROCESS | 3669 | |10;stanford-crypto-aes;76;77;80;74;76;75;75;75;79;79 23:35:09 INFO - PROCESS | 3669 | |11;stanford-crypto-ccm;119;116;125;117;128;139;130;119;158;125 23:35:09 INFO - PROCESS | 3669 | |12;stanford-crypto-pbkdf2;154;158;156;157;157;155;154;156;156;157 23:35:09 INFO - PROCESS | 3669 | |13;stanford-crypto-sha256-iterative;62;62;62;65;63;62;62;62;61;59 23:35:09 INFO - PROCESS | 3669 | __end_tp_report 23:35:09 INFO - PROCESS | 3669 | __start_cc_report 23:35:09 INFO - PROCESS | 3669 | _x_x_mozilla_cycle_collect,1630 23:35:09 INFO - PROCESS | 3669 | __end_cc_report 23:35:09 INFO - PROCESS | 3669 | __startTimestamp1467873309079__endTimestamp 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | ------- Summary: start ------- 23:35:09 INFO - PROCESS | 3669 | Number of tests: 14 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.06 (2.8%) stddev-sans-first:0.53 23:35:09 INFO - PROCESS | 3669 | Values: 101.0 110.0 110.0 111.0 111.0 111.0 111.0 111.0 110.0 110.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:136.50 stddev:20.40 (14.9%) stddev-sans-first:21.33 23:35:09 INFO - PROCESS | 3669 | Values: 145.0 120.0 128.0 171.0 121.0 120.0 149.0 116.0 164.0 119.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 23:35:09 INFO - PROCESS | 3669 | Values: 158.0 161.0 159.0 160.0 159.0 159.0 159.0 161.0 160.0 161.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.50 stddev:16.47 (21.8%) stddev-sans-first:17.25 23:35:09 INFO - PROCESS | 3669 | Values: 76.0 76.0 74.0 122.0 75.0 75.0 79.0 75.0 105.0 76.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.00 stddev:16.32 (19.7%) stddev-sans-first:16.86 23:35:09 INFO - PROCESS | 3669 | Values: 83.0 83.0 113.0 83.0 84.0 83.0 118.0 85.0 83.0 120.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:35:09 INFO - PROCESS | 3669 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:35:09 INFO - PROCESS | 3669 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.73 23:35:09 INFO - PROCESS | 3669 | Values: 97.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 94.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 23:35:09 INFO - PROCESS | 3669 | Values: 53.0 52.0 51.0 53.0 52.0 53.0 53.0 52.0 52.0 53.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 23:35:09 INFO - PROCESS | 3669 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 61.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.50 stddev:2.07 (2.7%) stddev-sans-first:2.18 23:35:09 INFO - PROCESS | 3669 | Values: 76.0 77.0 80.0 74.0 76.0 75.0 75.0 75.0 79.0 79.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:126.50 stddev:12.77 (10.1%) stddev-sans-first:13.16 23:35:09 INFO - PROCESS | 3669 | Values: 119.0 116.0 125.0 117.0 128.0 139.0 130.0 119.0 158.0 125.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.50 stddev:1.33 (0.9%) stddev-sans-first:1.20 23:35:09 INFO - PROCESS | 3669 | Values: 154.0 158.0 156.0 157.0 157.0 155.0 154.0 156.0 156.0 157.0 23:35:09 INFO - PROCESS | 3669 | 23:35:09 INFO - PROCESS | 3669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:1.58 23:35:09 INFO - PROCESS | 3669 | Values: 62.0 62.0 62.0 65.0 63.0 62.0 62.0 62.0 61.0 59.0 23:35:09 INFO - PROCESS | 3669 | -------- Summary: end -------- 23:35:09 INFO - PROCESS | 3669 | 23:35:10 INFO - TEST-INFO | 3669: exit 0 23:35:10 INFO - TEST-OK | kraken | took 61521ms 23:35:10 INFO - SUITE-END | took 1176s 23:35:10 INFO - Completed test suite (00:19:36) 23:35:10 INFO - javascript benchmark 23:35:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.5047192449206, 3107.285324375395, 3120.500719884819, 3137.796043257189, 3156.6054243219596, 5145.279660847485, 5255.395629502608, 5267.841964741055, 5340.572754179666, 5342.839714808557, 5350.785968561253, 5357.732113394334, 5366.195070739391, 5370.140777475604, 5410.431904650014, 4847.103285892122, 4853.077915196119, 4919.975400122994, 4938.037082768861, 5029.170186919154, 4926.581240594536, 4936.753162341886, 4967.205247160455, 4981.427135879384, 4989.750512474362, 4714.952850471503, 4770.30830529573, 4844.442889067767, 4906.362172917497, 4919.065377578248, 4889.217725163992, 4898.853034408973, 4907.2639104134305, 4968.324437571714, 5021.62337824661, 4932.876678083041, 4937.259411088329, 4969.428515720666, 4978.203487442028, 5005.299258103868, 5153.974230128825, 5229.08491014071, 5329.920051199235, 5335.493128152819, 5388.892222155574, 5721.599488035839, 5744.425557444222, 5744.712764361765, 5751.05107657236, 5753.050746626802, 5564.33228012637, 5741.827745167651, 5786.929418057631, 5799.855003624901, 5800.535957123462, 5272.393674727417, 5327.760250788724, 5333.973330133324, 5360.0, 5409.134538473864, 5873.735681894325, 5883.970580147157, 5894.646321220741, 5900.085486749561, 5903.734331955073, 5449.073657478239, 5499.615026948155, 5726.026575482178, 5777.971110144423, 5783.8554036149435, 5594.552435805207, 5711.942880571224, 5716.256886604798, 5718.857028574235, 5723.341815691166, 5624.831255062355, 5630.239917611152, 5634.070378387521, 5637.351704553947, 5638.154276858504, 5438.075527160392, 5641.435856414326, 5655.179998900218, 5671.404502527258, 5723.54211663066, 4358.956410435919, 4376.387305777193, 4386.320120381346, 4423.424954755861, 4429.069895322018, 3893.610638936084, 3912.667423268997, 3915.9608403915595, 3940.704447166474, 3958.188571342868, 5247.790088396498, 5262.052830490548, 5392.703401312887, 5440.510354068153, 5443.972780136153, 5733.598648094593, 5760.049591817303, 5766.452187042224, 5772.94227057724, 5822.912656310159, 5464.890702186013, 5466.234727138204, 5468.234447177399, 5468.507834294853, 5471.23402723619, 4811.759412029384, 4891.804327826847, 4948.678335908155, 4960.727160006162, 5024.171011783088, 5936.8812623748145, 5938.228030356113, 5939.881202376015, 5940.673262970492, 5942.3166335871065, 5750.7987220447085, 5762.8847423050465, 5763.596548241583, 5764.711764411679, 5766.019776637898, 5645.266115404971, 5788.421157884178, 5821.505172060253, 5826.533877289891, 5859.648421094748, 5554.222408862682, 5558.972205138948, 5572.164175373727, 5575.135853942646, 5579.497845193952, 5450.291462109901, 5629.88740225185, 5687.232223649754, 5692.345380281321, 5694.202811606296, 5486.369067557282, 5554.6944918028275, 5561.332640083216, 5574.91637625444, 5585.748641311069, 5556.666600004012, 5561.749721262472, 5568.860778480571, 5569.832905012856, 5570.0, 5359.0, 5432.158015507603, 5476.698781567052, 5541.722913854211, 5583.106702927512, 5575.944240557705, 5595.35653399848, 5613.831585052455, 5638.661680299195, 5660.943390566042, 5515.61390702663, 5522.116461366162, 5526.336839579276, 5526.696031718294, 5531.612787104864], "value": 5272.022419339134, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5111782779205, 608.276151379858, 611.5199568338853, 616.6022915219684, 627.4541149200196, 32781.83609081954, 35180.648193518056, 35506.46740298898, 35510.2897942041, 43694.7815260924, 41774.58225417745, 46255.0, 46362.768186159105, 46397.53602463975, 46407.30389044167, 9041.186293233624, 9214.354995150343, 9217.078292170763, 9218.723438296862, 9227.261819054493, 9002.819943601124, 9092.318076144316, 9097.044810294923, 9099.727008189764, 9102.681406150787, 9066.274698024175, 9099.909000909973, 9125.863112053292, 9139.086091390842, 9147.771305717344, 9081.954590227073, 9088.727338179831, 9106.681266155685, 9135.13216244459, 9141.405808622418, 8962.327825413055, 9027.0, 9028.277737780962, 9031.051739567316, 9031.81936361269, 42798.78600606977, 43103.0, 43150.56849431497, 43162.0, 43164.784176079236, 3397.915052123692, 3406.744494162948, 3481.8781342652887, 3591.497190393347, 4009.498812648419, 32306.367387982264, 33058.17354566131, 33290.667093329, 33335.16662083443, 33633.66366336354, 4107.815148318303, 4108.4864391951005, 4135.193637240739, 4202.600752928497, 4207.221663992141, 364501.0, 364989.0, 365212.0, 365348.0, 365551.1722441397, 57409.0, 57546.0, 57655.0, 57686.134707979414, 57709.13436298459, 35552.822235888656, 35889.461658075146, 35949.82025089858, 37747.81126094352, 37755.24489510195, 17750.644987100186, 17896.46310610684, 17967.910160449115, 17986.0, 17986.55033624144, 13620.727585448434, 13794.93102534481, 13799.51701690436, 13800.102993305403, 13803.861961380459, 19528.51178720515, 19558.315458958867, 19643.60712785736, 19723.0, 19808.60382792336, 6843.452523798084, 6987.790366289019, 7014.964925175342, 7066.328698773608, 7067.0, 949.2121539122512, 978.5400861595039, 1012.2863381316155, 1018.9286749927434, 1088.6298658456162, 32748.672513274563, 32803.835980819946, 32949.83525082359, 33002.66997330044, 33115.50326745101, 1099.263493459384, 1107.479484642217, 1131.971700707489, 1150.9079273658087, 1186.128195776104, 16791.748123778154, 17093.0, 17276.0, 17466.65066698659, 17520.123993800258, 555950.0, 585707.0, 587259.0, 589644.0, 589692.0, 58243.12635310474, 58514.41485585175, 59022.0, 59066.0, 59066.40933590695, 1211.3337664284609, 1329.2821876186945, 1346.9865301347056, 1349.1500354776624, 1353.1678018018847, 29971.400571988, 33886.322273554884, 34165.487517687754, 34251.657483424846, 34589.65410345864, 50556.49443505665, 50726.49273507218, 51191.0, 51215.743921280155, 51238.231426529375, 324968.0, 325796.0, 326050.0, 326142.0, 326265.0, 27364.0, 28561.42877142487, 28628.71371286344, 28633.28416789597, 28647.0, 47436.288455672504, 49397.25904111513, 49702.751486242334, 49704.75147624239, 49923.75038124786, 41893.1621367577, 41925.79037104795, 42174.0, 42661.0, 43718.0, 41726.79136604298, 41888.0, 42468.0, 42602.14795704006, 42715.78642106769, 40759.592404076764, 41399.0, 42301.03892727479, 42355.576444235165, 42371.57628423676, 34291.65708342884, 36414.0, 36985.44521832228, 37359.626403735616, 37421.81289093537, 28052.797107549934, 28190.71809281881, 28354.2911427216, 28392.716072839008, 29828.254293642833], "value": 19947.361245553613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.56634339762076, 378.31713756669217, 379.09018355945733, 392.284081551169, 394.9901252468688, 15613.453529126482, 17624.911875440637, 18227.303110132492, 19764.70352944707, 20564.48588785281, 17744.645107097884, 17853.285868565243, 17976.4607061788, 17987.820121798777, 18474.0, 5659.66042037477, 5845.181674565564, 5862.706864656771, 5889.0, 5893.263342082239, 5444.455554444564, 5765.855853603673, 5772.797952071678, 5826.475617194452, 5832.504237139849, 5554.638948468337, 5743.167240750089, 5777.191193232929, 5792.739326730307, 5794.942050579503, 5757.453041961007, 5803.738831752581, 5849.444302791249, 5855.151003104568, 5858.062709966428, 5541.168824676331, 5548.0, 5635.718214089279, 5638.577106716972, 5653.773849046033, 13884.6604945973, 13955.860441395558, 14153.646158846112, 14165.858341416557, 14284.714305713931, 2300.5398920216026, 2365.503244318695, 2382.3448551648435, 2383.0, 2910.185148158519, 9705.12653861156, 10228.284020118595, 10511.054005139575, 10575.0, 10609.681709548726, 1942.1454559993558, 2003.1486618187212, 2012.4968757810548, 2066.2974588639936, 2104.2109209046607, 75867.0, 81821.0, 81838.18161818365, 82109.58945205236, 82343.0, 10392.740181495523, 10614.628488003038, 10647.0, 10693.732656683489, 10998.34009959389, 14065.789013164811, 14092.224927628873, 14120.576382708536, 14140.43438262458, 14169.079009864327, 8188.50868947865, 8562.272206862363, 8590.613422396007, 8606.87089693655, 8636.093210212963, 8301.211384918422, 8352.12302708219, 8511.659533618586, 8578.485290882567, 8590.269827064769, 4687.39063921688, 4720.433547974265, 4756.17902471614, 4810.302506136591, 4858.198397264412, 1918.7601549806275, 1933.980660193408, 1966.3314473078935, 1977.2684106880547, 1990.9800901990795, 861.6251930410292, 986.9407835529747, 994.5524513968743, 1016.9338992965434, 1025.1542477456128, 19513.902430487757, 19835.900820495805, 20331.288404905757, 20362.89113266044, 20392.0, 986.1322036607883, 986.921046316293, 987.8962708915604, 990.0990099009866, 1001.5392919257223, 10533.534767224633, 10934.945325273482, 11144.60993865211, 11217.214794964437, 11312.943435282936, 479620.0, 486007.0, 489361.0, 492540.0, 493744.0, 73404.63297683478, 83662.58168709239, 91413.54293228491, 94636.0, 96475.0, 972.0716715536646, 985.2561316206219, 1005.1556692378583, 1007.6019972110975, 1007.8913195485054, 18171.54571135732, 18296.176672049525, 18718.344857929907, 18752.249910003993, 18986.43040708781, 43758.12483750371, 44844.775776120914, 45710.54289457063, 46036.76981615071, 46236.0, 61608.69195653993, 62540.68729656505, 63421.0, 64168.67915660392, 65042.0, 7453.813654658677, 8461.450005749606, 8500.489970601784, 8522.91477085246, 9229.630814767334, 12253.326067066397, 13979.370928308048, 14089.084209526349, 14399.568012959628, 14585.197814120325, 12479.87520124787, 12554.435050422935, 12572.371381430708, 12595.87404125947, 12664.556740514037, 11523.250988685708, 12044.638660840188, 12184.51261949512, 12267.815982760087, 12352.4441400139, 12522.561710340095, 12765.808512872129, 12781.233126012468, 12824.29466379358, 12834.165779224693, 8072.39457040736, 8106.351491880518, 8230.300424463987, 8238.052623948322, 8378.120297368932, 11555.537778489102, 12122.454489547816, 12531.812022819482, 12922.0, 13022.02334824873], "value": 9216.2945981999, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.6304229379216, 1464.289819437573, 1530.2119408504623, 1745.075110191599, 1774.1750086209918, 8354.874676879845, 8887.866681999774, 8942.016378198394, 8943.865842012367, 8948.463092214455, 7411.0, 8304.46021008634, 8458.069612342653, 8537.530435826027, 8542.91457085429, 2216.9556608867815, 2243.371855880356, 2244.2033078257227, 2244.5062086340977, 2246.6854640350284, 1807.8011418743927, 2274.5678321119017, 2276.226083131735, 2317.281642690763, 2318.5594737, 2202.570498752744, 2265.524239909621, 2276.3739971507803, 2293.6674182243564, 2296.1389478945393, 2245.14684419921, 2253.504229069602, 2266.3767463947383, 2287.359539328974, 2295.827812914038, 2224.0, 2239.9328020159423, 2240.283109404991, 2250.246167533862, 2281.851679640818, 8854.070322616097, 8890.86663700045, 8921.15249051339, 8953.059928707456, 8984.640614375417, 5073.949260507385, 5209.947900520984, 5220.164773636238, 5221.634485586011, 5243.711595862264, 3137.215696075981, 3200.631927328364, 3250.479923212298, 3259.788113772597, 3279.737620990315, 1029.1560920045565, 1051.3376572759112, 1063.2025980514613, 1095.6712986104137, 1097.1058587251443, 12337.444814983257, 12438.689032774162, 12453.813192802025, 12471.688207794878, 12480.563180288736, 4396.824127034947, 4446.644268458515, 4652.581267685924, 4654.0, 4661.347411362412, 10337.173026157889, 10368.948155259175, 10375.94812025935, 10377.429241391645, 10435.0, 5228.581713462914, 5263.421023687391, 5266.47335266478, 5267.868303292448, 5269.947300526946, 4780.282957556325, 4820.204666230033, 4830.903381932341, 4831.73425461596, 4867.294242334841, 3793.336166170909, 3805.8667946621736, 3835.7314987951136, 3839.827207775657, 3928.862489812843, 1050.9527071281811, 1161.6805378520974, 1200.2978257719158, 1200.7418405042959, 1205.1262834444958, 898.6270697660398, 951.5670369981642, 967.1102585621245, 972.5331840716354, 991.0337421014598, 5810.564207684441, 5864.824055278348, 6047.213862197974, 6061.575689701678, 6111.724972376253, 957.5978089202551, 971.2763990826738, 974.2546951582045, 1000.5147503460815, 1020.9591616335412, 4133.0, 4189.853355132555, 4216.3464662977285, 4219.472565929259, 4223.366495025771, 10614.628488002883, 11028.889711102947, 11160.776784464266, 11178.049865761339, 11179.385133817717, 9271.351005429555, 10110.595576177018, 10580.629677961235, 10992.725181870517, 10995.780084398268, 8116.75649730509, 8201.548914809624, 8277.58612069394, 8281.0, 8291.129431409616, 5990.850228744316, 6212.285587157354, 6216.968915155395, 6245.843853903507, 6301.4643755279485, 10042.14641755459, 10121.089101980562, 10161.745956351151, 10179.49102544855, 10213.897861021294, 9589.808203836024, 10008.749781255527, 10047.547860346156, 10194.57275981378, 10244.129249013917, 7438.776836694908, 7518.0, 7534.623268836646, 7549.7357592483995, 7555.282248186413, 8260.876086858822, 8301.169883011651, 8308.584570771558, 8334.833303333779, 8349.666013359398, 6192.97815860378, 6360.49116070704, 7116.146062472537, 7136.678849451683, 7535.208803075599, 7159.0, 7216.819579510554, 7256.4194864411775, 7372.631368431665, 7402.185759566336, 6610.338966103352, 6718.395344419026, 6741.898871517029, 6745.494087943326, 6756.932430675827, 4863.003084367767, 4951.851444456672, 4978.228374601942, 5014.974925125497, 5100.38795344561, 5054.848354549369, 5127.46161653021, 5130.897382052263, 5188.221766734869, 5328.333958255218], "value": 4560.569435770257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2322978392292, 325.201629998354, 331.3753574512045, 334.0329745387106, 335.7918090783713, 5396.622236443451, 5402.567794576435, 5434.945650543494, 5435.347758269008, 5454.072807622703, 5046.21783623538, 5173.586113110951, 5321.388040375358, 5330.440303768107, 5375.81184658537, 4162.43807086044, 4227.8097485613225, 4233.407322974786, 4242.321228603431, 4244.978775106136, 4212.641925436326, 4235.957640423587, 4250.234957707611, 4254.680898932577, 4256.1913236485125, 3994.980025099885, 4065.512138543364, 4074.409210664452, 4151.526208196092, 4155.750654960697, 4142.91714165718, 4168.624823765876, 4176.812043458051, 4177.958220417788, 4181.289180839264, 3671.522702048743, 3686.8340924658455, 3689.4834723138783, 3690.0959264979983, 3692.984429281942, 5094.6433749637545, 5159.890623515925, 5178.223266510016, 5213.191955246943, 5269.841904742864, 4747.1486120413065, 4755.548222918817, 4758.928616070727, 4772.880677983044, 4783.7129772213775, 5545.223668686387, 5564.360098588633, 5610.597350662334, 5622.690752008638, 5633.971830140864, 3829.0, 4010.7593544387137, 4012.7191096623246, 4021.698372622036, 4054.0878302382025, 5801.274840644919, 5813.651180929158, 5836.416358364172, 5853.209816674737, 5903.79336723217, 4156.771377574202, 4156.916861662749, 4159.230542349675, 4160.271952408317, 4161.729487583298, 4075.0, 4115.0, 4116.0, 4141.813618387119, 4203.4115223868685, 4688.320193571981, 4746.247176637542, 4752.120857641278, 4759.428868535798, 4762.738049407316, 5621.8594535136135, 5663.0, 5684.175794509855, 5684.459976302244, 5693.658380497101, 1383.8546952570036, 1403.8245219347582, 1428.6285565752978, 1442.502336693839, 1448.797498076594, 997.586001809241, 1011.7925825205815, 1018.4551265073151, 1030.5877648940334, 1036.445332001997, 5307.310049693592, 5318.803269264385, 5349.22436246742, 5370.301860758076, 5379.67721936685, 5674.120511320752, 5674.2339784129435, 5679.346875109332, 5686.829395118153, 5694.4590263924865, 5131.923021154611, 5347.572194224531, 5352.4915133062295, 5363.410024897258, 5401.756920938567, 3006.1432491739747, 3031.863566139529, 3032.0297504798255, 3035.6357237131688, 3050.34417600217, 5822.301323841081, 5866.501347385435, 5868.471837534642, 5886.852828679232, 5908.14331921869, 5612.859678507988, 5830.883382332329, 5917.881642367214, 5939.732712027882, 5951.494122999594, 5933.970330148408, 5956.821295361146, 5962.0460726284455, 5966.671833049224, 5992.760289588367, 5616.522595579258, 5814.674130347895, 5835.824925252249, 5839.854003649943, 5841.32824725162, 5758.683272420057, 5778.335491418541, 5788.0, 5795.015566982923, 5797.594168408171, 6019.879602408015, 6039.577229593886, 6049.092636104443, 6054.576179667381, 6069.453749162597, 3898.902527436837, 4018.9397159043224, 4099.8975025624595, 4139.793010349531, 4151.8339266429, 5806.44838740319, 5821.330546986981, 5832.883342333044, 5839.883202336015, 5849.356570777126, 5454.181872719124, 5538.307711536058, 5632.436756324335, 5650.915236271541, 5660.660360378391, 5555.666660000413, 5611.699203326616, 5629.605927585029, 5649.661020338793, 5663.575231857545, 5314.202869569595, 5526.834194974157, 5568.638038527482, 5572.384008637449, 5587.49137732818, 5630.718464076862, 5657.660540367591, 5662.858428539154, 5670.177824215548, 5674.262345895172, 5508.807191748269, 5526.47498487643, 5533.612647114664, 5540.584456165884, 5544.584156188383], "value": 4291.183345352322, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.5097380859589, 717.7631381644057, 754.8528037032777, 778.7663700889733, 806.9717559885402, 15441.845581544181, 16727.563541848904, 16912.661746765087, 17091.82908170918, 17140.0, 15175.92412037941, 15228.771568426482, 15294.694106117871, 15344.156071416068, 15384.538463846075, 650.3983814971157, 665.8834703926817, 666.3902529185789, 785.2343964634479, 805.1827395193883, 647.0165348670018, 782.2334112569686, 806.3226889412892, 816.1185919207271, 822.4653974916292, 858.3390789092426, 860.2000139869918, 860.5181098584782, 861.8750281209221, 862.1292494580456, 686.6086330791451, 855.6791203298794, 855.6962278391206, 855.9429105055252, 855.9614817333204, 599.4544964082708, 611.7155522681929, 613.101805854421, 613.1814028272262, 615.5414216408759, 14836.406543738238, 14925.328360223815, 14926.62683432912, 14939.103653780809, 14973.925130374388, 13871.0, 14544.345504452325, 14569.125852448888, 14603.342849571794, 14766.926165369105, 12798.872011279862, 13001.0, 13021.0234232432, 13110.737785244337, 13195.60413187606, 4565.657575681837, 4576.977115114403, 4586.495485496593, 4589.655775816827, 4592.357070010201, 67129.32870671329, 69836.0, 70050.0, 75733.0, 82116.0, 10854.18593605467, 10913.017828395483, 10945.726356841144, 11614.419279036183, 12454.688632784071, 19422.611547768967, 20239.4940126498, 20260.0, 21176.25883094115, 21239.0, 8729.258013068833, 8839.513826739463, 8871.955640221757, 9060.909390906138, 9215.0, 4850.7817148227705, 4990.151674215392, 5079.6698214615935, 5104.3874735031295, 5175.870603234874, 3287.539744435781, 3402.4045791986305, 3405.557277553902, 3405.8126803025575, 3406.9488957665653, 633.1642232253381, 641.4547634510628, 648.2901223160632, 649.3506493506494, 650.0898741761572, 668.2982867988593, 737.1044181319722, 750.9962450187824, 803.2048272210586, 805.642477524467, 9960.900390996143, 10170.351396383985, 10289.53697083633, 10296.22778291631, 10761.515731792088, 642.2613993907045, 663.9402453779087, 714.6319645382632, 724.485615213194, 729.3545212486881, 4999.900002000012, 5027.8548751022845, 5029.497050295015, 5045.192769156917, 5082.644214904921, 120593.0, 121285.0, 121565.78434215544, 123119.38440307921, 123783.0, 103025.48487257515, 103841.48079259555, 104846.47576762068, 106335.0, 106674.46662766636, 77707.0, 82252.0, 86797.0, 88069.0, 90201.0, 9895.356801807859, 9980.991431215874, 9991.150752186146, 10073.496325183565, 10329.74175645615, 51374.0, 51461.48538514716, 53079.469205307454, 53101.46898530965, 54171.729141354044, 71311.64344178246, 80225.59887200527, 80701.59649201951, 80784.19215807767, 81146.56560303201, 12398.752024959631, 12564.0, 12746.745065098461, 13310.068295219242, 13312.134711243738, 14079.0848594841, 14113.08264962774, 14200.857991420367, 15169.469068582988, 15661.138637374597, 14554.636134096732, 14666.34001469915, 15210.695786084438, 15567.844321557093, 15586.0, 14439.422423102958, 14481.131132132106, 14548.345324460637, 14551.126932384092, 14650.487232946796, 14097.647558811112, 14182.290885455479, 14378.0, 14838.258087095386, 14866.554003379915, 11462.312261264351, 11932.568091829036, 12084.395780210778, 12548.560800372308, 12561.371931403575, 11155.107591392507, 11421.31472111676, 11446.885531144582, 11557.595484158013, 11562.190646654653], "value": 7745.515019238176, "unit": "score"}], "name": "dromaeo_css", "value": 7264.154796879241, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 128.0, 171.0, 121.0, 120.0, 149.0, 116.0, 164.0, 119.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 159.0, 160.0, 159.0, 159.0, 159.0, 161.0, 160.0, 161.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 122.0, 75.0, 75.0, 79.0, 75.0, 105.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 83.0, 84.0, 83.0, 118.0, 85.0, 83.0, 120.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 53.0, 52.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 61.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 80.0, 74.0, 76.0, 75.0, 75.0, 75.0, 79.0, 79.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 125.0, 117.0, 128.0, 139.0, 130.0, 119.0, 158.0, 125.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 156.0, 157.0, 157.0, 155.0, 154.0, 156.0, 156.0, 157.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 65.0, 63.0, 62.0, 62.0, 62.0, 61.0, 59.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1475.6999999999998, "alertThreshold": 2.0}]} 23:35:10 INFO - Return code: 0 23:35:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:35:10 INFO - # TBPL SUCCESS # 23:35:10 INFO - Running post-action listener: _resource_record_post_action 23:35:10 INFO - ##### 23:35:10 INFO - ##### Finished run-tests step (success) 23:35:10 INFO - ##### 23:35:10 INFO - Running post-run listener: _resource_record_post_run 23:35:10 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 458489856; Read time: 1936; Write time: 351336 23:35:10 INFO - TinderboxPrint: CPU usage
12.9% 23:35:10 INFO - TinderboxPrint: I/O read bytes / time
7,811,072 / 1,936 23:35:10 INFO - TinderboxPrint: I/O write bytes / time
458,489,856 / 351,336 23:35:10 INFO - TinderboxPrint: CPU idle
8,297.2 (87.1%) 23:35:10 INFO - TinderboxPrint: CPU user
1,188.2 (12.5%) 23:35:10 INFO - TinderboxPrint: Swap in / out
0 / 0 23:35:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 93769728; Read time: 0; Write time: 63080 23:35:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5574656; Write bytes: 364720128; Read time: 1788; Write time: 288256 23:35:11 INFO - Running post-run listener: _upload_blobber_files 23:35:11 INFO - Blob upload gear active. 23:35:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:35:11 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 23:35:11 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'] 23:35:11 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 23:35:11 INFO - (blobuploader) - INFO - Open directory for files ... 23:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:12 INFO - (blobuploader) - INFO - Done attempting. 23:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:13 INFO - (blobuploader) - INFO - Done attempting. 23:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:16 INFO - (blobuploader) - INFO - Done attempting. 23:35:16 INFO - (blobuploader) - INFO - Iteration through files over. 23:35:16 INFO - Return code: 0 23:35:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:35:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:35:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0907710bf314d03f18feaf874137910cc78a592fb6f6bbec069f96794473905254168d2e65d1076d927d32179d117c1a4a2af287f33cd38d74db99e97815b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcfcd297e23033f9b42d67aa49d1e4a1de421c12c102ae65458943e9885f36dd2ba744061b9dc188681dbbb8eb114d88b4f0c7c34becf8fdac3205452f38d1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/945785d864ee9f921b04f7e5deacc38ce5ad0287186fd8cdc2bf690f6d68578cf42dea01fa28c032e86e99425ab065cd0eef42521cc8ab3ab8272f998ffd2d03"} 23:35:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:35:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:35:16 INFO - Contents: 23:35:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0907710bf314d03f18feaf874137910cc78a592fb6f6bbec069f96794473905254168d2e65d1076d927d32179d117c1a4a2af287f33cd38d74db99e97815b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcfcd297e23033f9b42d67aa49d1e4a1de421c12c102ae65458943e9885f36dd2ba744061b9dc188681dbbb8eb114d88b4f0c7c34becf8fdac3205452f38d1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/945785d864ee9f921b04f7e5deacc38ce5ad0287186fd8cdc2bf690f6d68578cf42dea01fa28c032e86e99425ab065cd0eef42521cc8ab3ab8272f998ffd2d03"} 23:35:16 INFO - Running post-run listener: copy_logs_to_upload_dir 23:35:16 INFO - Copying logs to upload dir... 23:35:16 INFO - mkdir: /builds/slave/test/build/upload/logs 23:35:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.456544 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-06 23:35:16.878980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:16.882688) ========= 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-1467871944.48709-291881478 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/e0907710bf314d03f18feaf874137910cc78a592fb6f6bbec069f96794473905254168d2e65d1076d927d32179d117c1a4a2af287f33cd38d74db99e97815b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcfcd297e23033f9b42d67aa49d1e4a1de421c12c102ae65458943e9885f36dd2ba744061b9dc188681dbbb8eb114d88b4f0c7c34becf8fdac3205452f38d1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/945785d864ee9f921b04f7e5deacc38ce5ad0287186fd8cdc2bf690f6d68578cf42dea01fa28c032e86e99425ab065cd0eef42521cc8ab3ab8272f998ffd2d03"} build_url:https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/AT_xGFrbR8O4pfz6D2IXag/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/e0907710bf314d03f18feaf874137910cc78a592fb6f6bbec069f96794473905254168d2e65d1076d927d32179d117c1a4a2af287f33cd38d74db99e97815b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fcfcd297e23033f9b42d67aa49d1e4a1de421c12c102ae65458943e9885f36dd2ba744061b9dc188681dbbb8eb114d88b4f0c7c34becf8fdac3205452f38d1ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/945785d864ee9f921b04f7e5deacc38ce5ad0287186fd8cdc2bf690f6d68578cf42dea01fa28c032e86e99425ab065cd0eef42521cc8ab3ab8272f998ffd2d03"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:16.912481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:16.912829) ========= 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-1467871944.48709-291881478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:35:16.999294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:35:16.999956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 23:35:17.000597) ========= ========= Total master_lag: 0.26 =========