builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1468920611.37 results: success (0) buildid: 20160719010919 builduid: f8f74ccea64e480890c3ae059a5e4da8 revision: 0175a8da10333b8df86bf886b3490050bbabbaf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.373300) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.373748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.374036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.411221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.411522) ========= 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=eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 02:30:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.2M=0.001s 2016-07-19 02:30:12 (17.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.528336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.528645) ========= 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=eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.578510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:11.578861) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0175a8da10333b8df86bf886b3490050bbabbaf9 --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 0175a8da10333b8df86bf886b3490050bbabbaf9 --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=eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 02:30:12,164 truncating revision to first 12 chars 2016-07-19 02:30:12,164 Setting DEBUG logging. 2016-07-19 02:30:12,164 attempt 1/10 2016-07-19 02:30:12,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0175a8da1033?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 02:30:12,481 unpacking tar archive at: autoland-0175a8da1033/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:12.251131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:12.251409) ========= script_repo_revision: 0175a8da10333b8df86bf886b3490050bbabbaf9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:12.251768) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:12.252041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 02:30:12.265122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-19 02:30:12.265510) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:30:12 INFO - MultiFileLogger online at 20160719 02:30:12 in /builds/slave/test 02:30:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 02:30:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:30:12 INFO - {'append_to_log': False, 02:30:12 INFO - 'base_work_dir': '/builds/slave/test', 02:30:12 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:30:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:30:12 INFO - 'branch': 'Autoland-Non-PGO', 02:30:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:30:12 INFO - 'config_files': ('talos/linux_config.py',), 02:30:12 INFO - 'default_actions': ('clobber', 02:30:12 INFO - 'read-buildbot-config', 02:30:12 INFO - 'download-and-extract', 02:30:12 INFO - 'populate-webroot', 02:30:12 INFO - 'create-virtualenv', 02:30:12 INFO - 'install', 02:30:12 INFO - 'run-tests'), 02:30:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:30:12 INFO - 'download_minidump_stackwalk': True, 02:30:12 INFO - 'download_symbols': 'ondemand', 02:30:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:30:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:30:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:30:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:30:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:30:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:30:12 INFO - 'installer_path': 'installer.exe', 02:30:12 INFO - 'log_level': 'info', 02:30:12 INFO - 'log_name': 'talos', 02:30:12 INFO - 'log_to_console': True, 02:30:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:30:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:30:12 INFO - 'opt_config_files': (), 02:30:12 INFO - 'pip_index': False, 02:30:12 INFO - 'sps_profile': False, 02:30:12 INFO - 'sps_profile_interval': 0, 02:30:12 INFO - 'suite': 'dromaeojs-e10s', 02:30:12 INFO - 'system_bits': '32', 02:30:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:30:12 INFO - 'title': 'talos-linux64-ix-010', 02:30:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:30:12 INFO - 'use_talos_json': True, 02:30:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:30:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:30:12 INFO - 'work_dir': 'build'} 02:30:12 INFO - ##### 02:30:12 INFO - ##### Running clobber step. 02:30:12 INFO - ##### 02:30:12 INFO - Running pre-action listener: _resource_record_pre_action 02:30:12 INFO - Running main action method: clobber 02:30:12 INFO - rmtree: /builds/slave/test/build 02:30:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:30:13 INFO - Running post-action listener: _resource_record_post_action 02:30:13 INFO - ##### 02:30:13 INFO - ##### Finished clobber step (success) 02:30:13 INFO - ##### 02:30:13 INFO - ##### 02:30:13 INFO - ##### Running read-buildbot-config step. 02:30:13 INFO - ##### 02:30:13 INFO - Running pre-action listener: _resource_record_pre_action 02:30:13 INFO - Running main action method: read_buildbot_config 02:30:13 INFO - Using buildbot properties: 02:30:13 INFO - { 02:30:13 INFO - "project": "", 02:30:13 INFO - "product": "firefox", 02:30:13 INFO - "script_repo_revision": "production", 02:30:13 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 02:30:13 INFO - "repository": "", 02:30:13 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 02:30:13 INFO - "buildid": "20160719010919", 02:30:13 INFO - "pgo_build": "False", 02:30:13 INFO - "basedir": "/builds/slave/test", 02:30:13 INFO - "buildnumber": 97, 02:30:13 INFO - "slavename": "talos-linux64-ix-010", 02:30:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:30:13 INFO - "platform": "ubuntu64_hw", 02:30:13 INFO - "scheduler": "tests-autoland-linux64-talos", 02:30:13 INFO - "branch": "autoland", 02:30:13 INFO - "repo_path": "integration/autoland", 02:30:13 INFO - "revision": "0175a8da10333b8df86bf886b3490050bbabbaf9", 02:30:13 INFO - "stage_platform": "linux64", 02:30:13 INFO - "builduid": "f8f74ccea64e480890c3ae059a5e4da8", 02:30:13 INFO - "slavebuilddir": "test" 02:30:13 INFO - } 02:30:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:30:13 INFO - Running post-action listener: _resource_record_post_action 02:30:13 INFO - ##### 02:30:13 INFO - ##### Finished read-buildbot-config step (success) 02:30:13 INFO - ##### 02:30:13 INFO - ##### 02:30:13 INFO - ##### Running download-and-extract step. 02:30:13 INFO - ##### 02:30:13 INFO - Running pre-action listener: _resource_record_pre_action 02:30:13 INFO - Running main action method: download_and_extract 02:30:13 INFO - mkdir: /builds/slave/test/build/tests 02:30:13 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')]} 02:30:13 INFO - https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:30:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:30:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:30:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:16 INFO - Downloaded 1361 bytes. 02:30:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:30:16 INFO - Using the following test package requirements: 02:30:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:30:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:30:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:30:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'jsshell-linux-x86_64.zip'], 02:30:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:30:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:30:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:30:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:30:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:30:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:30:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:30:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:16 INFO - https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:17 INFO - Downloaded 22765222 bytes. 02:30:17 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'] 02:30:17 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 02:30:18 INFO - Return code: 0 02:30:18 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 02:30:18 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')]} 02:30:18 INFO - https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:30:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:30:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:30:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:20 INFO - Downloaded 22765222 bytes. 02:30:20 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'] 02:30:20 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 02:30:21 INFO - Return code: 0 02:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:21 INFO - https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:30:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:30:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:30:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:22 INFO - Downloaded 14403317 bytes. 02:30:22 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'] 02:30:22 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 02:30:22 INFO - Return code: 0 02:30:22 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')]} 02:30:22 INFO - https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:30:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:30:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:30:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/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 02:30:24 INFO - Downloaded 57132296 bytes. 02:30:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:30:24 INFO - mkdir: /builds/slave/test/properties 02:30:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:30:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:30:24 INFO - Contents: 02:30:24 INFO - build_url:https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:30:24 INFO - Running post-action listener: _resource_record_post_action 02:30:24 INFO - Running post-action listener: set_extra_try_arguments 02:30:24 INFO - ##### 02:30:24 INFO - ##### Finished download-and-extract step (success) 02:30:24 INFO - ##### 02:30:24 INFO - ##### 02:30:24 INFO - ##### Running populate-webroot step. 02:30:24 INFO - ##### 02:30:24 INFO - Running pre-action listener: _resource_record_pre_action 02:30:24 INFO - Running main action method: populate_webroot 02:30:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:30:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:30:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:30:24 INFO - '--tppagecycles', 02:30:24 INFO - '7'], 02:30:24 INFO - 'tests': ['tsvgm']}}, 02:30:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:30:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:30:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:30:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:30:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['damp', 'tps']}, 02:30:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'tests': ['damp', 'tps']}, 02:30:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['dromaeo_dom']}, 02:30:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:30:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['basic_compositor_video']}, 02:30:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:30:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['a11yr', 02:30:24 INFO - 'ts_paint', 02:30:24 INFO - 'tpaint', 02:30:24 INFO - 'sessionrestore', 02:30:24 INFO - 'sessionrestore_no_auto_restore', 02:30:24 INFO - 'tabpaint']}, 02:30:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:30:24 INFO - 'ts_paint', 02:30:24 INFO - 'tpaint', 02:30:24 INFO - 'sessionrestore', 02:30:24 INFO - 'sessionrestore_no_auto_restore', 02:30:24 INFO - 'tabpaint']}, 02:30:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:30:24 INFO - 'ts_paint', 02:30:24 INFO - 'tpaint', 02:30:24 INFO - 'sessionrestore', 02:30:24 INFO - 'sessionrestore_no_auto_restore', 02:30:24 INFO - 'tabpaint']}, 02:30:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:30:24 INFO - 'ts_paint', 02:30:24 INFO - 'tpaint', 02:30:24 INFO - 'sessionrestore', 02:30:24 INFO - 'sessionrestore_no_auto_restore', 02:30:24 INFO - 'tabpaint']}, 02:30:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['a11yr', 02:30:24 INFO - 'ts_paint', 02:30:24 INFO - 'tpaint', 02:30:24 INFO - 'sessionrestore', 02:30:24 INFO - 'sessionrestore_no_auto_restore', 02:30:24 INFO - 'tabpaint']}, 02:30:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['a11yr', 02:30:24 INFO - 'ts_paint', 02:30:24 INFO - 'tpaint', 02:30:24 INFO - 'sessionrestore', 02:30:24 INFO - 'sessionrestore_no_auto_restore', 02:30:24 INFO - 'tabpaint']}, 02:30:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['tsvgx', 02:30:24 INFO - 'tsvgr_opacity', 02:30:24 INFO - 'tart', 02:30:24 INFO - 'tscrollx', 02:30:24 INFO - 'cart']}, 02:30:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:30:24 INFO - 'tsvgr_opacity', 02:30:24 INFO - 'tart', 02:30:24 INFO - 'tscrollx', 02:30:24 INFO - 'cart']}, 02:30:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'talos_options': ['--disable-e10s'], 02:30:24 INFO - 'tests': ['tp5o']}, 02:30:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'tests': ['tp5o']}, 02:30:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'talos_options': ['--disable-e10s', 02:30:24 INFO - '--xperf_path', 02:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:24 INFO - 'tests': ['tp5n']}, 02:30:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:24 INFO - 'talos_options': ['--xperf_path', 02:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:24 INFO - 'tests': ['tp5n']}}, 02:30:24 INFO - 'talos.zip': {'path': '', 02:30:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:30:24 INFO - Running post-action listener: _resource_record_post_action 02:30:24 INFO - ##### 02:30:24 INFO - ##### Finished populate-webroot step (success) 02:30:24 INFO - ##### 02:30:24 INFO - ##### 02:30:24 INFO - ##### Running create-virtualenv step. 02:30:24 INFO - ##### 02:30:24 INFO - Running pre-action listener: _resource_record_pre_action 02:30:24 INFO - Running main action method: create_virtualenv 02:30:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:30:24 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 02:30:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:30:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:30:24 INFO - Using real prefix '/usr' 02:30:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:30:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:27 INFO - Installing pip.................done. 02:30:27 INFO - Return code: 0 02:30:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:27 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:27 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 02:30:27 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 02:30:27 INFO - Using env: {'DISPLAY': ':0', 02:30:27 INFO - 'HOME': '/home/cltbld', 02:30:27 INFO - 'LANG': 'en_US.UTF-8', 02:30:27 INFO - 'LANGUAGE': 'en_US:en', 02:30:27 INFO - 'LOGNAME': 'cltbld', 02:30:27 INFO - 'MAIL': '/var/mail/cltbld', 02:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:27 INFO - 'MOZ_NO_REMOTE': '1', 02:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:27 INFO - 'NO_EM_RESTART': '1', 02:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:27 INFO - 'PWD': '/builds/slave/test', 02:30:27 INFO - 'SHELL': '/bin/bash', 02:30:27 INFO - 'SHLVL': '1', 02:30:27 INFO - 'TERM': 'linux', 02:30:27 INFO - 'TMOUT': '86400', 02:30:27 INFO - 'USER': 'cltbld', 02:30:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:27 INFO - '_': '/tools/buildbot/bin/python'} 02:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:27 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 02:30:27 INFO - Cleaning up... 02:30:27 INFO - Return code: 0 02:30:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:27 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:27 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 02:30:27 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 02:30:27 INFO - Using env: {'DISPLAY': ':0', 02:30:27 INFO - 'HOME': '/home/cltbld', 02:30:27 INFO - 'LANG': 'en_US.UTF-8', 02:30:27 INFO - 'LANGUAGE': 'en_US:en', 02:30:27 INFO - 'LOGNAME': 'cltbld', 02:30:27 INFO - 'MAIL': '/var/mail/cltbld', 02:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:27 INFO - 'MOZ_NO_REMOTE': '1', 02:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:27 INFO - 'NO_EM_RESTART': '1', 02:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:27 INFO - 'PWD': '/builds/slave/test', 02:30:27 INFO - 'SHELL': '/bin/bash', 02:30:27 INFO - 'SHLVL': '1', 02:30:27 INFO - 'TERM': 'linux', 02:30:27 INFO - 'TMOUT': '86400', 02:30:27 INFO - 'USER': 'cltbld', 02:30:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:27 INFO - '_': '/tools/buildbot/bin/python'} 02:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:27 INFO - Downloading/unpacking psutil>=3.1.1 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:29 INFO - Installing collected packages: psutil 02:30:29 INFO - Running setup.py install for psutil 02:30:29 INFO - building 'psutil._psutil_linux' extension 02:30:29 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 02:30:30 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 02:30:30 INFO - building 'psutil._psutil_posix' extension 02:30:30 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 02:30:30 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 02:30:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:30 INFO - Successfully installed psutil 02:30:30 INFO - Cleaning up... 02:30:30 INFO - Return code: 0 02:30:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:30:30 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')]} 02:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:30 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')]} 02:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:30 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:30 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 02:30:30 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 02:30:30 INFO - Using env: {'DISPLAY': ':0', 02:30:30 INFO - 'HOME': '/home/cltbld', 02:30:30 INFO - 'LANG': 'en_US.UTF-8', 02:30:30 INFO - 'LANGUAGE': 'en_US:en', 02:30:30 INFO - 'LOGNAME': 'cltbld', 02:30:30 INFO - 'MAIL': '/var/mail/cltbld', 02:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:30 INFO - 'MOZ_NO_REMOTE': '1', 02:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:30 INFO - 'NO_EM_RESTART': '1', 02:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:30 INFO - 'PWD': '/builds/slave/test', 02:30:30 INFO - 'SHELL': '/bin/bash', 02:30:30 INFO - 'SHLVL': '1', 02:30:30 INFO - 'TERM': 'linux', 02:30:30 INFO - 'TMOUT': '86400', 02:30:30 INFO - 'USER': 'cltbld', 02:30:30 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:30 INFO - '_': '/tools/buildbot/bin/python'} 02:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:30:32 INFO - Installing collected packages: mozsystemmonitor 02:30:32 INFO - Running setup.py install for mozsystemmonitor 02:30:32 INFO - Successfully installed mozsystemmonitor 02:30:32 INFO - Cleaning up... 02:30:32 INFO - Return code: 0 02:30:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:30:32 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')]} 02:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:32 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')]} 02:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:32 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:32 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 02:30:32 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 02:30:32 INFO - Using env: {'DISPLAY': ':0', 02:30:32 INFO - 'HOME': '/home/cltbld', 02:30:32 INFO - 'LANG': 'en_US.UTF-8', 02:30:32 INFO - 'LANGUAGE': 'en_US:en', 02:30:32 INFO - 'LOGNAME': 'cltbld', 02:30:32 INFO - 'MAIL': '/var/mail/cltbld', 02:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:32 INFO - 'MOZ_NO_REMOTE': '1', 02:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:32 INFO - 'NO_EM_RESTART': '1', 02:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:32 INFO - 'PWD': '/builds/slave/test', 02:30:32 INFO - 'SHELL': '/bin/bash', 02:30:32 INFO - 'SHLVL': '1', 02:30:32 INFO - 'TERM': 'linux', 02:30:32 INFO - 'TMOUT': '86400', 02:30:32 INFO - 'USER': 'cltbld', 02:30:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:32 INFO - '_': '/tools/buildbot/bin/python'} 02:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:30:32 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 02:30:32 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 02:30:32 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 02:30:32 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 02:30:32 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 02:30:32 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 02:30:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:35 INFO - warning: no files found matching '*.txt' 02:30:35 INFO - no previously-included directories found matching 'build' 02:30:35 INFO - no previously-included directories found matching 'dist' 02:30:35 INFO - no previously-included directories found matching '.git*' 02:30:35 INFO - Installing collected packages: jsonschema, functools32 02:30:35 INFO - Running setup.py install for functools32 02:30:35 INFO - warning: no files found matching '*.txt' 02:30:35 INFO - no previously-included directories found matching 'build' 02:30:35 INFO - no previously-included directories found matching 'dist' 02:30:35 INFO - no previously-included directories found matching '.git*' 02:30:35 INFO - Successfully installed jsonschema functools32 02:30:35 INFO - Cleaning up... 02:30:35 INFO - Return code: 0 02:30:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:35 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:35 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 02:30:35 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 02:30:35 INFO - Using env: {'DISPLAY': ':0', 02:30:35 INFO - 'HOME': '/home/cltbld', 02:30:35 INFO - 'LANG': 'en_US.UTF-8', 02:30:35 INFO - 'LANGUAGE': 'en_US:en', 02:30:35 INFO - 'LOGNAME': 'cltbld', 02:30:35 INFO - 'MAIL': '/var/mail/cltbld', 02:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:35 INFO - 'MOZ_NO_REMOTE': '1', 02:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:35 INFO - 'NO_EM_RESTART': '1', 02:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:35 INFO - 'PWD': '/builds/slave/test', 02:30:35 INFO - 'SHELL': '/bin/bash', 02:30:35 INFO - 'SHLVL': '1', 02:30:35 INFO - 'TERM': 'linux', 02:30:35 INFO - 'TMOUT': '86400', 02:30:35 INFO - 'USER': 'cltbld', 02:30:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:35 INFO - '_': '/tools/buildbot/bin/python'} 02:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:30:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:30:37 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 02:30:37 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 02:30:37 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 02:30:37 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 02:30:37 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 02:30:37 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 02:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:30:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:30:38 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 02:30:38 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 02:30:38 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 02:30:38 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 02:30:38 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 02:30:38 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 02:30:38 INFO - Downloading docopt-0.6.1.tar.gz 02:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:30:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:30:38 INFO - Running setup.py install for blobuploader 02:30:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:30:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:30:38 INFO - Running setup.py install for requests 02:30:39 INFO - Running setup.py install for docopt 02:30:39 INFO - Successfully installed blobuploader requests docopt 02:30:39 INFO - Cleaning up... 02:30:39 INFO - Return code: 0 02:30:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:39 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')]} 02:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:39 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')]} 02:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:39 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:39 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 02:30:39 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 02:30:39 INFO - Using env: {'DISPLAY': ':0', 02:30:39 INFO - 'HOME': '/home/cltbld', 02:30:39 INFO - 'LANG': 'en_US.UTF-8', 02:30:39 INFO - 'LANGUAGE': 'en_US:en', 02:30:39 INFO - 'LOGNAME': 'cltbld', 02:30:39 INFO - 'MAIL': '/var/mail/cltbld', 02:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:39 INFO - 'MOZ_NO_REMOTE': '1', 02:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:39 INFO - 'NO_EM_RESTART': '1', 02:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:39 INFO - 'PWD': '/builds/slave/test', 02:30:39 INFO - 'SHELL': '/bin/bash', 02:30:39 INFO - 'SHLVL': '1', 02:30:39 INFO - 'TERM': 'linux', 02:30:39 INFO - 'TMOUT': '86400', 02:30:39 INFO - 'USER': 'cltbld', 02:30:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:39 INFO - '_': '/tools/buildbot/bin/python'} 02:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:39 INFO - Running setup.py (path:/tmp/pip-2HTkj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:39 INFO - Running setup.py (path:/tmp/pip-mewDmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:39 INFO - Running setup.py (path:/tmp/pip-ARbPOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:39 INFO - Running setup.py (path:/tmp/pip-N7KGLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:39 INFO - Running setup.py (path:/tmp/pip-jCDnrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:39 INFO - Running setup.py (path:/tmp/pip-vhbmKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:39 INFO - Running setup.py (path:/tmp/pip-xljpYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:40 INFO - Running setup.py (path:/tmp/pip-RwOyVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:40 INFO - Running setup.py (path:/tmp/pip-UZKis5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:40 INFO - Running setup.py (path:/tmp/pip-fDs7iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:40 INFO - Running setup.py (path:/tmp/pip-0wVXmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:40 INFO - Running setup.py (path:/tmp/pip-6hwCL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:40 INFO - Running setup.py (path:/tmp/pip-QwAep5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:40 INFO - Running setup.py (path:/tmp/pip-tnFJss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:40 INFO - Running setup.py (path:/tmp/pip-16jUc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:40 INFO - Running setup.py (path:/tmp/pip-b82hz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:40 INFO - Running setup.py (path:/tmp/pip-UYA4bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:30:40 INFO - Running setup.py install for manifestparser 02:30:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:30:40 INFO - Running setup.py install for mozcrash 02:30:40 INFO - Running setup.py install for mozdebug 02:30:41 INFO - Running setup.py install for mozdevice 02:30:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Running setup.py install for mozfile 02:30:41 INFO - Running setup.py install for mozhttpd 02:30:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Running setup.py install for mozinfo 02:30:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Running setup.py install for mozInstall 02:30:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Running setup.py install for mozleak 02:30:41 INFO - Running setup.py install for mozlog 02:30:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Running setup.py install for moznetwork 02:30:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:30:41 INFO - Running setup.py install for mozprocess 02:30:41 INFO - Running setup.py install for mozprofile 02:30:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:30:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:30:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:30:42 INFO - Running setup.py install for mozrunner 02:30:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:30:42 INFO - Running setup.py install for mozscreenshot 02:30:42 INFO - Running setup.py install for moztest 02:30:42 INFO - Running setup.py install for mozversion 02:30:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:30:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:30:42 INFO - Cleaning up... 02:30:42 INFO - Return code: 0 02:30:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:42 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:42 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 02:30:42 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 02:30:42 INFO - Using env: {'DISPLAY': ':0', 02:30:42 INFO - 'HOME': '/home/cltbld', 02:30:42 INFO - 'LANG': 'en_US.UTF-8', 02:30:42 INFO - 'LANGUAGE': 'en_US:en', 02:30:42 INFO - 'LOGNAME': 'cltbld', 02:30:42 INFO - 'MAIL': '/var/mail/cltbld', 02:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:42 INFO - 'MOZ_NO_REMOTE': '1', 02:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:42 INFO - 'NO_EM_RESTART': '1', 02:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:42 INFO - 'PWD': '/builds/slave/test', 02:30:42 INFO - 'SHELL': '/bin/bash', 02:30:42 INFO - 'SHLVL': '1', 02:30:42 INFO - 'TERM': 'linux', 02:30:42 INFO - 'TMOUT': '86400', 02:30:42 INFO - 'USER': 'cltbld', 02:30:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:42 INFO - '_': '/tools/buildbot/bin/python'} 02:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:42 INFO - Running setup.py (path:/tmp/pip-Gec7UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:42 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)) 02:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:42 INFO - Running setup.py (path:/tmp/pip-rqJmW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:42 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)) 02:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:42 INFO - Running setup.py (path:/tmp/pip-v50msp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:42 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)) 02:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:42 INFO - Running setup.py (path:/tmp/pip-w2XsU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:43 INFO - Running setup.py (path:/tmp/pip-2Mr1it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:43 INFO - Running setup.py (path:/tmp/pip-XW0vQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:43 INFO - Running setup.py (path:/tmp/pip-9HckyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:43 INFO - Running setup.py (path:/tmp/pip-ORB2NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:43 INFO - Running setup.py (path:/tmp/pip-xLgReB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:43 INFO - Running setup.py (path:/tmp/pip-RWSFBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:43 INFO - Running setup.py (path:/tmp/pip-BUUF4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:43 INFO - Running setup.py (path:/tmp/pip-wrn31t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:43 INFO - Running setup.py (path:/tmp/pip-xYdXZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:43 INFO - Running setup.py (path:/tmp/pip-bpziSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:43 INFO - Running setup.py (path:/tmp/pip-UqUgdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:43 INFO - Running setup.py (path:/tmp/pip-MiWlfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:43 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)) 02:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:43 INFO - Running setup.py (path:/tmp/pip-30_PHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:43 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)) 02:30:43 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)) 02:30:43 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)) 02:30:43 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)) 02:30:43 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)) 02:30:43 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)) 02:30:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:45 INFO - Downloading blessings-1.6.tar.gz 02:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:30:45 INFO - Installing collected packages: blessings 02:30:45 INFO - Running setup.py install for blessings 02:30:46 INFO - Successfully installed blessings 02:30:46 INFO - Cleaning up... 02:30:46 INFO - Return code: 0 02:30:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:46 INFO - Reading from file tmpfile_stdout 02:30:46 INFO - Current package versions: 02:30:46 INFO - argparse == 1.2.1 02:30:46 INFO - blessings == 1.6 02:30:46 INFO - blobuploader == 1.2.4 02:30:46 INFO - docopt == 0.6.1 02:30:46 INFO - functools32 == 3.2.3-2 02:30:46 INFO - jsonschema == 2.5.1 02:30:46 INFO - manifestparser == 1.1 02:30:46 INFO - mozInstall == 1.12 02:30:46 INFO - mozcrash == 0.17 02:30:46 INFO - mozdebug == 0.1 02:30:46 INFO - mozdevice == 0.48 02:30:46 INFO - mozfile == 1.2 02:30:46 INFO - mozhttpd == 0.7 02:30:46 INFO - mozinfo == 0.9 02:30:46 INFO - mozleak == 0.1 02:30:46 INFO - mozlog == 3.2 02:30:46 INFO - moznetwork == 0.27 02:30:46 INFO - mozprocess == 0.23 02:30:46 INFO - mozprofile == 0.28 02:30:46 INFO - mozrunner == 6.12 02:30:46 INFO - mozscreenshot == 0.1 02:30:46 INFO - mozsystemmonitor == 0.3 02:30:46 INFO - moztest == 0.7 02:30:46 INFO - mozversion == 1.4 02:30:46 INFO - psutil == 3.1.1 02:30:46 INFO - requests == 1.2.3 02:30:46 INFO - wsgiref == 0.1.2 02:30:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:46 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')]} 02:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:46 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')]} 02:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:46 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:46 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 02:30:46 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 02:30:46 INFO - Using env: {'DISPLAY': ':0', 02:30:46 INFO - 'HOME': '/home/cltbld', 02:30:46 INFO - 'LANG': 'en_US.UTF-8', 02:30:46 INFO - 'LANGUAGE': 'en_US:en', 02:30:46 INFO - 'LOGNAME': 'cltbld', 02:30:46 INFO - 'MAIL': '/var/mail/cltbld', 02:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:46 INFO - 'MOZ_NO_REMOTE': '1', 02:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:46 INFO - 'NO_EM_RESTART': '1', 02:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:46 INFO - 'PWD': '/builds/slave/test', 02:30:46 INFO - 'SHELL': '/bin/bash', 02:30:46 INFO - 'SHLVL': '1', 02:30:46 INFO - 'TERM': 'linux', 02:30:46 INFO - 'TMOUT': '86400', 02:30:46 INFO - 'USER': 'cltbld', 02:30:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:46 INFO - '_': '/tools/buildbot/bin/python'} 02:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 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)) 02:30:46 INFO - Cleaning up... 02:30:46 INFO - Return code: 0 02:30:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:30:46 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')]} 02:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:46 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')]} 02:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:46 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 0x279a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, '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': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', '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 02:30:46 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 02:30:46 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 02:30:46 INFO - Using env: {'DISPLAY': ':0', 02:30:46 INFO - 'HOME': '/home/cltbld', 02:30:46 INFO - 'LANG': 'en_US.UTF-8', 02:30:46 INFO - 'LANGUAGE': 'en_US:en', 02:30:46 INFO - 'LOGNAME': 'cltbld', 02:30:46 INFO - 'MAIL': '/var/mail/cltbld', 02:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:46 INFO - 'MOZ_NO_REMOTE': '1', 02:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:46 INFO - 'NO_EM_RESTART': '1', 02:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:46 INFO - 'PWD': '/builds/slave/test', 02:30:46 INFO - 'SHELL': '/bin/bash', 02:30:46 INFO - 'SHLVL': '1', 02:30:46 INFO - 'TERM': 'linux', 02:30:46 INFO - 'TMOUT': '86400', 02:30:46 INFO - 'USER': 'cltbld', 02:30:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:46 INFO - '_': '/tools/buildbot/bin/python'} 02:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:30:46 INFO - Cleaning up... 02:30:46 INFO - Return code: 0 02:30:46 INFO - Running post-action listener: _resource_record_post_action 02:30:46 INFO - Running post-action listener: _start_resource_monitoring 02:30:46 INFO - Starting resource monitoring. 02:30:46 INFO - ##### 02:30:46 INFO - ##### Finished create-virtualenv step (success) 02:30:46 INFO - ##### 02:30:46 INFO - ##### 02:30:46 INFO - ##### Running install step. 02:30:46 INFO - ##### 02:30:46 INFO - Running pre-action listener: _resource_record_pre_action 02:30:46 INFO - Running main action method: install 02:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:47 INFO - Reading from file tmpfile_stdout 02:30:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:30:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:30:47 INFO - Reading from file tmpfile_stdout 02:30:47 INFO - Output received: 02:30:47 INFO - Usage: mozinstall [options] installer 02:30:47 INFO - Options: 02:30:47 INFO - -h, --help show this help message and exit 02:30:47 INFO - -d DEST, --destination=DEST 02:30:47 INFO - Directory to install application into. [default: 02:30:47 INFO - "/builds/slave/test"] 02:30:47 INFO - --app=APP Application being installed. [default: firefox] 02:30:47 INFO - mkdir: /builds/slave/test/build/application 02:30:47 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'] 02:30:47 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 02:31:03 INFO - Reading from file tmpfile_stdout 02:31:03 INFO - Output received: 02:31:03 INFO - /builds/slave/test/build/application/firefox/firefox 02:31:03 INFO - Running post-action listener: _resource_record_post_action 02:31:03 INFO - ##### 02:31:03 INFO - ##### Finished install step (success) 02:31:03 INFO - ##### 02:31:03 INFO - ##### 02:31:03 INFO - ##### Running run-tests step. 02:31:03 INFO - ##### 02:31:03 INFO - Running pre-action listener: _resource_record_pre_action 02:31:03 INFO - Running main action method: run_tests 02:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:31:03 INFO - Python 2.7.3 02:31:03 INFO - Return code: 0 02:31:03 INFO - grabbing minidump binary from tooltool 02:31: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')]} 02:31:03 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 0x2a58570>, '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 0x2a59470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:31:03 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 02:31:03 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 02:31:03 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 02:31:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:31:03 INFO - Return code: 0 02:31:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:31:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:31:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:31:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:31:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:31:03 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:31:03 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:31:03 INFO - Using env: {'DISPLAY': ':0', 02:31:03 INFO - 'HOME': '/home/cltbld', 02:31:03 INFO - 'LANG': 'en_US.UTF-8', 02:31:03 INFO - 'LANGUAGE': 'en_US:en', 02:31:03 INFO - 'LOGNAME': 'cltbld', 02:31:03 INFO - 'MAIL': '/var/mail/cltbld', 02:31:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:31:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:03 INFO - 'MOZ_NO_REMOTE': '1', 02:31:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:03 INFO - 'NO_EM_RESTART': '1', 02:31:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:03 INFO - 'PWD': '/builds/slave/test', 02:31:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:31:03 INFO - 'SHELL': '/bin/bash', 02:31:03 INFO - 'SHLVL': '1', 02:31:03 INFO - 'TERM': 'linux', 02:31:03 INFO - 'TMOUT': '86400', 02:31:03 INFO - 'USER': 'cltbld', 02:31:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169', 02:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:03 INFO - '_': '/tools/buildbot/bin/python'} 02:31:03 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:31:03 INFO - mozversion application_buildid: 20160719010919 02:31:03 INFO - mozversion application_changeset: 0175a8da10333b8df86bf886b3490050bbabbaf9 02:31:03 INFO - mozversion application_display_name: Nightly 02:31:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:31:03 INFO - mozversion application_name: Firefox 02:31:03 INFO - mozversion application_remotingname: firefox 02:31:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:31:03 INFO - mozversion application_vendor: Mozilla 02:31:03 INFO - mozversion application_version: 50.0a1 02:31:03 INFO - mozversion platform_buildid: 20160719010919 02:31:03 INFO - mozversion platform_changeset: 0175a8da10333b8df86bf886b3490050bbabbaf9 02:31:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:31:03 INFO - mozversion platform_version: 50.0a1 02:31:03 INFO - using testdate: 1468920663 02:31:03 INFO - actual date: 1468920663 02:31:03 INFO - starting webserver on 'localhost:45562' 02:31:03 INFO - SUITE-START | Running 2 tests 02:31:03 INFO - TEST-START | dromaeo_css 02:31:03 INFO - operating with platform_type : linux_ 02:31:03 INFO - Initialising browser for dromaeo_css test... 02:31:03 INFO - TEST-INFO | started process 31069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdW3Klm/profile http://localhost:45562/getInfo.html) 02:31:09 INFO - PROCESS | 31069 | __metrics Screen width/height:1600/1200 02:31:09 INFO - PROCESS | 31069 | colorDepth:24 02:31:09 INFO - PROCESS | 31069 | Browser inner width/height: 1024/697 02:31:09 INFO - PROCESS | 31069 | __metrics 02:31:09 ERROR - PROCESS | 31069 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:31:10 INFO - TEST-INFO | 31069: exit 0 02:31:10 INFO - Browser initialized. 02:31:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:31:10 INFO - TEST-INFO | started process 31189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdW3Klm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:22 INFO - PROCESS | 31189 | RSS: Main: 168808448 02:31:22 INFO - PROCESS | 31189 | 02:32:12 INFO - PROCESS | 31189 | 1468920732285 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] 02:34:24 INFO - PROCESS | 31189 | Cycle 1(1): loaded http://localhost:45562/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45562/tests/dromaeo/cssquery-ext.html) 02:34:25 INFO - PROCESS | 31189 | RSS: Main: 169869312 02:34:25 INFO - PROCESS | 31189 | 02:37:27 INFO - PROCESS | 31189 | Cycle 1(1): loaded http://localhost:45562/tests/dromaeo/cssquery-ext.html (next: http://localhost:45562/tests/dromaeo/cssquery-jquery.html) 02:37:28 INFO - PROCESS | 31189 | RSS: Main: 169885696 02:37:28 INFO - PROCESS | 31189 | 02:40:30 INFO - PROCESS | 31189 | Cycle 1(1): loaded http://localhost:45562/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45562/tests/dromaeo/cssquery-mootools.html) 02:40:31 INFO - PROCESS | 31189 | RSS: Main: 173039616 02:40:31 INFO - PROCESS | 31189 | 02:43:33 INFO - PROCESS | 31189 | Cycle 1(1): loaded http://localhost:45562/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45562/tests/dromaeo/cssquery-prototype.html) 02:43:33 INFO - PROCESS | 31189 | RSS: Main: 167202816 02:43:33 INFO - PROCESS | 31189 | 02:46:36 INFO - PROCESS | 31189 | Cycle 1(1): loaded http://localhost:45562/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45562/tests/dromaeo/cssquery-yui.html) 02:46:37 INFO - PROCESS | 31189 | RSS: Main: 169132032 02:46:37 INFO - PROCESS | 31189 | 02:49:39 INFO - PROCESS | 31189 | Cycle 1(1): loaded http://localhost:45562/tests/dromaeo/cssquery-yui.html (next: http://localhost:45562/tests/dromaeo/cssquery-dojo.html) 02:49:40 INFO - PROCESS | 31189 | RSS: Main: 169603072 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | __start_tp_report 02:49:40 INFO - PROCESS | 31189 | _x_x_mozilla_page_load 02:49:40 INFO - PROCESS | 31189 | _x_x_mozilla_page_load_details 02:49:40 INFO - PROCESS | 31189 | |i|pagename|runs| 02:49:40 INFO - PROCESS | 31189 | |0;dojo.html;2604.5311843868103;2637.973620263797;2642.3129986203594;2653.1112077454054;2665.6667916510437;4747.216709242975;4753.500882407345;4785.162596545603;4829.806807727696;4864.6837955532865;4596.655250856191;4658.883527911796;4697.013627138296;4737.3604563384015;4747.667663263573;4336.067745434731;4394.802233899466;4467.151241264166;4470.910581788362;4501.347304640825;4477.820887164509;4513.548645135476;4536.478304994935;4593.770311484429;4634.814607415699;314.6078479641572;4464.218761716719;4473.2842745160615;4565;4630.259158534635;4471.8658440246845;4475.149721552894;4484.8206071757095;4529.275315949465;4538.001639639274;4446.333050042487;4452.48796388413;4459.35339375792;4470.597646211857;4508.729476231404;4707.835225767116;4811.855644330676;4843.66094373394;4852.636052296092;4890.682105663121;5250.737463126867;5252.973735131338;5262.184361423985;5263.0000299942885;5289.629725919187;5280.155175171954;5295.947040529584;5296.3379577552805;5308.389535203462;5364.329458817648;4740.7392593407;4799.496052914464;4830.468648448667;4863.367762190893;4925.236588328779;5345.893082138413;5351.759170837322;5366.302380690485;5373.596980226499;5403.864903377368;5106;5109.821156259587;5115.462876397999;5128.512791284897;5153.252778347119;4997.150484417658;5102.438731739506;5199.428062913076;5205.9219111713355;5236.895262094737;5154.201098829687;5180.404253510819;5182.196759502283;5189.766460509286;5223;4952.579030782352;5156.226566015052;5175.120229560984;5179.585633149339;5188.662736922088;4310.52584215736;4371.890702732457;4381.233284175257;4390;4424.292113261863;3793.393057110904;3850.172212974168;3857.884263472044;3897.0841852165286;3910.1397692507603;4323.589259020388;4517.028838799608;4538.205813982606;4553.066621342617;4555.020670555847;5176.9741151294;5192.532672059458;5219.895602087937;5226.503482169188;5233.869153271123;4456.086502267092;4488.663350248679;4500.617447516932;4502.144592527409;4538.02432477019;4590.701604395704;4663.650226233046;4713.7643117844655;4722.763861806896;4748.857534273909;4885.828995985124;4903.387076615423;4924.63065270099;4940.110780059624;4975.651704380731;5202.895942081062;5210.53105220532;5216.530512253916;5217.217417387271;5260.158374660036;4746.501617330268;4870.634702397264;4878.121938051185;4908.7545622719435;4924.901501970012;5090.541851233407;5111.105556527667;5120;5130.333056702605;5160.561352285098;5152.690838549699;5172.818951336685;5188.792448302026;5205.843824685266;5247.475252474875;4806.2310030394965;4970.179920313108;5011.498850114959;5021.598272138147;5041.269015992734;5059.241113832954;5067.087924173684;5073.898522029613;5083.186690129562;5147.845564632918;4960.8759781005765;4974.701517908937;4982.925256121089;4997.5002499749735;5010.7745151469;4857;4999.550040496373;5076.543111120017;5080.923786143285;5132.8460146195675;4902.583280421061;4903.632227583017;4922.1632322505975;4971.502849715;4980.302757613865 02:49:40 INFO - PROCESS | 31189 | |1;ext.html;556.1879655702677;568.4202113843879;573.7704918032789;579.0387955993052;594.1889321076732;35384.29231415373;39400.211995760066;39465.21069578607;39471.40792888105;39501.40747888784;38811.22377552447;39251.214975700466;39364.606353936455;39611.80194099033;39640.207195856136;7786.922130778677;7959.3632509399395;7965.203479652017;7966.800829979239;8002.479838810488;7917.881231781528;8006.599670016505;8020.11778704342;8022.759317220463;8033.1163572007035;7935.682572697114;8021.478603890758;8057.556834374107;8061.395395345343;8083.919160808405;7975.122736498981;7985.640646170878;8005.239502247277;8011.879821802678;8012.879806802932;7864.4888082274465;7890.053193616745;7898.091719452279;7919.920800791976;7921.841563168762;38219.617803821886;38649.806750966345;38829.80585097085;38833.61166388328;38910.41634375486;3019.4564978303897;3116.3611459650715;3378.9155271118175;3471.5660542432197;3767.566729826078;29189.854050729824;29209.123726288246;29500.557491637643;29604.40791184186;29675.406491870042;3192.8984500347574;3296.901092967215;3370.9831450842835;3375.544301519288;3376.7973921564785;260662;261529;261830;262052.689736552;262219;28204.43591128166;28844.567331490045;51302;51345.486545134816;51422.22866657003;33737.662623373944;33789.83105084459;33903.830480847435;33982.830085849906;33994.49008264878;13530.661733456742;13657.726845463036;13658.726825463435;13674.17954922688;13694.041417100707;11339.829902551468;11360.147988900866;11435.542578296774;11450;11475.426228688531;7805.5316680998185;7912.960435197902;7928.7621371358955;7994.800129996796;8000.5599692017495;3102.317490152163;3106.3010822565193;3127.343257915863;3174.0479605042733;3183.8567264473154;806.2622700229225;943.5848226780195;957.2533423929207;962.8603852441357;987.017917172418;28332.575011374847;28987.42025159527;29173.7082629171;29311.413771724445;29523.704762952526;918.3800934369274;966.1932286540817;982.8525721141743;1069.1767339148812;1093.0763504838399;14515.129092254498;14772.926135369255;14796;14887.702245955237;14972.251387430584;386081;386947;387541;388726;389112;50101.49898501041;50190.74904625453;50446;50767.492325077015;50878;1196.4257156564724;1207.3128665056986;1237.9566715164926;1238.8629613916103;1246.4827096754746;25986.350341240865;27163.592546111428;27394;27663;27712;41695;41968.370474442294;42136.36795448009;42431.575684242765;42484;335473;335996;338565;339840;340208;23449.648255275843;23535.02519905786;23543.29370118899;23723.881380592986;23875.761242387354;42010.78994605008;42744.77271818699;43092.569074308856;43101.78449107734;43459;35422;36684;37106.8144659275;37215.44176837404;37764;34239.48640770341;36448.27103457863;36549;36716;36814.63185368112;29948.70051299459;35512.82243588869;36384;36555.97884232679;40129.1974160521;32269.677303227607;33836.32327353489;33939.830300848334;34173.316533669684;34220.48669270013;26202.213933582025;26228.73771262339;26319.4736105273;26423.37864424116;26592.069277575192 02:49:40 INFO - PROCESS | 31189 | |2;jquery.html;366.78543052314393;368.0485943835186;368.9335919534483;376.99434508482375;385.63172170577104;15811.84188158118;16095.275712592933;17337.739933901;17350.132493375342;17366.56583585411;16461.67076658469;16889.577760555992;17265.568360790985;17286.913565432187;17290.135493225353;5080.618953578487;5232.45059268777;5270.104082305998;5271.551918086967;5277.656952298107;5154.07226699194;5224.947750522484;5226.738663066851;5228.0850851101095;5231.450697676746;5083.567896728782;5184;5215.191645294985;5243.292155559008;5266.789328426858;5121.513456221653;5141.434442211354;5166.483351664841;5175.482451754794;5199.896002079956;4510.8646740597505;4573.49691533931;4601.481511101329;4623.514530974233;4642.117997580483;20622.278220262368;21089.68365474519;21122.471938201514;21409.250676226413;21421.571568568543;1965.7247985282072;1971.9309824156085;2013.8690985085923;2057.4856285928518;2241.7982381585734;13058.085933984625;13162.736745265136;13172.077954543185;13522.932385338108;13676.111052781538;1718.7335962925642;1735.7396390541394;1767.938122165718;1768.0831197727355;1807.5119717676284;49418;60711.08933366003;61236.693816530635;65452.345476545575;67063.32936670669;9051.728448146567;9166.633334666538;9468.90531094694;9472.100150485692;9516.571754271074;12538.81191782124;12634.81047784284;12653.683657908627;12671.17637353569;12719.046071544672;7003.789886303419;7070.92929070713;7240.312170343809;7443.478956473104;7485.7754267372065;7222.169450513154;7251.3836323912;7289.380402665833;7391.926080739231;7396.297351751575;5880.26496687914;5921.7631294747725;5947.286325640951;5995.250593675791;6048.880957022877;1682;1702.191459056963;1737.3658614605579;1779.9021053842164;1780.6260685255982;855.7261676263661;860.3332417376458;897.3583887520324;922.7739203895088;961.3126614470548;17055.232514536874;18056.90971545134;18189.363372281907;18255;18363.72454413185;874.9343799215085;882.5895958379384;909.7634615000147;919.1865199298535;922.1562270522397;10076.899231007743;10270.845937310947;10380.169586433067;10393.53229104692;10459;387055;387914;399535;400091;403945;66887;68755.65622171958;71353;71892.99999999895;72032;933.3186773655134;935.4013431403907;943.3773709351932;944.4239014201469;944.9999999999862;15567;15750.527484175493;15822.647035542072;15901;16287.67424651524;34512.30975380528;35053.47419788756;35537.64462355343;35907.82046089753;36735.448968266035;46076;46149.30776038429;47182;47237.763811180725;47452;7382.741604043833;7492.587907664913;7513.534860702111;7525.88711169322;7542.094948606203;11630.70923226926;11908.702282443008;12233.632991010283;12304.0156787455;12378.442970066188;10730.409827459252;10825.67522974312;10928.6503401769;10967.50646220906;10974.012338889539;10184.083432491112;10192.643257485952;10217;10271.435071071162;10294.948525257325;10428.217883658604;10754.784904302027;10885.836712449478;11088.944555277172;11105.222634415837;7406.185319614946;7409.777706668809;7474.626268686653;7479.70081196746;7565.886511702219;9734.075262850018;10038.447885366375;10233.641822536176;10523.579056837641;10599.62901298451 02:49:40 INFO - PROCESS | 31189 | |3;mootools.html;1341.3226320708045;1385.106606238976;1455.6870272891326;1667.5414261078195;1688.5778555361153;6747.156605424322;7558.848823023536;7671.6547755351;8033.598320083995;8038.919610803898;7395.889061664066;7671.884921726165;7680.577568233745;7722.459427840054;7726.806829829257;2165.6968024476587;2209.624363858148;2212.9557408851815;2218.157100301883;2223.2218723446827;2167.1764729402803;2181.1384503121258;2198.505336299328;2202.2292197730826;2206.5145667953025;2134.4343748906554;2154.838387120972;2158.0504577985635;2161.9891900540474;2194.6269134247136;2123.0870725587993;2143.9571208575817;2148.387709502784;2150.53763440861;2159.9352019439443;2089.7910208979133;2135.626265403548;2151.236311109549;2156.2884248198056;2157.244964262511;7927.72252971149;8022.3983201260135;8024.919750802475;8028.157043510464;8035.156308587572;4587.288970209623;4751.809927602892;4758.857234282977;4758.881027974294;4768.47546769855;2854.685984541699;2856.9000084997133;2901.8694158762905;2911.1557648281973;2962.2742428105253;890.1098901098901;899.5727029660859;959.4627008875052;960.2462067277154;960.8174446855076;10554.419506927039;10578.100861426788;10579.100776434012;10609.469526523642;10616.57533698651;4143.502779666459;4244.172386384687;4380.408644832907;4391.4730232371685;4417.911641767211;9017.504037277882;9034.277257819358;9066.773330666654;9103.635854565875;9131.452112873249;4764.8332308369045;4783.784729687172;4790.233562629963;4802.255650374198;4822.855314340575;3751.2122454284904;4199.349100889367;4384.802683879233;4391.824327026883;4392.450943632046;3685.9078523037138;3714.201446688921;3800.923981520354;3842.346801043829;3936.1340505088833;1215.7203843116133;1224.975500490003;1248.9812652810215;1250.7123361626877;1261.413442749126;852.9232369086812;853.6073406233203;877.3639111644135;889.2707979456912;891.3804905590682;5488.1493368527945;5561.304836895388;5561.443855614406;5639.013172694762;5731;909.3589019741066;926.2589928057527;947.554649314821;991.0931497679686;999.4403134244847;3711.777293362407;3810.466534685146;3835.4438606401914;3871.5547712012917;3882.5535063467496;9488.478133702574;9707.9029209707;9756.756081097887;9782.5597848097;9795.9020409795;9347.485888276075;9672.129508344282;9691.321607487549;9781.266405019653;9784.315097943076;7450.776476705708;7471.066116735408;7507.0240868687815;7546.434017448713;7574.091109066837;5305.920411193758;5352.250684904195;5491.258680078298;5497.422770609189;5510.173473978935;8686.305095592465;8791.164839340252;8797.296216302808;8858.557072146496;8896.377253592187;8525.95737021311;8858.069902660385;8867.955660221658;8867.955660221658;8984.640614375352;6028.728707208098;6675.766348177791;6772.898406523807;6922.7923162305215;6940.548864323803;7729.227077292226;7739.961300193463;7748.147703752696;7787.571683557232;7815.2184781523665;6821.8635627286185;6904.482163837632;6983.266756990442;6993;7137.214906360193;6712.127423434922;6734.3265673434225;6754.96622516904;6779.762708305383;6837.692303846438;6152.292486363946;6368.87262254743;6442.90335644975;6443.097966284818;6444.742210311535;4587.17430862448;4606.88482787933;4714.104320179155;4788.640851936049;4843.128236917389;4651.604613607881;4710.411198600175;4741.336212930261;4786.856394308176;4824.0110777289865 02:49:40 INFO - PROCESS | 31189 | |4;prototype.html;292.3728602148392;297.5655542907355;303.2736595852931;304.7105250012488;308.9536569514574;5007.874803129924;5032.924506132406;5058.848234552965;5060.949390506094;5085.466026067265;4953.504649535044;4960.950390496094;4976.129177393959;4978.825741099062;5023.547880690737;3948.6643635291034;3952.861649842256;3956.843520281446;3967.809657102872;3979.8010099495054;3834.6740527055235;3895.6493915547594;3942.8422863085443;3971.761694298337;3984.3625019996807;3870.574236833946;3888.358420860555;3903.551091624457;3908.53097628285;3923.941140882889;3921.4510268443946;3933.6853051755793;3941.6452519273403;3959.5842436544035;3960.2475529649273;3237.919052023695;3338.7662863599558;3422.863085476578;3423.4864770284407;3450.879219227315;4839.153148199051;4859.3682821233015;4877;4884.951150488485;4935.333729946447;4478.57453541913;4479.2609219478745;4494.73031618104;4505.617022553087;4533.297338912474;5024.512866131252;5173.275741396207;5178.197379406198;5227.059129356714;5263.631365885367;3703.8148092595534;3729.5151630287887;3745.3445647011663;3751.212245428463;3760.172761992357;5454.7272636368025;5461.262729531502;5464.754086066137;5481.506664400184;5520.309961254843;3549.5208146900354;3776.3013842439236;3784.508013958223;3847.1920896611464;3850.4609354690365;3811.5426148862316;3819.4652748615217;3828.889622009586;3829.5404551454003;3833.846646134179;4372.207394968048;4383.189110014658;4383.495897971774;4385.6710746694125;4403.383526306319;4933.717233519311;5257.868553286122;5265.947340526623;5286.788528458896;5292.338457692788;1350.9662258443618;1353.4653811744504;1359.7484465373739;1365.9590212293647;1367.3778430813957;861.7974775927652;881.9382643215042;891.8528442806864;902.0438335364404;903.4579252448478;4080.9797550612348;4112.3420252759415;4135.90398544386;4160.396742472324;4167.708260421741;4727.834525791581;4745.857624271277;4754.23932170851;4756.7145971241835;4807.7019204814505;4103.5691252418665;4103.768869339246;4111.9177616447505;4130.586941305905;4135.697255364611;2437.780599745996;2578.3940773918116;2791.4556661450824;2832.8583570821374;2871.5118429866975;5118.181091025418;5123.745551957127;5135.460776618476;5136.30659860914;5139.817841896384;5485.561155107582;5512.5589952803675;5542.944570554243;5545.639533430314;5571.359293681197;4891.192953162759;5073.441921388644;5089.898202035939;5099.5410413063;5099.87250318745;5361.705106219196;5374.629469485412;5399.568034557147;5419.783208671609;5433.918491222714;5062;5276.920846187233;5283.709395983258;5317.229001794641;5327.147656374961;5160.380754309507;5165.870853228699;5177.197534382177;5190.97404512975;5194.168932970707;3801.41503777434;3804.467374567618;3839.0996456754087;3860.5367355916346;3861.4980052594105;5372.664464999956;5385.784568617211;5516.972415137899;5521.806736764194;5567.550277877721;5281.339832520935;5293.60297977661;5295.74311798249;5297.761600728054;5304.416514183359;5271;5288.762005709676;5297.496737809902;5299.49654782795;5312.495312945264;5072.289879416959;5144.434112247575;5213.452587478412;5223.81716639931;5234.267202591716;5320.813771517978;5335.893282134258;5355.196720491957;5363;5394.919076213939;5221.843344699665;5233.712145832016;5235.921461178009;5255.264263003106;5257.63196576236 02:49:40 INFO - PROCESS | 31189 | |5;yui.html;644.555256872758;647.2685864972581;703.1702590942685;733.9138075648041;766.2950085920954;11891.405429728511;12619.24284542927;12649.494020239192;12673.873261267408;12687.302198379086;11914.880851191485;12683.61949141525;12706.047046471505;12819.230846149214;13131.6717082073;767.1829501580812;780.7501599488166;782.2412260107686;783.8158032862273;784.1961988961303;772.1236396689769;786.3473317146783;786.8662327404355;787.3150359187515;789.7512283630638;818.3412353055787;828.4408024583412;829.3738227638155;829.875518672201;832.4339449174558;812.7480481050864;816.8693009118542;816.9387295952797;817.5666896544841;819.3035919468405;606.6511755740466;606.7451670298485;608.2184393054947;610.3103493052866;611.3428064830325;11481.36852473122;11487;11487.770244595145;11489.597864074718;11502.137339699557;12381.257124572465;12506.374681265901;12527.812082818766;12535.122541422104;12667.619971400873;11793.882061179364;11922.582709605122;11993.700157496045;12057.57798477049;12538.561150359694;4079.4900637420324;4159.604837540429;4178.6657067434535;4240.406343111967;4312;63008.36991630117;63221.367786322466;64570.67714661397;64613.35386646167;64660.35339646637;9592.228375973133;9597.424154550748;10105.090541851268;10270.435126068138;10279.383237005804;15955.680886382208;15999.120048397217;16023.919880400757;16060.598485037968;16118.516444506684;6807.693653785592;6826.112605361272;6827.624480653512;6893.310668933066;7066.399356054793;3667.468217108558;3691.8154092295276;3698.7780733156096;3806.4393598624433;3850.2492014057552;2863.3557449573677;2948.189247956786;2955.985220073886;2991.8504074796174;3202.3275112226693;556.4769117029979;561.6714222179988;569.5358282999342;573.0344369737006;578.3031447106227;526.3762441506826;549.0885130683047;608.0666177417643;620.5842085802433;633.5438484291303;8470.830583388297;8629.827403451896;8761.123887611187;9082.772930676654;9197.448153110834;591.5474661883662;604.5133667397699;610.9847253818601;619.5260625621403;620;3910.159315747128;4513.345564893072;4668.5798278155125;4738.502457242009;4870.245112007645;60452;61205.08192377118;61227.38772612306;61339.38660613337;100131.99868001373;64360;91884;91887;92763;96683;84271.15728842755;86169.56915215509;87129.56435217784;87617.12382876217;89174.55412722896;8655.610497527501;8781.692640757543;8785.51679657625;8795;8813.867791982997;48686.26970595515;49475.0629924397;49921.75039124781;50028;50387.244191336424;68972.31027689659;73888.63055684687;73936.63031684807;74202;74600.2539974615;10886.510107045044;11288.717782055513;11360.375179364884;11440.48517816717;11719.76560468803;12484.937575312066;12577.034586345913;12956.93521532424;13009.739805204032;13320.00099992485;10818.67543973682;10859.2398532102;11078.446077695922;11165.330080195214;11245.100391968459;12298.734478046632;12486.875131248935;12531.765409337639;12804.871951280367;13149.868501314864;11493.827592586285;11786.58746943853;12074.215176013531;12336.938315308365;12347.876521234673;8874.911250887408;8945.552722363986;8949.373543851867;9071.455712657262;9124.908750912406;9087.454752714859;9515.04849515043;9662.227021838376;9674.634893548979;9686.225101991964 02:49:40 INFO - PROCESS | 31189 | __end_tp_report 02:49:40 INFO - PROCESS | 31189 | __start_cc_report 02:49:40 INFO - PROCESS | 31189 | _x_x_mozilla_cycle_collect,383 02:49:40 INFO - PROCESS | 31189 | __end_cc_report 02:49:40 INFO - PROCESS | 31189 | __startTimestamp1468921780128__endTimestamp 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | ------- Summary: start ------- 02:49:40 INFO - PROCESS | 31189 | Number of tests: 6 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | [#0] dojo.html Cycles:165 Average:4770.12 Median:4903.63 stddev:619.46 (12.6%) stddev-sans-first:597.61 02:49:40 INFO - PROCESS | 31189 | Values: 2604.5 2638.0 2642.3 2653.1 2665.7 4747.2 4753.5 4785.2 4829.8 4864.7 4596.7 4658.9 4697.0 4737.4 4747.7 4336.1 4394.8 4467.2 4470.9 4501.3 4477.8 4513.5 4536.5 4593.8 4634.8 314.6 4464.2 4473.3 4565.0 4630.3 4471.9 4475.1 4484.8 4529.3 4538.0 4446.3 4452.5 4459.4 4470.6 4508.7 4707.8 4811.9 4843.7 4852.6 4890.7 5250.7 5253.0 5262.2 5263.0 5289.6 5280.2 5295.9 5296.3 5308.4 5364.3 4740.7 4799.5 4830.5 4863.4 4925.2 5345.9 5351.8 5366.3 5373.6 5403.9 5106.0 5109.8 5115.5 5128.5 5153.3 4997.2 5102.4 5199.4 5205.9 5236.9 5154.2 5180.4 5182.2 5189.8 5223.0 4952.6 5156.2 5175.1 5179.6 5188.7 4310.5 4371.9 4381.2 4390.0 4424.3 3793.4 3850.2 3857.9 3897.1 3910.1 4323.6 4517.0 4538.2 4553.1 4555.0 5177.0 5192.5 5219.9 5226.5 5233.9 4456.1 4488.7 4500.6 4502.1 4538.0 4590.7 4663.7 4713.8 4722.8 4748.9 4885.8 4903.4 4924.6 4940.1 4975.7 5202.9 5210.5 5216.5 5217.2 5260.2 4746.5 4870.6 4878.1 4908.8 4924.9 5090.5 5111.1 5120.0 5130.3 5160.6 5152.7 5172.8 5188.8 5205.8 5247.5 4806.2 4970.2 5011.5 5021.6 5041.3 5059.2 5067.1 5073.9 5083.2 5147.8 4960.9 4974.7 4982.9 4997.5 5010.8 4857.0 4999.6 5076.5 5080.9 5132.8 4902.6 4903.6 4922.2 4971.5 4980.3 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | [#1] ext.html Cycles:180 Average:47079.71 Median:36552.49 stddev:87919.81 (240.5%) stddev-sans-first:88097.06 02:49:40 INFO - PROCESS | 31189 | Values: 556.2 568.4 573.8 579.0 594.2 35384.3 39400.2 39465.2 39471.4 39501.4 38811.2 39251.2 39364.6 39611.8 39640.2 7786.9 7959.4 7965.2 7966.8 8002.5 7917.9 8006.6 8020.1 8022.8 8033.1 7935.7 8021.5 8057.6 8061.4 8083.9 7975.1 7985.6 8005.2 8011.9 8012.9 7864.5 7890.1 7898.1 7919.9 7921.8 38219.6 38649.8 38829.8 38833.6 38910.4 3019.5 3116.4 3378.9 3471.6 3767.6 29189.9 29209.1 29500.6 29604.4 29675.4 3192.9 3296.9 3371.0 3375.5 3376.8 260662.0 261529.0 261830.0 262052.7 262219.0 28204.4 28844.6 51302.0 51345.5 51422.2 33737.7 33789.8 33903.8 33982.8 33994.5 13530.7 13657.7 13658.7 13674.2 13694.0 11339.8 11360.1 11435.5 11450.0 11475.4 7805.5 7913.0 7928.8 7994.8 8000.6 3102.3 3106.3 3127.3 3174.0 3183.9 806.3 943.6 957.3 962.9 987.0 28332.6 28987.4 29173.7 29311.4 29523.7 918.4 966.2 982.9 1069.2 1093.1 14515.1 14772.9 14796.0 14887.7 14972.3 386081.0 386947.0 387541.0 388726.0 389112.0 50101.5 50190.7 50446.0 50767.5 50878.0 1196.4 1207.3 1238.0 1238.9 1246.5 25986.4 27163.6 27394.0 27663.0 27712.0 41695.0 41968.4 42136.4 42431.6 42484.0 335473.0 335996.0 338565.0 339840.0 340208.0 23449.6 23535.0 23543.3 23723.9 23875.8 42010.8 42744.8 43092.6 43101.8 43459.0 35422.0 36684.0 37106.8 37215.4 37764.0 34239.5 36448.3 36549.0 36716.0 36814.6 29948.7 35512.8 36384.0 36556.0 40129.2 32269.7 33836.3 33939.8 34173.3 34220.5 26202.2 26228.7 26319.5 26423.4 26592.1 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | [#2] jquery.html Cycles:180 Average:24091.05 Median:393724.50 stddev:64938.89 (16.5%) stddev-sans-first:65096.63 02:49:40 INFO - PROCESS | 31189 | Values: 366.8 368.0 368.9 377.0 385.6 15811.8 16095.3 17337.7 17350.1 17366.6 16461.7 16889.6 17265.6 17286.9 17290.1 5080.6 5232.5 5270.1 5271.6 5277.7 5154.1 5224.9 5226.7 5228.1 5231.5 5083.6 5184.0 5215.2 5243.3 5266.8 5121.5 5141.4 5166.5 5175.5 5199.9 4510.9 4573.5 4601.5 4623.5 4642.1 20622.3 21089.7 21122.5 21409.3 21421.6 1965.7 1971.9 2013.9 2057.5 2241.8 13058.1 13162.7 13172.1 13522.9 13676.1 1718.7 1735.7 1767.9 1768.1 1807.5 49418.0 60711.1 61236.7 65452.3 67063.3 9051.7 9166.6 9468.9 9472.1 9516.6 12538.8 12634.8 12653.7 12671.2 12719.0 7003.8 7070.9 7240.3 7443.5 7485.8 7222.2 7251.4 7289.4 7391.9 7396.3 5880.3 5921.8 5947.3 5995.3 6048.9 1682.0 1702.2 1737.4 1779.9 1780.6 855.7 860.3 897.4 922.8 961.3 17055.2 18056.9 18189.4 18255.0 18363.7 874.9 882.6 909.8 919.2 922.2 10076.9 10270.8 10380.2 10393.5 10459.0 387055.0 387914.0 399535.0 400091.0 403945.0 66887.0 68755.7 71353.0 71893.0 72032.0 933.3 935.4 943.4 944.4 945.0 15567.0 15750.5 15822.6 15901.0 16287.7 34512.3 35053.5 35537.6 35907.8 36735.4 46076.0 46149.3 47182.0 47237.8 47452.0 7382.7 7492.6 7513.5 7525.9 7542.1 11630.7 11908.7 12233.6 12304.0 12378.4 10730.4 10825.7 10928.7 10967.5 10974.0 10184.1 10192.6 10217.0 10271.4 10294.9 10428.2 10754.8 10885.8 11088.9 11105.2 7406.2 7409.8 7474.6 7479.7 7565.9 9734.1 10038.4 10233.6 10523.6 10599.6 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | [#3] mootools.html Cycles:180 Average:5204.17 Median:5535.74 stddev:2864.24 (51.7%) stddev-sans-first:2857.56 02:49:40 INFO - PROCESS | 31189 | Values: 1341.3 1385.1 1455.7 1667.5 1688.6 6747.2 7558.8 7671.7 8033.6 8038.9 7395.9 7671.9 7680.6 7722.5 7726.8 2165.7 2209.6 2213.0 2218.2 2223.2 2167.2 2181.1 2198.5 2202.2 2206.5 2134.4 2154.8 2158.1 2162.0 2194.6 2123.1 2144.0 2148.4 2150.5 2159.9 2089.8 2135.6 2151.2 2156.3 2157.2 7927.7 8022.4 8024.9 8028.2 8035.2 4587.3 4751.8 4758.9 4758.9 4768.5 2854.7 2856.9 2901.9 2911.2 2962.3 890.1 899.6 959.5 960.2 960.8 10554.4 10578.1 10579.1 10609.5 10616.6 4143.5 4244.2 4380.4 4391.5 4417.9 9017.5 9034.3 9066.8 9103.6 9131.5 4764.8 4783.8 4790.2 4802.3 4822.9 3751.2 4199.3 4384.8 4391.8 4392.5 3685.9 3714.2 3800.9 3842.3 3936.1 1215.7 1225.0 1249.0 1250.7 1261.4 852.9 853.6 877.4 889.3 891.4 5488.1 5561.3 5561.4 5639.0 5731.0 909.4 926.3 947.6 991.1 999.4 3711.8 3810.5 3835.4 3871.6 3882.6 9488.5 9707.9 9756.8 9782.6 9795.9 9347.5 9672.1 9691.3 9781.3 9784.3 7450.8 7471.1 7507.0 7546.4 7574.1 5305.9 5352.3 5491.3 5497.4 5510.2 8686.3 8791.2 8797.3 8858.6 8896.4 8526.0 8858.1 8868.0 8868.0 8984.6 6028.7 6675.8 6772.9 6922.8 6940.5 7729.2 7740.0 7748.1 7787.6 7815.2 6821.9 6904.5 6983.3 6993.0 7137.2 6712.1 6734.3 6755.0 6779.8 6837.7 6152.3 6368.9 6442.9 6443.1 6444.7 4587.2 4606.9 4714.1 4788.6 4843.1 4651.6 4710.4 4741.3 4786.9 4824.0 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | [#4] prototype.html Cycles:180 Average:4320.68 Median:4934.53 stddev:1270.56 (25.7%) stddev-sans-first:1237.62 02:49:40 INFO - PROCESS | 31189 | Values: 292.4 297.6 303.3 304.7 309.0 5007.9 5032.9 5058.8 5060.9 5085.5 4953.5 4961.0 4976.1 4978.8 5023.5 3948.7 3952.9 3956.8 3967.8 3979.8 3834.7 3895.6 3942.8 3971.8 3984.4 3870.6 3888.4 3903.6 3908.5 3923.9 3921.5 3933.7 3941.6 3959.6 3960.2 3237.9 3338.8 3422.9 3423.5 3450.9 4839.2 4859.4 4877.0 4885.0 4935.3 4478.6 4479.3 4494.7 4505.6 4533.3 5024.5 5173.3 5178.2 5227.1 5263.6 3703.8 3729.5 3745.3 3751.2 3760.2 5454.7 5461.3 5464.8 5481.5 5520.3 3549.5 3776.3 3784.5 3847.2 3850.5 3811.5 3819.5 3828.9 3829.5 3833.8 4372.2 4383.2 4383.5 4385.7 4403.4 4933.7 5257.9 5265.9 5286.8 5292.3 1351.0 1353.5 1359.7 1366.0 1367.4 861.8 881.9 891.9 902.0 903.5 4081.0 4112.3 4135.9 4160.4 4167.7 4727.8 4745.9 4754.2 4756.7 4807.7 4103.6 4103.8 4111.9 4130.6 4135.7 2437.8 2578.4 2791.5 2832.9 2871.5 5118.2 5123.7 5135.5 5136.3 5139.8 5485.6 5512.6 5542.9 5545.6 5571.4 4891.2 5073.4 5089.9 5099.5 5099.9 5361.7 5374.6 5399.6 5419.8 5433.9 5062.0 5276.9 5283.7 5317.2 5327.1 5160.4 5165.9 5177.2 5191.0 5194.2 3801.4 3804.5 3839.1 3860.5 3861.5 5372.7 5385.8 5517.0 5521.8 5567.6 5281.3 5293.6 5295.7 5297.8 5304.4 5271.0 5288.8 5297.5 5299.5 5312.5 5072.3 5144.4 5213.5 5223.8 5234.3 5320.8 5335.9 5355.2 5363.0 5394.9 5221.8 5233.7 5235.9 5255.3 5257.6 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - PROCESS | 31189 | [#5] yui.html Cycles:180 Average:17832.67 Median:584.93 stddev:25386.81 (4340.2%) stddev-sans-first:25425.22 02:49:40 INFO - PROCESS | 31189 | Values: 644.6 647.3 703.2 733.9 766.3 11891.4 12619.2 12649.5 12673.9 12687.3 11914.9 12683.6 12706.0 12819.2 13131.7 767.2 780.8 782.2 783.8 784.2 772.1 786.3 786.9 787.3 789.8 818.3 828.4 829.4 829.9 832.4 812.7 816.9 816.9 817.6 819.3 606.7 606.7 608.2 610.3 611.3 11481.4 11487.0 11487.8 11489.6 11502.1 12381.3 12506.4 12527.8 12535.1 12667.6 11793.9 11922.6 11993.7 12057.6 12538.6 4079.5 4159.6 4178.7 4240.4 4312.0 63008.4 63221.4 64570.7 64613.4 64660.4 9592.2 9597.4 10105.1 10270.4 10279.4 15955.7 15999.1 16023.9 16060.6 16118.5 6807.7 6826.1 6827.6 6893.3 7066.4 3667.5 3691.8 3698.8 3806.4 3850.2 2863.4 2948.2 2956.0 2991.9 3202.3 556.5 561.7 569.5 573.0 578.3 526.4 549.1 608.1 620.6 633.5 8470.8 8629.8 8761.1 9082.8 9197.4 591.5 604.5 611.0 619.5 620.0 3910.2 4513.3 4668.6 4738.5 4870.2 60452.0 61205.1 61227.4 61339.4 100132.0 64360.0 91884.0 91887.0 92763.0 96683.0 84271.2 86169.6 87129.6 87617.1 89174.6 8655.6 8781.7 8785.5 8795.0 8813.9 48686.3 49475.1 49921.8 50028.0 50387.2 68972.3 73888.6 73936.6 74202.0 74600.3 10886.5 11288.7 11360.4 11440.5 11719.8 12484.9 12577.0 12956.9 13009.7 13320.0 10818.7 10859.2 11078.4 11165.3 11245.1 12298.7 12486.9 12531.8 12804.9 13149.9 11493.8 11786.6 12074.2 12336.9 12347.9 8874.9 8945.6 8949.4 9071.5 9124.9 9087.5 9515.0 9662.2 9674.6 9686.2 02:49:40 INFO - PROCESS | 31189 | -------- Summary: end -------- 02:49:40 INFO - PROCESS | 31189 | 02:49:40 INFO - TEST-INFO | 31189: exit 0 02:49:40 INFO - TEST-OK | dromaeo_css | took 1117105ms 02:49:40 INFO - TEST-START | kraken 02:49:40 INFO - operating with platform_type : linux_ 02:49:40 INFO - Initialising browser for kraken test... 02:49:40 INFO - TEST-INFO | started process 31426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWYf9Jv/profile http://localhost:45562/getInfo.html) 02:49:46 INFO - PROCESS | 31426 | __metrics Screen width/height:1600/1200 02:49:46 INFO - PROCESS | 31426 | colorDepth:24 02:49:46 INFO - PROCESS | 31426 | Browser inner width/height: 1024/697 02:49:46 INFO - PROCESS | 31426 | __metrics 02:49:46 ERROR - PROCESS | 31426 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:49:47 INFO - TEST-INFO | 31426: exit 0 02:49:47 INFO - Browser initialized. 02:49:47 INFO - Running cycle 1/1 for kraken test... 02:49:47 INFO - TEST-INFO | started process 31543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWYf9Jv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:59 INFO - PROCESS | 31543 | RSS: Main: 169418752 02:49:59 INFO - PROCESS | 31543 | 02:50:02 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45562/tests/kraken/driver.html?testName=audio-beat-detection) 02:50:03 INFO - PROCESS | 31543 | RSS: Main: 174784512 02:50:03 INFO - PROCESS | 31543 | 02:50:06 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45562/tests/kraken/driver.html?testName=audio-dft) 02:50:06 INFO - PROCESS | 31543 | RSS: Main: 174243840 02:50:06 INFO - PROCESS | 31543 | 02:50:09 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45562/tests/kraken/driver.html?testName=audio-fft) 02:50:10 INFO - PROCESS | 31543 | RSS: Main: 168493056 02:50:10 INFO - PROCESS | 31543 | 02:50:12 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45562/tests/kraken/driver.html?testName=audio-oscillator) 02:50:13 INFO - PROCESS | 31543 | RSS: Main: 169775104 02:50:13 INFO - PROCESS | 31543 | 02:50:15 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45562/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:50:16 INFO - PROCESS | 31543 | RSS: Main: 169512960 02:50:16 INFO - PROCESS | 31543 | 02:50:19 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45562/tests/kraken/driver.html?testName=imaging-darkroom) 02:50:19 INFO - PROCESS | 31543 | RSS: Main: 169373696 02:50:19 INFO - PROCESS | 31543 | 02:50:23 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45562/tests/kraken/driver.html?testName=imaging-desaturate) 02:50:24 INFO - PROCESS | 31543 | RSS: Main: 167800832 02:50:24 INFO - PROCESS | 31543 | 02:50:27 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45562/tests/kraken/driver.html?testName=json-parse-financial) 02:50:27 INFO - PROCESS | 31543 | RSS: Main: 168833024 02:50:27 INFO - PROCESS | 31543 | 02:50:29 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45562/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:30 INFO - PROCESS | 31543 | RSS: Main: 169127936 02:50:30 INFO - PROCESS | 31543 | 02:50:31 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:32 INFO - PROCESS | 31543 | RSS: Main: 169762816 02:50:32 INFO - PROCESS | 31543 | 02:50:34 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:35 INFO - PROCESS | 31543 | RSS: Main: 169938944 02:50:35 INFO - PROCESS | 31543 | 02:50:38 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:38 INFO - PROCESS | 31543 | RSS: Main: 169914368 02:50:38 INFO - PROCESS | 31543 | 02:50:41 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:42 INFO - PROCESS | 31543 | RSS: Main: 169369600 02:50:42 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:45562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45562/tests/kraken/driver.html?testName=ai-astar) 02:50:44 INFO - PROCESS | 31543 | RSS: Main: 170065920 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | __start_tp_report 02:50:44 INFO - PROCESS | 31543 | _x_x_mozilla_page_load 02:50:44 INFO - PROCESS | 31543 | _x_x_mozilla_page_load_details 02:50:44 INFO - PROCESS | 31543 | |i|pagename|runs| 02:50:44 INFO - PROCESS | 31543 | |0;ai-astar;106;115;108;114;115;117;118;117;114;114 02:50:44 INFO - PROCESS | 31543 | |1;audio-beat-detection;149;123;154;182;126;149;147;125;196;123 02:50:44 INFO - PROCESS | 31543 | |2;audio-dft;167;165;165;168;169;164;163;162;164;162 02:50:44 INFO - PROCESS | 31543 | |3;audio-fft;76;76;76;169;77;78;78;76;164;77 02:50:44 INFO - PROCESS | 31543 | |4;audio-oscillator;85;85;146;85;85;86;144;86;87;145 02:50:44 INFO - PROCESS | 31543 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;118;117;117 02:50:44 INFO - PROCESS | 31543 | |6;imaging-darkroom;149;147;148;148;147;149;147;148;147;147 02:50:44 INFO - PROCESS | 31543 | |7;imaging-desaturate;95;96;95;95;96;96;96;97;96;96 02:50:44 INFO - PROCESS | 31543 | |8;json-parse-financial;63;65;64;65;64;66;63;64;65;65 02:50:44 INFO - PROCESS | 31543 | |9;json-stringify-tinderbox;67;66;66;66;67;67;66;67;67;67 02:50:44 INFO - PROCESS | 31543 | |10;stanford-crypto-aes;81;85;81;80;82;79;81;80;84;79 02:50:44 INFO - PROCESS | 31543 | |11;stanford-crypto-ccm;136;130;139;144;138;148;132;135;183;133 02:50:44 INFO - PROCESS | 31543 | |12;stanford-crypto-pbkdf2;167;168;165;167;168;166;173;168;169;173 02:50:44 INFO - PROCESS | 31543 | |13;stanford-crypto-sha256-iterative;68;67;80;71;70;67;68;66;73;69 02:50:44 INFO - PROCESS | 31543 | __end_tp_report 02:50:44 INFO - PROCESS | 31543 | __start_cc_report 02:50:44 INFO - PROCESS | 31543 | _x_x_mozilla_cycle_collect,1003 02:50:44 INFO - PROCESS | 31543 | __end_cc_report 02:50:44 INFO - PROCESS | 31543 | __startTimestamp1468921844474__endTimestamp 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | ------- Summary: start ------- 02:50:44 INFO - PROCESS | 31543 | Number of tests: 14 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:3.88 (3.4%) stddev-sans-first:2.92 02:50:44 INFO - PROCESS | 31543 | Values: 106.0 115.0 108.0 114.0 115.0 117.0 118.0 117.0 114.0 114.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:149.00 stddev:25.29 (17.0%) stddev-sans-first:26.82 02:50:44 INFO - PROCESS | 31543 | Values: 149.0 123.0 154.0 182.0 126.0 149.0 147.0 125.0 196.0 123.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.42 (1.5%) stddev-sans-first:2.45 02:50:44 INFO - PROCESS | 31543 | Values: 167.0 165.0 165.0 168.0 169.0 164.0 163.0 162.0 164.0 162.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.50 stddev:37.87 (49.5%) stddev-sans-first:39.56 02:50:44 INFO - PROCESS | 31543 | Values: 76.0 76.0 76.0 169.0 77.0 78.0 78.0 76.0 164.0 77.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:28.72 (33.8%) stddev-sans-first:29.68 02:50:44 INFO - PROCESS | 31543 | Values: 85.0 85.0 146.0 85.0 85.0 86.0 144.0 86.0 87.0 145.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:50:44 INFO - PROCESS | 31543 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 02:50:44 INFO - PROCESS | 31543 | Values: 149.0 147.0 148.0 148.0 147.0 149.0 147.0 148.0 147.0 147.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 02:50:44 INFO - PROCESS | 31543 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 97.0 96.0 96.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 02:50:44 INFO - PROCESS | 31543 | Values: 63.0 65.0 64.0 65.0 64.0 66.0 63.0 64.0 65.0 65.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:50:44 INFO - PROCESS | 31543 | Values: 67.0 66.0 66.0 66.0 67.0 67.0 66.0 67.0 67.0 67.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.99 (2.5%) stddev-sans-first:2.11 02:50:44 INFO - PROCESS | 31543 | Values: 81.0 85.0 81.0 80.0 82.0 79.0 81.0 80.0 84.0 79.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:138.50 stddev:15.48 (11.2%) stddev-sans-first:16.27 02:50:44 INFO - PROCESS | 31543 | Values: 136.0 130.0 139.0 144.0 138.0 148.0 132.0 135.0 183.0 133.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.00 stddev:2.67 (1.6%) stddev-sans-first:2.79 02:50:44 INFO - PROCESS | 31543 | Values: 167.0 168.0 165.0 167.0 168.0 166.0 173.0 168.0 169.0 173.0 02:50:44 INFO - PROCESS | 31543 | 02:50:44 INFO - PROCESS | 31543 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:4.12 (5.9%) stddev-sans-first:4.31 02:50:44 INFO - PROCESS | 31543 | Values: 68.0 67.0 80.0 71.0 70.0 67.0 68.0 66.0 73.0 69.0 02:50:44 INFO - PROCESS | 31543 | -------- Summary: end -------- 02:50:44 INFO - PROCESS | 31543 | 02:50:45 INFO - TEST-INFO | 31543: exit 0 02:50:45 INFO - TEST-OK | kraken | took 64882ms 02:50:45 INFO - SUITE-END | took 1181s 02:50:46 INFO - Completed test suite (00:19:42) 02:50:46 INFO - javascript benchmark 02:50:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6447.340798224834, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.5311843868103, 2637.973620263797, 2642.3129986203594, 2653.1112077454054, 2665.6667916510437, 4747.216709242975, 4753.500882407345, 4785.162596545603, 4829.806807727696, 4864.6837955532865, 4596.655250856191, 4658.883527911796, 4697.013627138296, 4737.3604563384015, 4747.667663263573, 4336.067745434731, 4394.802233899466, 4467.151241264166, 4470.910581788362, 4501.347304640825, 4477.820887164509, 4513.548645135476, 4536.478304994935, 4593.770311484429, 4634.814607415699, 314.6078479641572, 4464.218761716719, 4473.2842745160615, 4565.0, 4630.259158534635, 4471.8658440246845, 4475.149721552894, 4484.8206071757095, 4529.275315949465, 4538.001639639274, 4446.333050042487, 4452.48796388413, 4459.35339375792, 4470.597646211857, 4508.729476231404, 4707.835225767116, 4811.855644330676, 4843.66094373394, 4852.636052296092, 4890.682105663121, 5250.737463126867, 5252.973735131338, 5262.184361423985, 5263.0000299942885, 5289.629725919187, 5280.155175171954, 5295.947040529584, 5296.3379577552805, 5308.389535203462, 5364.329458817648, 4740.7392593407, 4799.496052914464, 4830.468648448667, 4863.367762190893, 4925.236588328779, 5345.893082138413, 5351.759170837322, 5366.302380690485, 5373.596980226499, 5403.864903377368, 5106.0, 5109.821156259587, 5115.462876397999, 5128.512791284897, 5153.252778347119, 4997.150484417658, 5102.438731739506, 5199.428062913076, 5205.9219111713355, 5236.895262094737, 5154.201098829687, 5180.404253510819, 5182.196759502283, 5189.766460509286, 5223.0, 4952.579030782352, 5156.226566015052, 5175.120229560984, 5179.585633149339, 5188.662736922088, 4310.52584215736, 4371.890702732457, 4381.233284175257, 4390.0, 4424.292113261863, 3793.393057110904, 3850.172212974168, 3857.884263472044, 3897.0841852165286, 3910.1397692507603, 4323.589259020388, 4517.028838799608, 4538.205813982606, 4553.066621342617, 4555.020670555847, 5176.9741151294, 5192.532672059458, 5219.895602087937, 5226.503482169188, 5233.869153271123, 4456.086502267092, 4488.663350248679, 4500.617447516932, 4502.144592527409, 4538.02432477019, 4590.701604395704, 4663.650226233046, 4713.7643117844655, 4722.763861806896, 4748.857534273909, 4885.828995985124, 4903.387076615423, 4924.63065270099, 4940.110780059624, 4975.651704380731, 5202.895942081062, 5210.53105220532, 5216.530512253916, 5217.217417387271, 5260.158374660036, 4746.501617330268, 4870.634702397264, 4878.121938051185, 4908.7545622719435, 4924.901501970012, 5090.541851233407, 5111.105556527667, 5120.0, 5130.333056702605, 5160.561352285098, 5152.690838549699, 5172.818951336685, 5188.792448302026, 5205.843824685266, 5247.475252474875, 4806.2310030394965, 4970.179920313108, 5011.498850114959, 5021.598272138147, 5041.269015992734, 5059.241113832954, 5067.087924173684, 5073.898522029613, 5083.186690129562, 5147.845564632918, 4960.8759781005765, 4974.701517908937, 4982.925256121089, 4997.5002499749735, 5010.7745151469, 4857.0, 4999.550040496373, 5076.543111120017, 5080.923786143285, 5132.8460146195675, 4902.583280421061, 4903.632227583017, 4922.1632322505975, 4971.502849715, 4980.302757613865], "value": 4732.360505010127, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1879655702677, 568.4202113843879, 573.7704918032789, 579.0387955993052, 594.1889321076732, 35384.29231415373, 39400.211995760066, 39465.21069578607, 39471.40792888105, 39501.40747888784, 38811.22377552447, 39251.214975700466, 39364.606353936455, 39611.80194099033, 39640.207195856136, 7786.922130778677, 7959.3632509399395, 7965.203479652017, 7966.800829979239, 8002.479838810488, 7917.881231781528, 8006.599670016505, 8020.11778704342, 8022.759317220463, 8033.1163572007035, 7935.682572697114, 8021.478603890758, 8057.556834374107, 8061.395395345343, 8083.919160808405, 7975.122736498981, 7985.640646170878, 8005.239502247277, 8011.879821802678, 8012.879806802932, 7864.4888082274465, 7890.053193616745, 7898.091719452279, 7919.920800791976, 7921.841563168762, 38219.617803821886, 38649.806750966345, 38829.80585097085, 38833.61166388328, 38910.41634375486, 3019.4564978303897, 3116.3611459650715, 3378.9155271118175, 3471.5660542432197, 3767.566729826078, 29189.854050729824, 29209.123726288246, 29500.557491637643, 29604.40791184186, 29675.406491870042, 3192.8984500347574, 3296.901092967215, 3370.9831450842835, 3375.544301519288, 3376.7973921564785, 260662.0, 261529.0, 261830.0, 262052.689736552, 262219.0, 28204.43591128166, 28844.567331490045, 51302.0, 51345.486545134816, 51422.22866657003, 33737.662623373944, 33789.83105084459, 33903.830480847435, 33982.830085849906, 33994.49008264878, 13530.661733456742, 13657.726845463036, 13658.726825463435, 13674.17954922688, 13694.041417100707, 11339.829902551468, 11360.147988900866, 11435.542578296774, 11450.0, 11475.426228688531, 7805.5316680998185, 7912.960435197902, 7928.7621371358955, 7994.800129996796, 8000.5599692017495, 3102.317490152163, 3106.3010822565193, 3127.343257915863, 3174.0479605042733, 3183.8567264473154, 806.2622700229225, 943.5848226780195, 957.2533423929207, 962.8603852441357, 987.017917172418, 28332.575011374847, 28987.42025159527, 29173.7082629171, 29311.413771724445, 29523.704762952526, 918.3800934369274, 966.1932286540817, 982.8525721141743, 1069.1767339148812, 1093.0763504838399, 14515.129092254498, 14772.926135369255, 14796.0, 14887.702245955237, 14972.251387430584, 386081.0, 386947.0, 387541.0, 388726.0, 389112.0, 50101.49898501041, 50190.74904625453, 50446.0, 50767.492325077015, 50878.0, 1196.4257156564724, 1207.3128665056986, 1237.9566715164926, 1238.8629613916103, 1246.4827096754746, 25986.350341240865, 27163.592546111428, 27394.0, 27663.0, 27712.0, 41695.0, 41968.370474442294, 42136.36795448009, 42431.575684242765, 42484.0, 335473.0, 335996.0, 338565.0, 339840.0, 340208.0, 23449.648255275843, 23535.02519905786, 23543.29370118899, 23723.881380592986, 23875.761242387354, 42010.78994605008, 42744.77271818699, 43092.569074308856, 43101.78449107734, 43459.0, 35422.0, 36684.0, 37106.8144659275, 37215.44176837404, 37764.0, 34239.48640770341, 36448.27103457863, 36549.0, 36716.0, 36814.63185368112, 29948.70051299459, 35512.82243588869, 36384.0, 36555.97884232679, 40129.1974160521, 32269.677303227607, 33836.32327353489, 33939.830300848334, 34173.316533669684, 34220.48669270013, 26202.213933582025, 26228.73771262339, 26319.4736105273, 26423.37864424116, 26592.069277575192], "value": 16595.654493836068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.78543052314393, 368.0485943835186, 368.9335919534483, 376.99434508482375, 385.63172170577104, 15811.84188158118, 16095.275712592933, 17337.739933901, 17350.132493375342, 17366.56583585411, 16461.67076658469, 16889.577760555992, 17265.568360790985, 17286.913565432187, 17290.135493225353, 5080.618953578487, 5232.45059268777, 5270.104082305998, 5271.551918086967, 5277.656952298107, 5154.07226699194, 5224.947750522484, 5226.738663066851, 5228.0850851101095, 5231.450697676746, 5083.567896728782, 5184.0, 5215.191645294985, 5243.292155559008, 5266.789328426858, 5121.513456221653, 5141.434442211354, 5166.483351664841, 5175.482451754794, 5199.896002079956, 4510.8646740597505, 4573.49691533931, 4601.481511101329, 4623.514530974233, 4642.117997580483, 20622.278220262368, 21089.68365474519, 21122.471938201514, 21409.250676226413, 21421.571568568543, 1965.7247985282072, 1971.9309824156085, 2013.8690985085923, 2057.4856285928518, 2241.7982381585734, 13058.085933984625, 13162.736745265136, 13172.077954543185, 13522.932385338108, 13676.111052781538, 1718.7335962925642, 1735.7396390541394, 1767.938122165718, 1768.0831197727355, 1807.5119717676284, 49418.0, 60711.08933366003, 61236.693816530635, 65452.345476545575, 67063.32936670669, 9051.728448146567, 9166.633334666538, 9468.90531094694, 9472.100150485692, 9516.571754271074, 12538.81191782124, 12634.81047784284, 12653.683657908627, 12671.17637353569, 12719.046071544672, 7003.789886303419, 7070.92929070713, 7240.312170343809, 7443.478956473104, 7485.7754267372065, 7222.169450513154, 7251.3836323912, 7289.380402665833, 7391.926080739231, 7396.297351751575, 5880.26496687914, 5921.7631294747725, 5947.286325640951, 5995.250593675791, 6048.880957022877, 1682.0, 1702.191459056963, 1737.3658614605579, 1779.9021053842164, 1780.6260685255982, 855.7261676263661, 860.3332417376458, 897.3583887520324, 922.7739203895088, 961.3126614470548, 17055.232514536874, 18056.90971545134, 18189.363372281907, 18255.0, 18363.72454413185, 874.9343799215085, 882.5895958379384, 909.7634615000147, 919.1865199298535, 922.1562270522397, 10076.899231007743, 10270.845937310947, 10380.169586433067, 10393.53229104692, 10459.0, 387055.0, 387914.0, 399535.0, 400091.0, 403945.0, 66887.0, 68755.65622171958, 71353.0, 71892.99999999895, 72032.0, 933.3186773655134, 935.4013431403907, 943.3773709351932, 944.4239014201469, 944.9999999999862, 15567.0, 15750.527484175493, 15822.647035542072, 15901.0, 16287.67424651524, 34512.30975380528, 35053.47419788756, 35537.64462355343, 35907.82046089753, 36735.448968266035, 46076.0, 46149.30776038429, 47182.0, 47237.763811180725, 47452.0, 7382.741604043833, 7492.587907664913, 7513.534860702111, 7525.88711169322, 7542.094948606203, 11630.70923226926, 11908.702282443008, 12233.632991010283, 12304.0156787455, 12378.442970066188, 10730.409827459252, 10825.67522974312, 10928.6503401769, 10967.50646220906, 10974.012338889539, 10184.083432491112, 10192.643257485952, 10217.0, 10271.435071071162, 10294.948525257325, 10428.217883658604, 10754.784904302027, 10885.836712449478, 11088.944555277172, 11105.222634415837, 7406.185319614946, 7409.777706668809, 7474.626268686653, 7479.70081196746, 7565.886511702219, 9734.075262850018, 10038.447885366375, 10233.641822536176, 10523.579056837641, 10599.62901298451], "value": 8305.22583868651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.3226320708045, 1385.106606238976, 1455.6870272891326, 1667.5414261078195, 1688.5778555361153, 6747.156605424322, 7558.848823023536, 7671.6547755351, 8033.598320083995, 8038.919610803898, 7395.889061664066, 7671.884921726165, 7680.577568233745, 7722.459427840054, 7726.806829829257, 2165.6968024476587, 2209.624363858148, 2212.9557408851815, 2218.157100301883, 2223.2218723446827, 2167.1764729402803, 2181.1384503121258, 2198.505336299328, 2202.2292197730826, 2206.5145667953025, 2134.4343748906554, 2154.838387120972, 2158.0504577985635, 2161.9891900540474, 2194.6269134247136, 2123.0870725587993, 2143.9571208575817, 2148.387709502784, 2150.53763440861, 2159.9352019439443, 2089.7910208979133, 2135.626265403548, 2151.236311109549, 2156.2884248198056, 2157.244964262511, 7927.72252971149, 8022.3983201260135, 8024.919750802475, 8028.157043510464, 8035.156308587572, 4587.288970209623, 4751.809927602892, 4758.857234282977, 4758.881027974294, 4768.47546769855, 2854.685984541699, 2856.9000084997133, 2901.8694158762905, 2911.1557648281973, 2962.2742428105253, 890.1098901098901, 899.5727029660859, 959.4627008875052, 960.2462067277154, 960.8174446855076, 10554.419506927039, 10578.100861426788, 10579.100776434012, 10609.469526523642, 10616.57533698651, 4143.502779666459, 4244.172386384687, 4380.408644832907, 4391.4730232371685, 4417.911641767211, 9017.504037277882, 9034.277257819358, 9066.773330666654, 9103.635854565875, 9131.452112873249, 4764.8332308369045, 4783.784729687172, 4790.233562629963, 4802.255650374198, 4822.855314340575, 3751.2122454284904, 4199.349100889367, 4384.802683879233, 4391.824327026883, 4392.450943632046, 3685.9078523037138, 3714.201446688921, 3800.923981520354, 3842.346801043829, 3936.1340505088833, 1215.7203843116133, 1224.975500490003, 1248.9812652810215, 1250.7123361626877, 1261.413442749126, 852.9232369086812, 853.6073406233203, 877.3639111644135, 889.2707979456912, 891.3804905590682, 5488.1493368527945, 5561.304836895388, 5561.443855614406, 5639.013172694762, 5731.0, 909.3589019741066, 926.2589928057527, 947.554649314821, 991.0931497679686, 999.4403134244847, 3711.777293362407, 3810.466534685146, 3835.4438606401914, 3871.5547712012917, 3882.5535063467496, 9488.478133702574, 9707.9029209707, 9756.756081097887, 9782.5597848097, 9795.9020409795, 9347.485888276075, 9672.129508344282, 9691.321607487549, 9781.266405019653, 9784.315097943076, 7450.776476705708, 7471.066116735408, 7507.0240868687815, 7546.434017448713, 7574.091109066837, 5305.920411193758, 5352.250684904195, 5491.258680078298, 5497.422770609189, 5510.173473978935, 8686.305095592465, 8791.164839340252, 8797.296216302808, 8858.557072146496, 8896.377253592187, 8525.95737021311, 8858.069902660385, 8867.955660221658, 8867.955660221658, 8984.640614375352, 6028.728707208098, 6675.766348177791, 6772.898406523807, 6922.7923162305215, 6940.548864323803, 7729.227077292226, 7739.961300193463, 7748.147703752696, 7787.571683557232, 7815.2184781523665, 6821.8635627286185, 6904.482163837632, 6983.266756990442, 6993.0, 7137.214906360193, 6712.127423434922, 6734.3265673434225, 6754.96622516904, 6779.762708305383, 6837.692303846438, 6152.292486363946, 6368.87262254743, 6442.90335644975, 6443.097966284818, 6444.742210311535, 4587.17430862448, 4606.88482787933, 4714.104320179155, 4788.640851936049, 4843.128236917389, 4651.604613607881, 4710.411198600175, 4741.336212930261, 4786.856394308176, 4824.0110777289865], "value": 4215.738820821285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.3728602148392, 297.5655542907355, 303.2736595852931, 304.7105250012488, 308.9536569514574, 5007.874803129924, 5032.924506132406, 5058.848234552965, 5060.949390506094, 5085.466026067265, 4953.504649535044, 4960.950390496094, 4976.129177393959, 4978.825741099062, 5023.547880690737, 3948.6643635291034, 3952.861649842256, 3956.843520281446, 3967.809657102872, 3979.8010099495054, 3834.6740527055235, 3895.6493915547594, 3942.8422863085443, 3971.761694298337, 3984.3625019996807, 3870.574236833946, 3888.358420860555, 3903.551091624457, 3908.53097628285, 3923.941140882889, 3921.4510268443946, 3933.6853051755793, 3941.6452519273403, 3959.5842436544035, 3960.2475529649273, 3237.919052023695, 3338.7662863599558, 3422.863085476578, 3423.4864770284407, 3450.879219227315, 4839.153148199051, 4859.3682821233015, 4877.0, 4884.951150488485, 4935.333729946447, 4478.57453541913, 4479.2609219478745, 4494.73031618104, 4505.617022553087, 4533.297338912474, 5024.512866131252, 5173.275741396207, 5178.197379406198, 5227.059129356714, 5263.631365885367, 3703.8148092595534, 3729.5151630287887, 3745.3445647011663, 3751.212245428463, 3760.172761992357, 5454.7272636368025, 5461.262729531502, 5464.754086066137, 5481.506664400184, 5520.309961254843, 3549.5208146900354, 3776.3013842439236, 3784.508013958223, 3847.1920896611464, 3850.4609354690365, 3811.5426148862316, 3819.4652748615217, 3828.889622009586, 3829.5404551454003, 3833.846646134179, 4372.207394968048, 4383.189110014658, 4383.495897971774, 4385.6710746694125, 4403.383526306319, 4933.717233519311, 5257.868553286122, 5265.947340526623, 5286.788528458896, 5292.338457692788, 1350.9662258443618, 1353.4653811744504, 1359.7484465373739, 1365.9590212293647, 1367.3778430813957, 861.7974775927652, 881.9382643215042, 891.8528442806864, 902.0438335364404, 903.4579252448478, 4080.9797550612348, 4112.3420252759415, 4135.90398544386, 4160.396742472324, 4167.708260421741, 4727.834525791581, 4745.857624271277, 4754.23932170851, 4756.7145971241835, 4807.7019204814505, 4103.5691252418665, 4103.768869339246, 4111.9177616447505, 4130.586941305905, 4135.697255364611, 2437.780599745996, 2578.3940773918116, 2791.4556661450824, 2832.8583570821374, 2871.5118429866975, 5118.181091025418, 5123.745551957127, 5135.460776618476, 5136.30659860914, 5139.817841896384, 5485.561155107582, 5512.5589952803675, 5542.944570554243, 5545.639533430314, 5571.359293681197, 4891.192953162759, 5073.441921388644, 5089.898202035939, 5099.5410413063, 5099.87250318745, 5361.705106219196, 5374.629469485412, 5399.568034557147, 5419.783208671609, 5433.918491222714, 5062.0, 5276.920846187233, 5283.709395983258, 5317.229001794641, 5327.147656374961, 5160.380754309507, 5165.870853228699, 5177.197534382177, 5190.97404512975, 5194.168932970707, 3801.41503777434, 3804.467374567618, 3839.0996456754087, 3860.5367355916346, 3861.4980052594105, 5372.664464999956, 5385.784568617211, 5516.972415137899, 5521.806736764194, 5567.550277877721, 5281.339832520935, 5293.60297977661, 5295.74311798249, 5297.761600728054, 5304.416514183359, 5271.0, 5288.762005709676, 5297.496737809902, 5299.49654782795, 5312.495312945264, 5072.289879416959, 5144.434112247575, 5213.452587478412, 5223.81716639931, 5234.267202591716, 5320.813771517978, 5335.893282134258, 5355.196720491957, 5363.0, 5394.919076213939, 5221.843344699665, 5233.712145832016, 5235.921461178009, 5255.264263003106, 5257.63196576236], "value": 3917.228951748032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.555256872758, 647.2685864972581, 703.1702590942685, 733.9138075648041, 766.2950085920954, 11891.405429728511, 12619.24284542927, 12649.494020239192, 12673.873261267408, 12687.302198379086, 11914.880851191485, 12683.61949141525, 12706.047046471505, 12819.230846149214, 13131.6717082073, 767.1829501580812, 780.7501599488166, 782.2412260107686, 783.8158032862273, 784.1961988961303, 772.1236396689769, 786.3473317146783, 786.8662327404355, 787.3150359187515, 789.7512283630638, 818.3412353055787, 828.4408024583412, 829.3738227638155, 829.875518672201, 832.4339449174558, 812.7480481050864, 816.8693009118542, 816.9387295952797, 817.5666896544841, 819.3035919468405, 606.6511755740466, 606.7451670298485, 608.2184393054947, 610.3103493052866, 611.3428064830325, 11481.36852473122, 11487.0, 11487.770244595145, 11489.597864074718, 11502.137339699557, 12381.257124572465, 12506.374681265901, 12527.812082818766, 12535.122541422104, 12667.619971400873, 11793.882061179364, 11922.582709605122, 11993.700157496045, 12057.57798477049, 12538.561150359694, 4079.4900637420324, 4159.604837540429, 4178.6657067434535, 4240.406343111967, 4312.0, 63008.36991630117, 63221.367786322466, 64570.67714661397, 64613.35386646167, 64660.35339646637, 9592.228375973133, 9597.424154550748, 10105.090541851268, 10270.435126068138, 10279.383237005804, 15955.680886382208, 15999.120048397217, 16023.919880400757, 16060.598485037968, 16118.516444506684, 6807.693653785592, 6826.112605361272, 6827.624480653512, 6893.310668933066, 7066.399356054793, 3667.468217108558, 3691.8154092295276, 3698.7780733156096, 3806.4393598624433, 3850.2492014057552, 2863.3557449573677, 2948.189247956786, 2955.985220073886, 2991.8504074796174, 3202.3275112226693, 556.4769117029979, 561.6714222179988, 569.5358282999342, 573.0344369737006, 578.3031447106227, 526.3762441506826, 549.0885130683047, 608.0666177417643, 620.5842085802433, 633.5438484291303, 8470.830583388297, 8629.827403451896, 8761.123887611187, 9082.772930676654, 9197.448153110834, 591.5474661883662, 604.5133667397699, 610.9847253818601, 619.5260625621403, 620.0, 3910.159315747128, 4513.345564893072, 4668.5798278155125, 4738.502457242009, 4870.245112007645, 60452.0, 61205.08192377118, 61227.38772612306, 61339.38660613337, 100131.99868001373, 64360.0, 91884.0, 91887.0, 92763.0, 96683.0, 84271.15728842755, 86169.56915215509, 87129.56435217784, 87617.12382876217, 89174.55412722896, 8655.610497527501, 8781.692640757543, 8785.51679657625, 8795.0, 8813.867791982997, 48686.26970595515, 49475.0629924397, 49921.75039124781, 50028.0, 50387.244191336424, 68972.31027689659, 73888.63055684687, 73936.63031684807, 74202.0, 74600.2539974615, 10886.510107045044, 11288.717782055513, 11360.375179364884, 11440.48517816717, 11719.76560468803, 12484.937575312066, 12577.034586345913, 12956.93521532424, 13009.739805204032, 13320.00099992485, 10818.67543973682, 10859.2398532102, 11078.446077695922, 11165.330080195214, 11245.100391968459, 12298.734478046632, 12486.875131248935, 12531.765409337639, 12804.871951280367, 13149.868501314864, 11493.827592586285, 11786.58746943853, 12074.215176013531, 12336.938315308365, 12347.876521234673, 8874.911250887408, 8945.552722363986, 8949.373543851867, 9071.455712657262, 9124.908750912406, 9087.454752714859, 9515.04849515043, 9662.227021838376, 9674.634893548979, 9686.225101991964], "value": 6667.490093157546, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 108.0, 114.0, 115.0, 117.0, 118.0, 117.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 154.0, 182.0, 126.0, 149.0, 147.0, 125.0, 196.0, 123.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 165.0, 168.0, 169.0, 164.0, 163.0, 162.0, 164.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 169.0, 77.0, 78.0, 78.0, 76.0, 164.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 85.0, 85.0, 86.0, 144.0, 86.0, 87.0, 145.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 148.0, 147.0, 149.0, 147.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 64.0, 66.0, 63.0, 64.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 81.0, 80.0, 82.0, 79.0, 81.0, 80.0, 84.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 139.0, 144.0, 138.0, 148.0, 132.0, 135.0, 183.0, 133.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 165.0, 167.0, 168.0, 166.0, 173.0, 168.0, 169.0, 173.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 80.0, 71.0, 70.0, 67.0, 68.0, 66.0, 73.0, 69.0], "value": 69.9, "unit": "score"}]}]} 02:50:46 INFO - Return code: 0 02:50:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:50:46 ERROR - # TBPL SUCCESS # 02:50:46 INFO - Running post-action listener: _resource_record_post_action 02:50:46 INFO - ##### 02:50:46 INFO - ##### Finished run-tests step (success) 02:50:46 INFO - ##### 02:50:46 INFO - Running post-run listener: _resource_record_post_run 02:50:46 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 559800320; Read time: 0; Write time: 458040 02:50:46 INFO - TinderboxPrint: CPU usage
13.3% 02:50:46 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:50:46 INFO - TinderboxPrint: I/O write bytes / time
559,800,320 / 458,040 02:50:46 INFO - TinderboxPrint: CPU idle
8,289.9 (86.6%) 02:50:46 INFO - TinderboxPrint: CPU user
1,220.8 (12.8%) 02:50:46 INFO - TinderboxPrint: Swap in / out
0 / 0 02:50:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255774720; Read time: 0; Write time: 252136 02:50:46 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 299511808; Read time: 0; Write time: 205300 02:50:46 INFO - Running post-run listener: _upload_blobber_files 02:50:46 INFO - Blob upload gear active. 02:50:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:50:46 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 02:50:46 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'] 02:50:46 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 02:50:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:50:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:50:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:50:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:55 INFO - (blobuploader) - INFO - Done attempting. 02:50:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:50:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:50:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:56 INFO - (blobuploader) - INFO - Done attempting. 02:50:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:50:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:50:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:56 INFO - (blobuploader) - INFO - Done attempting. 02:50:56 INFO - (blobuploader) - INFO - Iteration through files over. 02:50:56 INFO - Return code: 0 02:50:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:50:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:50:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38ff0a746b67628c3b733d0599846217d0aa9156a6b6e8be49494b8e8c2db6b1d68548eb3c1286494cf5eecd1f665499d72c6f5b964a10b7fd8973fa34aa6dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3385a6201b0a099ad0c0992423ca19a783e5597ca6cc8d93cda2fddbe1d16ba65296f20c50487c42e18f71879f5153d3de1b4f87a94a0023f5b19bd6cb6bbe9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d71c8023015dbea2c62440c9f4f82a6c68a0400cf97a648224fcd13c0b02903d9ec34a577ffb6194ba4764da60962e8c4c1600acd28e801b7396d5d7474d6f1"} 02:50:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:50:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:50:56 INFO - Contents: 02:50:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38ff0a746b67628c3b733d0599846217d0aa9156a6b6e8be49494b8e8c2db6b1d68548eb3c1286494cf5eecd1f665499d72c6f5b964a10b7fd8973fa34aa6dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3385a6201b0a099ad0c0992423ca19a783e5597ca6cc8d93cda2fddbe1d16ba65296f20c50487c42e18f71879f5153d3de1b4f87a94a0023f5b19bd6cb6bbe9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d71c8023015dbea2c62440c9f4f82a6c68a0400cf97a648224fcd13c0b02903d9ec34a577ffb6194ba4764da60962e8c4c1600acd28e801b7396d5d7474d6f1"} 02:50:56 INFO - Running post-run listener: copy_logs_to_upload_dir 02:50:56 INFO - Copying logs to upload dir... 02:50:56 INFO - mkdir: /builds/slave/test/build/upload/logs 02:50:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.128433 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-19 02:50:56.405470) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 02:50:56.409352) ========= 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=eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38ff0a746b67628c3b733d0599846217d0aa9156a6b6e8be49494b8e8c2db6b1d68548eb3c1286494cf5eecd1f665499d72c6f5b964a10b7fd8973fa34aa6dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3385a6201b0a099ad0c0992423ca19a783e5597ca6cc8d93cda2fddbe1d16ba65296f20c50487c42e18f71879f5153d3de1b4f87a94a0023f5b19bd6cb6bbe9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d71c8023015dbea2c62440c9f4f82a6c68a0400cf97a648224fcd13c0b02903d9ec34a577ffb6194ba4764da60962e8c4c1600acd28e801b7396d5d7474d6f1"} build_url:https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/XoZOhrgQS8eQOaNBdYH9Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/38ff0a746b67628c3b733d0599846217d0aa9156a6b6e8be49494b8e8c2db6b1d68548eb3c1286494cf5eecd1f665499d72c6f5b964a10b7fd8973fa34aa6dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e3385a6201b0a099ad0c0992423ca19a783e5597ca6cc8d93cda2fddbe1d16ba65296f20c50487c42e18f71879f5153d3de1b4f87a94a0023f5b19bd6cb6bbe9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2d71c8023015dbea2c62440c9f4f82a6c68a0400cf97a648224fcd13c0b02903d9ec34a577ffb6194ba4764da60962e8c4c1600acd28e801b7396d5d7474d6f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 02:50:56.434737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:50:56.435078) ========= 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=eca2ab57546de7b41f256b19000001ef-1468920447.573772-1300459169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:50:56.519953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 02:50:56.520628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 02:50:56.521287) ========= ========= Total master_lag: 0.17 =========