builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1472666438.68 results: success (0) buildid: 20160831092321 builduid: a88339f57ad64ea09c2d7b4d8de4212b revision: fabfb2ff761eace61d0433e4d6e3d74e0cba193e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.679103) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.679539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.679811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.694349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.694666) ========= 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=db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 11:00:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-08-31 11:00:38 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095394 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.804813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.805170) ========= 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=db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015585 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:38.854922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 11:00:38.855272) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fabfb2ff761eace61d0433e4d6e3d74e0cba193e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev fabfb2ff761eace61d0433e4d6e3d74e0cba193e --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=db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 11:00:38,966 truncating revision to first 12 chars 2016-08-31 11:00:38,966 Setting DEBUG logging. 2016-08-31 11:00:38,966 attempt 1/10 2016-08-31 11:00:38,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fabfb2ff761e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 11:00:40,077 unpacking tar archive at: autoland-fabfb2ff761e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 11:00:40.251120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:40.251482) ========= script_repo_revision: fabfb2ff761eace61d0433e4d6e3d74e0cba193e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:40.251861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:40.252139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:40.261659) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-31 11:00:40.262055) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:40 INFO - MultiFileLogger online at 20160831 11:00:40 in /builds/slave/test 11:00:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 11:00:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:00:40 INFO - {'append_to_log': False, 11:00:40 INFO - 'base_work_dir': '/builds/slave/test', 11:00:40 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:00:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:00:40 INFO - 'branch': 'Autoland-Non-PGO', 11:00:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:40 INFO - 'config_files': ('talos/linux_config.py',), 11:00:40 INFO - 'default_actions': ('clobber', 11:00:40 INFO - 'read-buildbot-config', 11:00:40 INFO - 'download-and-extract', 11:00:40 INFO - 'populate-webroot', 11:00:40 INFO - 'create-virtualenv', 11:00:40 INFO - 'install', 11:00:40 INFO - 'run-tests'), 11:00:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:40 INFO - 'download_minidump_stackwalk': True, 11:00:40 INFO - 'download_symbols': 'ondemand', 11:00:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:40 INFO - 'installer_path': 'installer.exe', 11:00:40 INFO - 'log_level': 'info', 11:00:40 INFO - 'log_name': 'talos', 11:00:40 INFO - 'log_to_console': True, 11:00:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:40 INFO - 'opt_config_files': (), 11:00:40 INFO - 'pip_index': False, 11:00:40 INFO - 'sps_profile': False, 11:00:40 INFO - 'sps_profile_interval': 0, 11:00:40 INFO - 'suite': 'dromaeojs', 11:00:40 INFO - 'system_bits': '32', 11:00:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:40 INFO - 'title': 'talos-linux64-ix-031', 11:00:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:40 INFO - 'use_talos_json': True, 11:00:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:00:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:40 INFO - 'work_dir': 'build'} 11:00:40 INFO - [mozharness: 2016-08-31 18:00:40.470961Z] Running clobber step. 11:00:40 INFO - Running pre-action listener: _resource_record_pre_action 11:00:40 INFO - Running main action method: clobber 11:00:40 INFO - rmtree: /builds/slave/test/build 11:00:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:00:41 INFO - Running post-action listener: _resource_record_post_action 11:00:41 INFO - [mozharness: 2016-08-31 18:00:41.446158Z] Finished clobber step (success) 11:00:41 INFO - [mozharness: 2016-08-31 18:00:41.446259Z] Running read-buildbot-config step. 11:00:41 INFO - Running pre-action listener: _resource_record_pre_action 11:00:41 INFO - Running main action method: read_buildbot_config 11:00:41 INFO - Using buildbot properties: 11:00:41 INFO - { 11:00:41 INFO - "project": "", 11:00:41 INFO - "product": "firefox", 11:00:41 INFO - "script_repo_revision": "production", 11:00:41 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:00:41 INFO - "repository": "", 11:00:41 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:00:41 INFO - "buildid": "20160831092321", 11:00:41 INFO - "pgo_build": "False", 11:00:41 INFO - "basedir": "/builds/slave/test", 11:00:41 INFO - "buildnumber": 581, 11:00:41 INFO - "slavename": "talos-linux64-ix-031", 11:00:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:00:41 INFO - "platform": "ubuntu64_hw", 11:00:41 INFO - "scheduler": "tests-autoland-linux64-talos", 11:00:41 INFO - "branch": "autoland", 11:00:41 INFO - "repo_path": "integration/autoland", 11:00:41 INFO - "revision": "fabfb2ff761eace61d0433e4d6e3d74e0cba193e", 11:00:41 INFO - "stage_platform": "linux64", 11:00:41 INFO - "builduid": "a88339f57ad64ea09c2d7b4d8de4212b", 11:00:41 INFO - "slavebuilddir": "test" 11:00:41 INFO - } 11:00:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:00:41 INFO - Running post-action listener: _resource_record_post_action 11:00:41 INFO - [mozharness: 2016-08-31 18:00:41.448693Z] Finished read-buildbot-config step (success) 11:00:41 INFO - [mozharness: 2016-08-31 18:00:41.448785Z] Running download-and-extract step. 11:00:41 INFO - Running pre-action listener: _resource_record_pre_action 11:00:41 INFO - Running main action method: download_and_extract 11:00:41 INFO - mkdir: /builds/slave/test/build/tests 11:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:41 INFO - trying https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:00:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:00:42 INFO - Downloaded 1361 bytes. 11:00:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:00:42 INFO - Using the following test package requirements: 11:00:42 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:00:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:00:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'jsshell-linux-x86_64.zip'], 11:00:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:00:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:00:42 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:00:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:00:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:00:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:42 INFO - trying https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:42 INFO - Downloaded 20332247 bytes. 11:00:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:00:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:47 INFO - trying https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:47 INFO - Downloaded 20332247 bytes. 11:00:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:52 INFO - trying https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:00:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:00:53 INFO - Downloaded 14413998 bytes. 11:00:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:00:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:53 INFO - trying https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:00:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:00:54 INFO - Downloaded 55865311 bytes. 11:00:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:00:54 INFO - mkdir: /builds/slave/test/properties 11:00:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:00:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:00:54 INFO - Contents: 11:00:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:00:55 INFO - Running post-action listener: _resource_record_post_action 11:00:55 INFO - Running post-action listener: set_extra_try_arguments 11:00:55 INFO - [mozharness: 2016-08-31 18:00:55.477025Z] Finished download-and-extract step (success) 11:00:55 INFO - [mozharness: 2016-08-31 18:00:55.477294Z] Running populate-webroot step. 11:00:55 INFO - Running pre-action listener: _resource_record_pre_action 11:00:55 INFO - Running main action method: populate_webroot 11:00:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:55 INFO - '--tppagecycles', 11:00:55 INFO - '7'], 11:00:55 INFO - 'tests': ['tsvgm']}}, 11:00:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:00:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:00:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:00:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['damp', 'tps']}, 11:00:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'tests': ['damp', 'tps']}, 11:00:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['dromaeo_dom']}, 11:00:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['basic_compositor_video']}, 11:00:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:00:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['a11yr', 11:00:55 INFO - 'ts_paint', 11:00:55 INFO - 'tpaint', 11:00:55 INFO - 'sessionrestore', 11:00:55 INFO - 'sessionrestore_no_auto_restore', 11:00:55 INFO - 'tabpaint']}, 11:00:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:00:55 INFO - 'ts_paint', 11:00:55 INFO - 'tpaint', 11:00:55 INFO - 'sessionrestore', 11:00:55 INFO - 'sessionrestore_no_auto_restore', 11:00:55 INFO - 'tabpaint']}, 11:00:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:00:55 INFO - 'ts_paint', 11:00:55 INFO - 'tpaint', 11:00:55 INFO - 'sessionrestore', 11:00:55 INFO - 'sessionrestore_no_auto_restore', 11:00:55 INFO - 'tabpaint']}, 11:00:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:00:55 INFO - 'ts_paint', 11:00:55 INFO - 'tpaint', 11:00:55 INFO - 'sessionrestore', 11:00:55 INFO - 'sessionrestore_no_auto_restore', 11:00:55 INFO - 'tabpaint']}, 11:00:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['a11yr', 11:00:55 INFO - 'ts_paint', 11:00:55 INFO - 'tpaint', 11:00:55 INFO - 'sessionrestore', 11:00:55 INFO - 'sessionrestore_no_auto_restore', 11:00:55 INFO - 'tabpaint']}, 11:00:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['a11yr', 11:00:55 INFO - 'ts_paint', 11:00:55 INFO - 'tpaint', 11:00:55 INFO - 'sessionrestore', 11:00:55 INFO - 'sessionrestore_no_auto_restore', 11:00:55 INFO - 'tabpaint']}, 11:00:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['tsvgx', 11:00:55 INFO - 'tsvgr_opacity', 11:00:55 INFO - 'tart', 11:00:55 INFO - 'tscrollx', 11:00:55 INFO - 'cart']}, 11:00:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:00:55 INFO - 'tsvgr_opacity', 11:00:55 INFO - 'tart', 11:00:55 INFO - 'tscrollx', 11:00:55 INFO - 'cart']}, 11:00:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'talos_options': ['--disable-e10s'], 11:00:55 INFO - 'tests': ['tp5o']}, 11:00:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'tests': ['tp5o']}, 11:00:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'talos_options': ['--disable-e10s', 11:00:55 INFO - '--xperf_path', 11:00:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:55 INFO - 'tests': ['tp5n']}, 11:00:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:55 INFO - 'talos_options': ['--xperf_path', 11:00:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:55 INFO - 'tests': ['tp5n']}}, 11:00:55 INFO - 'talos.zip': {'path': '', 11:00:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:55 INFO - Running post-action listener: _resource_record_post_action 11:00:55 INFO - [mozharness: 2016-08-31 18:00:55.493179Z] Finished populate-webroot step (success) 11:00:55 INFO - [mozharness: 2016-08-31 18:00:55.493288Z] Running create-virtualenv step. 11:00:55 INFO - Running pre-action listener: _resource_record_pre_action 11:00:55 INFO - Running main action method: create_virtualenv 11:00:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:00:55 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 11:00:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:00:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:55 INFO - Using real prefix '/usr' 11:00:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:00:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:58 INFO - Installing pip.................done. 11:00:58 INFO - Return code: 0 11:00:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:58 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:00:58 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 11:00:58 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 11:00:58 INFO - Using env: {'DISPLAY': ':0', 11:00:58 INFO - 'HOME': '/home/cltbld', 11:00:58 INFO - 'LANG': 'en_US.UTF-8', 11:00:58 INFO - 'LANGUAGE': 'en_US:en', 11:00:58 INFO - 'LOGNAME': 'cltbld', 11:00:58 INFO - 'MAIL': '/var/mail/cltbld', 11:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:58 INFO - 'MOZ_NO_REMOTE': '1', 11:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:58 INFO - 'NO_EM_RESTART': '1', 11:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:58 INFO - 'PWD': '/builds/slave/test', 11:00:58 INFO - 'SHELL': '/bin/bash', 11:00:58 INFO - 'SHLVL': '1', 11:00:58 INFO - 'TERM': 'linux', 11:00:58 INFO - 'TMOUT': '86400', 11:00:58 INFO - 'USER': 'cltbld', 11:00:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:58 INFO - '_': '/tools/buildbot/bin/python'} 11:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:58 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 11:00:58 INFO - Cleaning up... 11:00:58 INFO - Return code: 0 11:00:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:58 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:00:58 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 11:00:58 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 11:00:58 INFO - Using env: {'DISPLAY': ':0', 11:00:58 INFO - 'HOME': '/home/cltbld', 11:00:58 INFO - 'LANG': 'en_US.UTF-8', 11:00:58 INFO - 'LANGUAGE': 'en_US:en', 11:00:58 INFO - 'LOGNAME': 'cltbld', 11:00:58 INFO - 'MAIL': '/var/mail/cltbld', 11:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:58 INFO - 'MOZ_NO_REMOTE': '1', 11:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:58 INFO - 'NO_EM_RESTART': '1', 11:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:58 INFO - 'PWD': '/builds/slave/test', 11:00:58 INFO - 'SHELL': '/bin/bash', 11:00:58 INFO - 'SHLVL': '1', 11:00:58 INFO - 'TERM': 'linux', 11:00:58 INFO - 'TMOUT': '86400', 11:00:58 INFO - 'USER': 'cltbld', 11:00:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:58 INFO - '_': '/tools/buildbot/bin/python'} 11:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:58 INFO - Downloading/unpacking psutil>=3.1.1 11:00:58 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 11:00:58 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 11:00:58 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 11:00:58 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 11:00:58 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 11:00:58 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 11:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:00 INFO - Installing collected packages: psutil 11:01:00 INFO - Running setup.py install for psutil 11:01:00 INFO - building 'psutil._psutil_linux' extension 11:01:00 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 11:01:00 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 11:01:00 INFO - building 'psutil._psutil_posix' extension 11:01:00 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 11:01:00 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 11:01:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:00 INFO - Successfully installed psutil 11:01:00 INFO - Cleaning up... 11:01:01 INFO - Return code: 0 11:01:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:01:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:01 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01:01 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 11:01:01 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 11:01:01 INFO - Using env: {'DISPLAY': ':0', 11:01:01 INFO - 'HOME': '/home/cltbld', 11:01:01 INFO - 'LANG': 'en_US.UTF-8', 11:01:01 INFO - 'LANGUAGE': 'en_US:en', 11:01:01 INFO - 'LOGNAME': 'cltbld', 11:01:01 INFO - 'MAIL': '/var/mail/cltbld', 11:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:01 INFO - 'MOZ_NO_REMOTE': '1', 11:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:01 INFO - 'NO_EM_RESTART': '1', 11:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:01 INFO - 'PWD': '/builds/slave/test', 11:01:01 INFO - 'SHELL': '/bin/bash', 11:01:01 INFO - 'SHLVL': '1', 11:01:01 INFO - 'TERM': 'linux', 11:01:01 INFO - 'TMOUT': '86400', 11:01:01 INFO - 'USER': 'cltbld', 11:01:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:01 INFO - '_': '/tools/buildbot/bin/python'} 11:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:01:01 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 11:01:01 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 11:01:01 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 11:01:01 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 11:01:01 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 11:01:01 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 11:01:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:01:03 INFO - Installing collected packages: mozsystemmonitor 11:01:03 INFO - Running setup.py install for mozsystemmonitor 11:01:03 INFO - Successfully installed mozsystemmonitor 11:01:03 INFO - Cleaning up... 11:01:03 INFO - Return code: 0 11:01:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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', '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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:01: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 jsonschema==2.5.1 11:01:03 INFO - Using env: {'DISPLAY': ':0', 11:01:03 INFO - 'HOME': '/home/cltbld', 11:01:03 INFO - 'LANG': 'en_US.UTF-8', 11:01:03 INFO - 'LANGUAGE': 'en_US:en', 11:01:03 INFO - 'LOGNAME': 'cltbld', 11:01:03 INFO - 'MAIL': '/var/mail/cltbld', 11:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:03 INFO - 'MOZ_NO_REMOTE': '1', 11:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:03 INFO - 'NO_EM_RESTART': '1', 11:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:03 INFO - 'PWD': '/builds/slave/test', 11:01:03 INFO - 'SHELL': '/bin/bash', 11:01:03 INFO - 'SHLVL': '1', 11:01:03 INFO - 'TERM': 'linux', 11:01:03 INFO - 'TMOUT': '86400', 11:01:03 INFO - 'USER': 'cltbld', 11:01:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:03 INFO - '_': '/tools/buildbot/bin/python'} 11:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:03 INFO - Downloading/unpacking jsonschema==2.5.1 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:01:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:01:05 INFO - warning: no files found matching '*.txt' 11:01:05 INFO - no previously-included directories found matching 'build' 11:01:05 INFO - no previously-included directories found matching 'dist' 11:01:05 INFO - no previously-included directories found matching '.git*' 11:01:05 INFO - Installing collected packages: jsonschema, functools32 11:01:05 INFO - Running setup.py install for functools32 11:01:05 INFO - warning: no files found matching '*.txt' 11:01:05 INFO - no previously-included directories found matching 'build' 11:01:05 INFO - no previously-included directories found matching 'dist' 11:01:05 INFO - no previously-included directories found matching '.git*' 11:01:05 INFO - Successfully installed jsonschema functools32 11:01:05 INFO - Cleaning up... 11:01:05 INFO - Return code: 0 11:01:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:01: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 functools32==3.2.3-2 11:01:05 INFO - Using env: {'DISPLAY': ':0', 11:01:05 INFO - 'HOME': '/home/cltbld', 11:01:05 INFO - 'LANG': 'en_US.UTF-8', 11:01:05 INFO - 'LANGUAGE': 'en_US:en', 11:01:05 INFO - 'LOGNAME': 'cltbld', 11:01:05 INFO - 'MAIL': '/var/mail/cltbld', 11:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:05 INFO - 'MOZ_NO_REMOTE': '1', 11:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:05 INFO - 'NO_EM_RESTART': '1', 11:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:05 INFO - 'PWD': '/builds/slave/test', 11:01:05 INFO - 'SHELL': '/bin/bash', 11:01:05 INFO - 'SHLVL': '1', 11:01:05 INFO - 'TERM': 'linux', 11:01:05 INFO - 'TMOUT': '86400', 11:01:05 INFO - 'USER': 'cltbld', 11:01:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:05 INFO - '_': '/tools/buildbot/bin/python'} 11:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:01:06 INFO - Cleaning up... 11:01:06 INFO - Return code: 0 11:01:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:01:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:06 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01:06 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 11:01:06 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 11:01:06 INFO - Using env: {'DISPLAY': ':0', 11:01:06 INFO - 'HOME': '/home/cltbld', 11:01:06 INFO - 'LANG': 'en_US.UTF-8', 11:01:06 INFO - 'LANGUAGE': 'en_US:en', 11:01:06 INFO - 'LOGNAME': 'cltbld', 11:01:06 INFO - 'MAIL': '/var/mail/cltbld', 11:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:06 INFO - 'MOZ_NO_REMOTE': '1', 11:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:06 INFO - 'NO_EM_RESTART': '1', 11:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:06 INFO - 'PWD': '/builds/slave/test', 11:01:06 INFO - 'SHELL': '/bin/bash', 11:01:06 INFO - 'SHLVL': '1', 11:01:06 INFO - 'TERM': 'linux', 11:01:06 INFO - 'TMOUT': '86400', 11:01:06 INFO - 'USER': 'cltbld', 11:01:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:06 INFO - '_': '/tools/buildbot/bin/python'} 11:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:06 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 11:01:06 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 11:01:06 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 11:01:06 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 11:01:06 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 11:01:06 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 11:01:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:01:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:08 INFO - Downloading docopt-0.6.1.tar.gz 11:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:08 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:08 INFO - Running setup.py install for blobuploader 11:01:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:01:09 INFO - Running setup.py install for requests 11:01:09 INFO - Running setup.py install for docopt 11:01:09 INFO - Successfully installed blobuploader requests docopt 11:01:09 INFO - Cleaning up... 11:01:09 INFO - Return code: 0 11:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:09 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01:09 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 11:01:09 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 11:01:09 INFO - Using env: {'DISPLAY': ':0', 11:01:09 INFO - 'HOME': '/home/cltbld', 11:01:09 INFO - 'LANG': 'en_US.UTF-8', 11:01:09 INFO - 'LANGUAGE': 'en_US:en', 11:01:09 INFO - 'LOGNAME': 'cltbld', 11:01:09 INFO - 'MAIL': '/var/mail/cltbld', 11:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:09 INFO - 'MOZ_NO_REMOTE': '1', 11:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:09 INFO - 'NO_EM_RESTART': '1', 11:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:09 INFO - 'PWD': '/builds/slave/test', 11:01:09 INFO - 'SHELL': '/bin/bash', 11:01:09 INFO - 'SHLVL': '1', 11:01:09 INFO - 'TERM': 'linux', 11:01:09 INFO - 'TMOUT': '86400', 11:01:09 INFO - 'USER': 'cltbld', 11:01:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:09 INFO - '_': '/tools/buildbot/bin/python'} 11:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:09 INFO - Running setup.py (path:/tmp/pip-wn3FUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:01:09 INFO - Running setup.py (path:/tmp/pip-Tm_elu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:01:09 INFO - Running setup.py (path:/tmp/pip-87CyRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:01:10 INFO - Running setup.py (path:/tmp/pip-fT32Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:01:10 INFO - Running setup.py (path:/tmp/pip-P3IUX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:01:10 INFO - Running setup.py (path:/tmp/pip-6dBma7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:10 INFO - Running setup.py (path:/tmp/pip-bl5AT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:10 INFO - Running setup.py (path:/tmp/pip-8BJNPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:10 INFO - Running setup.py (path:/tmp/pip-43QNdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:10 INFO - Running setup.py (path:/tmp/pip-Xpkwq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:10 INFO - Running setup.py (path:/tmp/pip-5T_LnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:10 INFO - Running setup.py (path:/tmp/pip-xJUWOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:10 INFO - Running setup.py (path:/tmp/pip-KDy2HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:10 INFO - Running setup.py (path:/tmp/pip-PR4Y6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:10 INFO - Running setup.py (path:/tmp/pip-fspaez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:10 INFO - Running setup.py (path:/tmp/pip-nZxpTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:10 INFO - Running setup.py (path:/tmp/pip-Sznope-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:01:11 INFO - Running setup.py install for manifestparser 11:01:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Running setup.py install for mozcrash 11:01:11 INFO - Running setup.py install for mozdebug 11:01:11 INFO - Running setup.py install for mozdevice 11:01:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Running setup.py install for mozfile 11:01:11 INFO - Running setup.py install for mozhttpd 11:01:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Running setup.py install for mozinfo 11:01:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Running setup.py install for mozInstall 11:01:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:01:11 INFO - Running setup.py install for mozleak 11:01:11 INFO - Running setup.py install for mozlog 11:01:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:01:12 INFO - Running setup.py install for moznetwork 11:01:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:01:12 INFO - Running setup.py install for mozprocess 11:01:12 INFO - Running setup.py install for mozprofile 11:01:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:01:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:01:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:01:12 INFO - Running setup.py install for mozrunner 11:01:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:01:12 INFO - Running setup.py install for mozscreenshot 11:01:12 INFO - Running setup.py install for moztest 11:01:12 INFO - Running setup.py install for mozversion 11:01:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:01:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:01:12 INFO - Cleaning up... 11:01:12 INFO - Return code: 0 11:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:12 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:12 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:12 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01:12 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 11:01:12 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 11:01:12 INFO - Using env: {'DISPLAY': ':0', 11:01:12 INFO - 'HOME': '/home/cltbld', 11:01:12 INFO - 'LANG': 'en_US.UTF-8', 11:01:12 INFO - 'LANGUAGE': 'en_US:en', 11:01:12 INFO - 'LOGNAME': 'cltbld', 11:01:12 INFO - 'MAIL': '/var/mail/cltbld', 11:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:12 INFO - 'MOZ_NO_REMOTE': '1', 11:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:12 INFO - 'NO_EM_RESTART': '1', 11:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:12 INFO - 'PWD': '/builds/slave/test', 11:01:12 INFO - 'SHELL': '/bin/bash', 11:01:12 INFO - 'SHLVL': '1', 11:01:12 INFO - 'TERM': 'linux', 11:01:12 INFO - 'TMOUT': '86400', 11:01:12 INFO - 'USER': 'cltbld', 11:01:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:12 INFO - '_': '/tools/buildbot/bin/python'} 11:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:13 INFO - Running setup.py (path:/tmp/pip-prNGW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:01:13 INFO - Running setup.py (path:/tmp/pip-kyncN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:01:13 INFO - Running setup.py (path:/tmp/pip-jt6aUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:01:13 INFO - Running setup.py (path:/tmp/pip-qPFRgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:01:13 INFO - Running setup.py (path:/tmp/pip-78nk40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:01:13 INFO - Running setup.py (path:/tmp/pip-cTTz75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:13 INFO - Running setup.py (path:/tmp/pip-GlxDRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:13 INFO - Running setup.py (path:/tmp/pip-ncQB2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:13 INFO - Running setup.py (path:/tmp/pip-re2C8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:13 INFO - Running setup.py (path:/tmp/pip-SpNiUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:13 INFO - Running setup.py (path:/tmp/pip-Bv8WAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:13 INFO - Running setup.py (path:/tmp/pip-StCXeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:13 INFO - Running setup.py (path:/tmp/pip-Br6pIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:13 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)) 11:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:13 INFO - Running setup.py (path:/tmp/pip-c0FENl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:14 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)) 11:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:14 INFO - Running setup.py (path:/tmp/pip-InWz72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:14 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)) 11:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:14 INFO - Running setup.py (path:/tmp/pip-fwS4Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:14 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)) 11:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:14 INFO - Running setup.py (path:/tmp/pip-NabzVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:14 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)) 11:01:14 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)) 11:01:14 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)) 11:01:14 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)) 11:01:14 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)) 11:01:14 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)) 11:01:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:14 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 11:01:14 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 11:01:14 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 11:01:14 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 11:01:14 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 11:01:14 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 11:01:16 INFO - Downloading blessings-1.6.tar.gz 11:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:01:16 INFO - Installing collected packages: blessings 11:01:16 INFO - Running setup.py install for blessings 11:01:16 INFO - Successfully installed blessings 11:01:16 INFO - Cleaning up... 11:01:16 INFO - Return code: 0 11:01:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:16 INFO - Reading from file tmpfile_stdout 11:01:16 INFO - Current package versions: 11:01:16 INFO - argparse == 1.2.1 11:01:16 INFO - blessings == 1.6 11:01:16 INFO - blobuploader == 1.2.4 11:01:16 INFO - docopt == 0.6.1 11:01:16 INFO - functools32 == 3.2.3-2 11:01:16 INFO - jsonschema == 2.5.1 11:01:16 INFO - manifestparser == 1.1 11:01:16 INFO - mozInstall == 1.12 11:01:16 INFO - mozcrash == 0.17 11:01:16 INFO - mozdebug == 0.1 11:01:16 INFO - mozdevice == 0.48 11:01:16 INFO - mozfile == 1.2 11:01:16 INFO - mozhttpd == 0.7 11:01:16 INFO - mozinfo == 0.9 11:01:16 INFO - mozleak == 0.1 11:01:16 INFO - mozlog == 3.3 11:01:16 INFO - moznetwork == 0.27 11:01:16 INFO - mozprocess == 0.23 11:01:16 INFO - mozprofile == 0.28 11:01:16 INFO - mozrunner == 6.12 11:01:16 INFO - mozscreenshot == 0.1 11:01:16 INFO - mozsystemmonitor == 0.3 11:01:16 INFO - moztest == 0.7 11:01:16 INFO - mozversion == 1.4 11:01:16 INFO - psutil == 3.1.1 11:01:16 INFO - requests == 1.2.3 11:01:16 INFO - wsgiref == 0.1.2 11:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:16 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01:16 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 11:01:16 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 11:01:16 INFO - Using env: {'DISPLAY': ':0', 11:01:16 INFO - 'HOME': '/home/cltbld', 11:01:16 INFO - 'LANG': 'en_US.UTF-8', 11:01:16 INFO - 'LANGUAGE': 'en_US:en', 11:01:16 INFO - 'LOGNAME': 'cltbld', 11:01:16 INFO - 'MAIL': '/var/mail/cltbld', 11:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:16 INFO - 'MOZ_NO_REMOTE': '1', 11:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:16 INFO - 'NO_EM_RESTART': '1', 11:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:16 INFO - 'PWD': '/builds/slave/test', 11:01:16 INFO - 'SHELL': '/bin/bash', 11:01:16 INFO - 'SHLVL': '1', 11:01:16 INFO - 'TERM': 'linux', 11:01:16 INFO - 'TMOUT': '86400', 11:01:16 INFO - 'USER': 'cltbld', 11:01:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:16 INFO - '_': '/tools/buildbot/bin/python'} 11:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 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)) 11:01:16 INFO - Cleaning up... 11:01:16 INFO - Return code: 0 11:01:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:16 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 0x7fc59db2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ad230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, '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': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', '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 11:01:16 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 11:01:16 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 11:01:16 INFO - Using env: {'DISPLAY': ':0', 11:01:16 INFO - 'HOME': '/home/cltbld', 11:01:16 INFO - 'LANG': 'en_US.UTF-8', 11:01:16 INFO - 'LANGUAGE': 'en_US:en', 11:01:16 INFO - 'LOGNAME': 'cltbld', 11:01:16 INFO - 'MAIL': '/var/mail/cltbld', 11:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:16 INFO - 'MOZ_NO_REMOTE': '1', 11:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:16 INFO - 'NO_EM_RESTART': '1', 11:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:16 INFO - 'PWD': '/builds/slave/test', 11:01:16 INFO - 'SHELL': '/bin/bash', 11:01:16 INFO - 'SHLVL': '1', 11:01:16 INFO - 'TERM': 'linux', 11:01:16 INFO - 'TMOUT': '86400', 11:01:16 INFO - 'USER': 'cltbld', 11:01:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:16 INFO - '_': '/tools/buildbot/bin/python'} 11:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:01:17 INFO - Cleaning up... 11:01:17 INFO - Return code: 0 11:01:17 INFO - Running post-action listener: _resource_record_post_action 11:01:17 INFO - Running post-action listener: _start_resource_monitoring 11:01:17 INFO - Starting resource monitoring. 11:01:17 INFO - [mozharness: 2016-08-31 18:01:17.086471Z] Finished create-virtualenv step (success) 11:01:17 INFO - [mozharness: 2016-08-31 18:01:17.086940Z] Running install step. 11:01:17 INFO - Running pre-action listener: _resource_record_pre_action 11:01:17 INFO - Running main action method: install 11:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:17 INFO - Reading from file tmpfile_stdout 11:01:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:01:17 INFO - Reading from file tmpfile_stdout 11:01:17 INFO - Output received: 11:01:17 INFO - Usage: mozinstall [options] installer 11:01:17 INFO - Options: 11:01:17 INFO - -h, --help show this help message and exit 11:01:17 INFO - -d DEST, --destination=DEST 11:01:17 INFO - Directory to install application into. [default: 11:01:17 INFO - "/builds/slave/test"] 11:01:17 INFO - --app=APP Application being installed. [default: firefox] 11:01:17 INFO - mkdir: /builds/slave/test/build/application 11:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:01:33 INFO - Reading from file tmpfile_stdout 11:01:33 INFO - Output received: 11:01:33 INFO - /builds/slave/test/build/application/firefox/firefox 11:01:33 INFO - Running post-action listener: _resource_record_post_action 11:01:33 INFO - [mozharness: 2016-08-31 18:01:33.504583Z] Finished install step (success) 11:01:33 INFO - [mozharness: 2016-08-31 18:01:33.504869Z] Running run-tests step. 11:01:33 INFO - Running pre-action listener: _resource_record_pre_action 11:01:33 INFO - Running main action method: run_tests 11:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:01:33 INFO - Python 2.7.3 11:01:33 INFO - Return code: 0 11:01:33 INFO - grabbing minidump binary from tooltool 11:01:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:33 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 0x29a7090>, '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 0x29aa9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:01:33 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 11:01:33 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 11:01:33 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 11:01:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:33 INFO - Return code: 0 11:01:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:01:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:01:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:01:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:01:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 11:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 11:01:33 INFO - Using env: {'DISPLAY': ':0', 11:01:33 INFO - 'HOME': '/home/cltbld', 11:01:33 INFO - 'LANG': 'en_US.UTF-8', 11:01:33 INFO - 'LANGUAGE': 'en_US:en', 11:01:33 INFO - 'LOGNAME': 'cltbld', 11:01:33 INFO - 'MAIL': '/var/mail/cltbld', 11:01:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:01:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:33 INFO - 'MOZ_NO_REMOTE': '1', 11:01:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:33 INFO - 'NO_EM_RESTART': '1', 11:01:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:33 INFO - 'PWD': '/builds/slave/test', 11:01:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:01:33 INFO - 'SHELL': '/bin/bash', 11:01:33 INFO - 'SHLVL': '1', 11:01:33 INFO - 'TERM': 'linux', 11:01:33 INFO - 'TMOUT': '86400', 11:01:33 INFO - 'USER': 'cltbld', 11:01:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851', 11:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:33 INFO - '_': '/tools/buildbot/bin/python'} 11:01:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 11:01:33 INFO - mozversion application_buildid: 20160831092321 11:01:33 INFO - mozversion application_changeset: fabfb2ff761eace61d0433e4d6e3d74e0cba193e 11:01:33 INFO - mozversion application_display_name: Nightly 11:01:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:33 INFO - mozversion application_name: Firefox 11:01:33 INFO - mozversion application_remotingname: firefox 11:01:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:01:33 INFO - mozversion application_vendor: Mozilla 11:01:33 INFO - mozversion application_version: 51.0a1 11:01:33 INFO - mozversion platform_buildid: 20160831092321 11:01:33 INFO - mozversion platform_changeset: fabfb2ff761eace61d0433e4d6e3d74e0cba193e 11:01:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:01:33 INFO - mozversion platform_version: 51.0a1 11:01:33 INFO - using testdate: 1472666493 11:01:33 INFO - actual date: 1472666493 11:01:33 INFO - starting webserver on 'localhost:57283' 11:01:33 INFO - SUITE-START | Running 2 tests 11:01:33 INFO - TEST-START | dromaeo_css 11:01:33 INFO - operating with platform_type : linux_ 11:01:33 INFO - Initialising browser for dromaeo_css test... 11:01:33 INFO - TEST-INFO | started process 30117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD9ZnZv/profile http://localhost:57283/getInfo.html) 11:01:38 INFO - PROCESS | 30117 | __metrics Screen width/height:1600/1200 11:01:38 INFO - PROCESS | 30117 | colorDepth:24 11:01:38 INFO - PROCESS | 30117 | Browser inner width/height: 1024/697 11:01:38 INFO - PROCESS | 30117 | __metrics 11:01:38 INFO - PROCESS | 30117 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:01:38 INFO - PROCESS | 30117 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:39 INFO - PROCESS | 30117 | console.error: PushService: 11:01:39 INFO - PROCESS | 30117 | stateChangeProcessEnqueue: Error transitioning state 11:01:39 INFO - PROCESS | 30117 | UnknownError 11:01:39 INFO - TEST-INFO | 30117: exit 0 11:01:39 INFO - Browser initialized. 11:01:39 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:39 INFO - TEST-INFO | started process 30200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD9ZnZv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:52 INFO - PROCESS | 30200 | RSS: Main: 181501952 11:01:52 INFO - PROCESS | 30200 | 11:02:43 INFO - PROCESS | 30200 | 1472666563935 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] 11:04:55 INFO - PROCESS | 30200 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57283/tests/dromaeo/cssquery-ext.html) 11:04:56 INFO - PROCESS | 30200 | RSS: Main: 303833088 11:04:56 INFO - PROCESS | 30200 | 11:07:59 INFO - PROCESS | 30200 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-ext.html (next: http://localhost:57283/tests/dromaeo/cssquery-jquery.html) 11:08:00 INFO - PROCESS | 30200 | RSS: Main: 274272256 11:08:00 INFO - PROCESS | 30200 | 11:11:02 INFO - PROCESS | 30200 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57283/tests/dromaeo/cssquery-mootools.html) 11:11:03 INFO - PROCESS | 30200 | RSS: Main: 220545024 11:11:03 INFO - PROCESS | 30200 | 11:14:05 INFO - PROCESS | 30200 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57283/tests/dromaeo/cssquery-prototype.html) 11:14:06 INFO - PROCESS | 30200 | RSS: Main: 219385856 11:14:06 INFO - PROCESS | 30200 | 11:17:09 INFO - PROCESS | 30200 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57283/tests/dromaeo/cssquery-yui.html) 11:17:09 INFO - PROCESS | 30200 | RSS: Main: 219648000 11:17:09 INFO - PROCESS | 30200 | 11:20:12 INFO - PROCESS | 30200 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-yui.html (next: http://localhost:57283/tests/dromaeo/cssquery-dojo.html) 11:20:13 INFO - PROCESS | 30200 | RSS: Main: 310726656 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | __start_tp_report 11:20:13 INFO - PROCESS | 30200 | _x_x_mozilla_page_load 11:20:13 INFO - PROCESS | 30200 | _x_x_mozilla_page_load_details 11:20:13 INFO - PROCESS | 30200 | |i|pagename|runs| 11:20:13 INFO - PROCESS | 30200 | |0;dojo.html;2538.403475183332;2541.9618705719404;2555.5655538558444;2569.9871500642494;2576.2400091972854;4412.492563355215;4461.553844615537;4554.658400619955;4565.88585285368;4586.449626044875;4518.254488009483;4521.954780452194;4524.886877828056;4525.208088584501;4563.794629241684;4169.562195969433;4181.853635122771;4247.214265360903;4252.170826688797;4324.286492728696;4222.451081359419;4241.830326786925;4248.150369926027;4249.3201087825955;4335;4216.5361810201;4273.1240095780295;4277.037666525022;4311.784410779464;4353.978230108845;4266.616004559573;4310.030243195288;4340.804663790105;4350.499692535367;4367.475902891641;4111.383292506118;4158.771267580282;4166.83332666693;4172.582741725833;4223.68322375823;4494.213512635309;4509.842155524541;4538.115067561826;4583.243764778807;4623.514530974267;4904.264360345941;4908.484609116027;4909.091818013679;4912.410510738699;4958.157113290713;4781.593564547018;4838.419389673227;4863.659543831933;4907.8773030674165;4954.331165292675;4542.727436353829;4564.2012647786505;4564.954350456453;4611.239145540982;4619.214733495314;4992.2761199626575;4996.7501624918605;4998.300237966688;5005.624578156653;5029.547340739351;4649.488556258809;4724.385829842098;4786.497417771154;4808.206645903457;4817.542333478314;4882.951170488321;4910.926336104962;4913.06651736169;4947.431045429749;4966.453690094087;4859.757012149378;4865.878353041202;4866.4403593586485;4892.461829198785;4909.7790599423115;4722.055588882237;4762.9523704762505;4786.138495070851;4863.319135321058;4886.340344053508;4068.450759147477;4089.1821635672986;4090.570490098497;4137.710360274752;4138.317177665652;3585.8924232273075;3596.9820150899077;3630.6913912317223;3639.5996440391536;3641.8361173746716;4170.395292682544;4177.164567086595;4194.2450358935685;4203.831846726097;4207.053412982115;4889.364382630235;4937.9012419752125;4961.03259864323;5010.574101201366;5026.52248036436;4243.045314804206;4254.170436764863;4255.361695745601;4307.030918043415;4316.352547117957;4317.978410107992;4358.455193100863;4430.867073987785;4445.799939002753;4447.199504089295;4574.908501830011;4584.610308123847;4597.264437689953;4665.6734028617675;4669.673122881366;4894.779734912009;4904.141775189399;4910.263460480956;4911.435184953776;4966.950330496648;4458.866234012985;4575.565321294472;4606.654500912378;4611.700239484423;4667.229907065432;4821.300911367762;4837.733924634179;4847.975760121318;4908.165611846066;4921.6062714982;4902.926456103232;4911.852644420673;4913.091078150554;4936.679115857458;4959.13215187348;4621.907561848677;4767.094252092092;4779.235322348408;4801.447833499193;4854.514548545118;4785.712857228438;4821.445533763522;4840.201366774443;4886.780094895809;4892.902141957212;4754.952450475589;4766.928496072631;4773.236282194832;4775.2598347256235;4835.419749630067;4694.460137084279;4736.289556566542;4846.588040016638;4859.684120532154;4913.361263035782;4668;4700.036492519093;4714.882127946828;4716.976415117902;4758.619310455225 11:20:13 INFO - PROCESS | 30200 | |1;ext.html;571.129028231946;574.5977815529129;578.1241419249837;580.1384943359109;583.6323116436643;28289.292767680818;42679;44391.11217775647;44454.33318500225;44536.1092778145;40903.38644920321;41232.38151427731;41305;41379.586204138024;41395.58604413962;7614.352780013705;7797.142314345446;7801.14187439384;7802.60986950653;7803.765887023398;7661.731839385623;7693.7307194248215;7694.999650045486;7703.5377877327255;7752;7725.381969442431;7775.144734079275;7782.688692452323;7784.1437441881635;7785.532868027908;7656.770296891103;7682.615869206573;7689.346405555534;7707.342921271954;7713.4600577959845;7690.192529784348;7782.961085194538;7784.182660820589;7789.337906277973;7832.138464768871;39049.80475097635;39473.802630986946;39518.40722389166;39560.81317560478;39574.406383904265;2838.7445129938196;2946.6905974872757;3333.4333163362285;3620.601733809279;3691.8338674759702;26721.331966700793;29450;29716.405671886656;29786.851065744533;29844.253893652614;3536.717062634983;3604.6575575320567;3700.9259814803822;3750.9062273443383;3764;257287;258326;259997;260208;260741.6962915192;49683.503164967886;49846.50153498491;49876;49901.25148122781;49971.50028499741;29571.556426653617;30290;30312.54531182034;30327.545086823717;30395.544066839015;14483.710325793425;14644.780328295084;14652.853471465362;14692.706145877022;14695.926520367544;11072.224944253987;11084.113270938306;11095.223334366678;11177.66467005991;11192.664220073411;17935.192916318796;17950.102494875464;17952.640947180982;18032.368867089852;18074.367397141035;6786.423154031864;6822.795316140524;6887.931120688829;6903.032635698802;7026.629807187549;756.3986630628664;844.2317491083207;871.407442938795;958.6932181701789;963.7831487915163;27941.580876286873;28298.85850570734;28563;28756;29212;922.1930810540777;928.6424726480219;956.6135878988442;1001.47923079998;1017.6234793126442;14282.85717142836;14983;15202;15219.923900380649;15353.385864565516;390771;393287;395889;395994.4205858401;396688;50967.235491467654;51320.74339628353;51429.742851285504;51500.742496287276;51603.483965160616;1064.7870425914848;1100.5762781329247;1128.3342827731678;1163.3020187887369;1196.8144937534696;25924.22227333183;28885.566716498848;29560.852195738884;29729.25676858096;29878.253043673212;37822.32665100257;38170.618293816704;38202.617973819906;38211.61788382192;38228.42657360197;314168;314845;317680;318502;318678;22130.88934555317;24302.149424770047;25548.23355299344;25586.360340991625;25705.485890282464;36336.818315908255;36684.680721295794;42231.577684222764;43018.13963720771;43949.780251099815;35975.820120899225;36100.8194959034;37215.441768372955;37909;37939;35733.64266357303;36385.454218187275;36404.453933190496;36857;37336.6266337344;35186.648133518334;35985.82007089948;36038;36064.45903311505;36264.63735362612;31652.841735791175;33389.33221335608;33656.1585960353;33985;34114;25040.37399065038;25462.618060729474;25742.485150296514;26027;26246 11:20:13 INFO - PROCESS | 30200 | |2;jquery.html;344.15166614295754;365.55584964268417;365.9725520585955;366.5692810947138;385.46612941076603;12440;14666.413343466262;16394.26225819838;16444;16642.167891605415;15808.051516908994;16384.344626214937;16633.91683041583;16718;16887.66224675506;4770.904581908359;5114;5135.8202462913805;5144.922826157611;5146.562542183919;3692.316921369542;5079.542841144296;5162.92255616166;5167;5671.376148623648;5859.0625499920025;5988.670623115727;5999.040153575429;6003.279606447232;6004.42957918997;5803.332616749086;5877.147813567009;5926.703664816742;5959.7020148992815;5977.31260904995;5242.685438873642;5247.816326428557;5252;5252.448492908266;5255.343082114736;20820.37538873836;20922.37232883016;21337.039833207542;21400.35798926035;21484.24805131813;1812.501562070428;2437.8293519453646;2439.097533912464;2450.3016640257442;2460.9138680146107;6083.209182806251;6420.165378500812;9903.950480247624;11939.141967305992;12255.816162757477;1662.393226472329;1702.3701230544655;1771.5216891439238;1808.6925222712039;1924.8845069295887;68569.31430685679;71287;71683.53063509814;72747;72756;10127.392356458637;10265.230107741949;10285.537150828231;10456.424896630606;10994.670159895217;13941.302934853216;13963.720725585432;14046.85953140476;14068.577942661737;14083.507077252247;7152.856942861218;7211.350978411968;7250.601216933014;7318.597477138808;7494.70021199146;6848.280930502325;6900.482463815234;7026.367626913602;7035.050268213828;7063.293670632998;4010.6590939770444;4145.067359844072;4249.6387807036745;4354.281543545343;4545.272756358967;1797.8202179781917;1830.9267629294945;1844.4374465788064;1846.2061313634997;1848.491664792166;783.8902553642495;801.7795106345801;843.9535825529655;930.8324501589778;944.9102335278137;15776.368945242062;16306.695464362823;16773.412930547373;16880.49358519222;17694.469165925042;826.557791581513;831.3224721851672;859.6604341285157;863.7538301584144;874.5190145419994;8883.779055236191;9698.36960597559;9754.122129008423;9756.560954757053;9922.454265015349;265720;271986;370624;375215;376014;85057.57471212605;85342;85717;86393;90245.54877225703;900.9369344145847;915.1397686174975;948.1466679988066;956.4022485946283;957.167264479893;15574.844251557339;15673.921630392231;16272.839950421776;16350.672986540441;16534.09062501526;36083.81958090298;37605.435918460695;37638;37822;38741.2251754969;48291;53239.733801330745;54390.45609543854;55551.72224138853;55811.72094139503;7572;7636.31273185416;7913.327367173854;7930.722424715107;8335.666573337241;11188.66434006981;11232.101431885592;11930;12162.358081659217;12691.365431728562;10010.949945250228;10365.170786336925;10797.136229101496;10843.295185812896;10899.673009809718;8143.389245806707;10592.470376481298;10618.469076546296;10666.46667666629;10678.305910115818;7732.536047837148;10514.842277365999;10680.57277708914;10857.18571107186;11188.384638844616;7849.882251766342;7896.6446509906045;8047.798805029921;8115.229053239933;8132.390070744599;8200.302974247017;10255.589776409159;10365;10463.68608941733;10927.235093543375 11:20:13 INFO - PROCESS | 30200 | |3;mootools.html;1210.509743553861;1346.710457251691;1395.281430063517;1448.5292280008994;1688.6116193275545;7304.707811687533;7782.883256751146;7785;8000.679972801081;8016.719414820483;7872.212778722125;7965.322947549451;7982.2416870397365;7983.760487185379;7987.880181797278;1856.3131641292741;2106.820920221783;2144.635411979967;2148.645473496875;2179.705739725133;2195.9560808783813;2222.7221597300336;2228.0308065991267;2228.9665655015187;2241.4396400899777;2175.673648952662;2184.1154332495366;2194.462356722597;2201.6697495375743;2233.508628101815;2078.8025137612053;2151.34384012876;2157.967630485544;2168.728908886389;2173;2144.238795227703;2162.664786958024;2163.102312540294;2169.2516081951703;2170.4790850195996;7803.609819509059;7838.255365740246;7841.176676448948;7849.215078492162;7856.921430785676;4408.3607876858;4514.571115743999;4568.840090596813;4571.58855702985;4605.424321959755;2866.254773758817;2920.7663386928994;3018.743406810424;3019.0188188838715;3024.259056531164;970.7573106723319;974.1378879691524;984.7390441532999;989.3766926836047;992.538469611634;10630.574777008911;10685.305455145392;10696.465176741132;10705.1435885129;10708.839367409495;4007.5591684914634;4094.5700701426517;4107.322291821816;4119.876403707894;4181.330987042059;8491.532965686947;8515.446495977742;8522.403431759842;8527.573621318908;8530.957345213234;4583.656225783079;4585.633149348044;4591.104734576792;4592.380028696083;4598.632109431237;3630.2739452109154;4095.5085389752826;4190.832366705358;4215.451991241119;4241.384999175102;3381.323735252959;3396.5904149777566;3503.824808759603;3504.491848681927;3516.982415087908;1040.921930855189;1044.0446991003298;1045.9186219423293;1046.027194708928;1067.3649178738638;740.7962810227231;796.9322607578305;806.1374329467413;812.90258151495;816.7508909782455;5046.369203849519;5117.8720531987;5118.974405128025;5261.210818377274;5284.630075894727;414.1693713785077;436.3280547956112;440.9162259170747;839.1650307943635;932.5011119051275;3499.1951851074396;3663.358912190356;3705.9258814824093;3716.5168528091717;3733.178700685845;9545.904540954501;9697.418154910727;9817.263705222136;9850.458224797561;9852.605895764233;9769.218462522982;9786.314957953018;9790.706278811647;9806.803863922682;9814.46020468881;6999.09011828459;7113.89329160063;7127.89308160378;7138.214796372291;7141.357277845019;5005.174146265826;5051.267566202807;5199.74001299941;5337.172738225581;5415.2147938547905;8676.652933882575;8710.912890871263;8823.558822058743;8875.201231889161;8882.111788821067;8622.78443038929;8834.204921557091;8893.377463577488;9049.049849765679;9097.954510227672;5817.5345972321265;6237.875242495215;6461.547691661726;6467.838304042437;6652.933470665425;7370.5577665338105;7388.963055184689;7412.332890039706;7456.217097204715;7463.3656139226605;6415.454686351713;6468.8706225874275;6513.934860651333;6521.380468855451;6664.333566643297;6278.529110316836;6542.967285163544;6647.434968027772;6792.1849378072975;6865.588064716133;5828.679422631626;6030.7889223876955;6035.939640603538;6038.154658347923;6043.7884674036195;4174;4190.497140343056;4244.299690551148;4338.219120558204;4420.535843736361;4172.874813755592;4506.504284528633;4552.362669226245;4553.863384098482;4584.335271385564 11:20:13 INFO - PROCESS | 30200 | |4;prototype.html;299.77516862353235;299.85007496251876;307.5801530910308;308.9165925200196;309.6856690459184;4724.551167639073;4767.785449654765;4786.415335718716;4793.233082706767;4829.8792530186765;4680.742559159245;4735.952640473594;4764.78558464869;4768.284757286408;4768.64235182361;3529.9294014119764;3584.8207589620547;3699.7780133192095;3700.9814950925343;3702.3520883845217;3696.0205545530457;3700.5567828546887;3743.101655602663;3746.2132952080096;3763.2849758545926;3663.084228942764;3670;3678.062094165997;3690.9630903690886;3704.111013356802;3501.579810422753;3600.4959305697093;3687;3714.7213958952916;3746.981265093657;3319.3527262183884;3330.500424936279;3330.5021234074443;3335.099523128766;3338;4645.163870503308;4647.372604698357;4667.836625718083;4681.157391669498;4681.81272749093;4154.356074808409;4229.577042295777;4238.978805105986;4291.047573354116;4295.6778241632;4875.634327425421;4886.755662216875;4891.315215869781;4908.263760435963;4928.1129396708575;3601.711863050976;3603.387424137903;3606.5852426970973;3615.566132064143;3629.3830048891487;4855.951440485585;5125.692458452505;5174.508421699932;5211.140161873286;5211.739413029333;3542.1498840278146;3600.5859326177824;3601.405768048295;3605.3149901518627;3608.783472991629;3651.379265524867;3663.7543235300127;3665.395209790408;3666.7249956252854;3669.119411341259;4181.498220213533;4188.549698426394;4196.328587425997;4196.4964204295065;4206.095689426788;4759.143354196278;4880.341153944243;4916.508349165127;4959;4977.576905963034;1230.8522977242787;1244.8443944506937;1245.3586403002462;1245.9813102803466;1252.8496580410226;806.4637016384156;806.9106705946924;830.2030051150842;833.7748807821854;855.3029281135854;4353.651707863363;4356.869293921188;4359.346098085312;4359.891002724958;4372.256716358227;5026.743314171457;5035.136999310205;5036.823711170092;5052.343195384577;5055.69665820052;4347.956520434818;4352.934705979413;4363.825446982085;4370.497392799805;4378.620734468632;2559.5648739714293;2695.191442567261;2704.9729502705113;2709.6206531085663;2720.9728752079827;4775.761211939389;4779.737114458669;4785.856424307207;4797.376341075707;4800.95199048012;4978.203487442064;5196.948030519722;5207.0366982108435;5213.739313034409;5229.241759944786;4803.18345881201;4809.567138957511;4820.108279968217;4830.637702172351;4837.443693975097;5116.232565115262;5129.666571672829;5168.819091331936;5187.818426355059;5213.921791173211;4796.304535842213;5041.521055499722;5065.594752419871;5112.488751124858;5120.743962801919;4819.95180048195;4825.552334299767;4844.563989240985;4854.975725121351;4859.392575928009;3677.4667673187773;3679.24575462035;3682.116292089933;3686.5391826021746;3697.3899306614107;4972.2790195422185;5148.562372198405;5154.304168937146;5164.251183578285;5166.922496162636;4902.313676085422;4925.950740492549;4939.407271127488;4942.5304596063315;4943.332650092191;4928.014397120519;4934.679245849008;4939.678920870132;4974.577160941216;4979.626528010342;4632.4672662644225;4888.460135057446;4895.63282753802;4896.2655601660035;4898.216285394462;4755.524447555217;4877.634177436636;4934.185859333314;4950.9257361140335;5008.547521218951;4842;4853.6602437829015;4875.902481950412;4884.876478409915;4901.681390709592 11:20:13 INFO - PROCESS | 30200 | |5;yui.html;605.2555356910999;680.1158493957854;698.183125742881;713.243961400915;734.8897665350194;12747.107702460831;13436.193828370304;13439.596812095653;13489.595312140627;13516.594502164939;13539.119957202774;13713.794293085612;13772;13774.104683195585;13785;598.8772301678167;713.0409599089243;742.5062333548184;743.5687301365209;749.4341771962161;768.3660979691749;770.0912922751152;770.5299767142039;771.1324759645399;772.0889350566357;804.0351578106266;806.5120602035743;807.3339494916688;807.4347956430522;808.3250485844327;630.180765005491;773.2460850670608;793.8809178623253;798.2974982015847;801.2308184143229;588.6909372579387;588.8498432899626;588.8939990801654;589.416477687091;589.4635881347953;12347;12376.443060062229;12383.62849114528;12384.504619815196;12424.06819488542;12161.695957601043;12417.503299867994;12681.302528360937;12861.356932153449;13145;10663.466826658636;10773.946130269376;10828.72928176794;11304.547818087267;11430.085593152528;3872.186840763443;3909.648131668135;3935.0949281665376;4028.637422631977;4109.609587089221;66711.33288667149;68266.3173368265;69124;69206.3079369205;69329;9677.661281855102;9939.602415903282;9997.900020999843;10030.799384012278;10327.018933201334;18664.34674786376;19852.90073549623;19854.20583176657;19858.60282794336;19884.90057549703;6736.932630673728;6807.183138023469;6978.092847929838;7026.1217347831525;7349.375303099297;3780.092777733324;3780.3384407729086;3792.981035094807;3807.371783655721;3874.2057878134915;2822.788290878192;2921.123662901121;2922.313256384748;2922.459345021178;2924.4297362014204;494.3474613510204;496.149104286151;500.87478130467383;503.0090721279074;514.390447319927;395.992080158401;461.19291240329426;479.6306843730308;507.29739311054453;570.8629928817054;7427.628618569158;7490.625468726542;8211.630476628567;8399.202075802788;8549.145085491402;428.37671188420774;479.75532478435554;517.2990597740084;539.7881755458941;572.4904834697123;3756.567994680592;3952.24907267624;3992.161646054303;4010.839566417369;4094.6314831665295;65808.34191658022;106087.46956265169;106092;106463.14452705176;108970;90365.54817225871;93315;94342.52828735813;94954;95220;84063.5796821012;85125.57437212774;86916.5654171725;87506;89507.55246223857;7308.478574891654;7507.361874240532;7549.50928189666;7870.881936770838;7918.841623167619;46581.3012804815;47059.29411058906;47117;47577;48778.512214877395;52440;70520.64739676268;71531;73532.26467735469;73648.21628539408;10990.670279891616;11638.53445862156;11735.47190376418;11818.76362472763;11947.522099116286;11678.416079196177;12103.273803571814;12555.811662825248;13244.404001820134;13301.334933253493;10805.621803237163;11131.276467029616;11483.196176267582;11498.655040348469;11679.591214307458;11021.583309174182;11276.267042642203;11395.373254470753;11866.881331186923;11915.285082895054;11280.943595281971;11477.82783258235;11664;12144.33206173669;12266.448009839758;10036.949815250877;10216.284860059724;10485.947570262406;10507.31702439339;10557.9472102639;9668.854967175357;10481.580736770444;10589.629362972259;10695.465226738788;10727.839082413613 11:20:13 INFO - PROCESS | 30200 | __end_tp_report 11:20:13 INFO - PROCESS | 30200 | __start_cc_report 11:20:13 INFO - PROCESS | 30200 | _x_x_mozilla_cycle_collect,1098 11:20:13 INFO - PROCESS | 30200 | __end_cc_report 11:20:13 INFO - PROCESS | 30200 | __startTimestamp1472667613225__endTimestamp 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | ------- Summary: start ------- 11:20:13 INFO - PROCESS | 30200 | Number of tests: 6 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | [#0] dojo.html Cycles:165 Average:4531.66 Median:4623.51 stddev:475.16 (10.3%) stddev-sans-first:450.16 11:20:13 INFO - PROCESS | 30200 | Values: 2538.4 2542.0 2555.6 2570.0 2576.2 4412.5 4461.6 4554.7 4565.9 4586.4 4518.3 4522.0 4524.9 4525.2 4563.8 4169.6 4181.9 4247.2 4252.2 4324.3 4222.5 4241.8 4248.2 4249.3 4335.0 4216.5 4273.1 4277.0 4311.8 4354.0 4266.6 4310.0 4340.8 4350.5 4367.5 4111.4 4158.8 4166.8 4172.6 4223.7 4494.2 4509.8 4538.1 4583.2 4623.5 4904.3 4908.5 4909.1 4912.4 4958.2 4781.6 4838.4 4863.7 4907.9 4954.3 4542.7 4564.2 4565.0 4611.2 4619.2 4992.3 4996.8 4998.3 5005.6 5029.5 4649.5 4724.4 4786.5 4808.2 4817.5 4883.0 4910.9 4913.1 4947.4 4966.5 4859.8 4865.9 4866.4 4892.5 4909.8 4722.1 4763.0 4786.1 4863.3 4886.3 4068.5 4089.2 4090.6 4137.7 4138.3 3585.9 3597.0 3630.7 3639.6 3641.8 4170.4 4177.2 4194.2 4203.8 4207.1 4889.4 4937.9 4961.0 5010.6 5026.5 4243.0 4254.2 4255.4 4307.0 4316.4 4318.0 4358.5 4430.9 4445.8 4447.2 4574.9 4584.6 4597.3 4665.7 4669.7 4894.8 4904.1 4910.3 4911.4 4967.0 4458.9 4575.6 4606.7 4611.7 4667.2 4821.3 4837.7 4848.0 4908.2 4921.6 4902.9 4911.9 4913.1 4936.7 4959.1 4621.9 4767.1 4779.2 4801.4 4854.5 4785.7 4821.4 4840.2 4886.8 4892.9 4755.0 4766.9 4773.2 4775.3 4835.4 4694.5 4736.3 4846.6 4859.7 4913.4 4668.0 4700.0 4714.9 4717.0 4758.6 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | [#1] ext.html Cycles:180 Average:47128.75 Median:36770.84 stddev:86445.82 (235.1%) stddev-sans-first:86617.64 11:20:13 INFO - PROCESS | 30200 | Values: 571.1 574.6 578.1 580.1 583.6 28289.3 42679.0 44391.1 44454.3 44536.1 40903.4 41232.4 41305.0 41379.6 41395.6 7614.4 7797.1 7801.1 7802.6 7803.8 7661.7 7693.7 7695.0 7703.5 7752.0 7725.4 7775.1 7782.7 7784.1 7785.5 7656.8 7682.6 7689.3 7707.3 7713.5 7690.2 7783.0 7784.2 7789.3 7832.1 39049.8 39473.8 39518.4 39560.8 39574.4 2838.7 2946.7 3333.4 3620.6 3691.8 26721.3 29450.0 29716.4 29786.9 29844.3 3536.7 3604.7 3700.9 3750.9 3764.0 257287.0 258326.0 259997.0 260208.0 260741.7 49683.5 49846.5 49876.0 49901.3 49971.5 29571.6 30290.0 30312.5 30327.5 30395.5 14483.7 14644.8 14652.9 14692.7 14695.9 11072.2 11084.1 11095.2 11177.7 11192.7 17935.2 17950.1 17952.6 18032.4 18074.4 6786.4 6822.8 6887.9 6903.0 7026.6 756.4 844.2 871.4 958.7 963.8 27941.6 28298.9 28563.0 28756.0 29212.0 922.2 928.6 956.6 1001.5 1017.6 14282.9 14983.0 15202.0 15219.9 15353.4 390771.0 393287.0 395889.0 395994.4 396688.0 50967.2 51320.7 51429.7 51500.7 51603.5 1064.8 1100.6 1128.3 1163.3 1196.8 25924.2 28885.6 29560.9 29729.3 29878.3 37822.3 38170.6 38202.6 38211.6 38228.4 314168.0 314845.0 317680.0 318502.0 318678.0 22130.9 24302.1 25548.2 25586.4 25705.5 36336.8 36684.7 42231.6 43018.1 43949.8 35975.8 36100.8 37215.4 37909.0 37939.0 35733.6 36385.5 36404.5 36857.0 37336.6 35186.6 35985.8 36038.0 36064.5 36264.6 31652.8 33389.3 33656.2 33985.0 34114.0 25040.4 25462.6 25742.5 26027.0 26246.0 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | [#2] jquery.html Cycles:180 Average:23148.25 Median:4077.86 stddev:56273.54 (1380.0%) stddev-sans-first:56405.35 11:20:13 INFO - PROCESS | 30200 | Values: 344.2 365.6 366.0 366.6 385.5 12440.0 14666.4 16394.3 16444.0 16642.2 15808.1 16384.3 16633.9 16718.0 16887.7 4770.9 5114.0 5135.8 5144.9 5146.6 3692.3 5079.5 5162.9 5167.0 5671.4 5859.1 5988.7 5999.0 6003.3 6004.4 5803.3 5877.1 5926.7 5959.7 5977.3 5242.7 5247.8 5252.0 5252.4 5255.3 20820.4 20922.4 21337.0 21400.4 21484.2 1812.5 2437.8 2439.1 2450.3 2460.9 6083.2 6420.2 9904.0 11939.1 12255.8 1662.4 1702.4 1771.5 1808.7 1924.9 68569.3 71287.0 71683.5 72747.0 72756.0 10127.4 10265.2 10285.5 10456.4 10994.7 13941.3 13963.7 14046.9 14068.6 14083.5 7152.9 7211.4 7250.6 7318.6 7494.7 6848.3 6900.5 7026.4 7035.1 7063.3 4010.7 4145.1 4249.6 4354.3 4545.3 1797.8 1830.9 1844.4 1846.2 1848.5 783.9 801.8 844.0 930.8 944.9 15776.4 16306.7 16773.4 16880.5 17694.5 826.6 831.3 859.7 863.8 874.5 8883.8 9698.4 9754.1 9756.6 9922.5 265720.0 271986.0 370624.0 375215.0 376014.0 85057.6 85342.0 85717.0 86393.0 90245.5 900.9 915.1 948.1 956.4 957.2 15574.8 15673.9 16272.8 16350.7 16534.1 36083.8 37605.4 37638.0 37822.0 38741.2 48291.0 53239.7 54390.5 55551.7 55811.7 7572.0 7636.3 7913.3 7930.7 8335.7 11188.7 11232.1 11930.0 12162.4 12691.4 10010.9 10365.2 10797.1 10843.3 10899.7 8143.4 10592.5 10618.5 10666.5 10678.3 7732.5 10514.8 10680.6 10857.2 11188.4 7849.9 7896.6 8047.8 8115.2 8132.4 8200.3 10255.6 10365.0 10463.7 10927.2 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | [#3] mootools.html Cycles:180 Average:5060.74 Median:5084.57 stddev:2873.86 (56.5%) stddev-sans-first:2867.36 11:20:13 INFO - PROCESS | 30200 | Values: 1210.5 1346.7 1395.3 1448.5 1688.6 7304.7 7782.9 7785.0 8000.7 8016.7 7872.2 7965.3 7982.2 7983.8 7987.9 1856.3 2106.8 2144.6 2148.6 2179.7 2196.0 2222.7 2228.0 2229.0 2241.4 2175.7 2184.1 2194.5 2201.7 2233.5 2078.8 2151.3 2158.0 2168.7 2173.0 2144.2 2162.7 2163.1 2169.3 2170.5 7803.6 7838.3 7841.2 7849.2 7856.9 4408.4 4514.6 4568.8 4571.6 4605.4 2866.3 2920.8 3018.7 3019.0 3024.3 970.8 974.1 984.7 989.4 992.5 10630.6 10685.3 10696.5 10705.1 10708.8 4007.6 4094.6 4107.3 4119.9 4181.3 8491.5 8515.4 8522.4 8527.6 8531.0 4583.7 4585.6 4591.1 4592.4 4598.6 3630.3 4095.5 4190.8 4215.5 4241.4 3381.3 3396.6 3503.8 3504.5 3517.0 1040.9 1044.0 1045.9 1046.0 1067.4 740.8 796.9 806.1 812.9 816.8 5046.4 5117.9 5119.0 5261.2 5284.6 414.2 436.3 440.9 839.2 932.5 3499.2 3663.4 3705.9 3716.5 3733.2 9545.9 9697.4 9817.3 9850.5 9852.6 9769.2 9786.3 9790.7 9806.8 9814.5 6999.1 7113.9 7127.9 7138.2 7141.4 5005.2 5051.3 5199.7 5337.2 5415.2 8676.7 8710.9 8823.6 8875.2 8882.1 8622.8 8834.2 8893.4 9049.0 9098.0 5817.5 6237.9 6461.5 6467.8 6652.9 7370.6 7389.0 7412.3 7456.2 7463.4 6415.5 6468.9 6513.9 6521.4 6664.3 6278.5 6543.0 6647.4 6792.2 6865.6 5828.7 6030.8 6035.9 6038.2 6043.8 4174.0 4190.5 4244.3 4338.2 4420.5 4172.9 4506.5 4552.4 4553.9 4584.3 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | [#4] prototype.html Cycles:180 Average:4121.35 Median:4761.96 stddev:1193.86 (25.1%) stddev-sans-first:1162.24 11:20:13 INFO - PROCESS | 30200 | Values: 299.8 299.9 307.6 308.9 309.7 4724.6 4767.8 4786.4 4793.2 4829.9 4680.7 4736.0 4764.8 4768.3 4768.6 3529.9 3584.8 3699.8 3701.0 3702.4 3696.0 3700.6 3743.1 3746.2 3763.3 3663.1 3670.0 3678.1 3691.0 3704.1 3501.6 3600.5 3687.0 3714.7 3747.0 3319.4 3330.5 3330.5 3335.1 3338.0 4645.2 4647.4 4667.8 4681.2 4681.8 4154.4 4229.6 4239.0 4291.0 4295.7 4875.6 4886.8 4891.3 4908.3 4928.1 3601.7 3603.4 3606.6 3615.6 3629.4 4856.0 5125.7 5174.5 5211.1 5211.7 3542.1 3600.6 3601.4 3605.3 3608.8 3651.4 3663.8 3665.4 3666.7 3669.1 4181.5 4188.5 4196.3 4196.5 4206.1 4759.1 4880.3 4916.5 4959.0 4977.6 1230.9 1244.8 1245.4 1246.0 1252.8 806.5 806.9 830.2 833.8 855.3 4353.7 4356.9 4359.3 4359.9 4372.3 5026.7 5035.1 5036.8 5052.3 5055.7 4348.0 4352.9 4363.8 4370.5 4378.6 2559.6 2695.2 2705.0 2709.6 2721.0 4775.8 4779.7 4785.9 4797.4 4801.0 4978.2 5196.9 5207.0 5213.7 5229.2 4803.2 4809.6 4820.1 4830.6 4837.4 5116.2 5129.7 5168.8 5187.8 5213.9 4796.3 5041.5 5065.6 5112.5 5120.7 4820.0 4825.6 4844.6 4855.0 4859.4 3677.5 3679.2 3682.1 3686.5 3697.4 4972.3 5148.6 5154.3 5164.3 5166.9 4902.3 4926.0 4939.4 4942.5 4943.3 4928.0 4934.7 4939.7 4974.6 4979.6 4632.5 4888.5 4895.6 4896.3 4898.2 4755.5 4877.6 4934.2 4950.9 5008.5 4842.0 4853.7 4875.9 4884.9 4901.7 11:20:13 INFO - PROCESS | 30200 | 11:20:13 INFO - PROCESS | 30200 | [#5] yui.html Cycles:180 Average:18849.68 Median:2268.99 stddev:27767.46 (1223.8%) stddev-sans-first:27811.57 11:20:13 INFO - PROCESS | 30200 | Values: 605.3 680.1 698.2 713.2 734.9 12747.1 13436.2 13439.6 13489.6 13516.6 13539.1 13713.8 13772.0 13774.1 13785.0 598.9 713.0 742.5 743.6 749.4 768.4 770.1 770.5 771.1 772.1 804.0 806.5 807.3 807.4 808.3 630.2 773.2 793.9 798.3 801.2 588.7 588.8 588.9 589.4 589.5 12347.0 12376.4 12383.6 12384.5 12424.1 12161.7 12417.5 12681.3 12861.4 13145.0 10663.5 10773.9 10828.7 11304.5 11430.1 3872.2 3909.6 3935.1 4028.6 4109.6 66711.3 68266.3 69124.0 69206.3 69329.0 9677.7 9939.6 9997.9 10030.8 10327.0 18664.3 19852.9 19854.2 19858.6 19884.9 6736.9 6807.2 6978.1 7026.1 7349.4 3780.1 3780.3 3793.0 3807.4 3874.2 2822.8 2921.1 2922.3 2922.5 2924.4 494.3 496.1 500.9 503.0 514.4 396.0 461.2 479.6 507.3 570.9 7427.6 7490.6 8211.6 8399.2 8549.1 428.4 479.8 517.3 539.8 572.5 3756.6 3952.2 3992.2 4010.8 4094.6 65808.3 106087.5 106092.0 106463.1 108970.0 90365.5 93315.0 94342.5 94954.0 95220.0 84063.6 85125.6 86916.6 87506.0 89507.6 7308.5 7507.4 7549.5 7870.9 7918.8 46581.3 47059.3 47117.0 47577.0 48778.5 52440.0 70520.6 71531.0 73532.3 73648.2 10990.7 11638.5 11735.5 11818.8 11947.5 11678.4 12103.3 12555.8 13244.4 13301.3 10805.6 11131.3 11483.2 11498.7 11679.6 11021.6 11276.3 11395.4 11866.9 11915.3 11280.9 11477.8 11664.0 12144.3 12266.4 10036.9 10216.3 10485.9 10507.3 10557.9 9668.9 10481.6 10589.6 10695.5 10727.8 11:20:13 INFO - PROCESS | 30200 | -------- Summary: end -------- 11:20:13 INFO - PROCESS | 30200 | 11:20:14 INFO - TEST-INFO | 30200: exit 0 11:20:14 INFO - TEST-OK | dromaeo_css | took 1120348ms 11:20:14 INFO - TEST-START | kraken 11:20:14 INFO - operating with platform_type : linux_ 11:20:14 INFO - Initialising browser for kraken test... 11:20:14 INFO - TEST-INFO | started process 30510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkBkgOt/profile http://localhost:57283/getInfo.html) 11:20:18 INFO - PROCESS | 30510 | __metrics Screen width/height:1600/1200 11:20:18 INFO - PROCESS | 30510 | colorDepth:24 11:20:18 INFO - PROCESS | 30510 | Browser inner width/height: 1024/697 11:20:18 INFO - PROCESS | 30510 | __metrics 11:20:19 INFO - PROCESS | 30510 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:20:19 INFO - PROCESS | 30510 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:19 INFO - PROCESS | 30510 | console.error: PushService: 11:20:19 INFO - PROCESS | 30510 | stateChangeProcessEnqueue: Error transitioning state 11:20:19 INFO - PROCESS | 30510 | UnknownError 11:20:20 INFO - TEST-INFO | 30510: exit 0 11:20:20 INFO - Browser initialized. 11:20:20 INFO - Running cycle 1/1 for kraken test... 11:20:20 INFO - TEST-INFO | started process 30590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkBkgOt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:32 INFO - PROCESS | 30590 | RSS: Main: 182390784 11:20:32 INFO - PROCESS | 30590 | 11:20:35 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:36 INFO - PROCESS | 30590 | RSS: Main: 244170752 11:20:36 INFO - PROCESS | 30590 | 11:20:38 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-dft) 11:20:39 INFO - PROCESS | 30590 | RSS: Main: 226451456 11:20:39 INFO - PROCESS | 30590 | 11:20:42 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-fft) 11:20:43 INFO - PROCESS | 30590 | RSS: Main: 303415296 11:20:43 INFO - PROCESS | 30590 | 11:20:45 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-oscillator) 11:20:46 INFO - PROCESS | 30590 | RSS: Main: 213872640 11:20:46 INFO - PROCESS | 30590 | 11:20:48 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:48 INFO - PROCESS | 30590 | RSS: Main: 215445504 11:20:48 INFO - PROCESS | 30590 | 11:20:52 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57283/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:52 INFO - PROCESS | 30590 | RSS: Main: 253706240 11:20:52 INFO - PROCESS | 30590 | 11:20:56 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57283/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:56 INFO - PROCESS | 30590 | RSS: Main: 247742464 11:20:56 INFO - PROCESS | 30590 | 11:20:59 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57283/tests/kraken/driver.html?testName=json-parse-financial) 11:21:00 INFO - PROCESS | 30590 | RSS: Main: 250544128 11:21:00 INFO - PROCESS | 30590 | 11:21:02 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:02 INFO - PROCESS | 30590 | RSS: Main: 214691840 11:21:02 INFO - PROCESS | 30590 | 11:21:04 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:05 INFO - PROCESS | 30590 | RSS: Main: 221454336 11:21:05 INFO - PROCESS | 30590 | 11:21:07 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:08 INFO - PROCESS | 30590 | RSS: Main: 223473664 11:21:08 INFO - PROCESS | 30590 | 11:21:10 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:11 INFO - PROCESS | 30590 | RSS: Main: 223510528 11:21:11 INFO - PROCESS | 30590 | 11:21:14 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:21:15 INFO - PROCESS | 30590 | RSS: Main: 221667328 11:21:15 INFO - PROCESS | 30590 | 11:21:16 INFO - PROCESS | 30590 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57283/tests/kraken/driver.html?testName=ai-astar) 11:21:17 INFO - PROCESS | 30590 | RSS: Main: 272990208 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | __start_tp_report 11:21:17 INFO - PROCESS | 30590 | _x_x_mozilla_page_load 11:21:17 INFO - PROCESS | 30590 | _x_x_mozilla_page_load_details 11:21:17 INFO - PROCESS | 30590 | |i|pagename|runs| 11:21:17 INFO - PROCESS | 30590 | |0;ai-astar;112;115;132;115;114;114;113;115;114;116 11:21:17 INFO - PROCESS | 30590 | |1;audio-beat-detection;153;124;151;187;130;146;153;123;200;126 11:21:17 INFO - PROCESS | 30590 | |2;audio-dft;163;161;163;161;165;162;160;162;162;162 11:21:17 INFO - PROCESS | 30590 | |3;audio-fft;76;74;77;161;78;76;77;77;173;79 11:21:17 INFO - PROCESS | 30590 | |4;audio-oscillator;84;84;146;83;84;84;137;84;84;138 11:21:17 INFO - PROCESS | 30590 | |5;imaging-gaussian-blur;116;117;117;117;117;118;117;116;117;117 11:21:17 INFO - PROCESS | 30590 | |6;imaging-darkroom;146;147;148;146;147;147;146;146;146;147 11:21:17 INFO - PROCESS | 30590 | |7;imaging-desaturate;95;95;95;96;95;94;95;95;94;94 11:21:17 INFO - PROCESS | 30590 | |8;json-parse-financial;65;63;64;63;64;65;65;63;66;64 11:21:17 INFO - PROCESS | 30590 | |9;json-stringify-tinderbox;67;66;67;67;68;66;67;66;67;67 11:21:17 INFO - PROCESS | 30590 | |10;stanford-crypto-aes;82;82;85;81;86;82;82;81;81;84 11:21:17 INFO - PROCESS | 30590 | |11;stanford-crypto-ccm;138;152;138;135;136;138;134;131;176;132 11:21:17 INFO - PROCESS | 30590 | |12;stanford-crypto-pbkdf2;174;172;173;171;170;170;173;172;177;171 11:21:17 INFO - PROCESS | 30590 | |13;stanford-crypto-sha256-iterative;70;70;70;69;70;68;69;69;68;70 11:21:17 INFO - PROCESS | 30590 | __end_tp_report 11:21:17 INFO - PROCESS | 30590 | __start_cc_report 11:21:17 INFO - PROCESS | 30590 | _x_x_mozilla_cycle_collect,1993 11:21:17 INFO - PROCESS | 30590 | __end_cc_report 11:21:17 INFO - PROCESS | 30590 | __startTimestamp1472667677112__endTimestamp 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | ------- Summary: start ------- 11:21:17 INFO - PROCESS | 30590 | Number of tests: 14 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.00 stddev:5.73 (5.0%) stddev-sans-first:5.90 11:21:17 INFO - PROCESS | 30590 | Values: 112.0 115.0 132.0 115.0 114.0 114.0 113.0 115.0 114.0 116.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:152.00 stddev:26.42 (17.4%) stddev-sans-first:27.98 11:21:17 INFO - PROCESS | 30590 | Values: 153.0 124.0 151.0 187.0 130.0 146.0 153.0 123.0 200.0 126.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.41 11:21:17 INFO - PROCESS | 30590 | Values: 163.0 161.0 163.0 161.0 165.0 162.0 160.0 162.0 162.0 162.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:38.18 (49.6%) stddev-sans-first:39.89 11:21:17 INFO - PROCESS | 30590 | Values: 76.0 74.0 77.0 161.0 78.0 76.0 77.0 77.0 173.0 79.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:84.00 stddev:27.38 (32.6%) stddev-sans-first:28.36 11:21:17 INFO - PROCESS | 30590 | Values: 84.0 84.0 146.0 83.0 84.0 84.0 137.0 84.0 84.0 138.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 11:21:17 INFO - PROCESS | 30590 | Values: 116.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:21:17 INFO - PROCESS | 30590 | Values: 146.0 147.0 148.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:21:17 INFO - PROCESS | 30590 | Values: 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 94.0 94.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 11:21:17 INFO - PROCESS | 30590 | Values: 65.0 63.0 64.0 63.0 64.0 65.0 65.0 63.0 66.0 64.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 11:21:17 INFO - PROCESS | 30590 | Values: 67.0 66.0 67.0 67.0 68.0 66.0 67.0 66.0 67.0 67.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:1.78 (2.2%) stddev-sans-first:1.87 11:21:17 INFO - PROCESS | 30590 | Values: 82.0 82.0 85.0 81.0 86.0 82.0 82.0 81.0 81.0 84.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:138.00 stddev:13.60 (9.9%) stddev-sans-first:14.38 11:21:17 INFO - PROCESS | 30590 | Values: 138.0 152.0 138.0 135.0 136.0 138.0 134.0 131.0 176.0 132.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.50 stddev:2.11 (1.2%) stddev-sans-first:2.15 11:21:17 INFO - PROCESS | 30590 | Values: 174.0 172.0 173.0 171.0 170.0 170.0 173.0 172.0 177.0 171.0 11:21:17 INFO - PROCESS | 30590 | 11:21:17 INFO - PROCESS | 30590 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 11:21:17 INFO - PROCESS | 30590 | Values: 70.0 70.0 70.0 69.0 70.0 68.0 69.0 69.0 68.0 70.0 11:21:17 INFO - PROCESS | 30590 | -------- Summary: end -------- 11:21:17 INFO - PROCESS | 30590 | 11:21:18 INFO - TEST-INFO | 30590: exit 0 11:21:18 INFO - TEST-OK | kraken | took 64200ms 11:21:18 INFO - SUITE-END | took 1184s 11:21:18 INFO - Completed test suite (00:19:44) 11:21:18 INFO - javascript benchmark 11:21:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2538.403475183332, 2541.9618705719404, 2555.5655538558444, 2569.9871500642494, 2576.2400091972854, 4412.492563355215, 4461.553844615537, 4554.658400619955, 4565.88585285368, 4586.449626044875, 4518.254488009483, 4521.954780452194, 4524.886877828056, 4525.208088584501, 4563.794629241684, 4169.562195969433, 4181.853635122771, 4247.214265360903, 4252.170826688797, 4324.286492728696, 4222.451081359419, 4241.830326786925, 4248.150369926027, 4249.3201087825955, 4335.0, 4216.5361810201, 4273.1240095780295, 4277.037666525022, 4311.784410779464, 4353.978230108845, 4266.616004559573, 4310.030243195288, 4340.804663790105, 4350.499692535367, 4367.475902891641, 4111.383292506118, 4158.771267580282, 4166.83332666693, 4172.582741725833, 4223.68322375823, 4494.213512635309, 4509.842155524541, 4538.115067561826, 4583.243764778807, 4623.514530974267, 4904.264360345941, 4908.484609116027, 4909.091818013679, 4912.410510738699, 4958.157113290713, 4781.593564547018, 4838.419389673227, 4863.659543831933, 4907.8773030674165, 4954.331165292675, 4542.727436353829, 4564.2012647786505, 4564.954350456453, 4611.239145540982, 4619.214733495314, 4992.2761199626575, 4996.7501624918605, 4998.300237966688, 5005.624578156653, 5029.547340739351, 4649.488556258809, 4724.385829842098, 4786.497417771154, 4808.206645903457, 4817.542333478314, 4882.951170488321, 4910.926336104962, 4913.06651736169, 4947.431045429749, 4966.453690094087, 4859.757012149378, 4865.878353041202, 4866.4403593586485, 4892.461829198785, 4909.7790599423115, 4722.055588882237, 4762.9523704762505, 4786.138495070851, 4863.319135321058, 4886.340344053508, 4068.450759147477, 4089.1821635672986, 4090.570490098497, 4137.710360274752, 4138.317177665652, 3585.8924232273075, 3596.9820150899077, 3630.6913912317223, 3639.5996440391536, 3641.8361173746716, 4170.395292682544, 4177.164567086595, 4194.2450358935685, 4203.831846726097, 4207.053412982115, 4889.364382630235, 4937.9012419752125, 4961.03259864323, 5010.574101201366, 5026.52248036436, 4243.045314804206, 4254.170436764863, 4255.361695745601, 4307.030918043415, 4316.352547117957, 4317.978410107992, 4358.455193100863, 4430.867073987785, 4445.799939002753, 4447.199504089295, 4574.908501830011, 4584.610308123847, 4597.264437689953, 4665.6734028617675, 4669.673122881366, 4894.779734912009, 4904.141775189399, 4910.263460480956, 4911.435184953776, 4966.950330496648, 4458.866234012985, 4575.565321294472, 4606.654500912378, 4611.700239484423, 4667.229907065432, 4821.300911367762, 4837.733924634179, 4847.975760121318, 4908.165611846066, 4921.6062714982, 4902.926456103232, 4911.852644420673, 4913.091078150554, 4936.679115857458, 4959.13215187348, 4621.907561848677, 4767.094252092092, 4779.235322348408, 4801.447833499193, 4854.514548545118, 4785.712857228438, 4821.445533763522, 4840.201366774443, 4886.780094895809, 4892.902141957212, 4754.952450475589, 4766.928496072631, 4773.236282194832, 4775.2598347256235, 4835.419749630067, 4694.460137084279, 4736.289556566542, 4846.588040016638, 4859.684120532154, 4913.361263035782, 4668.0, 4700.036492519093, 4714.882127946828, 4716.976415117902, 4758.619310455225], "value": 4501.240840627634, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.129028231946, 574.5977815529129, 578.1241419249837, 580.1384943359109, 583.6323116436643, 28289.292767680818, 42679.0, 44391.11217775647, 44454.33318500225, 44536.1092778145, 40903.38644920321, 41232.38151427731, 41305.0, 41379.586204138024, 41395.58604413962, 7614.352780013705, 7797.142314345446, 7801.14187439384, 7802.60986950653, 7803.765887023398, 7661.731839385623, 7693.7307194248215, 7694.999650045486, 7703.5377877327255, 7752.0, 7725.381969442431, 7775.144734079275, 7782.688692452323, 7784.1437441881635, 7785.532868027908, 7656.770296891103, 7682.615869206573, 7689.346405555534, 7707.342921271954, 7713.4600577959845, 7690.192529784348, 7782.961085194538, 7784.182660820589, 7789.337906277973, 7832.138464768871, 39049.80475097635, 39473.802630986946, 39518.40722389166, 39560.81317560478, 39574.406383904265, 2838.7445129938196, 2946.6905974872757, 3333.4333163362285, 3620.601733809279, 3691.8338674759702, 26721.331966700793, 29450.0, 29716.405671886656, 29786.851065744533, 29844.253893652614, 3536.717062634983, 3604.6575575320567, 3700.9259814803822, 3750.9062273443383, 3764.0, 257287.0, 258326.0, 259997.0, 260208.0, 260741.6962915192, 49683.503164967886, 49846.50153498491, 49876.0, 49901.25148122781, 49971.50028499741, 29571.556426653617, 30290.0, 30312.54531182034, 30327.545086823717, 30395.544066839015, 14483.710325793425, 14644.780328295084, 14652.853471465362, 14692.706145877022, 14695.926520367544, 11072.224944253987, 11084.113270938306, 11095.223334366678, 11177.66467005991, 11192.664220073411, 17935.192916318796, 17950.102494875464, 17952.640947180982, 18032.368867089852, 18074.367397141035, 6786.423154031864, 6822.795316140524, 6887.931120688829, 6903.032635698802, 7026.629807187549, 756.3986630628664, 844.2317491083207, 871.407442938795, 958.6932181701789, 963.7831487915163, 27941.580876286873, 28298.85850570734, 28563.0, 28756.0, 29212.0, 922.1930810540777, 928.6424726480219, 956.6135878988442, 1001.47923079998, 1017.6234793126442, 14282.85717142836, 14983.0, 15202.0, 15219.923900380649, 15353.385864565516, 390771.0, 393287.0, 395889.0, 395994.4205858401, 396688.0, 50967.235491467654, 51320.74339628353, 51429.742851285504, 51500.742496287276, 51603.483965160616, 1064.7870425914848, 1100.5762781329247, 1128.3342827731678, 1163.3020187887369, 1196.8144937534696, 25924.22227333183, 28885.566716498848, 29560.852195738884, 29729.25676858096, 29878.253043673212, 37822.32665100257, 38170.618293816704, 38202.617973819906, 38211.61788382192, 38228.42657360197, 314168.0, 314845.0, 317680.0, 318502.0, 318678.0, 22130.88934555317, 24302.149424770047, 25548.23355299344, 25586.360340991625, 25705.485890282464, 36336.818315908255, 36684.680721295794, 42231.577684222764, 43018.13963720771, 43949.780251099815, 35975.820120899225, 36100.8194959034, 37215.441768372955, 37909.0, 37939.0, 35733.64266357303, 36385.454218187275, 36404.453933190496, 36857.0, 37336.6266337344, 35186.648133518334, 35985.82007089948, 36038.0, 36064.45903311505, 36264.63735362612, 31652.841735791175, 33389.33221335608, 33656.1585960353, 33985.0, 34114.0, 25040.37399065038, 25462.618060729474, 25742.485150296514, 26027.0, 26246.0], "value": 17280.368534171193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.15166614295754, 365.55584964268417, 365.9725520585955, 366.5692810947138, 385.46612941076603, 12440.0, 14666.413343466262, 16394.26225819838, 16444.0, 16642.167891605415, 15808.051516908994, 16384.344626214937, 16633.91683041583, 16718.0, 16887.66224675506, 4770.904581908359, 5114.0, 5135.8202462913805, 5144.922826157611, 5146.562542183919, 3692.316921369542, 5079.542841144296, 5162.92255616166, 5167.0, 5671.376148623648, 5859.0625499920025, 5988.670623115727, 5999.040153575429, 6003.279606447232, 6004.42957918997, 5803.332616749086, 5877.147813567009, 5926.703664816742, 5959.7020148992815, 5977.31260904995, 5242.685438873642, 5247.816326428557, 5252.0, 5252.448492908266, 5255.343082114736, 20820.37538873836, 20922.37232883016, 21337.039833207542, 21400.35798926035, 21484.24805131813, 1812.501562070428, 2437.8293519453646, 2439.097533912464, 2450.3016640257442, 2460.9138680146107, 6083.209182806251, 6420.165378500812, 9903.950480247624, 11939.141967305992, 12255.816162757477, 1662.393226472329, 1702.3701230544655, 1771.5216891439238, 1808.6925222712039, 1924.8845069295887, 68569.31430685679, 71287.0, 71683.53063509814, 72747.0, 72756.0, 10127.392356458637, 10265.230107741949, 10285.537150828231, 10456.424896630606, 10994.670159895217, 13941.302934853216, 13963.720725585432, 14046.85953140476, 14068.577942661737, 14083.507077252247, 7152.856942861218, 7211.350978411968, 7250.601216933014, 7318.597477138808, 7494.70021199146, 6848.280930502325, 6900.482463815234, 7026.367626913602, 7035.050268213828, 7063.293670632998, 4010.6590939770444, 4145.067359844072, 4249.6387807036745, 4354.281543545343, 4545.272756358967, 1797.8202179781917, 1830.9267629294945, 1844.4374465788064, 1846.2061313634997, 1848.491664792166, 783.8902553642495, 801.7795106345801, 843.9535825529655, 930.8324501589778, 944.9102335278137, 15776.368945242062, 16306.695464362823, 16773.412930547373, 16880.49358519222, 17694.469165925042, 826.557791581513, 831.3224721851672, 859.6604341285157, 863.7538301584144, 874.5190145419994, 8883.779055236191, 9698.36960597559, 9754.122129008423, 9756.560954757053, 9922.454265015349, 265720.0, 271986.0, 370624.0, 375215.0, 376014.0, 85057.57471212605, 85342.0, 85717.0, 86393.0, 90245.54877225703, 900.9369344145847, 915.1397686174975, 948.1466679988066, 956.4022485946283, 957.167264479893, 15574.844251557339, 15673.921630392231, 16272.839950421776, 16350.672986540441, 16534.09062501526, 36083.81958090298, 37605.435918460695, 37638.0, 37822.0, 38741.2251754969, 48291.0, 53239.733801330745, 54390.45609543854, 55551.72224138853, 55811.72094139503, 7572.0, 7636.31273185416, 7913.327367173854, 7930.722424715107, 8335.666573337241, 11188.66434006981, 11232.101431885592, 11930.0, 12162.358081659217, 12691.365431728562, 10010.949945250228, 10365.170786336925, 10797.136229101496, 10843.295185812896, 10899.673009809718, 8143.389245806707, 10592.470376481298, 10618.469076546296, 10666.46667666629, 10678.305910115818, 7732.536047837148, 10514.842277365999, 10680.57277708914, 10857.18571107186, 11188.384638844616, 7849.882251766342, 7896.6446509906045, 8047.798805029921, 8115.229053239933, 8132.390070744599, 8200.302974247017, 10255.589776409159, 10365.0, 10463.68608941733, 10927.235093543375], "value": 8299.141312162561, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.509743553861, 1346.710457251691, 1395.281430063517, 1448.5292280008994, 1688.6116193275545, 7304.707811687533, 7782.883256751146, 7785.0, 8000.679972801081, 8016.719414820483, 7872.212778722125, 7965.322947549451, 7982.2416870397365, 7983.760487185379, 7987.880181797278, 1856.3131641292741, 2106.820920221783, 2144.635411979967, 2148.645473496875, 2179.705739725133, 2195.9560808783813, 2222.7221597300336, 2228.0308065991267, 2228.9665655015187, 2241.4396400899777, 2175.673648952662, 2184.1154332495366, 2194.462356722597, 2201.6697495375743, 2233.508628101815, 2078.8025137612053, 2151.34384012876, 2157.967630485544, 2168.728908886389, 2173.0, 2144.238795227703, 2162.664786958024, 2163.102312540294, 2169.2516081951703, 2170.4790850195996, 7803.609819509059, 7838.255365740246, 7841.176676448948, 7849.215078492162, 7856.921430785676, 4408.3607876858, 4514.571115743999, 4568.840090596813, 4571.58855702985, 4605.424321959755, 2866.254773758817, 2920.7663386928994, 3018.743406810424, 3019.0188188838715, 3024.259056531164, 970.7573106723319, 974.1378879691524, 984.7390441532999, 989.3766926836047, 992.538469611634, 10630.574777008911, 10685.305455145392, 10696.465176741132, 10705.1435885129, 10708.839367409495, 4007.5591684914634, 4094.5700701426517, 4107.322291821816, 4119.876403707894, 4181.330987042059, 8491.532965686947, 8515.446495977742, 8522.403431759842, 8527.573621318908, 8530.957345213234, 4583.656225783079, 4585.633149348044, 4591.104734576792, 4592.380028696083, 4598.632109431237, 3630.2739452109154, 4095.5085389752826, 4190.832366705358, 4215.451991241119, 4241.384999175102, 3381.323735252959, 3396.5904149777566, 3503.824808759603, 3504.491848681927, 3516.982415087908, 1040.921930855189, 1044.0446991003298, 1045.9186219423293, 1046.027194708928, 1067.3649178738638, 740.7962810227231, 796.9322607578305, 806.1374329467413, 812.90258151495, 816.7508909782455, 5046.369203849519, 5117.8720531987, 5118.974405128025, 5261.210818377274, 5284.630075894727, 414.1693713785077, 436.3280547956112, 440.9162259170747, 839.1650307943635, 932.5011119051275, 3499.1951851074396, 3663.358912190356, 3705.9258814824093, 3716.5168528091717, 3733.178700685845, 9545.904540954501, 9697.418154910727, 9817.263705222136, 9850.458224797561, 9852.605895764233, 9769.218462522982, 9786.314957953018, 9790.706278811647, 9806.803863922682, 9814.46020468881, 6999.09011828459, 7113.89329160063, 7127.89308160378, 7138.214796372291, 7141.357277845019, 5005.174146265826, 5051.267566202807, 5199.74001299941, 5337.172738225581, 5415.2147938547905, 8676.652933882575, 8710.912890871263, 8823.558822058743, 8875.201231889161, 8882.111788821067, 8622.78443038929, 8834.204921557091, 8893.377463577488, 9049.049849765679, 9097.954510227672, 5817.5345972321265, 6237.875242495215, 6461.547691661726, 6467.838304042437, 6652.933470665425, 7370.5577665338105, 7388.963055184689, 7412.332890039706, 7456.217097204715, 7463.3656139226605, 6415.454686351713, 6468.8706225874275, 6513.934860651333, 6521.380468855451, 6664.333566643297, 6278.529110316836, 6542.967285163544, 6647.434968027772, 6792.1849378072975, 6865.588064716133, 5828.679422631626, 6030.7889223876955, 6035.939640603538, 6038.154658347923, 6043.7884674036195, 4174.0, 4190.497140343056, 4244.299690551148, 4338.219120558204, 4420.535843736361, 4172.874813755592, 4506.504284528633, 4552.362669226245, 4553.863384098482, 4584.335271385564], "value": 4035.235862719205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.77516862353235, 299.85007496251876, 307.5801530910308, 308.9165925200196, 309.6856690459184, 4724.551167639073, 4767.785449654765, 4786.415335718716, 4793.233082706767, 4829.8792530186765, 4680.742559159245, 4735.952640473594, 4764.78558464869, 4768.284757286408, 4768.64235182361, 3529.9294014119764, 3584.8207589620547, 3699.7780133192095, 3700.9814950925343, 3702.3520883845217, 3696.0205545530457, 3700.5567828546887, 3743.101655602663, 3746.2132952080096, 3763.2849758545926, 3663.084228942764, 3670.0, 3678.062094165997, 3690.9630903690886, 3704.111013356802, 3501.579810422753, 3600.4959305697093, 3687.0, 3714.7213958952916, 3746.981265093657, 3319.3527262183884, 3330.500424936279, 3330.5021234074443, 3335.099523128766, 3338.0, 4645.163870503308, 4647.372604698357, 4667.836625718083, 4681.157391669498, 4681.81272749093, 4154.356074808409, 4229.577042295777, 4238.978805105986, 4291.047573354116, 4295.6778241632, 4875.634327425421, 4886.755662216875, 4891.315215869781, 4908.263760435963, 4928.1129396708575, 3601.711863050976, 3603.387424137903, 3606.5852426970973, 3615.566132064143, 3629.3830048891487, 4855.951440485585, 5125.692458452505, 5174.508421699932, 5211.140161873286, 5211.739413029333, 3542.1498840278146, 3600.5859326177824, 3601.405768048295, 3605.3149901518627, 3608.783472991629, 3651.379265524867, 3663.7543235300127, 3665.395209790408, 3666.7249956252854, 3669.119411341259, 4181.498220213533, 4188.549698426394, 4196.328587425997, 4196.4964204295065, 4206.095689426788, 4759.143354196278, 4880.341153944243, 4916.508349165127, 4959.0, 4977.576905963034, 1230.8522977242787, 1244.8443944506937, 1245.3586403002462, 1245.9813102803466, 1252.8496580410226, 806.4637016384156, 806.9106705946924, 830.2030051150842, 833.7748807821854, 855.3029281135854, 4353.651707863363, 4356.869293921188, 4359.346098085312, 4359.891002724958, 4372.256716358227, 5026.743314171457, 5035.136999310205, 5036.823711170092, 5052.343195384577, 5055.69665820052, 4347.956520434818, 4352.934705979413, 4363.825446982085, 4370.497392799805, 4378.620734468632, 2559.5648739714293, 2695.191442567261, 2704.9729502705113, 2709.6206531085663, 2720.9728752079827, 4775.761211939389, 4779.737114458669, 4785.856424307207, 4797.376341075707, 4800.95199048012, 4978.203487442064, 5196.948030519722, 5207.0366982108435, 5213.739313034409, 5229.241759944786, 4803.18345881201, 4809.567138957511, 4820.108279968217, 4830.637702172351, 4837.443693975097, 5116.232565115262, 5129.666571672829, 5168.819091331936, 5187.818426355059, 5213.921791173211, 4796.304535842213, 5041.521055499722, 5065.594752419871, 5112.488751124858, 5120.743962801919, 4819.95180048195, 4825.552334299767, 4844.563989240985, 4854.975725121351, 4859.392575928009, 3677.4667673187773, 3679.24575462035, 3682.116292089933, 3686.5391826021746, 3697.3899306614107, 4972.2790195422185, 5148.562372198405, 5154.304168937146, 5164.251183578285, 5166.922496162636, 4902.313676085422, 4925.950740492549, 4939.407271127488, 4942.5304596063315, 4943.332650092191, 4928.014397120519, 4934.679245849008, 4939.678920870132, 4974.577160941216, 4979.626528010342, 4632.4672662644225, 4888.460135057446, 4895.63282753802, 4896.2655601660035, 4898.216285394462, 4755.524447555217, 4877.634177436636, 4934.185859333314, 4950.9257361140335, 5008.547521218951, 4842.0, 4853.6602437829015, 4875.902481950412, 4884.876478409915, 4901.681390709592], "value": 3742.639868440875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2555356910999, 680.1158493957854, 698.183125742881, 713.243961400915, 734.8897665350194, 12747.107702460831, 13436.193828370304, 13439.596812095653, 13489.595312140627, 13516.594502164939, 13539.119957202774, 13713.794293085612, 13772.0, 13774.104683195585, 13785.0, 598.8772301678167, 713.0409599089243, 742.5062333548184, 743.5687301365209, 749.4341771962161, 768.3660979691749, 770.0912922751152, 770.5299767142039, 771.1324759645399, 772.0889350566357, 804.0351578106266, 806.5120602035743, 807.3339494916688, 807.4347956430522, 808.3250485844327, 630.180765005491, 773.2460850670608, 793.8809178623253, 798.2974982015847, 801.2308184143229, 588.6909372579387, 588.8498432899626, 588.8939990801654, 589.416477687091, 589.4635881347953, 12347.0, 12376.443060062229, 12383.62849114528, 12384.504619815196, 12424.06819488542, 12161.695957601043, 12417.503299867994, 12681.302528360937, 12861.356932153449, 13145.0, 10663.466826658636, 10773.946130269376, 10828.72928176794, 11304.547818087267, 11430.085593152528, 3872.186840763443, 3909.648131668135, 3935.0949281665376, 4028.637422631977, 4109.609587089221, 66711.33288667149, 68266.3173368265, 69124.0, 69206.3079369205, 69329.0, 9677.661281855102, 9939.602415903282, 9997.900020999843, 10030.799384012278, 10327.018933201334, 18664.34674786376, 19852.90073549623, 19854.20583176657, 19858.60282794336, 19884.90057549703, 6736.932630673728, 6807.183138023469, 6978.092847929838, 7026.1217347831525, 7349.375303099297, 3780.092777733324, 3780.3384407729086, 3792.981035094807, 3807.371783655721, 3874.2057878134915, 2822.788290878192, 2921.123662901121, 2922.313256384748, 2922.459345021178, 2924.4297362014204, 494.3474613510204, 496.149104286151, 500.87478130467383, 503.0090721279074, 514.390447319927, 395.992080158401, 461.19291240329426, 479.6306843730308, 507.29739311054453, 570.8629928817054, 7427.628618569158, 7490.625468726542, 8211.630476628567, 8399.202075802788, 8549.145085491402, 428.37671188420774, 479.75532478435554, 517.2990597740084, 539.7881755458941, 572.4904834697123, 3756.567994680592, 3952.24907267624, 3992.161646054303, 4010.839566417369, 4094.6314831665295, 65808.34191658022, 106087.46956265169, 106092.0, 106463.14452705176, 108970.0, 90365.54817225871, 93315.0, 94342.52828735813, 94954.0, 95220.0, 84063.5796821012, 85125.57437212774, 86916.5654171725, 87506.0, 89507.55246223857, 7308.478574891654, 7507.361874240532, 7549.50928189666, 7870.881936770838, 7918.841623167619, 46581.3012804815, 47059.29411058906, 47117.0, 47577.0, 48778.512214877395, 52440.0, 70520.64739676268, 71531.0, 73532.26467735469, 73648.21628539408, 10990.670279891616, 11638.53445862156, 11735.47190376418, 11818.76362472763, 11947.522099116286, 11678.416079196177, 12103.273803571814, 12555.811662825248, 13244.404001820134, 13301.334933253493, 10805.621803237163, 11131.276467029616, 11483.196176267582, 11498.655040348469, 11679.591214307458, 11021.583309174182, 11276.267042642203, 11395.373254470753, 11866.881331186923, 11915.285082895054, 11280.943595281971, 11477.82783258235, 11664.0, 12144.33206173669, 12266.448009839758, 10036.949815250877, 10216.284860059724, 10485.947570262406, 10507.31702439339, 10557.9472102639, 9668.854967175357, 10481.580736770444, 10589.629362972259, 10695.465226738788, 10727.839082413613], "value": 6607.600075059758, "unit": "score"}], "name": "dromaeo_css", "value": 6331.551574295578, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 132.0, 115.0, 114.0, 114.0, 113.0, 115.0, 114.0, 116.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 151.0, 187.0, 130.0, 146.0, 153.0, 123.0, 200.0, 126.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 165.0, 162.0, 160.0, 162.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 161.0, 78.0, 76.0, 77.0, 77.0, 173.0, 79.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 146.0, 83.0, 84.0, 84.0, 137.0, 84.0, 84.0, 138.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 65.0, 65.0, 63.0, 66.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 81.0, 86.0, 82.0, 82.0, 81.0, 81.0, 84.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 152.0, 138.0, 135.0, 136.0, 138.0, 134.0, 131.0, 176.0, 132.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 173.0, 171.0, 170.0, 170.0, 173.0, 172.0, 177.0, 171.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 70.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1577.4999999999995, "alertThreshold": 2.0}]} 11:21:18 INFO - Return code: 0 11:21:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:21:18 INFO - # TBPL SUCCESS # 11:21:18 INFO - Running post-action listener: _resource_record_post_action 11:21:18 INFO - [mozharness: 2016-08-31 18:21:18.934801Z] Finished run-tests step (success) 11:21:18 INFO - Running post-run listener: _resource_record_post_run 11:21:18 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417402880; Read time: 16; Write time: 422324 11:21:18 INFO - TinderboxPrint: CPU usage
13.0% 11:21:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:21:18 INFO - TinderboxPrint: I/O write bytes / time
417,402,880 / 422,324 11:21:18 INFO - TinderboxPrint: CPU idle
8,333.6 (87.0%) 11:21:18 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 11:21:18 INFO - TinderboxPrint: Swap in / out
0 / 0 11:21:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 123125760; Read time: 0; Write time: 112960 11:21:19 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 293711872; Read time: 0; Write time: 309328 11:21:19 INFO - Running post-run listener: _upload_blobber_files 11:21:19 INFO - Blob upload gear active. 11:21:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:21:19 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 11:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:21:19 INFO - (blobuploader) - INFO - Open directory for files ... 11:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:23 INFO - (blobuploader) - INFO - Done attempting. 11:21:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:21:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:23 INFO - (blobuploader) - INFO - Done attempting. 11:21:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:21:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:21:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:24 INFO - (blobuploader) - INFO - Done attempting. 11:21:24 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:24 INFO - Return code: 0 11:21:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:21:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4181df7c1584b81a2afd8e56cef95065e7be1f96ee11c6e2e5ffe4dca066d8d58a581afbb07d1a7a87d43c03cd245d725c288f32c676cbbb1885e2a855c9f578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bed4dffbdc62ac865564d2275f58cdfb17fc88ee6750d52118ddc8c3c41d125d85054a3906893cb657e95d7a77fbd2ff807da07ca2f0253ba9aee8b68a178836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ddec7e0eca76c3059ccb9cbdaf62ab954ad31f3016c4423cd7260366fb995d23267fcb26b12c2d8c269552a2c691eea7ae09c0b3187c07744e2ae8e8e056c78"} 11:21:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:21:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:21:24 INFO - Contents: 11:21:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4181df7c1584b81a2afd8e56cef95065e7be1f96ee11c6e2e5ffe4dca066d8d58a581afbb07d1a7a87d43c03cd245d725c288f32c676cbbb1885e2a855c9f578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bed4dffbdc62ac865564d2275f58cdfb17fc88ee6750d52118ddc8c3c41d125d85054a3906893cb657e95d7a77fbd2ff807da07ca2f0253ba9aee8b68a178836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ddec7e0eca76c3059ccb9cbdaf62ab954ad31f3016c4423cd7260366fb995d23267fcb26b12c2d8c269552a2c691eea7ae09c0b3187c07744e2ae8e8e056c78"} 11:21:24 INFO - Running post-run listener: copy_logs_to_upload_dir 11:21:24 INFO - Copying logs to upload dir... 11:21:24 INFO - mkdir: /builds/slave/test/build/upload/logs 11:21:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.491430 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-31 11:21:24.779993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:24.783560) ========= 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=db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4181df7c1584b81a2afd8e56cef95065e7be1f96ee11c6e2e5ffe4dca066d8d58a581afbb07d1a7a87d43c03cd245d725c288f32c676cbbb1885e2a855c9f578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bed4dffbdc62ac865564d2275f58cdfb17fc88ee6750d52118ddc8c3c41d125d85054a3906893cb657e95d7a77fbd2ff807da07ca2f0253ba9aee8b68a178836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ddec7e0eca76c3059ccb9cbdaf62ab954ad31f3016c4423cd7260366fb995d23267fcb26b12c2d8c269552a2c691eea7ae09c0b3187c07744e2ae8e8e056c78"} build_url:https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/Pr2z7ELOS-6uaPSNPcWBVg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4181df7c1584b81a2afd8e56cef95065e7be1f96ee11c6e2e5ffe4dca066d8d58a581afbb07d1a7a87d43c03cd245d725c288f32c676cbbb1885e2a855c9f578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bed4dffbdc62ac865564d2275f58cdfb17fc88ee6750d52118ddc8c3c41d125d85054a3906893cb657e95d7a77fbd2ff807da07ca2f0253ba9aee8b68a178836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0ddec7e0eca76c3059ccb9cbdaf62ab954ad31f3016c4423cd7260366fb995d23267fcb26b12c2d8c269552a2c691eea7ae09c0b3187c07744e2ae8e8e056c78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:24.813949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:24.814408) ========= 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=db0483c52d987ecb441a263b000001ad-1472666437.636985-1210526851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:24.899817) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:21:24.900287) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:21:24.900688) ========= ========= Total master_lag: 0.19 =========