builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1467848898.02 results: success (0) buildid: 20160706153024 builduid: 652c7787013a43f09862526a70d03cc3 revision: 9740c3f2b075012c80e6f6106a6736e682fb918a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.024025) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.024509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.024946) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.074678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.074993) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 16:48:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.5M=0s 2016-07-06 16:48:18 (23.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098850 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.199796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.200124) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021170 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.272717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.273085) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9740c3f2b075012c80e6f6106a6736e682fb918a --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 9740c3f2b075012c80e6f6106a6736e682fb918a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 16:48:18,494 truncating revision to first 12 chars 2016-07-06 16:48:18,494 Setting DEBUG logging. 2016-07-06 16:48:18,494 attempt 1/10 2016-07-06 16:48:18,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9740c3f2b075?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 16:48:18,810 unpacking tar archive at: autoland-9740c3f2b075/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.950616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.950945) ========= script_repo_revision: 9740c3f2b075012c80e6f6106a6736e682fb918a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.951398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.951715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 16:48:18.962384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-06 16:48:18.962742) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:48:19 INFO - MultiFileLogger online at 20160706 16:48:19 in /builds/slave/test 16:48:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 16:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:48:19 INFO - {'append_to_log': False, 16:48:19 INFO - 'base_work_dir': '/builds/slave/test', 16:48:19 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 16:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:48:19 INFO - 'branch': 'Autoland-Non-PGO', 16:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:48:19 INFO - 'config_files': ('talos/linux_config.py',), 16:48:19 INFO - 'default_actions': ('clobber', 16:48:19 INFO - 'read-buildbot-config', 16:48:19 INFO - 'download-and-extract', 16:48:19 INFO - 'populate-webroot', 16:48:19 INFO - 'create-virtualenv', 16:48:19 INFO - 'install', 16:48:19 INFO - 'run-tests'), 16:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:48:19 INFO - 'download_minidump_stackwalk': True, 16:48:19 INFO - 'download_symbols': 'ondemand', 16:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:48:19 INFO - 'installer_path': 'installer.exe', 16:48:19 INFO - 'log_level': 'info', 16:48:19 INFO - 'log_name': 'talos', 16:48:19 INFO - 'log_to_console': True, 16:48:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:48:19 INFO - 'opt_config_files': (), 16:48:19 INFO - 'pip_index': False, 16:48:19 INFO - 'sps_profile': False, 16:48:19 INFO - 'sps_profile_interval': 0, 16:48:19 INFO - 'suite': 'dromaeojs', 16:48:19 INFO - 'system_bits': '32', 16:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:48:19 INFO - 'title': 'talos-linux64-ix-011', 16:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:48:19 INFO - 'use_talos_json': True, 16:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:48:19 INFO - 'work_dir': 'build'} 16:48:19 INFO - ##### 16:48:19 INFO - ##### Running clobber step. 16:48:19 INFO - ##### 16:48:19 INFO - Running pre-action listener: _resource_record_pre_action 16:48:19 INFO - Running main action method: clobber 16:48:19 INFO - rmtree: /builds/slave/test/build 16:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:48:20 INFO - Running post-action listener: _resource_record_post_action 16:48:20 INFO - ##### 16:48:20 INFO - ##### Finished clobber step (success) 16:48:20 INFO - ##### 16:48:20 INFO - ##### 16:48:20 INFO - ##### Running read-buildbot-config step. 16:48:20 INFO - ##### 16:48:20 INFO - Running pre-action listener: _resource_record_pre_action 16:48:20 INFO - Running main action method: read_buildbot_config 16:48:20 INFO - Using buildbot properties: 16:48:20 INFO - { 16:48:20 INFO - "project": "", 16:48:20 INFO - "product": "firefox", 16:48:20 INFO - "script_repo_revision": "production", 16:48:20 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 16:48:20 INFO - "repository": "", 16:48:20 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 16:48:20 INFO - "buildid": "20160706153024", 16:48:20 INFO - "pgo_build": "False", 16:48:20 INFO - "basedir": "/builds/slave/test", 16:48:20 INFO - "buildnumber": 68, 16:48:20 INFO - "slavename": "talos-linux64-ix-011", 16:48:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:48:20 INFO - "platform": "ubuntu64_hw", 16:48:20 INFO - "scheduler": "tests-autoland-linux64-talos", 16:48:20 INFO - "branch": "autoland", 16:48:20 INFO - "repo_path": "integration/autoland", 16:48:20 INFO - "revision": "9740c3f2b075012c80e6f6106a6736e682fb918a", 16:48:20 INFO - "stage_platform": "linux64", 16:48:20 INFO - "builduid": "652c7787013a43f09862526a70d03cc3", 16:48:20 INFO - "slavebuilddir": "test" 16:48:20 INFO - } 16:48:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:48:20 INFO - Running post-action listener: _resource_record_post_action 16:48:20 INFO - ##### 16:48:20 INFO - ##### Finished read-buildbot-config step (success) 16:48:20 INFO - ##### 16:48:20 INFO - ##### 16:48:20 INFO - ##### Running download-and-extract step. 16:48:20 INFO - ##### 16:48:20 INFO - Running pre-action listener: _resource_record_pre_action 16:48:20 INFO - Running main action method: download_and_extract 16:48:20 INFO - mkdir: /builds/slave/test/build/tests 16:48:20 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')]} 16:48:20 INFO - https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:27 INFO - Downloaded 1361 bytes. 16:48:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:48:27 INFO - Using the following test package requirements: 16:48:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:48:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:48:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'jsshell-linux-x86_64.zip'], 16:48:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:48:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:48:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:48:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:48:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:48:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:48: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')]} 16:48:27 INFO - https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:48:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:48:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:48:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:38 INFO - Downloaded 22733127 bytes. 16:48:38 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'] 16:48:38 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 16:48:40 INFO - Return code: 0 16:48:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:40 INFO - https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:41 INFO - Downloaded 22733127 bytes. 16:48:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:48:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:48:42 INFO - Return code: 0 16:48: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')]} 16:48:42 INFO - https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:44 INFO - Downloaded 14403333 bytes. 16:48:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:48:44 INFO - Return code: 0 16:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:44 INFO - https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DzDCoTSkTFCAnXJaWZjm7g/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 16:48:46 INFO - Downloaded 56603699 bytes. 16:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:48:46 INFO - mkdir: /builds/slave/test/properties 16:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:48:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:48:46 INFO - Contents: 16:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:48:46 INFO - Running post-action listener: _resource_record_post_action 16:48:46 INFO - Running post-action listener: set_extra_try_arguments 16:48:46 INFO - ##### 16:48:46 INFO - ##### Finished download-and-extract step (success) 16:48:46 INFO - ##### 16:48:46 INFO - ##### 16:48:46 INFO - ##### Running populate-webroot step. 16:48:46 INFO - ##### 16:48:46 INFO - Running pre-action listener: _resource_record_pre_action 16:48:46 INFO - Running main action method: populate_webroot 16:48:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:48:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:48:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:48:46 INFO - '--tppagecycles', 16:48:46 INFO - '7'], 16:48:46 INFO - 'tests': ['tsvgm']}}, 16:48:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:48:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:48:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:48:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:48:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['damp', 'tps']}, 16:48:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'tests': ['damp', 'tps']}, 16:48:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['dromaeo_dom']}, 16:48:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:48:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['basic_compositor_video']}, 16:48:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:48:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['a11yr', 16:48:46 INFO - 'ts_paint', 16:48:46 INFO - 'tpaint', 16:48:46 INFO - 'sessionrestore', 16:48:46 INFO - 'sessionrestore_no_auto_restore', 16:48:46 INFO - 'tabpaint']}, 16:48:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:48:46 INFO - 'ts_paint', 16:48:46 INFO - 'tpaint', 16:48:46 INFO - 'sessionrestore', 16:48:46 INFO - 'sessionrestore_no_auto_restore', 16:48:46 INFO - 'tabpaint']}, 16:48:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:48:46 INFO - 'ts_paint', 16:48:46 INFO - 'tpaint', 16:48:46 INFO - 'sessionrestore', 16:48:46 INFO - 'sessionrestore_no_auto_restore', 16:48:46 INFO - 'tabpaint']}, 16:48:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:48:46 INFO - 'ts_paint', 16:48:46 INFO - 'tpaint', 16:48:46 INFO - 'sessionrestore', 16:48:46 INFO - 'sessionrestore_no_auto_restore', 16:48:46 INFO - 'tabpaint']}, 16:48:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['a11yr', 16:48:46 INFO - 'ts_paint', 16:48:46 INFO - 'tpaint', 16:48:46 INFO - 'sessionrestore', 16:48:46 INFO - 'sessionrestore_no_auto_restore', 16:48:46 INFO - 'tabpaint']}, 16:48:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['a11yr', 16:48:46 INFO - 'ts_paint', 16:48:46 INFO - 'tpaint', 16:48:46 INFO - 'sessionrestore', 16:48:46 INFO - 'sessionrestore_no_auto_restore', 16:48:46 INFO - 'tabpaint']}, 16:48:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['tsvgx', 16:48:46 INFO - 'tsvgr_opacity', 16:48:46 INFO - 'tart', 16:48:46 INFO - 'tscrollx', 16:48:46 INFO - 'cart']}, 16:48:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:48:46 INFO - 'tsvgr_opacity', 16:48:46 INFO - 'tart', 16:48:46 INFO - 'tscrollx', 16:48:46 INFO - 'cart']}, 16:48:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'talos_options': ['--disable-e10s'], 16:48:46 INFO - 'tests': ['tp5o']}, 16:48:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'tests': ['tp5o']}, 16:48:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'talos_options': ['--disable-e10s', 16:48:46 INFO - '--xperf_path', 16:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:46 INFO - 'tests': ['tp5n']}, 16:48:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:46 INFO - 'talos_options': ['--xperf_path', 16:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:46 INFO - 'tests': ['tp5n']}}, 16:48:46 INFO - 'talos.zip': {'path': '', 16:48:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:48:46 INFO - Running post-action listener: _resource_record_post_action 16:48:46 INFO - ##### 16:48:46 INFO - ##### Finished populate-webroot step (success) 16:48:46 INFO - ##### 16:48:46 INFO - ##### 16:48:46 INFO - ##### Running create-virtualenv step. 16:48:46 INFO - ##### 16:48:46 INFO - Running pre-action listener: _resource_record_pre_action 16:48:46 INFO - Running main action method: create_virtualenv 16:48:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:48:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:48:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:48:46 INFO - Using real prefix '/usr' 16:48:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:48:49 INFO - Installing pip.................done. 16:48:49 INFO - Return code: 0 16:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:48:49 INFO - Using env: {'DISPLAY': ':0', 16:48:49 INFO - 'HOME': '/home/cltbld', 16:48:49 INFO - 'LANG': 'en_US.UTF-8', 16:48:49 INFO - 'LANGUAGE': 'en_US:en', 16:48:49 INFO - 'LOGNAME': 'cltbld', 16:48:49 INFO - 'MAIL': '/var/mail/cltbld', 16:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:49 INFO - 'MOZ_NO_REMOTE': '1', 16:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:49 INFO - 'NO_EM_RESTART': '1', 16:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:49 INFO - 'PWD': '/builds/slave/test', 16:48:49 INFO - 'SHELL': '/bin/bash', 16:48:49 INFO - 'SHLVL': '1', 16:48:49 INFO - 'TERM': 'linux', 16:48:49 INFO - 'TMOUT': '86400', 16:48:49 INFO - 'USER': 'cltbld', 16:48:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:49 INFO - '_': '/tools/buildbot/bin/python'} 16:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:48:49 INFO - Cleaning up... 16:48:49 INFO - Return code: 0 16:48:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:48:49 INFO - Using env: {'DISPLAY': ':0', 16:48:49 INFO - 'HOME': '/home/cltbld', 16:48:49 INFO - 'LANG': 'en_US.UTF-8', 16:48:49 INFO - 'LANGUAGE': 'en_US:en', 16:48:49 INFO - 'LOGNAME': 'cltbld', 16:48:49 INFO - 'MAIL': '/var/mail/cltbld', 16:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:49 INFO - 'MOZ_NO_REMOTE': '1', 16:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:49 INFO - 'NO_EM_RESTART': '1', 16:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:49 INFO - 'PWD': '/builds/slave/test', 16:48:49 INFO - 'SHELL': '/bin/bash', 16:48:49 INFO - 'SHLVL': '1', 16:48:49 INFO - 'TERM': 'linux', 16:48:49 INFO - 'TMOUT': '86400', 16:48:49 INFO - 'USER': 'cltbld', 16:48:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:49 INFO - '_': '/tools/buildbot/bin/python'} 16:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:49 INFO - Downloading/unpacking psutil>=3.1.1 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:51 INFO - Installing collected packages: psutil 16:48:51 INFO - Running setup.py install for psutil 16:48:51 INFO - building 'psutil._psutil_linux' extension 16:48:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:48:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:48:52 INFO - building 'psutil._psutil_posix' extension 16:48:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:48:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:52 INFO - Successfully installed psutil 16:48:52 INFO - Cleaning up... 16:48:52 INFO - Return code: 0 16:48:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:48:52 INFO - Using env: {'DISPLAY': ':0', 16:48:52 INFO - 'HOME': '/home/cltbld', 16:48:52 INFO - 'LANG': 'en_US.UTF-8', 16:48:52 INFO - 'LANGUAGE': 'en_US:en', 16:48:52 INFO - 'LOGNAME': 'cltbld', 16:48:52 INFO - 'MAIL': '/var/mail/cltbld', 16:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:52 INFO - 'MOZ_NO_REMOTE': '1', 16:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:52 INFO - 'NO_EM_RESTART': '1', 16:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:52 INFO - 'PWD': '/builds/slave/test', 16:48:52 INFO - 'SHELL': '/bin/bash', 16:48:52 INFO - 'SHLVL': '1', 16:48:52 INFO - 'TERM': 'linux', 16:48:52 INFO - 'TMOUT': '86400', 16:48:52 INFO - 'USER': 'cltbld', 16:48:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:52 INFO - '_': '/tools/buildbot/bin/python'} 16:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:48:54 INFO - Installing collected packages: mozsystemmonitor 16:48:54 INFO - Running setup.py install for mozsystemmonitor 16:48:54 INFO - Successfully installed mozsystemmonitor 16:48:54 INFO - Cleaning up... 16:48:54 INFO - Return code: 0 16:48:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:48:54 INFO - Using env: {'DISPLAY': ':0', 16:48:54 INFO - 'HOME': '/home/cltbld', 16:48:54 INFO - 'LANG': 'en_US.UTF-8', 16:48:54 INFO - 'LANGUAGE': 'en_US:en', 16:48:54 INFO - 'LOGNAME': 'cltbld', 16:48:54 INFO - 'MAIL': '/var/mail/cltbld', 16:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:54 INFO - 'MOZ_NO_REMOTE': '1', 16:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:54 INFO - 'NO_EM_RESTART': '1', 16:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:54 INFO - 'PWD': '/builds/slave/test', 16:48:54 INFO - 'SHELL': '/bin/bash', 16:48:54 INFO - 'SHLVL': '1', 16:48:54 INFO - 'TERM': 'linux', 16:48:54 INFO - 'TMOUT': '86400', 16:48:54 INFO - 'USER': 'cltbld', 16:48:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:54 INFO - '_': '/tools/buildbot/bin/python'} 16:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:48:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:48:57 INFO - warning: no files found matching '*.txt' 16:48:57 INFO - no previously-included directories found matching 'build' 16:48:57 INFO - no previously-included directories found matching 'dist' 16:48:57 INFO - no previously-included directories found matching '.git*' 16:48:57 INFO - Installing collected packages: jsonschema, functools32 16:48:57 INFO - Running setup.py install for functools32 16:48:57 INFO - warning: no files found matching '*.txt' 16:48:57 INFO - no previously-included directories found matching 'build' 16:48:57 INFO - no previously-included directories found matching 'dist' 16:48:57 INFO - no previously-included directories found matching '.git*' 16:48:57 INFO - Successfully installed jsonschema functools32 16:48:57 INFO - Cleaning up... 16:48:57 INFO - Return code: 0 16:48:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:48:57 INFO - Using env: {'DISPLAY': ':0', 16:48:57 INFO - 'HOME': '/home/cltbld', 16:48:57 INFO - 'LANG': 'en_US.UTF-8', 16:48:57 INFO - 'LANGUAGE': 'en_US:en', 16:48:57 INFO - 'LOGNAME': 'cltbld', 16:48:57 INFO - 'MAIL': '/var/mail/cltbld', 16:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:57 INFO - 'MOZ_NO_REMOTE': '1', 16:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:57 INFO - 'NO_EM_RESTART': '1', 16:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:57 INFO - 'PWD': '/builds/slave/test', 16:48:57 INFO - 'SHELL': '/bin/bash', 16:48:57 INFO - 'SHLVL': '1', 16:48:57 INFO - 'TERM': 'linux', 16:48:57 INFO - 'TMOUT': '86400', 16:48:57 INFO - 'USER': 'cltbld', 16:48:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:57 INFO - '_': '/tools/buildbot/bin/python'} 16:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:48:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:48:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:00 INFO - Downloading docopt-0.6.1.tar.gz 16:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:00 INFO - Running setup.py install for blobuploader 16:49:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:49:00 INFO - Running setup.py install for requests 16:49:00 INFO - Running setup.py install for docopt 16:49:00 INFO - Successfully installed blobuploader requests docopt 16:49:00 INFO - Cleaning up... 16:49:00 INFO - Return code: 0 16:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:49:00 INFO - Using env: {'DISPLAY': ':0', 16:49:00 INFO - 'HOME': '/home/cltbld', 16:49:00 INFO - 'LANG': 'en_US.UTF-8', 16:49:00 INFO - 'LANGUAGE': 'en_US:en', 16:49:00 INFO - 'LOGNAME': 'cltbld', 16:49:00 INFO - 'MAIL': '/var/mail/cltbld', 16:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:00 INFO - 'MOZ_NO_REMOTE': '1', 16:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:00 INFO - 'NO_EM_RESTART': '1', 16:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:00 INFO - 'PWD': '/builds/slave/test', 16:49:00 INFO - 'SHELL': '/bin/bash', 16:49:00 INFO - 'SHLVL': '1', 16:49:00 INFO - 'TERM': 'linux', 16:49:00 INFO - 'TMOUT': '86400', 16:49:00 INFO - 'USER': 'cltbld', 16:49:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:00 INFO - '_': '/tools/buildbot/bin/python'} 16:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:00 INFO - Running setup.py (path:/tmp/pip-On6jgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:01 INFO - Running setup.py (path:/tmp/pip-0rv37S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:01 INFO - Running setup.py (path:/tmp/pip-i_7CRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:01 INFO - Running setup.py (path:/tmp/pip-Zl2Ru_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:01 INFO - Running setup.py (path:/tmp/pip-ApkC7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:01 INFO - Running setup.py (path:/tmp/pip-NU4EZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:01 INFO - Running setup.py (path:/tmp/pip-K3_HeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:01 INFO - Running setup.py (path:/tmp/pip-uE1T05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:01 INFO - Running setup.py (path:/tmp/pip-Cx4GnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:01 INFO - Running setup.py (path:/tmp/pip-D4Rb2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:01 INFO - Running setup.py (path:/tmp/pip-I1213o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:01 INFO - Running setup.py (path:/tmp/pip-WXKNDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:01 INFO - Running setup.py (path:/tmp/pip-FGT2wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:01 INFO - Running setup.py (path:/tmp/pip-C9XAAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:01 INFO - Running setup.py (path:/tmp/pip-sS1afF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:02 INFO - Running setup.py (path:/tmp/pip-AMoKeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:02 INFO - Running setup.py (path:/tmp/pip-M_tJbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:02 INFO - Running setup.py install for manifestparser 16:49:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:49:02 INFO - Running setup.py install for mozcrash 16:49:02 INFO - Running setup.py install for mozdebug 16:49:02 INFO - Running setup.py install for mozdevice 16:49:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:49:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:49:02 INFO - Running setup.py install for mozfile 16:49:02 INFO - Running setup.py install for mozhttpd 16:49:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:49:02 INFO - Running setup.py install for mozinfo 16:49:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:49:02 INFO - Running setup.py install for mozInstall 16:49:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Running setup.py install for mozleak 16:49:03 INFO - Running setup.py install for mozlog 16:49:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Running setup.py install for moznetwork 16:49:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Running setup.py install for mozprocess 16:49:03 INFO - Running setup.py install for mozprofile 16:49:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Running setup.py install for mozrunner 16:49:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Running setup.py install for mozscreenshot 16:49:03 INFO - Running setup.py install for moztest 16:49:03 INFO - Running setup.py install for mozversion 16:49:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:49:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:03 INFO - Cleaning up... 16:49:03 INFO - Return code: 0 16:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49: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')]} 16:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49: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')]} 16:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:49:04 INFO - Using env: {'DISPLAY': ':0', 16:49:04 INFO - 'HOME': '/home/cltbld', 16:49:04 INFO - 'LANG': 'en_US.UTF-8', 16:49:04 INFO - 'LANGUAGE': 'en_US:en', 16:49:04 INFO - 'LOGNAME': 'cltbld', 16:49:04 INFO - 'MAIL': '/var/mail/cltbld', 16:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:04 INFO - 'MOZ_NO_REMOTE': '1', 16:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:04 INFO - 'NO_EM_RESTART': '1', 16:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:04 INFO - 'PWD': '/builds/slave/test', 16:49:04 INFO - 'SHELL': '/bin/bash', 16:49:04 INFO - 'SHLVL': '1', 16:49:04 INFO - 'TERM': 'linux', 16:49:04 INFO - 'TMOUT': '86400', 16:49:04 INFO - 'USER': 'cltbld', 16:49:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:04 INFO - '_': '/tools/buildbot/bin/python'} 16:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:04 INFO - Running setup.py (path:/tmp/pip-ovxr67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:04 INFO - Running setup.py (path:/tmp/pip-UajgWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:04 INFO - Running setup.py (path:/tmp/pip-qJYE8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:04 INFO - Running setup.py (path:/tmp/pip-u06yfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:04 INFO - Running setup.py (path:/tmp/pip-a45lSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:04 INFO - Running setup.py (path:/tmp/pip-hZLR3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:04 INFO - Running setup.py (path:/tmp/pip-zfRRrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:04 INFO - Running setup.py (path:/tmp/pip-MMkHPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:04 INFO - Running setup.py (path:/tmp/pip-UmjNLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:04 INFO - Running setup.py (path:/tmp/pip-zD_gWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:04 INFO - Running setup.py (path:/tmp/pip-x5Gi84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:04 INFO - Running setup.py (path:/tmp/pip-d9yVL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:05 INFO - Running setup.py (path:/tmp/pip-5qjxHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:05 INFO - Running setup.py (path:/tmp/pip-HTVkI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:05 INFO - Running setup.py (path:/tmp/pip-ZwKEsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:05 INFO - Running setup.py (path:/tmp/pip-Ds2j9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:49:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:05 INFO - Running setup.py (path:/tmp/pip-ORAyTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:07 INFO - Downloading blessings-1.6.tar.gz 16:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:07 INFO - Installing collected packages: blessings 16:49:07 INFO - Running setup.py install for blessings 16:49:07 INFO - Successfully installed blessings 16:49:07 INFO - Cleaning up... 16:49:07 INFO - Return code: 0 16:49:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:49:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:07 INFO - Reading from file tmpfile_stdout 16:49:07 INFO - Current package versions: 16:49:07 INFO - argparse == 1.2.1 16:49:07 INFO - blessings == 1.6 16:49:07 INFO - blobuploader == 1.2.4 16:49:07 INFO - docopt == 0.6.1 16:49:07 INFO - functools32 == 3.2.3-2 16:49:07 INFO - jsonschema == 2.5.1 16:49:07 INFO - manifestparser == 1.1 16:49:07 INFO - mozInstall == 1.12 16:49:07 INFO - mozcrash == 0.17 16:49:07 INFO - mozdebug == 0.1 16:49:07 INFO - mozdevice == 0.48 16:49:07 INFO - mozfile == 1.2 16:49:07 INFO - mozhttpd == 0.7 16:49:07 INFO - mozinfo == 0.9 16:49:07 INFO - mozleak == 0.1 16:49:07 INFO - mozlog == 3.2 16:49:07 INFO - moznetwork == 0.27 16:49:07 INFO - mozprocess == 0.23 16:49:07 INFO - mozprofile == 0.28 16:49:07 INFO - mozrunner == 6.12 16:49:07 INFO - mozscreenshot == 0.1 16:49:07 INFO - mozsystemmonitor == 0.3 16:49:07 INFO - moztest == 0.7 16:49:07 INFO - mozversion == 1.4 16:49:07 INFO - psutil == 3.1.1 16:49:07 INFO - requests == 1.2.3 16:49:07 INFO - wsgiref == 0.1.2 16:49:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:49:07 INFO - Using env: {'DISPLAY': ':0', 16:49:07 INFO - 'HOME': '/home/cltbld', 16:49:07 INFO - 'LANG': 'en_US.UTF-8', 16:49:07 INFO - 'LANGUAGE': 'en_US:en', 16:49:07 INFO - 'LOGNAME': 'cltbld', 16:49:07 INFO - 'MAIL': '/var/mail/cltbld', 16:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:07 INFO - 'MOZ_NO_REMOTE': '1', 16:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:07 INFO - 'NO_EM_RESTART': '1', 16:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:07 INFO - 'PWD': '/builds/slave/test', 16:49:07 INFO - 'SHELL': '/bin/bash', 16:49:07 INFO - 'SHLVL': '1', 16:49:07 INFO - 'TERM': 'linux', 16:49:07 INFO - 'TMOUT': '86400', 16:49:07 INFO - 'USER': 'cltbld', 16:49:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:07 INFO - '_': '/tools/buildbot/bin/python'} 16:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:49:08 INFO - Cleaning up... 16:49:08 INFO - Return code: 0 16:49:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', '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 16:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:49:08 INFO - Using env: {'DISPLAY': ':0', 16:49:08 INFO - 'HOME': '/home/cltbld', 16:49:08 INFO - 'LANG': 'en_US.UTF-8', 16:49:08 INFO - 'LANGUAGE': 'en_US:en', 16:49:08 INFO - 'LOGNAME': 'cltbld', 16:49:08 INFO - 'MAIL': '/var/mail/cltbld', 16:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:08 INFO - 'MOZ_NO_REMOTE': '1', 16:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:08 INFO - 'NO_EM_RESTART': '1', 16:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:08 INFO - 'PWD': '/builds/slave/test', 16:49:08 INFO - 'SHELL': '/bin/bash', 16:49:08 INFO - 'SHLVL': '1', 16:49:08 INFO - 'TERM': 'linux', 16:49:08 INFO - 'TMOUT': '86400', 16:49:08 INFO - 'USER': 'cltbld', 16:49:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:08 INFO - '_': '/tools/buildbot/bin/python'} 16:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:49:08 INFO - Cleaning up... 16:49:08 INFO - Return code: 0 16:49:08 INFO - Running post-action listener: _resource_record_post_action 16:49:08 INFO - Running post-action listener: _start_resource_monitoring 16:49:08 INFO - Starting resource monitoring. 16:49:08 INFO - ##### 16:49:08 INFO - ##### Finished create-virtualenv step (success) 16:49:08 INFO - ##### 16:49:08 INFO - ##### 16:49:08 INFO - ##### Running install step. 16:49:08 INFO - ##### 16:49:08 INFO - Running pre-action listener: _resource_record_pre_action 16:49:08 INFO - Running main action method: install 16:49:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:08 INFO - Reading from file tmpfile_stdout 16:49:08 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:49:08 INFO - Reading from file tmpfile_stdout 16:49:08 INFO - Output received: 16:49:08 INFO - Usage: mozinstall [options] installer 16:49:08 INFO - Options: 16:49:08 INFO - -h, --help show this help message and exit 16:49:08 INFO - -d DEST, --destination=DEST 16:49:08 INFO - Directory to install application into. [default: 16:49:08 INFO - "/builds/slave/test"] 16:49:08 INFO - --app=APP Application being installed. [default: firefox] 16:49:08 INFO - mkdir: /builds/slave/test/build/application 16:49:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:49:24 INFO - Reading from file tmpfile_stdout 16:49:24 INFO - Output received: 16:49:24 INFO - /builds/slave/test/build/application/firefox/firefox 16:49:24 INFO - Running post-action listener: _resource_record_post_action 16:49:24 INFO - ##### 16:49:24 INFO - ##### Finished install step (success) 16:49:24 INFO - ##### 16:49:24 INFO - ##### 16:49:24 INFO - ##### Running run-tests step. 16:49:24 INFO - ##### 16:49:24 INFO - Running pre-action listener: _resource_record_pre_action 16:49:24 INFO - Running main action method: run_tests 16:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:49:24 INFO - Python 2.7.3 16:49:24 INFO - Return code: 0 16:49:24 INFO - grabbing minidump binary from tooltool 16:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a613b0>, '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 0x2a622b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:49:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:49:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:49:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:49:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:49:24 INFO - Return code: 0 16:49:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:49:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:49:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:49:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:49:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:49:24 INFO - Using env: {'DISPLAY': ':0', 16:49:24 INFO - 'HOME': '/home/cltbld', 16:49:24 INFO - 'LANG': 'en_US.UTF-8', 16:49:24 INFO - 'LANGUAGE': 'en_US:en', 16:49:24 INFO - 'LOGNAME': 'cltbld', 16:49:24 INFO - 'MAIL': '/var/mail/cltbld', 16:49:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:49:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:24 INFO - 'MOZ_NO_REMOTE': '1', 16:49:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:24 INFO - 'NO_EM_RESTART': '1', 16:49:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:24 INFO - 'PWD': '/builds/slave/test', 16:49:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:49:24 INFO - 'SHELL': '/bin/bash', 16:49:24 INFO - 'SHLVL': '1', 16:49:24 INFO - 'TERM': 'linux', 16:49:24 INFO - 'TMOUT': '86400', 16:49:24 INFO - 'USER': 'cltbld', 16:49:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401', 16:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:24 INFO - '_': '/tools/buildbot/bin/python'} 16:49:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:49:25 INFO - mozversion application_buildid: 20160706153024 16:49:25 INFO - mozversion application_changeset: 9740c3f2b075012c80e6f6106a6736e682fb918a 16:49:25 INFO - mozversion application_display_name: Nightly 16:49:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:49:25 INFO - mozversion application_name: Firefox 16:49:25 INFO - mozversion application_remotingname: firefox 16:49:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:49:25 INFO - mozversion application_vendor: Mozilla 16:49:25 INFO - mozversion application_version: 50.0a1 16:49:25 INFO - mozversion platform_buildid: 20160706153024 16:49:25 INFO - mozversion platform_changeset: 9740c3f2b075012c80e6f6106a6736e682fb918a 16:49:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:49:25 INFO - mozversion platform_version: 50.0a1 16:49:25 INFO - using testdate: 1467848965 16:49:25 INFO - actual date: 1467848965 16:49:25 INFO - starting webserver on 'localhost:47910' 16:49:25 INFO - SUITE-START | Running 2 tests 16:49:25 INFO - TEST-START | dromaeo_css 16:49:25 INFO - operating with platform_type : linux_ 16:49:25 INFO - Initialising browser for dromaeo_css test... 16:49:25 INFO - TEST-INFO | started process 16838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph3MS11/profile http://localhost:47910/getInfo.html) 16:49:30 INFO - PROCESS | 16838 | __metrics Screen width/height:1600/1200 16:49:30 INFO - PROCESS | 16838 | colorDepth:24 16:49:30 INFO - PROCESS | 16838 | Browser inner width/height: 1024/697 16:49:30 INFO - PROCESS | 16838 | __metrics 16:49:31 INFO - PROCESS | 16838 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:49:32 INFO - TEST-INFO | 16838: exit 0 16:49:32 INFO - Browser initialized. 16:49:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:49:32 INFO - TEST-INFO | started process 16921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph3MS11/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:44 INFO - PROCESS | 16921 | RSS: Main: 159318016 16:49:44 INFO - PROCESS | 16921 | 16:50:35 INFO - PROCESS | 16921 | 1467849035179 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] 16:52:48 INFO - PROCESS | 16921 | Cycle 1(1): loaded http://localhost:47910/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47910/tests/dromaeo/cssquery-ext.html) 16:52:49 INFO - PROCESS | 16921 | RSS: Main: 272769024 16:52:49 INFO - PROCESS | 16921 | 16:55:52 INFO - PROCESS | 16921 | Cycle 1(1): loaded http://localhost:47910/tests/dromaeo/cssquery-ext.html (next: http://localhost:47910/tests/dromaeo/cssquery-jquery.html) 16:55:52 INFO - PROCESS | 16921 | RSS: Main: 246411264 16:55:52 INFO - PROCESS | 16921 | 16:58:55 INFO - PROCESS | 16921 | Cycle 1(1): loaded http://localhost:47910/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47910/tests/dromaeo/cssquery-mootools.html) 16:58:55 INFO - PROCESS | 16921 | RSS: Main: 244215808 16:58:55 INFO - PROCESS | 16921 | 17:01:57 INFO - PROCESS | 16921 | Cycle 1(1): loaded http://localhost:47910/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47910/tests/dromaeo/cssquery-prototype.html) 17:01:58 INFO - PROCESS | 16921 | RSS: Main: 245497856 17:01:58 INFO - PROCESS | 16921 | 17:05:01 INFO - PROCESS | 16921 | Cycle 1(1): loaded http://localhost:47910/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47910/tests/dromaeo/cssquery-yui.html) 17:05:02 INFO - PROCESS | 16921 | RSS: Main: 214228992 17:05:02 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | Cycle 1(1): loaded http://localhost:47910/tests/dromaeo/cssquery-yui.html (next: http://localhost:47910/tests/dromaeo/cssquery-dojo.html) 17:08:05 INFO - PROCESS | 16921 | RSS: Main: 279998464 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | __start_tp_report 17:08:05 INFO - PROCESS | 16921 | _x_x_mozilla_page_load 17:08:05 INFO - PROCESS | 16921 | _x_x_mozilla_page_load_details 17:08:05 INFO - PROCESS | 16921 | |i|pagename|runs| 17:08:05 INFO - PROCESS | 16921 | |0;dojo.html;2663.60045993101;2671.839689618622;2705.472432875589;2721.4285000149966;2724.6866610339816;4778.904421911559;4804.951950480494;4861.319415281863;4952.009598080384;4961.454240033598;4788.3535722677425;4797.160496913044;4836.105320515699;4915.70505769654;4934.555889969902;4443;4456.086502267044;4538.092381523692;4584.266517357223;4632.5135860734645;4557.498675145731;4558.863234102965;4597.954020459802;4603.976980115095;4623;4365.519792822787;4393.406890069831;4484.170428470743;4504.6396288296855;4525.864224073283;4426.424564806587;4441.689081764278;4445.53321901199;4485.237509623372;4499.302608095751;4485.46174459067;4495.820167193308;4511.864644060651;4535.909281814378;4539.273716205391;4718.221493453576;4755.881102972418;4839.806407743686;4878.536539028786;4928.975355123202;5224.373075230997;5280.762365693553;5314.813981510667;5335.146376579767;5336.30628018359;5265.763040663141;5338.306020217386;5352.91970620441;5358.062339090682;5360.812371567015;4796.112719146969;4812.975935120302;4828.710277383298;4922.507749225048;4969.552740253358;5360.383555891122;5410.78356865721;5410.810621628224;5413.621046526705;5418.187271909245;5157.4584668610005;5162.277281180638;5167.379914410295;5167.914737905006;5187.04039752647;5123.615728820353;5246.501582349671;5271.4728527147745;5274.947250527523;5275;5239.947600524022;5276.683398996072;5280.128778751463;5280.3663560373;5280.577553795687;5249.527542521191;5263.736813159327;5271.130263506555;5271.341082364705;5327.493888080626;4326.848560300375;4343.826246950087;4350.151720414552;4415.4259946206785;4418.293073108287;3822.9235415291537;3843.9039024024623;3866.574676785551;3887.8056097195026;3898.8440462381186;4478.081993191388;4483.663725220556;4486.394336764495;4493.303537951622;4542.727436353829;5074.543291103744;5218.086834803894;5232.633715639945;5300.284461597712;5364.8122315718765;4466.776661166994;4505.594496495331;4513.187626227311;4552.681312308173;4556.567126123013;4502.842400515966;4514.25514790056;4515.074409745994;4531.478879928784;4556.2937744649635;4875.3174555562955;4876.658633895593;4911.7298548580175;4983.750812459435;4986.650934434555;5270.288511050959;5287.365516138088;5297.894042119059;5301.5493683037375;5340.786368545215;4925.16272233714;4930.285108659296;4940.258961155711;4961.925571116364;5015.147424937696;4970.726610036482;5042.520960508746;5079.847604571869;5109.693418394908;5136.383633963948;5242.030224408497;5247.816326428557;5259.815906443256;5263.842084737464;5266.183741520071;5105.795768169381;5135.35808023997;5143.974280128576;5148.716820574904;5150.819721309736;4948.678335908298;5043.697378157322;5061.544460998528;5107.029664363759;5117.2068329409;4977.552020318189;5007.599392048554;5024.045431368028;5074.82238121664;5087;4961.355023846877;5103.8468845934685;5117.104506711236;5117.232415137611;5118.641695081308;4925.852224433273;4968.627352948615;4969.900601988013;4994.225894986283;5015.473375295542 17:08:05 INFO - PROCESS | 16921 | |1;ext.html;572.3961220911938;577.6995962099709;590.8463799412154;594.2126682146152;601.425638515218;28112.29719257017;40427.59572404275;41712.374314385306;41779.373309400384;45659.77170114145;41782.791086044526;41945.37081943766;42202.155956880844;42214.155716885645;42371.36442953358;7487.625618719042;7858.057033156015;7991.5604641744685;7994.360451163922;7995;7397.149327827315;7661.195574464685;7661.195574464685;9948.104670579647;10204.74488137795;10402.791944161112;10446.634367797129;10454.059134677878;10464.529096190652;10469.528871200777;10279.383237005766;10326.380417174994;10344.017318354745;10353.482325883675;10361.585536578528;7526.36025937796;9951.303408761389;10317.226208034428;10325.225608079425;10665.893341066645;39738;39756;40153.19693606112;40180.59819401798;40209.39685904714;2549.783268422186;2992.431438026768;3049.085274417688;3051.4049760296753;3057.480228361184;28138.577921331198;29999.400011999856;30322;30402.69597304021;30761;3253.2029652734996;3444.896653100411;3516.771409858351;3551.7158627309755;3624.7100231981376;271650;272844;272914;273184.63407683035;274038;49384.50615493799;55725.72137139289;57459;57767.42232577704;57957.71021144867;59546;59603.40396596065;59749;59851.10223346653;59952.70023649941;14055.43778248879;14245.572632821031;14246.786298205536;14252.073615214978;14253.857461425254;9683.080107389787;10256.17950563968;10317.48412579368;10349.379037257788;10352.948235258775;18156.909215454103;18796.154173062245;18819.71770423445;19224.903875480533;19314.227430902607;7071.964640176869;7115.537490063233;7138.214796372395;7139.750108746272;7198.136223653195;839.6851180807197;894.5750768385095;926.8007378413539;980.7352014955922;987.76293689514;28527.144185674464;29389.853050734608;29421.285722796696;29492.557611635842;29910.40179196404;936.6815282803743;957.3346524165638;982.3467394182932;1042.3329069395593;1063.3779239145033;15380.538583842503;15548.844511554966;15570.24645168355;15630.811686363919;15840.683186336439;396937;397053;401453;402530;403007;50466.495335046915;50686.239706404434;50898.236526452136;50910;50931.23603145956;1051.3008849115406;1113.9443027848413;1179.1392283632824;1185.3539820797687;1236.140882086941;26260;29810.850945745133;29840.25399365033;30067.69932300649;30470.695293047673;42603.7869810649;42744.14511709811;43064.35403469013;43221.351679725456;43224;309136;309595.5202239924;312230;313686;314714;22471.887640561694;24762.25713228606;25393.238202853943;25402.618960715234;26923.057692980652;42373.78813105915;42510;42638;43546.34680479859;43773.562264376946;36030;36723.44914826226;37171.62828371682;37172.44241336436;37367.62632373641;36873;37364;37380;37409.625903741704;37869.24261514809;36007.27985440329;36286.455703165004;36458.45312320264;36672.59928808453;36861.44707829438;30459.69540304657;33375.332493350485;33820.3235935275;33857;33879.830600846835;25187;25243.74756252414;25604.211533859983;25990.35024124412;26229.34426639349 17:08:05 INFO - PROCESS | 16921 | |2;jquery.html;350.81932804605617;375.8477816484324;378.3228021840905;380.72968192583267;389.7096662986076;13084.934575327123;16269.267882945267;17121.400750973702;18632.906835465838;18647.254109835623;17449.651006979886;17519.474415767516;17709.114544272798;17936.641267174648;18158.636827263446;4897.167481528131;5228.451012643655;5239.13554263546;5242.004019236333;5244.187150991584;3676.0809797550614;5144.305518754976;5850.180974663551;6177.7837775677635;6202.472789812871;6188.715399931133;6249.531285153609;6271.404216599416;6282.68586570672;6283.780067697631;6118.969405152968;6279.183706118221;6280.717367718464;6282.026285925666;6282.340354262782;3352.1619595101224;5073.7209453480045;5380.219868119101;5387.515123638891;5488.588355873286;21170.78829211719;21724.456888577755;21777;21787.67318490224;22000.229991950364;1927.4892153579312;2262.615355389571;2376.9049238030457;2470.2465747946867;2533.265353047614;13230.206187628677;13601.659958501017;13641.386137623831;13931.512397066053;14242.857571424256;1749.5303944686525;1781.7950935642436;1798.5503624093976;1826.2147276671026;1858.7118996555555;71153.28846711518;71260.6436967817;72855.27144728538;73062;73371.26628733697;8540.44487108336;9206.355555111079;9634.373765705206;10108.140808031252;10430.947845260725;12108;12810.295433751047;12829.550965716155;13352.732945341233;13406.262655553843;7315.158756742936;7498;7539.660715267716;7545.924540754632;7600.543967361976;7133;7165.92834071663;7249.456290778213;7297.89053164203;7298.671559779823;6237.844053898689;6300.495960323163;6336.556441049082;6352.205974253218;6450.387213214737;1735.1237624999294;1827.259959716317;1827.661882551732;1832.6059897121916;1864.2263460663673;878.499255424402;881.9470831750116;920.3511524375299;925.6945208081318;940.6190492850407;17134.742978855327;17305.480835574952;17601.823981760273;18233.817661823214;18370.265189392543;875.5097145598357;887.3921363865772;890.0387581412059;904.8190361927509;951.7287573041789;9584.952075239578;10112.393256404639;10429.68710938673;10449.373037617766;10830.837537436944;411765;413776;425952;428839.8464061465;429021;86337;89151.10848891558;89497.55251223702;89824.5508772465;90090;954.2985905359556;974.4883935933833;987.782687808681;994.7366844107943;1003.0379999003964;15747;16146.677066458371;16478.83521164821;16541.83458165451;16648.417305394254;36609.45085823662;37281;38426.807865960494;41387.7930610345;43092.35361469518;53672;54173.45826541684;54179.45820541744;54855.725721371135;55248.447515525935;7521.360684341892;7870.567118808521;7915.802104947423;8021.5187088774865;8021.959890200512;11634.243774154653;12406.193597416139;12426.875731242571;12438;12617.747645046864;10820.350778952974;10905.131944305478;10977.17671174681;11042.472970611258;11042.558297668325;9998.300118991601;11038.668839934815;11219.943900280447;11226.66320010401;11469.885301146882;10701.304415212986;10926;10960.890391095987;11096.722581935515;11102.167337449562;7710.768676939477;7788.415868809975;7838.437285539575;7952.085510166405;8088.312493438124;10547.261691681508;10664.946675266574;10730.463476825971;10756.569737210424;10776.892231077589 17:08:05 INFO - PROCESS | 16921 | |3;mootools.html;1264.367816091954;1349.2781361971345;1396.3716327652558;1471.198196982645;1740.1908112727588;6837.213720422147;7761.728339508119;8023.67905283788;8027.799305017363;8324.583770811465;8078.9192108078905;8122.47203931744;8166.959165204181;8174.141715119916;8181.590920453983;2263.9434014149656;2288.9084436622516;2289.1415719105335;2291.9312420627407;2293.094227780026;2211.7898799614013;2235.575240704269;2251.3358559224985;2251.3921241264848;2254.1434254983083;2157.4174972757346;2222.0445208560313;2241.0923575951765;2247.449374903143;2249.640057590786;2187.0814258011515;2200.2299195281685;2209.0390680054065;2210.104907512452;2210.447388152954;2188.4091295350167;2191.2768786300644;2194.3965409512352;2194.967075493869;2196.4728465168246;7774.378049756006;8197.79505512361;8238.670453181925;8241.134680858484;8250.216229458192;4545.11370282795;4715.693479923794;4721.291806229059;4724.787384567669;4728.621710263171;2857.9285517862013;2935.7504612107996;2957.6155099836883;2964.0663191094736;2980.567817666448;905.8097799462121;912.4160537256162;924.3529529329496;928.1461055828654;937.1752857485437;11038.724031899186;11135.721606959809;11139.888601113966;11140.387278699669;11152.609658661908;3996.480457540559;4120.7321524100835;4236.957630423718;4241.151769646083;4275.03811642378;8698.695545655999;8741.650333986569;8754.649814007369;8755.824883502295;8758.518281494451;4691.296305554194;4715.693479923794;4723.716577005391;4725.385699858996;4731.858044258678;3669.174435751988;3857.8649747259274;3951.308521008812;4007.0783719744622;4381.058072514425;3445.8621655133516;3534.1871369584624;3575.0704816747834;3583.6023950659264;3605.837737301828;993.9701808945744;999.8800143982769;1001.9549120289604;1018.1854516386861;1041.4584416103585;727.0148948175253;776.3672606825419;831.7878940870039;837.5728378526995;878.7275944457239;5363.785448582013;5508.394076651565;5528.806491772769;5555.833325000176;5735.684537350402;858.8711693246063;870.8824308718242;885.154677283193;885.9822803544022;932.2728271947891;3547.7161827053774;3670.559532856021;3742.7754334740002;3759.981200094037;3833.750806197644;9500.287478439144;9835.45904975219;9938.552765125587;9953.552090155961;9965.302428830057;9835.262355323379;9848.162906152915;9849.852252216222;9861.063198996084;9875.604975800887;7458.5151965122095;7781.182975787574;7781.8832717509285;7786.961065194638;7790.961045194851;5046.29351890743;5219;5271;5404.054290499225;5406.107992181246;9340.065993400605;9349;9401.059894010545;9422.057794220796;9509.809803804024;9015.639374425213;9371.390859594105;9404.059594040542;9621.470819105016;9665.226781857575;6328.968355158195;6564.146660934048;6565.146530950946;6729.798106056826;6794.72821087151;7628.923710763043;7962.7213047543055;7962.920370796218;7967.4024448167775;7973.521588704696;6942.340477654615;7196.712131514681;7204.9279507204255;7246.5289756165685;7296.379807716191;6914.51598388108;7233.240509746401;7240.746573869889;7341.4860959732305;7345.338919497271;6792.184937807495;6810.31896810315;6831.795046148623;6859.622720750406;6860;4727.220008698664;4800.1119792838435;4848;4858.392700912386;4873.220284754422;4610.561996610317;4618.468876079294;4638.234691275901;4650.441946966385;4753.096911586787 17:08:05 INFO - PROCESS | 16921 | |4;prototype.html;290.09056607535376;299.8905399529171;302.511444017911;306.552433447167;309.6392702501586;5053.2925390445325;5067.113255180348;5068;5077.74611269436;5097.082525145473;4963.280324352967;4999.500049994998;5005.6496045276845;5027.472115427882;5034.1945288753805;3697.5378077740284;3790;3814.694824414054;3857.691384689218;3933.6853051755934;3877.922441551167;3880;3922.293987082324;3929.390944403622;3948.6643635291034;3679.172186258097;3858.8004837242784;3859.2860320840596;3884.3396622574232;3895.844166233347;3578.8210589470423;3737.5141231639986;3779.9055023624355;3782.489363935861;3919.7256192066566;3422.9144271393166;3429.5198672185916;3452.4130897747445;3467.6705712957228;3478.8260586970805;4804.375431193957;4819.156647586658;4828.7102773833685;4851.151048566522;4874.390701162355;4316.935245971313;4467.620252278561;4474.753888536129;4495.842645507391;4495.955040449619;5171.844844654666;5195.818146364897;5244.213367994793;5260.447652996457;5281.155015197588;3780.4707340972286;3783.7135373972706;3784.545854497478;3785;3806.9619303807162;5160.619794034913;5452.591055670801;5465.262189604392;5539.723013849291;5549.750261238254;3845.9038524036564;3871.5547712012917;3874.3800991841736;3904.3752999520507;3906.160175562268;3952.3519242107855;3953.6244056814558;3954.6440820326306;3957.1294315250598;3968.7817170055346;4359.433273674402;4461.464624245112;4479.440069991251;4491.416115904912;4503.301988191835;5230.555402790729;5244.370675518962;5261.289725886956;5261.289725887033;5262.236975638511;1320.973580528384;1342.6039318401095;1342.664333916521;1343.7648411527944;1343.8118663387133;854.3933806996978;881.7002219245359;888.7555922121468;901.8151278987792;905.9954700226457;4155.522114956758;4391.978040109843;4457.64338852891;4567.794449249725;4570.131674981742;5365.3293338332705;5397.73011349431;5418.972905135528;5434.429384914606;5436.266104075979;4564.452265728134;4567.588916997486;4575.062112266977;4592.609628181575;4602.401687780567;2754.118682021774;2831.7876159288135;2841.6590009198617;2875.3386721053857;2883;5001.349824522788;5067.92032413903;5093.796248150033;5097.46476619957;5116.258142569307;5315.422020320141;5494.395616482184;5557.221988921554;5557.916631250535;5585.804496842591;5075.563729409904;5097.974510127426;5102.4897510248675;5117.820876269388;5128.153854613947;5305.389880163831;5345.4654534546235;5348.491893270133;5363.678179309254;5397.3523177218985;4965.205567109245;5226.660267082628;5243.711595862112;5255.423372988164;5261.605379596469;5048.899022019613;5084.567811736044;5121.308623335802;5128.1794912813775;5138.203578445347;3892.1242720387686;3917.6865850732443;3918.2359439910083;3926.3325234710737;3926.6073392660505;5087.64386492942;5396.379416367168;5400.864978375572;5406.4052954175795;5420.455170276452;5194.1429664105;5201.895962080813;5229.869253268699;5230.947690523046;5237.292965449616;5178.6374953752875;5195.480451954774;5244.7902083916215;5267.341582302212;5269.209618557247;4906.681065730716;5130.384353877558;5149.588032957429;5166.070107380708;5207;5039.823606173766;5115.693058416507;5232.790688372423;5253.9211911820585;5268.1834315681135;5098.515641014098;5107.310513080686;5176.9741151294;5189.636725429335;5215.687058776485 17:08:05 INFO - PROCESS | 16921 | |5;yui.html;652.7780554611433;675.7297081167533;684.6542496039506;736.4734215036248;749.2470067582077;13046.412911418985;13256.668583285422;13562;13749.10630808998;13811.1022783519;13363.398647060882;13419.0606657534;13525.120867143629;13539.59381218565;13549.051566390357;626.6052386996186;758.8785794272917;779.1507257089771;795.1650766694976;800.3077338102557;795.0499153511556;795.4670370851514;797.1351084073758;798.0264077825074;798.5248776977689;841.6296829395077;842.7850898021027;843.1105184030845;843.4770442325736;843.4896887383137;641.7433026789275;665.2748504130521;667.3893387550434;668.729164688302;825.1748251748252;584.433099893103;602.9568845896623;605.9515238780887;607.0529973241713;608.2822269721727;13260.602181934557;13318.600441986757;13367.665808354868;13379.130356526795;13396.598102056856;12082.15424920256;12200.206986545845;12274.75450490994;12732.80900786489;13153.60539183826;11554.653360399201;11657.883421165765;11797.646070617895;11857.110716696283;12270.631881043493;4094.4063110849056;4097.323941549641;4170.791460426997;4291.313389857639;4301.161273551658;63365;63479;63497.99999999954;63509.36490635127;63536.68231658858;9516.524173791282;9577.616895324249;9606.903930960741;9717.854232186522;9969.750756231153;17570;17575.209115589572;17591.472255832345;17599.824001760073;17624.471265862045;6743.089682892747;6747.831304217336;6805.081314022643;6811.318868113149;7105.43156547475;3642.25333806569;3737.719671024684;3793.79134147619;3802.4676545283683;3810.5236845394325;2785.902493412721;2869.8995535156587;2873.066253467631;2876.1515352970923;2883.5242185039233;516.8733660253262;525.3774277481197;525.6320575597098;526.3946461569226;531.6305167908343;542;544.5153813106339;546.1534621336991;566.7194738604417;568.9374168841424;7714.382849372037;7757.340626046736;7875.763727088197;7969.561674107979;7974.840503189904;497.6367251906129;512.6411511941656;525.4616343736969;529.1559961860826;547.8958997790407;3767.1147280389087;3775.301569209705;3791.469194312798;3909.706771992112;4040.1313717550865;101097.49451252697;102039.489802552;104124;104417.47791260995;104547.4772626132;89295.55352223327;90235.09764902398;90732.09267907236;91026.54486727524;93439;51469;65460.34539654638;78540.99999999885;78690;78930.60534697404;7743.806404839924;7872.606369681607;7940.0471943367165;8024.277814996678;8150.75547733569;45257.547424525335;45715.25708457503;47628.52371476241;47647.76176119097;47781;64105;70031.64984175046;70973.29026709874;71177.64411177911;72091;9405.717828464883;9528.428294302365;9632.373895696757;9692.224622030362;9711.3202075854;10146;10429.374237545771;10524.736881578021;10885.836712449161;11066.723331916444;9221.953890230507;9527.714168574954;10288.897111028793;10378.169746420117;10407.739806504898;9789.85315220258;10015.098641122335;10373.533191006574;10466.738331541772;10625.309354891908;10076.244281678757;10197.643082492077;10222.783852897188;10229.693109206735;10548.894511054792;8513.106123856905;8537.658493660185;8541.786455338666;8550.529720865412;8713.564321784012;8160.959195203986;8487.490750554987;8506;8564.379874903636;8607.612657430305 17:08:05 INFO - PROCESS | 16921 | __end_tp_report 17:08:05 INFO - PROCESS | 16921 | __start_cc_report 17:08:05 INFO - PROCESS | 16921 | _x_x_mozilla_cycle_collect,1080 17:08:05 INFO - PROCESS | 16921 | __end_cc_report 17:08:05 INFO - PROCESS | 16921 | __startTimestamp1467850085294__endTimestamp 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | ------- Summary: start ------- 17:08:05 INFO - PROCESS | 16921 | Number of tests: 6 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | [#0] dojo.html Cycles:165 Average:4831.96 Median:4961.45 stddev:523.65 (10.6%) stddev-sans-first:496.86 17:08:05 INFO - PROCESS | 16921 | Values: 2663.6 2671.8 2705.5 2721.4 2724.7 4778.9 4805.0 4861.3 4952.0 4961.5 4788.4 4797.2 4836.1 4915.7 4934.6 4443.0 4456.1 4538.1 4584.3 4632.5 4557.5 4558.9 4598.0 4604.0 4623.0 4365.5 4393.4 4484.2 4504.6 4525.9 4426.4 4441.7 4445.5 4485.2 4499.3 4485.5 4495.8 4511.9 4535.9 4539.3 4718.2 4755.9 4839.8 4878.5 4929.0 5224.4 5280.8 5314.8 5335.1 5336.3 5265.8 5338.3 5352.9 5358.1 5360.8 4796.1 4813.0 4828.7 4922.5 4969.6 5360.4 5410.8 5410.8 5413.6 5418.2 5157.5 5162.3 5167.4 5167.9 5187.0 5123.6 5246.5 5271.5 5274.9 5275.0 5239.9 5276.7 5280.1 5280.4 5280.6 5249.5 5263.7 5271.1 5271.3 5327.5 4326.8 4343.8 4350.2 4415.4 4418.3 3822.9 3843.9 3866.6 3887.8 3898.8 4478.1 4483.7 4486.4 4493.3 4542.7 5074.5 5218.1 5232.6 5300.3 5364.8 4466.8 4505.6 4513.2 4552.7 4556.6 4502.8 4514.3 4515.1 4531.5 4556.3 4875.3 4876.7 4911.7 4983.8 4986.7 5270.3 5287.4 5297.9 5301.5 5340.8 4925.2 4930.3 4940.3 4961.9 5015.1 4970.7 5042.5 5079.8 5109.7 5136.4 5242.0 5247.8 5259.8 5263.8 5266.2 5105.8 5135.4 5144.0 5148.7 5150.8 4948.7 5043.7 5061.5 5107.0 5117.2 4977.6 5007.6 5024.0 5074.8 5087.0 4961.4 5103.8 5117.1 5117.2 5118.6 4925.9 4968.6 4969.9 4994.2 5015.5 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | [#1] ext.html Cycles:180 Average:49022.88 Median:36018.64 stddev:87460.01 (242.8%) stddev-sans-first:87629.70 17:08:05 INFO - PROCESS | 16921 | Values: 572.4 577.7 590.8 594.2 601.4 28112.3 40427.6 41712.4 41779.4 45659.8 41782.8 41945.4 42202.2 42214.2 42371.4 7487.6 7858.1 7991.6 7994.4 7995.0 7397.1 7661.2 7661.2 9948.1 10204.7 10402.8 10446.6 10454.1 10464.5 10469.5 10279.4 10326.4 10344.0 10353.5 10361.6 7526.4 9951.3 10317.2 10325.2 10665.9 39738.0 39756.0 40153.2 40180.6 40209.4 2549.8 2992.4 3049.1 3051.4 3057.5 28138.6 29999.4 30322.0 30402.7 30761.0 3253.2 3444.9 3516.8 3551.7 3624.7 271650.0 272844.0 272914.0 273184.6 274038.0 49384.5 55725.7 57459.0 57767.4 57957.7 59546.0 59603.4 59749.0 59851.1 59952.7 14055.4 14245.6 14246.8 14252.1 14253.9 9683.1 10256.2 10317.5 10349.4 10352.9 18156.9 18796.2 18819.7 19224.9 19314.2 7072.0 7115.5 7138.2 7139.8 7198.1 839.7 894.6 926.8 980.7 987.8 28527.1 29389.9 29421.3 29492.6 29910.4 936.7 957.3 982.3 1042.3 1063.4 15380.5 15548.8 15570.2 15630.8 15840.7 396937.0 397053.0 401453.0 402530.0 403007.0 50466.5 50686.2 50898.2 50910.0 50931.2 1051.3 1113.9 1179.1 1185.4 1236.1 26260.0 29810.9 29840.3 30067.7 30470.7 42603.8 42744.1 43064.4 43221.4 43224.0 309136.0 309595.5 312230.0 313686.0 314714.0 22471.9 24762.3 25393.2 25402.6 26923.1 42373.8 42510.0 42638.0 43546.3 43773.6 36030.0 36723.4 37171.6 37172.4 37367.6 36873.0 37364.0 37380.0 37409.6 37869.2 36007.3 36286.5 36458.5 36672.6 36861.4 30459.7 33375.3 33820.3 33857.0 33879.8 25187.0 25243.7 25604.2 25990.4 26229.3 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | [#2] jquery.html Cycles:180 Average:26209.80 Median:206077.35 stddev:69766.60 (33.9%) stddev-sans-first:69935.29 17:08:05 INFO - PROCESS | 16921 | Values: 350.8 375.8 378.3 380.7 389.7 13084.9 16269.3 17121.4 18632.9 18647.3 17449.7 17519.5 17709.1 17936.6 18158.6 4897.2 5228.5 5239.1 5242.0 5244.2 3676.1 5144.3 5850.2 6177.8 6202.5 6188.7 6249.5 6271.4 6282.7 6283.8 6119.0 6279.2 6280.7 6282.0 6282.3 3352.2 5073.7 5380.2 5387.5 5488.6 21170.8 21724.5 21777.0 21787.7 22000.2 1927.5 2262.6 2376.9 2470.2 2533.3 13230.2 13601.7 13641.4 13931.5 14242.9 1749.5 1781.8 1798.6 1826.2 1858.7 71153.3 71260.6 72855.3 73062.0 73371.3 8540.4 9206.4 9634.4 10108.1 10430.9 12108.0 12810.3 12829.6 13352.7 13406.3 7315.2 7498.0 7539.7 7545.9 7600.5 7133.0 7165.9 7249.5 7297.9 7298.7 6237.8 6300.5 6336.6 6352.2 6450.4 1735.1 1827.3 1827.7 1832.6 1864.2 878.5 881.9 920.4 925.7 940.6 17134.7 17305.5 17601.8 18233.8 18370.3 875.5 887.4 890.0 904.8 951.7 9585.0 10112.4 10429.7 10449.4 10830.8 411765.0 413776.0 425952.0 428839.8 429021.0 86337.0 89151.1 89497.6 89824.6 90090.0 954.3 974.5 987.8 994.7 1003.0 15747.0 16146.7 16478.8 16541.8 16648.4 36609.5 37281.0 38426.8 41387.8 43092.4 53672.0 54173.5 54179.5 54855.7 55248.4 7521.4 7870.6 7915.8 8021.5 8022.0 11634.2 12406.2 12426.9 12438.0 12617.7 10820.4 10905.1 10977.2 11042.5 11042.6 9998.3 11038.7 11219.9 11226.7 11469.9 10701.3 10926.0 10960.9 11096.7 11102.2 7710.8 7788.4 7838.4 7952.1 8088.3 10547.3 10664.9 10730.5 10756.6 10776.9 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | [#3] mootools.html Cycles:180 Average:5281.93 Median:5542.32 stddev:3001.56 (54.2%) stddev-sans-first:2994.79 17:08:05 INFO - PROCESS | 16921 | Values: 1264.4 1349.3 1396.4 1471.2 1740.2 6837.2 7761.7 8023.7 8027.8 8324.6 8078.9 8122.5 8167.0 8174.1 8181.6 2263.9 2288.9 2289.1 2291.9 2293.1 2211.8 2235.6 2251.3 2251.4 2254.1 2157.4 2222.0 2241.1 2247.4 2249.6 2187.1 2200.2 2209.0 2210.1 2210.4 2188.4 2191.3 2194.4 2195.0 2196.5 7774.4 8197.8 8238.7 8241.1 8250.2 4545.1 4715.7 4721.3 4724.8 4728.6 2857.9 2935.8 2957.6 2964.1 2980.6 905.8 912.4 924.4 928.1 937.2 11038.7 11135.7 11139.9 11140.4 11152.6 3996.5 4120.7 4237.0 4241.2 4275.0 8698.7 8741.7 8754.6 8755.8 8758.5 4691.3 4715.7 4723.7 4725.4 4731.9 3669.2 3857.9 3951.3 4007.1 4381.1 3445.9 3534.2 3575.1 3583.6 3605.8 994.0 999.9 1002.0 1018.2 1041.5 727.0 776.4 831.8 837.6 878.7 5363.8 5508.4 5528.8 5555.8 5735.7 858.9 870.9 885.2 886.0 932.3 3547.7 3670.6 3742.8 3760.0 3833.8 9500.3 9835.5 9938.6 9953.6 9965.3 9835.3 9848.2 9849.9 9861.1 9875.6 7458.5 7781.2 7781.9 7787.0 7791.0 5046.3 5219.0 5271.0 5404.1 5406.1 9340.1 9349.0 9401.1 9422.1 9509.8 9015.6 9371.4 9404.1 9621.5 9665.2 6329.0 6564.1 6565.1 6729.8 6794.7 7628.9 7962.7 7962.9 7967.4 7973.5 6942.3 7196.7 7204.9 7246.5 7296.4 6914.5 7233.2 7240.7 7341.5 7345.3 6792.2 6810.3 6831.8 6859.6 6860.0 4727.2 4800.1 4848.0 4858.4 4873.2 4610.6 4618.5 4638.2 4650.4 4753.1 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | [#4] prototype.html Cycles:180 Average:4344.84 Median:5016.56 stddev:1261.43 (25.1%) stddev-sans-first:1227.71 17:08:05 INFO - PROCESS | 16921 | Values: 290.1 299.9 302.5 306.6 309.6 5053.3 5067.1 5068.0 5077.7 5097.1 4963.3 4999.5 5005.6 5027.5 5034.2 3697.5 3790.0 3814.7 3857.7 3933.7 3877.9 3880.0 3922.3 3929.4 3948.7 3679.2 3858.8 3859.3 3884.3 3895.8 3578.8 3737.5 3779.9 3782.5 3919.7 3422.9 3429.5 3452.4 3467.7 3478.8 4804.4 4819.2 4828.7 4851.2 4874.4 4316.9 4467.6 4474.8 4495.8 4496.0 5171.8 5195.8 5244.2 5260.4 5281.2 3780.5 3783.7 3784.5 3785.0 3807.0 5160.6 5452.6 5465.3 5539.7 5549.8 3845.9 3871.6 3874.4 3904.4 3906.2 3952.4 3953.6 3954.6 3957.1 3968.8 4359.4 4461.5 4479.4 4491.4 4503.3 5230.6 5244.4 5261.3 5261.3 5262.2 1321.0 1342.6 1342.7 1343.8 1343.8 854.4 881.7 888.8 901.8 906.0 4155.5 4392.0 4457.6 4567.8 4570.1 5365.3 5397.7 5419.0 5434.4 5436.3 4564.5 4567.6 4575.1 4592.6 4602.4 2754.1 2831.8 2841.7 2875.3 2883.0 5001.3 5067.9 5093.8 5097.5 5116.3 5315.4 5494.4 5557.2 5557.9 5585.8 5075.6 5098.0 5102.5 5117.8 5128.2 5305.4 5345.5 5348.5 5363.7 5397.4 4965.2 5226.7 5243.7 5255.4 5261.6 5048.9 5084.6 5121.3 5128.2 5138.2 3892.1 3917.7 3918.2 3926.3 3926.6 5087.6 5396.4 5400.9 5406.4 5420.5 5194.1 5201.9 5229.9 5230.9 5237.3 5178.6 5195.5 5244.8 5267.3 5269.2 4906.7 5130.4 5149.6 5166.1 5207.0 5039.8 5115.7 5232.8 5253.9 5268.2 5098.5 5107.3 5177.0 5189.6 5215.7 17:08:05 INFO - PROCESS | 16921 | 17:08:05 INFO - PROCESS | 16921 | [#5] yui.html Cycles:180 Average:17991.03 Median:557.31 stddev:26742.58 (4798.5%) stddev-sans-first:26785.91 17:08:05 INFO - PROCESS | 16921 | Values: 652.8 675.7 684.7 736.5 749.2 13046.4 13256.7 13562.0 13749.1 13811.1 13363.4 13419.1 13525.1 13539.6 13549.1 626.6 758.9 779.2 795.2 800.3 795.0 795.5 797.1 798.0 798.5 841.6 842.8 843.1 843.5 843.5 641.7 665.3 667.4 668.7 825.2 584.4 603.0 606.0 607.1 608.3 13260.6 13318.6 13367.7 13379.1 13396.6 12082.2 12200.2 12274.8 12732.8 13153.6 11554.7 11657.9 11797.6 11857.1 12270.6 4094.4 4097.3 4170.8 4291.3 4301.2 63365.0 63479.0 63498.0 63509.4 63536.7 9516.5 9577.6 9606.9 9717.9 9969.8 17570.0 17575.2 17591.5 17599.8 17624.5 6743.1 6747.8 6805.1 6811.3 7105.4 3642.3 3737.7 3793.8 3802.5 3810.5 2785.9 2869.9 2873.1 2876.2 2883.5 516.9 525.4 525.6 526.4 531.6 542.0 544.5 546.2 566.7 568.9 7714.4 7757.3 7875.8 7969.6 7974.8 497.6 512.6 525.5 529.2 547.9 3767.1 3775.3 3791.5 3909.7 4040.1 101097.5 102039.5 104124.0 104417.5 104547.5 89295.6 90235.1 90732.1 91026.5 93439.0 51469.0 65460.3 78541.0 78690.0 78930.6 7743.8 7872.6 7940.0 8024.3 8150.8 45257.5 45715.3 47628.5 47647.8 47781.0 64105.0 70031.6 70973.3 71177.6 72091.0 9405.7 9528.4 9632.4 9692.2 9711.3 10146.0 10429.4 10524.7 10885.8 11066.7 9222.0 9527.7 10288.9 10378.2 10407.7 9789.9 10015.1 10373.5 10466.7 10625.3 10076.2 10197.6 10222.8 10229.7 10548.9 8513.1 8537.7 8541.8 8550.5 8713.6 8161.0 8487.5 8506.0 8564.4 8607.6 17:08:05 INFO - PROCESS | 16921 | -------- Summary: end -------- 17:08:05 INFO - PROCESS | 16921 | 17:08:06 INFO - TEST-INFO | 16921: exit 0 17:08:06 INFO - TEST-OK | dromaeo_css | took 1120960ms 17:08:06 INFO - TEST-START | kraken 17:08:06 INFO - operating with platform_type : linux_ 17:08:06 INFO - Initialising browser for kraken test... 17:08:06 INFO - TEST-INFO | started process 17109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptJEqiv/profile http://localhost:47910/getInfo.html) 17:08:11 INFO - PROCESS | 17109 | __metrics Screen width/height:1600/1200 17:08:11 INFO - PROCESS | 17109 | colorDepth:24 17:08:11 INFO - PROCESS | 17109 | Browser inner width/height: 1024/697 17:08:11 INFO - PROCESS | 17109 | __metrics 17:08:12 INFO - PROCESS | 17109 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:13 INFO - PROCESS | 17109 | console.error: PushService: 17:08:13 INFO - PROCESS | 17109 | stateChangeProcessEnqueue: Error transitioning state 17:08:13 INFO - PROCESS | 17109 | UnknownError 17:08:13 INFO - TEST-INFO | 17109: exit 0 17:08:13 INFO - Browser initialized. 17:08:13 INFO - Running cycle 1/1 for kraken test... 17:08:13 INFO - TEST-INFO | started process 17193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptJEqiv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:25 INFO - PROCESS | 17193 | RSS: Main: 158986240 17:08:25 INFO - PROCESS | 17193 | 17:08:28 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47910/tests/kraken/driver.html?testName=audio-beat-detection) 17:08:29 INFO - PROCESS | 17193 | RSS: Main: 216752128 17:08:29 INFO - PROCESS | 17193 | 17:08:31 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47910/tests/kraken/driver.html?testName=audio-dft) 17:08:32 INFO - PROCESS | 17193 | RSS: Main: 204238848 17:08:32 INFO - PROCESS | 17193 | 17:08:35 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47910/tests/kraken/driver.html?testName=audio-fft) 17:08:36 INFO - PROCESS | 17193 | RSS: Main: 271253504 17:08:36 INFO - PROCESS | 17193 | 17:08:38 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47910/tests/kraken/driver.html?testName=audio-oscillator) 17:08:39 INFO - PROCESS | 17193 | RSS: Main: 182693888 17:08:39 INFO - PROCESS | 17193 | 17:08:41 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47910/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:42 INFO - PROCESS | 17193 | RSS: Main: 186286080 17:08:42 INFO - PROCESS | 17193 | 17:08:45 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47910/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:46 INFO - PROCESS | 17193 | RSS: Main: 221593600 17:08:46 INFO - PROCESS | 17193 | 17:08:49 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47910/tests/kraken/driver.html?testName=imaging-desaturate) 17:08:50 INFO - PROCESS | 17193 | RSS: Main: 222720000 17:08:50 INFO - PROCESS | 17193 | 17:08:52 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47910/tests/kraken/driver.html?testName=json-parse-financial) 17:08:53 INFO - PROCESS | 17193 | RSS: Main: 222810112 17:08:53 INFO - PROCESS | 17193 | 17:08:55 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47910/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:08:55 INFO - PROCESS | 17193 | RSS: Main: 209534976 17:08:55 INFO - PROCESS | 17193 | 17:08:57 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:08:58 INFO - PROCESS | 17193 | RSS: Main: 212111360 17:08:58 INFO - PROCESS | 17193 | 17:09:00 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:01 INFO - PROCESS | 17193 | RSS: Main: 214282240 17:09:01 INFO - PROCESS | 17193 | 17:09:03 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:04 INFO - PROCESS | 17193 | RSS: Main: 226250752 17:09:04 INFO - PROCESS | 17193 | 17:09:07 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:08 INFO - PROCESS | 17193 | RSS: Main: 225124352 17:09:08 INFO - PROCESS | 17193 | 17:09:09 INFO - PROCESS | 17193 | Cycle 1(1): loaded http://localhost:47910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47910/tests/kraken/driver.html?testName=ai-astar) 17:09:10 INFO - PROCESS | 17193 | RSS: Main: 267763712 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | __start_tp_report 17:09:10 INFO - PROCESS | 17193 | _x_x_mozilla_page_load 17:09:10 INFO - PROCESS | 17193 | _x_x_mozilla_page_load_details 17:09:10 INFO - PROCESS | 17193 | |i|pagename|runs| 17:09:10 INFO - PROCESS | 17193 | |0;ai-astar;103;113;112;113;113;113;111;111;112;112 17:09:10 INFO - PROCESS | 17193 | |1;audio-beat-detection;149;122;129;179;128;129;147;124;156;122 17:09:10 INFO - PROCESS | 17193 | |2;audio-dft;161;160;161;161;161;161;161;160;162;161 17:09:10 INFO - PROCESS | 17193 | |3;audio-fft;77;79;77;111;77;83;77;76;105;75 17:09:10 INFO - PROCESS | 17193 | |4;audio-oscillator;91;85;121;86;85;85;113;86;86;135 17:09:10 INFO - PROCESS | 17193 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 17:09:10 INFO - PROCESS | 17193 | |6;imaging-darkroom;146;147;147;147;146;146;147;147;146;148 17:09:10 INFO - PROCESS | 17193 | |7;imaging-desaturate;95;96;94;95;95;95;96;95;95;95 17:09:10 INFO - PROCESS | 17193 | |8;json-parse-financial;64;65;63;64;63;65;64;63;63;64 17:09:10 INFO - PROCESS | 17193 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;71;66;64 17:09:10 INFO - PROCESS | 17193 | |10;stanford-crypto-aes;87;80;87;81;78;77;78;79;78;88 17:09:10 INFO - PROCESS | 17193 | |11;stanford-crypto-ccm;131;130;128;137;126;136;136;144;166;130 17:09:10 INFO - PROCESS | 17193 | |12;stanford-crypto-pbkdf2;164;166;162;163;165;165;165;164;163;162 17:09:10 INFO - PROCESS | 17193 | |13;stanford-crypto-sha256-iterative;66;66;66;67;72;66;65;65;71;65 17:09:10 INFO - PROCESS | 17193 | __end_tp_report 17:09:10 INFO - PROCESS | 17193 | __start_cc_report 17:09:10 INFO - PROCESS | 17193 | _x_x_mozilla_cycle_collect,1924 17:09:10 INFO - PROCESS | 17193 | __end_cc_report 17:09:10 INFO - PROCESS | 17193 | __startTimestamp1467850150029__endTimestamp 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | ------- Summary: start ------- 17:09:10 INFO - PROCESS | 17193 | Number of tests: 14 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.02 (2.7%) stddev-sans-first:0.83 17:09:10 INFO - PROCESS | 17193 | Values: 103.0 113.0 112.0 113.0 113.0 113.0 111.0 111.0 112.0 112.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:138.00 stddev:18.78 (13.6%) stddev-sans-first:19.53 17:09:10 INFO - PROCESS | 17193 | Values: 149.0 122.0 129.0 179.0 128.0 129.0 147.0 124.0 156.0 122.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:09:10 INFO - PROCESS | 17193 | Values: 161.0 160.0 161.0 161.0 161.0 161.0 161.0 160.0 162.0 161.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#3] audio-fft Cycles:10 Average:83.70 Median:77.00 stddev:13.06 (17.0%) stddev-sans-first:13.63 17:09:10 INFO - PROCESS | 17193 | Values: 77.0 79.0 77.0 111.0 77.0 83.0 77.0 76.0 105.0 75.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.50 stddev:18.58 (21.7%) stddev-sans-first:19.56 17:09:10 INFO - PROCESS | 17193 | Values: 91.0 85.0 121.0 86.0 85.0 85.0 113.0 86.0 86.0 135.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:09:10 INFO - PROCESS | 17193 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:09:10 INFO - PROCESS | 17193 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 148.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:09:10 INFO - PROCESS | 17193 | Values: 95.0 96.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 17:09:10 INFO - PROCESS | 17193 | Values: 64.0 65.0 63.0 64.0 63.0 65.0 64.0 63.0 63.0 64.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:64.00 stddev:2.21 (3.5%) stddev-sans-first:2.32 17:09:10 INFO - PROCESS | 17193 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 71.0 66.0 64.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:4.32 (5.4%) stddev-sans-first:4.06 17:09:10 INFO - PROCESS | 17193 | Values: 87.0 80.0 87.0 81.0 78.0 77.0 78.0 79.0 78.0 88.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:136.00 stddev:11.66 (8.6%) stddev-sans-first:12.21 17:09:10 INFO - PROCESS | 17193 | Values: 131.0 130.0 128.0 137.0 126.0 136.0 136.0 144.0 166.0 130.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.50 stddev:1.37 (0.8%) stddev-sans-first:1.45 17:09:10 INFO - PROCESS | 17193 | Values: 164.0 166.0 162.0 163.0 165.0 165.0 165.0 164.0 163.0 162.0 17:09:10 INFO - PROCESS | 17193 | 17:09:10 INFO - PROCESS | 17193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:2.51 (3.8%) stddev-sans-first:2.65 17:09:10 INFO - PROCESS | 17193 | Values: 66.0 66.0 66.0 67.0 72.0 66.0 65.0 65.0 71.0 65.0 17:09:10 INFO - PROCESS | 17193 | -------- Summary: end -------- 17:09:10 INFO - PROCESS | 17193 | 17:09:11 INFO - TEST-INFO | 17193: exit 0 17:09:11 INFO - TEST-OK | kraken | took 65122ms 17:09:11 INFO - SUITE-END | took 1186s 17:09:11 INFO - Completed test suite (00:19:46) 17:09:11 INFO - javascript benchmark 17:09:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.60045993101, 2671.839689618622, 2705.472432875589, 2721.4285000149966, 2724.6866610339816, 4778.904421911559, 4804.951950480494, 4861.319415281863, 4952.009598080384, 4961.454240033598, 4788.3535722677425, 4797.160496913044, 4836.105320515699, 4915.70505769654, 4934.555889969902, 4443.0, 4456.086502267044, 4538.092381523692, 4584.266517357223, 4632.5135860734645, 4557.498675145731, 4558.863234102965, 4597.954020459802, 4603.976980115095, 4623.0, 4365.519792822787, 4393.406890069831, 4484.170428470743, 4504.6396288296855, 4525.864224073283, 4426.424564806587, 4441.689081764278, 4445.53321901199, 4485.237509623372, 4499.302608095751, 4485.46174459067, 4495.820167193308, 4511.864644060651, 4535.909281814378, 4539.273716205391, 4718.221493453576, 4755.881102972418, 4839.806407743686, 4878.536539028786, 4928.975355123202, 5224.373075230997, 5280.762365693553, 5314.813981510667, 5335.146376579767, 5336.30628018359, 5265.763040663141, 5338.306020217386, 5352.91970620441, 5358.062339090682, 5360.812371567015, 4796.112719146969, 4812.975935120302, 4828.710277383298, 4922.507749225048, 4969.552740253358, 5360.383555891122, 5410.78356865721, 5410.810621628224, 5413.621046526705, 5418.187271909245, 5157.4584668610005, 5162.277281180638, 5167.379914410295, 5167.914737905006, 5187.04039752647, 5123.615728820353, 5246.501582349671, 5271.4728527147745, 5274.947250527523, 5275.0, 5239.947600524022, 5276.683398996072, 5280.128778751463, 5280.3663560373, 5280.577553795687, 5249.527542521191, 5263.736813159327, 5271.130263506555, 5271.341082364705, 5327.493888080626, 4326.848560300375, 4343.826246950087, 4350.151720414552, 4415.4259946206785, 4418.293073108287, 3822.9235415291537, 3843.9039024024623, 3866.574676785551, 3887.8056097195026, 3898.8440462381186, 4478.081993191388, 4483.663725220556, 4486.394336764495, 4493.303537951622, 4542.727436353829, 5074.543291103744, 5218.086834803894, 5232.633715639945, 5300.284461597712, 5364.8122315718765, 4466.776661166994, 4505.594496495331, 4513.187626227311, 4552.681312308173, 4556.567126123013, 4502.842400515966, 4514.25514790056, 4515.074409745994, 4531.478879928784, 4556.2937744649635, 4875.3174555562955, 4876.658633895593, 4911.7298548580175, 4983.750812459435, 4986.650934434555, 5270.288511050959, 5287.365516138088, 5297.894042119059, 5301.5493683037375, 5340.786368545215, 4925.16272233714, 4930.285108659296, 4940.258961155711, 4961.925571116364, 5015.147424937696, 4970.726610036482, 5042.520960508746, 5079.847604571869, 5109.693418394908, 5136.383633963948, 5242.030224408497, 5247.816326428557, 5259.815906443256, 5263.842084737464, 5266.183741520071, 5105.795768169381, 5135.35808023997, 5143.974280128576, 5148.716820574904, 5150.819721309736, 4948.678335908298, 5043.697378157322, 5061.544460998528, 5107.029664363759, 5117.2068329409, 4977.552020318189, 5007.599392048554, 5024.045431368028, 5074.82238121664, 5087.0, 4961.355023846877, 5103.8468845934685, 5117.104506711236, 5117.232415137611, 5118.641695081308, 4925.852224433273, 4968.627352948615, 4969.900601988013, 4994.225894986283, 5015.473375295542], "value": 4797.502575999515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3961220911938, 577.6995962099709, 590.8463799412154, 594.2126682146152, 601.425638515218, 28112.29719257017, 40427.59572404275, 41712.374314385306, 41779.373309400384, 45659.77170114145, 41782.791086044526, 41945.37081943766, 42202.155956880844, 42214.155716885645, 42371.36442953358, 7487.625618719042, 7858.057033156015, 7991.5604641744685, 7994.360451163922, 7995.0, 7397.149327827315, 7661.195574464685, 7661.195574464685, 9948.104670579647, 10204.74488137795, 10402.791944161112, 10446.634367797129, 10454.059134677878, 10464.529096190652, 10469.528871200777, 10279.383237005766, 10326.380417174994, 10344.017318354745, 10353.482325883675, 10361.585536578528, 7526.36025937796, 9951.303408761389, 10317.226208034428, 10325.225608079425, 10665.893341066645, 39738.0, 39756.0, 40153.19693606112, 40180.59819401798, 40209.39685904714, 2549.783268422186, 2992.431438026768, 3049.085274417688, 3051.4049760296753, 3057.480228361184, 28138.577921331198, 29999.400011999856, 30322.0, 30402.69597304021, 30761.0, 3253.2029652734996, 3444.896653100411, 3516.771409858351, 3551.7158627309755, 3624.7100231981376, 271650.0, 272844.0, 272914.0, 273184.63407683035, 274038.0, 49384.50615493799, 55725.72137139289, 57459.0, 57767.42232577704, 57957.71021144867, 59546.0, 59603.40396596065, 59749.0, 59851.10223346653, 59952.70023649941, 14055.43778248879, 14245.572632821031, 14246.786298205536, 14252.073615214978, 14253.857461425254, 9683.080107389787, 10256.17950563968, 10317.48412579368, 10349.379037257788, 10352.948235258775, 18156.909215454103, 18796.154173062245, 18819.71770423445, 19224.903875480533, 19314.227430902607, 7071.964640176869, 7115.537490063233, 7138.214796372395, 7139.750108746272, 7198.136223653195, 839.6851180807197, 894.5750768385095, 926.8007378413539, 980.7352014955922, 987.76293689514, 28527.144185674464, 29389.853050734608, 29421.285722796696, 29492.557611635842, 29910.40179196404, 936.6815282803743, 957.3346524165638, 982.3467394182932, 1042.3329069395593, 1063.3779239145033, 15380.538583842503, 15548.844511554966, 15570.24645168355, 15630.811686363919, 15840.683186336439, 396937.0, 397053.0, 401453.0, 402530.0, 403007.0, 50466.495335046915, 50686.239706404434, 50898.236526452136, 50910.0, 50931.23603145956, 1051.3008849115406, 1113.9443027848413, 1179.1392283632824, 1185.3539820797687, 1236.140882086941, 26260.0, 29810.850945745133, 29840.25399365033, 30067.69932300649, 30470.695293047673, 42603.7869810649, 42744.14511709811, 43064.35403469013, 43221.351679725456, 43224.0, 309136.0, 309595.5202239924, 312230.0, 313686.0, 314714.0, 22471.887640561694, 24762.25713228606, 25393.238202853943, 25402.618960715234, 26923.057692980652, 42373.78813105915, 42510.0, 42638.0, 43546.34680479859, 43773.562264376946, 36030.0, 36723.44914826226, 37171.62828371682, 37172.44241336436, 37367.62632373641, 36873.0, 37364.0, 37380.0, 37409.625903741704, 37869.24261514809, 36007.27985440329, 36286.455703165004, 36458.45312320264, 36672.59928808453, 36861.44707829438, 30459.69540304657, 33375.332493350485, 33820.3235935275, 33857.0, 33879.830600846835, 25187.0, 25243.74756252414, 25604.211533859983, 25990.35024124412, 26229.34426639349], "value": 18277.984192740758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.81932804605617, 375.8477816484324, 378.3228021840905, 380.72968192583267, 389.7096662986076, 13084.934575327123, 16269.267882945267, 17121.400750973702, 18632.906835465838, 18647.254109835623, 17449.651006979886, 17519.474415767516, 17709.114544272798, 17936.641267174648, 18158.636827263446, 4897.167481528131, 5228.451012643655, 5239.13554263546, 5242.004019236333, 5244.187150991584, 3676.0809797550614, 5144.305518754976, 5850.180974663551, 6177.7837775677635, 6202.472789812871, 6188.715399931133, 6249.531285153609, 6271.404216599416, 6282.68586570672, 6283.780067697631, 6118.969405152968, 6279.183706118221, 6280.717367718464, 6282.026285925666, 6282.340354262782, 3352.1619595101224, 5073.7209453480045, 5380.219868119101, 5387.515123638891, 5488.588355873286, 21170.78829211719, 21724.456888577755, 21777.0, 21787.67318490224, 22000.229991950364, 1927.4892153579312, 2262.615355389571, 2376.9049238030457, 2470.2465747946867, 2533.265353047614, 13230.206187628677, 13601.659958501017, 13641.386137623831, 13931.512397066053, 14242.857571424256, 1749.5303944686525, 1781.7950935642436, 1798.5503624093976, 1826.2147276671026, 1858.7118996555555, 71153.28846711518, 71260.6436967817, 72855.27144728538, 73062.0, 73371.26628733697, 8540.44487108336, 9206.355555111079, 9634.373765705206, 10108.140808031252, 10430.947845260725, 12108.0, 12810.295433751047, 12829.550965716155, 13352.732945341233, 13406.262655553843, 7315.158756742936, 7498.0, 7539.660715267716, 7545.924540754632, 7600.543967361976, 7133.0, 7165.92834071663, 7249.456290778213, 7297.89053164203, 7298.671559779823, 6237.844053898689, 6300.495960323163, 6336.556441049082, 6352.205974253218, 6450.387213214737, 1735.1237624999294, 1827.259959716317, 1827.661882551732, 1832.6059897121916, 1864.2263460663673, 878.499255424402, 881.9470831750116, 920.3511524375299, 925.6945208081318, 940.6190492850407, 17134.742978855327, 17305.480835574952, 17601.823981760273, 18233.817661823214, 18370.265189392543, 875.5097145598357, 887.3921363865772, 890.0387581412059, 904.8190361927509, 951.7287573041789, 9584.952075239578, 10112.393256404639, 10429.68710938673, 10449.373037617766, 10830.837537436944, 411765.0, 413776.0, 425952.0, 428839.8464061465, 429021.0, 86337.0, 89151.10848891558, 89497.55251223702, 89824.5508772465, 90090.0, 954.2985905359556, 974.4883935933833, 987.782687808681, 994.7366844107943, 1003.0379999003964, 15747.0, 16146.677066458371, 16478.83521164821, 16541.83458165451, 16648.417305394254, 36609.45085823662, 37281.0, 38426.807865960494, 41387.7930610345, 43092.35361469518, 53672.0, 54173.45826541684, 54179.45820541744, 54855.725721371135, 55248.447515525935, 7521.360684341892, 7870.567118808521, 7915.802104947423, 8021.5187088774865, 8021.959890200512, 11634.243774154653, 12406.193597416139, 12426.875731242571, 12438.0, 12617.747645046864, 10820.350778952974, 10905.131944305478, 10977.17671174681, 11042.472970611258, 11042.558297668325, 9998.300118991601, 11038.668839934815, 11219.943900280447, 11226.66320010401, 11469.885301146882, 10701.304415212986, 10926.0, 10960.890391095987, 11096.722581935515, 11102.167337449562, 7710.768676939477, 7788.415868809975, 7838.437285539575, 7952.085510166405, 8088.312493438124, 10547.261691681508, 10664.946675266574, 10730.463476825971, 10756.569737210424, 10776.892231077589], "value": 8765.808401844959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.367816091954, 1349.2781361971345, 1396.3716327652558, 1471.198196982645, 1740.1908112727588, 6837.213720422147, 7761.728339508119, 8023.67905283788, 8027.799305017363, 8324.583770811465, 8078.9192108078905, 8122.47203931744, 8166.959165204181, 8174.141715119916, 8181.590920453983, 2263.9434014149656, 2288.9084436622516, 2289.1415719105335, 2291.9312420627407, 2293.094227780026, 2211.7898799614013, 2235.575240704269, 2251.3358559224985, 2251.3921241264848, 2254.1434254983083, 2157.4174972757346, 2222.0445208560313, 2241.0923575951765, 2247.449374903143, 2249.640057590786, 2187.0814258011515, 2200.2299195281685, 2209.0390680054065, 2210.104907512452, 2210.447388152954, 2188.4091295350167, 2191.2768786300644, 2194.3965409512352, 2194.967075493869, 2196.4728465168246, 7774.378049756006, 8197.79505512361, 8238.670453181925, 8241.134680858484, 8250.216229458192, 4545.11370282795, 4715.693479923794, 4721.291806229059, 4724.787384567669, 4728.621710263171, 2857.9285517862013, 2935.7504612107996, 2957.6155099836883, 2964.0663191094736, 2980.567817666448, 905.8097799462121, 912.4160537256162, 924.3529529329496, 928.1461055828654, 937.1752857485437, 11038.724031899186, 11135.721606959809, 11139.888601113966, 11140.387278699669, 11152.609658661908, 3996.480457540559, 4120.7321524100835, 4236.957630423718, 4241.151769646083, 4275.03811642378, 8698.695545655999, 8741.650333986569, 8754.649814007369, 8755.824883502295, 8758.518281494451, 4691.296305554194, 4715.693479923794, 4723.716577005391, 4725.385699858996, 4731.858044258678, 3669.174435751988, 3857.8649747259274, 3951.308521008812, 4007.0783719744622, 4381.058072514425, 3445.8621655133516, 3534.1871369584624, 3575.0704816747834, 3583.6023950659264, 3605.837737301828, 993.9701808945744, 999.8800143982769, 1001.9549120289604, 1018.1854516386861, 1041.4584416103585, 727.0148948175253, 776.3672606825419, 831.7878940870039, 837.5728378526995, 878.7275944457239, 5363.785448582013, 5508.394076651565, 5528.806491772769, 5555.833325000176, 5735.684537350402, 858.8711693246063, 870.8824308718242, 885.154677283193, 885.9822803544022, 932.2728271947891, 3547.7161827053774, 3670.559532856021, 3742.7754334740002, 3759.981200094037, 3833.750806197644, 9500.287478439144, 9835.45904975219, 9938.552765125587, 9953.552090155961, 9965.302428830057, 9835.262355323379, 9848.162906152915, 9849.852252216222, 9861.063198996084, 9875.604975800887, 7458.5151965122095, 7781.182975787574, 7781.8832717509285, 7786.961065194638, 7790.961045194851, 5046.29351890743, 5219.0, 5271.0, 5404.054290499225, 5406.107992181246, 9340.065993400605, 9349.0, 9401.059894010545, 9422.057794220796, 9509.809803804024, 9015.639374425213, 9371.390859594105, 9404.059594040542, 9621.470819105016, 9665.226781857575, 6328.968355158195, 6564.146660934048, 6565.146530950946, 6729.798106056826, 6794.72821087151, 7628.923710763043, 7962.7213047543055, 7962.920370796218, 7967.4024448167775, 7973.521588704696, 6942.340477654615, 7196.712131514681, 7204.9279507204255, 7246.5289756165685, 7296.379807716191, 6914.51598388108, 7233.240509746401, 7240.746573869889, 7341.4860959732305, 7345.338919497271, 6792.184937807495, 6810.31896810315, 6831.795046148623, 6859.622720750406, 6860.0, 4727.220008698664, 4800.1119792838435, 4848.0, 4858.392700912386, 4873.220284754422, 4610.561996610317, 4618.468876079294, 4638.234691275901, 4650.441946966385, 4753.096911586787], "value": 4212.559972442177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.09056607535376, 299.8905399529171, 302.511444017911, 306.552433447167, 309.6392702501586, 5053.2925390445325, 5067.113255180348, 5068.0, 5077.74611269436, 5097.082525145473, 4963.280324352967, 4999.500049994998, 5005.6496045276845, 5027.472115427882, 5034.1945288753805, 3697.5378077740284, 3790.0, 3814.694824414054, 3857.691384689218, 3933.6853051755934, 3877.922441551167, 3880.0, 3922.293987082324, 3929.390944403622, 3948.6643635291034, 3679.172186258097, 3858.8004837242784, 3859.2860320840596, 3884.3396622574232, 3895.844166233347, 3578.8210589470423, 3737.5141231639986, 3779.9055023624355, 3782.489363935861, 3919.7256192066566, 3422.9144271393166, 3429.5198672185916, 3452.4130897747445, 3467.6705712957228, 3478.8260586970805, 4804.375431193957, 4819.156647586658, 4828.7102773833685, 4851.151048566522, 4874.390701162355, 4316.935245971313, 4467.620252278561, 4474.753888536129, 4495.842645507391, 4495.955040449619, 5171.844844654666, 5195.818146364897, 5244.213367994793, 5260.447652996457, 5281.155015197588, 3780.4707340972286, 3783.7135373972706, 3784.545854497478, 3785.0, 3806.9619303807162, 5160.619794034913, 5452.591055670801, 5465.262189604392, 5539.723013849291, 5549.750261238254, 3845.9038524036564, 3871.5547712012917, 3874.3800991841736, 3904.3752999520507, 3906.160175562268, 3952.3519242107855, 3953.6244056814558, 3954.6440820326306, 3957.1294315250598, 3968.7817170055346, 4359.433273674402, 4461.464624245112, 4479.440069991251, 4491.416115904912, 4503.301988191835, 5230.555402790729, 5244.370675518962, 5261.289725886956, 5261.289725887033, 5262.236975638511, 1320.973580528384, 1342.6039318401095, 1342.664333916521, 1343.7648411527944, 1343.8118663387133, 854.3933806996978, 881.7002219245359, 888.7555922121468, 901.8151278987792, 905.9954700226457, 4155.522114956758, 4391.978040109843, 4457.64338852891, 4567.794449249725, 4570.131674981742, 5365.3293338332705, 5397.73011349431, 5418.972905135528, 5434.429384914606, 5436.266104075979, 4564.452265728134, 4567.588916997486, 4575.062112266977, 4592.609628181575, 4602.401687780567, 2754.118682021774, 2831.7876159288135, 2841.6590009198617, 2875.3386721053857, 2883.0, 5001.349824522788, 5067.92032413903, 5093.796248150033, 5097.46476619957, 5116.258142569307, 5315.422020320141, 5494.395616482184, 5557.221988921554, 5557.916631250535, 5585.804496842591, 5075.563729409904, 5097.974510127426, 5102.4897510248675, 5117.820876269388, 5128.153854613947, 5305.389880163831, 5345.4654534546235, 5348.491893270133, 5363.678179309254, 5397.3523177218985, 4965.205567109245, 5226.660267082628, 5243.711595862112, 5255.423372988164, 5261.605379596469, 5048.899022019613, 5084.567811736044, 5121.308623335802, 5128.1794912813775, 5138.203578445347, 3892.1242720387686, 3917.6865850732443, 3918.2359439910083, 3926.3325234710737, 3926.6073392660505, 5087.64386492942, 5396.379416367168, 5400.864978375572, 5406.4052954175795, 5420.455170276452, 5194.1429664105, 5201.895962080813, 5229.869253268699, 5230.947690523046, 5237.292965449616, 5178.6374953752875, 5195.480451954774, 5244.7902083916215, 5267.341582302212, 5269.209618557247, 4906.681065730716, 5130.384353877558, 5149.588032957429, 5166.070107380708, 5207.0, 5039.823606173766, 5115.693058416507, 5232.790688372423, 5253.9211911820585, 5268.1834315681135, 5098.515641014098, 5107.310513080686, 5176.9741151294, 5189.636725429335, 5215.687058776485], "value": 3941.3583686235306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.7780554611433, 675.7297081167533, 684.6542496039506, 736.4734215036248, 749.2470067582077, 13046.412911418985, 13256.668583285422, 13562.0, 13749.10630808998, 13811.1022783519, 13363.398647060882, 13419.0606657534, 13525.120867143629, 13539.59381218565, 13549.051566390357, 626.6052386996186, 758.8785794272917, 779.1507257089771, 795.1650766694976, 800.3077338102557, 795.0499153511556, 795.4670370851514, 797.1351084073758, 798.0264077825074, 798.5248776977689, 841.6296829395077, 842.7850898021027, 843.1105184030845, 843.4770442325736, 843.4896887383137, 641.7433026789275, 665.2748504130521, 667.3893387550434, 668.729164688302, 825.1748251748252, 584.433099893103, 602.9568845896623, 605.9515238780887, 607.0529973241713, 608.2822269721727, 13260.602181934557, 13318.600441986757, 13367.665808354868, 13379.130356526795, 13396.598102056856, 12082.15424920256, 12200.206986545845, 12274.75450490994, 12732.80900786489, 13153.60539183826, 11554.653360399201, 11657.883421165765, 11797.646070617895, 11857.110716696283, 12270.631881043493, 4094.4063110849056, 4097.323941549641, 4170.791460426997, 4291.313389857639, 4301.161273551658, 63365.0, 63479.0, 63497.99999999954, 63509.36490635127, 63536.68231658858, 9516.524173791282, 9577.616895324249, 9606.903930960741, 9717.854232186522, 9969.750756231153, 17570.0, 17575.209115589572, 17591.472255832345, 17599.824001760073, 17624.471265862045, 6743.089682892747, 6747.831304217336, 6805.081314022643, 6811.318868113149, 7105.43156547475, 3642.25333806569, 3737.719671024684, 3793.79134147619, 3802.4676545283683, 3810.5236845394325, 2785.902493412721, 2869.8995535156587, 2873.066253467631, 2876.1515352970923, 2883.5242185039233, 516.8733660253262, 525.3774277481197, 525.6320575597098, 526.3946461569226, 531.6305167908343, 542.0, 544.5153813106339, 546.1534621336991, 566.7194738604417, 568.9374168841424, 7714.382849372037, 7757.340626046736, 7875.763727088197, 7969.561674107979, 7974.840503189904, 497.6367251906129, 512.6411511941656, 525.4616343736969, 529.1559961860826, 547.8958997790407, 3767.1147280389087, 3775.301569209705, 3791.469194312798, 3909.706771992112, 4040.1313717550865, 101097.49451252697, 102039.489802552, 104124.0, 104417.47791260995, 104547.4772626132, 89295.55352223327, 90235.09764902398, 90732.09267907236, 91026.54486727524, 93439.0, 51469.0, 65460.34539654638, 78540.99999999885, 78690.0, 78930.60534697404, 7743.806404839924, 7872.606369681607, 7940.0471943367165, 8024.277814996678, 8150.75547733569, 45257.547424525335, 45715.25708457503, 47628.52371476241, 47647.76176119097, 47781.0, 64105.0, 70031.64984175046, 70973.29026709874, 71177.64411177911, 72091.0, 9405.717828464883, 9528.428294302365, 9632.373895696757, 9692.224622030362, 9711.3202075854, 10146.0, 10429.374237545771, 10524.736881578021, 10885.836712449161, 11066.723331916444, 9221.953890230507, 9527.714168574954, 10288.897111028793, 10378.169746420117, 10407.739806504898, 9789.85315220258, 10015.098641122335, 10373.533191006574, 10466.738331541772, 10625.309354891908, 10076.244281678757, 10197.643082492077, 10222.783852897188, 10229.693109206735, 10548.894511054792, 8513.106123856905, 8537.658493660185, 8541.786455338666, 8550.529720865412, 8713.564321784012, 8160.959195203986, 8487.490750554987, 8506.0, 8564.379874903636, 8607.612657430305], "value": 6406.0387448870215, "unit": "score"}], "name": "dromaeo_css", "value": 6588.113509429859, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 113.0, 113.0, 113.0, 111.0, 111.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 129.0, 179.0, 128.0, 129.0, 147.0, 124.0, 156.0, 122.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 111.0, 77.0, 83.0, 77.0, 76.0, 105.0, 75.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 121.0, 86.0, 85.0, 85.0, 113.0, 86.0, 86.0, 135.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 63.0, 65.0, 64.0, 63.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 71.0, 66.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 87.0, 81.0, 78.0, 77.0, 78.0, 79.0, 78.0, 88.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 128.0, 137.0, 126.0, 136.0, 136.0, 144.0, 166.0, 130.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 162.0, 163.0, 165.0, 165.0, 165.0, 164.0, 163.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 72.0, 66.0, 65.0, 65.0, 71.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1527.6000000000001, "alertThreshold": 2.0}]} 17:09:11 INFO - Return code: 0 17:09:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:09:11 INFO - # TBPL SUCCESS # 17:09:11 INFO - Running post-action listener: _resource_record_post_action 17:09:11 INFO - ##### 17:09:11 INFO - ##### Finished run-tests step (success) 17:09:11 INFO - ##### 17:09:11 INFO - Running post-run listener: _resource_record_post_run 17:09:11 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542040064; Read time: 8; Write time: 690520 17:09:11 INFO - TinderboxPrint: CPU usage
13.0% 17:09:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:09:11 INFO - TinderboxPrint: I/O write bytes / time
542,040,064 / 690,520 17:09:11 INFO - TinderboxPrint: CPU idle
8,354.0 (87.0%) 17:09:11 INFO - TinderboxPrint: CPU user
1,201.4 (12.5%) 17:09:11 INFO - TinderboxPrint: Swap in / out
0 / 0 17:09:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245927936; Read time: 0; Write time: 341376 17:09:11 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 295366656; Read time: 0; Write time: 349116 17:09:12 INFO - Running post-run listener: _upload_blobber_files 17:09:12 INFO - Blob upload gear active. 17:09:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:12 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 17:09:12 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'] 17:09:12 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 17:09:12 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:09:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:09:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:13 INFO - (blobuploader) - INFO - Done attempting. 17:09:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:09:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:09:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:14 INFO - (blobuploader) - INFO - Done attempting. 17:09:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:09:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:09:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:18 INFO - (blobuploader) - INFO - Done attempting. 17:09:18 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:18 INFO - Return code: 0 17:09:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6b1c537a5d6fcda8f9fcbe18a207be6471bc9830a8e7a343d8ae7973e9dc52c962ee56834383504ca14b32c451d65cd3845dd72a07dba11f9d8db6448bdbc688", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7094b7b569f0441ee0175bfb11e3fd7dfa6b086eac3ba292f5aed71def8f0706a8c35a6f40f8f841782cd50910b6edbfd5f96775988ac89669da9bfc3a0174b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/388d5c928ab11755b81912639e05c80c52eb99eda0016ded319fc21fdafe6fa3697ef94ee5c2806d36a16809ce3ef5380d1a97e1c8d260b080332610e95f41a0"} 17:09:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:18 INFO - Contents: 17:09:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6b1c537a5d6fcda8f9fcbe18a207be6471bc9830a8e7a343d8ae7973e9dc52c962ee56834383504ca14b32c451d65cd3845dd72a07dba11f9d8db6448bdbc688", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7094b7b569f0441ee0175bfb11e3fd7dfa6b086eac3ba292f5aed71def8f0706a8c35a6f40f8f841782cd50910b6edbfd5f96775988ac89669da9bfc3a0174b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/388d5c928ab11755b81912639e05c80c52eb99eda0016ded319fc21fdafe6fa3697ef94ee5c2806d36a16809ce3ef5380d1a97e1c8d260b080332610e95f41a0"} 17:09:18 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:18 INFO - Copying logs to upload dir... 17:09:18 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.003076 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-06 17:09:17.989377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 17:09:17.992619) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6b1c537a5d6fcda8f9fcbe18a207be6471bc9830a8e7a343d8ae7973e9dc52c962ee56834383504ca14b32c451d65cd3845dd72a07dba11f9d8db6448bdbc688", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7094b7b569f0441ee0175bfb11e3fd7dfa6b086eac3ba292f5aed71def8f0706a8c35a6f40f8f841782cd50910b6edbfd5f96775988ac89669da9bfc3a0174b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/388d5c928ab11755b81912639e05c80c52eb99eda0016ded319fc21fdafe6fa3697ef94ee5c2806d36a16809ce3ef5380d1a97e1c8d260b080332610e95f41a0"} build_url:https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/DzDCoTSkTFCAnXJaWZjm7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6b1c537a5d6fcda8f9fcbe18a207be6471bc9830a8e7a343d8ae7973e9dc52c962ee56834383504ca14b32c451d65cd3845dd72a07dba11f9d8db6448bdbc688", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7094b7b569f0441ee0175bfb11e3fd7dfa6b086eac3ba292f5aed71def8f0706a8c35a6f40f8f841782cd50910b6edbfd5f96775988ac89669da9bfc3a0174b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/388d5c928ab11755b81912639e05c80c52eb99eda0016ded319fc21fdafe6fa3697ef94ee5c2806d36a16809ce3ef5380d1a97e1c8d260b080332610e95f41a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 17:09:18.022960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 17:09:18.023399) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467847521.406672-1534311401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 17:09:18.106136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 17:09:18.107044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 17:09:18.107720) ========= ========= Total master_lag: 0.22 =========