builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1467170414.35 results: success (0) buildid: 20160628192830 builduid: b0763ebf714e434e987f30804fa9b1ce revision: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.353834) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.354274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.354587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.688753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.689050) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 20:20:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-06-28 20:20:14 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092190 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.914590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.914910) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022197 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.978542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:14.978879) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb --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 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 20:20:15,134 truncating revision to first 12 chars 2016-06-28 20:20:15,134 Setting DEBUG logging. 2016-06-28 20:20:15,134 attempt 1/10 2016-06-28 20:20:15,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5af9bddf1fd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 20:20:15,510 unpacking tar archive at: autoland-5af9bddf1fd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729306 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.729755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.730547) ========= script_repo_revision: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.731431) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.731891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 20:20:15.743134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-28 20:20:15.743691) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:20:15 INFO - MultiFileLogger online at 20160628 20:20:15 in /builds/slave/test 20:20:15 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 20:20:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:20:15 INFO - {'append_to_log': False, 20:20:15 INFO - 'base_work_dir': '/builds/slave/test', 20:20:15 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:20:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:20:15 INFO - 'branch': 'Autoland-Non-PGO', 20:20:15 INFO - 'buildbot_json_path': 'buildprops.json', 20:20:15 INFO - 'config_files': ('talos/linux_config.py',), 20:20:15 INFO - 'default_actions': ('clobber', 20:20:15 INFO - 'read-buildbot-config', 20:20:15 INFO - 'download-and-extract', 20:20:15 INFO - 'populate-webroot', 20:20:15 INFO - 'create-virtualenv', 20:20:15 INFO - 'install', 20:20:15 INFO - 'run-tests'), 20:20:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:20:15 INFO - 'download_minidump_stackwalk': True, 20:20:15 INFO - 'download_symbols': 'ondemand', 20:20:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:20:15 INFO - 'tooltool.py': '/tools/tooltool.py', 20:20:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:20:15 INFO - '/tools/misc-python/virtualenv.py')}, 20:20:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:20:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:20:15 INFO - 'installer_path': 'installer.exe', 20:20:15 INFO - 'log_level': 'info', 20:20:15 INFO - 'log_name': 'talos', 20:20:15 INFO - 'log_to_console': True, 20:20:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:20:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:20:15 INFO - 'opt_config_files': (), 20:20:15 INFO - 'pip_index': False, 20:20:15 INFO - 'sps_profile': False, 20:20:15 INFO - 'sps_profile_interval': 0, 20:20:15 INFO - 'suite': 'dromaeojs', 20:20:15 INFO - 'system_bits': '32', 20:20:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:20:15 INFO - 'title': 'talos-linux64-ix-011', 20:20:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:20:15 INFO - 'use_talos_json': True, 20:20:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:20:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:20:15 INFO - 'work_dir': 'build'} 20:20:15 INFO - ##### 20:20:15 INFO - ##### Running clobber step. 20:20:15 INFO - ##### 20:20:15 INFO - Running pre-action listener: _resource_record_pre_action 20:20:15 INFO - Running main action method: clobber 20:20:15 INFO - rmtree: /builds/slave/test/build 20:20:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:20:16 INFO - Running post-action listener: _resource_record_post_action 20:20:16 INFO - ##### 20:20:16 INFO - ##### Finished clobber step (success) 20:20:16 INFO - ##### 20:20:16 INFO - ##### 20:20:16 INFO - ##### Running read-buildbot-config step. 20:20:16 INFO - ##### 20:20:16 INFO - Running pre-action listener: _resource_record_pre_action 20:20:16 INFO - Running main action method: read_buildbot_config 20:20:16 INFO - Using buildbot properties: 20:20:16 INFO - { 20:20:16 INFO - "project": "", 20:20:16 INFO - "product": "firefox", 20:20:16 INFO - "script_repo_revision": "production", 20:20:16 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:20:16 INFO - "repository": "", 20:20:16 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 20:20:16 INFO - "buildid": "20160628192830", 20:20:16 INFO - "pgo_build": "False", 20:20:16 INFO - "basedir": "/builds/slave/test", 20:20:16 INFO - "buildnumber": 2, 20:20:16 INFO - "slavename": "talos-linux64-ix-011", 20:20:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:20:16 INFO - "platform": "ubuntu64_hw", 20:20:16 INFO - "scheduler": "tests-autoland-linux64-talos", 20:20:16 INFO - "branch": "autoland", 20:20:16 INFO - "repo_path": "integration/autoland", 20:20:16 INFO - "revision": "5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb", 20:20:16 INFO - "stage_platform": "linux64", 20:20:16 INFO - "builduid": "b0763ebf714e434e987f30804fa9b1ce", 20:20:16 INFO - "slavebuilddir": "test" 20:20:16 INFO - } 20:20:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:20:16 INFO - Running post-action listener: _resource_record_post_action 20:20:16 INFO - ##### 20:20:16 INFO - ##### Finished read-buildbot-config step (success) 20:20:16 INFO - ##### 20:20:16 INFO - ##### 20:20:16 INFO - ##### Running download-and-extract step. 20:20:16 INFO - ##### 20:20:16 INFO - Running pre-action listener: _resource_record_pre_action 20:20:16 INFO - Running main action method: download_and_extract 20:20:16 INFO - mkdir: /builds/slave/test/build/tests 20:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:16 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:20:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:20 INFO - Downloaded 1361 bytes. 20:20:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:20:20 INFO - Using the following test package requirements: 20:20:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:20:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:20:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'jsshell-linux-x86_64.zip'], 20:20:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:20:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:20:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:20:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:20:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:20:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:20: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')]} 20:20:20 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:21 INFO - Downloaded 22700530 bytes. 20:20:21 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'] 20:20:21 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 20:20:22 INFO - Return code: 0 20:20:22 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 20:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:22 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:20:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:26 INFO - Downloaded 22700530 bytes. 20:20:26 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'] 20:20:26 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 20:20:27 INFO - Return code: 0 20:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:27 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:28 INFO - Downloaded 14405245 bytes. 20:20:28 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'] 20:20:28 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 20:20:28 INFO - Return code: 0 20:20:28 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')]} 20:20:28 INFO - https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHlAhNREQm23g81S78GXBA/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 20:20:32 INFO - Downloaded 56438136 bytes. 20:20:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:32 INFO - mkdir: /builds/slave/test/properties 20:20:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:20:32 INFO - Writing to file /builds/slave/test/properties/build_url 20:20:32 INFO - Contents: 20:20:32 INFO - build_url:https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:20:33 INFO - Running post-action listener: _resource_record_post_action 20:20:33 INFO - Running post-action listener: set_extra_try_arguments 20:20:33 INFO - ##### 20:20:33 INFO - ##### Finished download-and-extract step (success) 20:20:33 INFO - ##### 20:20:33 INFO - ##### 20:20:33 INFO - ##### Running populate-webroot step. 20:20:33 INFO - ##### 20:20:33 INFO - Running pre-action listener: _resource_record_pre_action 20:20:33 INFO - Running main action method: populate_webroot 20:20:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:20:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:20:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:20:33 INFO - '--tppagecycles', 20:20:33 INFO - '7'], 20:20:33 INFO - 'tests': ['tsvgm']}}, 20:20:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:20:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:20:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:20:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:20:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['damp', 'tps']}, 20:20:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'tests': ['damp', 'tps']}, 20:20:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['dromaeo_dom']}, 20:20:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:20:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['basic_compositor_video']}, 20:20:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:20:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['a11yr', 20:20:33 INFO - 'ts_paint', 20:20:33 INFO - 'tpaint', 20:20:33 INFO - 'sessionrestore', 20:20:33 INFO - 'sessionrestore_no_auto_restore', 20:20:33 INFO - 'tabpaint']}, 20:20:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:20:33 INFO - 'ts_paint', 20:20:33 INFO - 'tpaint', 20:20:33 INFO - 'sessionrestore', 20:20:33 INFO - 'sessionrestore_no_auto_restore', 20:20:33 INFO - 'tabpaint']}, 20:20:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:20:33 INFO - 'ts_paint', 20:20:33 INFO - 'tpaint', 20:20:33 INFO - 'sessionrestore', 20:20:33 INFO - 'sessionrestore_no_auto_restore', 20:20:33 INFO - 'tabpaint']}, 20:20:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:20:33 INFO - 'ts_paint', 20:20:33 INFO - 'tpaint', 20:20:33 INFO - 'sessionrestore', 20:20:33 INFO - 'sessionrestore_no_auto_restore', 20:20:33 INFO - 'tabpaint']}, 20:20:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['a11yr', 20:20:33 INFO - 'ts_paint', 20:20:33 INFO - 'tpaint', 20:20:33 INFO - 'sessionrestore', 20:20:33 INFO - 'sessionrestore_no_auto_restore', 20:20:33 INFO - 'tabpaint']}, 20:20:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['a11yr', 20:20:33 INFO - 'ts_paint', 20:20:33 INFO - 'tpaint', 20:20:33 INFO - 'sessionrestore', 20:20:33 INFO - 'sessionrestore_no_auto_restore', 20:20:33 INFO - 'tabpaint']}, 20:20:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['tsvgx', 20:20:33 INFO - 'tsvgr_opacity', 20:20:33 INFO - 'tart', 20:20:33 INFO - 'tscrollx', 20:20:33 INFO - 'cart']}, 20:20:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:20:33 INFO - 'tsvgr_opacity', 20:20:33 INFO - 'tart', 20:20:33 INFO - 'tscrollx', 20:20:33 INFO - 'cart']}, 20:20:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'talos_options': ['--disable-e10s'], 20:20:33 INFO - 'tests': ['tp5o']}, 20:20:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'tests': ['tp5o']}, 20:20:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'talos_options': ['--disable-e10s', 20:20:33 INFO - '--xperf_path', 20:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:33 INFO - 'tests': ['tp5n']}, 20:20:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:33 INFO - 'talos_options': ['--xperf_path', 20:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:33 INFO - 'tests': ['tp5n']}}, 20:20:33 INFO - 'talos.zip': {'path': '', 20:20:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:20:33 INFO - Running post-action listener: _resource_record_post_action 20:20:33 INFO - ##### 20:20:33 INFO - ##### Finished populate-webroot step (success) 20:20:33 INFO - ##### 20:20:33 INFO - ##### 20:20:33 INFO - ##### Running create-virtualenv step. 20:20:33 INFO - ##### 20:20:33 INFO - Running pre-action listener: _resource_record_pre_action 20:20:33 INFO - Running main action method: create_virtualenv 20:20:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:20:33 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 20:20:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:20:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:20:33 INFO - Using real prefix '/usr' 20:20:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:20:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:36 INFO - Installing pip.................done. 20:20:36 INFO - Return code: 0 20:20:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20:36 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')]} 20:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:36 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')]} 20:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:36 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:36 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 20:20:36 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 20:20:36 INFO - Using env: {'DISPLAY': ':0', 20:20:36 INFO - 'HOME': '/home/cltbld', 20:20:36 INFO - 'LANG': 'en_US.UTF-8', 20:20:36 INFO - 'LANGUAGE': 'en_US:en', 20:20:36 INFO - 'LOGNAME': 'cltbld', 20:20:36 INFO - 'MAIL': '/var/mail/cltbld', 20:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:36 INFO - 'MOZ_NO_REMOTE': '1', 20:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:36 INFO - 'NO_EM_RESTART': '1', 20:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:36 INFO - 'PWD': '/builds/slave/test', 20:20:36 INFO - 'SHELL': '/bin/bash', 20:20:36 INFO - 'SHLVL': '1', 20:20:36 INFO - 'TERM': 'linux', 20:20:36 INFO - 'TMOUT': '86400', 20:20:36 INFO - 'USER': 'cltbld', 20:20:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:36 INFO - '_': '/tools/buildbot/bin/python'} 20:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:36 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 20:20:36 INFO - Cleaning up... 20:20:36 INFO - Return code: 0 20:20:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:20:36 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')]} 20:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:36 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')]} 20:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:36 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:36 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 20:20:36 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 20:20:36 INFO - Using env: {'DISPLAY': ':0', 20:20:36 INFO - 'HOME': '/home/cltbld', 20:20:36 INFO - 'LANG': 'en_US.UTF-8', 20:20:36 INFO - 'LANGUAGE': 'en_US:en', 20:20:36 INFO - 'LOGNAME': 'cltbld', 20:20:36 INFO - 'MAIL': '/var/mail/cltbld', 20:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:36 INFO - 'MOZ_NO_REMOTE': '1', 20:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:36 INFO - 'NO_EM_RESTART': '1', 20:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:36 INFO - 'PWD': '/builds/slave/test', 20:20:36 INFO - 'SHELL': '/bin/bash', 20:20:36 INFO - 'SHLVL': '1', 20:20:36 INFO - 'TERM': 'linux', 20:20:36 INFO - 'TMOUT': '86400', 20:20:36 INFO - 'USER': 'cltbld', 20:20:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:36 INFO - '_': '/tools/buildbot/bin/python'} 20:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:36 INFO - Downloading/unpacking psutil>=3.1.1 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:38 INFO - Installing collected packages: psutil 20:20:38 INFO - Running setup.py install for psutil 20:20:38 INFO - building 'psutil._psutil_linux' extension 20:20:38 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 20:20:38 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 20:20:38 INFO - building 'psutil._psutil_posix' extension 20:20:38 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 20:20:39 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 20:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:39 INFO - Successfully installed psutil 20:20:39 INFO - Cleaning up... 20:20:39 INFO - Return code: 0 20:20:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:39 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:39 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 20:20:39 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 20:20:39 INFO - Using env: {'DISPLAY': ':0', 20:20:39 INFO - 'HOME': '/home/cltbld', 20:20:39 INFO - 'LANG': 'en_US.UTF-8', 20:20:39 INFO - 'LANGUAGE': 'en_US:en', 20:20:39 INFO - 'LOGNAME': 'cltbld', 20:20:39 INFO - 'MAIL': '/var/mail/cltbld', 20:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:39 INFO - 'MOZ_NO_REMOTE': '1', 20:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:39 INFO - 'NO_EM_RESTART': '1', 20:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:39 INFO - 'PWD': '/builds/slave/test', 20:20:39 INFO - 'SHELL': '/bin/bash', 20:20:39 INFO - 'SHLVL': '1', 20:20:39 INFO - 'TERM': 'linux', 20:20:39 INFO - 'TMOUT': '86400', 20:20:39 INFO - 'USER': 'cltbld', 20:20:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:39 INFO - '_': '/tools/buildbot/bin/python'} 20:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:20:39 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 20:20:39 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 20:20:39 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 20:20:39 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 20:20:39 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 20:20:39 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 20:20:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:20:41 INFO - Installing collected packages: mozsystemmonitor 20:20:41 INFO - Running setup.py install for mozsystemmonitor 20:20:41 INFO - Successfully installed mozsystemmonitor 20:20:41 INFO - Cleaning up... 20:20:41 INFO - Return code: 0 20:20:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:41 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:41 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 20:20:41 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 20:20:41 INFO - Using env: {'DISPLAY': ':0', 20:20:41 INFO - 'HOME': '/home/cltbld', 20:20:41 INFO - 'LANG': 'en_US.UTF-8', 20:20:41 INFO - 'LANGUAGE': 'en_US:en', 20:20:41 INFO - 'LOGNAME': 'cltbld', 20:20:41 INFO - 'MAIL': '/var/mail/cltbld', 20:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:41 INFO - 'MOZ_NO_REMOTE': '1', 20:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:41 INFO - 'NO_EM_RESTART': '1', 20:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:41 INFO - 'PWD': '/builds/slave/test', 20:20:41 INFO - 'SHELL': '/bin/bash', 20:20:41 INFO - 'SHLVL': '1', 20:20:41 INFO - 'TERM': 'linux', 20:20:41 INFO - 'TMOUT': '86400', 20:20:41 INFO - 'USER': 'cltbld', 20:20:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:41 INFO - '_': '/tools/buildbot/bin/python'} 20:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:41 INFO - Downloading/unpacking jsonschema==2.5.1 20:20:41 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 20:20:41 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 20:20:41 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 20:20:41 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 20:20:41 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 20:20:41 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 20:20:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:43 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:43 INFO - warning: no files found matching '*.txt' 20:20:43 INFO - no previously-included directories found matching 'build' 20:20:43 INFO - no previously-included directories found matching 'dist' 20:20:43 INFO - no previously-included directories found matching '.git*' 20:20:43 INFO - Installing collected packages: jsonschema, functools32 20:20:44 INFO - Running setup.py install for functools32 20:20:44 INFO - warning: no files found matching '*.txt' 20:20:44 INFO - no previously-included directories found matching 'build' 20:20:44 INFO - no previously-included directories found matching 'dist' 20:20:44 INFO - no previously-included directories found matching '.git*' 20:20:44 INFO - Successfully installed jsonschema functools32 20:20:44 INFO - Cleaning up... 20:20:44 INFO - Return code: 0 20:20:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:44 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:44 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 20:20:44 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 20:20:44 INFO - Using env: {'DISPLAY': ':0', 20:20:44 INFO - 'HOME': '/home/cltbld', 20:20:44 INFO - 'LANG': 'en_US.UTF-8', 20:20:44 INFO - 'LANGUAGE': 'en_US:en', 20:20:44 INFO - 'LOGNAME': 'cltbld', 20:20:44 INFO - 'MAIL': '/var/mail/cltbld', 20:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:44 INFO - 'MOZ_NO_REMOTE': '1', 20:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:44 INFO - 'NO_EM_RESTART': '1', 20:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:44 INFO - 'PWD': '/builds/slave/test', 20:20:44 INFO - 'SHELL': '/bin/bash', 20:20:44 INFO - 'SHLVL': '1', 20:20:44 INFO - 'TERM': 'linux', 20:20:44 INFO - 'TMOUT': '86400', 20:20:44 INFO - 'USER': 'cltbld', 20:20:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:44 INFO - '_': '/tools/buildbot/bin/python'} 20:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:20:44 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 20:20:44 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 20:20:44 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 20:20:44 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 20:20:44 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 20:20:44 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 20:20:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:20:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:20:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 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 20:20:46 INFO - Downloading docopt-0.6.1.tar.gz 20:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:20:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:20:47 INFO - Running setup.py install for blobuploader 20:20:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:20:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:20:47 INFO - Running setup.py install for requests 20:20:47 INFO - Running setup.py install for docopt 20:20:47 INFO - Successfully installed blobuploader requests docopt 20:20:47 INFO - Cleaning up... 20:20:47 INFO - Return code: 0 20:20:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:47 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')]} 20:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:47 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')]} 20:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:47 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:47 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 20:20:47 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 20:20:47 INFO - Using env: {'DISPLAY': ':0', 20:20:47 INFO - 'HOME': '/home/cltbld', 20:20:47 INFO - 'LANG': 'en_US.UTF-8', 20:20:47 INFO - 'LANGUAGE': 'en_US:en', 20:20:47 INFO - 'LOGNAME': 'cltbld', 20:20:47 INFO - 'MAIL': '/var/mail/cltbld', 20:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:47 INFO - 'MOZ_NO_REMOTE': '1', 20:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:47 INFO - 'NO_EM_RESTART': '1', 20:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:47 INFO - 'PWD': '/builds/slave/test', 20:20:47 INFO - 'SHELL': '/bin/bash', 20:20:47 INFO - 'SHLVL': '1', 20:20:47 INFO - 'TERM': 'linux', 20:20:47 INFO - 'TMOUT': '86400', 20:20:47 INFO - 'USER': 'cltbld', 20:20:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:47 INFO - '_': '/tools/buildbot/bin/python'} 20:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:47 INFO - Running setup.py (path:/tmp/pip-7pSWTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:47 INFO - Running setup.py (path:/tmp/pip-EXsuiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:47 INFO - Running setup.py (path:/tmp/pip-KeOo3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:48 INFO - Running setup.py (path:/tmp/pip-akpWCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:48 INFO - Running setup.py (path:/tmp/pip-hBq7kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:48 INFO - Running setup.py (path:/tmp/pip-DdiDfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:48 INFO - Running setup.py (path:/tmp/pip-LwNeTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:48 INFO - Running setup.py (path:/tmp/pip-cnZJWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:48 INFO - Running setup.py (path:/tmp/pip-YXvule-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:48 INFO - Running setup.py (path:/tmp/pip-ukZ3YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:48 INFO - Running setup.py (path:/tmp/pip-7iM0H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:48 INFO - Running setup.py (path:/tmp/pip-3V4bod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:48 INFO - Running setup.py (path:/tmp/pip-Tz8CIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:48 INFO - Running setup.py (path:/tmp/pip-VK7tmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:48 INFO - Running setup.py (path:/tmp/pip-ghLwxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:48 INFO - Running setup.py (path:/tmp/pip-oBx8rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:49 INFO - Running setup.py (path:/tmp/pip-ctkTM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:20:49 INFO - Running setup.py install for manifestparser 20:20:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Running setup.py install for mozcrash 20:20:49 INFO - Running setup.py install for mozdebug 20:20:49 INFO - Running setup.py install for mozdevice 20:20:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Running setup.py install for mozfile 20:20:49 INFO - Running setup.py install for mozhttpd 20:20:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Running setup.py install for mozinfo 20:20:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Running setup.py install for mozInstall 20:20:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:20:49 INFO - Running setup.py install for mozleak 20:20:49 INFO - Running setup.py install for mozlog 20:20:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:20:50 INFO - Running setup.py install for moznetwork 20:20:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:20:50 INFO - Running setup.py install for mozprocess 20:20:50 INFO - Running setup.py install for mozprofile 20:20:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:20:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:20:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:20:50 INFO - Running setup.py install for mozrunner 20:20:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:20:50 INFO - Running setup.py install for mozscreenshot 20:20:50 INFO - Running setup.py install for moztest 20:20:50 INFO - Running setup.py install for mozversion 20:20:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:20:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:20:50 INFO - Cleaning up... 20:20:50 INFO - Return code: 0 20:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:50 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:50 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 20:20:50 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 20:20:50 INFO - Using env: {'DISPLAY': ':0', 20:20:50 INFO - 'HOME': '/home/cltbld', 20:20:50 INFO - 'LANG': 'en_US.UTF-8', 20:20:50 INFO - 'LANGUAGE': 'en_US:en', 20:20:50 INFO - 'LOGNAME': 'cltbld', 20:20:50 INFO - 'MAIL': '/var/mail/cltbld', 20:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:50 INFO - 'MOZ_NO_REMOTE': '1', 20:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:50 INFO - 'NO_EM_RESTART': '1', 20:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:50 INFO - 'PWD': '/builds/slave/test', 20:20:50 INFO - 'SHELL': '/bin/bash', 20:20:50 INFO - 'SHLVL': '1', 20:20:50 INFO - 'TERM': 'linux', 20:20:50 INFO - 'TMOUT': '86400', 20:20:50 INFO - 'USER': 'cltbld', 20:20:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:50 INFO - '_': '/tools/buildbot/bin/python'} 20:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:51 INFO - Running setup.py (path:/tmp/pip-zkJ3EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:51 INFO - Running setup.py (path:/tmp/pip-hvNgtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:51 INFO - Running setup.py (path:/tmp/pip-q8QYGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:51 INFO - Running setup.py (path:/tmp/pip-RyNIup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:51 INFO - Running setup.py (path:/tmp/pip-jZ6Xqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:51 INFO - Running setup.py (path:/tmp/pip-2BUCih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:51 INFO - Running setup.py (path:/tmp/pip-EtlSdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:51 INFO - Running setup.py (path:/tmp/pip-F7D6n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:51 INFO - Running setup.py (path:/tmp/pip-Uk75yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:51 INFO - Running setup.py (path:/tmp/pip-uGM0QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:51 INFO - Running setup.py (path:/tmp/pip-B1Keco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:51 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)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:51 INFO - Running setup.py (path:/tmp/pip-B4QCF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:51 INFO - Running setup.py (path:/tmp/pip-XNGvRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:52 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)) 20:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:52 INFO - Running setup.py (path:/tmp/pip-lae_EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:52 INFO - Running setup.py (path:/tmp/pip-m3RxEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:52 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)) 20:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:52 INFO - Running setup.py (path:/tmp/pip-IYSdAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:52 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)) 20:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:52 INFO - Running setup.py (path:/tmp/pip-MMFgAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:52 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)) 20:20:52 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)) 20:20:52 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)) 20:20:52 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)) 20:20:52 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)) 20:20:52 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)) 20:20:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:54 INFO - Downloading blessings-1.6.tar.gz 20:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:20:54 INFO - Installing collected packages: blessings 20:20:54 INFO - Running setup.py install for blessings 20:20:54 INFO - Successfully installed blessings 20:20:54 INFO - Cleaning up... 20:20:54 INFO - Return code: 0 20:20:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:20:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:54 INFO - Reading from file tmpfile_stdout 20:20:54 INFO - Current package versions: 20:20:54 INFO - argparse == 1.2.1 20:20:54 INFO - blessings == 1.6 20:20:54 INFO - blobuploader == 1.2.4 20:20:54 INFO - docopt == 0.6.1 20:20:54 INFO - functools32 == 3.2.3-2 20:20:54 INFO - jsonschema == 2.5.1 20:20:54 INFO - manifestparser == 1.1 20:20:54 INFO - mozInstall == 1.12 20:20:54 INFO - mozcrash == 0.17 20:20:54 INFO - mozdebug == 0.1 20:20:54 INFO - mozdevice == 0.48 20:20:54 INFO - mozfile == 1.2 20:20:54 INFO - mozhttpd == 0.7 20:20:54 INFO - mozinfo == 0.9 20:20:54 INFO - mozleak == 0.1 20:20:54 INFO - mozlog == 3.2 20:20:54 INFO - moznetwork == 0.27 20:20:54 INFO - mozprocess == 0.22 20:20:54 INFO - mozprofile == 0.28 20:20:54 INFO - mozrunner == 6.11 20:20:54 INFO - mozscreenshot == 0.1 20:20:54 INFO - mozsystemmonitor == 0.3 20:20:54 INFO - moztest == 0.7 20:20:54 INFO - mozversion == 1.4 20:20:54 INFO - psutil == 3.1.1 20:20:54 INFO - requests == 1.2.3 20:20:54 INFO - wsgiref == 0.1.2 20:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:54 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 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:54 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 20:20:54 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 20:20:54 INFO - Using env: {'DISPLAY': ':0', 20:20:54 INFO - 'HOME': '/home/cltbld', 20:20:54 INFO - 'LANG': 'en_US.UTF-8', 20:20:54 INFO - 'LANGUAGE': 'en_US:en', 20:20:54 INFO - 'LOGNAME': 'cltbld', 20:20:54 INFO - 'MAIL': '/var/mail/cltbld', 20:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:54 INFO - 'MOZ_NO_REMOTE': '1', 20:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:54 INFO - 'NO_EM_RESTART': '1', 20:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:54 INFO - 'PWD': '/builds/slave/test', 20:20:54 INFO - 'SHELL': '/bin/bash', 20:20:54 INFO - 'SHLVL': '1', 20:20:54 INFO - 'TERM': 'linux', 20:20:54 INFO - 'TMOUT': '86400', 20:20:54 INFO - 'USER': 'cltbld', 20:20:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:54 INFO - '_': '/tools/buildbot/bin/python'} 20:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 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)) 20:20:54 INFO - Cleaning up... 20:20:54 INFO - Return code: 0 20:20:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2175030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2436180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', '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 20:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:20:54 INFO - Using env: {'DISPLAY': ':0', 20:20:54 INFO - 'HOME': '/home/cltbld', 20:20:54 INFO - 'LANG': 'en_US.UTF-8', 20:20:54 INFO - 'LANGUAGE': 'en_US:en', 20:20:54 INFO - 'LOGNAME': 'cltbld', 20:20:54 INFO - 'MAIL': '/var/mail/cltbld', 20:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:54 INFO - 'MOZ_NO_REMOTE': '1', 20:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:54 INFO - 'NO_EM_RESTART': '1', 20:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:54 INFO - 'PWD': '/builds/slave/test', 20:20:54 INFO - 'SHELL': '/bin/bash', 20:20:54 INFO - 'SHLVL': '1', 20:20:54 INFO - 'TERM': 'linux', 20:20:54 INFO - 'TMOUT': '86400', 20:20:54 INFO - 'USER': 'cltbld', 20:20:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:54 INFO - '_': '/tools/buildbot/bin/python'} 20:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:20:55 INFO - Cleaning up... 20:20:55 INFO - Return code: 0 20:20:55 INFO - Running post-action listener: _resource_record_post_action 20:20:55 INFO - Running post-action listener: _start_resource_monitoring 20:20:55 INFO - Starting resource monitoring. 20:20:55 INFO - ##### 20:20:55 INFO - ##### Finished create-virtualenv step (success) 20:20:55 INFO - ##### 20:20:55 INFO - ##### 20:20:55 INFO - ##### Running install step. 20:20:55 INFO - ##### 20:20:55 INFO - Running pre-action listener: _resource_record_pre_action 20:20:55 INFO - Running main action method: install 20:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:55 INFO - Reading from file tmpfile_stdout 20:20:55 INFO - Detecting whether we're running mozinstall >=1.0... 20:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:20:55 INFO - Reading from file tmpfile_stdout 20:20:55 INFO - Output received: 20:20:55 INFO - Usage: mozinstall [options] installer 20:20:55 INFO - Options: 20:20:55 INFO - -h, --help show this help message and exit 20:20:55 INFO - -d DEST, --destination=DEST 20:20:55 INFO - Directory to install application into. [default: 20:20:55 INFO - "/builds/slave/test"] 20:20:55 INFO - --app=APP Application being installed. [default: firefox] 20:20:55 INFO - mkdir: /builds/slave/test/build/application 20:20:55 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'] 20:20:55 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 20:21:11 INFO - Reading from file tmpfile_stdout 20:21:11 INFO - Output received: 20:21:11 INFO - /builds/slave/test/build/application/firefox/firefox 20:21:11 INFO - Running post-action listener: _resource_record_post_action 20:21:11 INFO - ##### 20:21:11 INFO - ##### Finished install step (success) 20:21:11 INFO - ##### 20:21:11 INFO - ##### 20:21:11 INFO - ##### Running run-tests step. 20:21:11 INFO - ##### 20:21:11 INFO - Running pre-action listener: _resource_record_pre_action 20:21:11 INFO - Running main action method: run_tests 20:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:21:11 INFO - Python 2.7.3 20:21:11 INFO - Return code: 0 20:21:11 INFO - grabbing minidump binary from tooltool 20:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:11 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 0x24343b0>, '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 0x24352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:21:11 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 20:21:11 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 20:21:11 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 20:21:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:21:11 INFO - Return code: 0 20:21:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:21:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:21:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:21:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:21:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:21:11 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/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:21:11 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/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:21:11 INFO - Using env: {'DISPLAY': ':0', 20:21:11 INFO - 'HOME': '/home/cltbld', 20:21:11 INFO - 'LANG': 'en_US.UTF-8', 20:21:11 INFO - 'LANGUAGE': 'en_US:en', 20:21:11 INFO - 'LOGNAME': 'cltbld', 20:21:11 INFO - 'MAIL': '/var/mail/cltbld', 20:21:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:21:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:11 INFO - 'MOZ_NO_REMOTE': '1', 20:21:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:11 INFO - 'NO_EM_RESTART': '1', 20:21:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:11 INFO - 'PWD': '/builds/slave/test', 20:21:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:21:11 INFO - 'SHELL': '/bin/bash', 20:21:11 INFO - 'SHLVL': '1', 20:21:11 INFO - 'TERM': 'linux', 20:21:11 INFO - 'TMOUT': '86400', 20:21:11 INFO - 'USER': 'cltbld', 20:21:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256', 20:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:11 INFO - '_': '/tools/buildbot/bin/python'} 20:21:11 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/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:21:12 INFO - mozversion application_buildid: 20160628192830 20:21:12 INFO - mozversion application_changeset: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb 20:21:12 INFO - mozversion application_display_name: Nightly 20:21:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:21:12 INFO - mozversion application_name: Firefox 20:21:12 INFO - mozversion application_remotingname: firefox 20:21:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:21:12 INFO - mozversion application_vendor: Mozilla 20:21:12 INFO - mozversion application_version: 50.0a1 20:21:12 INFO - mozversion platform_buildid: 20160628192830 20:21:12 INFO - mozversion platform_changeset: 5af9bddf1fd37c8dde5896c7dd176f62edb7c7fb 20:21:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:21:12 INFO - mozversion platform_version: 50.0a1 20:21:12 INFO - using testdate: 1467170472 20:21:12 INFO - actual date: 1467170472 20:21:12 INFO - starting webserver on 'localhost:52320' 20:21:12 INFO - SUITE-START | Running 2 tests 20:21:12 INFO - TEST-START | dromaeo_css 20:21:12 INFO - operating with platform_type : linux_ 20:21:12 INFO - Initialising browser for dromaeo_css test... 20:21:12 INFO - TEST-INFO | started process 3792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNl32qN/profile http://localhost:52320/getInfo.html) 20:21:17 INFO - PROCESS | 3792 | __metrics Screen width/height:1600/1200 20:21:17 INFO - PROCESS | 3792 | colorDepth:24 20:21:17 INFO - PROCESS | 3792 | Browser inner width/height: 1024/697 20:21:17 INFO - PROCESS | 3792 | __metrics 20:21:18 INFO - PROCESS | 3792 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:21:19 INFO - TEST-INFO | 3792: exit 0 20:21:19 INFO - Browser initialized. 20:21:19 INFO - Running cycle 1/1 for dromaeo_css test... 20:21:19 INFO - TEST-INFO | started process 3873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNl32qN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:31 INFO - PROCESS | 3873 | RSS: Main: 158130176 20:21:31 INFO - PROCESS | 3873 | 20:22:22 INFO - PROCESS | 3873 | 1467170542207 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] 20:24:35 INFO - PROCESS | 3873 | Cycle 1(1): loaded http://localhost:52320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52320/tests/dromaeo/cssquery-ext.html) 20:24:36 INFO - PROCESS | 3873 | RSS: Main: 271347712 20:24:36 INFO - PROCESS | 3873 | 20:27:39 INFO - PROCESS | 3873 | Cycle 1(1): loaded http://localhost:52320/tests/dromaeo/cssquery-ext.html (next: http://localhost:52320/tests/dromaeo/cssquery-jquery.html) 20:27:39 INFO - PROCESS | 3873 | RSS: Main: 240066560 20:27:39 INFO - PROCESS | 3873 | 20:30:42 INFO - PROCESS | 3873 | Cycle 1(1): loaded http://localhost:52320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52320/tests/dromaeo/cssquery-mootools.html) 20:30:42 INFO - PROCESS | 3873 | RSS: Main: 252493824 20:30:42 INFO - PROCESS | 3873 | 20:33:44 INFO - PROCESS | 3873 | Cycle 1(1): loaded http://localhost:52320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52320/tests/dromaeo/cssquery-prototype.html) 20:33:45 INFO - PROCESS | 3873 | RSS: Main: 244490240 20:33:45 INFO - PROCESS | 3873 | 20:36:48 INFO - PROCESS | 3873 | Cycle 1(1): loaded http://localhost:52320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52320/tests/dromaeo/cssquery-yui.html) 20:36:49 INFO - PROCESS | 3873 | RSS: Main: 215511040 20:36:49 INFO - PROCESS | 3873 | 20:39:51 INFO - PROCESS | 3873 | Cycle 1(1): loaded http://localhost:52320/tests/dromaeo/cssquery-yui.html (next: http://localhost:52320/tests/dromaeo/cssquery-dojo.html) 20:39:52 INFO - PROCESS | 3873 | RSS: Main: 308985856 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | __start_tp_report 20:39:52 INFO - PROCESS | 3873 | _x_x_mozilla_page_load 20:39:52 INFO - PROCESS | 3873 | _x_x_mozilla_page_load_details 20:39:52 INFO - PROCESS | 3873 | |i|pagename|runs| 20:39:52 INFO - PROCESS | 3873 | |0;dojo.html;2634.420427505948;2636.5517861963463;2674.157640343291;2687.959680604791;2690.9596356054662;4713.410823647044;4728.1962066448705;4788.186008378575;4793.209120495123;4844.346013288209;4777.116233496806;4784.545468180518;4787.736674482902;4847.806087756486;4869.440014398345;4337.436133302666;4362.0621566363225;4421.624161946223;4447.866564003069;4560.042391097873;4464.486584042828;4482.305242687388;4512;4517.051419201972;4546.931796023062;4284.5715428457215;4338.327559228324;4345.109252603209;4371.103923695667;4412.713173643735;4352.434183556149;4360.585744354281;4362.302031674917;4409.382686423904;4415.359772832953;4386.517483076859;4387.670924680661;4400.075984043323;4433.9113217735785;4442.555744425564;4675.368825208588;4741.715497070187;4814.518548145193;4822.228443449067;4833.154198015333;5180.248863914749;5207.3490813648295;5221.973890130525;5230.08473517133;5234.685918844843;5243.9213411798855;5278.736063196825;5285.920711189336;5289.656172348785;5293.655912365684;4712.458067322234;4798.04039192163;4844.903101937942;4863.489333619989;4916.311716359713;5373.032854086224;5396.4333744957;5399.70301633414;5400.756965936543;5404.054290499147;4923.163062279421;5158.38099428071;5164.122099243138;5166.793328266903;5167.948320516747;5110.003549307924;5141.048905952411;5151.047056294523;5227.895442091213;5244.659097158673;5140.974295128575;5141.5886729061585;5147.3308469898675;5147.845564633067;5150.150225212873;5105.770240339194;5109.514596113363;5148.047611191867;5149;5185.066687996122;4246.002189485468;4286.5284818669925;4319.870403887889;4371.300591905344;4377.978110109493;3834.5973672764517;3843.385058390644;3852.3643598806443;3875.9612403876163;3936.3111455495173;4465.151621191963;4476.686631935733;4480.529544397857;4520.570545798144;4524.5927866492175;4967.3542439482635;5151.201563757623;5181.06740786662;5211.114110601206;5271.262023316739;4450.065486247924;4467.821287148543;4468.128714900563;4502.594766471033;4513.977430112828;4692.249240121564;4695.765211739399;4704.764761761899;4731.1720448921305;4752.1921273383605;4734.857954261378;4857.077155340474;4905.460399355997;4912.606991440676;4915.877103072452;5212.869678257922;5214.582833373397;5223.347081614798;5223.373195216598;5233.685978841282;4925.48282430354;4931.186354251508;4934.161192597196;4934.7285899275885;4947.579455746302;4949.381327334083;5060.367454068241;5109.1059064662795;5136.075506408883;5145.639805213749;5174.974125129501;5221.765020574007;5223.712695801767;5229;5278;4890.339804126397;5057.8735531612;5083.237514372726;5083.822066227664;5083.822066227664;5008.599312054954;5035.345405097314;5061.645684802029;5074.213496907985;5091;5012.799488020584;5022.221555658879;5042.193249080129;5068.695878247317;5075.87310317245;4881.8535443936735;4995.100881841304;5118.283440318432;5158.716270605153;5173.3533308336455;4948.752562371795;4951.084049450863;4977.0792403405485;4977.303177555073;5027.321311622884 20:39:52 INFO - PROCESS | 3873 | |1;ext.html;545.8847554809383;577.4802677590166;578.3522454850568;586.3023002626875;601.3895895665898;27055.729442705593;39309.21381572367;40369;40402.595974040254;40462.393064104064;41225.79387103068;41601.58398416015;41604;41672.37491437623;41718.58281417185;7611.353034992005;7792.610369481517;7924.167962363927;7926.445148839583;7929.088154862178;7600.391968642495;7830.412719046066;7857.1357150713375;10000.89999100007;10275.588976440971;9948.452835094067;9981.700548983543;9988.500574971258;9992.95003524985;9993.100620944113;10198.082172604463;10263.025012623788;10268.94865525675;10280.383177009404;10283.228757843191;7612.885806712904;7844.9215507844765;7845.058592968823;9785.755356116155;10189.89810101897;38238;38386.23227535462;38418.42372364417;38457;38459;3020.048684664324;3046.558249053897;3149.826759528225;3171.1120886151684;3549.0730480098296;28743.712562874312;28878;29364.412711745645;29503.70496295031;29909.70090299091;3464.8787292444645;3522.5068490411363;3593.5148754918273;3599.1362073102528;3623.6738693517445;176993;177402;177643;177694.99999999872;177745;51785.48214517882;52340;52359.47640523546;52473;52498.47501524936;55124;55222;55265.72367138138;55292.170617440774;55395.16907246395;13850.861491385158;14289.428422863177;14315.57053288403;14316.785248221286;14318.212498312692;9959.153471954965;11410.543578256942;11451.656450306504;11497;11508.194426390073;15155.621109472351;15516.68966620684;15614.687706245812;16058.27737751804;16085.437009704838;5495.505404513613;5564.137558678412;5596.244506991586;5755.107958266475;5804.3300081961925;819.7375244325704;910.0217266438605;928.5960607135918;980.1815484070738;1021.9131373833308;26591.601125983125;27649.112382084073;28231;28352.43295134086;28552.143435696962;968.9370190937567;977.9804403911882;985.5515740338129;1032.6850310655173;1036.9170466362823;14429.422823087169;15020.849791502163;15062.698746025018;15077.170755608548;15077.594327928826;391297;391872;392527;392952;393139;49668;49915.75042124766;49997;50030.49969500258;50130.49869501258;1066.088494337346;1183.526589364261;1195.0857593940643;1268.543324403214;1351.601277623084;26281.21156365312;29935.55096673595;30326.696733032386;30390.544141837447;30891;43114.78442607767;43158.784206080025;43870.34194487021;43915.34126988162;43920.78039609781;350207;355597;356156;357478;357819;32801.83599081989;33803;37956.810215948746;38726.80636596799;38737.225255494166;41651.37522937098;42065.369019464124;42103.15793684171;42238.788806055774;43317.566824331356;35743.64256357403;36101.81949090238;36228.63771362253;36636;36638;37019.62980370269;37049.109843466045;37238.25523489569;37270;37443.81278093592;35403;35974.820125899205;36050.819745901106;36243.81878090592;36533.08667283339;31790.36419271648;32686.20225887599;33373.49939750954;33508.83245583757;33634.66365336413;24911.252662420156;25083.24750257495;25495.74504255008;25581;25843 20:39:52 INFO - PROCESS | 3873 | |2;jquery.html;363.58551251573203;369.10281154864003;369.9759515631482;383.1513198265841;385.54120596490174;15873.920630396846;17446.825531744693;17965.820341796578;17976.460706178834;18000.36998705044;15176;16385.590360241;16589.66820663589;16639.251233694482;16760.245788939497;5091.719955402451;5207.323048003755;5236.842894713146;5268.473152684739;5271.15661494161;3595.496630471736;3814.5231846019246;5143.81996630118;5824.388439213885;6188.412100850434;6206.813795586139;6223.751049957997;6226.066090086478;6245.063240513914;6251.187345645059;5926.051831706928;6058.3335833058545;6102.206713127265;6103.603265787732;6113.23584551931;3285.474324108155;4969.4036715594;5312.5218730314455;5315.813946511892;5316.521513063843;19641.508962275915;20413.69379459309;20456.795432045637;20544.691829622567;20555.79444205569;2068.3174552397672;2181.498255401251;2283.292179424384;2310.122153581628;2536.07433286849;12831.679208019781;13259.204447733167;13284.73430531384;13986;14045;1655.4040545403645;1767.7348397740313;1769.9557511062199;1772.769539959797;1797.3978717129778;66600.3339966599;67364.32635673629;68550;68863;69304.65347673229;9032.187103160748;9170.541472926461;9318.440893546272;9364.812703746024;9583.90416095844;12583.622491325275;12703.618891433272;12716;12728.936355318165;12757.55348562796;7093.787186384417;7112.6443677815905;7207.9279207207255;7232;7290.088738907637;6813.829654258584;6909.75815846453;7008;7013.964930175419;7024.683889224997;5849.736761845727;5871.677057761779;5959.314678811906;5996.970015149896;6002.339742628307;1594.3224129744813;1671.615528428444;1742.6950283700303;1762.3038899634828;1785.1788177438264;819.5779173725537;937.9916589666136;957.482959202037;975.7219192530094;992.9106380425796;16726.6654666906;17394.478165654797;17467.82532174662;17815.287388504315;17876.106194690212;890.3544929925881;922.2990527199242;936.0405584276035;943.1323182671821;975.7463059604554;9696;10184.847227291597;10254.692359229235;10314.690559283234;10374.740631484123;390349;391015;406347;406497;406607;70469.29530704627;70895;71144.64427677932;72092.2790772096;72184;954.3033585482498;966.6665000574791;980.2892902645525;1000.7598176437748;1002.5037606384741;15561.299741511886;15685.60785980314;15776;15845.841541584437;16198.109103999393;24714.876425617756;36002.4599631011;36911.26177476489;36964.26071478609;37385.252294954495;47060.52939470561;47479.287810683556;48880.75559622179;49482.505174947786;50383.74808126083;7604.809879752829;7704.768856934301;7740.690372385042;7814.921850781647;8022.719204827803;11802.586909458129;12093.81859272094;12228.144029918176;12318.876811231772;12354.629361119181;9976.650817221362;10115.898841011496;10138.543765530421;10151;10197.9490102549;10091.091801737879;10178.23663225276;10465.476726163814;10600.840987385041;10770.515326810155;10112.49437528106;10203.540840662337;10323.793524129325;10346.689599312032;10369.274150809371;7832.159442530887;7863.056433228049;7884;7900.2889739923685;7938.920610793818;9999.950000249952;10095.44475053879;10098;10199.13307368882;10301.381917084998 20:39:52 INFO - PROCESS | 3873 | |3;mootools.html;1200.6158029430585;1385.2104300548688;1421.2751496736662;1507.3217052326456;1694.5001224638731;6688.364605362489;7642.885356719654;7894.460580186866;7911.09022462417;8096.3118134958595;7909.564973926432;7936.127026027132;8000.239977202156;8000.519968801876;8000.639971201295;1852.231324000538;2157.913683452668;2193.7915897989706;2224.8998795054263;2226.955460890781;2247.685324054634;2285.223024171781;2286.6570014497875;2287.2909398086563;2288.7367952685486;2175.575762726269;2187.9343619691354;2195.1768086967386;2202.8678279303294;2203.2068455356057;1779.8398144166958;2100.422383844455;2121.6393213153724;2138.0165124043037;2177.6951226828255;2156.676498525218;2174.0542863854116;2174.6737989301573;2175.3039027511204;2176.6082105221053;7895.644695988694;7934.761957141295;7938.6427610757655;7955.323797477164;7959.920400795976;4545.522720114373;4668.953310466886;4670.626349892001;4673.579377856009;4674.392328997243;2830.5988535674974;2846.8576571171357;2993.8652760625823;3036.6811484794;3038.073387616776;913.1005959130251;930.5951910918704;948.9952550237205;966.792139689963;976.0922342221731;10511.737206569744;10541.683749487527;10566.735831604194;10583.417912014836;10636.308639938457;4194.6853985950565;4201.411802347674;4289.699721019561;4325.070109926381;4328.696991210585;9213.493257870747;9256.490893000815;9267.629294828266;9268.90731092694;9279;4714.316424118552;4722.456917454468;4725.314829349793;4727.7399743013775;4729.030548737501;3745.1011757178626;4132.607402296777;4247.5752424757275;4305.763183024964;4313.547077556874;3672.981635091861;3691.224842782992;3735.0475628714503;3782.0544863784053;3795.5635101963626;1160.6924165096257;1185.7509922916113;1186.7745128425572;1197.7963746163173;1201.831743555903;770.3413581387832;781.7185813107277;812.8333691593209;819.4837252530867;825.2078005115037;4914.336564563738;4968.105740966661;5041.294218809369;5124.282600435942;5130.1535246684625;873.3319010956624;890.2166093837382;890.7773056735816;893.5264309915755;894.5035505294494;3370.983145084308;3470.132466883279;3506.9123271918406;3512.3853325667906;3554.1647712787476;9435.952820235992;9626.229901607854;9666.516674166263;9690.176335011603;9787.608495660237;9669.613215471443;9669.854952175723;9670.516474176264;9698.854517182248;9700.805983880284;6940.375366217065;6951.339622735832;7026.15686117659;7105.218425973242;7117.92882071183;4842.612590992641;4887.291342755351;4910.43529994041;4914.36113305268;4991.57571606403;8475.57622118904;8487.915120848713;8503.064662886954;8505.74482765518;8571.914280857112;8425.283850872744;8475.194856488624;8686.609102590524;8687.348448866234;8691.087435819149;5795.884082318415;6346.365363463617;6591.901121483277;6592.868142637216;6664.366885145903;7739.3034626883855;7755.418343624138;7801.414893882868;7806.258405451473;7809.570473624005;6812.114425124702;6903.6203008835;6929.480288978448;7038.190608079932;7066.681999310146;6928.376446119873;6936.653167341714;6982.511224214256;7019.052427922165;7048.118985126859;5728.283964504437;5782.681952492485;5800.042992906123;5885.352611212677;5908.084246941559;4310.224159651293;4329.0259691569145;4335.956640433681;4385.627221686193;4426.712263702849;4378.693491455568;4491.034427598082;4514;4515.616172625232;4568.063546972929 20:39:52 INFO - PROCESS | 3873 | |4;prototype.html;301.19881116230823;304.0422668593929;308.3909279173634;308.4694325759694;308.5495177041518;4730.90538189236;4911.459739428665;4913.656044076916;4928.496808473423;4946.183879659852;4828.275758636198;4843.079814835188;4871.829485967992;4876;4907.165781817091;3573.6426357364185;3647.908802279938;3765.548134223897;3782.621737826209;3797.449369841378;3720.8511659533588;3746.213295207996;3774.4904437900805;3785.8988261514846;3794.829232684536;3690.3910854708943;3691.446283057536;3705.722070844684;3719.6466335698065;3739.551253849528;3539.407266729969;3595.173110184659;3712.7215458840424;3722.5532936047575;3744.2511497700298;3253.7559683023633;3261.429249881285;3274.8035117893;3275.4595491743835;3283.589551306087;4724.314974328738;4731.597814185799;4732.550407711296;4735.200623762948;4737.881552961169;4161.479815023122;4211.768352740598;4270.7864606769535;4274.529801721839;4280.4221430106845;5009.799608015675;5033.213209310678;5047.268146118829;5048.7223202723835;5053.444121146671;3574.964250357489;3576.856925722968;3577.0878426001464;3584.3189793939328;3588.910277243064;4926.00496798797;5267.973660131714;5293.100172970604;5304.708241046741;5308;3608.9458658120147;3630.7821530707715;3653.7577223743524;3661.139632186434;3668.2296717689583;3686.5806664434385;3692.7045836333027;3707.7775333480076;3722.9813850931114;3725;4224.324108142682;4224.662516611904;4226.619604235572;4239.236937351307;4244.898775106342;4773.427188737304;5030.119729047402;5031.4465408805;5047.384836852246;5051.82318618854;1264.1846009323936;1269.936503174856;1279.8592154862959;1283.857366943421;1285.5500574798746;821.8068753842842;831.8253166835033;838.3460900497622;864.5461132905275;880.4761167105562;4454.532274111237;4461.843835465743;4466.508684044752;4474.530174331713;4477.440319960005;5164.32863727713;5173.32746742921;5178.922316165261;5182.4299327073995;5186.792528298825;4296.677749168824;4465.397171381886;4469.754163520973;4479.17135329965;4500.234960056799;2758.7930905182193;2765.769232691473;2777.9027734029214;2779.3329600896045;2787.275308419785;4949.183384741549;4962.528559786814;4964.578010869117;4968.801247950114;4973.041040580849;5082.542571168613;5372.791121997519;5373.650712703662;5394.9460505394445;5395.217693434509;4936.703797772145;4959.454460009396;4975.104481193275;4979.278004689372;4989.775460104304;5218.530332270114;5241.50205730455;5276.736163191748;5277.182036784305;5279.656822306538;4892.657513973988;5195;5196.7401629917595;5199.870003249949;5200.531952124327;4907.141250281115;4920.237363208708;4938.234573641092;4987.8753031173055;4987.950120498894;3681.4477828325967;3700.851965921333;3713.164537979041;3725.27357165361;3729.608391119002;5102.438731739431;5260.894782104413;5270.920936186037;5279.9472005280995;5284.392294886137;5075.670081444694;5093;5097.413797413345;5106.642535022661;5108.948910510847;5051.722155281494;5055.823046193365;5070.797168113234;5106.285120083266;5107.668001579886;4774.379330686988;4994.525520075587;5021.4225364083595;5042.546170844642;5055.090083784954;4910.790144434947;4964.801407943642;5111.437741848319;5142.151544995034;5155.793768249228;5003;5012.624053195952;5032.647714659939;5037.19404895215;5047.343845300087 20:39:52 INFO - PROCESS | 3873 | |5;yui.html;632.7216024949022;648.7761722205837;657.0177584511157;736.0946036375257;746.2313816768726;12777.425015874285;13651.249181295025;13677.794833077487;13692.726145477085;13732.038757287006;12571.120021598492;12801.615951521446;12834.550790722327;12944.22334659921;13076.150050246728;608.1121562518728;762.0246085011195;776.6776787633125;777.4441274488739;780.3406121827047;764.4495962906698;795.9482633628795;804.2319584796505;805.3275514945028;805.907320658123;828.5484410995991;828.8466633672759;829.618375547249;829.7261903571807;832.5504227717025;642.9132067170918;798.9560574168419;822.268181318627;822.3832125905541;822.4284122534841;604.0606856338392;607.2045620237503;607.2318517075903;607.4441885674603;607.4957785038407;12555.246685198917;12586.622401327975;12591.118621696392;12601;12606.369681515887;12949.935250323782;13563.932180339134;13571.660708482366;13586.524471643545;13722.313884305844;11954.147107198398;12048.87951120495;12097.516099356015;12286.385680715928;12693.174943628635;4179.811908464096;4182.435371224876;4262.744235345889;4269.5516970718245;4294;61567;61664.69167654133;62383.688081559754;62769;62863.05705414422;10242;10372.170226381872;10387.84418233727;10436.165106791439;10742.78514429707;18872.33946811855;18883.433496995112;18907.716384254247;18948.715769263472;19038.80961190398;6956.165260168812;7006.649667516604;7076.540024898365;7147.64261786919;7395.297446742551;3695.501107350527;3760.360738674432;3772.641599048086;3802.657760801486;3814.809259537012;2841.502737021013;2914.8979785707825;2927.6194094767543;2941.044160647798;2945.5139901916373;496.8708135884696;509.1980131293228;510.65020460984346;516.8242797448886;517.2809794385806;441.7901496789;447.5502120369008;489.6132055675976;514.4161376837242;536.6350881400685;7691.884621730678;7733.110692270461;7737.508341051977;7909.288164065261;7962.721304754422;514.0720998597567;521.6817741177879;521.9608529360313;524.0959345129621;530.8487081181845;3563.768355056913;3642.581103173116;3727.7763334199494;3753.774773513598;4100.5899410059355;100715.49642251742;102627.4868625667;104555.4772226134;104835.47582262193;104863.47568262262;61232.69383653053;82727;84400.57799710962;84907.57546212229;85678.57160714157;77198;79421.60289198633;79657.60171199107;80251.59874200591;80929.78605320925;8657.567121643766;8778.56107194625;8931.330150238628;8947.910520894708;8962;44582.3312650304;45644;45690.31464527968;45812.770936145105;47194.52805471901;66116;70614.64692676504;71412;71549.63377746586;71883;11070.778584428428;11186.552537898719;11329.660110196708;11497.655070347902;11594.826077608674;11971.521139154336;12111.83051772476;12229.388530573258;12234.082443816927;12696.619101426972;12126.514939402325;12345.135840491439;12366.690832729253;12410.317432541297;12815.295158766357;11641.47613357384;11834.519838701579;11991.880081199077;12031.27812331263;12347.876521235032;11476.655700329004;11508.309501429942;11624.302541847177;12230.502530586205;12241.265524068584;9823.486564423889;10028.648997285352;10186.541605627617;10226.437545934747;10445.112165465716;9452.43285402878;9983.400995940267;10087.394756314645;10107.797844043225;10194.796104078025 20:39:52 INFO - PROCESS | 3873 | __end_tp_report 20:39:52 INFO - PROCESS | 3873 | __start_cc_report 20:39:52 INFO - PROCESS | 3873 | _x_x_mozilla_cycle_collect,1107 20:39:52 INFO - PROCESS | 3873 | __end_cc_report 20:39:52 INFO - PROCESS | 3873 | __startTimestamp1467171592087__endTimestamp 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | ------- Summary: start ------- 20:39:52 INFO - PROCESS | 3873 | Number of tests: 6 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | [#0] dojo.html Cycles:165 Average:4785.84 Median:4923.16 stddev:517.88 (10.5%) stddev-sans-first:491.20 20:39:52 INFO - PROCESS | 3873 | Values: 2634.4 2636.6 2674.2 2688.0 2691.0 4713.4 4728.2 4788.2 4793.2 4844.3 4777.1 4784.5 4787.7 4847.8 4869.4 4337.4 4362.1 4421.6 4447.9 4560.0 4464.5 4482.3 4512.0 4517.1 4546.9 4284.6 4338.3 4345.1 4371.1 4412.7 4352.4 4360.6 4362.3 4409.4 4415.4 4386.5 4387.7 4400.1 4433.9 4442.6 4675.4 4741.7 4814.5 4822.2 4833.2 5180.2 5207.3 5222.0 5230.1 5234.7 5243.9 5278.7 5285.9 5289.7 5293.7 4712.5 4798.0 4844.9 4863.5 4916.3 5373.0 5396.4 5399.7 5400.8 5404.1 4923.2 5158.4 5164.1 5166.8 5167.9 5110.0 5141.0 5151.0 5227.9 5244.7 5141.0 5141.6 5147.3 5147.8 5150.2 5105.8 5109.5 5148.0 5149.0 5185.1 4246.0 4286.5 4319.9 4371.3 4378.0 3834.6 3843.4 3852.4 3876.0 3936.3 4465.2 4476.7 4480.5 4520.6 4524.6 4967.4 5151.2 5181.1 5211.1 5271.3 4450.1 4467.8 4468.1 4502.6 4514.0 4692.2 4695.8 4704.8 4731.2 4752.2 4734.9 4857.1 4905.5 4912.6 4915.9 5212.9 5214.6 5223.3 5223.4 5233.7 4925.5 4931.2 4934.2 4934.7 4947.6 4949.4 5060.4 5109.1 5136.1 5145.6 5175.0 5221.8 5223.7 5229.0 5278.0 4890.3 5057.9 5083.2 5083.8 5083.8 5008.6 5035.3 5061.6 5074.2 5091.0 5012.8 5022.2 5042.2 5068.7 5075.9 4881.9 4995.1 5118.3 5158.7 5173.4 4948.8 4951.1 4977.1 4977.3 5027.3 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | [#1] ext.html Cycles:180 Average:47075.99 Median:36584.54 stddev:85135.56 (232.7%) stddev-sans-first:85302.70 20:39:52 INFO - PROCESS | 3873 | Values: 545.9 577.5 578.4 586.3 601.4 27055.7 39309.2 40369.0 40402.6 40462.4 41225.8 41601.6 41604.0 41672.4 41718.6 7611.4 7792.6 7924.2 7926.4 7929.1 7600.4 7830.4 7857.1 10000.9 10275.6 9948.5 9981.7 9988.5 9993.0 9993.1 10198.1 10263.0 10268.9 10280.4 10283.2 7612.9 7844.9 7845.1 9785.8 10189.9 38238.0 38386.2 38418.4 38457.0 38459.0 3020.0 3046.6 3149.8 3171.1 3549.1 28743.7 28878.0 29364.4 29503.7 29909.7 3464.9 3522.5 3593.5 3599.1 3623.7 176993.0 177402.0 177643.0 177695.0 177745.0 51785.5 52340.0 52359.5 52473.0 52498.5 55124.0 55222.0 55265.7 55292.2 55395.2 13850.9 14289.4 14315.6 14316.8 14318.2 9959.2 11410.5 11451.7 11497.0 11508.2 15155.6 15516.7 15614.7 16058.3 16085.4 5495.5 5564.1 5596.2 5755.1 5804.3 819.7 910.0 928.6 980.2 1021.9 26591.6 27649.1 28231.0 28352.4 28552.1 968.9 978.0 985.6 1032.7 1036.9 14429.4 15020.8 15062.7 15077.2 15077.6 391297.0 391872.0 392527.0 392952.0 393139.0 49668.0 49915.8 49997.0 50030.5 50130.5 1066.1 1183.5 1195.1 1268.5 1351.6 26281.2 29935.6 30326.7 30390.5 30891.0 43114.8 43158.8 43870.3 43915.3 43920.8 350207.0 355597.0 356156.0 357478.0 357819.0 32801.8 33803.0 37956.8 38726.8 38737.2 41651.4 42065.4 42103.2 42238.8 43317.6 35743.6 36101.8 36228.6 36636.0 36638.0 37019.6 37049.1 37238.3 37270.0 37443.8 35403.0 35974.8 36050.8 36243.8 36533.1 31790.4 32686.2 33373.5 33508.8 33634.7 24911.3 25083.2 25495.7 25581.0 25843.0 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | [#2] jquery.html Cycles:180 Average:24465.91 Median:384.35 stddev:65803.40 (17120.9%) stddev-sans-first:65963.11 20:39:52 INFO - PROCESS | 3873 | Values: 363.6 369.1 370.0 383.2 385.5 15873.9 17446.8 17965.8 17976.5 18000.4 15176.0 16385.6 16589.7 16639.3 16760.2 5091.7 5207.3 5236.8 5268.5 5271.2 3595.5 3814.5 5143.8 5824.4 6188.4 6206.8 6223.8 6226.1 6245.1 6251.2 5926.1 6058.3 6102.2 6103.6 6113.2 3285.5 4969.4 5312.5 5315.8 5316.5 19641.5 20413.7 20456.8 20544.7 20555.8 2068.3 2181.5 2283.3 2310.1 2536.1 12831.7 13259.2 13284.7 13986.0 14045.0 1655.4 1767.7 1770.0 1772.8 1797.4 66600.3 67364.3 68550.0 68863.0 69304.7 9032.2 9170.5 9318.4 9364.8 9583.9 12583.6 12703.6 12716.0 12728.9 12757.6 7093.8 7112.6 7207.9 7232.0 7290.1 6813.8 6909.8 7008.0 7014.0 7024.7 5849.7 5871.7 5959.3 5997.0 6002.3 1594.3 1671.6 1742.7 1762.3 1785.2 819.6 938.0 957.5 975.7 992.9 16726.7 17394.5 17467.8 17815.3 17876.1 890.4 922.3 936.0 943.1 975.7 9696.0 10184.8 10254.7 10314.7 10374.7 390349.0 391015.0 406347.0 406497.0 406607.0 70469.3 70895.0 71144.6 72092.3 72184.0 954.3 966.7 980.3 1000.8 1002.5 15561.3 15685.6 15776.0 15845.8 16198.1 24714.9 36002.5 36911.3 36964.3 37385.3 47060.5 47479.3 48880.8 49482.5 50383.7 7604.8 7704.8 7740.7 7814.9 8022.7 11802.6 12093.8 12228.1 12318.9 12354.6 9976.7 10115.9 10138.5 10151.0 10197.9 10091.1 10178.2 10465.5 10600.8 10770.5 10112.5 10203.5 10323.8 10346.7 10369.3 7832.2 7863.1 7884.0 7900.3 7938.9 10000.0 10095.4 10098.0 10199.1 10301.4 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | [#3] mootools.html Cycles:180 Average:5100.57 Median:4979.84 stddev:2861.85 (57.5%) stddev-sans-first:2854.87 20:39:52 INFO - PROCESS | 3873 | Values: 1200.6 1385.2 1421.3 1507.3 1694.5 6688.4 7642.9 7894.5 7911.1 8096.3 7909.6 7936.1 8000.2 8000.5 8000.6 1852.2 2157.9 2193.8 2224.9 2227.0 2247.7 2285.2 2286.7 2287.3 2288.7 2175.6 2187.9 2195.2 2202.9 2203.2 1779.8 2100.4 2121.6 2138.0 2177.7 2156.7 2174.1 2174.7 2175.3 2176.6 7895.6 7934.8 7938.6 7955.3 7959.9 4545.5 4669.0 4670.6 4673.6 4674.4 2830.6 2846.9 2993.9 3036.7 3038.1 913.1 930.6 949.0 966.8 976.1 10511.7 10541.7 10566.7 10583.4 10636.3 4194.7 4201.4 4289.7 4325.1 4328.7 9213.5 9256.5 9267.6 9268.9 9279.0 4714.3 4722.5 4725.3 4727.7 4729.0 3745.1 4132.6 4247.6 4305.8 4313.5 3673.0 3691.2 3735.0 3782.1 3795.6 1160.7 1185.8 1186.8 1197.8 1201.8 770.3 781.7 812.8 819.5 825.2 4914.3 4968.1 5041.3 5124.3 5130.2 873.3 890.2 890.8 893.5 894.5 3371.0 3470.1 3506.9 3512.4 3554.2 9436.0 9626.2 9666.5 9690.2 9787.6 9669.6 9669.9 9670.5 9698.9 9700.8 6940.4 6951.3 7026.2 7105.2 7117.9 4842.6 4887.3 4910.4 4914.4 4991.6 8475.6 8487.9 8503.1 8505.7 8571.9 8425.3 8475.2 8686.6 8687.3 8691.1 5795.9 6346.4 6591.9 6592.9 6664.4 7739.3 7755.4 7801.4 7806.3 7809.6 6812.1 6903.6 6929.5 7038.2 7066.7 6928.4 6936.7 6982.5 7019.1 7048.1 5728.3 5782.7 5800.0 5885.4 5908.1 4310.2 4329.0 4336.0 4385.6 4426.7 4378.7 4491.0 4514.0 4515.6 4568.1 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | [#4] prototype.html Cycles:180 Average:4203.56 Median:4873.91 stddev:1232.94 (25.3%) stddev-sans-first:1201.11 20:39:52 INFO - PROCESS | 3873 | Values: 301.2 304.0 308.4 308.5 308.5 4730.9 4911.5 4913.7 4928.5 4946.2 4828.3 4843.1 4871.8 4876.0 4907.2 3573.6 3647.9 3765.5 3782.6 3797.4 3720.9 3746.2 3774.5 3785.9 3794.8 3690.4 3691.4 3705.7 3719.6 3739.6 3539.4 3595.2 3712.7 3722.6 3744.3 3253.8 3261.4 3274.8 3275.5 3283.6 4724.3 4731.6 4732.6 4735.2 4737.9 4161.5 4211.8 4270.8 4274.5 4280.4 5009.8 5033.2 5047.3 5048.7 5053.4 3575.0 3576.9 3577.1 3584.3 3588.9 4926.0 5268.0 5293.1 5304.7 5308.0 3608.9 3630.8 3653.8 3661.1 3668.2 3686.6 3692.7 3707.8 3723.0 3725.0 4224.3 4224.7 4226.6 4239.2 4244.9 4773.4 5030.1 5031.4 5047.4 5051.8 1264.2 1269.9 1279.9 1283.9 1285.6 821.8 831.8 838.3 864.5 880.5 4454.5 4461.8 4466.5 4474.5 4477.4 5164.3 5173.3 5178.9 5182.4 5186.8 4296.7 4465.4 4469.8 4479.2 4500.2 2758.8 2765.8 2777.9 2779.3 2787.3 4949.2 4962.5 4964.6 4968.8 4973.0 5082.5 5372.8 5373.7 5394.9 5395.2 4936.7 4959.5 4975.1 4979.3 4989.8 5218.5 5241.5 5276.7 5277.2 5279.7 4892.7 5195.0 5196.7 5199.9 5200.5 4907.1 4920.2 4938.2 4987.9 4988.0 3681.4 3700.9 3713.2 3725.3 3729.6 5102.4 5260.9 5270.9 5279.9 5284.4 5075.7 5093.0 5097.4 5106.6 5108.9 5051.7 5055.8 5070.8 5106.3 5107.7 4774.4 4994.5 5021.4 5042.5 5055.1 4910.8 4964.8 5111.4 5142.2 5155.8 5003.0 5012.6 5032.6 5037.2 5047.3 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - PROCESS | 3873 | [#5] yui.html Cycles:180 Average:18318.22 Median:4281.78 stddev:26322.69 (614.8%) stddev-sans-first:26363.04 20:39:52 INFO - PROCESS | 3873 | Values: 632.7 648.8 657.0 736.1 746.2 12777.4 13651.2 13677.8 13692.7 13732.0 12571.1 12801.6 12834.6 12944.2 13076.2 608.1 762.0 776.7 777.4 780.3 764.4 795.9 804.2 805.3 805.9 828.5 828.8 829.6 829.7 832.6 642.9 799.0 822.3 822.4 822.4 604.1 607.2 607.2 607.4 607.5 12555.2 12586.6 12591.1 12601.0 12606.4 12949.9 13563.9 13571.7 13586.5 13722.3 11954.1 12048.9 12097.5 12286.4 12693.2 4179.8 4182.4 4262.7 4269.6 4294.0 61567.0 61664.7 62383.7 62769.0 62863.1 10242.0 10372.2 10387.8 10436.2 10742.8 18872.3 18883.4 18907.7 18948.7 19038.8 6956.2 7006.6 7076.5 7147.6 7395.3 3695.5 3760.4 3772.6 3802.7 3814.8 2841.5 2914.9 2927.6 2941.0 2945.5 496.9 509.2 510.7 516.8 517.3 441.8 447.6 489.6 514.4 536.6 7691.9 7733.1 7737.5 7909.3 7962.7 514.1 521.7 522.0 524.1 530.8 3563.8 3642.6 3727.8 3753.8 4100.6 100715.5 102627.5 104555.5 104835.5 104863.5 61232.7 82727.0 84400.6 84907.6 85678.6 77198.0 79421.6 79657.6 80251.6 80929.8 8657.6 8778.6 8931.3 8947.9 8962.0 44582.3 45644.0 45690.3 45812.8 47194.5 66116.0 70614.6 71412.0 71549.6 71883.0 11070.8 11186.6 11329.7 11497.7 11594.8 11971.5 12111.8 12229.4 12234.1 12696.6 12126.5 12345.1 12366.7 12410.3 12815.3 11641.5 11834.5 11991.9 12031.3 12347.9 11476.7 11508.3 11624.3 12230.5 12241.3 9823.5 10028.6 10186.5 10226.4 10445.1 9452.4 9983.4 10087.4 10107.8 10194.8 20:39:52 INFO - PROCESS | 3873 | -------- Summary: end -------- 20:39:52 INFO - PROCESS | 3873 | 20:39:52 INFO - TEST-INFO | 3873: exit 0 20:39:52 INFO - TEST-OK | dromaeo_css | took 1120957ms 20:39:52 INFO - TEST-START | kraken 20:39:52 INFO - operating with platform_type : linux_ 20:39:52 INFO - Initialising browser for kraken test... 20:39:52 INFO - TEST-INFO | started process 4053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFLqFQ/profile http://localhost:52320/getInfo.html) 20:39:58 INFO - PROCESS | 4053 | __metrics Screen width/height:1600/1200 20:39:58 INFO - PROCESS | 4053 | colorDepth:24 20:39:58 INFO - PROCESS | 4053 | Browser inner width/height: 1024/697 20:39:58 INFO - PROCESS | 4053 | __metrics 20:39:59 INFO - PROCESS | 4053 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:40:00 INFO - TEST-INFO | 4053: exit 0 20:40:00 INFO - Browser initialized. 20:40:00 INFO - Running cycle 1/1 for kraken test... 20:40:00 INFO - TEST-INFO | started process 4137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFLqFQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:12 INFO - PROCESS | 4137 | RSS: Main: 158281728 20:40:12 INFO - PROCESS | 4137 | 20:40:15 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52320/tests/kraken/driver.html?testName=audio-beat-detection) 20:40:16 INFO - PROCESS | 4137 | RSS: Main: 216076288 20:40:16 INFO - PROCESS | 4137 | 20:40:19 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52320/tests/kraken/driver.html?testName=audio-dft) 20:40:19 INFO - PROCESS | 4137 | RSS: Main: 204701696 20:40:19 INFO - PROCESS | 4137 | 20:40:22 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52320/tests/kraken/driver.html?testName=audio-fft) 20:40:23 INFO - PROCESS | 4137 | RSS: Main: 270655488 20:40:23 INFO - PROCESS | 4137 | 20:40:25 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52320/tests/kraken/driver.html?testName=audio-oscillator) 20:40:26 INFO - PROCESS | 4137 | RSS: Main: 181186560 20:40:26 INFO - PROCESS | 4137 | 20:40:28 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:40:29 INFO - PROCESS | 4137 | RSS: Main: 185249792 20:40:29 INFO - PROCESS | 4137 | 20:40:32 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52320/tests/kraken/driver.html?testName=imaging-darkroom) 20:40:32 INFO - PROCESS | 4137 | RSS: Main: 221200384 20:40:32 INFO - PROCESS | 4137 | 20:40:36 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52320/tests/kraken/driver.html?testName=imaging-desaturate) 20:40:36 INFO - PROCESS | 4137 | RSS: Main: 216412160 20:40:36 INFO - PROCESS | 4137 | 20:40:39 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52320/tests/kraken/driver.html?testName=json-parse-financial) 20:40:40 INFO - PROCESS | 4137 | RSS: Main: 219836416 20:40:40 INFO - PROCESS | 4137 | 20:40:42 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:40:42 INFO - PROCESS | 4137 | RSS: Main: 205819904 20:40:42 INFO - PROCESS | 4137 | 20:40:44 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:40:45 INFO - PROCESS | 4137 | RSS: Main: 211316736 20:40:45 INFO - PROCESS | 4137 | 20:40:47 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:40:48 INFO - PROCESS | 4137 | RSS: Main: 215711744 20:40:48 INFO - PROCESS | 4137 | 20:40:50 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:40:51 INFO - PROCESS | 4137 | RSS: Main: 235868160 20:40:51 INFO - PROCESS | 4137 | 20:40:54 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:54 INFO - PROCESS | 4137 | RSS: Main: 230416384 20:40:54 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | Cycle 1(1): loaded http://localhost:52320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52320/tests/kraken/driver.html?testName=ai-astar) 20:40:56 INFO - PROCESS | 4137 | RSS: Main: 272670720 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | __start_tp_report 20:40:56 INFO - PROCESS | 4137 | _x_x_mozilla_page_load 20:40:56 INFO - PROCESS | 4137 | _x_x_mozilla_page_load_details 20:40:56 INFO - PROCESS | 4137 | |i|pagename|runs| 20:40:56 INFO - PROCESS | 4137 | |0;ai-astar;104;113;112;112;112;114;112;111;113;112 20:40:56 INFO - PROCESS | 4137 | |1;audio-beat-detection;164;138;136;177;134;140;132;151;168;129 20:40:56 INFO - PROCESS | 4137 | |2;audio-dft;162;162;162;159;161;162;161;162;159;162 20:40:56 INFO - PROCESS | 4137 | |3;audio-fft;74;74;75;121;75;77;74;76;97;76 20:40:56 INFO - PROCESS | 4137 | |4;audio-oscillator;86;87;123;86;86;85;113;86;86;127 20:40:56 INFO - PROCESS | 4137 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;118;117;117 20:40:56 INFO - PROCESS | 4137 | |6;imaging-darkroom;147;147;146;148;147;147;147;146;147;146 20:40:56 INFO - PROCESS | 4137 | |7;imaging-desaturate;95;94;95;95;94;95;94;95;95;94 20:40:56 INFO - PROCESS | 4137 | |8;json-parse-financial;63;65;65;65;65;65;64;64;64;65 20:40:56 INFO - PROCESS | 4137 | |9;json-stringify-tinderbox;64;66;64;64;65;64;64;67;65;64 20:40:56 INFO - PROCESS | 4137 | |10;stanford-crypto-aes;88;82;81;88;84;82;84;84;142;87 20:40:56 INFO - PROCESS | 4137 | |11;stanford-crypto-ccm;135;130;127;129;132;136;138;146;130;128 20:40:56 INFO - PROCESS | 4137 | |12;stanford-crypto-pbkdf2;167;165;163;164;164;165;164;164;164;161 20:40:56 INFO - PROCESS | 4137 | |13;stanford-crypto-sha256-iterative;66;67;67;65;67;66;66;64;65;65 20:40:56 INFO - PROCESS | 4137 | __end_tp_report 20:40:56 INFO - PROCESS | 4137 | __start_cc_report 20:40:56 INFO - PROCESS | 4137 | _x_x_mozilla_cycle_collect,1922 20:40:56 INFO - PROCESS | 4137 | __end_cc_report 20:40:56 INFO - PROCESS | 4137 | __startTimestamp1467171656958__endTimestamp 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | ------- Summary: start ------- 20:40:56 INFO - PROCESS | 4137 | Number of tests: 14 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 20:40:56 INFO - PROCESS | 4137 | Values: 104.0 113.0 112.0 112.0 112.0 114.0 112.0 111.0 113.0 112.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:145.50 stddev:17.05 (11.7%) stddev-sans-first:16.92 20:40:56 INFO - PROCESS | 4137 | Values: 164.0 138.0 136.0 177.0 134.0 140.0 132.0 151.0 168.0 129.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 20:40:56 INFO - PROCESS | 4137 | Values: 162.0 162.0 162.0 159.0 161.0 162.0 161.0 162.0 159.0 162.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.50 stddev:15.39 (20.4%) stddev-sans-first:16.06 20:40:56 INFO - PROCESS | 4137 | Values: 74.0 74.0 75.0 121.0 75.0 77.0 74.0 76.0 97.0 76.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:86.00 stddev:17.25 (20.1%) stddev-sans-first:17.87 20:40:56 INFO - PROCESS | 4137 | Values: 86.0 87.0 123.0 86.0 86.0 85.0 113.0 86.0 86.0 127.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:40:56 INFO - PROCESS | 4137 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:40:56 INFO - PROCESS | 4137 | Values: 147.0 147.0 146.0 148.0 147.0 147.0 147.0 146.0 147.0 146.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:40:56 INFO - PROCESS | 4137 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 20:40:56 INFO - PROCESS | 4137 | Values: 63.0 65.0 65.0 65.0 65.0 65.0 64.0 64.0 64.0 65.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:64.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 20:40:56 INFO - PROCESS | 4137 | Values: 64.0 66.0 64.0 64.0 65.0 64.0 64.0 67.0 65.0 64.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:84.00 stddev:18.37 (21.9%) stddev-sans-first:19.47 20:40:56 INFO - PROCESS | 4137 | Values: 88.0 82.0 81.0 88.0 84.0 82.0 84.0 84.0 142.0 87.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:133.50 stddev:5.80 (4.3%) stddev-sans-first:6.11 20:40:56 INFO - PROCESS | 4137 | Values: 135.0 130.0 127.0 129.0 132.0 136.0 138.0 146.0 130.0 128.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:1.52 (0.9%) stddev-sans-first:1.20 20:40:56 INFO - PROCESS | 4137 | Values: 167.0 165.0 163.0 164.0 164.0 165.0 164.0 164.0 164.0 161.0 20:40:56 INFO - PROCESS | 4137 | 20:40:56 INFO - PROCESS | 4137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 20:40:56 INFO - PROCESS | 4137 | Values: 66.0 67.0 67.0 65.0 67.0 66.0 66.0 64.0 65.0 65.0 20:40:56 INFO - PROCESS | 4137 | -------- Summary: end -------- 20:40:56 INFO - PROCESS | 4137 | 20:40:58 INFO - TEST-INFO | 4137: exit 0 20:40:58 INFO - TEST-OK | kraken | took 65459ms 20:40:58 INFO - SUITE-END | took 1186s 20:40:58 INFO - Completed test suite (00:19:46) 20:40:58 INFO - javascript benchmark 20:40:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.420427505948, 2636.5517861963463, 2674.157640343291, 2687.959680604791, 2690.9596356054662, 4713.410823647044, 4728.1962066448705, 4788.186008378575, 4793.209120495123, 4844.346013288209, 4777.116233496806, 4784.545468180518, 4787.736674482902, 4847.806087756486, 4869.440014398345, 4337.436133302666, 4362.0621566363225, 4421.624161946223, 4447.866564003069, 4560.042391097873, 4464.486584042828, 4482.305242687388, 4512.0, 4517.051419201972, 4546.931796023062, 4284.5715428457215, 4338.327559228324, 4345.109252603209, 4371.103923695667, 4412.713173643735, 4352.434183556149, 4360.585744354281, 4362.302031674917, 4409.382686423904, 4415.359772832953, 4386.517483076859, 4387.670924680661, 4400.075984043323, 4433.9113217735785, 4442.555744425564, 4675.368825208588, 4741.715497070187, 4814.518548145193, 4822.228443449067, 4833.154198015333, 5180.248863914749, 5207.3490813648295, 5221.973890130525, 5230.08473517133, 5234.685918844843, 5243.9213411798855, 5278.736063196825, 5285.920711189336, 5289.656172348785, 5293.655912365684, 4712.458067322234, 4798.04039192163, 4844.903101937942, 4863.489333619989, 4916.311716359713, 5373.032854086224, 5396.4333744957, 5399.70301633414, 5400.756965936543, 5404.054290499147, 4923.163062279421, 5158.38099428071, 5164.122099243138, 5166.793328266903, 5167.948320516747, 5110.003549307924, 5141.048905952411, 5151.047056294523, 5227.895442091213, 5244.659097158673, 5140.974295128575, 5141.5886729061585, 5147.3308469898675, 5147.845564633067, 5150.150225212873, 5105.770240339194, 5109.514596113363, 5148.047611191867, 5149.0, 5185.066687996122, 4246.002189485468, 4286.5284818669925, 4319.870403887889, 4371.300591905344, 4377.978110109493, 3834.5973672764517, 3843.385058390644, 3852.3643598806443, 3875.9612403876163, 3936.3111455495173, 4465.151621191963, 4476.686631935733, 4480.529544397857, 4520.570545798144, 4524.5927866492175, 4967.3542439482635, 5151.201563757623, 5181.06740786662, 5211.114110601206, 5271.262023316739, 4450.065486247924, 4467.821287148543, 4468.128714900563, 4502.594766471033, 4513.977430112828, 4692.249240121564, 4695.765211739399, 4704.764761761899, 4731.1720448921305, 4752.1921273383605, 4734.857954261378, 4857.077155340474, 4905.460399355997, 4912.606991440676, 4915.877103072452, 5212.869678257922, 5214.582833373397, 5223.347081614798, 5223.373195216598, 5233.685978841282, 4925.48282430354, 4931.186354251508, 4934.161192597196, 4934.7285899275885, 4947.579455746302, 4949.381327334083, 5060.367454068241, 5109.1059064662795, 5136.075506408883, 5145.639805213749, 5174.974125129501, 5221.765020574007, 5223.712695801767, 5229.0, 5278.0, 4890.339804126397, 5057.8735531612, 5083.237514372726, 5083.822066227664, 5083.822066227664, 5008.599312054954, 5035.345405097314, 5061.645684802029, 5074.213496907985, 5091.0, 5012.799488020584, 5022.221555658879, 5042.193249080129, 5068.695878247317, 5075.87310317245, 4881.8535443936735, 4995.100881841304, 5118.283440318432, 5158.716270605153, 5173.3533308336455, 4948.752562371795, 4951.084049450863, 4977.0792403405485, 4977.303177555073, 5027.321311622884], "value": 4751.772108690605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.8847554809383, 577.4802677590166, 578.3522454850568, 586.3023002626875, 601.3895895665898, 27055.729442705593, 39309.21381572367, 40369.0, 40402.595974040254, 40462.393064104064, 41225.79387103068, 41601.58398416015, 41604.0, 41672.37491437623, 41718.58281417185, 7611.353034992005, 7792.610369481517, 7924.167962363927, 7926.445148839583, 7929.088154862178, 7600.391968642495, 7830.412719046066, 7857.1357150713375, 10000.89999100007, 10275.588976440971, 9948.452835094067, 9981.700548983543, 9988.500574971258, 9992.95003524985, 9993.100620944113, 10198.082172604463, 10263.025012623788, 10268.94865525675, 10280.383177009404, 10283.228757843191, 7612.885806712904, 7844.9215507844765, 7845.058592968823, 9785.755356116155, 10189.89810101897, 38238.0, 38386.23227535462, 38418.42372364417, 38457.0, 38459.0, 3020.048684664324, 3046.558249053897, 3149.826759528225, 3171.1120886151684, 3549.0730480098296, 28743.712562874312, 28878.0, 29364.412711745645, 29503.70496295031, 29909.70090299091, 3464.8787292444645, 3522.5068490411363, 3593.5148754918273, 3599.1362073102528, 3623.6738693517445, 176993.0, 177402.0, 177643.0, 177694.99999999872, 177745.0, 51785.48214517882, 52340.0, 52359.47640523546, 52473.0, 52498.47501524936, 55124.0, 55222.0, 55265.72367138138, 55292.170617440774, 55395.16907246395, 13850.861491385158, 14289.428422863177, 14315.57053288403, 14316.785248221286, 14318.212498312692, 9959.153471954965, 11410.543578256942, 11451.656450306504, 11497.0, 11508.194426390073, 15155.621109472351, 15516.68966620684, 15614.687706245812, 16058.27737751804, 16085.437009704838, 5495.505404513613, 5564.137558678412, 5596.244506991586, 5755.107958266475, 5804.3300081961925, 819.7375244325704, 910.0217266438605, 928.5960607135918, 980.1815484070738, 1021.9131373833308, 26591.601125983125, 27649.112382084073, 28231.0, 28352.43295134086, 28552.143435696962, 968.9370190937567, 977.9804403911882, 985.5515740338129, 1032.6850310655173, 1036.9170466362823, 14429.422823087169, 15020.849791502163, 15062.698746025018, 15077.170755608548, 15077.594327928826, 391297.0, 391872.0, 392527.0, 392952.0, 393139.0, 49668.0, 49915.75042124766, 49997.0, 50030.49969500258, 50130.49869501258, 1066.088494337346, 1183.526589364261, 1195.0857593940643, 1268.543324403214, 1351.601277623084, 26281.21156365312, 29935.55096673595, 30326.696733032386, 30390.544141837447, 30891.0, 43114.78442607767, 43158.784206080025, 43870.34194487021, 43915.34126988162, 43920.78039609781, 350207.0, 355597.0, 356156.0, 357478.0, 357819.0, 32801.83599081989, 33803.0, 37956.810215948746, 38726.80636596799, 38737.225255494166, 41651.37522937098, 42065.369019464124, 42103.15793684171, 42238.788806055774, 43317.566824331356, 35743.64256357403, 36101.81949090238, 36228.63771362253, 36636.0, 36638.0, 37019.62980370269, 37049.109843466045, 37238.25523489569, 37270.0, 37443.81278093592, 35403.0, 35974.820125899205, 36050.819745901106, 36243.81878090592, 36533.08667283339, 31790.36419271648, 32686.20225887599, 33373.49939750954, 33508.83245583757, 33634.66365336413, 24911.252662420156, 25083.24750257495, 25495.74504255008, 25581.0, 25843.0], "value": 17926.196528354794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.58551251573203, 369.10281154864003, 369.9759515631482, 383.1513198265841, 385.54120596490174, 15873.920630396846, 17446.825531744693, 17965.820341796578, 17976.460706178834, 18000.36998705044, 15176.0, 16385.590360241, 16589.66820663589, 16639.251233694482, 16760.245788939497, 5091.719955402451, 5207.323048003755, 5236.842894713146, 5268.473152684739, 5271.15661494161, 3595.496630471736, 3814.5231846019246, 5143.81996630118, 5824.388439213885, 6188.412100850434, 6206.813795586139, 6223.751049957997, 6226.066090086478, 6245.063240513914, 6251.187345645059, 5926.051831706928, 6058.3335833058545, 6102.206713127265, 6103.603265787732, 6113.23584551931, 3285.474324108155, 4969.4036715594, 5312.5218730314455, 5315.813946511892, 5316.521513063843, 19641.508962275915, 20413.69379459309, 20456.795432045637, 20544.691829622567, 20555.79444205569, 2068.3174552397672, 2181.498255401251, 2283.292179424384, 2310.122153581628, 2536.07433286849, 12831.679208019781, 13259.204447733167, 13284.73430531384, 13986.0, 14045.0, 1655.4040545403645, 1767.7348397740313, 1769.9557511062199, 1772.769539959797, 1797.3978717129778, 66600.3339966599, 67364.32635673629, 68550.0, 68863.0, 69304.65347673229, 9032.187103160748, 9170.541472926461, 9318.440893546272, 9364.812703746024, 9583.90416095844, 12583.622491325275, 12703.618891433272, 12716.0, 12728.936355318165, 12757.55348562796, 7093.787186384417, 7112.6443677815905, 7207.9279207207255, 7232.0, 7290.088738907637, 6813.829654258584, 6909.75815846453, 7008.0, 7013.964930175419, 7024.683889224997, 5849.736761845727, 5871.677057761779, 5959.314678811906, 5996.970015149896, 6002.339742628307, 1594.3224129744813, 1671.615528428444, 1742.6950283700303, 1762.3038899634828, 1785.1788177438264, 819.5779173725537, 937.9916589666136, 957.482959202037, 975.7219192530094, 992.9106380425796, 16726.6654666906, 17394.478165654797, 17467.82532174662, 17815.287388504315, 17876.106194690212, 890.3544929925881, 922.2990527199242, 936.0405584276035, 943.1323182671821, 975.7463059604554, 9696.0, 10184.847227291597, 10254.692359229235, 10314.690559283234, 10374.740631484123, 390349.0, 391015.0, 406347.0, 406497.0, 406607.0, 70469.29530704627, 70895.0, 71144.64427677932, 72092.2790772096, 72184.0, 954.3033585482498, 966.6665000574791, 980.2892902645525, 1000.7598176437748, 1002.5037606384741, 15561.299741511886, 15685.60785980314, 15776.0, 15845.841541584437, 16198.109103999393, 24714.876425617756, 36002.4599631011, 36911.26177476489, 36964.26071478609, 37385.252294954495, 47060.52939470561, 47479.287810683556, 48880.75559622179, 49482.505174947786, 50383.74808126083, 7604.809879752829, 7704.768856934301, 7740.690372385042, 7814.921850781647, 8022.719204827803, 11802.586909458129, 12093.81859272094, 12228.144029918176, 12318.876811231772, 12354.629361119181, 9976.650817221362, 10115.898841011496, 10138.543765530421, 10151.0, 10197.9490102549, 10091.091801737879, 10178.23663225276, 10465.476726163814, 10600.840987385041, 10770.515326810155, 10112.49437528106, 10203.540840662337, 10323.793524129325, 10346.689599312032, 10369.274150809371, 7832.159442530887, 7863.056433228049, 7884.0, 7900.2889739923685, 7938.920610793818, 9999.950000249952, 10095.44475053879, 10098.0, 10199.13307368882, 10301.381917084998], "value": 8426.823256711188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.6158029430585, 1385.2104300548688, 1421.2751496736662, 1507.3217052326456, 1694.5001224638731, 6688.364605362489, 7642.885356719654, 7894.460580186866, 7911.09022462417, 8096.3118134958595, 7909.564973926432, 7936.127026027132, 8000.239977202156, 8000.519968801876, 8000.639971201295, 1852.231324000538, 2157.913683452668, 2193.7915897989706, 2224.8998795054263, 2226.955460890781, 2247.685324054634, 2285.223024171781, 2286.6570014497875, 2287.2909398086563, 2288.7367952685486, 2175.575762726269, 2187.9343619691354, 2195.1768086967386, 2202.8678279303294, 2203.2068455356057, 1779.8398144166958, 2100.422383844455, 2121.6393213153724, 2138.0165124043037, 2177.6951226828255, 2156.676498525218, 2174.0542863854116, 2174.6737989301573, 2175.3039027511204, 2176.6082105221053, 7895.644695988694, 7934.761957141295, 7938.6427610757655, 7955.323797477164, 7959.920400795976, 4545.522720114373, 4668.953310466886, 4670.626349892001, 4673.579377856009, 4674.392328997243, 2830.5988535674974, 2846.8576571171357, 2993.8652760625823, 3036.6811484794, 3038.073387616776, 913.1005959130251, 930.5951910918704, 948.9952550237205, 966.792139689963, 976.0922342221731, 10511.737206569744, 10541.683749487527, 10566.735831604194, 10583.417912014836, 10636.308639938457, 4194.6853985950565, 4201.411802347674, 4289.699721019561, 4325.070109926381, 4328.696991210585, 9213.493257870747, 9256.490893000815, 9267.629294828266, 9268.90731092694, 9279.0, 4714.316424118552, 4722.456917454468, 4725.314829349793, 4727.7399743013775, 4729.030548737501, 3745.1011757178626, 4132.607402296777, 4247.5752424757275, 4305.763183024964, 4313.547077556874, 3672.981635091861, 3691.224842782992, 3735.0475628714503, 3782.0544863784053, 3795.5635101963626, 1160.6924165096257, 1185.7509922916113, 1186.7745128425572, 1197.7963746163173, 1201.831743555903, 770.3413581387832, 781.7185813107277, 812.8333691593209, 819.4837252530867, 825.2078005115037, 4914.336564563738, 4968.105740966661, 5041.294218809369, 5124.282600435942, 5130.1535246684625, 873.3319010956624, 890.2166093837382, 890.7773056735816, 893.5264309915755, 894.5035505294494, 3370.983145084308, 3470.132466883279, 3506.9123271918406, 3512.3853325667906, 3554.1647712787476, 9435.952820235992, 9626.229901607854, 9666.516674166263, 9690.176335011603, 9787.608495660237, 9669.613215471443, 9669.854952175723, 9670.516474176264, 9698.854517182248, 9700.805983880284, 6940.375366217065, 6951.339622735832, 7026.15686117659, 7105.218425973242, 7117.92882071183, 4842.612590992641, 4887.291342755351, 4910.43529994041, 4914.36113305268, 4991.57571606403, 8475.57622118904, 8487.915120848713, 8503.064662886954, 8505.74482765518, 8571.914280857112, 8425.283850872744, 8475.194856488624, 8686.609102590524, 8687.348448866234, 8691.087435819149, 5795.884082318415, 6346.365363463617, 6591.901121483277, 6592.868142637216, 6664.366885145903, 7739.3034626883855, 7755.418343624138, 7801.414893882868, 7806.258405451473, 7809.570473624005, 6812.114425124702, 6903.6203008835, 6929.480288978448, 7038.190608079932, 7066.681999310146, 6928.376446119873, 6936.653167341714, 6982.511224214256, 7019.052427922165, 7048.118985126859, 5728.283964504437, 5782.681952492485, 5800.042992906123, 5885.352611212677, 5908.084246941559, 4310.224159651293, 4329.0259691569145, 4335.956640433681, 4385.627221686193, 4426.712263702849, 4378.693491455568, 4491.034427598082, 4514.0, 4515.616172625232, 4568.063546972929], "value": 4111.784984355614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.19881116230823, 304.0422668593929, 308.3909279173634, 308.4694325759694, 308.5495177041518, 4730.90538189236, 4911.459739428665, 4913.656044076916, 4928.496808473423, 4946.183879659852, 4828.275758636198, 4843.079814835188, 4871.829485967992, 4876.0, 4907.165781817091, 3573.6426357364185, 3647.908802279938, 3765.548134223897, 3782.621737826209, 3797.449369841378, 3720.8511659533588, 3746.213295207996, 3774.4904437900805, 3785.8988261514846, 3794.829232684536, 3690.3910854708943, 3691.446283057536, 3705.722070844684, 3719.6466335698065, 3739.551253849528, 3539.407266729969, 3595.173110184659, 3712.7215458840424, 3722.5532936047575, 3744.2511497700298, 3253.7559683023633, 3261.429249881285, 3274.8035117893, 3275.4595491743835, 3283.589551306087, 4724.314974328738, 4731.597814185799, 4732.550407711296, 4735.200623762948, 4737.881552961169, 4161.479815023122, 4211.768352740598, 4270.7864606769535, 4274.529801721839, 4280.4221430106845, 5009.799608015675, 5033.213209310678, 5047.268146118829, 5048.7223202723835, 5053.444121146671, 3574.964250357489, 3576.856925722968, 3577.0878426001464, 3584.3189793939328, 3588.910277243064, 4926.00496798797, 5267.973660131714, 5293.100172970604, 5304.708241046741, 5308.0, 3608.9458658120147, 3630.7821530707715, 3653.7577223743524, 3661.139632186434, 3668.2296717689583, 3686.5806664434385, 3692.7045836333027, 3707.7775333480076, 3722.9813850931114, 3725.0, 4224.324108142682, 4224.662516611904, 4226.619604235572, 4239.236937351307, 4244.898775106342, 4773.427188737304, 5030.119729047402, 5031.4465408805, 5047.384836852246, 5051.82318618854, 1264.1846009323936, 1269.936503174856, 1279.8592154862959, 1283.857366943421, 1285.5500574798746, 821.8068753842842, 831.8253166835033, 838.3460900497622, 864.5461132905275, 880.4761167105562, 4454.532274111237, 4461.843835465743, 4466.508684044752, 4474.530174331713, 4477.440319960005, 5164.32863727713, 5173.32746742921, 5178.922316165261, 5182.4299327073995, 5186.792528298825, 4296.677749168824, 4465.397171381886, 4469.754163520973, 4479.17135329965, 4500.234960056799, 2758.7930905182193, 2765.769232691473, 2777.9027734029214, 2779.3329600896045, 2787.275308419785, 4949.183384741549, 4962.528559786814, 4964.578010869117, 4968.801247950114, 4973.041040580849, 5082.542571168613, 5372.791121997519, 5373.650712703662, 5394.9460505394445, 5395.217693434509, 4936.703797772145, 4959.454460009396, 4975.104481193275, 4979.278004689372, 4989.775460104304, 5218.530332270114, 5241.50205730455, 5276.736163191748, 5277.182036784305, 5279.656822306538, 4892.657513973988, 5195.0, 5196.7401629917595, 5199.870003249949, 5200.531952124327, 4907.141250281115, 4920.237363208708, 4938.234573641092, 4987.8753031173055, 4987.950120498894, 3681.4477828325967, 3700.851965921333, 3713.164537979041, 3725.27357165361, 3729.608391119002, 5102.438731739431, 5260.894782104413, 5270.920936186037, 5279.9472005280995, 5284.392294886137, 5075.670081444694, 5093.0, 5097.413797413345, 5106.642535022661, 5108.948910510847, 5051.722155281494, 5055.823046193365, 5070.797168113234, 5106.285120083266, 5107.668001579886, 4774.379330686988, 4994.525520075587, 5021.4225364083595, 5042.546170844642, 5055.090083784954, 4910.790144434947, 4964.801407943642, 5111.437741848319, 5142.151544995034, 5155.793768249228, 5003.0, 5012.624053195952, 5032.647714659939, 5037.19404895215, 5047.343845300087], "value": 3812.841117761837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.7216024949022, 648.7761722205837, 657.0177584511157, 736.0946036375257, 746.2313816768726, 12777.425015874285, 13651.249181295025, 13677.794833077487, 13692.726145477085, 13732.038757287006, 12571.120021598492, 12801.615951521446, 12834.550790722327, 12944.22334659921, 13076.150050246728, 608.1121562518728, 762.0246085011195, 776.6776787633125, 777.4441274488739, 780.3406121827047, 764.4495962906698, 795.9482633628795, 804.2319584796505, 805.3275514945028, 805.907320658123, 828.5484410995991, 828.8466633672759, 829.618375547249, 829.7261903571807, 832.5504227717025, 642.9132067170918, 798.9560574168419, 822.268181318627, 822.3832125905541, 822.4284122534841, 604.0606856338392, 607.2045620237503, 607.2318517075903, 607.4441885674603, 607.4957785038407, 12555.246685198917, 12586.622401327975, 12591.118621696392, 12601.0, 12606.369681515887, 12949.935250323782, 13563.932180339134, 13571.660708482366, 13586.524471643545, 13722.313884305844, 11954.147107198398, 12048.87951120495, 12097.516099356015, 12286.385680715928, 12693.174943628635, 4179.811908464096, 4182.435371224876, 4262.744235345889, 4269.5516970718245, 4294.0, 61567.0, 61664.69167654133, 62383.688081559754, 62769.0, 62863.05705414422, 10242.0, 10372.170226381872, 10387.84418233727, 10436.165106791439, 10742.78514429707, 18872.33946811855, 18883.433496995112, 18907.716384254247, 18948.715769263472, 19038.80961190398, 6956.165260168812, 7006.649667516604, 7076.540024898365, 7147.64261786919, 7395.297446742551, 3695.501107350527, 3760.360738674432, 3772.641599048086, 3802.657760801486, 3814.809259537012, 2841.502737021013, 2914.8979785707825, 2927.6194094767543, 2941.044160647798, 2945.5139901916373, 496.8708135884696, 509.1980131293228, 510.65020460984346, 516.8242797448886, 517.2809794385806, 441.7901496789, 447.5502120369008, 489.6132055675976, 514.4161376837242, 536.6350881400685, 7691.884621730678, 7733.110692270461, 7737.508341051977, 7909.288164065261, 7962.721304754422, 514.0720998597567, 521.6817741177879, 521.9608529360313, 524.0959345129621, 530.8487081181845, 3563.768355056913, 3642.581103173116, 3727.7763334199494, 3753.774773513598, 4100.5899410059355, 100715.49642251742, 102627.4868625667, 104555.4772226134, 104835.47582262193, 104863.47568262262, 61232.69383653053, 82727.0, 84400.57799710962, 84907.57546212229, 85678.57160714157, 77198.0, 79421.60289198633, 79657.60171199107, 80251.59874200591, 80929.78605320925, 8657.567121643766, 8778.56107194625, 8931.330150238628, 8947.910520894708, 8962.0, 44582.3312650304, 45644.0, 45690.31464527968, 45812.770936145105, 47194.52805471901, 66116.0, 70614.64692676504, 71412.0, 71549.63377746586, 71883.0, 11070.778584428428, 11186.552537898719, 11329.660110196708, 11497.655070347902, 11594.826077608674, 11971.521139154336, 12111.83051772476, 12229.388530573258, 12234.082443816927, 12696.619101426972, 12126.514939402325, 12345.135840491439, 12366.690832729253, 12410.317432541297, 12815.295158766357, 11641.47613357384, 11834.519838701579, 11991.880081199077, 12031.27812331263, 12347.876521235032, 11476.655700329004, 11508.309501429942, 11624.302541847177, 12230.502530586205, 12241.265524068584, 9823.486564423889, 10028.648997285352, 10186.541605627617, 10226.437545934747, 10445.112165465716, 9452.43285402878, 9983.400995940267, 10087.394756314645, 10107.797844043225, 10194.796104078025], "value": 6647.177292022956, "unit": "score"}], "name": "dromaeo_css", "value": 6491.2613954135695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 112.0, 112.0, 114.0, 112.0, 111.0, 113.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 138.0, 136.0, 177.0, 134.0, 140.0, 132.0, 151.0, 168.0, 129.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 159.0, 161.0, 162.0, 161.0, 162.0, 159.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 121.0, 75.0, 77.0, 74.0, 76.0, 97.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 123.0, 86.0, 86.0, 85.0, 113.0, 86.0, 86.0, 127.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 64.0, 65.0, 64.0, 64.0, 67.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 81.0, 88.0, 84.0, 82.0, 84.0, 84.0, 142.0, 87.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 130.0, 127.0, 129.0, 132.0, 136.0, 138.0, 146.0, 130.0, 128.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 163.0, 164.0, 164.0, 165.0, 164.0, 164.0, 164.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 67.0, 66.0, 66.0, 64.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1538.7999999999997, "alertThreshold": 2.0}]} 20:40:58 INFO - Return code: 0 20:40:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:40:58 INFO - # TBPL SUCCESS # 20:40:58 INFO - Running post-action listener: _resource_record_post_action 20:40:58 INFO - ##### 20:40:58 INFO - ##### Finished run-tests step (success) 20:40:58 INFO - ##### 20:40:58 INFO - Running post-run listener: _resource_record_post_run 20:40:58 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540315648; Read time: 16; Write time: 939380 20:40:58 INFO - TinderboxPrint: CPU usage
13.1% 20:40:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:40:58 INFO - TinderboxPrint: I/O write bytes / time
540,315,648 / 939,380 20:40:58 INFO - TinderboxPrint: CPU idle
8,338.8 (86.8%) 20:40:58 INFO - TinderboxPrint: CPU user
1,211.7 (12.6%) 20:40:58 INFO - TinderboxPrint: Swap in / out
0 / 0 20:40:58 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 245612544; Read time: 0; Write time: 497192 20:40:58 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294703104; Read time: 0; Write time: 442188 20:40:59 INFO - Running post-run listener: _upload_blobber_files 20:40:59 INFO - Blob upload gear active. 20:40:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:40:59 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 20:40:59 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'] 20:40:59 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 20:40:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:40:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:40:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:41:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:00 INFO - (blobuploader) - INFO - Done attempting. 20:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:01 INFO - (blobuploader) - INFO - Done attempting. 20:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:04 INFO - (blobuploader) - INFO - Done attempting. 20:41:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:41:04 INFO - Return code: 0 20:41:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:41:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:41:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b318006aef784105254cfc4051128d2b7524289c2117a79d3459aed2be946d1b01940d07ad1db1d331886745fedd08cc8a3065cc8363827ece132543beb40989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b29f2dd15f4a2da6c853cec8540d591ed97f4ec7c72ca2daa5fbe238ebf95f70a8b2dbfa930d9428499c8b42155c663a007df5f45a64aa471fe83d50459c062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ccd772b67c60dedc3efc9baa7638586d5debdbe0b50f4d8e580329785eb1049bcb6e476dafbcbce64b41f0c218df87a512c1afe94df3b159d8b4f58f6966da7d"} 20:41:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:41:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:41:04 INFO - Contents: 20:41:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b318006aef784105254cfc4051128d2b7524289c2117a79d3459aed2be946d1b01940d07ad1db1d331886745fedd08cc8a3065cc8363827ece132543beb40989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b29f2dd15f4a2da6c853cec8540d591ed97f4ec7c72ca2daa5fbe238ebf95f70a8b2dbfa930d9428499c8b42155c663a007df5f45a64aa471fe83d50459c062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ccd772b67c60dedc3efc9baa7638586d5debdbe0b50f4d8e580329785eb1049bcb6e476dafbcbce64b41f0c218df87a512c1afe94df3b159d8b4f58f6966da7d"} 20:41:04 INFO - Running post-run listener: copy_logs_to_upload_dir 20:41:04 INFO - Copying logs to upload dir... 20:41:04 INFO - mkdir: /builds/slave/test/build/upload/logs 20:41:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.831346 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-28 20:41:04.593738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:04.597625) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256 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/b318006aef784105254cfc4051128d2b7524289c2117a79d3459aed2be946d1b01940d07ad1db1d331886745fedd08cc8a3065cc8363827ece132543beb40989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b29f2dd15f4a2da6c853cec8540d591ed97f4ec7c72ca2daa5fbe238ebf95f70a8b2dbfa930d9428499c8b42155c663a007df5f45a64aa471fe83d50459c062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ccd772b67c60dedc3efc9baa7638586d5debdbe0b50f4d8e580329785eb1049bcb6e476dafbcbce64b41f0c218df87a512c1afe94df3b159d8b4f58f6966da7d"} build_url:https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/dHlAhNREQm23g81S78GXBA/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/b318006aef784105254cfc4051128d2b7524289c2117a79d3459aed2be946d1b01940d07ad1db1d331886745fedd08cc8a3065cc8363827ece132543beb40989", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b29f2dd15f4a2da6c853cec8540d591ed97f4ec7c72ca2daa5fbe238ebf95f70a8b2dbfa930d9428499c8b42155c663a007df5f45a64aa471fe83d50459c062", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ccd772b67c60dedc3efc9baa7638586d5debdbe0b50f4d8e580329785eb1049bcb6e476dafbcbce64b41f0c218df87a512c1afe94df3b159d8b4f58f6966da7d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:04.622761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:04.623061) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1467169806.39196-1037052256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 20:41:04.704988) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 20:41:04.705313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 20:41:04.705595) ========= ========= Total master_lag: 0.31 =========