builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1467982244.72 results: success (0) buildid: 20160708023010 builduid: 951ccdffcfe945dbaac7aee7cbc09f20 revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.721170) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.721703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.722018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.737059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.737466) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 05:50:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.0M=0s 2016-07-08 05:50:45 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086292 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.838128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.838466) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013682 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.887684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:44.888071) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 806cd7a7b68de8777caf419239e2f4e671aaa80b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 806cd7a7b68de8777caf419239e2f4e671aaa80b --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=9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 05:50:45,129 truncating revision to first 12 chars 2016-07-08 05:50:45,129 Setting DEBUG logging. 2016-07-08 05:50:45,129 attempt 1/10 2016-07-08 05:50:45,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/806cd7a7b68d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 05:50:45,455 unpacking tar archive at: fx-team-806cd7a7b68d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:45.558432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:45.558783) ========= script_repo_revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:45.559172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:45.559447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:50:45.568056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-07-08 05:50:45.568529) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:45 INFO - MultiFileLogger online at 20160708 05:50:45 in /builds/slave/test 05:50:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:50:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:45 INFO - {'append_to_log': False, 05:50:45 INFO - 'base_work_dir': '/builds/slave/test', 05:50:45 INFO - 'blob_upload_branch': 'Fx-Team', 05:50:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:45 INFO - 'branch': 'Fx-Team', 05:50:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:45 INFO - 'config_files': ('talos/linux_config.py',), 05:50:45 INFO - 'default_actions': ('clobber', 05:50:45 INFO - 'read-buildbot-config', 05:50:45 INFO - 'download-and-extract', 05:50:45 INFO - 'populate-webroot', 05:50:45 INFO - 'create-virtualenv', 05:50:45 INFO - 'install', 05:50:45 INFO - 'run-tests'), 05:50:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:45 INFO - 'download_minidump_stackwalk': True, 05:50:45 INFO - 'download_symbols': 'ondemand', 05:50:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:45 INFO - 'installer_path': 'installer.exe', 05:50:45 INFO - 'log_level': 'info', 05:50:45 INFO - 'log_name': 'talos', 05:50:45 INFO - 'log_to_console': True, 05:50:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:45 INFO - 'opt_config_files': (), 05:50:45 INFO - 'pip_index': False, 05:50:45 INFO - 'sps_profile': False, 05:50:45 INFO - 'sps_profile_interval': 0, 05:50:45 INFO - 'suite': 'dromaeojs', 05:50:45 INFO - 'system_bits': '32', 05:50:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:45 INFO - 'title': 'talos-linux64-ix-040', 05:50:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:45 INFO - 'use_talos_json': True, 05:50:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:45 INFO - 'work_dir': 'build'} 05:50:45 INFO - ##### 05:50:45 INFO - ##### Running clobber step. 05:50:45 INFO - ##### 05:50:45 INFO - Running pre-action listener: _resource_record_pre_action 05:50:45 INFO - Running main action method: clobber 05:50:45 INFO - rmtree: /builds/slave/test/build 05:50:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:46 INFO - Running post-action listener: _resource_record_post_action 05:50:46 INFO - ##### 05:50:46 INFO - ##### Finished clobber step (success) 05:50:46 INFO - ##### 05:50:46 INFO - ##### 05:50:46 INFO - ##### Running read-buildbot-config step. 05:50:46 INFO - ##### 05:50:46 INFO - Running pre-action listener: _resource_record_pre_action 05:50:46 INFO - Running main action method: read_buildbot_config 05:50:46 INFO - Using buildbot properties: 05:50:46 INFO - { 05:50:46 INFO - "project": "", 05:50:46 INFO - "product": "firefox", 05:50:46 INFO - "script_repo_revision": "production", 05:50:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:50:46 INFO - "repository": "", 05:50:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:50:46 INFO - "buildid": "20160708023010", 05:50:46 INFO - "pgo_build": "True", 05:50:46 INFO - "basedir": "/builds/slave/test", 05:50:46 INFO - "buildnumber": 262, 05:50:46 INFO - "slavename": "talos-linux64-ix-040", 05:50:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:50:46 INFO - "platform": "ubuntu64_hw", 05:50:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:50:46 INFO - "branch": "fx-team", 05:50:46 INFO - "repo_path": "integration/fx-team", 05:50:46 INFO - "revision": "806cd7a7b68de8777caf419239e2f4e671aaa80b", 05:50:46 INFO - "stage_platform": "linux64-pgo", 05:50:46 INFO - "builduid": "951ccdffcfe945dbaac7aee7cbc09f20", 05:50:46 INFO - "slavebuilddir": "test" 05:50:46 INFO - } 05:50:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:50:46 INFO - Running post-action listener: _resource_record_post_action 05:50:46 INFO - ##### 05:50:46 INFO - ##### Finished read-buildbot-config step (success) 05:50:46 INFO - ##### 05:50:46 INFO - ##### 05:50:46 INFO - ##### Running download-and-extract step. 05:50:46 INFO - ##### 05:50:46 INFO - Running pre-action listener: _resource_record_pre_action 05:50:46 INFO - Running main action method: download_and_extract 05:50:46 INFO - mkdir: /builds/slave/test/build/tests 05:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:46 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:50:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:50:47 INFO - Downloaded 1361 bytes. 05:50:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:47 INFO - Using the following test package requirements: 05:50:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'jsshell-linux-x86_64.zip'], 05:50:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50: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')]} 05:50:47 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:51:19 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip: The read operation timed out 05:51:19 INFO - retry: attempt #1 caught exception: The read operation timed out 05:51:19 INFO - retry: Failed, sleeping 30 seconds before retrying 05:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 #2 05:51:50 INFO - Downloaded 24304672 bytes. 05:51:50 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'] 05:51:50 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 05:51:51 INFO - Return code: 0 05:51:51 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 05:51:51 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')]} 05:51:51 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:51:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:51:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:51:52 INFO - Downloaded 24304672 bytes. 05:51:52 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'] 05:51:52 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 05:51:54 INFO - Return code: 0 05:51: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')]} 05:51:54 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:51:55 INFO - Downloaded 14403333 bytes. 05:51:55 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'] 05:51:55 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 05:51:55 INFO - Return code: 0 05:51:55 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')]} 05:51:55 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:51:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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 05:51:56 INFO - Downloaded 60450888 bytes. 05:51:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:56 INFO - mkdir: /builds/slave/test/properties 05:51:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:56 INFO - Contents: 05:51:56 INFO - build_url:https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:57 INFO - Running post-action listener: _resource_record_post_action 05:51:57 INFO - Running post-action listener: set_extra_try_arguments 05:51:57 INFO - ##### 05:51:57 INFO - ##### Finished download-and-extract step (success) 05:51:57 INFO - ##### 05:51:57 INFO - ##### 05:51:57 INFO - ##### Running populate-webroot step. 05:51:57 INFO - ##### 05:51:57 INFO - Running pre-action listener: _resource_record_pre_action 05:51:57 INFO - Running main action method: populate_webroot 05:51:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:57 INFO - '--tppagecycles', 05:51:57 INFO - '7'], 05:51:57 INFO - 'tests': ['tsvgm']}}, 05:51:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['damp', 'tps']}, 05:51:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'tests': ['damp', 'tps']}, 05:51:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['dromaeo_dom']}, 05:51:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['basic_compositor_video']}, 05:51:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:51:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['a11yr', 05:51:57 INFO - 'ts_paint', 05:51:57 INFO - 'tpaint', 05:51:57 INFO - 'sessionrestore', 05:51:57 INFO - 'sessionrestore_no_auto_restore', 05:51:57 INFO - 'tabpaint']}, 05:51:57 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:57 INFO - 'ts_paint', 05:51:57 INFO - 'tpaint', 05:51:57 INFO - 'sessionrestore', 05:51:57 INFO - 'sessionrestore_no_auto_restore', 05:51:57 INFO - 'tabpaint']}, 05:51:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:57 INFO - 'ts_paint', 05:51:57 INFO - 'tpaint', 05:51:57 INFO - 'sessionrestore', 05:51:57 INFO - 'sessionrestore_no_auto_restore', 05:51:57 INFO - 'tabpaint']}, 05:51:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:57 INFO - 'ts_paint', 05:51:57 INFO - 'tpaint', 05:51:57 INFO - 'sessionrestore', 05:51:57 INFO - 'sessionrestore_no_auto_restore', 05:51:57 INFO - 'tabpaint']}, 05:51:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['a11yr', 05:51:57 INFO - 'ts_paint', 05:51:57 INFO - 'tpaint', 05:51:57 INFO - 'sessionrestore', 05:51:57 INFO - 'sessionrestore_no_auto_restore', 05:51:57 INFO - 'tabpaint']}, 05:51:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['a11yr', 05:51:57 INFO - 'ts_paint', 05:51:57 INFO - 'tpaint', 05:51:57 INFO - 'sessionrestore', 05:51:57 INFO - 'sessionrestore_no_auto_restore', 05:51:57 INFO - 'tabpaint']}, 05:51:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['tsvgx', 05:51:57 INFO - 'tsvgr_opacity', 05:51:57 INFO - 'tart', 05:51:57 INFO - 'tscrollx', 05:51:57 INFO - 'cart']}, 05:51:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:57 INFO - 'tsvgr_opacity', 05:51:57 INFO - 'tart', 05:51:57 INFO - 'tscrollx', 05:51:57 INFO - 'cart']}, 05:51:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'talos_options': ['--disable-e10s'], 05:51:57 INFO - 'tests': ['tp5o']}, 05:51:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'tests': ['tp5o']}, 05:51:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'talos_options': ['--disable-e10s', 05:51:57 INFO - '--xperf_path', 05:51:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:57 INFO - 'tests': ['tp5n']}, 05:51:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:57 INFO - 'talos_options': ['--xperf_path', 05:51:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:57 INFO - 'tests': ['tp5n']}}, 05:51:57 INFO - 'talos.zip': {'path': '', 05:51:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:57 INFO - Running post-action listener: _resource_record_post_action 05:51:57 INFO - ##### 05:51:57 INFO - ##### Finished populate-webroot step (success) 05:51:57 INFO - ##### 05:51:57 INFO - ##### 05:51:57 INFO - ##### Running create-virtualenv step. 05:51:57 INFO - ##### 05:51:57 INFO - Running pre-action listener: _resource_record_pre_action 05:51:57 INFO - Running main action method: create_virtualenv 05:51:57 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:57 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 05:51:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:57 INFO - Using real prefix '/usr' 05:51:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:00 INFO - Installing pip.................done. 05:52:00 INFO - Return code: 0 05:52:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:00 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:00 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 05:52:00 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 05:52:00 INFO - Using env: {'DISPLAY': ':0', 05:52:00 INFO - 'HOME': '/home/cltbld', 05:52:00 INFO - 'LANG': 'en_US.UTF-8', 05:52:00 INFO - 'LANGUAGE': 'en_US:en', 05:52:00 INFO - 'LOGNAME': 'cltbld', 05:52:00 INFO - 'MAIL': '/var/mail/cltbld', 05:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:00 INFO - 'MOZ_NO_REMOTE': '1', 05:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:00 INFO - 'NO_EM_RESTART': '1', 05:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:00 INFO - 'PWD': '/builds/slave/test', 05:52:00 INFO - 'SHELL': '/bin/bash', 05:52:00 INFO - 'SHLVL': '1', 05:52:00 INFO - 'TERM': 'linux', 05:52:00 INFO - 'TMOUT': '86400', 05:52:00 INFO - 'USER': 'cltbld', 05:52:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:00 INFO - '_': '/tools/buildbot/bin/python'} 05:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:00 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 05:52:00 INFO - Cleaning up... 05:52:00 INFO - Return code: 0 05:52:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:00 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:00 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 05:52:00 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 05:52:00 INFO - Using env: {'DISPLAY': ':0', 05:52:00 INFO - 'HOME': '/home/cltbld', 05:52:00 INFO - 'LANG': 'en_US.UTF-8', 05:52:00 INFO - 'LANGUAGE': 'en_US:en', 05:52:00 INFO - 'LOGNAME': 'cltbld', 05:52:00 INFO - 'MAIL': '/var/mail/cltbld', 05:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:00 INFO - 'MOZ_NO_REMOTE': '1', 05:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:00 INFO - 'NO_EM_RESTART': '1', 05:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:00 INFO - 'PWD': '/builds/slave/test', 05:52:00 INFO - 'SHELL': '/bin/bash', 05:52:00 INFO - 'SHLVL': '1', 05:52:00 INFO - 'TERM': 'linux', 05:52:00 INFO - 'TMOUT': '86400', 05:52:00 INFO - 'USER': 'cltbld', 05:52:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:00 INFO - '_': '/tools/buildbot/bin/python'} 05:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:00 INFO - Downloading/unpacking psutil>=3.1.1 05:52:00 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 05:52:00 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 05:52:00 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 05:52:00 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 05:52:00 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 05:52:00 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 05:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:02 INFO - Installing collected packages: psutil 05:52:02 INFO - Running setup.py install for psutil 05:52:02 INFO - building 'psutil._psutil_linux' extension 05:52:02 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 05:52:02 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 05:52:02 INFO - building 'psutil._psutil_posix' extension 05:52:02 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 05:52:03 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 05:52:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:03 INFO - Successfully installed psutil 05:52:03 INFO - Cleaning up... 05:52:03 INFO - Return code: 0 05:52:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:03 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:03 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 05:52:03 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 05:52:03 INFO - Using env: {'DISPLAY': ':0', 05:52:03 INFO - 'HOME': '/home/cltbld', 05:52:03 INFO - 'LANG': 'en_US.UTF-8', 05:52:03 INFO - 'LANGUAGE': 'en_US:en', 05:52:03 INFO - 'LOGNAME': 'cltbld', 05:52:03 INFO - 'MAIL': '/var/mail/cltbld', 05:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:03 INFO - 'MOZ_NO_REMOTE': '1', 05:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:03 INFO - 'NO_EM_RESTART': '1', 05:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:03 INFO - 'PWD': '/builds/slave/test', 05:52:03 INFO - 'SHELL': '/bin/bash', 05:52:03 INFO - 'SHLVL': '1', 05:52:03 INFO - 'TERM': 'linux', 05:52:03 INFO - 'TMOUT': '86400', 05:52:03 INFO - 'USER': 'cltbld', 05:52:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:03 INFO - '_': '/tools/buildbot/bin/python'} 05:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:03 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 05:52:03 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 05:52:03 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 05:52:03 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 05:52:03 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 05:52:03 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 05:52:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:05 INFO - Installing collected packages: mozsystemmonitor 05:52:05 INFO - Running setup.py install for mozsystemmonitor 05:52:05 INFO - Successfully installed mozsystemmonitor 05:52:05 INFO - Cleaning up... 05:52:05 INFO - Return code: 0 05:52:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52:05 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')]} 05:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:05 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')]} 05:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:05 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:05 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 05:52:05 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 05:52:05 INFO - Using env: {'DISPLAY': ':0', 05:52:05 INFO - 'HOME': '/home/cltbld', 05:52:05 INFO - 'LANG': 'en_US.UTF-8', 05:52:05 INFO - 'LANGUAGE': 'en_US:en', 05:52:05 INFO - 'LOGNAME': 'cltbld', 05:52:05 INFO - 'MAIL': '/var/mail/cltbld', 05:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:05 INFO - 'MOZ_NO_REMOTE': '1', 05:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:05 INFO - 'NO_EM_RESTART': '1', 05:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:05 INFO - 'PWD': '/builds/slave/test', 05:52:05 INFO - 'SHELL': '/bin/bash', 05:52:05 INFO - 'SHLVL': '1', 05:52:05 INFO - 'TERM': 'linux', 05:52:05 INFO - 'TMOUT': '86400', 05:52:05 INFO - 'USER': 'cltbld', 05:52:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:05 INFO - '_': '/tools/buildbot/bin/python'} 05:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:05 INFO - Downloading/unpacking jsonschema==2.5.1 05:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52:07 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 05:52:07 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 05:52:07 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 05:52:07 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 05:52:07 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 05:52:07 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 05:52:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:07 INFO - warning: no files found matching '*.txt' 05:52:07 INFO - no previously-included directories found matching 'build' 05:52:07 INFO - no previously-included directories found matching 'dist' 05:52:07 INFO - no previously-included directories found matching '.git*' 05:52:07 INFO - Installing collected packages: jsonschema, functools32 05:52:07 INFO - Running setup.py install for functools32 05:52:08 INFO - warning: no files found matching '*.txt' 05:52:08 INFO - no previously-included directories found matching 'build' 05:52:08 INFO - no previously-included directories found matching 'dist' 05:52:08 INFO - no previously-included directories found matching '.git*' 05:52:08 INFO - Successfully installed jsonschema functools32 05:52:08 INFO - Cleaning up... 05:52:08 INFO - Return code: 0 05:52:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:52:08 INFO - Using env: {'DISPLAY': ':0', 05:52:08 INFO - 'HOME': '/home/cltbld', 05:52:08 INFO - 'LANG': 'en_US.UTF-8', 05:52:08 INFO - 'LANGUAGE': 'en_US:en', 05:52:08 INFO - 'LOGNAME': 'cltbld', 05:52:08 INFO - 'MAIL': '/var/mail/cltbld', 05:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:08 INFO - 'MOZ_NO_REMOTE': '1', 05:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:08 INFO - 'NO_EM_RESTART': '1', 05:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:08 INFO - 'PWD': '/builds/slave/test', 05:52:08 INFO - 'SHELL': '/bin/bash', 05:52:08 INFO - 'SHLVL': '1', 05:52:08 INFO - 'TERM': 'linux', 05:52:08 INFO - 'TMOUT': '86400', 05:52:08 INFO - 'USER': 'cltbld', 05:52:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:08 INFO - '_': '/tools/buildbot/bin/python'} 05:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:08 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 05:52:08 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 05:52:08 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 05:52:08 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 05:52:08 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 05:52:08 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 05:52:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 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 05:52:10 INFO - Downloading docopt-0.6.1.tar.gz 05:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:10 INFO - Running setup.py install for blobuploader 05:52:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:11 INFO - Running setup.py install for requests 05:52:11 INFO - Running setup.py install for docopt 05:52:11 INFO - Successfully installed blobuploader requests docopt 05:52:11 INFO - Cleaning up... 05:52:11 INFO - Return code: 0 05:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:11 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:11 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 05:52:11 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 05:52:11 INFO - Using env: {'DISPLAY': ':0', 05:52:11 INFO - 'HOME': '/home/cltbld', 05:52:11 INFO - 'LANG': 'en_US.UTF-8', 05:52:11 INFO - 'LANGUAGE': 'en_US:en', 05:52:11 INFO - 'LOGNAME': 'cltbld', 05:52:11 INFO - 'MAIL': '/var/mail/cltbld', 05:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:11 INFO - 'MOZ_NO_REMOTE': '1', 05:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:11 INFO - 'NO_EM_RESTART': '1', 05:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:11 INFO - 'PWD': '/builds/slave/test', 05:52:11 INFO - 'SHELL': '/bin/bash', 05:52:11 INFO - 'SHLVL': '1', 05:52:11 INFO - 'TERM': 'linux', 05:52:11 INFO - 'TMOUT': '86400', 05:52:11 INFO - 'USER': 'cltbld', 05:52:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:11 INFO - '_': '/tools/buildbot/bin/python'} 05:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:11 INFO - Running setup.py (path:/tmp/pip-dgSv1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:11 INFO - Running setup.py (path:/tmp/pip-0J8go7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:11 INFO - Running setup.py (path:/tmp/pip-YuGENA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:12 INFO - Running setup.py (path:/tmp/pip-D3PWPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:12 INFO - Running setup.py (path:/tmp/pip-QE6l82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:12 INFO - Running setup.py (path:/tmp/pip-zj4nf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:12 INFO - Running setup.py (path:/tmp/pip-ia39mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:12 INFO - Running setup.py (path:/tmp/pip-ZRQ4LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:12 INFO - Running setup.py (path:/tmp/pip-sH14SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:12 INFO - Running setup.py (path:/tmp/pip-fewrGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:12 INFO - Running setup.py (path:/tmp/pip-PjKIlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:12 INFO - Running setup.py (path:/tmp/pip-NimZb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:12 INFO - Running setup.py (path:/tmp/pip-5iYcvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:12 INFO - Running setup.py (path:/tmp/pip-Ja8KZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:12 INFO - Running setup.py (path:/tmp/pip-t1pmPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:12 INFO - Running setup.py (path:/tmp/pip-CvPwX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:12 INFO - Running setup.py (path:/tmp/pip-eVwyE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:13 INFO - Running setup.py install for manifestparser 05:52:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Running setup.py install for mozcrash 05:52:13 INFO - Running setup.py install for mozdebug 05:52:13 INFO - Running setup.py install for mozdevice 05:52:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Running setup.py install for mozfile 05:52:13 INFO - Running setup.py install for mozhttpd 05:52:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Running setup.py install for mozinfo 05:52:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Running setup.py install for mozInstall 05:52:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:13 INFO - Running setup.py install for mozleak 05:52:13 INFO - Running setup.py install for mozlog 05:52:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:14 INFO - Running setup.py install for moznetwork 05:52:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:14 INFO - Running setup.py install for mozprocess 05:52:14 INFO - Running setup.py install for mozprofile 05:52:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:14 INFO - Running setup.py install for mozrunner 05:52:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:14 INFO - Running setup.py install for mozscreenshot 05:52:14 INFO - Running setup.py install for moztest 05:52:14 INFO - Running setup.py install for mozversion 05:52:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:14 INFO - Cleaning up... 05:52:14 INFO - Return code: 0 05:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:14 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')]} 05:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:14 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')]} 05:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:14 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:14 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 05:52:14 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 05:52:14 INFO - Using env: {'DISPLAY': ':0', 05:52:14 INFO - 'HOME': '/home/cltbld', 05:52:14 INFO - 'LANG': 'en_US.UTF-8', 05:52:14 INFO - 'LANGUAGE': 'en_US:en', 05:52:14 INFO - 'LOGNAME': 'cltbld', 05:52:14 INFO - 'MAIL': '/var/mail/cltbld', 05:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:14 INFO - 'MOZ_NO_REMOTE': '1', 05:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:14 INFO - 'NO_EM_RESTART': '1', 05:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:14 INFO - 'PWD': '/builds/slave/test', 05:52:14 INFO - 'SHELL': '/bin/bash', 05:52:14 INFO - 'SHLVL': '1', 05:52:14 INFO - 'TERM': 'linux', 05:52:14 INFO - 'TMOUT': '86400', 05:52:14 INFO - 'USER': 'cltbld', 05:52:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:14 INFO - '_': '/tools/buildbot/bin/python'} 05:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:15 INFO - Running setup.py (path:/tmp/pip-5T6KvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:15 INFO - Running setup.py (path:/tmp/pip-GHP_PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:15 INFO - Running setup.py (path:/tmp/pip-3ug65v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:15 INFO - Running setup.py (path:/tmp/pip-D8KGqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:15 INFO - Running setup.py (path:/tmp/pip-GxR8Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:15 INFO - Running setup.py (path:/tmp/pip-Uicg5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:15 INFO - Running setup.py (path:/tmp/pip-deaMT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:15 INFO - Running setup.py (path:/tmp/pip-arXGHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:15 INFO - Running setup.py (path:/tmp/pip-6YSO1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:15 INFO - Running setup.py (path:/tmp/pip-hW_Bdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:15 INFO - Running setup.py (path:/tmp/pip-k5Q7n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:15 INFO - Running setup.py (path:/tmp/pip-d36iJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:15 INFO - Running setup.py (path:/tmp/pip-4sWRUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:15 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)) 05:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:16 INFO - Running setup.py (path:/tmp/pip-Cn6OCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:16 INFO - Running setup.py (path:/tmp/pip-4tArnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:16 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)) 05:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:16 INFO - Running setup.py (path:/tmp/pip-gM1jTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:16 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)) 05:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:16 INFO - Running setup.py (path:/tmp/pip-7nqH1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:16 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)) 05:52:16 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)) 05:52:16 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)) 05:52:16 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)) 05:52:16 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)) 05:52:16 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)) 05:52:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:16 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 05:52:16 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 05:52:16 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 05:52:16 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 05:52:16 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 05:52:16 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 05:52:18 INFO - Downloading blessings-1.6.tar.gz 05:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:18 INFO - Installing collected packages: blessings 05:52:18 INFO - Running setup.py install for blessings 05:52:18 INFO - Successfully installed blessings 05:52:18 INFO - Cleaning up... 05:52:18 INFO - Return code: 0 05:52:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:18 INFO - Reading from file tmpfile_stdout 05:52:18 INFO - Current package versions: 05:52:18 INFO - argparse == 1.2.1 05:52:18 INFO - blessings == 1.6 05:52:18 INFO - blobuploader == 1.2.4 05:52:18 INFO - docopt == 0.6.1 05:52:18 INFO - functools32 == 3.2.3-2 05:52:18 INFO - jsonschema == 2.5.1 05:52:18 INFO - manifestparser == 1.1 05:52:18 INFO - mozInstall == 1.12 05:52:18 INFO - mozcrash == 0.17 05:52:18 INFO - mozdebug == 0.1 05:52:18 INFO - mozdevice == 0.48 05:52:18 INFO - mozfile == 1.2 05:52:18 INFO - mozhttpd == 0.7 05:52:18 INFO - mozinfo == 0.9 05:52:18 INFO - mozleak == 0.1 05:52:18 INFO - mozlog == 3.2 05:52:18 INFO - moznetwork == 0.27 05:52:18 INFO - mozprocess == 0.23 05:52:18 INFO - mozprofile == 0.28 05:52:18 INFO - mozrunner == 6.12 05:52:18 INFO - mozscreenshot == 0.1 05:52:18 INFO - mozsystemmonitor == 0.3 05:52:18 INFO - moztest == 0.7 05:52:18 INFO - mozversion == 1.4 05:52:18 INFO - psutil == 3.1.1 05:52:18 INFO - requests == 1.2.3 05:52:18 INFO - wsgiref == 0.1.2 05:52:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:18 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 05:52:18 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 05:52:18 INFO - Using env: {'DISPLAY': ':0', 05:52:18 INFO - 'HOME': '/home/cltbld', 05:52:18 INFO - 'LANG': 'en_US.UTF-8', 05:52:18 INFO - 'LANGUAGE': 'en_US:en', 05:52:18 INFO - 'LOGNAME': 'cltbld', 05:52:18 INFO - 'MAIL': '/var/mail/cltbld', 05:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:18 INFO - 'MOZ_NO_REMOTE': '1', 05:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:18 INFO - 'NO_EM_RESTART': '1', 05:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:18 INFO - 'PWD': '/builds/slave/test', 05:52:18 INFO - 'SHELL': '/bin/bash', 05:52:18 INFO - 'SHLVL': '1', 05:52:18 INFO - 'TERM': 'linux', 05:52:18 INFO - 'TMOUT': '86400', 05:52:18 INFO - 'USER': 'cltbld', 05:52:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:18 INFO - '_': '/tools/buildbot/bin/python'} 05:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 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)) 05:52:18 INFO - Cleaning up... 05:52:18 INFO - Return code: 0 05:52:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 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 0x1e2c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', '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 05:52:18 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 05:52:18 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 05:52:18 INFO - Using env: {'DISPLAY': ':0', 05:52:18 INFO - 'HOME': '/home/cltbld', 05:52:18 INFO - 'LANG': 'en_US.UTF-8', 05:52:18 INFO - 'LANGUAGE': 'en_US:en', 05:52:18 INFO - 'LOGNAME': 'cltbld', 05:52:18 INFO - 'MAIL': '/var/mail/cltbld', 05:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:18 INFO - 'MOZ_NO_REMOTE': '1', 05:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:18 INFO - 'NO_EM_RESTART': '1', 05:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:18 INFO - 'PWD': '/builds/slave/test', 05:52:18 INFO - 'SHELL': '/bin/bash', 05:52:18 INFO - 'SHLVL': '1', 05:52:18 INFO - 'TERM': 'linux', 05:52:18 INFO - 'TMOUT': '86400', 05:52:18 INFO - 'USER': 'cltbld', 05:52:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:18 INFO - '_': '/tools/buildbot/bin/python'} 05:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:19 INFO - Cleaning up... 05:52:19 INFO - Return code: 0 05:52:19 INFO - Running post-action listener: _resource_record_post_action 05:52:19 INFO - Running post-action listener: _start_resource_monitoring 05:52:19 INFO - Starting resource monitoring. 05:52:19 INFO - ##### 05:52:19 INFO - ##### Finished create-virtualenv step (success) 05:52:19 INFO - ##### 05:52:19 INFO - ##### 05:52:19 INFO - ##### Running install step. 05:52:19 INFO - ##### 05:52:19 INFO - Running pre-action listener: _resource_record_pre_action 05:52:19 INFO - Running main action method: install 05:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:19 INFO - Reading from file tmpfile_stdout 05:52:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:19 INFO - Reading from file tmpfile_stdout 05:52:19 INFO - Output received: 05:52:19 INFO - Usage: mozinstall [options] installer 05:52:19 INFO - Options: 05:52:19 INFO - -h, --help show this help message and exit 05:52:19 INFO - -d DEST, --destination=DEST 05:52:19 INFO - Directory to install application into. [default: 05:52:19 INFO - "/builds/slave/test"] 05:52:19 INFO - --app=APP Application being installed. [default: firefox] 05:52:19 INFO - mkdir: /builds/slave/test/build/application 05:52:19 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'] 05:52:19 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 05:52:36 INFO - Reading from file tmpfile_stdout 05:52:36 INFO - Output received: 05:52:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:52:36 INFO - Running post-action listener: _resource_record_post_action 05:52:36 INFO - ##### 05:52:36 INFO - ##### Finished install step (success) 05:52:36 INFO - ##### 05:52:36 INFO - ##### 05:52:36 INFO - ##### Running run-tests step. 05:52:36 INFO - ##### 05:52:36 INFO - Running pre-action listener: _resource_record_pre_action 05:52:36 INFO - Running main action method: run_tests 05:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:36 INFO - Python 2.7.3 05:52:36 INFO - Return code: 0 05:52:36 INFO - grabbing minidump binary from tooltool 05:52: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')]} 05:52:36 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 0x20eb3b0>, '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 0x20ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ec740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:36 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 05:52:36 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 05:52:36 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 05:52:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:36 INFO - Return code: 0 05:52:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:52:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:52:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 05:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 05:52:36 INFO - Using env: {'DISPLAY': ':0', 05:52:36 INFO - 'HOME': '/home/cltbld', 05:52:36 INFO - 'LANG': 'en_US.UTF-8', 05:52:36 INFO - 'LANGUAGE': 'en_US:en', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MAIL': '/var/mail/cltbld', 05:52:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test', 05:52:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SHLVL': '1', 05:52:36 INFO - 'TERM': 'linux', 05:52:36 INFO - 'TMOUT': '86400', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - '_': '/tools/buildbot/bin/python'} 05:52:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 05:52:36 INFO - mozversion application_buildid: 20160708023010 05:52:36 INFO - mozversion application_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 05:52:36 INFO - mozversion application_display_name: Nightly 05:52:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:36 INFO - mozversion application_name: Firefox 05:52:36 INFO - mozversion application_remotingname: firefox 05:52:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:52:36 INFO - mozversion application_vendor: Mozilla 05:52:36 INFO - mozversion application_version: 50.0a1 05:52:36 INFO - mozversion platform_buildid: 20160708023010 05:52:36 INFO - mozversion platform_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 05:52:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:52:36 INFO - mozversion platform_version: 50.0a1 05:52:36 INFO - using testdate: 1467982356 05:52:36 INFO - actual date: 1467982356 05:52:36 INFO - starting webserver on 'localhost:51706' 05:52:36 INFO - SUITE-START | Running 2 tests 05:52:36 INFO - TEST-START | dromaeo_css 05:52:36 INFO - operating with platform_type : linux_ 05:52:36 INFO - Initialising browser for dromaeo_css test... 05:52:36 INFO - TEST-INFO | started process 15497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX9Eov8/profile http://localhost:51706/getInfo.html) 05:52:40 INFO - PROCESS | 15497 | __metrics Screen width/height:1600/1200 05:52:40 INFO - PROCESS | 15497 | colorDepth:24 05:52:40 INFO - PROCESS | 15497 | Browser inner width/height: 1024/697 05:52:40 INFO - PROCESS | 15497 | __metrics 05:52:41 INFO - PROCESS | 15497 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:42 INFO - TEST-INFO | 15497: exit 0 05:52:42 INFO - Browser initialized. 05:52:42 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:42 INFO - TEST-INFO | started process 15578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX9Eov8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:54 INFO - PROCESS | 15578 | RSS: Main: 157442048 05:52:54 INFO - PROCESS | 15578 | 05:53:46 INFO - PROCESS | 15578 | 1467982426145 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] 05:55:53 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51706/tests/dromaeo/cssquery-ext.html) 05:55:55 INFO - PROCESS | 15578 | RSS: Main: 278831104 05:55:55 INFO - PROCESS | 15578 | 05:58:57 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-ext.html (next: http://localhost:51706/tests/dromaeo/cssquery-jquery.html) 05:58:58 INFO - PROCESS | 15578 | RSS: Main: 242737152 05:58:58 INFO - PROCESS | 15578 | 06:02:00 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51706/tests/dromaeo/cssquery-mootools.html) 06:02:00 INFO - PROCESS | 15578 | RSS: Main: 238641152 06:02:00 INFO - PROCESS | 15578 | 06:05:02 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51706/tests/dromaeo/cssquery-prototype.html) 06:05:03 INFO - PROCESS | 15578 | RSS: Main: 240537600 06:05:03 INFO - PROCESS | 15578 | 06:08:05 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51706/tests/dromaeo/cssquery-yui.html) 06:08:06 INFO - PROCESS | 15578 | RSS: Main: 210845696 06:08:06 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-yui.html (next: http://localhost:51706/tests/dromaeo/cssquery-dojo.html) 06:11:09 INFO - PROCESS | 15578 | RSS: Main: 273997824 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | __start_tp_report 06:11:09 INFO - PROCESS | 15578 | _x_x_mozilla_page_load 06:11:09 INFO - PROCESS | 15578 | _x_x_mozilla_page_load_details 06:11:09 INFO - PROCESS | 15578 | |i|pagename|runs| 06:11:09 INFO - PROCESS | 15578 | |0;dojo.html;3021.969780302197;3028.1218446650473;3047.878084876605;3058.418900408922;3070.692930706928;5126.794928202868;5203.2975548300965;5274.2879711238975;5298.841034768959;5324.62727609067;5256.053910296155;5263.526282634562;5279.868003299919;5347;5397.136458166694;4716.221823399135;4781.402324709411;4787.066522028206;4789.233722604384;4966.304717339575;4874.73188974608;4877.658563900528;4906.239532872411;4932.704037757728;4945.184044632631;4723.78742956566;4735.976320118394;4750.7149571025675;4798.376211092571;4803.879903002418;4729.716217026989;4736.786844592001;4741.122892264908;4747.406574178228;4833.419989601271;4737.905241895142;4760.285957106427;4762.857114286577;4765.737884416356;4779.211430114027;5242.475752424727;5246.317978662788;5288.81489147878;5292.259083728281;5336.759845806948;5657.20799088128;5707.771689132472;5712.457316554921;5728.169415434739;5731.799387021434;5519.365272993617;5686.800961966353;5732.942670573282;5734.4265573442735;5745.712714364265;5179.352580927384;5243.764030618593;5267.209918512254;5267.3679158500845;5272.393674727378;5698.145278208219;5709.3434255060365;5722.942770572325;5728.828135155952;5748.5688573357165;5552.91670624941;5558.055130627803;5598.440155984369;5606.131049687305;5613;5583.497485226349;5675.262215911905;5680.460356266148;5680.68756218412;5704.828855134269;5511.559075274049;5561.860953476195;5570.944290557042;5673.205751194836;5683.147527870852;5652.208690783294;5702.315722113373;5703.144528320702;5709.029464990961;5715.142728590745;4313.331433627793;4352.825886964486;4362.607365337135;4365.148795984816;4371.978140109342;3906.4726261954274;3909.0227443139215;3910.354791459434;3941.664958478504;3955.920881582352;5455.809046683347;5465.699386533779;5470.7264636768;5472.890542189134;5508.338999320107;5515.062439385234;5537.169424586345;5590.18942253371;5634.267545219177;5760.683162426107;5256.816011439581;5279.287296215039;5279.709615971082;5302.681839089667;5339.065663508871;4784.378030856036;4800.207965685692;4801.303810947393;4801.615870730333;4847.151748444008;5719.399463056402;5767.452092051249;5783.508401785811;5830.2129212555765;5838.328592211865;5622.100463925753;5644.266245388073;5644.915326270027;5646.2942132233475;5710.571707122065;5831.708414579339;5883.470487656132;5887.587868849139;5889.469947704727;5889.911651325319;5501.504864562208;5536.252605898152;5543.501084902378;5595.048841697003;5614.887702246014;5681.318241811009;5682.176084467646;5688.601797874109;5694.544436445157;5695.430456954271;5417.702026388586;5542.0855558833955;5550.139728342114;5560.138178582326;5560.277163968658;5518.310211223597;5561.138023606348;5563.109902415594;5572.331320241597;5578.693171875586;5491.505764481216;5520.944790552043;5520.972395137998;5529;5529.4470552945995;5484.451554844483;5502.0371434997915;5610.7755689773585;5612.943870561242;5655.4910058094965;5439.945600543944;5466.234727138124;5466.453354664502;5466.617336786546;5520.199571062093 06:11:09 INFO - PROCESS | 15578 | |1;ext.html;585.3005658238404;612.6446660936657;618.5608218165099;621.2482895696207;639.1307821362949;31085.844570777143;44087.338689919634;45243;45361.773191134;45444.54555454444;45950.310745338844;46338;46360.536394636045;46372;46376;8823.250023747989;8958.955205223965;8963.238124759404;8966.686165984192;8967.058458861791;8881.245094167003;8935.106489351045;8976.820463590724;8981.550922453884;8986.191242788147;9010.86483702745;9038.728838134833;9075.183233508982;9076.546172691373;9079.18287354138;8979.416337938046;9007.324450666161;9016.05331440196;9016.594253258587;9028.09719028092;8884.644614215424;8945.46327220369;8947.64209431622;8950.149735775156;8957.641694332218;43250.13499730019;43296.78351608222;43390.349144762855;43400.13199736019;43416.78291608553;3464.861405543775;3646.690031347339;3672.338978983782;3774.7168962327937;3914.099757055893;33868.661313386794;34011.149721256916;34070.97787066392;34075.6592434075;35829.64170358289;4515.932261016054;4537.115262523809;4579.748113853737;4698.718076915396;4735.834245801415;338884;340009.9999999975;340822;340948;341742;59291;59458;59894.401055988885;59961.700191499636;60055.09917351243;63861.680691597176;63966;64041;64047;64153.35846641567;15636.827237956972;15703.21483925822;15740.842591574166;15741.134237616812;15759;13420.328983550784;13444;13446.05877588579;13471.259080750653;13473.191608503521;16513.587160321087;18008.819911800976;18437.354692585694;18500.537486562942;18537.35119270819;4984.053029924303;5735.971320143372;5775.29628759517;5986.640801551921;6039.094135879654;985.2167526816198;1027.2655051638114;1049.3703777733451;1075.516017791981;1090.8036553420302;32884;33158.17104572405;33181.66818331834;33537.83231083878;33659.66340336614;1121.388843080523;1180.4274926660562;1196.778595959733;1203.2058841164965;1250.4685508658783;16747;17269.222884970208;17303.480895573153;17337.2198251079;17340.739888901677;541511;546601;546841;547801;549244;58516.414835851945;59318;59591.40408595945;59707.82045256877;59730.40269597335;1232.950681972729;1343.8723321284463;1344.6302266876687;1344.8789608935242;1377.5109836008273;33099.66900330966;35149.65082304203;35315.47026794651;35364.115897102776;35391.646083538835;51324.15068869775;51846.74076629593;51856.48143518517;51925.480745192064;51972.74013629908;320664;320836;321349;321505;321676;25032.62451063272;28252.71747282501;28258.85870570634;28452.146435606966;28699.856500717364;49139.771505711215;49140.262896057306;49733.254001189285;50088.74955625198;50317.24524132068;41700;41722.79138604409;42167.789161053995;42950.570494294654;43417.56582434135;41640.58359416367;41834.37248441337;43377.74763633493;43752.343714843664;43793.343099854166;40984;42448;42926;43080.784596078076;43468.347974781034;33288.500672490416;38178.47286108525;38221.4266786004;38677;38832.80583597064;29148.854255728587;29183.708162918098;29366;29568.408631827675;29587.556186657646 06:11:09 INFO - PROCESS | 15578 | |2;jquery.html;370.9758865673731;371.6766413220498;380.7144641518861;383.36935740706537;400.62141276493725;18312.816871831295;20710.89644551779;20748.170073197074;21499.140034398624;21540;19943.50141246466;20274.189032438684;20665.276715314965;20817.583648327025;20880.477988050305;5769.3076830780365;5882.000059989812;5963.970180149093;6035.426634469718;6036.034234522455;5841.386654401269;5893.174955506232;5893.55798315126;5910.34986151523;5937.287525496947;5548;5875.676837773921;5888.352281249059;5897.852553686149;5920.496757775594;5929.110633405002;5950.345461999176;5965.373635768268;5968.79109231177;6150.077488376779;5833.154192642086;5871.765129394819;5872.765089396419;5879;5883.941160588382;14085.85914140866;14178.929105354511;14453.78319325211;14774.704505909822;14798.40806367744;2349.2482405630035;2500.2624225853415;2652.774514166298;2809.7190280971945;3035.878564857403;10259.589616415335;10436.112930400925;10614.893851061468;10699.732506687316;10860.782784344348;1861.4601765487992;1868.355417381015;2000.9299674511321;2012.2051789543195;2066.60734460452;82812.58593707053;88591.55704221502;88647;89175;89260.99999999935;10682.1988350874;10881.564737410574;10963.122950163968;11002.559897604006;11313.773724525463;15579.221038948008;15634.9218253908;15672.294746736425;15676.294566744524;15690.607734806494;8123;8287.668493260322;8312.6333834797;8386.790330241793;8437.831243375222;8007.479513831582;8052;8061.959690201512;8195.508269503729;8200.138985406566;4752.334673145762;4772.260299653559;4800.903981920412;4826.710397376169;4858.708477491362;1830.9633807324046;1899.1928430417017;1947.8149575790278;1962.7546556680416;1981.326349041304;879.872418499314;1008.9041541053588;1014.8376259798397;1084.311462221495;1104.139282259855;20424.69362959527;20750;20894.791052089284;20925;20946.371608851758;971.5579411367811;981.6024510073431;986.6842610364614;1000.8048430555972;1052.4106500359824;10546.841797373045;11278.887211127783;11469.197156199152;11521.884781152248;11585.478653460614;487656;492647;515617;525525;528833;105168;105594.47202763936;105814.47092764487;108920.4553977225;110585;921.1341339141186;932.6968735160964;956.6986399284203;967.3615413826841;1046.6336782126195;18908.43274701761;18986.905065474584;19280.132394042583;19347.613047739247;19355.8064419354;42353.364699530146;44101.33847992347;45175.09649807051;46669;49601.503984961135;64693.353066468735;66350.33649663441;66509.33490665031;66997;67237.32762672506;7825.686972521035;8652.547087340192;8780.604872780612;8885.06706795803;9192.724218273463;13575.660608484866;14298.428062877369;14439.566025605835;14539.127652340894;14628.561143165722;12231.938840305742;12551.184173028723;12596.244225346509;12691;12774.799194786145;12151.270923744603;12281.324527151093;12536.122471426912;12606;12606.621801345975;11800.350980696145;12420.875791241971;12691.301978391277;12704.6823829405;12760.553380631633;7617.695292188472;7984.081830589324;8094.433389662902;8159.551224682462;8206.466579672302;9140.497272650067;12667.683307917376;12810.359482026048;12810.807837882252;12835.550755723505 06:11:09 INFO - PROCESS | 15578 | |3;mootools.html;1338.0900987328625;1448.898577099603;1479.47478645081;1593.7370333894908;1745.8226028627903;8101.1898810118955;8399.790005249879;8415.70545030924;8609.225169734722;8619.138086191379;8406.789830254247;8543.231109200171;8544.65821367146;8549.187827156426;8549.316054715624;2231.7991380775725;2264.116994372196;2269.273832373641;2269.931902042933;2271.2277825539313;2247.5280191159877;2261.2989973108306;2280.8061314788265;2287.7597852225526;2290.713660792401;2202.526456811785;2206.6689996500495;2208.8895555222175;2210.071769856656;2241.495663475713;2172.6958225848393;2185.67214917762;2187.0377034105104;2187.07049503961;2196.187410658059;2186.9234576789736;2187.6171669957694;2188.890555472236;2195.3304242206123;2198.714167158259;7690.230976902321;7815.804604884924;8518.27594654455;8559.486430814171;8611.48331100136;4954.900901981976;5035.924461133086;5038.319826823368;5045.293658887758;5046.495350464961;3324.1024923270584;3408.625051244361;3424.6232914379398;3487.093355727529;3492.1269682579355;1071.6784964510693;1084.4523515624637;1111.9444027798659;1126.5043380912373;1127.2447460201683;11732.648020559396;11932.463039163258;11964.102692298113;11966.102542309274;11982.041436685044;4160.563140870226;4266.0827921996915;4322.567743225715;4426.579474949875;4442.267025940748;9036;9047.185753282236;9073.183413492685;9082.45505269686;9082.636694532144;4995.450500444948;5000.824971125993;5010.599152067899;5010.624203184776;5020.422651395063;3981.3231750602467;4223.260929337353;4520.615747661485;4628.814847406134;4629.791659375336;3677.3748462761396;3682.5396825396824;3750.3436898542645;3765.7363984521367;3768.660820526111;1097.4567589043475;1102.4267380962015;1103.7130346110068;1103.906167975731;1117.541807858774;1006.3810756384917;1011.3577878047493;1026.2662196529518;1027.5838285494387;1031.339942436841;5945;6091.086337049478;6161.106639537332;6220.440160385587;6330.4619107375465;432.3104648086297;434.75653633965084;441.7437886026097;444.757607104129;455.10344621096385;4249.87250382489;4345.261305577996;4361.847335343311;4366.19225443294;4387.890302742457;10366.896331036744;10804.459777011118;10854.96877796608;10909;10927;9965.451900145417;10466.738331541621;10758.300710453796;10767.569297228023;10772;8027.397945154137;8148.429609927248;8177.386695997824;8221.671133154607;8238.794030149174;5953.880922381615;6278.309385967631;6306.747730090745;6365.96817015912;6380.776672816615;10011.649592264235;10083.344582602107;10091.69724908254;10097.545610447694;10136.493175341056;9060.637574496946;9812.803743925224;10080.445575493419;10216.591336346462;10235.84646230322;7188;7397.408207343292;7411.740589079572;7576.583287919218;7585.620718963919;8256.504609723435;8259.339252859876;8288.088310285742;8354.373421993496;8489.660413583388;7112.644367781693;7145.678444469907;7736.883946740691;7862.882056769038;7884.093329266978;7321.121465424183;7345.1553071397475;7362.079740032496;7373.963130184315;7473.476856619985;6445.613263204223;6620.536562440583;6946.756863509753;6993.440524757905;7003.264657211123;5145.61407894402;5263.23683065961;5292.788288468572;5296.682199068068;5402.324709411324;5055.898882022266;5141.100307446107;5153.896922061613;5337.946620533745;5494.478024587658 06:11:09 INFO - PROCESS | 15578 | |4;prototype.html;296.7003326640093;302.6202116343988;308.9366679830635;312.3970736478596;313.9607549056368;5105.647003544063;5205.297284866542;5264.289320941672;5281.551068159206;5301.602379821515;5251.763670634821;5255.894882102356;5269.473052694729;5271;5271.551918086958;4101.794910254483;4116.197341518405;4118.9908472424295;4124.525679546846;4125.876223713279;3896.2597106549806;3915.588863169369;4107.650849677766;4127.092039751265;4145.859888530663;4048.7368321059184;4053.169100334439;4071.97964010181;4076.7350122242105;4087.1417002429525;4044.5955404459614;4053.513578370585;4056.7768772717636;4058.553559108496;4061.4923134608175;3526.5541128137597;3597.5323207983056;3600.243948770761;3613.2773445311045;3614.0784100054316;5077.365329333833;5078.314427552307;5094.388673359221;5097.643164978453;5119.795208191668;4634.6524010698995;4639.868089039918;4645.976770116162;4647.721136731807;4647.790849411785;5182.352205974254;5411.107167317388;5414.620976531644;5423.538999185034;5424.864378390533;3936.724429289951;3946.6842652587725;3950.42486549673;3951.525816901961;3956.5845586213322;5629.211910332557;5637.013522633522;5638;5640.5487560995025;5650.29371328584;4056;4066.3087275163293;4068.8200421877323;4073.5315438724924;4079.796010199478;3847.634474724897;4078.898027549335;4085.816138273785;4103.774292413946;4104.958950410517;4672.579467847842;4674.322223277673;4676.766161691902;4678.438587369469;4678.532146785362;5493.285872836585;5498.532624726863;5514.36584792754;5538.972305138448;5551.528120109755;1298.571471414431;1303.12690497367;1392.997042129665;1402.9368678409292;1403.9157650541001;937.8686983822271;949.5584553182803;962.4369743699874;964.2912459342377;966.3332300712626;5352.153507040065;5354.143337066051;5360.356757189163;5364.91952620711;5366.517013468729;5595.720213989365;5609.80365687199;5610.887782244332;5618.831435056954;5622.718864056863;5189.558887494605;5331.786728530893;5351.545118664879;5358.812441564526;5458.4541545845095;2995.5057415526194;3005.8046226995175;3015.728584427412;3026.5914101596445;3037.1951432870305;5845.048250633403;5877.794277200363;5883.794067207627;5890.558208134407;5898.233229680114;5566.387697353288;5777.902198582256;5782.595218334676;5785.537157027427;5787.88424231513;5874.412558744091;5885.705714714247;5887.3523912370465;5891.263592050994;5893.675847828325;5414.864628384322;5670.461306175906;5696.487316141567;5700.942990570207;5724.599278050663;5656.6888821115235;5677.233573467529;5690.5163061140265;5696.1455781633085;5697.743601537858;5869.559783016376;5902.793402230901;5956.957532431894;5959.344472107978;5968.373320801254;3957.5053118360206;4072;4073.816678249427;4085.5710150434966;4091.734037287567;5652.378238393691;5683.8010669626365;5691.601587888808;5693.316801983623;5746.770129194785;5419.888922770901;5531.557475402039;5548.944510555004;5550.361708403585;5551.583631227593;5558.722063896708;5562.5549956002615;5563.721813909369;5567.3040869891265;5580.525655319343;5408.972955135199;5439.857629897766;5480.451954804487;5491;5494.478024587658;5370.924476369949;5535.612507124462;5539.806106786243;5558.888822223614;5583.69289689071;5417.268668729828;5427.348718153847;5437.755301011385;5452.5365343946205;5469.343678758574 06:11:09 INFO - PROCESS | 15578 | |5;yui.html;753.7211231844218;782.5891407011314;785.7328508307178;798.165916617135;847.0343808058814;14427.78358324626;14918.850811491882;14946.402143914258;14949.177795221258;15000.249987500636;16791.496255112364;16812;16865.156742162904;16988;16995.320187192527;793.5238856685985;823.6334831000207;824.9175082491732;829.6142293833366;830.1366578758115;684.7671791590858;795.5783434779576;821.5645707774859;823.0288259853371;837.983240335196;853.5348235211793;856.25933567464;857.0829212742368;857.7684025313162;858.0561382479285;703.1948419060147;857.7726902370877;858.1461445861377;858.7895965488464;859.299670768325;596.373807502121;610.4322979628944;614.1034090228272;619.8977168767193;619.9690015499207;15666.138362390064;15746.527604171893;15750.76373854393;15751.527454176394;15767.763483547757;13961.232132232723;14148.717025659429;14176.858231417656;14305.642358941006;14432.927835360755;13010.284434356106;13043.673908152277;13153.21080735159;13172.802407963889;13365.799513007312;4400.119976004812;4445.799939002721;4580.404547408815;4589.495155532922;4608.28571571407;74691.87962180626;75055.6247218766;75970;76285;76793.61603191949;11513.88486115145;11542.19204655666;11569.826452603218;11746.412679365998;11756.882431175749;20784.79215207859;20971.056302466426;21048.368548943556;21063;21283.893580532;8407.2433480987;8557.700480483154;8588.184122508352;8719.12808719123;8868.15752503511;4915.8033678652455;4994.950050499521;5018.473060328686;5045.091883461012;5104.617153713486;3395.9981805366983;3488.947665785015;3494.545709057857;3499.720022398202;3503.7547371683736;603.1013789453682;605.8485378655337;608.9512838972871;614.3365165621208;623.1494010675395;615.3661728419735;623.6601052426438;669.1501792723311;718.9388901943394;719.2232389019846;9108.726738197733;9357.157855793012;9487.620495180254;9604.183644390305;9851.852222216672;693.5734523268154;714.6819665248914;717.9589595087144;734.7869117955839;735.9227281135511;4549.203889319356;4848.781804818792;4849.418069831643;4874.707517548958;4946.777395017233;67378.32621673819;105412.47293763635;111662;114139;117920;58335.416645833844;60770.69614651898;82226.58886705647;97286;97420.51289743648;54543.72728136413;55842.441575583725;66597.66701166463;70643.64678176577;86310.93735157844;9186.932940088427;9227.861582076408;9524.857127143237;9532.761680958032;9839.26205534602;47052.29421558748;47327.76336118297;49445.50554494409;49660.25509617286;50368.99999999854;48776;63684;65900.0114998285;70912.29087709056;75535.62232188803;13744.381502832597;13750.731129363943;13820.239886806323;14087.366068526735;14283.357248923616;14514.34685439179;14891.478798242442;14982.456491098363;15390.769138462709;15418.46035388756;13326.3336833156;13487.32563371847;13884;14145.434182632991;14499.057561258485;13754.587362379145;14536.127832330094;14548.854511455173;14769.778453323424;15209.163496007826;14050.437982480586;14252.429902803771;14340.784888226477;14455.566333010027;14921.473799670852;10990.780184396428;11966.22219555726;12185.878141218474;12592.496300147892;12882.227066376048;12239.571614993432;12247.571335003233;12263.896249337602;12417.565385211474;12476.688082798002 06:11:09 INFO - PROCESS | 15578 | __end_tp_report 06:11:09 INFO - PROCESS | 15578 | __start_cc_report 06:11:09 INFO - PROCESS | 15578 | _x_x_mozilla_cycle_collect,1042 06:11:09 INFO - PROCESS | 15578 | __end_cc_report 06:11:09 INFO - PROCESS | 15578 | __startTimestamp1467983469686__endTimestamp 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | ------- Summary: start ------- 06:11:09 INFO - PROCESS | 15578 | Number of tests: 6 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | [#0] dojo.html Cycles:165 Average:5256.21 Median:5502.04 stddev:595.93 (10.8%) stddev-sans-first:571.41 06:11:09 INFO - PROCESS | 15578 | Values: 3022.0 3028.1 3047.9 3058.4 3070.7 5126.8 5203.3 5274.3 5298.8 5324.6 5256.1 5263.5 5279.9 5347.0 5397.1 4716.2 4781.4 4787.1 4789.2 4966.3 4874.7 4877.7 4906.2 4932.7 4945.2 4723.8 4736.0 4750.7 4798.4 4803.9 4729.7 4736.8 4741.1 4747.4 4833.4 4737.9 4760.3 4762.9 4765.7 4779.2 5242.5 5246.3 5288.8 5292.3 5336.8 5657.2 5707.8 5712.5 5728.2 5731.8 5519.4 5686.8 5732.9 5734.4 5745.7 5179.4 5243.8 5267.2 5267.4 5272.4 5698.1 5709.3 5722.9 5728.8 5748.6 5552.9 5558.1 5598.4 5606.1 5613.0 5583.5 5675.3 5680.5 5680.7 5704.8 5511.6 5561.9 5570.9 5673.2 5683.1 5652.2 5702.3 5703.1 5709.0 5715.1 4313.3 4352.8 4362.6 4365.1 4372.0 3906.5 3909.0 3910.4 3941.7 3955.9 5455.8 5465.7 5470.7 5472.9 5508.3 5515.1 5537.2 5590.2 5634.3 5760.7 5256.8 5279.3 5279.7 5302.7 5339.1 4784.4 4800.2 4801.3 4801.6 4847.2 5719.4 5767.5 5783.5 5830.2 5838.3 5622.1 5644.3 5644.9 5646.3 5710.6 5831.7 5883.5 5887.6 5889.5 5889.9 5501.5 5536.3 5543.5 5595.0 5614.9 5681.3 5682.2 5688.6 5694.5 5695.4 5417.7 5542.1 5550.1 5560.1 5560.3 5518.3 5561.1 5563.1 5572.3 5578.7 5491.5 5520.9 5521.0 5529.0 5529.4 5484.5 5502.0 5610.8 5612.9 5655.5 5439.9 5466.2 5466.5 5466.6 5520.2 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | [#1] ext.html Cycles:180 Average:57692.24 Median:43273.46 stddev:110045.52 (254.3%) stddev-sans-first:110270.70 06:11:09 INFO - PROCESS | 15578 | Values: 585.3 612.6 618.6 621.2 639.1 31085.8 44087.3 45243.0 45361.8 45444.5 45950.3 46338.0 46360.5 46372.0 46376.0 8823.3 8959.0 8963.2 8966.7 8967.1 8881.2 8935.1 8976.8 8981.6 8986.2 9010.9 9038.7 9075.2 9076.5 9079.2 8979.4 9007.3 9016.1 9016.6 9028.1 8884.6 8945.5 8947.6 8950.1 8957.6 43250.1 43296.8 43390.3 43400.1 43416.8 3464.9 3646.7 3672.3 3774.7 3914.1 33868.7 34011.1 34071.0 34075.7 35829.6 4515.9 4537.1 4579.7 4698.7 4735.8 338884.0 340010.0 340822.0 340948.0 341742.0 59291.0 59458.0 59894.4 59961.7 60055.1 63861.7 63966.0 64041.0 64047.0 64153.4 15636.8 15703.2 15740.8 15741.1 15759.0 13420.3 13444.0 13446.1 13471.3 13473.2 16513.6 18008.8 18437.4 18500.5 18537.4 4984.1 5736.0 5775.3 5986.6 6039.1 985.2 1027.3 1049.4 1075.5 1090.8 32884.0 33158.2 33181.7 33537.8 33659.7 1121.4 1180.4 1196.8 1203.2 1250.5 16747.0 17269.2 17303.5 17337.2 17340.7 541511.0 546601.0 546841.0 547801.0 549244.0 58516.4 59318.0 59591.4 59707.8 59730.4 1233.0 1343.9 1344.6 1344.9 1377.5 33099.7 35149.7 35315.5 35364.1 35391.6 51324.2 51846.7 51856.5 51925.5 51972.7 320664.0 320836.0 321349.0 321505.0 321676.0 25032.6 28252.7 28258.9 28452.1 28699.9 49139.8 49140.3 49733.3 50088.7 50317.2 41700.0 41722.8 42167.8 42950.6 43417.6 41640.6 41834.4 43377.7 43752.3 43793.3 40984.0 42448.0 42926.0 43080.8 43468.3 33288.5 38178.5 38221.4 38677.0 38832.8 29148.9 29183.7 29366.0 29568.4 29587.6 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | [#2] jquery.html Cycles:180 Average:30612.38 Median:11944.62 stddev:84588.94 (708.2%) stddev-sans-first:84795.76 06:11:09 INFO - PROCESS | 15578 | Values: 371.0 371.7 380.7 383.4 400.6 18312.8 20710.9 20748.2 21499.1 21540.0 19943.5 20274.2 20665.3 20817.6 20880.5 5769.3 5882.0 5964.0 6035.4 6036.0 5841.4 5893.2 5893.6 5910.3 5937.3 5548.0 5875.7 5888.4 5897.9 5920.5 5929.1 5950.3 5965.4 5968.8 6150.1 5833.2 5871.8 5872.8 5879.0 5883.9 14085.9 14178.9 14453.8 14774.7 14798.4 2349.2 2500.3 2652.8 2809.7 3035.9 10259.6 10436.1 10614.9 10699.7 10860.8 1861.5 1868.4 2000.9 2012.2 2066.6 82812.6 88591.6 88647.0 89175.0 89261.0 10682.2 10881.6 10963.1 11002.6 11313.8 15579.2 15634.9 15672.3 15676.3 15690.6 8123.0 8287.7 8312.6 8386.8 8437.8 8007.5 8052.0 8062.0 8195.5 8200.1 4752.3 4772.3 4800.9 4826.7 4858.7 1831.0 1899.2 1947.8 1962.8 1981.3 879.9 1008.9 1014.8 1084.3 1104.1 20424.7 20750.0 20894.8 20925.0 20946.4 971.6 981.6 986.7 1000.8 1052.4 10546.8 11278.9 11469.2 11521.9 11585.5 487656.0 492647.0 515617.0 525525.0 528833.0 105168.0 105594.5 105814.5 108920.5 110585.0 921.1 932.7 956.7 967.4 1046.6 18908.4 18986.9 19280.1 19347.6 19355.8 42353.4 44101.3 45175.1 46669.0 49601.5 64693.4 66350.3 66509.3 66997.0 67237.3 7825.7 8652.5 8780.6 8885.1 9192.7 13575.7 14298.4 14439.6 14539.1 14628.6 12231.9 12551.2 12596.2 12691.0 12774.8 12151.3 12281.3 12536.1 12606.0 12606.6 11800.4 12420.9 12691.3 12704.7 12760.6 7617.7 7984.1 8094.4 8159.6 8206.5 9140.5 12667.7 12810.4 12810.8 12835.6 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | [#3] mootools.html Cycles:180 Average:5627.59 Median:2435.67 stddev:3205.31 (131.6%) stddev-sans-first:3198.09 06:11:09 INFO - PROCESS | 15578 | Values: 1338.1 1448.9 1479.5 1593.7 1745.8 8101.2 8399.8 8415.7 8609.2 8619.1 8406.8 8543.2 8544.7 8549.2 8549.3 2231.8 2264.1 2269.3 2269.9 2271.2 2247.5 2261.3 2280.8 2287.8 2290.7 2202.5 2206.7 2208.9 2210.1 2241.5 2172.7 2185.7 2187.0 2187.1 2196.2 2186.9 2187.6 2188.9 2195.3 2198.7 7690.2 7815.8 8518.3 8559.5 8611.5 4954.9 5035.9 5038.3 5045.3 5046.5 3324.1 3408.6 3424.6 3487.1 3492.1 1071.7 1084.5 1111.9 1126.5 1127.2 11732.6 11932.5 11964.1 11966.1 11982.0 4160.6 4266.1 4322.6 4426.6 4442.3 9036.0 9047.2 9073.2 9082.5 9082.6 4995.5 5000.8 5010.6 5010.6 5020.4 3981.3 4223.3 4520.6 4628.8 4629.8 3677.4 3682.5 3750.3 3765.7 3768.7 1097.5 1102.4 1103.7 1103.9 1117.5 1006.4 1011.4 1026.3 1027.6 1031.3 5945.0 6091.1 6161.1 6220.4 6330.5 432.3 434.8 441.7 444.8 455.1 4249.9 4345.3 4361.8 4366.2 4387.9 10366.9 10804.5 10855.0 10909.0 10927.0 9965.5 10466.7 10758.3 10767.6 10772.0 8027.4 8148.4 8177.4 8221.7 8238.8 5953.9 6278.3 6306.7 6366.0 6380.8 10011.6 10083.3 10091.7 10097.5 10136.5 9060.6 9812.8 10080.4 10216.6 10235.8 7188.0 7397.4 7411.7 7576.6 7585.6 8256.5 8259.3 8288.1 8354.4 8489.7 7112.6 7145.7 7736.9 7862.9 7884.1 7321.1 7345.2 7362.1 7374.0 7473.5 6445.6 6620.5 6946.8 6993.4 7003.3 5145.6 5263.2 5292.8 5296.7 5402.3 5055.9 5141.1 5153.9 5337.9 5494.5 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | [#4] prototype.html Cycles:180 Average:4648.27 Median:5356.48 stddev:1376.40 (25.7%) stddev-sans-first:1340.95 06:11:09 INFO - PROCESS | 15578 | Values: 296.7 302.6 308.9 312.4 314.0 5105.6 5205.3 5264.3 5281.6 5301.6 5251.8 5255.9 5269.5 5271.0 5271.6 4101.8 4116.2 4119.0 4124.5 4125.9 3896.3 3915.6 4107.7 4127.1 4145.9 4048.7 4053.2 4072.0 4076.7 4087.1 4044.6 4053.5 4056.8 4058.6 4061.5 3526.6 3597.5 3600.2 3613.3 3614.1 5077.4 5078.3 5094.4 5097.6 5119.8 4634.7 4639.9 4646.0 4647.7 4647.8 5182.4 5411.1 5414.6 5423.5 5424.9 3936.7 3946.7 3950.4 3951.5 3956.6 5629.2 5637.0 5638.0 5640.5 5650.3 4056.0 4066.3 4068.8 4073.5 4079.8 3847.6 4078.9 4085.8 4103.8 4105.0 4672.6 4674.3 4676.8 4678.4 4678.5 5493.3 5498.5 5514.4 5539.0 5551.5 1298.6 1303.1 1393.0 1402.9 1403.9 937.9 949.6 962.4 964.3 966.3 5352.2 5354.1 5360.4 5364.9 5366.5 5595.7 5609.8 5610.9 5618.8 5622.7 5189.6 5331.8 5351.5 5358.8 5458.5 2995.5 3005.8 3015.7 3026.6 3037.2 5845.0 5877.8 5883.8 5890.6 5898.2 5566.4 5777.9 5782.6 5785.5 5787.9 5874.4 5885.7 5887.4 5891.3 5893.7 5414.9 5670.5 5696.5 5700.9 5724.6 5656.7 5677.2 5690.5 5696.1 5697.7 5869.6 5902.8 5957.0 5959.3 5968.4 3957.5 4072.0 4073.8 4085.6 4091.7 5652.4 5683.8 5691.6 5693.3 5746.8 5419.9 5531.6 5548.9 5550.4 5551.6 5558.7 5562.6 5563.7 5567.3 5580.5 5409.0 5439.9 5480.5 5491.0 5494.5 5370.9 5535.6 5539.8 5558.9 5583.7 5417.3 5427.3 5437.8 5452.5 5469.3 06:11:09 INFO - PROCESS | 15578 | 06:11:09 INFO - PROCESS | 15578 | [#5] yui.html Cycles:180 Average:19295.74 Median:26845.90 stddev:26194.38 (97.6%) stddev-sans-first:26230.86 06:11:09 INFO - PROCESS | 15578 | Values: 753.7 782.6 785.7 798.2 847.0 14427.8 14918.9 14946.4 14949.2 15000.2 16791.5 16812.0 16865.2 16988.0 16995.3 793.5 823.6 824.9 829.6 830.1 684.8 795.6 821.6 823.0 838.0 853.5 856.3 857.1 857.8 858.1 703.2 857.8 858.1 858.8 859.3 596.4 610.4 614.1 619.9 620.0 15666.1 15746.5 15750.8 15751.5 15767.8 13961.2 14148.7 14176.9 14305.6 14432.9 13010.3 13043.7 13153.2 13172.8 13365.8 4400.1 4445.8 4580.4 4589.5 4608.3 74691.9 75055.6 75970.0 76285.0 76793.6 11513.9 11542.2 11569.8 11746.4 11756.9 20784.8 20971.1 21048.4 21063.0 21283.9 8407.2 8557.7 8588.2 8719.1 8868.2 4915.8 4995.0 5018.5 5045.1 5104.6 3396.0 3488.9 3494.5 3499.7 3503.8 603.1 605.8 609.0 614.3 623.1 615.4 623.7 669.2 718.9 719.2 9108.7 9357.2 9487.6 9604.2 9851.9 693.6 714.7 718.0 734.8 735.9 4549.2 4848.8 4849.4 4874.7 4946.8 67378.3 105412.5 111662.0 114139.0 117920.0 58335.4 60770.7 82226.6 97286.0 97420.5 54543.7 55842.4 66597.7 70643.6 86310.9 9186.9 9227.9 9524.9 9532.8 9839.3 47052.3 47327.8 49445.5 49660.3 50369.0 48776.0 63684.0 65900.0 70912.3 75535.6 13744.4 13750.7 13820.2 14087.4 14283.4 14514.3 14891.5 14982.5 15390.8 15418.5 13326.3 13487.3 13884.0 14145.4 14499.1 13754.6 14536.1 14548.9 14769.8 15209.2 14050.4 14252.4 14340.8 14455.6 14921.5 10990.8 11966.2 12185.9 12592.5 12882.2 12239.6 12247.6 12263.9 12417.6 12476.7 06:11:09 INFO - PROCESS | 15578 | -------- Summary: end -------- 06:11:09 INFO - PROCESS | 15578 | 06:11:10 INFO - TEST-INFO | 15578: exit 0 06:11:10 INFO - TEST-OK | dromaeo_css | took 1113639ms 06:11:10 INFO - TEST-START | kraken 06:11:10 INFO - operating with platform_type : linux_ 06:11:10 INFO - Initialising browser for kraken test... 06:11:10 INFO - TEST-INFO | started process 15771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMt4n1Q/profile http://localhost:51706/getInfo.html) 06:11:14 INFO - PROCESS | 15771 | __metrics Screen width/height:1600/1200 06:11:14 INFO - PROCESS | 15771 | colorDepth:24 06:11:14 INFO - PROCESS | 15771 | Browser inner width/height: 1024/697 06:11:14 INFO - PROCESS | 15771 | __metrics 06:11:15 INFO - PROCESS | 15771 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:16 INFO - TEST-INFO | 15771: exit 0 06:11:16 INFO - Browser initialized. 06:11:16 INFO - Running cycle 1/1 for kraken test... 06:11:16 INFO - TEST-INFO | started process 15852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMt4n1Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:28 INFO - PROCESS | 15852 | RSS: Main: 157532160 06:11:28 INFO - PROCESS | 15852 | 06:11:30 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:31 INFO - PROCESS | 15852 | RSS: Main: 215220224 06:11:31 INFO - PROCESS | 15852 | 06:11:33 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-dft) 06:11:34 INFO - PROCESS | 15852 | RSS: Main: 203165696 06:11:34 INFO - PROCESS | 15852 | 06:11:37 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-fft) 06:11:38 INFO - PROCESS | 15852 | RSS: Main: 269565952 06:11:38 INFO - PROCESS | 15852 | 06:11:40 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-oscillator) 06:11:41 INFO - PROCESS | 15852 | RSS: Main: 180883456 06:11:41 INFO - PROCESS | 15852 | 06:11:43 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:43 INFO - PROCESS | 15852 | RSS: Main: 184434688 06:11:43 INFO - PROCESS | 15852 | 06:11:46 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51706/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:47 INFO - PROCESS | 15852 | RSS: Main: 219009024 06:11:47 INFO - PROCESS | 15852 | 06:11:50 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51706/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:51 INFO - PROCESS | 15852 | RSS: Main: 220700672 06:11:51 INFO - PROCESS | 15852 | 06:11:54 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51706/tests/kraken/driver.html?testName=json-parse-financial) 06:11:54 INFO - PROCESS | 15852 | RSS: Main: 221065216 06:11:54 INFO - PROCESS | 15852 | 06:11:56 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:57 INFO - PROCESS | 15852 | RSS: Main: 207691776 06:11:57 INFO - PROCESS | 15852 | 06:11:58 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:59 INFO - PROCESS | 15852 | RSS: Main: 212332544 06:11:59 INFO - PROCESS | 15852 | 06:12:01 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:02 INFO - PROCESS | 15852 | RSS: Main: 212328448 06:12:02 INFO - PROCESS | 15852 | 06:12:04 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:05 INFO - PROCESS | 15852 | RSS: Main: 224964608 06:12:05 INFO - PROCESS | 15852 | 06:12:08 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:08 INFO - PROCESS | 15852 | RSS: Main: 225038336 06:12:08 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51706/tests/kraken/driver.html?testName=ai-astar) 06:12:10 INFO - PROCESS | 15852 | RSS: Main: 267403264 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | __start_tp_report 06:12:10 INFO - PROCESS | 15852 | _x_x_mozilla_page_load 06:12:10 INFO - PROCESS | 15852 | _x_x_mozilla_page_load_details 06:12:10 INFO - PROCESS | 15852 | |i|pagename|runs| 06:12:10 INFO - PROCESS | 15852 | |0;ai-astar;101;111;111;110;111;111;110;111;111;111 06:12:10 INFO - PROCESS | 15852 | |1;audio-beat-detection;144;115;116;182;121;117;144;123;162;117 06:12:10 INFO - PROCESS | 15852 | |2;audio-dft;161;161;161;161;160;161;161;161;161;161 06:12:10 INFO - PROCESS | 15852 | |3;audio-fft;76;76;75;128;75;75;74;74;111;74 06:12:10 INFO - PROCESS | 15852 | |4;audio-oscillator;84;84;119;85;84;85;127;83;84;131 06:12:10 INFO - PROCESS | 15852 | |5;imaging-gaussian-blur;117;118;116;117;117;117;118;117;116;119 06:12:10 INFO - PROCESS | 15852 | |6;imaging-darkroom;147;148;147;147;147;147;149;148;149;148 06:12:10 INFO - PROCESS | 15852 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 06:12:10 INFO - PROCESS | 15852 | |8;json-parse-financial;59;55;54;53;56;54;54;53;52;53 06:12:10 INFO - PROCESS | 15852 | |9;json-stringify-tinderbox;61;62;62;62;62;62;62;62;63;62 06:12:10 INFO - PROCESS | 15852 | |10;stanford-crypto-aes;76;76;79;76;76;75;77;76;83;81 06:12:10 INFO - PROCESS | 15852 | |11;stanford-crypto-ccm;124;126;126;123;120;119;125;119;175;123 06:12:10 INFO - PROCESS | 15852 | |12;stanford-crypto-pbkdf2;157;166;157;160;153;158;162;157;157;155 06:12:10 INFO - PROCESS | 15852 | |13;stanford-crypto-sha256-iterative;77;63;66;62;63;64;64;62;62;61 06:12:10 INFO - PROCESS | 15852 | __end_tp_report 06:12:10 INFO - PROCESS | 15852 | __start_cc_report 06:12:10 INFO - PROCESS | 15852 | _x_x_mozilla_cycle_collect,1696 06:12:10 INFO - PROCESS | 15852 | __end_cc_report 06:12:10 INFO - PROCESS | 15852 | __startTimestamp1467983530525__endTimestamp 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | ------- Summary: start ------- 06:12:10 INFO - PROCESS | 15852 | Number of tests: 14 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.12 (2.8%) stddev-sans-first:0.44 06:12:10 INFO - PROCESS | 15852 | Values: 101.0 111.0 111.0 110.0 111.0 111.0 110.0 111.0 111.0 111.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:133.50 stddev:23.19 (17.4%) stddev-sans-first:24.32 06:12:10 INFO - PROCESS | 15852 | Values: 144.0 115.0 116.0 182.0 121.0 117.0 144.0 123.0 162.0 117.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:12:10 INFO - PROCESS | 15852 | Values: 161.0 161.0 161.0 161.0 160.0 161.0 161.0 161.0 161.0 161.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.00 stddev:19.25 (25.7%) stddev-sans-first:20.21 06:12:10 INFO - PROCESS | 15852 | Values: 76.0 76.0 75.0 128.0 75.0 75.0 74.0 74.0 111.0 74.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:20.27 (24.1%) stddev-sans-first:20.98 06:12:10 INFO - PROCESS | 15852 | Values: 84.0 84.0 119.0 85.0 84.0 85.0 127.0 83.0 84.0 131.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 06:12:10 INFO - PROCESS | 15852 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 119.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 06:12:10 INFO - PROCESS | 15852 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 149.0 148.0 149.0 148.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 06:12:10 INFO - PROCESS | 15852 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:2.00 (3.7%) stddev-sans-first:1.20 06:12:10 INFO - PROCESS | 15852 | Values: 59.0 55.0 54.0 53.0 56.0 54.0 54.0 53.0 52.0 53.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 06:12:10 INFO - PROCESS | 15852 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:2.64 (3.4%) stddev-sans-first:2.74 06:12:10 INFO - PROCESS | 15852 | Values: 76.0 76.0 79.0 76.0 76.0 75.0 77.0 76.0 83.0 81.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:124.50 stddev:16.73 (13.4%) stddev-sans-first:17.68 06:12:10 INFO - PROCESS | 15852 | Values: 124.0 126.0 126.0 123.0 120.0 119.0 125.0 119.0 175.0 123.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:157.50 stddev:3.68 (2.3%) stddev-sans-first:3.87 06:12:10 INFO - PROCESS | 15852 | Values: 157.0 166.0 157.0 160.0 153.0 158.0 162.0 157.0 157.0 155.0 06:12:10 INFO - PROCESS | 15852 | 06:12:10 INFO - PROCESS | 15852 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:63.50 stddev:4.65 (7.3%) stddev-sans-first:1.50 06:12:10 INFO - PROCESS | 15852 | Values: 77.0 63.0 66.0 62.0 63.0 64.0 64.0 62.0 62.0 61.0 06:12:10 INFO - PROCESS | 15852 | -------- Summary: end -------- 06:12:10 INFO - PROCESS | 15852 | 06:12:11 INFO - TEST-INFO | 15852: exit 0 06:12:11 INFO - TEST-OK | kraken | took 60961ms 06:12:11 INFO - SUITE-END | took 1174s 06:12:11 INFO - Completed test suite (00:19:34) 06:12:11 INFO - javascript benchmark 06:12:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3021.969780302197, 3028.1218446650473, 3047.878084876605, 3058.418900408922, 3070.692930706928, 5126.794928202868, 5203.2975548300965, 5274.2879711238975, 5298.841034768959, 5324.62727609067, 5256.053910296155, 5263.526282634562, 5279.868003299919, 5347.0, 5397.136458166694, 4716.221823399135, 4781.402324709411, 4787.066522028206, 4789.233722604384, 4966.304717339575, 4874.73188974608, 4877.658563900528, 4906.239532872411, 4932.704037757728, 4945.184044632631, 4723.78742956566, 4735.976320118394, 4750.7149571025675, 4798.376211092571, 4803.879903002418, 4729.716217026989, 4736.786844592001, 4741.122892264908, 4747.406574178228, 4833.419989601271, 4737.905241895142, 4760.285957106427, 4762.857114286577, 4765.737884416356, 4779.211430114027, 5242.475752424727, 5246.317978662788, 5288.81489147878, 5292.259083728281, 5336.759845806948, 5657.20799088128, 5707.771689132472, 5712.457316554921, 5728.169415434739, 5731.799387021434, 5519.365272993617, 5686.800961966353, 5732.942670573282, 5734.4265573442735, 5745.712714364265, 5179.352580927384, 5243.764030618593, 5267.209918512254, 5267.3679158500845, 5272.393674727378, 5698.145278208219, 5709.3434255060365, 5722.942770572325, 5728.828135155952, 5748.5688573357165, 5552.91670624941, 5558.055130627803, 5598.440155984369, 5606.131049687305, 5613.0, 5583.497485226349, 5675.262215911905, 5680.460356266148, 5680.68756218412, 5704.828855134269, 5511.559075274049, 5561.860953476195, 5570.944290557042, 5673.205751194836, 5683.147527870852, 5652.208690783294, 5702.315722113373, 5703.144528320702, 5709.029464990961, 5715.142728590745, 4313.331433627793, 4352.825886964486, 4362.607365337135, 4365.148795984816, 4371.978140109342, 3906.4726261954274, 3909.0227443139215, 3910.354791459434, 3941.664958478504, 3955.920881582352, 5455.809046683347, 5465.699386533779, 5470.7264636768, 5472.890542189134, 5508.338999320107, 5515.062439385234, 5537.169424586345, 5590.18942253371, 5634.267545219177, 5760.683162426107, 5256.816011439581, 5279.287296215039, 5279.709615971082, 5302.681839089667, 5339.065663508871, 4784.378030856036, 4800.207965685692, 4801.303810947393, 4801.615870730333, 4847.151748444008, 5719.399463056402, 5767.452092051249, 5783.508401785811, 5830.2129212555765, 5838.328592211865, 5622.100463925753, 5644.266245388073, 5644.915326270027, 5646.2942132233475, 5710.571707122065, 5831.708414579339, 5883.470487656132, 5887.587868849139, 5889.469947704727, 5889.911651325319, 5501.504864562208, 5536.252605898152, 5543.501084902378, 5595.048841697003, 5614.887702246014, 5681.318241811009, 5682.176084467646, 5688.601797874109, 5694.544436445157, 5695.430456954271, 5417.702026388586, 5542.0855558833955, 5550.139728342114, 5560.138178582326, 5560.277163968658, 5518.310211223597, 5561.138023606348, 5563.109902415594, 5572.331320241597, 5578.693171875586, 5491.505764481216, 5520.944790552043, 5520.972395137998, 5529.0, 5529.4470552945995, 5484.451554844483, 5502.0371434997915, 5610.7755689773585, 5612.943870561242, 5655.4910058094965, 5439.945600543944, 5466.234727138124, 5466.453354664502, 5466.617336786546, 5520.199571062093], "value": 5215.9385511652645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.3005658238404, 612.6446660936657, 618.5608218165099, 621.2482895696207, 639.1307821362949, 31085.844570777143, 44087.338689919634, 45243.0, 45361.773191134, 45444.54555454444, 45950.310745338844, 46338.0, 46360.536394636045, 46372.0, 46376.0, 8823.250023747989, 8958.955205223965, 8963.238124759404, 8966.686165984192, 8967.058458861791, 8881.245094167003, 8935.106489351045, 8976.820463590724, 8981.550922453884, 8986.191242788147, 9010.86483702745, 9038.728838134833, 9075.183233508982, 9076.546172691373, 9079.18287354138, 8979.416337938046, 9007.324450666161, 9016.05331440196, 9016.594253258587, 9028.09719028092, 8884.644614215424, 8945.46327220369, 8947.64209431622, 8950.149735775156, 8957.641694332218, 43250.13499730019, 43296.78351608222, 43390.349144762855, 43400.13199736019, 43416.78291608553, 3464.861405543775, 3646.690031347339, 3672.338978983782, 3774.7168962327937, 3914.099757055893, 33868.661313386794, 34011.149721256916, 34070.97787066392, 34075.6592434075, 35829.64170358289, 4515.932261016054, 4537.115262523809, 4579.748113853737, 4698.718076915396, 4735.834245801415, 338884.0, 340009.9999999975, 340822.0, 340948.0, 341742.0, 59291.0, 59458.0, 59894.401055988885, 59961.700191499636, 60055.09917351243, 63861.680691597176, 63966.0, 64041.0, 64047.0, 64153.35846641567, 15636.827237956972, 15703.21483925822, 15740.842591574166, 15741.134237616812, 15759.0, 13420.328983550784, 13444.0, 13446.05877588579, 13471.259080750653, 13473.191608503521, 16513.587160321087, 18008.819911800976, 18437.354692585694, 18500.537486562942, 18537.35119270819, 4984.053029924303, 5735.971320143372, 5775.29628759517, 5986.640801551921, 6039.094135879654, 985.2167526816198, 1027.2655051638114, 1049.3703777733451, 1075.516017791981, 1090.8036553420302, 32884.0, 33158.17104572405, 33181.66818331834, 33537.83231083878, 33659.66340336614, 1121.388843080523, 1180.4274926660562, 1196.778595959733, 1203.2058841164965, 1250.4685508658783, 16747.0, 17269.222884970208, 17303.480895573153, 17337.2198251079, 17340.739888901677, 541511.0, 546601.0, 546841.0, 547801.0, 549244.0, 58516.414835851945, 59318.0, 59591.40408595945, 59707.82045256877, 59730.40269597335, 1232.950681972729, 1343.8723321284463, 1344.6302266876687, 1344.8789608935242, 1377.5109836008273, 33099.66900330966, 35149.65082304203, 35315.47026794651, 35364.115897102776, 35391.646083538835, 51324.15068869775, 51846.74076629593, 51856.48143518517, 51925.480745192064, 51972.74013629908, 320664.0, 320836.0, 321349.0, 321505.0, 321676.0, 25032.62451063272, 28252.71747282501, 28258.85870570634, 28452.146435606966, 28699.856500717364, 49139.771505711215, 49140.262896057306, 49733.254001189285, 50088.74955625198, 50317.24524132068, 41700.0, 41722.79138604409, 42167.789161053995, 42950.570494294654, 43417.56582434135, 41640.58359416367, 41834.37248441337, 43377.74763633493, 43752.343714843664, 43793.343099854166, 40984.0, 42448.0, 42926.0, 43080.784596078076, 43468.347974781034, 33288.500672490416, 38178.47286108525, 38221.4266786004, 38677.0, 38832.80583597064, 29148.854255728587, 29183.708162918098, 29366.0, 29568.408631827675, 29587.556186657646], "value": 20240.61030872779, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.9758865673731, 371.6766413220498, 380.7144641518861, 383.36935740706537, 400.62141276493725, 18312.816871831295, 20710.89644551779, 20748.170073197074, 21499.140034398624, 21540.0, 19943.50141246466, 20274.189032438684, 20665.276715314965, 20817.583648327025, 20880.477988050305, 5769.3076830780365, 5882.000059989812, 5963.970180149093, 6035.426634469718, 6036.034234522455, 5841.386654401269, 5893.174955506232, 5893.55798315126, 5910.34986151523, 5937.287525496947, 5548.0, 5875.676837773921, 5888.352281249059, 5897.852553686149, 5920.496757775594, 5929.110633405002, 5950.345461999176, 5965.373635768268, 5968.79109231177, 6150.077488376779, 5833.154192642086, 5871.765129394819, 5872.765089396419, 5879.0, 5883.941160588382, 14085.85914140866, 14178.929105354511, 14453.78319325211, 14774.704505909822, 14798.40806367744, 2349.2482405630035, 2500.2624225853415, 2652.774514166298, 2809.7190280971945, 3035.878564857403, 10259.589616415335, 10436.112930400925, 10614.893851061468, 10699.732506687316, 10860.782784344348, 1861.4601765487992, 1868.355417381015, 2000.9299674511321, 2012.2051789543195, 2066.60734460452, 82812.58593707053, 88591.55704221502, 88647.0, 89175.0, 89260.99999999935, 10682.1988350874, 10881.564737410574, 10963.122950163968, 11002.559897604006, 11313.773724525463, 15579.221038948008, 15634.9218253908, 15672.294746736425, 15676.294566744524, 15690.607734806494, 8123.0, 8287.668493260322, 8312.6333834797, 8386.790330241793, 8437.831243375222, 8007.479513831582, 8052.0, 8061.959690201512, 8195.508269503729, 8200.138985406566, 4752.334673145762, 4772.260299653559, 4800.903981920412, 4826.710397376169, 4858.708477491362, 1830.9633807324046, 1899.1928430417017, 1947.8149575790278, 1962.7546556680416, 1981.326349041304, 879.872418499314, 1008.9041541053588, 1014.8376259798397, 1084.311462221495, 1104.139282259855, 20424.69362959527, 20750.0, 20894.791052089284, 20925.0, 20946.371608851758, 971.5579411367811, 981.6024510073431, 986.6842610364614, 1000.8048430555972, 1052.4106500359824, 10546.841797373045, 11278.887211127783, 11469.197156199152, 11521.884781152248, 11585.478653460614, 487656.0, 492647.0, 515617.0, 525525.0, 528833.0, 105168.0, 105594.47202763936, 105814.47092764487, 108920.4553977225, 110585.0, 921.1341339141186, 932.6968735160964, 956.6986399284203, 967.3615413826841, 1046.6336782126195, 18908.43274701761, 18986.905065474584, 19280.132394042583, 19347.613047739247, 19355.8064419354, 42353.364699530146, 44101.33847992347, 45175.09649807051, 46669.0, 49601.503984961135, 64693.353066468735, 66350.33649663441, 66509.33490665031, 66997.0, 67237.32762672506, 7825.686972521035, 8652.547087340192, 8780.604872780612, 8885.06706795803, 9192.724218273463, 13575.660608484866, 14298.428062877369, 14439.566025605835, 14539.127652340894, 14628.561143165722, 12231.938840305742, 12551.184173028723, 12596.244225346509, 12691.0, 12774.799194786145, 12151.270923744603, 12281.324527151093, 12536.122471426912, 12606.0, 12606.621801345975, 11800.350980696145, 12420.875791241971, 12691.301978391277, 12704.6823829405, 12760.553380631633, 7617.695292188472, 7984.081830589324, 8094.433389662902, 8159.551224682462, 8206.466579672302, 9140.497272650067, 12667.683307917376, 12810.359482026048, 12810.807837882252, 12835.550755723505], "value": 9483.677073122595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.0900987328625, 1448.898577099603, 1479.47478645081, 1593.7370333894908, 1745.8226028627903, 8101.1898810118955, 8399.790005249879, 8415.70545030924, 8609.225169734722, 8619.138086191379, 8406.789830254247, 8543.231109200171, 8544.65821367146, 8549.187827156426, 8549.316054715624, 2231.7991380775725, 2264.116994372196, 2269.273832373641, 2269.931902042933, 2271.2277825539313, 2247.5280191159877, 2261.2989973108306, 2280.8061314788265, 2287.7597852225526, 2290.713660792401, 2202.526456811785, 2206.6689996500495, 2208.8895555222175, 2210.071769856656, 2241.495663475713, 2172.6958225848393, 2185.67214917762, 2187.0377034105104, 2187.07049503961, 2196.187410658059, 2186.9234576789736, 2187.6171669957694, 2188.890555472236, 2195.3304242206123, 2198.714167158259, 7690.230976902321, 7815.804604884924, 8518.27594654455, 8559.486430814171, 8611.48331100136, 4954.900901981976, 5035.924461133086, 5038.319826823368, 5045.293658887758, 5046.495350464961, 3324.1024923270584, 3408.625051244361, 3424.6232914379398, 3487.093355727529, 3492.1269682579355, 1071.6784964510693, 1084.4523515624637, 1111.9444027798659, 1126.5043380912373, 1127.2447460201683, 11732.648020559396, 11932.463039163258, 11964.102692298113, 11966.102542309274, 11982.041436685044, 4160.563140870226, 4266.0827921996915, 4322.567743225715, 4426.579474949875, 4442.267025940748, 9036.0, 9047.185753282236, 9073.183413492685, 9082.45505269686, 9082.636694532144, 4995.450500444948, 5000.824971125993, 5010.599152067899, 5010.624203184776, 5020.422651395063, 3981.3231750602467, 4223.260929337353, 4520.615747661485, 4628.814847406134, 4629.791659375336, 3677.3748462761396, 3682.5396825396824, 3750.3436898542645, 3765.7363984521367, 3768.660820526111, 1097.4567589043475, 1102.4267380962015, 1103.7130346110068, 1103.906167975731, 1117.541807858774, 1006.3810756384917, 1011.3577878047493, 1026.2662196529518, 1027.5838285494387, 1031.339942436841, 5945.0, 6091.086337049478, 6161.106639537332, 6220.440160385587, 6330.4619107375465, 432.3104648086297, 434.75653633965084, 441.7437886026097, 444.757607104129, 455.10344621096385, 4249.87250382489, 4345.261305577996, 4361.847335343311, 4366.19225443294, 4387.890302742457, 10366.896331036744, 10804.459777011118, 10854.96877796608, 10909.0, 10927.0, 9965.451900145417, 10466.738331541621, 10758.300710453796, 10767.569297228023, 10772.0, 8027.397945154137, 8148.429609927248, 8177.386695997824, 8221.671133154607, 8238.794030149174, 5953.880922381615, 6278.309385967631, 6306.747730090745, 6365.96817015912, 6380.776672816615, 10011.649592264235, 10083.344582602107, 10091.69724908254, 10097.545610447694, 10136.493175341056, 9060.637574496946, 9812.803743925224, 10080.445575493419, 10216.591336346462, 10235.84646230322, 7188.0, 7397.408207343292, 7411.740589079572, 7576.583287919218, 7585.620718963919, 8256.504609723435, 8259.339252859876, 8288.088310285742, 8354.373421993496, 8489.660413583388, 7112.644367781693, 7145.678444469907, 7736.883946740691, 7862.882056769038, 7884.093329266978, 7321.121465424183, 7345.1553071397475, 7362.079740032496, 7373.963130184315, 7473.476856619985, 6445.613263204223, 6620.536562440583, 6946.756863509753, 6993.440524757905, 7003.264657211123, 5145.61407894402, 5263.23683065961, 5292.788288468572, 5296.682199068068, 5402.324709411324, 5055.898882022266, 5141.100307446107, 5153.896922061613, 5337.946620533745, 5494.478024587658], "value": 4425.015166674564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.7003326640093, 302.6202116343988, 308.9366679830635, 312.3970736478596, 313.9607549056368, 5105.647003544063, 5205.297284866542, 5264.289320941672, 5281.551068159206, 5301.602379821515, 5251.763670634821, 5255.894882102356, 5269.473052694729, 5271.0, 5271.551918086958, 4101.794910254483, 4116.197341518405, 4118.9908472424295, 4124.525679546846, 4125.876223713279, 3896.2597106549806, 3915.588863169369, 4107.650849677766, 4127.092039751265, 4145.859888530663, 4048.7368321059184, 4053.169100334439, 4071.97964010181, 4076.7350122242105, 4087.1417002429525, 4044.5955404459614, 4053.513578370585, 4056.7768772717636, 4058.553559108496, 4061.4923134608175, 3526.5541128137597, 3597.5323207983056, 3600.243948770761, 3613.2773445311045, 3614.0784100054316, 5077.365329333833, 5078.314427552307, 5094.388673359221, 5097.643164978453, 5119.795208191668, 4634.6524010698995, 4639.868089039918, 4645.976770116162, 4647.721136731807, 4647.790849411785, 5182.352205974254, 5411.107167317388, 5414.620976531644, 5423.538999185034, 5424.864378390533, 3936.724429289951, 3946.6842652587725, 3950.42486549673, 3951.525816901961, 3956.5845586213322, 5629.211910332557, 5637.013522633522, 5638.0, 5640.5487560995025, 5650.29371328584, 4056.0, 4066.3087275163293, 4068.8200421877323, 4073.5315438724924, 4079.796010199478, 3847.634474724897, 4078.898027549335, 4085.816138273785, 4103.774292413946, 4104.958950410517, 4672.579467847842, 4674.322223277673, 4676.766161691902, 4678.438587369469, 4678.532146785362, 5493.285872836585, 5498.532624726863, 5514.36584792754, 5538.972305138448, 5551.528120109755, 1298.571471414431, 1303.12690497367, 1392.997042129665, 1402.9368678409292, 1403.9157650541001, 937.8686983822271, 949.5584553182803, 962.4369743699874, 964.2912459342377, 966.3332300712626, 5352.153507040065, 5354.143337066051, 5360.356757189163, 5364.91952620711, 5366.517013468729, 5595.720213989365, 5609.80365687199, 5610.887782244332, 5618.831435056954, 5622.718864056863, 5189.558887494605, 5331.786728530893, 5351.545118664879, 5358.812441564526, 5458.4541545845095, 2995.5057415526194, 3005.8046226995175, 3015.728584427412, 3026.5914101596445, 3037.1951432870305, 5845.048250633403, 5877.794277200363, 5883.794067207627, 5890.558208134407, 5898.233229680114, 5566.387697353288, 5777.902198582256, 5782.595218334676, 5785.537157027427, 5787.88424231513, 5874.412558744091, 5885.705714714247, 5887.3523912370465, 5891.263592050994, 5893.675847828325, 5414.864628384322, 5670.461306175906, 5696.487316141567, 5700.942990570207, 5724.599278050663, 5656.6888821115235, 5677.233573467529, 5690.5163061140265, 5696.1455781633085, 5697.743601537858, 5869.559783016376, 5902.793402230901, 5956.957532431894, 5959.344472107978, 5968.373320801254, 3957.5053118360206, 4072.0, 4073.816678249427, 4085.5710150434966, 4091.734037287567, 5652.378238393691, 5683.8010669626365, 5691.601587888808, 5693.316801983623, 5746.770129194785, 5419.888922770901, 5531.557475402039, 5548.944510555004, 5550.361708403585, 5551.583631227593, 5558.722063896708, 5562.5549956002615, 5563.721813909369, 5567.3040869891265, 5580.525655319343, 5408.972955135199, 5439.857629897766, 5480.451954804487, 5491.0, 5494.478024587658, 5370.924476369949, 5535.612507124462, 5539.806106786243, 5558.888822223614, 5583.69289689071, 5417.268668729828, 5427.348718153847, 5437.755301011385, 5452.5365343946205, 5469.343678758574], "value": 4201.8089536466105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.7211231844218, 782.5891407011314, 785.7328508307178, 798.165916617135, 847.0343808058814, 14427.78358324626, 14918.850811491882, 14946.402143914258, 14949.177795221258, 15000.249987500636, 16791.496255112364, 16812.0, 16865.156742162904, 16988.0, 16995.320187192527, 793.5238856685985, 823.6334831000207, 824.9175082491732, 829.6142293833366, 830.1366578758115, 684.7671791590858, 795.5783434779576, 821.5645707774859, 823.0288259853371, 837.983240335196, 853.5348235211793, 856.25933567464, 857.0829212742368, 857.7684025313162, 858.0561382479285, 703.1948419060147, 857.7726902370877, 858.1461445861377, 858.7895965488464, 859.299670768325, 596.373807502121, 610.4322979628944, 614.1034090228272, 619.8977168767193, 619.9690015499207, 15666.138362390064, 15746.527604171893, 15750.76373854393, 15751.527454176394, 15767.763483547757, 13961.232132232723, 14148.717025659429, 14176.858231417656, 14305.642358941006, 14432.927835360755, 13010.284434356106, 13043.673908152277, 13153.21080735159, 13172.802407963889, 13365.799513007312, 4400.119976004812, 4445.799939002721, 4580.404547408815, 4589.495155532922, 4608.28571571407, 74691.87962180626, 75055.6247218766, 75970.0, 76285.0, 76793.61603191949, 11513.88486115145, 11542.19204655666, 11569.826452603218, 11746.412679365998, 11756.882431175749, 20784.79215207859, 20971.056302466426, 21048.368548943556, 21063.0, 21283.893580532, 8407.2433480987, 8557.700480483154, 8588.184122508352, 8719.12808719123, 8868.15752503511, 4915.8033678652455, 4994.950050499521, 5018.473060328686, 5045.091883461012, 5104.617153713486, 3395.9981805366983, 3488.947665785015, 3494.545709057857, 3499.720022398202, 3503.7547371683736, 603.1013789453682, 605.8485378655337, 608.9512838972871, 614.3365165621208, 623.1494010675395, 615.3661728419735, 623.6601052426438, 669.1501792723311, 718.9388901943394, 719.2232389019846, 9108.726738197733, 9357.157855793012, 9487.620495180254, 9604.183644390305, 9851.852222216672, 693.5734523268154, 714.6819665248914, 717.9589595087144, 734.7869117955839, 735.9227281135511, 4549.203889319356, 4848.781804818792, 4849.418069831643, 4874.707517548958, 4946.777395017233, 67378.32621673819, 105412.47293763635, 111662.0, 114139.0, 117920.0, 58335.416645833844, 60770.69614651898, 82226.58886705647, 97286.0, 97420.51289743648, 54543.72728136413, 55842.441575583725, 66597.66701166463, 70643.64678176577, 86310.93735157844, 9186.932940088427, 9227.861582076408, 9524.857127143237, 9532.761680958032, 9839.26205534602, 47052.29421558748, 47327.76336118297, 49445.50554494409, 49660.25509617286, 50368.99999999854, 48776.0, 63684.0, 65900.0114998285, 70912.29087709056, 75535.62232188803, 13744.381502832597, 13750.731129363943, 13820.239886806323, 14087.366068526735, 14283.357248923616, 14514.34685439179, 14891.478798242442, 14982.456491098363, 15390.769138462709, 15418.46035388756, 13326.3336833156, 13487.32563371847, 13884.0, 14145.434182632991, 14499.057561258485, 13754.587362379145, 14536.127832330094, 14548.854511455173, 14769.778453323424, 15209.163496007826, 14050.437982480586, 14252.429902803771, 14340.784888226477, 14455.566333010027, 14921.473799670852, 10990.780184396428, 11966.22219555726, 12185.878141218474, 12592.496300147892, 12882.227066376048, 12239.571614993432, 12247.571335003233, 12263.896249337602, 12417.565385211474, 12476.688082798002], "value": 7558.967417665807, "unit": "score"}], "name": "dromaeo_css", "value": 7212.166660575352, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 116.0, 182.0, 121.0, 117.0, 144.0, 123.0, 162.0, 117.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 128.0, 75.0, 75.0, 74.0, 74.0, 111.0, 74.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 85.0, 84.0, 85.0, 127.0, 83.0, 84.0, 131.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 119.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 149.0, 148.0, 149.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 54.0, 53.0, 56.0, 54.0, 54.0, 53.0, 52.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 76.0, 76.0, 75.0, 77.0, 76.0, 83.0, 81.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 126.0, 123.0, 120.0, 119.0, 125.0, 119.0, 175.0, 123.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 166.0, 157.0, 160.0, 153.0, 158.0, 162.0, 157.0, 157.0, 155.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 63.0, 66.0, 62.0, 63.0, 64.0, 64.0, 62.0, 62.0, 61.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1489.3999999999999, "alertThreshold": 2.0}]} 06:12:11 INFO - Return code: 0 06:12:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:11 INFO - # TBPL SUCCESS # 06:12:11 INFO - Running post-action listener: _resource_record_post_action 06:12:11 INFO - ##### 06:12:11 INFO - ##### Finished run-tests step (success) 06:12:11 INFO - ##### 06:12:11 INFO - Running post-run listener: _resource_record_post_run 06:12:11 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 553308160; Read time: 0; Write time: 439304 06:12:11 INFO - TinderboxPrint: CPU usage
13.0% 06:12:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:12:11 INFO - TinderboxPrint: I/O write bytes / time
553,308,160 / 439,304 06:12:11 INFO - TinderboxPrint: CPU idle
8,277.8 (87.0%) 06:12:11 INFO - TinderboxPrint: CPU user
1,192.9 (12.5%) 06:12:11 INFO - TinderboxPrint: Swap in / out
0 / 0 06:12:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263434240; Read time: 0; Write time: 250104 06:12:11 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289873920; Read time: 0; Write time: 189200 06:12:12 INFO - Running post-run listener: _upload_blobber_files 06:12:12 INFO - Blob upload gear active. 06:12:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:12:12 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:16 INFO - (blobuploader) - INFO - Done attempting. 06:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:17 INFO - (blobuploader) - INFO - Done attempting. 06:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:18 INFO - (blobuploader) - INFO - Done attempting. 06:12:18 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:18 INFO - Return code: 0 06:12:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a21a119ff7f8993f6074525bf78ebd8c37f3b4b8e8c5b1dd57657a97cee809aabf25c6cbfe8a496925b8a6c90366d8ab603963cbfd13feb6543d64194d88f7ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3c15481fca175ee1f8510c7ee5551411751c2e57d059c536d191a6f6ac6987ed020d8d0391bd57aa174fa8b98f019e5fdfc963fdc0b0c6da9aaa3999d1b7ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66af182ea77477379db4a583557e7f1a8bedb029f2c2c662652947065c432ee7861b54c575d6bdcca9d48723d609b50b95f0f4467c414ebb7ff8086fdb75250"} 06:12:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:18 INFO - Contents: 06:12:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a21a119ff7f8993f6074525bf78ebd8c37f3b4b8e8c5b1dd57657a97cee809aabf25c6cbfe8a496925b8a6c90366d8ab603963cbfd13feb6543d64194d88f7ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3c15481fca175ee1f8510c7ee5551411751c2e57d059c536d191a6f6ac6987ed020d8d0391bd57aa174fa8b98f019e5fdfc963fdc0b0c6da9aaa3999d1b7ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66af182ea77477379db4a583557e7f1a8bedb029f2c2c662652947065c432ee7861b54c575d6bdcca9d48723d609b50b95f0f4467c414ebb7ff8086fdb75250"} 06:12:18 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:18 INFO - Copying logs to upload dir... 06:12:18 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.315474 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-07-08 06:12:17.896140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:12:17.899967) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a21a119ff7f8993f6074525bf78ebd8c37f3b4b8e8c5b1dd57657a97cee809aabf25c6cbfe8a496925b8a6c90366d8ab603963cbfd13feb6543d64194d88f7ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3c15481fca175ee1f8510c7ee5551411751c2e57d059c536d191a6f6ac6987ed020d8d0391bd57aa174fa8b98f019e5fdfc963fdc0b0c6da9aaa3999d1b7ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66af182ea77477379db4a583557e7f1a8bedb029f2c2c662652947065c432ee7861b54c575d6bdcca9d48723d609b50b95f0f4467c414ebb7ff8086fdb75250"} build_url:https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/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/Fx-Team/sha512/a21a119ff7f8993f6074525bf78ebd8c37f3b4b8e8c5b1dd57657a97cee809aabf25c6cbfe8a496925b8a6c90366d8ab603963cbfd13feb6543d64194d88f7ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e3c15481fca175ee1f8510c7ee5551411751c2e57d059c536d191a6f6ac6987ed020d8d0391bd57aa174fa8b98f019e5fdfc963fdc0b0c6da9aaa3999d1b7ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66af182ea77477379db4a583557e7f1a8bedb029f2c2c662652947065c432ee7861b54c575d6bdcca9d48723d609b50b95f0f4467c414ebb7ff8086fdb75250"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:12:17.926066) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:12:17.926389) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467982244.239793-67433203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:12:18.009818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:12:18.010126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:12:18.010423) ========= ========= Total master_lag: 0.17 =========