builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1467249797.89 results: success (0) buildid: 20160629170625 builduid: bf8374b651384e2d94b0ff7aff4ada72 revision: b79c51ca296e2679108429029e31f6c84ae1f0d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:17.894686) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:17.895326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:17.895616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:17.917837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:17.918186) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 18:23:18-- 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% 38.1M=0s 2016-06-29 18:23:18 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.020725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.021019) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.073287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.073624) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b79c51ca296e2679108429029e31f6c84ae1f0d7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b79c51ca296e2679108429029e31f6c84ae1f0d7 --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=7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 18:23:18,257 truncating revision to first 12 chars 2016-06-29 18:23:18,257 Setting DEBUG logging. 2016-06-29 18:23:18,257 attempt 1/10 2016-06-29 18:23:18,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b79c51ca296e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 18:23:18,548 unpacking tar archive at: autoland-b79c51ca296e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.724534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.724883) ========= script_repo_revision: b79c51ca296e2679108429029e31f6c84ae1f0d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.725398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.725746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 18:23:18.736268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-29 18:23:18.736582) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:23:19 INFO - MultiFileLogger online at 20160629 18:23:19 in /builds/slave/test 18:23:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 18:23:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:23:19 INFO - {'append_to_log': False, 18:23:19 INFO - 'base_work_dir': '/builds/slave/test', 18:23:19 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 18:23:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:23:19 INFO - 'branch': 'Autoland-Non-PGO', 18:23:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:23:19 INFO - 'config_files': ('talos/linux_config.py',), 18:23:19 INFO - 'default_actions': ('clobber', 18:23:19 INFO - 'read-buildbot-config', 18:23:19 INFO - 'download-and-extract', 18:23:19 INFO - 'populate-webroot', 18:23:19 INFO - 'create-virtualenv', 18:23:19 INFO - 'install', 18:23:19 INFO - 'run-tests'), 18:23:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:23:19 INFO - 'download_minidump_stackwalk': True, 18:23:19 INFO - 'download_symbols': 'ondemand', 18:23:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:23:19 INFO - 'tooltool.py': '/tools/tooltool.py', 18:23:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:23:19 INFO - '/tools/misc-python/virtualenv.py')}, 18:23:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:23:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:23:19 INFO - 'installer_path': 'installer.exe', 18:23:19 INFO - 'log_level': 'info', 18:23:19 INFO - 'log_name': 'talos', 18:23:19 INFO - 'log_to_console': True, 18:23:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:23:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:23:19 INFO - 'opt_config_files': (), 18:23:19 INFO - 'pip_index': False, 18:23:19 INFO - 'sps_profile': False, 18:23:19 INFO - 'sps_profile_interval': 0, 18:23:19 INFO - 'suite': 'dromaeojs', 18:23:19 INFO - 'system_bits': '32', 18:23:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:23:19 INFO - 'title': 'talos-linux64-ix-005', 18:23:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:23:19 INFO - 'use_talos_json': True, 18:23:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:23:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:23:19 INFO - 'work_dir': 'build'} 18:23:19 INFO - ##### 18:23:19 INFO - ##### Running clobber step. 18:23:19 INFO - ##### 18:23:19 INFO - Running pre-action listener: _resource_record_pre_action 18:23:19 INFO - Running main action method: clobber 18:23:19 INFO - rmtree: /builds/slave/test/build 18:23:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:23:19 INFO - Running post-action listener: _resource_record_post_action 18:23:19 INFO - ##### 18:23:19 INFO - ##### Finished clobber step (success) 18:23:19 INFO - ##### 18:23:19 INFO - ##### 18:23:19 INFO - ##### Running read-buildbot-config step. 18:23:19 INFO - ##### 18:23:19 INFO - Running pre-action listener: _resource_record_pre_action 18:23:19 INFO - Running main action method: read_buildbot_config 18:23:19 INFO - Using buildbot properties: 18:23:19 INFO - { 18:23:19 INFO - "project": "", 18:23:19 INFO - "product": "firefox", 18:23:19 INFO - "script_repo_revision": "production", 18:23:19 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 18:23:19 INFO - "repository": "", 18:23:19 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 18:23:19 INFO - "buildid": "20160629170625", 18:23:19 INFO - "pgo_build": "False", 18:23:19 INFO - "basedir": "/builds/slave/test", 18:23:19 INFO - "buildnumber": 16, 18:23:19 INFO - "slavename": "talos-linux64-ix-005", 18:23:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:23:19 INFO - "platform": "ubuntu64_hw", 18:23:19 INFO - "scheduler": "tests-autoland-linux64-talos", 18:23:19 INFO - "branch": "autoland", 18:23:19 INFO - "repo_path": "integration/autoland", 18:23:19 INFO - "revision": "b79c51ca296e2679108429029e31f6c84ae1f0d7", 18:23:19 INFO - "stage_platform": "linux64", 18:23:19 INFO - "builduid": "bf8374b651384e2d94b0ff7aff4ada72", 18:23:19 INFO - "slavebuilddir": "test" 18:23:19 INFO - } 18:23:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:23:19 INFO - Running post-action listener: _resource_record_post_action 18:23:19 INFO - ##### 18:23:19 INFO - ##### Finished read-buildbot-config step (success) 18:23:19 INFO - ##### 18:23:19 INFO - ##### 18:23:19 INFO - ##### Running download-and-extract step. 18:23:19 INFO - ##### 18:23:19 INFO - Running pre-action listener: _resource_record_pre_action 18:23:19 INFO - Running main action method: download_and_extract 18:23:19 INFO - mkdir: /builds/slave/test/build/tests 18:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:19 INFO - https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:27 INFO - Downloaded 1361 bytes. 18:23:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:23:27 INFO - Using the following test package requirements: 18:23:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:23:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:23:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'jsshell-linux-x86_64.zip'], 18:23:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:23:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:23:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:23:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:23:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:23:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:27 INFO - https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:23:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:23:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:23:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:37 INFO - Downloaded 22701701 bytes. 18:23:37 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'] 18:23:37 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 18:23:38 INFO - Return code: 0 18:23:38 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 18:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:38 INFO - https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:23:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:23:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:23:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:41 INFO - Downloaded 22701701 bytes. 18:23:41 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'] 18:23:41 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 18:23:42 INFO - Return code: 0 18:23:42 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')]} 18:23:42 INFO - https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:44 INFO - Downloaded 14405245 bytes. 18:23:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:23:44 INFO - Return code: 0 18:23: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')]} 18:23:44 INFO - https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:23:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:23:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:23:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W86_189LTE-DgLF0i3AKHg/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 18:23:45 INFO - Downloaded 56478081 bytes. 18:23:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:23:45 INFO - mkdir: /builds/slave/test/properties 18:23:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:45 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:45 INFO - Contents: 18:23:45 INFO - build_url:https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:23:46 INFO - Running post-action listener: _resource_record_post_action 18:23:46 INFO - Running post-action listener: set_extra_try_arguments 18:23:46 INFO - ##### 18:23:46 INFO - ##### Finished download-and-extract step (success) 18:23:46 INFO - ##### 18:23:46 INFO - ##### 18:23:46 INFO - ##### Running populate-webroot step. 18:23:46 INFO - ##### 18:23:46 INFO - Running pre-action listener: _resource_record_pre_action 18:23:46 INFO - Running main action method: populate_webroot 18:23:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:46 INFO - '--tppagecycles', 18:23:46 INFO - '7'], 18:23:46 INFO - 'tests': ['tsvgm']}}, 18:23:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:23:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:23:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:23:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['damp', 'tps']}, 18:23:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'tests': ['damp', 'tps']}, 18:23:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['dromaeo_dom']}, 18:23:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['basic_compositor_video']}, 18:23:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:23:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['a11yr', 18:23:46 INFO - 'ts_paint', 18:23:46 INFO - 'tpaint', 18:23:46 INFO - 'sessionrestore', 18:23:46 INFO - 'sessionrestore_no_auto_restore', 18:23:46 INFO - 'tabpaint']}, 18:23:46 INFO - 'other-e10s': {'tests': ['a11yr', 18:23:46 INFO - 'ts_paint', 18:23:46 INFO - 'tpaint', 18:23:46 INFO - 'sessionrestore', 18:23:46 INFO - 'sessionrestore_no_auto_restore', 18:23:46 INFO - 'tabpaint']}, 18:23:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:23:46 INFO - 'ts_paint', 18:23:46 INFO - 'tpaint', 18:23:46 INFO - 'sessionrestore', 18:23:46 INFO - 'sessionrestore_no_auto_restore', 18:23:46 INFO - 'tabpaint']}, 18:23:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:23:46 INFO - 'ts_paint', 18:23:46 INFO - 'tpaint', 18:23:46 INFO - 'sessionrestore', 18:23:46 INFO - 'sessionrestore_no_auto_restore', 18:23:46 INFO - 'tabpaint']}, 18:23:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['a11yr', 18:23:46 INFO - 'ts_paint', 18:23:46 INFO - 'tpaint', 18:23:46 INFO - 'sessionrestore', 18:23:46 INFO - 'sessionrestore_no_auto_restore', 18:23:46 INFO - 'tabpaint']}, 18:23:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['a11yr', 18:23:46 INFO - 'ts_paint', 18:23:46 INFO - 'tpaint', 18:23:46 INFO - 'sessionrestore', 18:23:46 INFO - 'sessionrestore_no_auto_restore', 18:23:46 INFO - 'tabpaint']}, 18:23:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['tsvgx', 18:23:46 INFO - 'tsvgr_opacity', 18:23:46 INFO - 'tart', 18:23:46 INFO - 'tscrollx', 18:23:46 INFO - 'cart']}, 18:23:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:23:46 INFO - 'tsvgr_opacity', 18:23:46 INFO - 'tart', 18:23:46 INFO - 'tscrollx', 18:23:46 INFO - 'cart']}, 18:23:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'talos_options': ['--disable-e10s'], 18:23:46 INFO - 'tests': ['tp5o']}, 18:23:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'tests': ['tp5o']}, 18:23:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'talos_options': ['--disable-e10s', 18:23:46 INFO - '--xperf_path', 18:23:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:46 INFO - 'tests': ['tp5n']}, 18:23:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:46 INFO - 'talos_options': ['--xperf_path', 18:23:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:46 INFO - 'tests': ['tp5n']}}, 18:23:46 INFO - 'talos.zip': {'path': '', 18:23:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:46 INFO - Running post-action listener: _resource_record_post_action 18:23:46 INFO - ##### 18:23:46 INFO - ##### Finished populate-webroot step (success) 18:23:46 INFO - ##### 18:23:46 INFO - ##### 18:23:46 INFO - ##### Running create-virtualenv step. 18:23:46 INFO - ##### 18:23:46 INFO - Running pre-action listener: _resource_record_pre_action 18:23:46 INFO - Running main action method: create_virtualenv 18:23:46 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:46 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 18:23:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:46 INFO - Using real prefix '/usr' 18:23:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:49 INFO - Installing pip.................done. 18:23:49 INFO - Return code: 0 18:23:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:49 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:23:49 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 18:23:49 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 18:23:49 INFO - Using env: {'DISPLAY': ':0', 18:23:49 INFO - 'HOME': '/home/cltbld', 18:23:49 INFO - 'LANG': 'en_US.UTF-8', 18:23:49 INFO - 'LANGUAGE': 'en_US:en', 18:23:49 INFO - 'LOGNAME': 'cltbld', 18:23:49 INFO - 'MAIL': '/var/mail/cltbld', 18:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:49 INFO - 'MOZ_NO_REMOTE': '1', 18:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:49 INFO - 'NO_EM_RESTART': '1', 18:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:49 INFO - 'PWD': '/builds/slave/test', 18:23:49 INFO - 'SHELL': '/bin/bash', 18:23:49 INFO - 'SHLVL': '1', 18:23:49 INFO - 'TERM': 'linux', 18:23:49 INFO - 'TMOUT': '86400', 18:23:49 INFO - 'USER': 'cltbld', 18:23:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:49 INFO - '_': '/tools/buildbot/bin/python'} 18:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:49 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 18:23:49 INFO - Cleaning up... 18:23:49 INFO - Return code: 0 18:23:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:49 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:23:49 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 18:23:49 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 18:23:49 INFO - Using env: {'DISPLAY': ':0', 18:23:49 INFO - 'HOME': '/home/cltbld', 18:23:49 INFO - 'LANG': 'en_US.UTF-8', 18:23:49 INFO - 'LANGUAGE': 'en_US:en', 18:23:49 INFO - 'LOGNAME': 'cltbld', 18:23:49 INFO - 'MAIL': '/var/mail/cltbld', 18:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:49 INFO - 'MOZ_NO_REMOTE': '1', 18:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:49 INFO - 'NO_EM_RESTART': '1', 18:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:49 INFO - 'PWD': '/builds/slave/test', 18:23:49 INFO - 'SHELL': '/bin/bash', 18:23:49 INFO - 'SHLVL': '1', 18:23:49 INFO - 'TERM': 'linux', 18:23:49 INFO - 'TMOUT': '86400', 18:23:49 INFO - 'USER': 'cltbld', 18:23:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:49 INFO - '_': '/tools/buildbot/bin/python'} 18:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:49 INFO - Downloading/unpacking psutil>=3.1.1 18:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:23:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:51 INFO - Installing collected packages: psutil 18:23:51 INFO - Running setup.py install for psutil 18:23:51 INFO - building 'psutil._psutil_linux' extension 18:23:51 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 18:23:51 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 18:23:51 INFO - building 'psutil._psutil_posix' extension 18:23:51 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 18:23:51 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 18:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:52 INFO - Successfully installed psutil 18:23:52 INFO - Cleaning up... 18:23:52 INFO - Return code: 0 18:23:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:23:52 INFO - Using env: {'DISPLAY': ':0', 18:23:52 INFO - 'HOME': '/home/cltbld', 18:23:52 INFO - 'LANG': 'en_US.UTF-8', 18:23:52 INFO - 'LANGUAGE': 'en_US:en', 18:23:52 INFO - 'LOGNAME': 'cltbld', 18:23:52 INFO - 'MAIL': '/var/mail/cltbld', 18:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:52 INFO - 'MOZ_NO_REMOTE': '1', 18:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:52 INFO - 'NO_EM_RESTART': '1', 18:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:52 INFO - 'PWD': '/builds/slave/test', 18:23:52 INFO - 'SHELL': '/bin/bash', 18:23:52 INFO - 'SHLVL': '1', 18:23:52 INFO - 'TERM': 'linux', 18:23:52 INFO - 'TMOUT': '86400', 18:23:52 INFO - 'USER': 'cltbld', 18:23:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:52 INFO - '_': '/tools/buildbot/bin/python'} 18:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:23:52 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 18:23:52 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 18:23:52 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 18:23:52 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 18:23:52 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 18:23:52 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 18:23:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:23:54 INFO - Installing collected packages: mozsystemmonitor 18:23:54 INFO - Running setup.py install for mozsystemmonitor 18:23:54 INFO - Successfully installed mozsystemmonitor 18:23:54 INFO - Cleaning up... 18:23:54 INFO - Return code: 0 18:23:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:23:54 INFO - Using env: {'DISPLAY': ':0', 18:23:54 INFO - 'HOME': '/home/cltbld', 18:23:54 INFO - 'LANG': 'en_US.UTF-8', 18:23:54 INFO - 'LANGUAGE': 'en_US:en', 18:23:54 INFO - 'LOGNAME': 'cltbld', 18:23:54 INFO - 'MAIL': '/var/mail/cltbld', 18:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:54 INFO - 'MOZ_NO_REMOTE': '1', 18:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:54 INFO - 'NO_EM_RESTART': '1', 18:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:54 INFO - 'PWD': '/builds/slave/test', 18:23:54 INFO - 'SHELL': '/bin/bash', 18:23:54 INFO - 'SHLVL': '1', 18:23:54 INFO - 'TERM': 'linux', 18:23:54 INFO - 'TMOUT': '86400', 18:23:54 INFO - 'USER': 'cltbld', 18:23:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:54 INFO - '_': '/tools/buildbot/bin/python'} 18:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:54 INFO - Downloading/unpacking jsonschema==2.5.1 18:23:54 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 18:23:54 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 18:23:54 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 18:23:54 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 18:23:54 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 18:23:54 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 18:23:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:23:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23:56 INFO - Downloading functools32-3.2.3-2.tar.gz 18:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:23:56 INFO - warning: no files found matching '*.txt' 18:23:56 INFO - no previously-included directories found matching 'build' 18:23:56 INFO - no previously-included directories found matching 'dist' 18:23:56 INFO - no previously-included directories found matching '.git*' 18:23:56 INFO - Installing collected packages: jsonschema, functools32 18:23:56 INFO - Running setup.py install for functools32 18:23:56 INFO - warning: no files found matching '*.txt' 18:23:56 INFO - no previously-included directories found matching 'build' 18:23:56 INFO - no previously-included directories found matching 'dist' 18:23:56 INFO - no previously-included directories found matching '.git*' 18:23:56 INFO - Successfully installed jsonschema functools32 18:23:56 INFO - Cleaning up... 18:23:57 INFO - Return code: 0 18:23:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:23:57 INFO - Using env: {'DISPLAY': ':0', 18:23:57 INFO - 'HOME': '/home/cltbld', 18:23:57 INFO - 'LANG': 'en_US.UTF-8', 18:23:57 INFO - 'LANGUAGE': 'en_US:en', 18:23:57 INFO - 'LOGNAME': 'cltbld', 18:23:57 INFO - 'MAIL': '/var/mail/cltbld', 18:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:57 INFO - 'MOZ_NO_REMOTE': '1', 18:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:57 INFO - 'NO_EM_RESTART': '1', 18:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:57 INFO - 'PWD': '/builds/slave/test', 18:23:57 INFO - 'SHELL': '/bin/bash', 18:23:57 INFO - 'SHLVL': '1', 18:23:57 INFO - 'TERM': 'linux', 18:23:57 INFO - 'TMOUT': '86400', 18:23:57 INFO - 'USER': 'cltbld', 18:23:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:57 INFO - '_': '/tools/buildbot/bin/python'} 18:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:57 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:59 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:59 INFO - Downloading docopt-0.6.1.tar.gz 18:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:59 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:59 INFO - Running setup.py install for blobuploader 18:23:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:59 INFO - Running setup.py install for requests 18:24:00 INFO - Running setup.py install for docopt 18:24:00 INFO - Successfully installed blobuploader requests docopt 18:24:00 INFO - Cleaning up... 18:24:00 INFO - Return code: 0 18:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:00 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:24:00 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 18:24:00 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 18:24:00 INFO - Using env: {'DISPLAY': ':0', 18:24:00 INFO - 'HOME': '/home/cltbld', 18:24:00 INFO - 'LANG': 'en_US.UTF-8', 18:24:00 INFO - 'LANGUAGE': 'en_US:en', 18:24:00 INFO - 'LOGNAME': 'cltbld', 18:24:00 INFO - 'MAIL': '/var/mail/cltbld', 18:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:00 INFO - 'MOZ_NO_REMOTE': '1', 18:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:00 INFO - 'NO_EM_RESTART': '1', 18:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:00 INFO - 'PWD': '/builds/slave/test', 18:24:00 INFO - 'SHELL': '/bin/bash', 18:24:00 INFO - 'SHLVL': '1', 18:24:00 INFO - 'TERM': 'linux', 18:24:00 INFO - 'TMOUT': '86400', 18:24:00 INFO - 'USER': 'cltbld', 18:24:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:00 INFO - '_': '/tools/buildbot/bin/python'} 18:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:00 INFO - Running setup.py (path:/tmp/pip-bLoLmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:00 INFO - Running setup.py (path:/tmp/pip-kd6AjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:00 INFO - Running setup.py (path:/tmp/pip-BGlOcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:00 INFO - Running setup.py (path:/tmp/pip-2q5PcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:00 INFO - Running setup.py (path:/tmp/pip-RYxvnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:01 INFO - Running setup.py (path:/tmp/pip-ORoOSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:01 INFO - Running setup.py (path:/tmp/pip-dn1lsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:01 INFO - Running setup.py (path:/tmp/pip-or2bGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:01 INFO - Running setup.py (path:/tmp/pip-DFYEu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:01 INFO - Running setup.py (path:/tmp/pip-yNDDSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:01 INFO - Running setup.py (path:/tmp/pip-7Z1oy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:01 INFO - Running setup.py (path:/tmp/pip-NUeanI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:01 INFO - Running setup.py (path:/tmp/pip-Yz16xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:01 INFO - Running setup.py (path:/tmp/pip-7BiY7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:01 INFO - Running setup.py (path:/tmp/pip-S5zqE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:01 INFO - Running setup.py (path:/tmp/pip-OWX04n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:01 INFO - Running setup.py (path:/tmp/pip-DD7pdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:24:01 INFO - Running setup.py install for manifestparser 18:24:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:24:01 INFO - Running setup.py install for mozcrash 18:24:02 INFO - Running setup.py install for mozdebug 18:24:02 INFO - Running setup.py install for mozdevice 18:24:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Running setup.py install for mozfile 18:24:02 INFO - Running setup.py install for mozhttpd 18:24:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Running setup.py install for mozinfo 18:24:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Running setup.py install for mozInstall 18:24:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Running setup.py install for mozleak 18:24:02 INFO - Running setup.py install for mozlog 18:24:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:24:02 INFO - Running setup.py install for moznetwork 18:24:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:24:03 INFO - Running setup.py install for mozprocess 18:24:03 INFO - Running setup.py install for mozprofile 18:24:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:24:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:24:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:24:03 INFO - Running setup.py install for mozrunner 18:24:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:24:03 INFO - Running setup.py install for mozscreenshot 18:24:03 INFO - Running setup.py install for moztest 18:24:03 INFO - Running setup.py install for mozversion 18:24:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:24:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:24:03 INFO - Cleaning up... 18:24:03 INFO - Return code: 0 18:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:03 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:24:03 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 18:24:03 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 18:24:03 INFO - Using env: {'DISPLAY': ':0', 18:24:03 INFO - 'HOME': '/home/cltbld', 18:24:03 INFO - 'LANG': 'en_US.UTF-8', 18:24:03 INFO - 'LANGUAGE': 'en_US:en', 18:24:03 INFO - 'LOGNAME': 'cltbld', 18:24:03 INFO - 'MAIL': '/var/mail/cltbld', 18:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:03 INFO - 'MOZ_NO_REMOTE': '1', 18:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:03 INFO - 'NO_EM_RESTART': '1', 18:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:03 INFO - 'PWD': '/builds/slave/test', 18:24:03 INFO - 'SHELL': '/bin/bash', 18:24:03 INFO - 'SHLVL': '1', 18:24:03 INFO - 'TERM': 'linux', 18:24:03 INFO - 'TMOUT': '86400', 18:24:03 INFO - 'USER': 'cltbld', 18:24:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:03 INFO - '_': '/tools/buildbot/bin/python'} 18:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:03 INFO - Running setup.py (path:/tmp/pip-dvcpyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:03 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)) 18:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:03 INFO - Running setup.py (path:/tmp/pip-wHDUMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:04 INFO - Running setup.py (path:/tmp/pip-O19ETT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:04 INFO - Running setup.py (path:/tmp/pip-x3k_wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:04 INFO - Running setup.py (path:/tmp/pip-UfsHCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:04 INFO - Running setup.py (path:/tmp/pip-9hzyIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:04 INFO - Running setup.py (path:/tmp/pip-kHyZGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:04 INFO - Running setup.py (path:/tmp/pip-Ubyloi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:04 INFO - Running setup.py (path:/tmp/pip-KS63B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:04 INFO - Running setup.py (path:/tmp/pip-3O92GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:04 INFO - Running setup.py (path:/tmp/pip-31NYEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:04 INFO - Running setup.py (path:/tmp/pip-zGKRt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:04 INFO - Running setup.py (path:/tmp/pip-E91BEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:04 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)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:04 INFO - Running setup.py (path:/tmp/pip-oFTiK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:04 INFO - Running setup.py (path:/tmp/pip-aDWW19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:05 INFO - Running setup.py (path:/tmp/pip-wKFIUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:05 INFO - Running setup.py (path:/tmp/pip-w5tpCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:05 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)) 18:24:05 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)) 18:24:05 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)) 18:24:05 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)) 18:24:05 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)) 18:24:05 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)) 18:24:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:07 INFO - Downloading blessings-1.6.tar.gz 18:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:24:07 INFO - Installing collected packages: blessings 18:24:07 INFO - Running setup.py install for blessings 18:24:07 INFO - Successfully installed blessings 18:24:07 INFO - Cleaning up... 18:24:07 INFO - Return code: 0 18:24:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:07 INFO - Reading from file tmpfile_stdout 18:24:07 INFO - Current package versions: 18:24:07 INFO - argparse == 1.2.1 18:24:07 INFO - blessings == 1.6 18:24:07 INFO - blobuploader == 1.2.4 18:24:07 INFO - docopt == 0.6.1 18:24:07 INFO - functools32 == 3.2.3-2 18:24:07 INFO - jsonschema == 2.5.1 18:24:07 INFO - manifestparser == 1.1 18:24:07 INFO - mozInstall == 1.12 18:24:07 INFO - mozcrash == 0.17 18:24:07 INFO - mozdebug == 0.1 18:24:07 INFO - mozdevice == 0.48 18:24:07 INFO - mozfile == 1.2 18:24:07 INFO - mozhttpd == 0.7 18:24:07 INFO - mozinfo == 0.9 18:24:07 INFO - mozleak == 0.1 18:24:07 INFO - mozlog == 3.2 18:24:07 INFO - moznetwork == 0.27 18:24:07 INFO - mozprocess == 0.22 18:24:07 INFO - mozprofile == 0.28 18:24:07 INFO - mozrunner == 6.11 18:24:07 INFO - mozscreenshot == 0.1 18:24:07 INFO - mozsystemmonitor == 0.3 18:24:07 INFO - moztest == 0.7 18:24:07 INFO - mozversion == 1.4 18:24:07 INFO - psutil == 3.1.1 18:24:07 INFO - requests == 1.2.3 18:24:07 INFO - wsgiref == 0.1.2 18:24:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:24:07 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 18:24:07 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 18:24:07 INFO - Using env: {'DISPLAY': ':0', 18:24:07 INFO - 'HOME': '/home/cltbld', 18:24:07 INFO - 'LANG': 'en_US.UTF-8', 18:24:07 INFO - 'LANGUAGE': 'en_US:en', 18:24:07 INFO - 'LOGNAME': 'cltbld', 18:24:07 INFO - 'MAIL': '/var/mail/cltbld', 18:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:07 INFO - 'MOZ_NO_REMOTE': '1', 18:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:07 INFO - 'NO_EM_RESTART': '1', 18:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:07 INFO - 'PWD': '/builds/slave/test', 18:24:07 INFO - 'SHELL': '/bin/bash', 18:24:07 INFO - 'SHLVL': '1', 18:24:07 INFO - 'TERM': 'linux', 18:24:07 INFO - 'TMOUT': '86400', 18:24:07 INFO - 'USER': 'cltbld', 18:24:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:07 INFO - '_': '/tools/buildbot/bin/python'} 18:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 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)) 18:24:07 INFO - Cleaning up... 18:24:07 INFO - Return code: 0 18:24:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:07 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', '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 18:24:07 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 18:24:07 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 18:24:07 INFO - Using env: {'DISPLAY': ':0', 18:24:07 INFO - 'HOME': '/home/cltbld', 18:24:07 INFO - 'LANG': 'en_US.UTF-8', 18:24:07 INFO - 'LANGUAGE': 'en_US:en', 18:24:07 INFO - 'LOGNAME': 'cltbld', 18:24:07 INFO - 'MAIL': '/var/mail/cltbld', 18:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:07 INFO - 'MOZ_NO_REMOTE': '1', 18:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:07 INFO - 'NO_EM_RESTART': '1', 18:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:07 INFO - 'PWD': '/builds/slave/test', 18:24:07 INFO - 'SHELL': '/bin/bash', 18:24:07 INFO - 'SHLVL': '1', 18:24:07 INFO - 'TERM': 'linux', 18:24:07 INFO - 'TMOUT': '86400', 18:24:07 INFO - 'USER': 'cltbld', 18:24:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:07 INFO - '_': '/tools/buildbot/bin/python'} 18:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:24:07 INFO - Cleaning up... 18:24:07 INFO - Return code: 0 18:24:07 INFO - Running post-action listener: _resource_record_post_action 18:24:07 INFO - Running post-action listener: _start_resource_monitoring 18:24:07 INFO - Starting resource monitoring. 18:24:07 INFO - ##### 18:24:07 INFO - ##### Finished create-virtualenv step (success) 18:24:07 INFO - ##### 18:24:07 INFO - ##### 18:24:07 INFO - ##### Running install step. 18:24:07 INFO - ##### 18:24:07 INFO - Running pre-action listener: _resource_record_pre_action 18:24:07 INFO - Running main action method: install 18:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:08 INFO - Reading from file tmpfile_stdout 18:24:08 INFO - Detecting whether we're running mozinstall >=1.0... 18:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:24:08 INFO - Reading from file tmpfile_stdout 18:24:08 INFO - Output received: 18:24:08 INFO - Usage: mozinstall [options] installer 18:24:08 INFO - Options: 18:24:08 INFO - -h, --help show this help message and exit 18:24:08 INFO - -d DEST, --destination=DEST 18:24:08 INFO - Directory to install application into. [default: 18:24:08 INFO - "/builds/slave/test"] 18:24:08 INFO - --app=APP Application being installed. [default: firefox] 18:24:08 INFO - mkdir: /builds/slave/test/build/application 18:24:08 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'] 18:24:08 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 18:24:24 INFO - Reading from file tmpfile_stdout 18:24:24 INFO - Output received: 18:24:24 INFO - /builds/slave/test/build/application/firefox/firefox 18:24:24 INFO - Running post-action listener: _resource_record_post_action 18:24:24 INFO - ##### 18:24:24 INFO - ##### Finished install step (success) 18:24:24 INFO - ##### 18:24:24 INFO - ##### 18:24:24 INFO - ##### Running run-tests step. 18:24:24 INFO - ##### 18:24:24 INFO - Running pre-action listener: _resource_record_pre_action 18:24:24 INFO - Running main action method: run_tests 18:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:24:24 INFO - Python 2.7.3 18:24:24 INFO - Return code: 0 18:24:24 INFO - grabbing minidump binary from tooltool 18:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:24 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 0x210a3b0>, '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 0x210b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:24:24 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 18:24:24 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 18:24:24 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 18:24:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:24:24 INFO - Return code: 0 18:24:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:24:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:24:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:24:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:24:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 18:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 18:24:24 INFO - Using env: {'DISPLAY': ':0', 18:24:24 INFO - 'HOME': '/home/cltbld', 18:24:24 INFO - 'LANG': 'en_US.UTF-8', 18:24:24 INFO - 'LANGUAGE': 'en_US:en', 18:24:24 INFO - 'LOGNAME': 'cltbld', 18:24:24 INFO - 'MAIL': '/var/mail/cltbld', 18:24:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:24:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:24 INFO - 'MOZ_NO_REMOTE': '1', 18:24:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:24 INFO - 'NO_EM_RESTART': '1', 18:24:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:24 INFO - 'PWD': '/builds/slave/test', 18:24:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:24:24 INFO - 'SHELL': '/bin/bash', 18:24:24 INFO - 'SHLVL': '1', 18:24:24 INFO - 'TERM': 'linux', 18:24:24 INFO - 'TMOUT': '86400', 18:24:24 INFO - 'USER': 'cltbld', 18:24:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003', 18:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:24 INFO - '_': '/tools/buildbot/bin/python'} 18:24:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 18:24:24 INFO - mozversion application_buildid: 20160629170625 18:24:24 INFO - mozversion application_changeset: b79c51ca296e2679108429029e31f6c84ae1f0d7 18:24:24 INFO - mozversion application_display_name: Nightly 18:24:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:24:24 INFO - mozversion application_name: Firefox 18:24:24 INFO - mozversion application_remotingname: firefox 18:24:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:24:24 INFO - mozversion application_vendor: Mozilla 18:24:24 INFO - mozversion application_version: 50.0a1 18:24:24 INFO - mozversion platform_buildid: 20160629170625 18:24:24 INFO - mozversion platform_changeset: b79c51ca296e2679108429029e31f6c84ae1f0d7 18:24:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:24:24 INFO - mozversion platform_version: 50.0a1 18:24:24 INFO - using testdate: 1467249864 18:24:24 INFO - actual date: 1467249864 18:24:24 INFO - starting webserver on 'localhost:36904' 18:24:24 INFO - SUITE-START | Running 2 tests 18:24:24 INFO - TEST-START | dromaeo_css 18:24:24 INFO - operating with platform_type : linux_ 18:24:24 INFO - Initialising browser for dromaeo_css test... 18:24:24 INFO - TEST-INFO | started process 9913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiqjNL/profile http://localhost:36904/getInfo.html) 18:24:28 INFO - PROCESS | 9913 | __metrics Screen width/height:1600/1200 18:24:28 INFO - PROCESS | 9913 | colorDepth:24 18:24:28 INFO - PROCESS | 9913 | Browser inner width/height: 1024/697 18:24:28 INFO - PROCESS | 9913 | __metrics 18:24:29 INFO - PROCESS | 9913 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:24:30 INFO - TEST-INFO | 9913: exit 0 18:24:30 INFO - Browser initialized. 18:24:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:24:30 INFO - TEST-INFO | started process 9993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiqjNL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:42 INFO - PROCESS | 9993 | RSS: Main: 158945280 18:24:42 INFO - PROCESS | 9993 | 18:25:33 INFO - PROCESS | 9993 | 1467249933670 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] 18:27:46 INFO - PROCESS | 9993 | Cycle 1(1): loaded http://localhost:36904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36904/tests/dromaeo/cssquery-ext.html) 18:27:47 INFO - PROCESS | 9993 | RSS: Main: 276733952 18:27:47 INFO - PROCESS | 9993 | 18:30:50 INFO - PROCESS | 9993 | Cycle 1(1): loaded http://localhost:36904/tests/dromaeo/cssquery-ext.html (next: http://localhost:36904/tests/dromaeo/cssquery-jquery.html) 18:30:51 INFO - PROCESS | 9993 | RSS: Main: 241848320 18:30:51 INFO - PROCESS | 9993 | 18:33:53 INFO - PROCESS | 9993 | Cycle 1(1): loaded http://localhost:36904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36904/tests/dromaeo/cssquery-mootools.html) 18:33:54 INFO - PROCESS | 9993 | RSS: Main: 243064832 18:33:54 INFO - PROCESS | 9993 | 18:36:56 INFO - PROCESS | 9993 | Cycle 1(1): loaded http://localhost:36904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36904/tests/dromaeo/cssquery-prototype.html) 18:36:57 INFO - PROCESS | 9993 | RSS: Main: 241557504 18:36:57 INFO - PROCESS | 9993 | 18:40:00 INFO - PROCESS | 9993 | Cycle 1(1): loaded http://localhost:36904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36904/tests/dromaeo/cssquery-yui.html) 18:40:00 INFO - PROCESS | 9993 | RSS: Main: 224841728 18:40:00 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | Cycle 1(1): loaded http://localhost:36904/tests/dromaeo/cssquery-yui.html (next: http://localhost:36904/tests/dromaeo/cssquery-dojo.html) 18:43:03 INFO - PROCESS | 9993 | RSS: Main: 278962176 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | __start_tp_report 18:43:03 INFO - PROCESS | 9993 | _x_x_mozilla_page_load 18:43:03 INFO - PROCESS | 9993 | _x_x_mozilla_page_load_details 18:43:03 INFO - PROCESS | 9993 | |i|pagename|runs| 18:43:03 INFO - PROCESS | 9993 | |0;dojo.html;2663.507251158536;2684.744949229825;2710.7424794644503;2719.9864000680004;2726.9863650681755;4765.475797662263;4860.586850117745;4863.562279394854;4948.703077815329;4977.975110124449;4808.591269742076;4865.026994601077;4871.926921096187;4886.998165376098;4908.680935739175;4408.030233348658;4414.359917811916;4438.977805110986;4456.353828694837;4572.97713511432;4469.508354081048;4516.435445569304;4554.811761363362;4567.337736028274;4589.173948689235;4370.060437006059;4501.729896206238;4522.502524722295;4550.613197878184;4554.795034223452;4387.934180987288;4405.339199120125;4406.272964960777;4412.977935110304;4431.468223813131;4388.648908087345;4451.443569553806;4454.420925279725;4501.009777848868;4519.118771839492;4759.071980963713;4917.114919314522;4923.901521969577;4928.876778080541;4949.480304568005;5188.533032027098;5264.368275806928;5264.763085661154;5269.578433725293;5280.498352656491;5309.601779866525;5317.9202311965355;5337.546308563777;5342.946570534284;5377.596680248997;4726.834560790356;4823.734694591761;4897.4123105227245;4909.950900491021;4957.876053098629;5336.91994620081;5380.946190538045;5381.596380271495;5417.485338892799;5426.240326354314;5142.768575414116;5180.041692286939;5181.35233095863;5189.974050129726;5193.610479214074;5051.393832740095;5184.896302074013;5209.739513024334;5242.13504771716;5303.522682958553;5161.27742116104;5188.169892817131;5193.896122077537;5198.662086964335;5224.947750522522;5142.588592912558;5154.5360917516855;5159.458256883048;5159.948400516022;5208.218767184952;3997.220541994341;3999.1002024544828;4025.8590949316635;4027.456293400412;4083.448734420815;3545.7517973742106;3560.145565064366;3574.1779390740276;3597.118705917067;3610.909727256787;4424;4427.203103441347;4433.911321773547;4438.977805110953;4484.39460672805;5052.873678158002;5093.032323858455;5132.692038477703;5173.948260517347;5184.507471790174;4446.42196514451;4447.933281000787;4449.28811390176;4473.664475164311;4481.35020422037;4679.742614156254;4687.812487500461;4689.742064186503;4689.929651055237;4737.881552961204;4755.928661070017;4816.133096042746;4862.562369386772;4871.80512779492;4880.6095512358215;5200.2199670049795;5206.947930520646;5214.478552144755;5220.425753167225;5222.451642577475;4869.683470574401;4900.093482705711;4905.26421036833;4909.5090490950615;4942.4316203637045;5024.698518088926;5152.819651312186;5191.740412979411;5216.869578260574;5245.554127899171;5261.842144735664;5281.445448228034;5295.417504074471;5297.682139071668;5301.098813201842;5006;5166.225066240094;5168.457311982338;5172.405173405106;5202.583793296603;4972.776225069808;5018.824341148043;5044.54599086084;5044.621653376085;5075.3148324975655;4991.80032798684;4996.525330093636;4999.725015124203;5046.21783623539;5047.823326183566;4954.702717836942;5029.823956161516;5083.87290317745;5100.260462232881;5102;4970.179920313252;4983.476734942924;5002.2496625506465;5047.949520504748;5055.1153548128195 18:43:03 INFO - PROCESS | 9993 | |1;ext.html;568.1250873654573;578.6238944685954;579.2498714165154;593.7179839576205;603.0833133636872;27744;30762.38475230494;30767.846160769222;30859.382812343738;39533.60466395335;37720.622793772054;42714;42729.35905961413;42873.57126428735;42880.571194288044;7650.617469126535;7779.222077792204;7781.144074151839;7784.922150778476;7787.338076263524;7889.3688504919755;7967.880481792778;7985.321247693924;7986.880196797053;7994.6002699864775;7996.560189189592;8041.55771432571;8043.839123217532;8045.316148127416;8046.074701409354;7919.960400197991;7948.8410231795615;7959.880601790977;7964.681412743484;7968.880466793003;7895.486793358414;7950.688136457477;7950.880736788895;7956.602169891482;7957.403194760416;39041.804790976144;39367.60632393668;39453.21093578112;39459;39482.80258598717;3114.377124575094;3236.7410607151373;3287.293231955141;3420.589529256505;3504.246586983785;29267;29483.85258073696;29746;29792.404151917057;30548.389032219453;3386.915327116817;3415.9316813663836;3451.8274086295837;3494.178867966026;3521.2605352875926;255723;259883;261008;261084;261943;32211.51682724761;33406;52543.73728131411;53399.466005340226;53470;34134.65865341315;34303;34376.656233437345;34400.655993439745;34460.65539344624;13663.863361366259;13795.793063104062;13797.310134493235;13811.309434528233;13824.86175138256;11438.256513326774;11557.017653499379;11564.132690048113;11574.710632234093;11581.13141514373;7990.960045199737;7991.600419978978;8005.959225300674;8067.596620169085;8075.434719569574;3144.213946513372;3171.717272622824;3186.8247246401206;3212.791168574035;3212.903612891617;912.5163663258484;916.6241840845355;921.2675922641382;960.9615615375446;981.3474039763478;27892.581611275848;28798.568021479696;29011.274718132216;29085.336022444983;29498.705012950024;770.5723323555369;978.4569563891966;978.6770365779275;983.1102851919024;1001.449202938381;14713.117212967256;14746.705065898837;14756.188409637358;14892.244934687118;15077.924610376878;414510;416612;420497;421118.0496877648;421303;50378.24432633514;50895.491045089075;50968.74515627398;50979.49020509821;50991.235131473055;1092.3009274064605;1193.3198077096145;1224.8224007519038;1231.593574120538;1233.2415564427813;28544.57183142213;29963;29977.85011075018;30313.848430757706;30775;41873.79063104665;42143.57856421397;42374.576254238294;42501.574984251;42515;314833;316074;316527;317370;518231;25163.87418062898;25699.743002569736;25868.22395328143;27222;27225.183244502696;38407.39111306661;42803.57196427996;43057;44014.55985440233;44360.55639443564;37123.35958005249;37195.81402092972;37376.06559835917;38153.618463816114;38756.80621596874;37101.6289837109;37132.44301335536;37261;37391.62608373881;37605.24789504249;36498.8175059123;36704.449433257985;36956.63043369532;36985.260294793414;37233.441498377004;31794;33604;33856.26012358321;33940.66059339375;34060.82969585236;25863.482730345662;26179.476410472063;26353.25641384569;26518.900652849567;26630 18:43:03 INFO - PROCESS | 9993 | |2;jquery.html;349.08713713638844;367.8289595338167;380.9295280373131;381.0492820413068;395.4542731031178;13298.335083245835;17568.1215939203;18415.815841841562;20247.59504809903;20300.898495507503;17524.299028038895;18624.441266761984;19550.511237219078;19587.216511339528;20308.492287692814;5827.630506830902;6053.152558641794;6096.634201947875;6103.176071230371;6104.4200800923845;4151.688623353246;4554.134714404269;5899.675517846538;7233.276672332751;7249.963750181241;7106.502544821865;7366.079240094989;7402.259774022608;7415.147258065337;7417.8887316690025;7186.892196617055;7208.207097219301;7223.963880180566;7237.276272372773;7269.382102521292;3936.0553467167674;6554;6930.61881596512;6940.583564986117;6943.652817359111;24224;24644;24920.50158996828;25037;25218.369540761443;2056.475598722316;2079.6048750737314;2157.223399576151;2331.3327353015566;2647.6293318935172;13874.722505549833;15839.445619403381;15911.60220994473;16019.599510012227;16125.677486450322;1926.8554858385678;1930.0928563575237;1933.5456167800555;1936.1287420660758;2022.3932820153896;85272.14727852705;88160.5591972036;89056.10943890543;89813.55093224558;91801.54099229528;13877.520156526161;14246.287685615678;16585.50243492673;17115.14424278806;17595.12024398775;29701.85149074284;30861.382772344878;30920.536191957137;31297.8435107823;31526.21184470361;9368.156865882103;9509.809803803884;9537.713868583814;9719.951400243095;9784.804303913881;7851.528908265523;7976.441649084509;8044.33428611404;8067.677292908218;8194.713185038614;8266.628001739817;8596.140385961355;8655.6537738491;8714.91285087141;8772.385932984758;3036.316828713566;3070.8925187618324;3199;3238.5627940228237;3304.1244070321386;802.2178376083389;843.717354686187;872.5026734761125;876.6142897125244;880.903100658927;17118.828811711723;17507.410980748915;17791.55521111957;17876.463706088838;18376.173072211783;824.5588610093571;848.2323497235012;873.1966590736538;877.1535468273147;899.5232526760827;9520.523973801282;9820.508974551243;9849.753756156153;9868.111869931741;9968.700938971842;146404;360708;432308;435808;440711;87153;87578;88466;88949.55525222332;89697.82417406591;896.3904544909394;943.1323182671958;948.990510094904;953;962.412928113864;16439.178041097657;16520.504384868473;16692.332306707594;16840.747388789423;16941.407050753165;41428.58571414247;42344.153116936875;42631.67104111986;43070.35394469148;44411.777941110086;58046.7097664509;60163.39836601578;60319.69840150771;60343;60504;7612.657430415756;7678.232176782277;7726.459147859596;7875.173106823701;7994.480358776661;11540.307581545134;11564.595239166589;11693.239939403911;11806.645800625995;11818.40907954616;9136.451812891248;9244.722658320261;9273.489958052101;9409.294302927445;10084.798304034024;9649.565769540248;10073.748156296151;10163.89836101659;10327.225458090523;10573.471326433493;7822.47461744977;9363.625454981997;9405.905940940504;9548.37935534188;9787.972262912577;7667.156612772479;7772.261635144652;7933.60331983387;7955.880661790194;7998.920010799818;8592.613332400182;8967.148120928501;9063.592138353659;9092.454452732858;9310.674126405544 18:43:03 INFO - PROCESS | 9993 | |3;mootools.html;1263.4630282130092;1315.7105436803902;1377.1530508737126;1413.5617958432886;1670.3736098962888;6925.27284635113;7899.5260284382975;8188.95905520473;8193.344532437406;8194.877076843852;7907;8082.636281367338;8084.9191508084905;8095.311898488636;8100.351971842253;1905.6379287935317;1967.1737870094594;1968.724378586999;2193.6709493575972;2224.065892325227;2015.3349394699787;2199.0544066051593;2268;2268.3988742983124;2274.1812947338944;2185.1259496201487;2196.769339219383;2200.1529411176734;2200.834937379695;2204.9228277010307;1902.077492416177;2136.2416342198453;2149.355193441961;2150.924717634883;2152.0208305221086;2155.795199456049;2233.743119541241;2234.6089434349087;2235.2176738141684;2236.944076398087;8020.997375328084;8068.8386232275025;8068.878966815502;8073.071596766388;8078.23256790604;4583.610393116589;4690.9530904690855;4696.835610753641;4698.4361876574685;4700.647451441156;2829.618001569803;2916.1105862711865;2958.6597541282813;2975.3008043109853;2979.657339405953;939.7133874168376;960.5533426956429;969.3795970578835;977.3695966101895;989.0307498651362;11032.338059716443;11032.558697652084;11034.944825275903;11036.944815275872;11050.33697978124;4106.301928672133;4126.834926602963;4295.183915056129;4300.440942677432;4327.242732521796;9301.209397201314;9332.906670933204;9337.066293370608;9347.392419492711;9357.625694972261;4759.143354196278;4761.428628564595;4765.571098601074;4766.856994290177;4770.451398089194;3760.0975765816006;3787.981060094682;4313.741175529478;4315.525292217853;4321.114171594815;3620.4931309616672;3749.1564398010228;3811.2568049230135;3820.5033345665443;3834.559025712023;1150.666306771027;1152.9192956492966;1159.431878379588;1161.9128565357632;1171.2328424881716;820.6676296100089;829.7925518620345;834.3075247544524;870.8258348330232;877.3156937588691;5291.973540132275;5335.1730481775385;5371.731413429391;5442.4829641184815;5473.7263136843;392.39766957719763;394.5127767207496;396.36779336957505;400.1876191331601;407.5089517131849;3680.6687398133763;3714.88855334335;3730.6828919542145;3743.6069212732814;3778.3954567269657;9611.903880961241;10004.749881253027;10063.69808905734;10118.645847395306;10123.493825308706;9965.252606054575;9970.651027214013;9971.601135954481;9992.10071093605;9996.850047249298;7533.359664428475;7583.469157158946;7597.202293759186;7602.087749470099;7603.847923041619;5266.131088370376;5316.043112239679;5402.918956215739;5541.639793413416;5632.183333416549;8799.648014079365;9111.908880911371;9121;9259.629614815332;9375.343725939392;8624.65501379963;9119.908800911906;9127.178553929913;9333.906660933304;9348.158665719846;6026;6056.333803281724;6715.328467153246;6835.21395039557;6996.370326670624;7734.071911370672;7815.687372505264;7820.296173344426;7821.648025838965;7843.019622547182;6850.280720524273;6961.860762784817;7033.859322813618;7105.964470177616;7128.28717128283;6899.379055884994;7006.264342244195;7017.543859649107;7106.040684507525;7125.5368401053765;5843.883122337445;5851.707414629166;5911.320198177093;5916.67458289781;5931.940680593311;4472.463304403493;4507.6619253555455;4545.636349092131;4561.452625684939;4589.908201835878;4613.838515651936;4661.324108004253;4663.067386522641;4699.060187962489;4763.071201115749 18:43:03 INFO - PROCESS | 9993 | |4;prototype.html;290.2873445690829;296.69292282487623;303.68113480845136;309.2331019072699;310.86322018311944;4890.584300334472;4913.72974486404;4926.753662316888;4934.531219534143;4942.739601401647;4589.311603259504;4707.05858828234;4723.220668589679;4733.231059829995;4862.975685121578;3675.467057276693;3770.26479836432;3771.868439468169;3840.5022041403877;3882.650561449469;3829.119302560413;3862.401327794182;3864.9613503865025;3866.699313908234;3900.648941595256;3595.1910820065405;3795.7532760370486;3830.7893065881367;3837.520309961255;3870.7096967727534;3776.83004264806;3788.147666774981;3790.6967442604664;3809.466674665549;3822.503074600312;3329.252142625117;3337.332533493287;3353.144948038259;3358.7313014958745;3362.865485380582;4754.738489383082;4761.976190119027;4780.450248221464;4784.952150478485;4813.638977076734;4102.979485102585;4305.806238719234;4313.374560688714;4322.119877853144;4324.875532361577;5077.720725360104;5081.136206844845;5086.41506226785;5095.643304968654;5100.183970564729;3588.3540962626716;3602.765820221677;3603.981980090109;3613.241219343941;3622.094476380905;5164.3802743671;5337.492938170868;5346.8395948121615;5376.462353764631;5384.919226211649;3632.945505817415;3662.6520480554304;3668.0463079598962;3679.2457546202963;3679.2825399047465;3711;3717.9070523237137;3720.404735242348;3726.5900750917376;3728.55257369112;4269.231538323132;4277.465316835395;4279.486461624625;4280.229558679468;4280.5505421930875;4932.260160975882;5104.4222667553395;5105.366282789546;5107.569880433484;5164.612654050961;1236.5733821831454;1289.9358029625596;1305.8106574546637;1308.7644224039764;1312.7112035352206;843.4770442325797;860.2343913916619;863.96976105836;863.9784005399915;868.2359523619175;4452.443444569429;4463.8214471421425;4465.821367145343;4485.215087359699;4536.88657783558;5155.123628983007;5165.690058596496;5211.609129315317;5240.659357141773;5254.789808407697;4422.955770442319;4460.754658493814;4473.306637471197;4497.865064048084;4532.365468834366;2736.5621500559814;2738.315421144714;2762.350847550824;2763.157237042721;2766.336079340944;4892.804287828518;4909.263610458388;4922;4922.114019476457;4936.48166942473;5060.1903695408555;5301.920471192935;5306.363236411578;5309.548688361532;5328.49379308965;4861.708297502161;4874.268859671078;4884.340614017062;4894.8042078317185;4903.95096049035;5209.4530074343165;5221.216817477409;5224.843254702365;5234.319538459976;5240.606954478353;4855.927161092516;4996.725180115129;5057.519535644108;5063.227870245385;5096.133657278346;4871.050145221648;4878.390201224847;4880.90238195227;4885.389326334208;4902.264660300983;3724.5158129443;3731.8880433587037;3733.6079711629886;3735.2716220336774;3740.457633643161;4970.769000149931;5144.819931302386;5159.819406320761;5176.534111929945;5258.1849813279005;5005.62457815658;5044.545990860694;5051.898962020666;5063.1898896176435;5082.170418649357;5045.571126454292;5048.167052436307;5118.129917913889;5143.92284115746;5156.1492353761205;4756.262779269219;4908.63185261114;4910.9263361050325;4959.280904268933;4975.477574854733;5105.617078719185;5144.408393034699;5148.279240906351;5156.948430515647;5176.352955880515;5004.549590536869;5012.548870601663;5051.4443411224;5062.949370506248;5081.390233172043 18:43:03 INFO - PROCESS | 9993 | |5;yui.html;621.2948303675329;659.1431139518628;663.2538394306405;696.6864910790142;710.6340234779088;11463.541458341666;12315;12318.137730358878;12323.568675096361;12327.19873208242;11635.767284654323;11844;11854.703632409173;11862.82205766912;11872.050235981122;625.8748250349926;756.8675481790692;767.9616019199032;785.5090568394753;791.8772590248492;782.3037496627977;786.9645865936046;788.763370988704;789.1122487201898;789.3290702902516;832.7918020494876;832.854250506162;834.4242472693821;835.1356346181703;835.2148979958849;652.774792696519;793.7261644732558;822.3996482567759;823.6622984576355;824.6124321568853;605.8636806718497;606.3118360660682;606.854354954812;607.6627471753176;607.9331273559905;11941.701457463547;11956.641300760992;11983.760324793542;12001.87998120025;12003.219790713663;11125;11192.328460292409;11257.324560526395;11504.942475287653;11880.287182768976;11177.385243811586;11310.09519238459;11397.48711307985;11408.429578521123;11459.427028648533;4089.120839019595;4109.773962432065;4119.752814831119;4167.249895018896;4226.028013556868;55608;57696.71151644257;58023;65740;65922.67038664776;8880.955595222113;9557.474338911288;9625.470599117116;9699.757506062264;9906.65326713576;16659.583510412336;17882.642347152985;17894.821051789575;17941.7308740369;17954.461366159037;6542.247641521286;6621.503387245976;6645.1361323027695;6912.930870691229;6997.195322537871;3511.438169892805;3701.2967536168044;3855.4602355670227;3862.24686186191;3862.942055869164;2788.4004938938224;2891.1760148357616;2892.985535072311;2900.448914706199;2904.433635441069;514.354485121178;540.8215288954635;543.1228565866098;556.3102399896464;562.4825160852026;488.02151685870314;592.3572923378097;604.5616927727363;613.227333559718;642.5566359212129;7707.961460192663;8116.2695357418115;8146.2261085196815;8280.985415414912;8424.989001319758;512.869218349326;559;597.8983572792636;608.6317777744489;643.787550108463;3859.4017927221325;3878.7478813877005;3932;3944.6449819516383;4075.286824805647;78002;81144;81437;94729;98215;48397.27404088942;49575;49747.751261243466;50562.74718626457;65956;46664.300035499495;72166.63916680383;74970.62514687501;75015;76528.61735691398;8170.346372290083;8238.876416853871;8434.873476897974;8499;8508.319334453105;37531;40437.59562404456;42651.3602295972;43099.56900431081;43694.56305436905;57970.42029579819;58060.419395805504;59539.702301489946;61565.384346157756;62045.37954620396;10655.200859935381;10700.090492308242;10919.508622111865;10935.56257749681;11115.944420277847;10107.69676909694;12065.638030859089;12079.214851034654;12611.93694031524;13029.47882084706;8576.914230857861;11157.609483668033;11801.173917826014;11840.644780656594;12175.939120304341;11966.880331196577;12001.39993000364;12262.4481898313;12750.553730619384;12767.425465854245;11823.467943942715;12477.064220183704;12487.375631218585;12506.624801255977;12637.620871373874;8930.240929520804;9281;9524.571394287135;10300.742481438025;10458.320209186379;9542.761430964281;9706.70879873605;9708.2718796092;9822.508874556386;9882.357646752938 18:43:03 INFO - PROCESS | 9993 | __end_tp_report 18:43:03 INFO - PROCESS | 9993 | __start_cc_report 18:43:03 INFO - PROCESS | 9993 | _x_x_mozilla_cycle_collect,1121 18:43:03 INFO - PROCESS | 9993 | __end_cc_report 18:43:03 INFO - PROCESS | 9993 | __startTimestamp1467250983881__endTimestamp 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | ------- Summary: start ------- 18:43:03 INFO - PROCESS | 9993 | Number of tests: 6 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | [#0] dojo.html Cycles:165 Average:4796.69 Median:4949.48 stddev:546.72 (11.0%) stddev-sans-first:522.16 18:43:03 INFO - PROCESS | 9993 | Values: 2663.5 2684.7 2710.7 2720.0 2727.0 4765.5 4860.6 4863.6 4948.7 4978.0 4808.6 4865.0 4871.9 4887.0 4908.7 4408.0 4414.4 4439.0 4456.4 4573.0 4469.5 4516.4 4554.8 4567.3 4589.2 4370.1 4501.7 4522.5 4550.6 4554.8 4387.9 4405.3 4406.3 4413.0 4431.5 4388.6 4451.4 4454.4 4501.0 4519.1 4759.1 4917.1 4923.9 4928.9 4949.5 5188.5 5264.4 5264.8 5269.6 5280.5 5309.6 5317.9 5337.5 5342.9 5377.6 4726.8 4823.7 4897.4 4910.0 4957.9 5336.9 5380.9 5381.6 5417.5 5426.2 5142.8 5180.0 5181.4 5190.0 5193.6 5051.4 5184.9 5209.7 5242.1 5303.5 5161.3 5188.2 5193.9 5198.7 5224.9 5142.6 5154.5 5159.5 5159.9 5208.2 3997.2 3999.1 4025.9 4027.5 4083.4 3545.8 3560.1 3574.2 3597.1 3610.9 4424.0 4427.2 4433.9 4439.0 4484.4 5052.9 5093.0 5132.7 5173.9 5184.5 4446.4 4447.9 4449.3 4473.7 4481.4 4679.7 4687.8 4689.7 4689.9 4737.9 4755.9 4816.1 4862.6 4871.8 4880.6 5200.2 5206.9 5214.5 5220.4 5222.5 4869.7 4900.1 4905.3 4909.5 4942.4 5024.7 5152.8 5191.7 5216.9 5245.6 5261.8 5281.4 5295.4 5297.7 5301.1 5006.0 5166.2 5168.5 5172.4 5202.6 4972.8 5018.8 5044.5 5044.6 5075.3 4991.8 4996.5 4999.7 5046.2 5047.8 4954.7 5029.8 5083.9 5100.3 5102.0 4970.2 4983.5 5002.2 5047.9 5055.1 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | [#1] ext.html Cycles:180 Average:48647.09 Median:37112.49 stddev:93884.72 (253.0%) stddev-sans-first:94078.69 18:43:03 INFO - PROCESS | 9993 | Values: 568.1 578.6 579.2 593.7 603.1 27744.0 30762.4 30767.8 30859.4 39533.6 37720.6 42714.0 42729.4 42873.6 42880.6 7650.6 7779.2 7781.1 7784.9 7787.3 7889.4 7967.9 7985.3 7986.9 7994.6 7996.6 8041.6 8043.8 8045.3 8046.1 7920.0 7948.8 7959.9 7964.7 7968.9 7895.5 7950.7 7950.9 7956.6 7957.4 39041.8 39367.6 39453.2 39459.0 39482.8 3114.4 3236.7 3287.3 3420.6 3504.2 29267.0 29483.9 29746.0 29792.4 30548.4 3386.9 3415.9 3451.8 3494.2 3521.3 255723.0 259883.0 261008.0 261084.0 261943.0 32211.5 33406.0 52543.7 53399.5 53470.0 34134.7 34303.0 34376.7 34400.7 34460.7 13663.9 13795.8 13797.3 13811.3 13824.9 11438.3 11557.0 11564.1 11574.7 11581.1 7991.0 7991.6 8006.0 8067.6 8075.4 3144.2 3171.7 3186.8 3212.8 3212.9 912.5 916.6 921.3 961.0 981.3 27892.6 28798.6 29011.3 29085.3 29498.7 770.6 978.5 978.7 983.1 1001.4 14713.1 14746.7 14756.2 14892.2 15077.9 414510.0 416612.0 420497.0 421118.0 421303.0 50378.2 50895.5 50968.7 50979.5 50991.2 1092.3 1193.3 1224.8 1231.6 1233.2 28544.6 29963.0 29977.9 30313.8 30775.0 41873.8 42143.6 42374.6 42501.6 42515.0 314833.0 316074.0 316527.0 317370.0 518231.0 25163.9 25699.7 25868.2 27222.0 27225.2 38407.4 42803.6 43057.0 44014.6 44360.6 37123.4 37195.8 37376.1 38153.6 38756.8 37101.6 37132.4 37261.0 37391.6 37605.2 36498.8 36704.4 36956.6 36985.3 37233.4 31794.0 33604.0 33856.3 33940.7 34060.8 25863.5 26179.5 26353.3 26518.9 26630.0 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | [#2] jquery.html Cycles:180 Average:26273.89 Median:6074.89 stddev:63713.18 (1048.8%) stddev-sans-first:63862.18 18:43:03 INFO - PROCESS | 9993 | Values: 349.1 367.8 380.9 381.0 395.5 13298.3 17568.1 18415.8 20247.6 20300.9 17524.3 18624.4 19550.5 19587.2 20308.5 5827.6 6053.2 6096.6 6103.2 6104.4 4151.7 4554.1 5899.7 7233.3 7250.0 7106.5 7366.1 7402.3 7415.1 7417.9 7186.9 7208.2 7224.0 7237.3 7269.4 3936.1 6554.0 6930.6 6940.6 6943.7 24224.0 24644.0 24920.5 25037.0 25218.4 2056.5 2079.6 2157.2 2331.3 2647.6 13874.7 15839.4 15911.6 16019.6 16125.7 1926.9 1930.1 1933.5 1936.1 2022.4 85272.1 88160.6 89056.1 89813.6 91801.5 13877.5 14246.3 16585.5 17115.1 17595.1 29701.9 30861.4 30920.5 31297.8 31526.2 9368.2 9509.8 9537.7 9720.0 9784.8 7851.5 7976.4 8044.3 8067.7 8194.7 8266.6 8596.1 8655.7 8714.9 8772.4 3036.3 3070.9 3199.0 3238.6 3304.1 802.2 843.7 872.5 876.6 880.9 17118.8 17507.4 17791.6 17876.5 18376.2 824.6 848.2 873.2 877.2 899.5 9520.5 9820.5 9849.8 9868.1 9968.7 146404.0 360708.0 432308.0 435808.0 440711.0 87153.0 87578.0 88466.0 88949.6 89697.8 896.4 943.1 949.0 953.0 962.4 16439.2 16520.5 16692.3 16840.7 16941.4 41428.6 42344.2 42631.7 43070.4 44411.8 58046.7 60163.4 60319.7 60343.0 60504.0 7612.7 7678.2 7726.5 7875.2 7994.5 11540.3 11564.6 11693.2 11806.6 11818.4 9136.5 9244.7 9273.5 9409.3 10084.8 9649.6 10073.7 10163.9 10327.2 10573.5 7822.5 9363.6 9405.9 9548.4 9788.0 7667.2 7772.3 7933.6 7955.9 7998.9 8592.6 8967.1 9063.6 9092.5 9310.7 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | [#3] mootools.html Cycles:180 Average:5228.11 Median:4764.32 stddev:3004.16 (63.1%) stddev-sans-first:2997.81 18:43:03 INFO - PROCESS | 9993 | Values: 1263.5 1315.7 1377.2 1413.6 1670.4 6925.3 7899.5 8189.0 8193.3 8194.9 7907.0 8082.6 8084.9 8095.3 8100.4 1905.6 1967.2 1968.7 2193.7 2224.1 2015.3 2199.1 2268.0 2268.4 2274.2 2185.1 2196.8 2200.2 2200.8 2204.9 1902.1 2136.2 2149.4 2150.9 2152.0 2155.8 2233.7 2234.6 2235.2 2236.9 8021.0 8068.8 8068.9 8073.1 8078.2 4583.6 4691.0 4696.8 4698.4 4700.6 2829.6 2916.1 2958.7 2975.3 2979.7 939.7 960.6 969.4 977.4 989.0 11032.3 11032.6 11034.9 11036.9 11050.3 4106.3 4126.8 4295.2 4300.4 4327.2 9301.2 9332.9 9337.1 9347.4 9357.6 4759.1 4761.4 4765.6 4766.9 4770.5 3760.1 3788.0 4313.7 4315.5 4321.1 3620.5 3749.2 3811.3 3820.5 3834.6 1150.7 1152.9 1159.4 1161.9 1171.2 820.7 829.8 834.3 870.8 877.3 5292.0 5335.2 5371.7 5442.5 5473.7 392.4 394.5 396.4 400.2 407.5 3680.7 3714.9 3730.7 3743.6 3778.4 9611.9 10004.7 10063.7 10118.6 10123.5 9965.3 9970.7 9971.6 9992.1 9996.9 7533.4 7583.5 7597.2 7602.1 7603.8 5266.1 5316.0 5402.9 5541.6 5632.2 8799.6 9111.9 9121.0 9259.6 9375.3 8624.7 9119.9 9127.2 9333.9 9348.2 6026.0 6056.3 6715.3 6835.2 6996.4 7734.1 7815.7 7820.3 7821.6 7843.0 6850.3 6961.9 7033.9 7106.0 7128.3 6899.4 7006.3 7017.5 7106.0 7125.5 5843.9 5851.7 5911.3 5916.7 5931.9 4472.5 4507.7 4545.6 4561.5 4589.9 4613.8 4661.3 4663.1 4699.1 4763.1 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | [#4] prototype.html Cycles:180 Average:4214.38 Median:4858.82 stddev:1220.86 (25.1%) stddev-sans-first:1188.23 18:43:03 INFO - PROCESS | 9993 | Values: 290.3 296.7 303.7 309.2 310.9 4890.6 4913.7 4926.8 4934.5 4942.7 4589.3 4707.1 4723.2 4733.2 4863.0 3675.5 3770.3 3771.9 3840.5 3882.7 3829.1 3862.4 3865.0 3866.7 3900.6 3595.2 3795.8 3830.8 3837.5 3870.7 3776.8 3788.1 3790.7 3809.5 3822.5 3329.3 3337.3 3353.1 3358.7 3362.9 4754.7 4762.0 4780.5 4785.0 4813.6 4103.0 4305.8 4313.4 4322.1 4324.9 5077.7 5081.1 5086.4 5095.6 5100.2 3588.4 3602.8 3604.0 3613.2 3622.1 5164.4 5337.5 5346.8 5376.5 5384.9 3632.9 3662.7 3668.0 3679.2 3679.3 3711.0 3717.9 3720.4 3726.6 3728.6 4269.2 4277.5 4279.5 4280.2 4280.6 4932.3 5104.4 5105.4 5107.6 5164.6 1236.6 1289.9 1305.8 1308.8 1312.7 843.5 860.2 864.0 864.0 868.2 4452.4 4463.8 4465.8 4485.2 4536.9 5155.1 5165.7 5211.6 5240.7 5254.8 4423.0 4460.8 4473.3 4497.9 4532.4 2736.6 2738.3 2762.4 2763.2 2766.3 4892.8 4909.3 4922.0 4922.1 4936.5 5060.2 5301.9 5306.4 5309.5 5328.5 4861.7 4874.3 4884.3 4894.8 4904.0 5209.5 5221.2 5224.8 5234.3 5240.6 4855.9 4996.7 5057.5 5063.2 5096.1 4871.1 4878.4 4880.9 4885.4 4902.3 3724.5 3731.9 3733.6 3735.3 3740.5 4970.8 5144.8 5159.8 5176.5 5258.2 5005.6 5044.5 5051.9 5063.2 5082.2 5045.6 5048.2 5118.1 5143.9 5156.1 4756.3 4908.6 4910.9 4959.3 4975.5 5105.6 5144.4 5148.3 5156.9 5176.4 5004.5 5012.5 5051.4 5062.9 5081.4 18:43:03 INFO - PROCESS | 9993 | 18:43:03 INFO - PROCESS | 9993 | [#5] yui.html Cycles:180 Average:16073.70 Median:549.72 stddev:21941.22 (3991.4%) stddev-sans-first:21972.09 18:43:03 INFO - PROCESS | 9993 | Values: 621.3 659.1 663.3 696.7 710.6 11463.5 12315.0 12318.1 12323.6 12327.2 11635.8 11844.0 11854.7 11862.8 11872.1 625.9 756.9 768.0 785.5 791.9 782.3 787.0 788.8 789.1 789.3 832.8 832.9 834.4 835.1 835.2 652.8 793.7 822.4 823.7 824.6 605.9 606.3 606.9 607.7 607.9 11941.7 11956.6 11983.8 12001.9 12003.2 11125.0 11192.3 11257.3 11504.9 11880.3 11177.4 11310.1 11397.5 11408.4 11459.4 4089.1 4109.8 4119.8 4167.2 4226.0 55608.0 57696.7 58023.0 65740.0 65922.7 8881.0 9557.5 9625.5 9699.8 9906.7 16659.6 17882.6 17894.8 17941.7 17954.5 6542.2 6621.5 6645.1 6912.9 6997.2 3511.4 3701.3 3855.5 3862.2 3862.9 2788.4 2891.2 2893.0 2900.4 2904.4 514.4 540.8 543.1 556.3 562.5 488.0 592.4 604.6 613.2 642.6 7708.0 8116.3 8146.2 8281.0 8425.0 512.9 559.0 597.9 608.6 643.8 3859.4 3878.7 3932.0 3944.6 4075.3 78002.0 81144.0 81437.0 94729.0 98215.0 48397.3 49575.0 49747.8 50562.7 65956.0 46664.3 72166.6 74970.6 75015.0 76528.6 8170.3 8238.9 8434.9 8499.0 8508.3 37531.0 40437.6 42651.4 43099.6 43694.6 57970.4 58060.4 59539.7 61565.4 62045.4 10655.2 10700.1 10919.5 10935.6 11115.9 10107.7 12065.6 12079.2 12611.9 13029.5 8576.9 11157.6 11801.2 11840.6 12175.9 11966.9 12001.4 12262.4 12750.6 12767.4 11823.5 12477.1 12487.4 12506.6 12637.6 8930.2 9281.0 9524.6 10300.7 10458.3 9542.8 9706.7 9708.3 9822.5 9882.4 18:43:03 INFO - PROCESS | 9993 | -------- Summary: end -------- 18:43:03 INFO - PROCESS | 9993 | 18:43:04 INFO - TEST-INFO | 9993: exit 0 18:43:04 INFO - TEST-OK | dromaeo_css | took 1119898ms 18:43:04 INFO - TEST-START | kraken 18:43:04 INFO - operating with platform_type : linux_ 18:43:04 INFO - Initialising browser for kraken test... 18:43:04 INFO - TEST-INFO | started process 10178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2v6Kk/profile http://localhost:36904/getInfo.html) 18:43:08 INFO - PROCESS | 10178 | __metrics Screen width/height:1600/1200 18:43:08 INFO - PROCESS | 10178 | colorDepth:24 18:43:08 INFO - PROCESS | 10178 | Browser inner width/height: 1024/697 18:43:08 INFO - PROCESS | 10178 | __metrics 18:43:09 INFO - PROCESS | 10178 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:43:10 INFO - TEST-INFO | 10178: exit 0 18:43:10 INFO - Browser initialized. 18:43:10 INFO - Running cycle 1/1 for kraken test... 18:43:10 INFO - TEST-INFO | started process 10261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd2v6Kk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:22 INFO - PROCESS | 10261 | RSS: Main: 158785536 18:43:22 INFO - PROCESS | 10261 | 18:43:25 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36904/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:26 INFO - PROCESS | 10261 | RSS: Main: 217432064 18:43:26 INFO - PROCESS | 10261 | 18:43:29 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36904/tests/kraken/driver.html?testName=audio-dft) 18:43:29 INFO - PROCESS | 10261 | RSS: Main: 204578816 18:43:29 INFO - PROCESS | 10261 | 18:43:32 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36904/tests/kraken/driver.html?testName=audio-fft) 18:43:33 INFO - PROCESS | 10261 | RSS: Main: 271650816 18:43:33 INFO - PROCESS | 10261 | 18:43:35 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36904/tests/kraken/driver.html?testName=audio-oscillator) 18:43:36 INFO - PROCESS | 10261 | RSS: Main: 182185984 18:43:36 INFO - PROCESS | 10261 | 18:43:38 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:43:39 INFO - PROCESS | 10261 | RSS: Main: 185847808 18:43:39 INFO - PROCESS | 10261 | 18:43:42 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36904/tests/kraken/driver.html?testName=imaging-darkroom) 18:43:42 INFO - PROCESS | 10261 | RSS: Main: 222097408 18:43:42 INFO - PROCESS | 10261 | 18:43:46 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36904/tests/kraken/driver.html?testName=imaging-desaturate) 18:43:47 INFO - PROCESS | 10261 | RSS: Main: 217636864 18:43:47 INFO - PROCESS | 10261 | 18:43:49 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36904/tests/kraken/driver.html?testName=json-parse-financial) 18:43:50 INFO - PROCESS | 10261 | RSS: Main: 220459008 18:43:50 INFO - PROCESS | 10261 | 18:43:52 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:43:52 INFO - PROCESS | 10261 | RSS: Main: 206958592 18:43:52 INFO - PROCESS | 10261 | 18:43:54 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:43:55 INFO - PROCESS | 10261 | RSS: Main: 212713472 18:43:55 INFO - PROCESS | 10261 | 18:43:57 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:43:58 INFO - PROCESS | 10261 | RSS: Main: 210595840 18:43:58 INFO - PROCESS | 10261 | 18:44:00 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:44:01 INFO - PROCESS | 10261 | RSS: Main: 223793152 18:44:01 INFO - PROCESS | 10261 | 18:44:04 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:44:04 INFO - PROCESS | 10261 | RSS: Main: 225792000 18:44:04 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | Cycle 1(1): loaded http://localhost:36904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36904/tests/kraken/driver.html?testName=ai-astar) 18:44:06 INFO - PROCESS | 10261 | RSS: Main: 267702272 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | __start_tp_report 18:44:06 INFO - PROCESS | 10261 | _x_x_mozilla_page_load 18:44:06 INFO - PROCESS | 10261 | _x_x_mozilla_page_load_details 18:44:06 INFO - PROCESS | 10261 | |i|pagename|runs| 18:44:06 INFO - PROCESS | 10261 | |0;ai-astar;104;114;112;113;115;112;113;114;112;115 18:44:06 INFO - PROCESS | 10261 | |1;audio-beat-detection;153;122;126;174;129;123;160;122;159;122 18:44:06 INFO - PROCESS | 10261 | |2;audio-dft;163;161;160;161;163;163;162;164;162;161 18:44:06 INFO - PROCESS | 10261 | |3;audio-fft;76;77;76;101;76;76;75;76;101;76 18:44:06 INFO - PROCESS | 10261 | |4;audio-oscillator;86;86;117;84;85;86;118;84;85;122 18:44:06 INFO - PROCESS | 10261 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;118;116 18:44:06 INFO - PROCESS | 10261 | |6;imaging-darkroom;147;147;147;146;147;146;147;146;146;147 18:44:06 INFO - PROCESS | 10261 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 18:44:06 INFO - PROCESS | 10261 | |8;json-parse-financial;64;63;64;63;64;63;63;65;63;63 18:44:06 INFO - PROCESS | 10261 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;64;64 18:44:06 INFO - PROCESS | 10261 | |10;stanford-crypto-aes;79;79;78;78;78;78;80;85;84;78 18:44:06 INFO - PROCESS | 10261 | |11;stanford-crypto-ccm;129;128;129;128;136;129;128;127;181;139 18:44:06 INFO - PROCESS | 10261 | |12;stanford-crypto-pbkdf2;168;165;168;169;167;168;167;168;164;164 18:44:06 INFO - PROCESS | 10261 | |13;stanford-crypto-sha256-iterative;71;70;70;70;66;70;67;66;66;66 18:44:06 INFO - PROCESS | 10261 | __end_tp_report 18:44:06 INFO - PROCESS | 10261 | __start_cc_report 18:44:06 INFO - PROCESS | 10261 | _x_x_mozilla_cycle_collect,1903 18:44:06 INFO - PROCESS | 10261 | __end_cc_report 18:44:06 INFO - PROCESS | 10261 | __startTimestamp1467251046956__endTimestamp 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | ------- Summary: start ------- 18:44:06 INFO - PROCESS | 10261 | Number of tests: 14 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.17 (2.8%) stddev-sans-first:1.22 18:44:06 INFO - PROCESS | 10261 | Values: 104.0 114.0 112.0 113.0 115.0 112.0 113.0 114.0 112.0 115.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:141.00 stddev:20.15 (14.3%) stddev-sans-first:20.73 18:44:06 INFO - PROCESS | 10261 | Values: 153.0 122.0 126.0 174.0 129.0 123.0 160.0 122.0 159.0 122.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 18:44:06 INFO - PROCESS | 10261 | Values: 163.0 161.0 160.0 161.0 163.0 163.0 162.0 164.0 162.0 161.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:10.55 (13.9%) stddev-sans-first:11.04 18:44:06 INFO - PROCESS | 10261 | Values: 76.0 77.0 76.0 101.0 76.0 76.0 75.0 76.0 101.0 76.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.00 stddev:16.42 (19.3%) stddev-sans-first:17.07 18:44:06 INFO - PROCESS | 10261 | Values: 86.0 86.0 117.0 84.0 85.0 86.0 118.0 84.0 85.0 122.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 18:44:06 INFO - PROCESS | 10261 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:44:06 INFO - PROCESS | 10261 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:44:06 INFO - PROCESS | 10261 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 18:44:06 INFO - PROCESS | 10261 | Values: 64.0 63.0 64.0 63.0 64.0 63.0 63.0 65.0 63.0 63.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 18:44:06 INFO - PROCESS | 10261 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:2.63 (3.3%) stddev-sans-first:2.77 18:44:06 INFO - PROCESS | 10261 | Values: 79.0 79.0 78.0 78.0 78.0 78.0 80.0 85.0 84.0 78.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:129.00 stddev:16.50 (12.8%) stddev-sans-first:17.34 18:44:06 INFO - PROCESS | 10261 | Values: 129.0 128.0 129.0 128.0 136.0 129.0 128.0 127.0 181.0 139.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:168.00 stddev:1.81 (1.1%) stddev-sans-first:1.87 18:44:06 INFO - PROCESS | 10261 | Values: 168.0 165.0 168.0 169.0 167.0 168.0 167.0 168.0 164.0 164.0 18:44:06 INFO - PROCESS | 10261 | 18:44:06 INFO - PROCESS | 10261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:70.00 stddev:2.15 (3.1%) stddev-sans-first:2.03 18:44:06 INFO - PROCESS | 10261 | Values: 71.0 70.0 70.0 70.0 66.0 70.0 67.0 66.0 66.0 66.0 18:44:06 INFO - PROCESS | 10261 | -------- Summary: end -------- 18:44:06 INFO - PROCESS | 10261 | 18:44:07 INFO - TEST-INFO | 10261: exit 0 18:44:08 INFO - TEST-OK | kraken | took 63319ms 18:44:08 INFO - SUITE-END | took 1183s 18:44:08 INFO - Completed test suite (00:19:43) 18:44:08 INFO - javascript benchmark 18:44:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.507251158536, 2684.744949229825, 2710.7424794644503, 2719.9864000680004, 2726.9863650681755, 4765.475797662263, 4860.586850117745, 4863.562279394854, 4948.703077815329, 4977.975110124449, 4808.591269742076, 4865.026994601077, 4871.926921096187, 4886.998165376098, 4908.680935739175, 4408.030233348658, 4414.359917811916, 4438.977805110986, 4456.353828694837, 4572.97713511432, 4469.508354081048, 4516.435445569304, 4554.811761363362, 4567.337736028274, 4589.173948689235, 4370.060437006059, 4501.729896206238, 4522.502524722295, 4550.613197878184, 4554.795034223452, 4387.934180987288, 4405.339199120125, 4406.272964960777, 4412.977935110304, 4431.468223813131, 4388.648908087345, 4451.443569553806, 4454.420925279725, 4501.009777848868, 4519.118771839492, 4759.071980963713, 4917.114919314522, 4923.901521969577, 4928.876778080541, 4949.480304568005, 5188.533032027098, 5264.368275806928, 5264.763085661154, 5269.578433725293, 5280.498352656491, 5309.601779866525, 5317.9202311965355, 5337.546308563777, 5342.946570534284, 5377.596680248997, 4726.834560790356, 4823.734694591761, 4897.4123105227245, 4909.950900491021, 4957.876053098629, 5336.91994620081, 5380.946190538045, 5381.596380271495, 5417.485338892799, 5426.240326354314, 5142.768575414116, 5180.041692286939, 5181.35233095863, 5189.974050129726, 5193.610479214074, 5051.393832740095, 5184.896302074013, 5209.739513024334, 5242.13504771716, 5303.522682958553, 5161.27742116104, 5188.169892817131, 5193.896122077537, 5198.662086964335, 5224.947750522522, 5142.588592912558, 5154.5360917516855, 5159.458256883048, 5159.948400516022, 5208.218767184952, 3997.220541994341, 3999.1002024544828, 4025.8590949316635, 4027.456293400412, 4083.448734420815, 3545.7517973742106, 3560.145565064366, 3574.1779390740276, 3597.118705917067, 3610.909727256787, 4424.0, 4427.203103441347, 4433.911321773547, 4438.977805110953, 4484.39460672805, 5052.873678158002, 5093.032323858455, 5132.692038477703, 5173.948260517347, 5184.507471790174, 4446.42196514451, 4447.933281000787, 4449.28811390176, 4473.664475164311, 4481.35020422037, 4679.742614156254, 4687.812487500461, 4689.742064186503, 4689.929651055237, 4737.881552961204, 4755.928661070017, 4816.133096042746, 4862.562369386772, 4871.80512779492, 4880.6095512358215, 5200.2199670049795, 5206.947930520646, 5214.478552144755, 5220.425753167225, 5222.451642577475, 4869.683470574401, 4900.093482705711, 4905.26421036833, 4909.5090490950615, 4942.4316203637045, 5024.698518088926, 5152.819651312186, 5191.740412979411, 5216.869578260574, 5245.554127899171, 5261.842144735664, 5281.445448228034, 5295.417504074471, 5297.682139071668, 5301.098813201842, 5006.0, 5166.225066240094, 5168.457311982338, 5172.405173405106, 5202.583793296603, 4972.776225069808, 5018.824341148043, 5044.54599086084, 5044.621653376085, 5075.3148324975655, 4991.80032798684, 4996.525330093636, 4999.725015124203, 5046.21783623539, 5047.823326183566, 4954.702717836942, 5029.823956161516, 5083.87290317745, 5100.260462232881, 5102.0, 4970.179920313252, 4983.476734942924, 5002.2496625506465, 5047.949520504748, 5055.1153548128195], "value": 4759.092308784958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1250873654573, 578.6238944685954, 579.2498714165154, 593.7179839576205, 603.0833133636872, 27744.0, 30762.38475230494, 30767.846160769222, 30859.382812343738, 39533.60466395335, 37720.622793772054, 42714.0, 42729.35905961413, 42873.57126428735, 42880.571194288044, 7650.617469126535, 7779.222077792204, 7781.144074151839, 7784.922150778476, 7787.338076263524, 7889.3688504919755, 7967.880481792778, 7985.321247693924, 7986.880196797053, 7994.6002699864775, 7996.560189189592, 8041.55771432571, 8043.839123217532, 8045.316148127416, 8046.074701409354, 7919.960400197991, 7948.8410231795615, 7959.880601790977, 7964.681412743484, 7968.880466793003, 7895.486793358414, 7950.688136457477, 7950.880736788895, 7956.602169891482, 7957.403194760416, 39041.804790976144, 39367.60632393668, 39453.21093578112, 39459.0, 39482.80258598717, 3114.377124575094, 3236.7410607151373, 3287.293231955141, 3420.589529256505, 3504.246586983785, 29267.0, 29483.85258073696, 29746.0, 29792.404151917057, 30548.389032219453, 3386.915327116817, 3415.9316813663836, 3451.8274086295837, 3494.178867966026, 3521.2605352875926, 255723.0, 259883.0, 261008.0, 261084.0, 261943.0, 32211.51682724761, 33406.0, 52543.73728131411, 53399.466005340226, 53470.0, 34134.65865341315, 34303.0, 34376.656233437345, 34400.655993439745, 34460.65539344624, 13663.863361366259, 13795.793063104062, 13797.310134493235, 13811.309434528233, 13824.86175138256, 11438.256513326774, 11557.017653499379, 11564.132690048113, 11574.710632234093, 11581.13141514373, 7990.960045199737, 7991.600419978978, 8005.959225300674, 8067.596620169085, 8075.434719569574, 3144.213946513372, 3171.717272622824, 3186.8247246401206, 3212.791168574035, 3212.903612891617, 912.5163663258484, 916.6241840845355, 921.2675922641382, 960.9615615375446, 981.3474039763478, 27892.581611275848, 28798.568021479696, 29011.274718132216, 29085.336022444983, 29498.705012950024, 770.5723323555369, 978.4569563891966, 978.6770365779275, 983.1102851919024, 1001.449202938381, 14713.117212967256, 14746.705065898837, 14756.188409637358, 14892.244934687118, 15077.924610376878, 414510.0, 416612.0, 420497.0, 421118.0496877648, 421303.0, 50378.24432633514, 50895.491045089075, 50968.74515627398, 50979.49020509821, 50991.235131473055, 1092.3009274064605, 1193.3198077096145, 1224.8224007519038, 1231.593574120538, 1233.2415564427813, 28544.57183142213, 29963.0, 29977.85011075018, 30313.848430757706, 30775.0, 41873.79063104665, 42143.57856421397, 42374.576254238294, 42501.574984251, 42515.0, 314833.0, 316074.0, 316527.0, 317370.0, 518231.0, 25163.87418062898, 25699.743002569736, 25868.22395328143, 27222.0, 27225.183244502696, 38407.39111306661, 42803.57196427996, 43057.0, 44014.55985440233, 44360.55639443564, 37123.35958005249, 37195.81402092972, 37376.06559835917, 38153.618463816114, 38756.80621596874, 37101.6289837109, 37132.44301335536, 37261.0, 37391.62608373881, 37605.24789504249, 36498.8175059123, 36704.449433257985, 36956.63043369532, 36985.260294793414, 37233.441498377004, 31794.0, 33604.0, 33856.26012358321, 33940.66059339375, 34060.82969585236, 25863.482730345662, 26179.476410472063, 26353.25641384569, 26518.900652849567, 26630.0], "value": 16762.482155565798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.08713713638844, 367.8289595338167, 380.9295280373131, 381.0492820413068, 395.4542731031178, 13298.335083245835, 17568.1215939203, 18415.815841841562, 20247.59504809903, 20300.898495507503, 17524.299028038895, 18624.441266761984, 19550.511237219078, 19587.216511339528, 20308.492287692814, 5827.630506830902, 6053.152558641794, 6096.634201947875, 6103.176071230371, 6104.4200800923845, 4151.688623353246, 4554.134714404269, 5899.675517846538, 7233.276672332751, 7249.963750181241, 7106.502544821865, 7366.079240094989, 7402.259774022608, 7415.147258065337, 7417.8887316690025, 7186.892196617055, 7208.207097219301, 7223.963880180566, 7237.276272372773, 7269.382102521292, 3936.0553467167674, 6554.0, 6930.61881596512, 6940.583564986117, 6943.652817359111, 24224.0, 24644.0, 24920.50158996828, 25037.0, 25218.369540761443, 2056.475598722316, 2079.6048750737314, 2157.223399576151, 2331.3327353015566, 2647.6293318935172, 13874.722505549833, 15839.445619403381, 15911.60220994473, 16019.599510012227, 16125.677486450322, 1926.8554858385678, 1930.0928563575237, 1933.5456167800555, 1936.1287420660758, 2022.3932820153896, 85272.14727852705, 88160.5591972036, 89056.10943890543, 89813.55093224558, 91801.54099229528, 13877.520156526161, 14246.287685615678, 16585.50243492673, 17115.14424278806, 17595.12024398775, 29701.85149074284, 30861.382772344878, 30920.536191957137, 31297.8435107823, 31526.21184470361, 9368.156865882103, 9509.809803803884, 9537.713868583814, 9719.951400243095, 9784.804303913881, 7851.528908265523, 7976.441649084509, 8044.33428611404, 8067.677292908218, 8194.713185038614, 8266.628001739817, 8596.140385961355, 8655.6537738491, 8714.91285087141, 8772.385932984758, 3036.316828713566, 3070.8925187618324, 3199.0, 3238.5627940228237, 3304.1244070321386, 802.2178376083389, 843.717354686187, 872.5026734761125, 876.6142897125244, 880.903100658927, 17118.828811711723, 17507.410980748915, 17791.55521111957, 17876.463706088838, 18376.173072211783, 824.5588610093571, 848.2323497235012, 873.1966590736538, 877.1535468273147, 899.5232526760827, 9520.523973801282, 9820.508974551243, 9849.753756156153, 9868.111869931741, 9968.700938971842, 146404.0, 360708.0, 432308.0, 435808.0, 440711.0, 87153.0, 87578.0, 88466.0, 88949.55525222332, 89697.82417406591, 896.3904544909394, 943.1323182671958, 948.990510094904, 953.0, 962.412928113864, 16439.178041097657, 16520.504384868473, 16692.332306707594, 16840.747388789423, 16941.407050753165, 41428.58571414247, 42344.153116936875, 42631.67104111986, 43070.35394469148, 44411.777941110086, 58046.7097664509, 60163.39836601578, 60319.69840150771, 60343.0, 60504.0, 7612.657430415756, 7678.232176782277, 7726.459147859596, 7875.173106823701, 7994.480358776661, 11540.307581545134, 11564.595239166589, 11693.239939403911, 11806.645800625995, 11818.40907954616, 9136.451812891248, 9244.722658320261, 9273.489958052101, 9409.294302927445, 10084.798304034024, 9649.565769540248, 10073.748156296151, 10163.89836101659, 10327.225458090523, 10573.471326433493, 7822.47461744977, 9363.625454981997, 9405.905940940504, 9548.37935534188, 9787.972262912577, 7667.156612772479, 7772.261635144652, 7933.60331983387, 7955.880661790194, 7998.920010799818, 8592.613332400182, 8967.148120928501, 9063.592138353659, 9092.454452732858, 9310.674126405544], "value": 9588.056215562881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.4630282130092, 1315.7105436803902, 1377.1530508737126, 1413.5617958432886, 1670.3736098962888, 6925.27284635113, 7899.5260284382975, 8188.95905520473, 8193.344532437406, 8194.877076843852, 7907.0, 8082.636281367338, 8084.9191508084905, 8095.311898488636, 8100.351971842253, 1905.6379287935317, 1967.1737870094594, 1968.724378586999, 2193.6709493575972, 2224.065892325227, 2015.3349394699787, 2199.0544066051593, 2268.0, 2268.3988742983124, 2274.1812947338944, 2185.1259496201487, 2196.769339219383, 2200.1529411176734, 2200.834937379695, 2204.9228277010307, 1902.077492416177, 2136.2416342198453, 2149.355193441961, 2150.924717634883, 2152.0208305221086, 2155.795199456049, 2233.743119541241, 2234.6089434349087, 2235.2176738141684, 2236.944076398087, 8020.997375328084, 8068.8386232275025, 8068.878966815502, 8073.071596766388, 8078.23256790604, 4583.610393116589, 4690.9530904690855, 4696.835610753641, 4698.4361876574685, 4700.647451441156, 2829.618001569803, 2916.1105862711865, 2958.6597541282813, 2975.3008043109853, 2979.657339405953, 939.7133874168376, 960.5533426956429, 969.3795970578835, 977.3695966101895, 989.0307498651362, 11032.338059716443, 11032.558697652084, 11034.944825275903, 11036.944815275872, 11050.33697978124, 4106.301928672133, 4126.834926602963, 4295.183915056129, 4300.440942677432, 4327.242732521796, 9301.209397201314, 9332.906670933204, 9337.066293370608, 9347.392419492711, 9357.625694972261, 4759.143354196278, 4761.428628564595, 4765.571098601074, 4766.856994290177, 4770.451398089194, 3760.0975765816006, 3787.981060094682, 4313.741175529478, 4315.525292217853, 4321.114171594815, 3620.4931309616672, 3749.1564398010228, 3811.2568049230135, 3820.5033345665443, 3834.559025712023, 1150.666306771027, 1152.9192956492966, 1159.431878379588, 1161.9128565357632, 1171.2328424881716, 820.6676296100089, 829.7925518620345, 834.3075247544524, 870.8258348330232, 877.3156937588691, 5291.973540132275, 5335.1730481775385, 5371.731413429391, 5442.4829641184815, 5473.7263136843, 392.39766957719763, 394.5127767207496, 396.36779336957505, 400.1876191331601, 407.5089517131849, 3680.6687398133763, 3714.88855334335, 3730.6828919542145, 3743.6069212732814, 3778.3954567269657, 9611.903880961241, 10004.749881253027, 10063.69808905734, 10118.645847395306, 10123.493825308706, 9965.252606054575, 9970.651027214013, 9971.601135954481, 9992.10071093605, 9996.850047249298, 7533.359664428475, 7583.469157158946, 7597.202293759186, 7602.087749470099, 7603.847923041619, 5266.131088370376, 5316.043112239679, 5402.918956215739, 5541.639793413416, 5632.183333416549, 8799.648014079365, 9111.908880911371, 9121.0, 9259.629614815332, 9375.343725939392, 8624.65501379963, 9119.908800911906, 9127.178553929913, 9333.906660933304, 9348.158665719846, 6026.0, 6056.333803281724, 6715.328467153246, 6835.21395039557, 6996.370326670624, 7734.071911370672, 7815.687372505264, 7820.296173344426, 7821.648025838965, 7843.019622547182, 6850.280720524273, 6961.860762784817, 7033.859322813618, 7105.964470177616, 7128.28717128283, 6899.379055884994, 7006.264342244195, 7017.543859649107, 7106.040684507525, 7125.5368401053765, 5843.883122337445, 5851.707414629166, 5911.320198177093, 5916.67458289781, 5931.940680593311, 4472.463304403493, 4507.6619253555455, 4545.636349092131, 4561.452625684939, 4589.908201835878, 4613.838515651936, 4661.324108004253, 4663.067386522641, 4699.060187962489, 4763.071201115749], "value": 4104.934713354675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.2873445690829, 296.69292282487623, 303.68113480845136, 309.2331019072699, 310.86322018311944, 4890.584300334472, 4913.72974486404, 4926.753662316888, 4934.531219534143, 4942.739601401647, 4589.311603259504, 4707.05858828234, 4723.220668589679, 4733.231059829995, 4862.975685121578, 3675.467057276693, 3770.26479836432, 3771.868439468169, 3840.5022041403877, 3882.650561449469, 3829.119302560413, 3862.401327794182, 3864.9613503865025, 3866.699313908234, 3900.648941595256, 3595.1910820065405, 3795.7532760370486, 3830.7893065881367, 3837.520309961255, 3870.7096967727534, 3776.83004264806, 3788.147666774981, 3790.6967442604664, 3809.466674665549, 3822.503074600312, 3329.252142625117, 3337.332533493287, 3353.144948038259, 3358.7313014958745, 3362.865485380582, 4754.738489383082, 4761.976190119027, 4780.450248221464, 4784.952150478485, 4813.638977076734, 4102.979485102585, 4305.806238719234, 4313.374560688714, 4322.119877853144, 4324.875532361577, 5077.720725360104, 5081.136206844845, 5086.41506226785, 5095.643304968654, 5100.183970564729, 3588.3540962626716, 3602.765820221677, 3603.981980090109, 3613.241219343941, 3622.094476380905, 5164.3802743671, 5337.492938170868, 5346.8395948121615, 5376.462353764631, 5384.919226211649, 3632.945505817415, 3662.6520480554304, 3668.0463079598962, 3679.2457546202963, 3679.2825399047465, 3711.0, 3717.9070523237137, 3720.404735242348, 3726.5900750917376, 3728.55257369112, 4269.231538323132, 4277.465316835395, 4279.486461624625, 4280.229558679468, 4280.5505421930875, 4932.260160975882, 5104.4222667553395, 5105.366282789546, 5107.569880433484, 5164.612654050961, 1236.5733821831454, 1289.9358029625596, 1305.8106574546637, 1308.7644224039764, 1312.7112035352206, 843.4770442325797, 860.2343913916619, 863.96976105836, 863.9784005399915, 868.2359523619175, 4452.443444569429, 4463.8214471421425, 4465.821367145343, 4485.215087359699, 4536.88657783558, 5155.123628983007, 5165.690058596496, 5211.609129315317, 5240.659357141773, 5254.789808407697, 4422.955770442319, 4460.754658493814, 4473.306637471197, 4497.865064048084, 4532.365468834366, 2736.5621500559814, 2738.315421144714, 2762.350847550824, 2763.157237042721, 2766.336079340944, 4892.804287828518, 4909.263610458388, 4922.0, 4922.114019476457, 4936.48166942473, 5060.1903695408555, 5301.920471192935, 5306.363236411578, 5309.548688361532, 5328.49379308965, 4861.708297502161, 4874.268859671078, 4884.340614017062, 4894.8042078317185, 4903.95096049035, 5209.4530074343165, 5221.216817477409, 5224.843254702365, 5234.319538459976, 5240.606954478353, 4855.927161092516, 4996.725180115129, 5057.519535644108, 5063.227870245385, 5096.133657278346, 4871.050145221648, 4878.390201224847, 4880.90238195227, 4885.389326334208, 4902.264660300983, 3724.5158129443, 3731.8880433587037, 3733.6079711629886, 3735.2716220336774, 3740.457633643161, 4970.769000149931, 5144.819931302386, 5159.819406320761, 5176.534111929945, 5258.1849813279005, 5005.62457815658, 5044.545990860694, 5051.898962020666, 5063.1898896176435, 5082.170418649357, 5045.571126454292, 5048.167052436307, 5118.129917913889, 5143.92284115746, 5156.1492353761205, 4756.262779269219, 4908.63185261114, 4910.9263361050325, 4959.280904268933, 4975.477574854733, 5105.617078719185, 5144.408393034699, 5148.279240906351, 5156.948430515647, 5176.352955880515, 5004.549590536869, 5012.548870601663, 5051.4443411224, 5062.949370506248, 5081.390233172043], "value": 3826.1103598696004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.2948303675329, 659.1431139518628, 663.2538394306405, 696.6864910790142, 710.6340234779088, 11463.541458341666, 12315.0, 12318.137730358878, 12323.568675096361, 12327.19873208242, 11635.767284654323, 11844.0, 11854.703632409173, 11862.82205766912, 11872.050235981122, 625.8748250349926, 756.8675481790692, 767.9616019199032, 785.5090568394753, 791.8772590248492, 782.3037496627977, 786.9645865936046, 788.763370988704, 789.1122487201898, 789.3290702902516, 832.7918020494876, 832.854250506162, 834.4242472693821, 835.1356346181703, 835.2148979958849, 652.774792696519, 793.7261644732558, 822.3996482567759, 823.6622984576355, 824.6124321568853, 605.8636806718497, 606.3118360660682, 606.854354954812, 607.6627471753176, 607.9331273559905, 11941.701457463547, 11956.641300760992, 11983.760324793542, 12001.87998120025, 12003.219790713663, 11125.0, 11192.328460292409, 11257.324560526395, 11504.942475287653, 11880.287182768976, 11177.385243811586, 11310.09519238459, 11397.48711307985, 11408.429578521123, 11459.427028648533, 4089.120839019595, 4109.773962432065, 4119.752814831119, 4167.249895018896, 4226.028013556868, 55608.0, 57696.71151644257, 58023.0, 65740.0, 65922.67038664776, 8880.955595222113, 9557.474338911288, 9625.470599117116, 9699.757506062264, 9906.65326713576, 16659.583510412336, 17882.642347152985, 17894.821051789575, 17941.7308740369, 17954.461366159037, 6542.247641521286, 6621.503387245976, 6645.1361323027695, 6912.930870691229, 6997.195322537871, 3511.438169892805, 3701.2967536168044, 3855.4602355670227, 3862.24686186191, 3862.942055869164, 2788.4004938938224, 2891.1760148357616, 2892.985535072311, 2900.448914706199, 2904.433635441069, 514.354485121178, 540.8215288954635, 543.1228565866098, 556.3102399896464, 562.4825160852026, 488.02151685870314, 592.3572923378097, 604.5616927727363, 613.227333559718, 642.5566359212129, 7707.961460192663, 8116.2695357418115, 8146.2261085196815, 8280.985415414912, 8424.989001319758, 512.869218349326, 559.0, 597.8983572792636, 608.6317777744489, 643.787550108463, 3859.4017927221325, 3878.7478813877005, 3932.0, 3944.6449819516383, 4075.286824805647, 78002.0, 81144.0, 81437.0, 94729.0, 98215.0, 48397.27404088942, 49575.0, 49747.751261243466, 50562.74718626457, 65956.0, 46664.300035499495, 72166.63916680383, 74970.62514687501, 75015.0, 76528.61735691398, 8170.346372290083, 8238.876416853871, 8434.873476897974, 8499.0, 8508.319334453105, 37531.0, 40437.59562404456, 42651.3602295972, 43099.56900431081, 43694.56305436905, 57970.42029579819, 58060.419395805504, 59539.702301489946, 61565.384346157756, 62045.37954620396, 10655.200859935381, 10700.090492308242, 10919.508622111865, 10935.56257749681, 11115.944420277847, 10107.69676909694, 12065.638030859089, 12079.214851034654, 12611.93694031524, 13029.47882084706, 8576.914230857861, 11157.609483668033, 11801.173917826014, 11840.644780656594, 12175.939120304341, 11966.880331196577, 12001.39993000364, 12262.4481898313, 12750.553730619384, 12767.425465854245, 11823.467943942715, 12477.064220183704, 12487.375631218585, 12506.624801255977, 12637.620871373874, 8930.240929520804, 9281.0, 9524.571394287135, 10300.742481438025, 10458.320209186379, 9542.761430964281, 9706.70879873605, 9708.2718796092, 9822.508874556386, 9882.357646752938], "value": 6369.6775883621, "unit": "score"}], "name": "dromaeo_css", "value": 6515.844445009903, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 112.0, 113.0, 115.0, 112.0, 113.0, 114.0, 112.0, 115.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 126.0, 174.0, 129.0, 123.0, 160.0, 122.0, 159.0, 122.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 163.0, 163.0, 162.0, 164.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 101.0, 76.0, 76.0, 75.0, 76.0, 101.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 117.0, 84.0, 85.0, 86.0, 118.0, 84.0, 85.0, 122.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 65.0, 63.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 80.0, 85.0, 84.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 129.0, 128.0, 136.0, 129.0, 128.0, 127.0, 181.0, 139.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 168.0, 169.0, 167.0, 168.0, 167.0, 168.0, 164.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 70.0, 66.0, 70.0, 67.0, 66.0, 66.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1525.8, "alertThreshold": 2.0}]} 18:44:08 INFO - Return code: 0 18:44:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:44:08 INFO - # TBPL SUCCESS # 18:44:08 INFO - Running post-action listener: _resource_record_post_action 18:44:08 INFO - ##### 18:44:08 INFO - ##### Finished run-tests step (success) 18:44:08 INFO - ##### 18:44:08 INFO - Running post-run listener: _resource_record_post_run 18:44:08 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 534982656; Read time: 100; Write time: 410112 18:44:08 INFO - TinderboxPrint: CPU usage
13.0% 18:44:08 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 100 18:44:08 INFO - TinderboxPrint: I/O write bytes / time
534,982,656 / 410,112 18:44:08 INFO - TinderboxPrint: CPU idle
8,335.9 (87.0%) 18:44:08 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 18:44:08 INFO - TinderboxPrint: Swap in / out
0 / 0 18:44:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245637120; Read time: 0; Write time: 217968 18:44:08 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288780288; Read time: 92; Write time: 192144 18:44:08 INFO - Running post-run listener: _upload_blobber_files 18:44:08 INFO - Blob upload gear active. 18:44:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:44:08 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 18:44:08 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:44:08 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:44:09 INFO - (blobuploader) - INFO - Open directory for files ... 18:44:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:44:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:10 INFO - (blobuploader) - INFO - Done attempting. 18:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:10 INFO - (blobuploader) - INFO - Done attempting. 18:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:44:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:14 INFO - (blobuploader) - INFO - Done attempting. 18:44:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:44:14 INFO - Return code: 0 18:44:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:44:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:44:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3962011a0405cffed92c22355c7ccd5b03255d8264c49dfd5ded5c451c849c3dd78b0091dc8db9adadd20fd5e57f11c5b4f1014b18eae23249d6aeccbbc7bb4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06b53f9950f3daf55bbf7134039388394512cabbdeed2f5f017e3dc2c632c23793af0fab7a03d61899c4e635d9ff4b4ecf6af3e897f3a025147a4fa5d257326a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92301512b205361d8965da33784e1c299e242a801b891df35f63484cf7be691f97b8aa1324a7c8bb4fd868e9d37a555b9358421390a7aaa0e947d6bd442e0f4d"} 18:44:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:44:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:44:14 INFO - Contents: 18:44:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3962011a0405cffed92c22355c7ccd5b03255d8264c49dfd5ded5c451c849c3dd78b0091dc8db9adadd20fd5e57f11c5b4f1014b18eae23249d6aeccbbc7bb4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06b53f9950f3daf55bbf7134039388394512cabbdeed2f5f017e3dc2c632c23793af0fab7a03d61899c4e635d9ff4b4ecf6af3e897f3a025147a4fa5d257326a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92301512b205361d8965da33784e1c299e242a801b891df35f63484cf7be691f97b8aa1324a7c8bb4fd868e9d37a555b9358421390a7aaa0e947d6bd442e0f4d"} 18:44:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:44:14 INFO - Copying logs to upload dir... 18:44:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:44:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.445387 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-29 18:44:14.197821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 18:44:14.201718) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3962011a0405cffed92c22355c7ccd5b03255d8264c49dfd5ded5c451c849c3dd78b0091dc8db9adadd20fd5e57f11c5b4f1014b18eae23249d6aeccbbc7bb4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06b53f9950f3daf55bbf7134039388394512cabbdeed2f5f017e3dc2c632c23793af0fab7a03d61899c4e635d9ff4b4ecf6af3e897f3a025147a4fa5d257326a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92301512b205361d8965da33784e1c299e242a801b891df35f63484cf7be691f97b8aa1324a7c8bb4fd868e9d37a555b9358421390a7aaa0e947d6bd442e0f4d"} build_url:https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/W86_189LTE-DgLF0i3AKHg/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/Autoland-Non-PGO/sha512/3962011a0405cffed92c22355c7ccd5b03255d8264c49dfd5ded5c451c849c3dd78b0091dc8db9adadd20fd5e57f11c5b4f1014b18eae23249d6aeccbbc7bb4c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/06b53f9950f3daf55bbf7134039388394512cabbdeed2f5f017e3dc2c632c23793af0fab7a03d61899c4e635d9ff4b4ecf6af3e897f3a025147a4fa5d257326a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/92301512b205361d8965da33784e1c299e242a801b891df35f63484cf7be691f97b8aa1324a7c8bb4fd868e9d37a555b9358421390a7aaa0e947d6bd442e0f4d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 18:44:14.227176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:44:14.227716) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467247947.86459-2143473003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 18:44:14.312362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 18:44:14.312683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 18:44:14.312980) ========= ========= Total master_lag: 0.17 =========