builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1468709816.84 results: success (0) buildid: 20160716143951 builduid: 9dbd6a50a0d24257ac8d95501ffa7e37 revision: 059794b8004eba9378d28c9d584c905c40a33f04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:56.838590) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:56.839058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:56.839349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:56.895637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:56.895912) ========= 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=62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 15:56:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.5M=0.001s 2016-07-16 15:56:57 (20.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142702 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.059281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.059613) ========= 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=62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015191 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.109254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.109580) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 059794b8004eba9378d28c9d584c905c40a33f04 --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 059794b8004eba9378d28c9d584c905c40a33f04 --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=62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 15:56:57,430 truncating revision to first 12 chars 2016-07-16 15:56:57,431 Setting DEBUG logging. 2016-07-16 15:56:57,431 attempt 1/10 2016-07-16 15:56:57,431 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/059794b8004e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 15:56:57,870 unpacking tar archive at: autoland-059794b8004e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.782685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.905228) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.905510) ========= script_repo_revision: 059794b8004eba9378d28c9d584c905c40a33f04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.905859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.906122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 15:56:57.915241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-16 15:56:57.915521) ========= /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=62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:56:58 INFO - MultiFileLogger online at 20160716 15:56:58 in /builds/slave/test 15:56:58 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 15:56:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:56:58 INFO - {'append_to_log': False, 15:56:58 INFO - 'base_work_dir': '/builds/slave/test', 15:56:58 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:56:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:56:58 INFO - 'branch': 'Autoland-Non-PGO', 15:56:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:56:58 INFO - 'config_files': ('talos/linux_config.py',), 15:56:58 INFO - 'default_actions': ('clobber', 15:56:58 INFO - 'read-buildbot-config', 15:56:58 INFO - 'download-and-extract', 15:56:58 INFO - 'populate-webroot', 15:56:58 INFO - 'create-virtualenv', 15:56:58 INFO - 'install', 15:56:58 INFO - 'run-tests'), 15:56:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:56:58 INFO - 'download_minidump_stackwalk': True, 15:56:58 INFO - 'download_symbols': 'ondemand', 15:56:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:56:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:56:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:56:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:56:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:56:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:56:58 INFO - 'installer_path': 'installer.exe', 15:56:58 INFO - 'log_level': 'info', 15:56:58 INFO - 'log_name': 'talos', 15:56:58 INFO - 'log_to_console': True, 15:56:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:56:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:56:58 INFO - 'opt_config_files': (), 15:56:58 INFO - 'pip_index': False, 15:56:58 INFO - 'sps_profile': False, 15:56:58 INFO - 'sps_profile_interval': 0, 15:56:58 INFO - 'suite': 'dromaeojs', 15:56:58 INFO - 'system_bits': '32', 15:56:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:56:58 INFO - 'title': 'talos-linux64-ix-018', 15:56:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:56:58 INFO - 'use_talos_json': True, 15:56:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:56:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:56:58 INFO - 'work_dir': 'build'} 15:56:58 INFO - ##### 15:56:58 INFO - ##### Running clobber step. 15:56:58 INFO - ##### 15:56:58 INFO - Running pre-action listener: _resource_record_pre_action 15:56:58 INFO - Running main action method: clobber 15:56:58 INFO - rmtree: /builds/slave/test/build 15:56:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:56:58 INFO - Running post-action listener: _resource_record_post_action 15:56:58 INFO - ##### 15:56:58 INFO - ##### Finished clobber step (success) 15:56:58 INFO - ##### 15:56:58 INFO - ##### 15:56:58 INFO - ##### Running read-buildbot-config step. 15:56:58 INFO - ##### 15:56:58 INFO - Running pre-action listener: _resource_record_pre_action 15:56:58 INFO - Running main action method: read_buildbot_config 15:56:58 INFO - Using buildbot properties: 15:56:58 INFO - { 15:56:58 INFO - "project": "", 15:56:58 INFO - "product": "firefox", 15:56:58 INFO - "script_repo_revision": "production", 15:56:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:56:58 INFO - "repository": "", 15:56:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:56:58 INFO - "buildid": "20160716143951", 15:56:58 INFO - "pgo_build": "False", 15:56:58 INFO - "basedir": "/builds/slave/test", 15:56:58 INFO - "buildnumber": 66, 15:56:58 INFO - "slavename": "talos-linux64-ix-018", 15:56:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:56:58 INFO - "platform": "ubuntu64_hw", 15:56:58 INFO - "scheduler": "tests-autoland-linux64-talos", 15:56:58 INFO - "branch": "autoland", 15:56:58 INFO - "repo_path": "integration/autoland", 15:56:58 INFO - "revision": "059794b8004eba9378d28c9d584c905c40a33f04", 15:56:58 INFO - "stage_platform": "linux64", 15:56:58 INFO - "builduid": "9dbd6a50a0d24257ac8d95501ffa7e37", 15:56:58 INFO - "slavebuilddir": "test" 15:56:58 INFO - } 15:56:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:56:58 INFO - Running post-action listener: _resource_record_post_action 15:56:58 INFO - ##### 15:56:58 INFO - ##### Finished read-buildbot-config step (success) 15:56:58 INFO - ##### 15:56:58 INFO - ##### 15:56:58 INFO - ##### Running download-and-extract step. 15:56:58 INFO - ##### 15:56:58 INFO - Running pre-action listener: _resource_record_pre_action 15:56:58 INFO - Running main action method: download_and_extract 15:56:58 INFO - mkdir: /builds/slave/test/build/tests 15:56:58 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')]} 15:56:58 INFO - https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:07 INFO - Downloaded 1361 bytes. 15:57:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:57:07 INFO - Using the following test package requirements: 15:57:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:57:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:57:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:57:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'jsshell-linux-x86_64.zip'], 15:57:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:57:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:57:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:57:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:57:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:57:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:57:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:57:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:57: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')]} 15:57:07 INFO - https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:57:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:57:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:57:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:14 INFO - Downloaded 22757712 bytes. 15:57:14 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'] 15:57:14 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 15:57:15 INFO - Return code: 0 15:57:15 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 15:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:15 INFO - https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:57:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:57:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:57:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:18 INFO - Downloaded 22757712 bytes. 15:57:18 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'] 15:57:18 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 15:57:19 INFO - Return code: 0 15:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:19 INFO - https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:20 INFO - Downloaded 14403317 bytes. 15:57:20 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'] 15:57:20 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 15:57:20 INFO - Return code: 0 15:57: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')]} 15:57:20 INFO - https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:57:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:57:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:57:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4ol_jHBSny97PSKk5nZWw/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 15:57:23 INFO - Downloaded 57064452 bytes. 15:57:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:57:23 INFO - mkdir: /builds/slave/test/properties 15:57:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:57:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:57:23 INFO - Contents: 15:57:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:57:24 INFO - Running post-action listener: _resource_record_post_action 15:57:24 INFO - Running post-action listener: set_extra_try_arguments 15:57:24 INFO - ##### 15:57:24 INFO - ##### Finished download-and-extract step (success) 15:57:24 INFO - ##### 15:57:24 INFO - ##### 15:57:24 INFO - ##### Running populate-webroot step. 15:57:24 INFO - ##### 15:57:24 INFO - Running pre-action listener: _resource_record_pre_action 15:57:24 INFO - Running main action method: populate_webroot 15:57:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:57:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:57:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:57:24 INFO - '--tppagecycles', 15:57:24 INFO - '7'], 15:57:24 INFO - 'tests': ['tsvgm']}}, 15:57:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:57:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:57:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:57:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:57:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:57:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:57:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['damp', 'tps']}, 15:57:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'tests': ['damp', 'tps']}, 15:57:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['dromaeo_dom']}, 15:57:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:57:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['basic_compositor_video']}, 15:57:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:57:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['a11yr', 15:57:24 INFO - 'ts_paint', 15:57:24 INFO - 'tpaint', 15:57:24 INFO - 'sessionrestore', 15:57:24 INFO - 'sessionrestore_no_auto_restore', 15:57:24 INFO - 'tabpaint']}, 15:57:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:57:24 INFO - 'ts_paint', 15:57:24 INFO - 'tpaint', 15:57:24 INFO - 'sessionrestore', 15:57:24 INFO - 'sessionrestore_no_auto_restore', 15:57:24 INFO - 'tabpaint']}, 15:57:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:57:24 INFO - 'ts_paint', 15:57:24 INFO - 'tpaint', 15:57:24 INFO - 'sessionrestore', 15:57:24 INFO - 'sessionrestore_no_auto_restore', 15:57:24 INFO - 'tabpaint']}, 15:57:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:57:24 INFO - 'ts_paint', 15:57:24 INFO - 'tpaint', 15:57:24 INFO - 'sessionrestore', 15:57:24 INFO - 'sessionrestore_no_auto_restore', 15:57:24 INFO - 'tabpaint']}, 15:57:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['a11yr', 15:57:24 INFO - 'ts_paint', 15:57:24 INFO - 'tpaint', 15:57:24 INFO - 'sessionrestore', 15:57:24 INFO - 'sessionrestore_no_auto_restore', 15:57:24 INFO - 'tabpaint']}, 15:57:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['a11yr', 15:57:24 INFO - 'ts_paint', 15:57:24 INFO - 'tpaint', 15:57:24 INFO - 'sessionrestore', 15:57:24 INFO - 'sessionrestore_no_auto_restore', 15:57:24 INFO - 'tabpaint']}, 15:57:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['tsvgx', 15:57:24 INFO - 'tsvgr_opacity', 15:57:24 INFO - 'tart', 15:57:24 INFO - 'tscrollx', 15:57:24 INFO - 'cart']}, 15:57:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:57:24 INFO - 'tsvgr_opacity', 15:57:24 INFO - 'tart', 15:57:24 INFO - 'tscrollx', 15:57:24 INFO - 'cart']}, 15:57:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'talos_options': ['--disable-e10s'], 15:57:24 INFO - 'tests': ['tp5o']}, 15:57:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'tests': ['tp5o']}, 15:57:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'talos_options': ['--disable-e10s', 15:57:24 INFO - '--xperf_path', 15:57:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:57:24 INFO - 'tests': ['tp5n']}, 15:57:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:57:24 INFO - 'talos_options': ['--xperf_path', 15:57:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:57:24 INFO - 'tests': ['tp5n']}}, 15:57:24 INFO - 'talos.zip': {'path': '', 15:57:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:57:24 INFO - Running post-action listener: _resource_record_post_action 15:57:24 INFO - ##### 15:57:24 INFO - ##### Finished populate-webroot step (success) 15:57:24 INFO - ##### 15:57:24 INFO - ##### 15:57:24 INFO - ##### Running create-virtualenv step. 15:57:24 INFO - ##### 15:57:24 INFO - Running pre-action listener: _resource_record_pre_action 15:57:24 INFO - Running main action method: create_virtualenv 15:57:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:57:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:57:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:57:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:57:24 INFO - Using real prefix '/usr' 15:57:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:57:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:57:26 INFO - Installing pip.................done. 15:57:26 INFO - Return code: 0 15:57:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:26 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:26 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 15:57:26 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 15:57:26 INFO - Using env: {'DISPLAY': ':0', 15:57:26 INFO - 'HOME': '/home/cltbld', 15:57:26 INFO - 'LANG': 'en_US.UTF-8', 15:57:26 INFO - 'LANGUAGE': 'en_US:en', 15:57:26 INFO - 'LOGNAME': 'cltbld', 15:57:26 INFO - 'MAIL': '/var/mail/cltbld', 15:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:26 INFO - 'MOZ_NO_REMOTE': '1', 15:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:26 INFO - 'NO_EM_RESTART': '1', 15:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:26 INFO - 'PWD': '/builds/slave/test', 15:57:26 INFO - 'SHELL': '/bin/bash', 15:57:26 INFO - 'SHLVL': '1', 15:57:26 INFO - 'TERM': 'linux', 15:57:26 INFO - 'TMOUT': '86400', 15:57:26 INFO - 'USER': 'cltbld', 15:57:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:26 INFO - '_': '/tools/buildbot/bin/python'} 15:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:26 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 15:57:26 INFO - Cleaning up... 15:57:26 INFO - Return code: 0 15:57:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:26 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:26 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 15:57:26 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 15:57:26 INFO - Using env: {'DISPLAY': ':0', 15:57:26 INFO - 'HOME': '/home/cltbld', 15:57:26 INFO - 'LANG': 'en_US.UTF-8', 15:57:26 INFO - 'LANGUAGE': 'en_US:en', 15:57:26 INFO - 'LOGNAME': 'cltbld', 15:57:26 INFO - 'MAIL': '/var/mail/cltbld', 15:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:26 INFO - 'MOZ_NO_REMOTE': '1', 15:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:26 INFO - 'NO_EM_RESTART': '1', 15:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:26 INFO - 'PWD': '/builds/slave/test', 15:57:26 INFO - 'SHELL': '/bin/bash', 15:57:26 INFO - 'SHLVL': '1', 15:57:26 INFO - 'TERM': 'linux', 15:57:26 INFO - 'TMOUT': '86400', 15:57:26 INFO - 'USER': 'cltbld', 15:57:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:26 INFO - '_': '/tools/buildbot/bin/python'} 15:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:27 INFO - Downloading/unpacking psutil>=3.1.1 15:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:57:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:57:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:57:29 INFO - Installing collected packages: psutil 15:57:29 INFO - Running setup.py install for psutil 15:57:29 INFO - building 'psutil._psutil_linux' extension 15:57:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:57:29 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 15:57:29 INFO - building 'psutil._psutil_posix' extension 15:57:29 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 15:57:29 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 15:57:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:57:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:57:29 INFO - Successfully installed psutil 15:57:29 INFO - Cleaning up... 15:57:29 INFO - Return code: 0 15:57:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:57:29 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')]} 15:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:29 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')]} 15:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:29 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:29 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 15:57:29 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 15:57:29 INFO - Using env: {'DISPLAY': ':0', 15:57:29 INFO - 'HOME': '/home/cltbld', 15:57:29 INFO - 'LANG': 'en_US.UTF-8', 15:57:29 INFO - 'LANGUAGE': 'en_US:en', 15:57:29 INFO - 'LOGNAME': 'cltbld', 15:57:29 INFO - 'MAIL': '/var/mail/cltbld', 15:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:29 INFO - 'MOZ_NO_REMOTE': '1', 15:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:29 INFO - 'NO_EM_RESTART': '1', 15:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:29 INFO - 'PWD': '/builds/slave/test', 15:57:29 INFO - 'SHELL': '/bin/bash', 15:57:29 INFO - 'SHLVL': '1', 15:57:29 INFO - 'TERM': 'linux', 15:57:29 INFO - 'TMOUT': '86400', 15:57:29 INFO - 'USER': 'cltbld', 15:57:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:29 INFO - '_': '/tools/buildbot/bin/python'} 15:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:57:29 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 15:57:29 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 15:57:29 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 15:57:29 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 15:57:29 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 15:57:29 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 15:57:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:57:31 INFO - Installing collected packages: mozsystemmonitor 15:57:31 INFO - Running setup.py install for mozsystemmonitor 15:57:31 INFO - Successfully installed mozsystemmonitor 15:57:31 INFO - Cleaning up... 15:57:32 INFO - Return code: 0 15:57:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:57:32 INFO - Using env: {'DISPLAY': ':0', 15:57:32 INFO - 'HOME': '/home/cltbld', 15:57:32 INFO - 'LANG': 'en_US.UTF-8', 15:57:32 INFO - 'LANGUAGE': 'en_US:en', 15:57:32 INFO - 'LOGNAME': 'cltbld', 15:57:32 INFO - 'MAIL': '/var/mail/cltbld', 15:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:32 INFO - 'MOZ_NO_REMOTE': '1', 15:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:32 INFO - 'NO_EM_RESTART': '1', 15:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:32 INFO - 'PWD': '/builds/slave/test', 15:57:32 INFO - 'SHELL': '/bin/bash', 15:57:32 INFO - 'SHLVL': '1', 15:57:32 INFO - 'TERM': 'linux', 15:57:32 INFO - 'TMOUT': '86400', 15:57:32 INFO - 'USER': 'cltbld', 15:57:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:32 INFO - '_': '/tools/buildbot/bin/python'} 15:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:32 INFO - Downloading/unpacking jsonschema==2.5.1 15:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:57:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:57:34 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 15:57:34 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 15:57:34 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 15:57:34 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 15:57:34 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 15:57:34 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 15:57:34 INFO - Downloading functools32-3.2.3-2.tar.gz 15:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:57:34 INFO - warning: no files found matching '*.txt' 15:57:34 INFO - no previously-included directories found matching 'build' 15:57:34 INFO - no previously-included directories found matching 'dist' 15:57:34 INFO - no previously-included directories found matching '.git*' 15:57:34 INFO - Installing collected packages: jsonschema, functools32 15:57:34 INFO - Running setup.py install for functools32 15:57:34 INFO - warning: no files found matching '*.txt' 15:57:34 INFO - no previously-included directories found matching 'build' 15:57:34 INFO - no previously-included directories found matching 'dist' 15:57:34 INFO - no previously-included directories found matching '.git*' 15:57:34 INFO - Successfully installed jsonschema functools32 15:57:34 INFO - Cleaning up... 15:57:34 INFO - Return code: 0 15:57:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:57:34 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')]} 15:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:34 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')]} 15:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:34 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:34 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 15:57:34 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 15:57:34 INFO - Using env: {'DISPLAY': ':0', 15:57:34 INFO - 'HOME': '/home/cltbld', 15:57:34 INFO - 'LANG': 'en_US.UTF-8', 15:57:34 INFO - 'LANGUAGE': 'en_US:en', 15:57:34 INFO - 'LOGNAME': 'cltbld', 15:57:34 INFO - 'MAIL': '/var/mail/cltbld', 15:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:34 INFO - 'MOZ_NO_REMOTE': '1', 15:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:34 INFO - 'NO_EM_RESTART': '1', 15:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:34 INFO - 'PWD': '/builds/slave/test', 15:57:34 INFO - 'SHELL': '/bin/bash', 15:57:34 INFO - 'SHLVL': '1', 15:57:34 INFO - 'TERM': 'linux', 15:57:34 INFO - 'TMOUT': '86400', 15:57:34 INFO - 'USER': 'cltbld', 15:57:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:34 INFO - '_': '/tools/buildbot/bin/python'} 15:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:57:34 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 15:57:34 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 15:57:34 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 15:57:34 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 15:57:34 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 15:57:34 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 15:57:36 INFO - Downloading blobuploader-1.2.4.tar.gz 15:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:57:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:57:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:37 INFO - Downloading docopt-0.6.1.tar.gz 15:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:57:37 INFO - Installing collected packages: blobuploader, requests, docopt 15:57:37 INFO - Running setup.py install for blobuploader 15:57:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:57:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:57:37 INFO - Running setup.py install for requests 15:57:37 INFO - Running setup.py install for docopt 15:57:38 INFO - Successfully installed blobuploader requests docopt 15:57:38 INFO - Cleaning up... 15:57:38 INFO - Return code: 0 15:57:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:38 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:38 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 15:57:38 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 15:57:38 INFO - Using env: {'DISPLAY': ':0', 15:57:38 INFO - 'HOME': '/home/cltbld', 15:57:38 INFO - 'LANG': 'en_US.UTF-8', 15:57:38 INFO - 'LANGUAGE': 'en_US:en', 15:57:38 INFO - 'LOGNAME': 'cltbld', 15:57:38 INFO - 'MAIL': '/var/mail/cltbld', 15:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:38 INFO - 'MOZ_NO_REMOTE': '1', 15:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:38 INFO - 'NO_EM_RESTART': '1', 15:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:38 INFO - 'PWD': '/builds/slave/test', 15:57:38 INFO - 'SHELL': '/bin/bash', 15:57:38 INFO - 'SHLVL': '1', 15:57:38 INFO - 'TERM': 'linux', 15:57:38 INFO - 'TMOUT': '86400', 15:57:38 INFO - 'USER': 'cltbld', 15:57:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:38 INFO - '_': '/tools/buildbot/bin/python'} 15:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:38 INFO - Running setup.py (path:/tmp/pip-LKQSBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:38 INFO - Running setup.py (path:/tmp/pip-01i7yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:38 INFO - Running setup.py (path:/tmp/pip-wsKSGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:38 INFO - Running setup.py (path:/tmp/pip-zefShL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:38 INFO - Running setup.py (path:/tmp/pip-tmJgJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:38 INFO - Running setup.py (path:/tmp/pip-73mkRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:38 INFO - Running setup.py (path:/tmp/pip-uSsiCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:38 INFO - Running setup.py (path:/tmp/pip-cD3FMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:38 INFO - Running setup.py (path:/tmp/pip-FO3QFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:39 INFO - Running setup.py (path:/tmp/pip-L112Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:39 INFO - Running setup.py (path:/tmp/pip-Y4YJhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:39 INFO - Running setup.py (path:/tmp/pip-Mpp_Rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:39 INFO - Running setup.py (path:/tmp/pip-rFc_vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:39 INFO - Running setup.py (path:/tmp/pip-j_q8Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:39 INFO - Running setup.py (path:/tmp/pip-swvldt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:39 INFO - Running setup.py (path:/tmp/pip-qd92Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:39 INFO - Running setup.py (path:/tmp/pip-x2oOI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:57:39 INFO - Running setup.py install for manifestparser 15:57:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:57:39 INFO - Running setup.py install for mozcrash 15:57:39 INFO - Running setup.py install for mozdebug 15:57:39 INFO - Running setup.py install for mozdevice 15:57:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:57:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Running setup.py install for mozfile 15:57:40 INFO - Running setup.py install for mozhttpd 15:57:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Running setup.py install for mozinfo 15:57:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Running setup.py install for mozInstall 15:57:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Running setup.py install for mozleak 15:57:40 INFO - Running setup.py install for mozlog 15:57:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Running setup.py install for moznetwork 15:57:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Running setup.py install for mozprocess 15:57:40 INFO - Running setup.py install for mozprofile 15:57:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:57:40 INFO - Running setup.py install for mozrunner 15:57:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:57:41 INFO - Running setup.py install for mozscreenshot 15:57:41 INFO - Running setup.py install for moztest 15:57:41 INFO - Running setup.py install for mozversion 15:57:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:57:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:57:41 INFO - Cleaning up... 15:57:41 INFO - Return code: 0 15:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:41 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:41 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 15:57:41 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 15:57:41 INFO - Using env: {'DISPLAY': ':0', 15:57:41 INFO - 'HOME': '/home/cltbld', 15:57:41 INFO - 'LANG': 'en_US.UTF-8', 15:57:41 INFO - 'LANGUAGE': 'en_US:en', 15:57:41 INFO - 'LOGNAME': 'cltbld', 15:57:41 INFO - 'MAIL': '/var/mail/cltbld', 15:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:41 INFO - 'MOZ_NO_REMOTE': '1', 15:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:41 INFO - 'NO_EM_RESTART': '1', 15:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:41 INFO - 'PWD': '/builds/slave/test', 15:57:41 INFO - 'SHELL': '/bin/bash', 15:57:41 INFO - 'SHLVL': '1', 15:57:41 INFO - 'TERM': 'linux', 15:57:41 INFO - 'TMOUT': '86400', 15:57:41 INFO - 'USER': 'cltbld', 15:57:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:41 INFO - '_': '/tools/buildbot/bin/python'} 15:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:41 INFO - Running setup.py (path:/tmp/pip-tt5OUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:41 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)) 15:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:41 INFO - Running setup.py (path:/tmp/pip-8Ipjaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:41 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)) 15:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:41 INFO - Running setup.py (path:/tmp/pip-NnXyG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:41 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)) 15:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:41 INFO - Running setup.py (path:/tmp/pip-rdwCuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:41 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)) 15:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:41 INFO - Running setup.py (path:/tmp/pip-srjKqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:41 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)) 15:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:41 INFO - Running setup.py (path:/tmp/pip-POvs57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:42 INFO - Running setup.py (path:/tmp/pip-DjSEZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:42 INFO - Running setup.py (path:/tmp/pip-1w4vPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:42 INFO - Running setup.py (path:/tmp/pip-1OhPeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:42 INFO - Running setup.py (path:/tmp/pip-F3Lxr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:42 INFO - Running setup.py (path:/tmp/pip-8RaYc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:42 INFO - Running setup.py (path:/tmp/pip-sCu9VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:42 INFO - Running setup.py (path:/tmp/pip-vKiFAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:42 INFO - Running setup.py (path:/tmp/pip-7t4AqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:42 INFO - Running setup.py (path:/tmp/pip-MyDyFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:42 INFO - Running setup.py (path:/tmp/pip-_5fGKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:42 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)) 15:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:42 INFO - Running setup.py (path:/tmp/pip-eanhpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:42 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)) 15:57:42 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)) 15:57:42 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)) 15:57:42 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)) 15:57:42 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)) 15:57:42 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)) 15:57:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:57:42 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 15:57:42 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 15:57:42 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 15:57:42 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 15:57:42 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 15:57:42 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 15:57:44 INFO - Downloading blessings-1.6.tar.gz 15:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:57:44 INFO - Installing collected packages: blessings 15:57:44 INFO - Running setup.py install for blessings 15:57:44 INFO - Successfully installed blessings 15:57:44 INFO - Cleaning up... 15:57:45 INFO - Return code: 0 15:57:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:45 INFO - Reading from file tmpfile_stdout 15:57:45 INFO - Current package versions: 15:57:45 INFO - argparse == 1.2.1 15:57:45 INFO - blessings == 1.6 15:57:45 INFO - blobuploader == 1.2.4 15:57:45 INFO - docopt == 0.6.1 15:57:45 INFO - functools32 == 3.2.3-2 15:57:45 INFO - jsonschema == 2.5.1 15:57:45 INFO - manifestparser == 1.1 15:57:45 INFO - mozInstall == 1.12 15:57:45 INFO - mozcrash == 0.17 15:57:45 INFO - mozdebug == 0.1 15:57:45 INFO - mozdevice == 0.48 15:57:45 INFO - mozfile == 1.2 15:57:45 INFO - mozhttpd == 0.7 15:57:45 INFO - mozinfo == 0.9 15:57:45 INFO - mozleak == 0.1 15:57:45 INFO - mozlog == 3.2 15:57:45 INFO - moznetwork == 0.27 15:57:45 INFO - mozprocess == 0.23 15:57:45 INFO - mozprofile == 0.28 15:57:45 INFO - mozrunner == 6.12 15:57:45 INFO - mozscreenshot == 0.1 15:57:45 INFO - mozsystemmonitor == 0.3 15:57:45 INFO - moztest == 0.7 15:57:45 INFO - mozversion == 1.4 15:57:45 INFO - psutil == 3.1.1 15:57:45 INFO - requests == 1.2.3 15:57:45 INFO - wsgiref == 0.1.2 15:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:45 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')]} 15:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:45 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')]} 15:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:45 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:45 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 15:57:45 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 15:57:45 INFO - Using env: {'DISPLAY': ':0', 15:57:45 INFO - 'HOME': '/home/cltbld', 15:57:45 INFO - 'LANG': 'en_US.UTF-8', 15:57:45 INFO - 'LANGUAGE': 'en_US:en', 15:57:45 INFO - 'LOGNAME': 'cltbld', 15:57:45 INFO - 'MAIL': '/var/mail/cltbld', 15:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:45 INFO - 'MOZ_NO_REMOTE': '1', 15:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:45 INFO - 'NO_EM_RESTART': '1', 15:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:45 INFO - 'PWD': '/builds/slave/test', 15:57:45 INFO - 'SHELL': '/bin/bash', 15:57:45 INFO - 'SHLVL': '1', 15:57:45 INFO - 'TERM': 'linux', 15:57:45 INFO - 'TMOUT': '86400', 15:57:45 INFO - 'USER': 'cltbld', 15:57:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:45 INFO - '_': '/tools/buildbot/bin/python'} 15:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 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)) 15:57:45 INFO - Cleaning up... 15:57:45 INFO - Return code: 0 15:57:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:57:45 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')]} 15:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:45 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')]} 15:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:45 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 0x1694030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1955180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, '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': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', '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 15:57:45 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 15:57:45 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 15:57:45 INFO - Using env: {'DISPLAY': ':0', 15:57:45 INFO - 'HOME': '/home/cltbld', 15:57:45 INFO - 'LANG': 'en_US.UTF-8', 15:57:45 INFO - 'LANGUAGE': 'en_US:en', 15:57:45 INFO - 'LOGNAME': 'cltbld', 15:57:45 INFO - 'MAIL': '/var/mail/cltbld', 15:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:45 INFO - 'MOZ_NO_REMOTE': '1', 15:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:45 INFO - 'NO_EM_RESTART': '1', 15:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:45 INFO - 'PWD': '/builds/slave/test', 15:57:45 INFO - 'SHELL': '/bin/bash', 15:57:45 INFO - 'SHLVL': '1', 15:57:45 INFO - 'TERM': 'linux', 15:57:45 INFO - 'TMOUT': '86400', 15:57:45 INFO - 'USER': 'cltbld', 15:57:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:45 INFO - '_': '/tools/buildbot/bin/python'} 15:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:57:45 INFO - Cleaning up... 15:57:45 INFO - Return code: 0 15:57:45 INFO - Running post-action listener: _resource_record_post_action 15:57:45 INFO - Running post-action listener: _start_resource_monitoring 15:57:45 INFO - Starting resource monitoring. 15:57:45 INFO - ##### 15:57:45 INFO - ##### Finished create-virtualenv step (success) 15:57:45 INFO - ##### 15:57:45 INFO - ##### 15:57:45 INFO - ##### Running install step. 15:57:45 INFO - ##### 15:57:45 INFO - Running pre-action listener: _resource_record_pre_action 15:57:45 INFO - Running main action method: install 15:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:45 INFO - Reading from file tmpfile_stdout 15:57:45 INFO - Detecting whether we're running mozinstall >=1.0... 15:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:57:46 INFO - Reading from file tmpfile_stdout 15:57:46 INFO - Output received: 15:57:46 INFO - Usage: mozinstall [options] installer 15:57:46 INFO - Options: 15:57:46 INFO - -h, --help show this help message and exit 15:57:46 INFO - -d DEST, --destination=DEST 15:57:46 INFO - Directory to install application into. [default: 15:57:46 INFO - "/builds/slave/test"] 15:57:46 INFO - --app=APP Application being installed. [default: firefox] 15:57:46 INFO - mkdir: /builds/slave/test/build/application 15:57:46 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'] 15:57:46 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 15:58:02 INFO - Reading from file tmpfile_stdout 15:58:02 INFO - Output received: 15:58:02 INFO - /builds/slave/test/build/application/firefox/firefox 15:58:02 INFO - Running post-action listener: _resource_record_post_action 15:58:02 INFO - ##### 15:58:02 INFO - ##### Finished install step (success) 15:58:02 INFO - ##### 15:58:02 INFO - ##### 15:58:02 INFO - ##### Running run-tests step. 15:58:02 INFO - ##### 15:58:02 INFO - Running pre-action listener: _resource_record_pre_action 15:58:02 INFO - Running main action method: run_tests 15:58:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:58:02 INFO - Python 2.7.3 15:58:02 INFO - Return code: 0 15:58:02 INFO - grabbing minidump binary from tooltool 15:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:02 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 0x19533b0>, '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 0x19542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:58:02 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 15:58:02 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 15:58:02 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 15:58:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:58:02 INFO - Return code: 0 15:58:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:58:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:58:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:58:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:58:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:58:02 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/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 15:58:02 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/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 15:58:02 INFO - Using env: {'DISPLAY': ':0', 15:58:02 INFO - 'HOME': '/home/cltbld', 15:58:02 INFO - 'LANG': 'en_US.UTF-8', 15:58:02 INFO - 'LANGUAGE': 'en_US:en', 15:58:02 INFO - 'LOGNAME': 'cltbld', 15:58:02 INFO - 'MAIL': '/var/mail/cltbld', 15:58:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:58:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:02 INFO - 'MOZ_NO_REMOTE': '1', 15:58:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:02 INFO - 'NO_EM_RESTART': '1', 15:58:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:02 INFO - 'PWD': '/builds/slave/test', 15:58:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:58:02 INFO - 'SHELL': '/bin/bash', 15:58:02 INFO - 'SHLVL': '1', 15:58:02 INFO - 'TERM': 'linux', 15:58:02 INFO - 'TMOUT': '86400', 15:58:02 INFO - 'USER': 'cltbld', 15:58:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391', 15:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:02 INFO - '_': '/tools/buildbot/bin/python'} 15:58:02 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/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 15:58:02 INFO - mozversion application_buildid: 20160716143951 15:58:02 INFO - mozversion application_changeset: 059794b8004eba9378d28c9d584c905c40a33f04 15:58:02 INFO - mozversion application_display_name: Nightly 15:58:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:58:02 INFO - mozversion application_name: Firefox 15:58:02 INFO - mozversion application_remotingname: firefox 15:58:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:58:02 INFO - mozversion application_vendor: Mozilla 15:58:02 INFO - mozversion application_version: 50.0a1 15:58:02 INFO - mozversion platform_buildid: 20160716143951 15:58:02 INFO - mozversion platform_changeset: 059794b8004eba9378d28c9d584c905c40a33f04 15:58:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:58:02 INFO - mozversion platform_version: 50.0a1 15:58:02 INFO - using testdate: 1468709882 15:58:02 INFO - actual date: 1468709882 15:58:02 INFO - starting webserver on 'localhost:57627' 15:58:02 INFO - SUITE-START | Running 2 tests 15:58:02 INFO - TEST-START | dromaeo_css 15:58:02 INFO - operating with platform_type : linux_ 15:58:02 INFO - Initialising browser for dromaeo_css test... 15:58:02 INFO - TEST-INFO | started process 25662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg7tMqu/profile http://localhost:57627/getInfo.html) 15:58:06 INFO - PROCESS | 25662 | __metrics Screen width/height:1600/1200 15:58:06 INFO - PROCESS | 25662 | colorDepth:24 15:58:06 INFO - PROCESS | 25662 | Browser inner width/height: 1024/697 15:58:06 INFO - PROCESS | 25662 | __metrics 15:58:07 INFO - PROCESS | 25662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:58:07 INFO - PROCESS | 25662 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:58:08 INFO - TEST-INFO | 25662: exit 0 15:58:08 INFO - Browser initialized. 15:58:08 INFO - Running cycle 1/1 for dromaeo_css test... 15:58:08 INFO - TEST-INFO | started process 25745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg7tMqu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:20 INFO - PROCESS | 25745 | RSS: Main: 158957568 15:58:20 INFO - PROCESS | 25745 | 15:59:11 INFO - PROCESS | 25745 | 1468709951354 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:01:23 INFO - PROCESS | 25745 | Cycle 1(1): loaded http://localhost:57627/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57627/tests/dromaeo/cssquery-ext.html) 16:01:24 INFO - PROCESS | 25745 | RSS: Main: 273485824 16:01:24 INFO - PROCESS | 25745 | 16:04:27 INFO - PROCESS | 25745 | Cycle 1(1): loaded http://localhost:57627/tests/dromaeo/cssquery-ext.html (next: http://localhost:57627/tests/dromaeo/cssquery-jquery.html) 16:04:28 INFO - PROCESS | 25745 | RSS: Main: 243359744 16:04:28 INFO - PROCESS | 25745 | 16:07:30 INFO - PROCESS | 25745 | Cycle 1(1): loaded http://localhost:57627/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57627/tests/dromaeo/cssquery-mootools.html) 16:07:31 INFO - PROCESS | 25745 | RSS: Main: 242126848 16:07:31 INFO - PROCESS | 25745 | 16:10:33 INFO - PROCESS | 25745 | Cycle 1(1): loaded http://localhost:57627/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57627/tests/dromaeo/cssquery-prototype.html) 16:10:33 INFO - PROCESS | 25745 | RSS: Main: 238682112 16:10:33 INFO - PROCESS | 25745 | 16:13:36 INFO - PROCESS | 25745 | Cycle 1(1): loaded http://localhost:57627/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57627/tests/dromaeo/cssquery-yui.html) 16:13:37 INFO - PROCESS | 25745 | RSS: Main: 222326784 16:13:37 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | Cycle 1(1): loaded http://localhost:57627/tests/dromaeo/cssquery-yui.html (next: http://localhost:57627/tests/dromaeo/cssquery-dojo.html) 16:16:40 INFO - PROCESS | 25745 | RSS: Main: 303341568 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | __start_tp_report 16:16:40 INFO - PROCESS | 25745 | _x_x_mozilla_page_load 16:16:40 INFO - PROCESS | 25745 | _x_x_mozilla_page_load_details 16:16:40 INFO - PROCESS | 25745 | |i|pagename|runs| 16:16:40 INFO - PROCESS | 25745 | |0;dojo.html;2660.3083198368427;2677.143314139476;2706.2151975926977;2708.0521817363924;2716.891324347026;4715.198416269234;4781.90436191276;4823.421189457261;4829.372181616393;4924.655274130808;4817.470078291394;4837.951620483794;4844.467108618058;4847.07905497956;4867.4159100907855;4377.190219809329;4391.516933137353;4424.734515929046;4429.357743127244;4477.888052798674;139.01446746922608;4441.822327106912;4477.238869392211;4480.0367920897;4503.707259028169;4326.351047342892;4463.085067561175;4481.215787237221;4499.370088187657;4512.435945506812;4435.911281774379;4440.045390241114;4443.844465443726;4455.287154055336;4488.326750987346;4280.657547396201;4417.116576684643;4428.579284967923;4445.888852778707;4467.084247729208;4711.363965864599;4713.198756211452;4765.928511072302;4766.451858036336;4767.451743049559;5126.6667666601925;5145.30538377318;5147.948520514784;5151.484851514856;5151.6136289778415;5041.8487445376695;5126.897462050775;5128.358955130609;5171.456997015334;5173.249878767595;4762.57136857681;4795.760211989456;4806.663533552618;4812.133815913169;4821.493743156988;5307.6019298552765;5373.032854086302;5373.516383525502;5373.865653358619;5376.973115134478;4993.525615066563;5018.4981501849525;5134.717590532557;5147.433782283946;5150.304708864255;5114.4629813869005;5195.844124676266;5215.687058776485;5218.034663587248;5219.034478621467;5112.642115051911;5128.538431541179;5142;5142.331496905378;5143.27994080829;4901.411830580353;5063.088644044034;5083.72039537829;5119.48805119485;5170;4382.320740285261;4401.735895846259;4436.467623885154;4442.577955094261;4443.822247110144;3824.9235015299537;3843.3082045231567;3854.807259637007;3866.6906647468136;3887.7667339959694;4380.890477738082;4415.116976604692;4422.115576884636;4432.645388368923;4510.50384457716;5127.6154288428515;5246.23929530216;5256.448072952361;5261.973690131601;5283.894322113536;4469.150861336336;4470.038941627566;4472.0608672179205;4484.708493947883;4506.864794056183;4480.036792089716;4690.108879312919;4693.6949098308505;4703.529647035269;4752.643551733565;4690.695104818176;4792.928106078341;4800.783964721526;4819.975900120477;4899.387576552931;5163.741812909415;5166.044281807877;5167.61242906776;5173.560247379015;5210.739463026757;4839.611712539414;4864.73243971585;4868.829590964299;4877.268409738425;4901.264810278487;4872.488388719134;4977.328060711758;5034.0686972910125;5045.672031317952;5085.313482679939;5105.157648987875;5105.4639262878345;5107.233914912793;5111.897762044664;5158.123119069692;4932;4966.304717339503;4971.254311853251;4980.626453016111;4981.4769449207315;4854.150523658416;4921.6062714982;4996.475370086088;5000.699958002531;5044.798208071636;4864.8054077837905;4883.487233840396;4886.609071274361;4900.558949694545;4947.134251506044;4899.804007839789;5051.040302342543;5055.266986286894;5059.291699162047;5092.516210959953;4933.309336692938;4939.604831613534;4950.232713929347;4960.379952505937;4974.9751251243515 16:16:40 INFO - PROCESS | 25745 | |1;ext.html;539.0674133748615;543.5570010441489;547.5619504396483;574.1703238819904;581.4708615160205;26769.464610707775;39397;41241.79379103108;41303.79348103259;45206;39779;40110.19779604406;40198.79900600493;40216.396754048714;40247.798761006154;7465.6267186640725;7915.643796029178;8046.195380461965;8048.919510804875;8056.315213206884;7505;7743.961280193591;7744.0319960005;10030.699079027641;10324.070833624972;10230.488475576229;10281;10285.537150828231;10294.073533381994;10305.84541231882;10204.693859184199;10288.948555257175;10298.073173414354;10305.536250868654;10320.225983051227;7503.737369192052;9938.80122397548;10328.225383096224;10346.586136554528;10657.946710266477;39224.41163382552;39561.40657890134;39579;39603.20793584141;39645.40531892024;2273.45437095096;2942.955855662167;2953.689862564421;2985;3008.413359394897;25148.371290717696;30044.24889377761;30542;30588.235294117603;31359.216019599466;3301.96698033019;3332.9333413331597;3359.9496007559906;3383;3429.296994116225;291219;295650;295868;408426;409009;54810;55243.89512209733;55288;55470.44529554733;55646.72176639091;41916.16167676629;58242.126368103665;59767.827860657;59814.401855981756;60229.69885150546;13915.791263131061;14065;14069.648258793408;14071.929640351938;14078.71842563143;8941.46351218929;9722.562484688206;9783.559739811726;9785.217182625373;9787.706368808947;17902.46292611224;18261.90869045646;18600.627987440177;18764.906175469307;19222.903885480762;6799.558028728117;6903.482238832108;6915.239323674392;6985.930140698528;7163.489889953885;721.1239587218699;787.4605894961969;872.437277955715;905.8731777551149;971.6987733802544;27446;28553.286167845556;28713.425731485255;28772.568411473843;29188.562171567442;905.7961958559272;906.7370462565782;937.0442149007973;948.1324588002038;993.8608594796734;14598.197099159648;14965.804473893893;15018.774718379233;15236.46672366484;15301.770473442908;385130;389985;393507;394857;396661;44085.33871991923;44092.55907440885;44158.58414158558;44222.55777442249;44254.336184957254;905.7463910105181;1059.1685526861377;1148.942552872353;1150.6317978247048;1213.836132122152;28549.42901142007;29230.123096307147;29556;29818.55272170876;30287.394252115275;42764.78617606892;43064.35403469013;43483.56516434795;43510.78244608756;43513;322918;323453;325101;326347;326447;20999.8950005249;24761;25293.367665808502;25394;27049.729502704722;41239.587604124776;41472;41785.1642967145;42304.57695423006;43153.784231078644;35628.287434250655;36968.63031369759;37307;37360.81319593385;37496.43755343727;36308.45537316995;36751.94483116469;36878;37039.44440833336;37221.627783721815;35500.822495887354;36085.81957090198;36105;36311.09222269464;36314.27371452609;32389.288879594424;32464.675353246166;32795.83602081974;32967.17582060468;33028;25053.74946250587;25169.119080832083;25195.87402062978;25568.488630227665;25856.741432586186 16:16:40 INFO - PROCESS | 25745 | |2;jquery.html;353.9646035396459;371.92375563009585;378.9677877380423;381.62028781362534;389.99415008774855;13092.73814523709;15512.922435387822;15943.601409964756;16173.757393639075;16871;14807.851921480782;14910.40358385666;15100.79193664507;15391.692166156698;15510.30203640836;5152.484751524846;5343.812966546172;5371.221172929942;5640.323161220659;6208.379162083801;6223.626582405048;6237.875242495147;6238.313785483593;6264.467520260783;6307.022411526198;5954.940450595482;6179.19670442844;6184.721687524072;6192.071189321593;6212;5967.850803729898;6156.138140660311;6171.59884607499;6174.166487524194;6175.351588083254;5424.83725488236;5457.290552228224;5459.645123066988;5461.371942226655;5463.672179669233;20385;20664.690029649566;20766.5846683067;20992.895035524725;21075.789242107538;1901.420066879601;1975.8221760041665;1999.0304702219412;2032.3699653107583;2070.6790447480666;6245.6252624842655;6266.404691554295;6284.371562843725;6731.629760363178;7429.665665045086;1596.8323326050713;1669.8914570552874;1763.3563749231566;1820.945371638853;1826.8855997841306;67041.66479167574;68654.65672671655;69636.30363696399;70640.2935970644;71055.28944710539;8511.53186574732;9177.541122943827;9357.20463760588;9556.331056825955;10222;12280.570180043656;13086.672833179247;13090.476380944656;13576.1854288743;13645.38595763193;7015;7157.89263161053;7177.210506844243;7310.195878453366;7316.195218525958;6791.151106111736;6853.314668533107;6854.760083397057;6949.930500694928;6962.303769623099;6132.325444201134;6243.656598887105;6246.219222597176;6282.1519094921605;6346.365363463617;1761.2426656537812;1790.9552261193573;1824.7920016779844;1842.0881663576615;1859.6094820087662;858.4891989266376;860.3902555339154;891.4383938119073;957.8228027814877;969.7963427680266;16630.50108496747;17001.80349408258;17553.64892702139;17810.643787124183;17882.821171788117;874.7725591346295;886.7029545102463;911.5487833522449;954.6849539652037;976.4580657735025;9535;10050.597976080875;10129.493525323851;10136.341137826017;10208.948955255177;396582;405315;407170;407457;407753;64993.35006649873;66501.6674916632;67145.32854671488;67806.66096669485;67858.66070669614;880.3033358086682;883.1830556734994;901.6213190459891;904.5386852705168;907.5734404829587;14553.708925821213;14870.405183792527;16170.919145404197;16383.918080409521;17027.48917532476;37712.81143594265;37798.81100594479;38675.6132438672;39146.60853391544;39663.40504892371;49890.25164622606;51623;52429.7378513105;52527.474725253785;53545;7163.140423149255;7218.89171662415;7317.86573081152;7348.228436014356;7441.144268409203;8838.646454141763;10770.838437423601;10796.298240614335;10872.891271087505;11166.665000050012;9225.016621426426;9478.38390504615;9562.56968436436;9613.471259080537;10105.040021197974;9273.67542136022;9322.906770932204;9530.666426675032;9821.950890245504;10002.549885255035;5173.275741396283;6496.512761542808;7935.722249721232;9238.491882946502;9979.800403992025;6533.085368048382;7156.677949492181;7212.963935180291;7231.819204519718;7603.1240559240305;9090.59092340833;10250.58997640116;10263.58945642166;10431.94784026075;10838.458077096271 16:16:40 INFO - PROCESS | 25745 | |3;mootools.html;1103.9668809935695;1288.3686993373246;1334.139480035377;1406.9015168938172;1710.8289171082886;6943.965280173598;7627.809304767384;7871.134175240719;7893.960530197348;8136.511809291446;7806.063272407305;7944.324732397753;7959.920400795991;7960.6019699015105;7960.7213747518845;1893.5928775313305;2087.27988843849;2111.9049642766036;2145.5065334972965;2221.80003799658;2244.36035729817;2263.219189379661;2267.875266860322;2268.8298377621663;2271.9772802272014;2204.7795220477983;2230.743464501587;2230.7992280694734;2233.8994745236505;2234.899429525667;1842.1802297977472;2112.0601332407086;2160.114353115223;2182.432567532437;2188.562287542498;2189.189999700105;2207.3267653365715;2210.2706106984656;2212.23677831148;2212.745534263548;8195.057568379652;8225.917740822635;8257.091719910804;8258.669653213865;8268.338532917352;4355.651547876194;4489.73061616304;4496.4829044659955;4498.055408364247;4500.707454015511;2713.1996061162004;2863.914082577526;2875.8993435229877;2882.855857207131;2900.274931267183;828.7306625346787;831.4512421801581;837.4472847920343;865.7965378136196;871.172386233081;11251.156163287786;11326.03728683063;11330;11344.546218151347;11366.829497557543;4029.6977726670616;4089.141280331104;4238.894027649333;4243.3634954757035;4265.957340426618;9593.664221752206;9599.664011759694;9606;9619.615215391446;9639.084286992724;4492.101579684077;4514.616257618073;4517.073999830027;4517.6160026397465;4521.11838191556;3535.4873543336585;3993.7803420812133;4141.544430112685;4146.108586653884;4205.306124489486;3743.5025989603832;3796.487474190949;3842.1355195080882;3891.3384724596885;3902.180542086137;1086.4187659602233;1181.9704507387212;1226.6565361698738;1227.846519185102;1232.1682864066897;731.0824914732084;755.8412733326063;756.8675481790665;770.1451388958252;778.5367706214793;5021.397432308073;5026.447090820006;5090.796368145307;5110.105731497048;5131.846044618667;823.4135863241686;843.7426584891667;873.4802792338548;879.2043200903065;905.4250550900226;4026.697997650188;4165.187788381297;4173;4235.9364609530885;4238.258304796648;10196;10365.585376584851;10400.947995259976;10476.109530689824;10503.264771465923;9591.808163836684;10344.948275258726;10347.172226221885;10361.378317300987;10396.532156052996;7312.268773122645;7630.542167469858;7683.615819209017;7696.191899850547;7702.807429814187;5544.445555444423;5838.2702162229725;5841.649501029951;5876.588638795243;5936.525077993664;9424.434533927986;9512.571934263113;9513.952430237805;9519.666811661558;9536.332456727963;9492.335536512377;9509.476978766234;9669;9769.951150244204;9827.55775990068;7096.396806271525;7184.568925864465;7222.530535515175;7223.313785190398;7227.8554428912175;7441.851162976818;7520.473566850268;7522.849543009219;7528.360089392463;7536.736214232695;6809.863802724017;7062.752803651848;7069.469789765891;7154.821129471805;7292;6976.058232138799;6987.301269872972;6994.9300506996315;7070.328318809705;7076.540024898365;6535.967320163559;6579.243387010363;6582;6584.934150658432;6592.90110648331;4493.415855938707;4551.226291530514;4580.106879158532;4618.953810461852;4623.214053610962;4528.750918699503;4605.447346318463;4665.183592871302;4723.173444647105;4783.378160839208 16:16:40 INFO - PROCESS | 25745 | |4;prototype.html;275.91032914302855;276.22381109083466;278.309791716543;293.26244495094835;302.7698948798913;4831.444383895853;4923.498333008435;4935.629827762914;4940;4941.975290123544;4876.780544875481;4877.561019508244;4883.584895283905;4884.267359896017;4888.462269150391;3570.3394871948644;3683.8158092095423;3686.944695829565;3805.181885894532;3844.4041173617993;3783.829727662262;3804.391297392418;3817.5991520890325;3828;3833.4058220975794;3561.857525698969;3777.376732839092;3780.924381512368;3787.428217289835;3798.4682144499793;3659.2315613721153;3740.1584643455003;3759.6052414496357;3770.924581508382;3774.6602805747616;3304.6695330467;3306.718928891047;3323.152596087982;3332.950120711968;3341.198112453018;4739.336492890998;4743.173878056973;4746.572808447257;4749.572538471554;4760.785764640565;4233.872983810491;4310.784460776948;4333.414988976479;4343.457067866517;4354.194474022316;5023.422306434733;5032.899342013139;5056.974715126437;5067.592893375654;5074.238864170404;3645.1069487975615;3645.398509245971;3650.5254316938626;3653.6894363978827;3653.8173091345593;5152.248235599914;5330.493603107699;5334.51989320963;5341.946580534183;5345.866353341159;3736.4955730976512;3749.418840079792;3754.831032603485;3765.9623403765613;3767.1335592813807;3794.5446546414055;3802.5550290889837;3804.163084121544;3811.237752449466;3822.140018495872;4320.854973432043;4325.41606883073;4333.371661109121;4339.7613131278085;4375.78121093944;4983;5095.770690318945;5105;5117.923231151536;5120.846374608767;1310.5675127207999;1310.652677040585;1312.5471712259255;1327.5287273018132;1327.7809161488246;802.4944285100349;821.5235163605095;825.4098319701322;829.0010537302536;840.8192238668715;4336.219480493478;4420.624246938982;4529.886752831139;4549.954500454953;4554.795034223468;5192.039472697563;5229.189475631283;5234.555062819627;5296.09966305729;5298.682079075191;4386.736795792199;4494.280915053641;4497.460304763449;4527.569880861313;4563.429571303587;2752.545829938078;2803.2851622836047;2811.2550174203852;2820.5205115130475;2826.307554649083;4956.5786908112495;4973.651844370932;4975.427825800007;4976.154053810861;4993.725345106054;5145.434002259748;5333.946660533423;5350.170723537858;5475.917861232085;5481.123020316731;5050.873728156826;5055.848324550269;5061.468545802712;5065.6200784941275;5076.74616269185;5336.813211537577;5347.27811745425;5351.6788992659;5353.571714262927;5354.196870469461;5115.386153661584;5179.637425380187;5237.790488380422;5247.08176069194;5251.238570407346;5012.4736902626155;5042.596592272536;5043.420006699276;5050.903874891878;5051.924221136759;3713.2759111972905;3721.1627383839505;3738.0841693785196;3739.691108112139;3740.495033170596;5137.743112844418;5309.442508536548;5339.9466005341;5348.438413966477;5361.463853614608;5152.587792976478;5174.586033117417;5178.97410512945;5181.663191892666;5195.3246078009615;5108.795648174031;5127.692338459704;5132.332796736549;5138.768755405941;5141.2288156776785;4796.944672172117;4807.927881081717;4991.226359914219;4992.925106123484;5012.072766538202;5040;5139.768710407966;5175.6192151609175;5186.507281808223;5188.351456067991;5039.470855560114;5043.646944713835;5056.696598204119;5062.82280120194;5066.670666406671 16:16:40 INFO - PROCESS | 25745 | |5;yui.html;591.7277455670144;651.1144843013503;671.362205904391;672.3343889549346;674.6053558668178;12301;13390;13415.12801667891;13808.792868106986;14361.066530675498;13899.096558723675;14083.647908802284;14087.084339517949;14094;14425.927870360634;616.0974172836793;757.9962100189491;769.6536558548662;786.2648423723837;793.9761807145795;787.6022608582658;790.2887401338784;792.1484404265409;793.4128744728888;793.6269953122023;830.8421399934024;832.0431503770652;832.1304237072274;832.4672209785742;833.3333333333339;643.768243432364;665.9267480577132;666.8666266746621;668.151447661472;826.6238861318086;575.1660092865362;593.6467801658007;596.6300893446048;597.2713289786496;597.7071235094772;13236.338183090904;13279.070465067449;13298.933505332509;13305.334733263298;13306.600801975956;11543.769124617545;12047.638570842888;12054.397280136045;12115.333656648882;12203.755924881452;10852.403117828517;10987.725306867313;11084.445777711082;11302.152338574557;11579.957803797615;3229.193494066625;3260.5924259467565;3309.5366648669205;3354.681305275995;3425.520427140202;58484.70757646184;60131.39868601302;60274.698626506586;60347.69826150885;60430;9719.465429401309;9931.205503559699;9962.501874906226;10128.696139115838;10220.335678180894;18289.359872404402;18325.816741832678;18499.445016649253;18523.259069637334;18555.25778968853;6569.24453687832;6599.439047681001;6744.5616034957575;6853.383195512428;6893.138357705287;3397.507361432628;3450.6721861423125;3460.4463285874644;3500.6149323574386;3595.9212236328995;2678.1831541380066;2761.9447611047667;2774.6809116951404;2775.7779377650145;2791.3161275487637;471.40838247998545;482.4307317365542;527.6201135182662;537.0226188337267;558.9189567512688;450.072849929147;514.0797971630814;514.1131548079533;546.7285108062828;546.8414159893587;8024.235406851421;8781.736547903573;8866.822663546693;9002.369834111549;9168.495732734631;496.3696105945501;501.91073939899974;516.9741512924339;582.7028215610069;585.771549095853;3672.8347224374966;4359.629431498295;4369.12617476506;4433.467983841895;4514.819407223675;58409.70795145997;58711.11933321004;100990;101445.49277253714;106304;51624.48375516272;53118;75927.62036189894;85967;86099;48855.26717099246;64157.679211604576;64783.67608162023;65622.34377656257;69649;7884.487508311941;8200.83598328042;8362.247397734232;8439.282660973886;8532.445391049561;45302;45404.77297613491;45823.31265031094;46446.30330544977;47260.527394725614;57503.42496574981;57568.71215643895;61579.692101541;66268.6686566564;66570.33429665834;9618.567164477476;9812.411255324703;9912.207023437963;10010.04904534068;10386.740331491774;12198.695032624255;12694.619161425171;12937.159084659466;12968.221906685629;13210.697325668583;11296.322220666787;11614.883851161718;11878.703032423913;11947.701307467036;12357.505699771908;11822.172447928562;11885.940570297093;11917.52329906794;12033.63899083029;12282.447289871798;11550;11601.593944211912;11933.940330298294;12411.131220814455;12432.81350779721;9283.257339412965;9702;9776.951115244377;10005.799884002134;10216.744581385525;9122.77193070152;9624.085711857362;9812.85280720804;9824.557894894604;9940.30417870771 16:16:40 INFO - PROCESS | 25745 | __end_tp_report 16:16:40 INFO - PROCESS | 25745 | __start_cc_report 16:16:40 INFO - PROCESS | 25745 | _x_x_mozilla_cycle_collect,1067 16:16:40 INFO - PROCESS | 25745 | __end_cc_report 16:16:40 INFO - PROCESS | 25745 | __startTimestamp1468711000570__endTimestamp 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | ------- Summary: start ------- 16:16:40 INFO - PROCESS | 25745 | Number of tests: 6 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | [#0] dojo.html Cycles:165 Average:4734.09 Median:4868.83 stddev:610.05 (12.5%) stddev-sans-first:589.83 16:16:40 INFO - PROCESS | 25745 | Values: 2660.3 2677.1 2706.2 2708.1 2716.9 4715.2 4781.9 4823.4 4829.4 4924.7 4817.5 4838.0 4844.5 4847.1 4867.4 4377.2 4391.5 4424.7 4429.4 4477.9 139.0 4441.8 4477.2 4480.0 4503.7 4326.4 4463.1 4481.2 4499.4 4512.4 4435.9 4440.0 4443.8 4455.3 4488.3 4280.7 4417.1 4428.6 4445.9 4467.1 4711.4 4713.2 4765.9 4766.5 4767.5 5126.7 5145.3 5147.9 5151.5 5151.6 5041.8 5126.9 5128.4 5171.5 5173.2 4762.6 4795.8 4806.7 4812.1 4821.5 5307.6 5373.0 5373.5 5373.9 5377.0 4993.5 5018.5 5134.7 5147.4 5150.3 5114.5 5195.8 5215.7 5218.0 5219.0 5112.6 5128.5 5142.0 5142.3 5143.3 4901.4 5063.1 5083.7 5119.5 5170.0 4382.3 4401.7 4436.5 4442.6 4443.8 3824.9 3843.3 3854.8 3866.7 3887.8 4380.9 4415.1 4422.1 4432.6 4510.5 5127.6 5246.2 5256.4 5262.0 5283.9 4469.2 4470.0 4472.1 4484.7 4506.9 4480.0 4690.1 4693.7 4703.5 4752.6 4690.7 4792.9 4800.8 4820.0 4899.4 5163.7 5166.0 5167.6 5173.6 5210.7 4839.6 4864.7 4868.8 4877.3 4901.3 4872.5 4977.3 5034.1 5045.7 5085.3 5105.2 5105.5 5107.2 5111.9 5158.1 4932.0 4966.3 4971.3 4980.6 4981.5 4854.2 4921.6 4996.5 5000.7 5044.8 4864.8 4883.5 4886.6 4900.6 4947.1 4899.8 5051.0 5055.3 5059.3 5092.5 4933.3 4939.6 4950.2 4960.4 4975.0 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | [#1] ext.html Cycles:180 Average:50470.98 Median:36814.97 stddev:93524.70 (254.0%) stddev-sans-first:93711.92 16:16:40 INFO - PROCESS | 25745 | Values: 539.1 543.6 547.6 574.2 581.5 26769.5 39397.0 41241.8 41303.8 45206.0 39779.0 40110.2 40198.8 40216.4 40247.8 7465.6 7915.6 8046.2 8048.9 8056.3 7505.0 7744.0 7744.0 10030.7 10324.1 10230.5 10281.0 10285.5 10294.1 10305.8 10204.7 10288.9 10298.1 10305.5 10320.2 7503.7 9938.8 10328.2 10346.6 10657.9 39224.4 39561.4 39579.0 39603.2 39645.4 2273.5 2943.0 2953.7 2985.0 3008.4 25148.4 30044.2 30542.0 30588.2 31359.2 3302.0 3332.9 3359.9 3383.0 3429.3 291219.0 295650.0 295868.0 408426.0 409009.0 54810.0 55243.9 55288.0 55470.4 55646.7 41916.2 58242.1 59767.8 59814.4 60229.7 13915.8 14065.0 14069.6 14071.9 14078.7 8941.5 9722.6 9783.6 9785.2 9787.7 17902.5 18261.9 18600.6 18764.9 19222.9 6799.6 6903.5 6915.2 6985.9 7163.5 721.1 787.5 872.4 905.9 971.7 27446.0 28553.3 28713.4 28772.6 29188.6 905.8 906.7 937.0 948.1 993.9 14598.2 14965.8 15018.8 15236.5 15301.8 385130.0 389985.0 393507.0 394857.0 396661.0 44085.3 44092.6 44158.6 44222.6 44254.3 905.7 1059.2 1148.9 1150.6 1213.8 28549.4 29230.1 29556.0 29818.6 30287.4 42764.8 43064.4 43483.6 43510.8 43513.0 322918.0 323453.0 325101.0 326347.0 326447.0 20999.9 24761.0 25293.4 25394.0 27049.7 41239.6 41472.0 41785.2 42304.6 43153.8 35628.3 36968.6 37307.0 37360.8 37496.4 36308.5 36751.9 36878.0 37039.4 37221.6 35500.8 36085.8 36105.0 36311.1 36314.3 32389.3 32464.7 32795.8 32967.2 33028.0 25053.7 25169.1 25195.9 25568.5 25856.7 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | [#2] jquery.html Cycles:180 Average:24333.51 Median:5961.40 stddev:66612.05 (1117.4%) stddev-sans-first:66774.58 16:16:40 INFO - PROCESS | 25745 | Values: 354.0 371.9 379.0 381.6 390.0 13092.7 15512.9 15943.6 16173.8 16871.0 14807.9 14910.4 15100.8 15391.7 15510.3 5152.5 5343.8 5371.2 5640.3 6208.4 6223.6 6237.9 6238.3 6264.5 6307.0 5954.9 6179.2 6184.7 6192.1 6212.0 5967.9 6156.1 6171.6 6174.2 6175.4 5424.8 5457.3 5459.6 5461.4 5463.7 20385.0 20664.7 20766.6 20992.9 21075.8 1901.4 1975.8 1999.0 2032.4 2070.7 6245.6 6266.4 6284.4 6731.6 7429.7 1596.8 1669.9 1763.4 1820.9 1826.9 67041.7 68654.7 69636.3 70640.3 71055.3 8511.5 9177.5 9357.2 9556.3 10222.0 12280.6 13086.7 13090.5 13576.2 13645.4 7015.0 7157.9 7177.2 7310.2 7316.2 6791.2 6853.3 6854.8 6949.9 6962.3 6132.3 6243.7 6246.2 6282.2 6346.4 1761.2 1791.0 1824.8 1842.1 1859.6 858.5 860.4 891.4 957.8 969.8 16630.5 17001.8 17553.6 17810.6 17882.8 874.8 886.7 911.5 954.7 976.5 9535.0 10050.6 10129.5 10136.3 10208.9 396582.0 405315.0 407170.0 407457.0 407753.0 64993.4 66501.7 67145.3 67806.7 67858.7 880.3 883.2 901.6 904.5 907.6 14553.7 14870.4 16170.9 16383.9 17027.5 37712.8 37798.8 38675.6 39146.6 39663.4 49890.3 51623.0 52429.7 52527.5 53545.0 7163.1 7218.9 7317.9 7348.2 7441.1 8838.6 10770.8 10796.3 10872.9 11166.7 9225.0 9478.4 9562.6 9613.5 10105.0 9273.7 9322.9 9530.7 9822.0 10002.5 5173.3 6496.5 7935.7 9238.5 9979.8 6533.1 7156.7 7213.0 7231.8 7603.1 9090.6 10250.6 10263.6 10431.9 10838.5 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | [#3] mootools.html Cycles:180 Average:5321.44 Median:4644.20 stddev:3086.23 (66.5%) stddev-sans-first:3078.61 16:16:40 INFO - PROCESS | 25745 | Values: 1104.0 1288.4 1334.1 1406.9 1710.8 6944.0 7627.8 7871.1 7894.0 8136.5 7806.1 7944.3 7959.9 7960.6 7960.7 1893.6 2087.3 2111.9 2145.5 2221.8 2244.4 2263.2 2267.9 2268.8 2272.0 2204.8 2230.7 2230.8 2233.9 2234.9 1842.2 2112.1 2160.1 2182.4 2188.6 2189.2 2207.3 2210.3 2212.2 2212.7 8195.1 8225.9 8257.1 8258.7 8268.3 4355.7 4489.7 4496.5 4498.1 4500.7 2713.2 2863.9 2875.9 2882.9 2900.3 828.7 831.5 837.4 865.8 871.2 11251.2 11326.0 11330.0 11344.5 11366.8 4029.7 4089.1 4238.9 4243.4 4266.0 9593.7 9599.7 9606.0 9619.6 9639.1 4492.1 4514.6 4517.1 4517.6 4521.1 3535.5 3993.8 4141.5 4146.1 4205.3 3743.5 3796.5 3842.1 3891.3 3902.2 1086.4 1182.0 1226.7 1227.8 1232.2 731.1 755.8 756.9 770.1 778.5 5021.4 5026.4 5090.8 5110.1 5131.8 823.4 843.7 873.5 879.2 905.4 4026.7 4165.2 4173.0 4235.9 4238.3 10196.0 10365.6 10400.9 10476.1 10503.3 9591.8 10344.9 10347.2 10361.4 10396.5 7312.3 7630.5 7683.6 7696.2 7702.8 5544.4 5838.3 5841.6 5876.6 5936.5 9424.4 9512.6 9514.0 9519.7 9536.3 9492.3 9509.5 9669.0 9770.0 9827.6 7096.4 7184.6 7222.5 7223.3 7227.9 7441.9 7520.5 7522.8 7528.4 7536.7 6809.9 7062.8 7069.5 7154.8 7292.0 6976.1 6987.3 6994.9 7070.3 7076.5 6536.0 6579.2 6582.0 6584.9 6592.9 4493.4 4551.2 4580.1 4619.0 4623.2 4528.8 4605.4 4665.2 4723.2 4783.4 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | [#4] prototype.html Cycles:180 Average:4252.23 Median:4883.93 stddev:1246.27 (25.5%) stddev-sans-first:1213.50 16:16:40 INFO - PROCESS | 25745 | Values: 275.9 276.2 278.3 293.3 302.8 4831.4 4923.5 4935.6 4940.0 4942.0 4876.8 4877.6 4883.6 4884.3 4888.5 3570.3 3683.8 3686.9 3805.2 3844.4 3783.8 3804.4 3817.6 3828.0 3833.4 3561.9 3777.4 3780.9 3787.4 3798.5 3659.2 3740.2 3759.6 3770.9 3774.7 3304.7 3306.7 3323.2 3333.0 3341.2 4739.3 4743.2 4746.6 4749.6 4760.8 4233.9 4310.8 4333.4 4343.5 4354.2 5023.4 5032.9 5057.0 5067.6 5074.2 3645.1 3645.4 3650.5 3653.7 3653.8 5152.2 5330.5 5334.5 5341.9 5345.9 3736.5 3749.4 3754.8 3766.0 3767.1 3794.5 3802.6 3804.2 3811.2 3822.1 4320.9 4325.4 4333.4 4339.8 4375.8 4983.0 5095.8 5105.0 5117.9 5120.8 1310.6 1310.7 1312.5 1327.5 1327.8 802.5 821.5 825.4 829.0 840.8 4336.2 4420.6 4529.9 4550.0 4554.8 5192.0 5229.2 5234.6 5296.1 5298.7 4386.7 4494.3 4497.5 4527.6 4563.4 2752.5 2803.3 2811.3 2820.5 2826.3 4956.6 4973.7 4975.4 4976.2 4993.7 5145.4 5333.9 5350.2 5475.9 5481.1 5050.9 5055.8 5061.5 5065.6 5076.7 5336.8 5347.3 5351.7 5353.6 5354.2 5115.4 5179.6 5237.8 5247.1 5251.2 5012.5 5042.6 5043.4 5050.9 5051.9 3713.3 3721.2 3738.1 3739.7 3740.5 5137.7 5309.4 5339.9 5348.4 5361.5 5152.6 5174.6 5179.0 5181.7 5195.3 5108.8 5127.7 5132.3 5138.8 5141.2 4796.9 4807.9 4991.2 4992.9 5012.1 5040.0 5139.8 5175.6 5186.5 5188.4 5039.5 5043.6 5056.7 5062.8 5066.7 16:16:40 INFO - PROCESS | 25745 | 16:16:40 INFO - PROCESS | 25745 | [#5] yui.html Cycles:180 Average:16670.62 Median:514.10 stddev:22951.27 (4464.4%) stddev-sans-first:22983.90 16:16:40 INFO - PROCESS | 25745 | Values: 591.7 651.1 671.4 672.3 674.6 12301.0 13390.0 13415.1 13808.8 14361.1 13899.1 14083.6 14087.1 14094.0 14425.9 616.1 758.0 769.7 786.3 794.0 787.6 790.3 792.1 793.4 793.6 830.8 832.0 832.1 832.5 833.3 643.8 665.9 666.9 668.2 826.6 575.2 593.6 596.6 597.3 597.7 13236.3 13279.1 13298.9 13305.3 13306.6 11543.8 12047.6 12054.4 12115.3 12203.8 10852.4 10987.7 11084.4 11302.2 11580.0 3229.2 3260.6 3309.5 3354.7 3425.5 58484.7 60131.4 60274.7 60347.7 60430.0 9719.5 9931.2 9962.5 10128.7 10220.3 18289.4 18325.8 18499.4 18523.3 18555.3 6569.2 6599.4 6744.6 6853.4 6893.1 3397.5 3450.7 3460.4 3500.6 3595.9 2678.2 2761.9 2774.7 2775.8 2791.3 471.4 482.4 527.6 537.0 558.9 450.1 514.1 514.1 546.7 546.8 8024.2 8781.7 8866.8 9002.4 9168.5 496.4 501.9 517.0 582.7 585.8 3672.8 4359.6 4369.1 4433.5 4514.8 58409.7 58711.1 100990.0 101445.5 106304.0 51624.5 53118.0 75927.6 85967.0 86099.0 48855.3 64157.7 64783.7 65622.3 69649.0 7884.5 8200.8 8362.2 8439.3 8532.4 45302.0 45404.8 45823.3 46446.3 47260.5 57503.4 57568.7 61579.7 66268.7 66570.3 9618.6 9812.4 9912.2 10010.0 10386.7 12198.7 12694.6 12937.2 12968.2 13210.7 11296.3 11614.9 11878.7 11947.7 12357.5 11822.2 11885.9 11917.5 12033.6 12282.4 11550.0 11601.6 11933.9 12411.1 12432.8 9283.3 9702.0 9777.0 10005.8 10216.7 9122.8 9624.1 9812.9 9824.6 9940.3 16:16:40 INFO - PROCESS | 25745 | -------- Summary: end -------- 16:16:40 INFO - PROCESS | 25745 | 16:16:41 INFO - TEST-INFO | 25745: exit 0 16:16:41 INFO - TEST-OK | dromaeo_css | took 1118733ms 16:16:41 INFO - TEST-START | kraken 16:16:41 INFO - operating with platform_type : linux_ 16:16:41 INFO - Initialising browser for kraken test... 16:16:41 INFO - TEST-INFO | started process 25938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqCKOdo/profile http://localhost:57627/getInfo.html) 16:16:45 INFO - PROCESS | 25938 | __metrics Screen width/height:1600/1200 16:16:45 INFO - PROCESS | 25938 | colorDepth:24 16:16:45 INFO - PROCESS | 25938 | Browser inner width/height: 1024/697 16:16:45 INFO - PROCESS | 25938 | __metrics 16:16:46 INFO - PROCESS | 25938 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:16:46 INFO - PROCESS | 25938 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:47 INFO - TEST-INFO | 25938: exit 0 16:16:47 INFO - Browser initialized. 16:16:47 INFO - Running cycle 1/1 for kraken test... 16:16:47 INFO - TEST-INFO | started process 26023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqCKOdo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:58 INFO - PROCESS | 26023 | RSS: Main: 159522816 16:16:58 INFO - PROCESS | 26023 | 16:17:01 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57627/tests/kraken/driver.html?testName=audio-beat-detection) 16:17:02 INFO - PROCESS | 26023 | RSS: Main: 218423296 16:17:02 INFO - PROCESS | 26023 | 16:17:05 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57627/tests/kraken/driver.html?testName=audio-dft) 16:17:05 INFO - PROCESS | 26023 | RSS: Main: 206606336 16:17:05 INFO - PROCESS | 26023 | 16:17:09 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57627/tests/kraken/driver.html?testName=audio-fft) 16:17:09 INFO - PROCESS | 26023 | RSS: Main: 273059840 16:17:09 INFO - PROCESS | 26023 | 16:17:12 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57627/tests/kraken/driver.html?testName=audio-oscillator) 16:17:12 INFO - PROCESS | 26023 | RSS: Main: 182231040 16:17:12 INFO - PROCESS | 26023 | 16:17:14 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57627/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:17:15 INFO - PROCESS | 26023 | RSS: Main: 186327040 16:17:15 INFO - PROCESS | 26023 | 16:17:18 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57627/tests/kraken/driver.html?testName=imaging-darkroom) 16:17:19 INFO - PROCESS | 26023 | RSS: Main: 222572544 16:17:19 INFO - PROCESS | 26023 | 16:17:22 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57627/tests/kraken/driver.html?testName=imaging-desaturate) 16:17:23 INFO - PROCESS | 26023 | RSS: Main: 223252480 16:17:23 INFO - PROCESS | 26023 | 16:17:26 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57627/tests/kraken/driver.html?testName=json-parse-financial) 16:17:26 INFO - PROCESS | 26023 | RSS: Main: 222707712 16:17:26 INFO - PROCESS | 26023 | 16:17:28 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57627/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:17:29 INFO - PROCESS | 26023 | RSS: Main: 211902464 16:17:29 INFO - PROCESS | 26023 | 16:17:30 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:17:31 INFO - PROCESS | 26023 | RSS: Main: 215625728 16:17:31 INFO - PROCESS | 26023 | 16:17:33 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:17:34 INFO - PROCESS | 26023 | RSS: Main: 213012480 16:17:34 INFO - PROCESS | 26023 | 16:17:37 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:17:37 INFO - PROCESS | 26023 | RSS: Main: 224817152 16:17:37 INFO - PROCESS | 26023 | 16:17:40 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:17:41 INFO - PROCESS | 26023 | RSS: Main: 225697792 16:17:41 INFO - PROCESS | 26023 | 16:17:42 INFO - PROCESS | 26023 | Cycle 1(1): loaded http://localhost:57627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57627/tests/kraken/driver.html?testName=ai-astar) 16:17:43 INFO - PROCESS | 26023 | RSS: Main: 268345344 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | __start_tp_report 16:17:43 INFO - PROCESS | 26023 | _x_x_mozilla_page_load 16:17:43 INFO - PROCESS | 26023 | _x_x_mozilla_page_load_details 16:17:43 INFO - PROCESS | 26023 | |i|pagename|runs| 16:17:43 INFO - PROCESS | 26023 | |0;ai-astar;104;113;112;114;113;113;112;113;114;115 16:17:43 INFO - PROCESS | 26023 | |1;audio-beat-detection;153;129;131;180;123;124;145;124;156;121 16:17:43 INFO - PROCESS | 26023 | |2;audio-dft;161;160;161;161;163;161;161;162;163;162 16:17:43 INFO - PROCESS | 26023 | |3;audio-fft;76;76;76;109;76;77;77;76;111;75 16:17:43 INFO - PROCESS | 26023 | |4;audio-oscillator;84;86;132;85;85;85;122;85;84;117 16:17:43 INFO - PROCESS | 26023 | |5;imaging-gaussian-blur;117;116;116;116;117;116;117;117;117;117 16:17:43 INFO - PROCESS | 26023 | |6;imaging-darkroom;147;146;146;146;146;147;146;146;145;146 16:17:43 INFO - PROCESS | 26023 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 16:17:43 INFO - PROCESS | 26023 | |8;json-parse-financial;65;69;64;63;63;63;62;63;64;65 16:17:43 INFO - PROCESS | 26023 | |9;json-stringify-tinderbox;66;66;65;65;66;65;65;66;67;67 16:17:43 INFO - PROCESS | 26023 | |10;stanford-crypto-aes;79;80;78;79;80;80;78;80;88;82 16:17:43 INFO - PROCESS | 26023 | |11;stanford-crypto-ccm;128;127;137;135;134;128;128;133;170;130 16:17:43 INFO - PROCESS | 26023 | |12;stanford-crypto-pbkdf2;166;165;169;165;169;166;166;167;174;166 16:17:43 INFO - PROCESS | 26023 | |13;stanford-crypto-sha256-iterative;68;66;67;67;71;65;65;66;65;66 16:17:43 INFO - PROCESS | 26023 | __end_tp_report 16:17:43 INFO - PROCESS | 26023 | __start_cc_report 16:17:43 INFO - PROCESS | 26023 | _x_x_mozilla_cycle_collect,1914 16:17:43 INFO - PROCESS | 26023 | __end_cc_report 16:17:43 INFO - PROCESS | 26023 | __startTimestamp1468711063194__endTimestamp 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | ------- Summary: start ------- 16:17:43 INFO - PROCESS | 26023 | Number of tests: 14 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:0.97 16:17:43 INFO - PROCESS | 26023 | Values: 104.0 113.0 112.0 114.0 113.0 113.0 112.0 113.0 114.0 115.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:138.00 stddev:19.42 (14.1%) stddev-sans-first:19.89 16:17:43 INFO - PROCESS | 26023 | Values: 153.0 129.0 131.0 180.0 123.0 124.0 145.0 124.0 156.0 121.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 16:17:43 INFO - PROCESS | 26023 | Values: 161.0 160.0 161.0 161.0 163.0 161.0 161.0 162.0 163.0 162.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:14.30 (18.8%) stddev-sans-first:14.95 16:17:43 INFO - PROCESS | 26023 | Values: 76.0 76.0 76.0 109.0 76.0 77.0 77.0 76.0 111.0 75.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:19.10 (22.5%) stddev-sans-first:19.71 16:17:43 INFO - PROCESS | 26023 | Values: 84.0 86.0 132.0 85.0 85.0 85.0 122.0 85.0 84.0 117.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:17:43 INFO - PROCESS | 26023 | Values: 117.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 16:17:43 INFO - PROCESS | 26023 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:17:43 INFO - PROCESS | 26023 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.97 (3.1%) stddev-sans-first:2.06 16:17:43 INFO - PROCESS | 26023 | Values: 65.0 69.0 64.0 63.0 63.0 63.0 62.0 63.0 64.0 65.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 16:17:43 INFO - PROCESS | 26023 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 65.0 66.0 67.0 67.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.91 (3.6%) stddev-sans-first:3.05 16:17:43 INFO - PROCESS | 26023 | Values: 79.0 80.0 78.0 79.0 80.0 80.0 78.0 80.0 88.0 82.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:133.50 stddev:12.78 (9.6%) stddev-sans-first:13.30 16:17:43 INFO - PROCESS | 26023 | Values: 128.0 127.0 137.0 135.0 134.0 128.0 128.0 133.0 170.0 130.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:166.50 stddev:2.75 (1.7%) stddev-sans-first:2.88 16:17:43 INFO - PROCESS | 26023 | Values: 166.0 165.0 169.0 165.0 169.0 166.0 166.0 167.0 174.0 166.0 16:17:43 INFO - PROCESS | 26023 | 16:17:43 INFO - PROCESS | 26023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.84 (2.8%) stddev-sans-first:1.88 16:17:43 INFO - PROCESS | 26023 | Values: 68.0 66.0 67.0 67.0 71.0 65.0 65.0 66.0 65.0 66.0 16:17:43 INFO - PROCESS | 26023 | -------- Summary: end -------- 16:17:43 INFO - PROCESS | 26023 | 16:17:44 INFO - TEST-INFO | 26023: exit 0 16:17:44 INFO - TEST-OK | kraken | took 62926ms 16:17:44 INFO - SUITE-END | took 1181s 16:17:44 INFO - Completed test suite (00:19:41) 16:17:44 INFO - javascript benchmark 16:17:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.3083198368427, 2677.143314139476, 2706.2151975926977, 2708.0521817363924, 2716.891324347026, 4715.198416269234, 4781.90436191276, 4823.421189457261, 4829.372181616393, 4924.655274130808, 4817.470078291394, 4837.951620483794, 4844.467108618058, 4847.07905497956, 4867.4159100907855, 4377.190219809329, 4391.516933137353, 4424.734515929046, 4429.357743127244, 4477.888052798674, 139.01446746922608, 4441.822327106912, 4477.238869392211, 4480.0367920897, 4503.707259028169, 4326.351047342892, 4463.085067561175, 4481.215787237221, 4499.370088187657, 4512.435945506812, 4435.911281774379, 4440.045390241114, 4443.844465443726, 4455.287154055336, 4488.326750987346, 4280.657547396201, 4417.116576684643, 4428.579284967923, 4445.888852778707, 4467.084247729208, 4711.363965864599, 4713.198756211452, 4765.928511072302, 4766.451858036336, 4767.451743049559, 5126.6667666601925, 5145.30538377318, 5147.948520514784, 5151.484851514856, 5151.6136289778415, 5041.8487445376695, 5126.897462050775, 5128.358955130609, 5171.456997015334, 5173.249878767595, 4762.57136857681, 4795.760211989456, 4806.663533552618, 4812.133815913169, 4821.493743156988, 5307.6019298552765, 5373.032854086302, 5373.516383525502, 5373.865653358619, 5376.973115134478, 4993.525615066563, 5018.4981501849525, 5134.717590532557, 5147.433782283946, 5150.304708864255, 5114.4629813869005, 5195.844124676266, 5215.687058776485, 5218.034663587248, 5219.034478621467, 5112.642115051911, 5128.538431541179, 5142.0, 5142.331496905378, 5143.27994080829, 4901.411830580353, 5063.088644044034, 5083.72039537829, 5119.48805119485, 5170.0, 4382.320740285261, 4401.735895846259, 4436.467623885154, 4442.577955094261, 4443.822247110144, 3824.9235015299537, 3843.3082045231567, 3854.807259637007, 3866.6906647468136, 3887.7667339959694, 4380.890477738082, 4415.116976604692, 4422.115576884636, 4432.645388368923, 4510.50384457716, 5127.6154288428515, 5246.23929530216, 5256.448072952361, 5261.973690131601, 5283.894322113536, 4469.150861336336, 4470.038941627566, 4472.0608672179205, 4484.708493947883, 4506.864794056183, 4480.036792089716, 4690.108879312919, 4693.6949098308505, 4703.529647035269, 4752.643551733565, 4690.695104818176, 4792.928106078341, 4800.783964721526, 4819.975900120477, 4899.387576552931, 5163.741812909415, 5166.044281807877, 5167.61242906776, 5173.560247379015, 5210.739463026757, 4839.611712539414, 4864.73243971585, 4868.829590964299, 4877.268409738425, 4901.264810278487, 4872.488388719134, 4977.328060711758, 5034.0686972910125, 5045.672031317952, 5085.313482679939, 5105.157648987875, 5105.4639262878345, 5107.233914912793, 5111.897762044664, 5158.123119069692, 4932.0, 4966.304717339503, 4971.254311853251, 4980.626453016111, 4981.4769449207315, 4854.150523658416, 4921.6062714982, 4996.475370086088, 5000.699958002531, 5044.798208071636, 4864.8054077837905, 4883.487233840396, 4886.609071274361, 4900.558949694545, 4947.134251506044, 4899.804007839789, 5051.040302342543, 5055.266986286894, 5059.291699162047, 5092.516210959953, 4933.309336692938, 4939.604831613534, 4950.232713929347, 4960.379952505937, 4974.9751251243515], "value": 4698.473088464906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.0674133748615, 543.5570010441489, 547.5619504396483, 574.1703238819904, 581.4708615160205, 26769.464610707775, 39397.0, 41241.79379103108, 41303.79348103259, 45206.0, 39779.0, 40110.19779604406, 40198.79900600493, 40216.396754048714, 40247.798761006154, 7465.6267186640725, 7915.643796029178, 8046.195380461965, 8048.919510804875, 8056.315213206884, 7505.0, 7743.961280193591, 7744.0319960005, 10030.699079027641, 10324.070833624972, 10230.488475576229, 10281.0, 10285.537150828231, 10294.073533381994, 10305.84541231882, 10204.693859184199, 10288.948555257175, 10298.073173414354, 10305.536250868654, 10320.225983051227, 7503.737369192052, 9938.80122397548, 10328.225383096224, 10346.586136554528, 10657.946710266477, 39224.41163382552, 39561.40657890134, 39579.0, 39603.20793584141, 39645.40531892024, 2273.45437095096, 2942.955855662167, 2953.689862564421, 2985.0, 3008.413359394897, 25148.371290717696, 30044.24889377761, 30542.0, 30588.235294117603, 31359.216019599466, 3301.96698033019, 3332.9333413331597, 3359.9496007559906, 3383.0, 3429.296994116225, 291219.0, 295650.0, 295868.0, 408426.0, 409009.0, 54810.0, 55243.89512209733, 55288.0, 55470.44529554733, 55646.72176639091, 41916.16167676629, 58242.126368103665, 59767.827860657, 59814.401855981756, 60229.69885150546, 13915.791263131061, 14065.0, 14069.648258793408, 14071.929640351938, 14078.71842563143, 8941.46351218929, 9722.562484688206, 9783.559739811726, 9785.217182625373, 9787.706368808947, 17902.46292611224, 18261.90869045646, 18600.627987440177, 18764.906175469307, 19222.903885480762, 6799.558028728117, 6903.482238832108, 6915.239323674392, 6985.930140698528, 7163.489889953885, 721.1239587218699, 787.4605894961969, 872.437277955715, 905.8731777551149, 971.6987733802544, 27446.0, 28553.286167845556, 28713.425731485255, 28772.568411473843, 29188.562171567442, 905.7961958559272, 906.7370462565782, 937.0442149007973, 948.1324588002038, 993.8608594796734, 14598.197099159648, 14965.804473893893, 15018.774718379233, 15236.46672366484, 15301.770473442908, 385130.0, 389985.0, 393507.0, 394857.0, 396661.0, 44085.33871991923, 44092.55907440885, 44158.58414158558, 44222.55777442249, 44254.336184957254, 905.7463910105181, 1059.1685526861377, 1148.942552872353, 1150.6317978247048, 1213.836132122152, 28549.42901142007, 29230.123096307147, 29556.0, 29818.55272170876, 30287.394252115275, 42764.78617606892, 43064.35403469013, 43483.56516434795, 43510.78244608756, 43513.0, 322918.0, 323453.0, 325101.0, 326347.0, 326447.0, 20999.8950005249, 24761.0, 25293.367665808502, 25394.0, 27049.729502704722, 41239.587604124776, 41472.0, 41785.1642967145, 42304.57695423006, 43153.784231078644, 35628.287434250655, 36968.63031369759, 37307.0, 37360.81319593385, 37496.43755343727, 36308.45537316995, 36751.94483116469, 36878.0, 37039.44440833336, 37221.627783721815, 35500.822495887354, 36085.81957090198, 36105.0, 36311.09222269464, 36314.27371452609, 32389.288879594424, 32464.675353246166, 32795.83602081974, 32967.17582060468, 33028.0, 25053.74946250587, 25169.119080832083, 25195.87402062978, 25568.488630227665, 25856.741432586186], "value": 17959.41186351727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9646035396459, 371.92375563009585, 378.9677877380423, 381.62028781362534, 389.99415008774855, 13092.73814523709, 15512.922435387822, 15943.601409964756, 16173.757393639075, 16871.0, 14807.851921480782, 14910.40358385666, 15100.79193664507, 15391.692166156698, 15510.30203640836, 5152.484751524846, 5343.812966546172, 5371.221172929942, 5640.323161220659, 6208.379162083801, 6223.626582405048, 6237.875242495147, 6238.313785483593, 6264.467520260783, 6307.022411526198, 5954.940450595482, 6179.19670442844, 6184.721687524072, 6192.071189321593, 6212.0, 5967.850803729898, 6156.138140660311, 6171.59884607499, 6174.166487524194, 6175.351588083254, 5424.83725488236, 5457.290552228224, 5459.645123066988, 5461.371942226655, 5463.672179669233, 20385.0, 20664.690029649566, 20766.5846683067, 20992.895035524725, 21075.789242107538, 1901.420066879601, 1975.8221760041665, 1999.0304702219412, 2032.3699653107583, 2070.6790447480666, 6245.6252624842655, 6266.404691554295, 6284.371562843725, 6731.629760363178, 7429.665665045086, 1596.8323326050713, 1669.8914570552874, 1763.3563749231566, 1820.945371638853, 1826.8855997841306, 67041.66479167574, 68654.65672671655, 69636.30363696399, 70640.2935970644, 71055.28944710539, 8511.53186574732, 9177.541122943827, 9357.20463760588, 9556.331056825955, 10222.0, 12280.570180043656, 13086.672833179247, 13090.476380944656, 13576.1854288743, 13645.38595763193, 7015.0, 7157.89263161053, 7177.210506844243, 7310.195878453366, 7316.195218525958, 6791.151106111736, 6853.314668533107, 6854.760083397057, 6949.930500694928, 6962.303769623099, 6132.325444201134, 6243.656598887105, 6246.219222597176, 6282.1519094921605, 6346.365363463617, 1761.2426656537812, 1790.9552261193573, 1824.7920016779844, 1842.0881663576615, 1859.6094820087662, 858.4891989266376, 860.3902555339154, 891.4383938119073, 957.8228027814877, 969.7963427680266, 16630.50108496747, 17001.80349408258, 17553.64892702139, 17810.643787124183, 17882.821171788117, 874.7725591346295, 886.7029545102463, 911.5487833522449, 954.6849539652037, 976.4580657735025, 9535.0, 10050.597976080875, 10129.493525323851, 10136.341137826017, 10208.948955255177, 396582.0, 405315.0, 407170.0, 407457.0, 407753.0, 64993.35006649873, 66501.6674916632, 67145.32854671488, 67806.66096669485, 67858.66070669614, 880.3033358086682, 883.1830556734994, 901.6213190459891, 904.5386852705168, 907.5734404829587, 14553.708925821213, 14870.405183792527, 16170.919145404197, 16383.918080409521, 17027.48917532476, 37712.81143594265, 37798.81100594479, 38675.6132438672, 39146.60853391544, 39663.40504892371, 49890.25164622606, 51623.0, 52429.7378513105, 52527.474725253785, 53545.0, 7163.140423149255, 7218.89171662415, 7317.86573081152, 7348.228436014356, 7441.144268409203, 8838.646454141763, 10770.838437423601, 10796.298240614335, 10872.891271087505, 11166.665000050012, 9225.016621426426, 9478.38390504615, 9562.56968436436, 9613.471259080537, 10105.040021197974, 9273.67542136022, 9322.906770932204, 9530.666426675032, 9821.950890245504, 10002.549885255035, 5173.275741396283, 6496.512761542808, 7935.722249721232, 9238.491882946502, 9979.800403992025, 6533.085368048382, 7156.677949492181, 7212.963935180291, 7231.819204519718, 7603.1240559240305, 9090.59092340833, 10250.58997640116, 10263.58945642166, 10431.94784026075, 10838.458077096271], "value": 8152.208425193977, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1103.9668809935695, 1288.3686993373246, 1334.139480035377, 1406.9015168938172, 1710.8289171082886, 6943.965280173598, 7627.809304767384, 7871.134175240719, 7893.960530197348, 8136.511809291446, 7806.063272407305, 7944.324732397753, 7959.920400795991, 7960.6019699015105, 7960.7213747518845, 1893.5928775313305, 2087.27988843849, 2111.9049642766036, 2145.5065334972965, 2221.80003799658, 2244.36035729817, 2263.219189379661, 2267.875266860322, 2268.8298377621663, 2271.9772802272014, 2204.7795220477983, 2230.743464501587, 2230.7992280694734, 2233.8994745236505, 2234.899429525667, 1842.1802297977472, 2112.0601332407086, 2160.114353115223, 2182.432567532437, 2188.562287542498, 2189.189999700105, 2207.3267653365715, 2210.2706106984656, 2212.23677831148, 2212.745534263548, 8195.057568379652, 8225.917740822635, 8257.091719910804, 8258.669653213865, 8268.338532917352, 4355.651547876194, 4489.73061616304, 4496.4829044659955, 4498.055408364247, 4500.707454015511, 2713.1996061162004, 2863.914082577526, 2875.8993435229877, 2882.855857207131, 2900.274931267183, 828.7306625346787, 831.4512421801581, 837.4472847920343, 865.7965378136196, 871.172386233081, 11251.156163287786, 11326.03728683063, 11330.0, 11344.546218151347, 11366.829497557543, 4029.6977726670616, 4089.141280331104, 4238.894027649333, 4243.3634954757035, 4265.957340426618, 9593.664221752206, 9599.664011759694, 9606.0, 9619.615215391446, 9639.084286992724, 4492.101579684077, 4514.616257618073, 4517.073999830027, 4517.6160026397465, 4521.11838191556, 3535.4873543336585, 3993.7803420812133, 4141.544430112685, 4146.108586653884, 4205.306124489486, 3743.5025989603832, 3796.487474190949, 3842.1355195080882, 3891.3384724596885, 3902.180542086137, 1086.4187659602233, 1181.9704507387212, 1226.6565361698738, 1227.846519185102, 1232.1682864066897, 731.0824914732084, 755.8412733326063, 756.8675481790665, 770.1451388958252, 778.5367706214793, 5021.397432308073, 5026.447090820006, 5090.796368145307, 5110.105731497048, 5131.846044618667, 823.4135863241686, 843.7426584891667, 873.4802792338548, 879.2043200903065, 905.4250550900226, 4026.697997650188, 4165.187788381297, 4173.0, 4235.9364609530885, 4238.258304796648, 10196.0, 10365.585376584851, 10400.947995259976, 10476.109530689824, 10503.264771465923, 9591.808163836684, 10344.948275258726, 10347.172226221885, 10361.378317300987, 10396.532156052996, 7312.268773122645, 7630.542167469858, 7683.615819209017, 7696.191899850547, 7702.807429814187, 5544.445555444423, 5838.2702162229725, 5841.649501029951, 5876.588638795243, 5936.525077993664, 9424.434533927986, 9512.571934263113, 9513.952430237805, 9519.666811661558, 9536.332456727963, 9492.335536512377, 9509.476978766234, 9669.0, 9769.951150244204, 9827.55775990068, 7096.396806271525, 7184.568925864465, 7222.530535515175, 7223.313785190398, 7227.8554428912175, 7441.851162976818, 7520.473566850268, 7522.849543009219, 7528.360089392463, 7536.736214232695, 6809.863802724017, 7062.752803651848, 7069.469789765891, 7154.821129471805, 7292.0, 6976.058232138799, 6987.301269872972, 6994.9300506996315, 7070.328318809705, 7076.540024898365, 6535.967320163559, 6579.243387010363, 6582.0, 6584.934150658432, 6592.90110648331, 4493.415855938707, 4551.226291530514, 4580.106879158532, 4618.953810461852, 4623.214053610962, 4528.750918699503, 4605.447346318463, 4665.183592871302, 4723.173444647105, 4783.378160839208], "value": 4212.804044192619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.91032914302855, 276.22381109083466, 278.309791716543, 293.26244495094835, 302.7698948798913, 4831.444383895853, 4923.498333008435, 4935.629827762914, 4940.0, 4941.975290123544, 4876.780544875481, 4877.561019508244, 4883.584895283905, 4884.267359896017, 4888.462269150391, 3570.3394871948644, 3683.8158092095423, 3686.944695829565, 3805.181885894532, 3844.4041173617993, 3783.829727662262, 3804.391297392418, 3817.5991520890325, 3828.0, 3833.4058220975794, 3561.857525698969, 3777.376732839092, 3780.924381512368, 3787.428217289835, 3798.4682144499793, 3659.2315613721153, 3740.1584643455003, 3759.6052414496357, 3770.924581508382, 3774.6602805747616, 3304.6695330467, 3306.718928891047, 3323.152596087982, 3332.950120711968, 3341.198112453018, 4739.336492890998, 4743.173878056973, 4746.572808447257, 4749.572538471554, 4760.785764640565, 4233.872983810491, 4310.784460776948, 4333.414988976479, 4343.457067866517, 4354.194474022316, 5023.422306434733, 5032.899342013139, 5056.974715126437, 5067.592893375654, 5074.238864170404, 3645.1069487975615, 3645.398509245971, 3650.5254316938626, 3653.6894363978827, 3653.8173091345593, 5152.248235599914, 5330.493603107699, 5334.51989320963, 5341.946580534183, 5345.866353341159, 3736.4955730976512, 3749.418840079792, 3754.831032603485, 3765.9623403765613, 3767.1335592813807, 3794.5446546414055, 3802.5550290889837, 3804.163084121544, 3811.237752449466, 3822.140018495872, 4320.854973432043, 4325.41606883073, 4333.371661109121, 4339.7613131278085, 4375.78121093944, 4983.0, 5095.770690318945, 5105.0, 5117.923231151536, 5120.846374608767, 1310.5675127207999, 1310.652677040585, 1312.5471712259255, 1327.5287273018132, 1327.7809161488246, 802.4944285100349, 821.5235163605095, 825.4098319701322, 829.0010537302536, 840.8192238668715, 4336.219480493478, 4420.624246938982, 4529.886752831139, 4549.954500454953, 4554.795034223468, 5192.039472697563, 5229.189475631283, 5234.555062819627, 5296.09966305729, 5298.682079075191, 4386.736795792199, 4494.280915053641, 4497.460304763449, 4527.569880861313, 4563.429571303587, 2752.545829938078, 2803.2851622836047, 2811.2550174203852, 2820.5205115130475, 2826.307554649083, 4956.5786908112495, 4973.651844370932, 4975.427825800007, 4976.154053810861, 4993.725345106054, 5145.434002259748, 5333.946660533423, 5350.170723537858, 5475.917861232085, 5481.123020316731, 5050.873728156826, 5055.848324550269, 5061.468545802712, 5065.6200784941275, 5076.74616269185, 5336.813211537577, 5347.27811745425, 5351.6788992659, 5353.571714262927, 5354.196870469461, 5115.386153661584, 5179.637425380187, 5237.790488380422, 5247.08176069194, 5251.238570407346, 5012.4736902626155, 5042.596592272536, 5043.420006699276, 5050.903874891878, 5051.924221136759, 3713.2759111972905, 3721.1627383839505, 3738.0841693785196, 3739.691108112139, 3740.495033170596, 5137.743112844418, 5309.442508536548, 5339.9466005341, 5348.438413966477, 5361.463853614608, 5152.587792976478, 5174.586033117417, 5178.97410512945, 5181.663191892666, 5195.3246078009615, 5108.795648174031, 5127.692338459704, 5132.332796736549, 5138.768755405941, 5141.2288156776785, 4796.944672172117, 4807.927881081717, 4991.226359914219, 4992.925106123484, 5012.072766538202, 5040.0, 5139.768710407966, 5175.6192151609175, 5186.507281808223, 5188.351456067991, 5039.470855560114, 5043.646944713835, 5056.696598204119, 5062.82280120194, 5066.670666406671], "value": 3847.8723092725163, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7277455670144, 651.1144843013503, 671.362205904391, 672.3343889549346, 674.6053558668178, 12301.0, 13390.0, 13415.12801667891, 13808.792868106986, 14361.066530675498, 13899.096558723675, 14083.647908802284, 14087.084339517949, 14094.0, 14425.927870360634, 616.0974172836793, 757.9962100189491, 769.6536558548662, 786.2648423723837, 793.9761807145795, 787.6022608582658, 790.2887401338784, 792.1484404265409, 793.4128744728888, 793.6269953122023, 830.8421399934024, 832.0431503770652, 832.1304237072274, 832.4672209785742, 833.3333333333339, 643.768243432364, 665.9267480577132, 666.8666266746621, 668.151447661472, 826.6238861318086, 575.1660092865362, 593.6467801658007, 596.6300893446048, 597.2713289786496, 597.7071235094772, 13236.338183090904, 13279.070465067449, 13298.933505332509, 13305.334733263298, 13306.600801975956, 11543.769124617545, 12047.638570842888, 12054.397280136045, 12115.333656648882, 12203.755924881452, 10852.403117828517, 10987.725306867313, 11084.445777711082, 11302.152338574557, 11579.957803797615, 3229.193494066625, 3260.5924259467565, 3309.5366648669205, 3354.681305275995, 3425.520427140202, 58484.70757646184, 60131.39868601302, 60274.698626506586, 60347.69826150885, 60430.0, 9719.465429401309, 9931.205503559699, 9962.501874906226, 10128.696139115838, 10220.335678180894, 18289.359872404402, 18325.816741832678, 18499.445016649253, 18523.259069637334, 18555.25778968853, 6569.24453687832, 6599.439047681001, 6744.5616034957575, 6853.383195512428, 6893.138357705287, 3397.507361432628, 3450.6721861423125, 3460.4463285874644, 3500.6149323574386, 3595.9212236328995, 2678.1831541380066, 2761.9447611047667, 2774.6809116951404, 2775.7779377650145, 2791.3161275487637, 471.40838247998545, 482.4307317365542, 527.6201135182662, 537.0226188337267, 558.9189567512688, 450.072849929147, 514.0797971630814, 514.1131548079533, 546.7285108062828, 546.8414159893587, 8024.235406851421, 8781.736547903573, 8866.822663546693, 9002.369834111549, 9168.495732734631, 496.3696105945501, 501.91073939899974, 516.9741512924339, 582.7028215610069, 585.771549095853, 3672.8347224374966, 4359.629431498295, 4369.12617476506, 4433.467983841895, 4514.819407223675, 58409.70795145997, 58711.11933321004, 100990.0, 101445.49277253714, 106304.0, 51624.48375516272, 53118.0, 75927.62036189894, 85967.0, 86099.0, 48855.26717099246, 64157.679211604576, 64783.67608162023, 65622.34377656257, 69649.0, 7884.487508311941, 8200.83598328042, 8362.247397734232, 8439.282660973886, 8532.445391049561, 45302.0, 45404.77297613491, 45823.31265031094, 46446.30330544977, 47260.527394725614, 57503.42496574981, 57568.71215643895, 61579.692101541, 66268.6686566564, 66570.33429665834, 9618.567164477476, 9812.411255324703, 9912.207023437963, 10010.04904534068, 10386.740331491774, 12198.695032624255, 12694.619161425171, 12937.159084659466, 12968.221906685629, 13210.697325668583, 11296.322220666787, 11614.883851161718, 11878.703032423913, 11947.701307467036, 12357.505699771908, 11822.172447928562, 11885.940570297093, 11917.52329906794, 12033.63899083029, 12282.447289871798, 11550.0, 11601.593944211912, 11933.940330298294, 12411.131220814455, 12432.81350779721, 9283.257339412965, 9702.0, 9776.951115244377, 10005.799884002134, 10216.744581385525, 9122.77193070152, 9624.085711857362, 9812.85280720804, 9824.557894894604, 9940.30417870771], "value": 6396.099555917692, "unit": "score"}], "name": "dromaeo_css", "value": 6439.913873452811, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 114.0, 113.0, 113.0, 112.0, 113.0, 114.0, 115.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 131.0, 180.0, 123.0, 124.0, 145.0, 124.0, 156.0, 121.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 163.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 109.0, 76.0, 77.0, 77.0, 76.0, 111.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 132.0, 85.0, 85.0, 85.0, 122.0, 85.0, 84.0, 117.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 67.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 79.0, 80.0, 80.0, 78.0, 80.0, 88.0, 82.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 137.0, 135.0, 134.0, 128.0, 128.0, 133.0, 170.0, 130.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 169.0, 165.0, 169.0, 166.0, 166.0, 167.0, 174.0, 166.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 71.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1528.6, "alertThreshold": 2.0}]} 16:17:44 INFO - Return code: 0 16:17:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:17:44 INFO - # TBPL SUCCESS # 16:17:44 INFO - Running post-action listener: _resource_record_post_action 16:17:44 INFO - ##### 16:17:44 INFO - ##### Finished run-tests step (success) 16:17:44 INFO - ##### 16:17:44 INFO - Running post-run listener: _resource_record_post_run 16:17:44 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536412160; Read time: 4; Write time: 477376 16:17:44 INFO - TinderboxPrint: CPU usage
12.9% 16:17:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 16:17:44 INFO - TinderboxPrint: I/O write bytes / time
536,412,160 / 477,376 16:17:44 INFO - TinderboxPrint: CPU idle
8,323.0 (87.0%) 16:17:44 INFO - TinderboxPrint: CPU user
1,197.5 (12.5%) 16:17:44 INFO - TinderboxPrint: Swap in / out
0 / 0 16:17:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246284288; Read time: 0; Write time: 266408 16:17:44 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289837056; Read time: 0; Write time: 210952 16:17:45 INFO - Running post-run listener: _upload_blobber_files 16:17:45 INFO - Blob upload gear active. 16:17:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:17:45 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 16:17:45 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'] 16:17:45 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 16:17:45 INFO - (blobuploader) - INFO - Open directory for files ... 16:17:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:17:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:17:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:46 INFO - (blobuploader) - INFO - Done attempting. 16:17:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:17:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:17:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:47 INFO - (blobuploader) - INFO - Done attempting. 16:17:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:17:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:17:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:50 INFO - (blobuploader) - INFO - Done attempting. 16:17:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:17:50 INFO - Return code: 0 16:17:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:17:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:17:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/903232fd54464ecbb76ece5340a8fd1753f9643fb5ad731ae02b296dc50bdbc2567502dabdc72b7c7c02937841454bfdcfb9e73ab044003cb981e09f8cb0592c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ed57c553263edd49877a65022f15e458c0b71ccd3458e9cfa625f18bc5d080beea79b1ce4a6166953b18dd9708adffa3046dd78a906800b0e656793d077e26a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15da2174e12e11a30b6c0bd54e89d61f51ddbc089c386d85faed9b884280416d83d342e6f0dfc40ef4d3f6a64cef447ac4ae33a4c9dff559c0d7dbcff6f78e24"} 16:17:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:17:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:17:50 INFO - Contents: 16:17:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/903232fd54464ecbb76ece5340a8fd1753f9643fb5ad731ae02b296dc50bdbc2567502dabdc72b7c7c02937841454bfdcfb9e73ab044003cb981e09f8cb0592c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ed57c553263edd49877a65022f15e458c0b71ccd3458e9cfa625f18bc5d080beea79b1ce4a6166953b18dd9708adffa3046dd78a906800b0e656793d077e26a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15da2174e12e11a30b6c0bd54e89d61f51ddbc089c386d85faed9b884280416d83d342e6f0dfc40ef4d3f6a64cef447ac4ae33a4c9dff559c0d7dbcff6f78e24"} 16:17:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:17:50 INFO - Copying logs to upload dir... 16:17:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:17:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.675415 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-16 16:17:50.608075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 16:17:50.611768) ========= 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=62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391 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/903232fd54464ecbb76ece5340a8fd1753f9643fb5ad731ae02b296dc50bdbc2567502dabdc72b7c7c02937841454bfdcfb9e73ab044003cb981e09f8cb0592c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ed57c553263edd49877a65022f15e458c0b71ccd3458e9cfa625f18bc5d080beea79b1ce4a6166953b18dd9708adffa3046dd78a906800b0e656793d077e26a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15da2174e12e11a30b6c0bd54e89d61f51ddbc089c386d85faed9b884280416d83d342e6f0dfc40ef4d3f6a64cef447ac4ae33a4c9dff559c0d7dbcff6f78e24"} build_url:https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/Q4ol_jHBSny97PSKk5nZWw/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/903232fd54464ecbb76ece5340a8fd1753f9643fb5ad731ae02b296dc50bdbc2567502dabdc72b7c7c02937841454bfdcfb9e73ab044003cb981e09f8cb0592c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ed57c553263edd49877a65022f15e458c0b71ccd3458e9cfa625f18bc5d080beea79b1ce4a6166953b18dd9708adffa3046dd78a906800b0e656793d077e26a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15da2174e12e11a30b6c0bd54e89d61f51ddbc089c386d85faed9b884280416d83d342e6f0dfc40ef4d3f6a64cef447ac4ae33a4c9dff559c0d7dbcff6f78e24"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 16:17:50.636660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 16:17:50.636971) ========= 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=62c568580acbfdaac3eec7be000001dc-1468708084.594109-660760391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 16:17:50.719079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 16:17:50.719445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 16:17:50.719732) ========= ========= Total master_lag: 0.18 =========