builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1471297315.74 results: success (0) buildid: 20160815113001 builduid: 7c7fd4f8f8c84f6ab6ae85d40126e6f4 revision: 59055929012280084afd040bfdf4216083a7636a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.743094) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.743672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.744095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.767181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.767799) ========= 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=52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 14:41:56-- 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% 35.3M=0s 2016-08-15 14:41:56 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.885978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.886302) ========= 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=52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.937284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:55.937802) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 59055929012280084afd040bfdf4216083a7636a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 59055929012280084afd040bfdf4216083a7636a --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=52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 14:41:56,963 truncating revision to first 12 chars 2016-08-15 14:41:56,963 Setting DEBUG logging. 2016-08-15 14:41:56,963 attempt 1/10 2016-08-15 14:41:56,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/590559290122?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 14:41:57,267 unpacking tar archive at: fx-team-590559290122/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:56.596066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:56.596414) ========= script_repo_revision: 59055929012280084afd040bfdf4216083a7636a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:56.596793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:56.597053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 14:41:56.606578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-15 14:41:56.606905) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:41:57 INFO - MultiFileLogger online at 20160815 14:41:57 in /builds/slave/test 14:41:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:41:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:41:57 INFO - {'append_to_log': False, 14:41:57 INFO - 'base_work_dir': '/builds/slave/test', 14:41:57 INFO - 'blob_upload_branch': 'Fx-Team', 14:41:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:41:57 INFO - 'branch': 'Fx-Team', 14:41:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:41:57 INFO - 'config_files': ('talos/linux_config.py',), 14:41:57 INFO - 'default_actions': ('clobber', 14:41:57 INFO - 'read-buildbot-config', 14:41:57 INFO - 'download-and-extract', 14:41:57 INFO - 'populate-webroot', 14:41:57 INFO - 'create-virtualenv', 14:41:57 INFO - 'install', 14:41:57 INFO - 'run-tests'), 14:41:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:41:57 INFO - 'download_minidump_stackwalk': True, 14:41:57 INFO - 'download_symbols': 'ondemand', 14:41:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:41:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:41:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:41:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:41:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:41:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:41:57 INFO - 'installer_path': 'installer.exe', 14:41:57 INFO - 'log_level': 'info', 14:41:57 INFO - 'log_name': 'talos', 14:41:57 INFO - 'log_to_console': True, 14:41:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:41:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:41:57 INFO - 'opt_config_files': (), 14:41:57 INFO - 'pip_index': False, 14:41:57 INFO - 'sps_profile': False, 14:41:57 INFO - 'sps_profile_interval': 0, 14:41:57 INFO - 'suite': 'dromaeojs', 14:41:57 INFO - 'system_bits': '32', 14:41:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:41:57 INFO - 'title': 'talos-linux64-ix-056', 14:41:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:41:57 INFO - 'use_talos_json': True, 14:41:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:41:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:41:57 INFO - 'work_dir': 'build'} 14:41:57 INFO - [mozharness: 2016-08-15 21:41:57.726925Z] Running clobber step. 14:41:57 INFO - Running pre-action listener: _resource_record_pre_action 14:41:57 INFO - Running main action method: clobber 14:41:57 INFO - rmtree: /builds/slave/test/build 14:41:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:41:58 INFO - Running post-action listener: _resource_record_post_action 14:41:58 INFO - [mozharness: 2016-08-15 21:41:58.176689Z] Finished clobber step (success) 14:41:58 INFO - [mozharness: 2016-08-15 21:41:58.176789Z] Running read-buildbot-config step. 14:41:58 INFO - Running pre-action listener: _resource_record_pre_action 14:41:58 INFO - Running main action method: read_buildbot_config 14:41:58 INFO - Using buildbot properties: 14:41:58 INFO - { 14:41:58 INFO - "project": "", 14:41:58 INFO - "product": "firefox", 14:41:58 INFO - "script_repo_revision": "production", 14:41:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:41:58 INFO - "repository": "", 14:41:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:41:58 INFO - "buildid": "20160815113001", 14:41:58 INFO - "pgo_build": "True", 14:41:58 INFO - "basedir": "/builds/slave/test", 14:41:58 INFO - "buildnumber": 1456, 14:41:58 INFO - "slavename": "talos-linux64-ix-056", 14:41:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:41:58 INFO - "platform": "ubuntu64_hw", 14:41:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:41:58 INFO - "branch": "fx-team", 14:41:58 INFO - "repo_path": "integration/fx-team", 14:41:58 INFO - "revision": "59055929012280084afd040bfdf4216083a7636a", 14:41:58 INFO - "stage_platform": "linux64-pgo", 14:41:58 INFO - "builduid": "7c7fd4f8f8c84f6ab6ae85d40126e6f4", 14:41:58 INFO - "slavebuilddir": "test" 14:41:58 INFO - } 14:41:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:41:58 INFO - Running post-action listener: _resource_record_post_action 14:41:58 INFO - [mozharness: 2016-08-15 21:41:58.179230Z] Finished read-buildbot-config step (success) 14:41:58 INFO - [mozharness: 2016-08-15 21:41:58.179317Z] Running download-and-extract step. 14:41:58 INFO - Running pre-action listener: _resource_record_pre_action 14:41:58 INFO - Running main action method: download_and_extract 14:41:58 INFO - mkdir: /builds/slave/test/build/tests 14:41: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')]} 14:41:58 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:41:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:41:58 INFO - Downloaded 1361 bytes. 14:41:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:41:58 INFO - Using the following test package requirements: 14:41:58 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:41:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:41:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:41:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'jsshell-linux-x86_64.zip'], 14:41:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:41:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:41:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:41:58 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:41:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:41:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:41:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:41:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:41: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')]} 14:41:58 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:41:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:41:59 INFO - Downloaded 21836062 bytes. 14:41:59 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 14:42:03 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 14:42: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')]} 14:42:03 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:42:03 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:42:04 INFO - Downloaded 21836062 bytes. 14:42:04 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 14:42: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')]} 14:42:09 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:42:09 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:42:10 INFO - Downloaded 14413719 bytes. 14:42:10 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 14:42:10 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')]} 14:42:10 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:42:10 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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 14:42:12 INFO - Downloaded 59412184 bytes. 14:42:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:42:12 INFO - mkdir: /builds/slave/test/properties 14:42:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:42:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:42:12 INFO - Contents: 14:42:12 INFO - build_url:https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:42:12 INFO - Running post-action listener: _resource_record_post_action 14:42:12 INFO - Running post-action listener: set_extra_try_arguments 14:42:12 INFO - [mozharness: 2016-08-15 21:42:12.727479Z] Finished download-and-extract step (success) 14:42:12 INFO - [mozharness: 2016-08-15 21:42:12.727701Z] Running populate-webroot step. 14:42:12 INFO - Running pre-action listener: _resource_record_pre_action 14:42:12 INFO - Running main action method: populate_webroot 14:42:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:42:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:42:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:42:12 INFO - '--tppagecycles', 14:42:12 INFO - '7'], 14:42:12 INFO - 'tests': ['tsvgm']}}, 14:42:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:42:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:42:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:42:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:42:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['damp', 'tps']}, 14:42:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'tests': ['damp', 'tps']}, 14:42:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['dromaeo_dom']}, 14:42:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:42:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['basic_compositor_video']}, 14:42:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:42:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['a11yr', 14:42:12 INFO - 'ts_paint', 14:42:12 INFO - 'tpaint', 14:42:12 INFO - 'sessionrestore', 14:42:12 INFO - 'sessionrestore_no_auto_restore', 14:42:12 INFO - 'tabpaint']}, 14:42:12 INFO - 'other-e10s': {'tests': ['a11yr', 14:42:12 INFO - 'ts_paint', 14:42:12 INFO - 'tpaint', 14:42:12 INFO - 'sessionrestore', 14:42:12 INFO - 'sessionrestore_no_auto_restore', 14:42:12 INFO - 'tabpaint']}, 14:42:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:42:12 INFO - 'ts_paint', 14:42:12 INFO - 'tpaint', 14:42:12 INFO - 'sessionrestore', 14:42:12 INFO - 'sessionrestore_no_auto_restore', 14:42:12 INFO - 'tabpaint']}, 14:42:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:42:12 INFO - 'ts_paint', 14:42:12 INFO - 'tpaint', 14:42:12 INFO - 'sessionrestore', 14:42:12 INFO - 'sessionrestore_no_auto_restore', 14:42:12 INFO - 'tabpaint']}, 14:42:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['a11yr', 14:42:12 INFO - 'ts_paint', 14:42:12 INFO - 'tpaint', 14:42:12 INFO - 'sessionrestore', 14:42:12 INFO - 'sessionrestore_no_auto_restore', 14:42:12 INFO - 'tabpaint']}, 14:42:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['a11yr', 14:42:12 INFO - 'ts_paint', 14:42:12 INFO - 'tpaint', 14:42:12 INFO - 'sessionrestore', 14:42:12 INFO - 'sessionrestore_no_auto_restore', 14:42:12 INFO - 'tabpaint']}, 14:42:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['tsvgx', 14:42:12 INFO - 'tsvgr_opacity', 14:42:12 INFO - 'tart', 14:42:12 INFO - 'tscrollx', 14:42:12 INFO - 'cart']}, 14:42:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:42:12 INFO - 'tsvgr_opacity', 14:42:12 INFO - 'tart', 14:42:12 INFO - 'tscrollx', 14:42:12 INFO - 'cart']}, 14:42:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'talos_options': ['--disable-e10s'], 14:42:12 INFO - 'tests': ['tp5o']}, 14:42:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'tests': ['tp5o']}, 14:42:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'talos_options': ['--disable-e10s', 14:42:12 INFO - '--xperf_path', 14:42:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:12 INFO - 'tests': ['tp5n']}, 14:42:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:12 INFO - 'talos_options': ['--xperf_path', 14:42:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:12 INFO - 'tests': ['tp5n']}}, 14:42:12 INFO - 'talos.zip': {'path': '', 14:42:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:42:12 INFO - Running post-action listener: _resource_record_post_action 14:42:12 INFO - [mozharness: 2016-08-15 21:42:12.747279Z] Finished populate-webroot step (success) 14:42:12 INFO - [mozharness: 2016-08-15 21:42:12.747367Z] Running create-virtualenv step. 14:42:12 INFO - Running pre-action listener: _resource_record_pre_action 14:42:12 INFO - Running main action method: create_virtualenv 14:42:12 INFO - Creating virtualenv /builds/slave/test/build/venv 14:42:12 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 14:42:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:42:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:42:12 INFO - Using real prefix '/usr' 14:42:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:42:13 INFO - Installing distribute.............................................................................................................................................................................................done. 14:42:15 INFO - Installing pip.................done. 14:42:15 INFO - Return code: 0 14:42:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:15 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:15 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 14:42:15 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 14:42:15 INFO - Using env: {'DISPLAY': ':0', 14:42:15 INFO - 'HOME': '/home/cltbld', 14:42:15 INFO - 'LANG': 'en_US.UTF-8', 14:42:15 INFO - 'LANGUAGE': 'en_US:en', 14:42:15 INFO - 'LOGNAME': 'cltbld', 14:42:15 INFO - 'MAIL': '/var/mail/cltbld', 14:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:15 INFO - 'MOZ_NO_REMOTE': '1', 14:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:15 INFO - 'NO_EM_RESTART': '1', 14:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:15 INFO - 'PWD': '/builds/slave/test', 14:42:15 INFO - 'SHELL': '/bin/bash', 14:42:15 INFO - 'SHLVL': '1', 14:42:15 INFO - 'TERM': 'linux', 14:42:15 INFO - 'TMOUT': '86400', 14:42:15 INFO - 'USER': 'cltbld', 14:42:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:15 INFO - '_': '/tools/buildbot/bin/python'} 14:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:15 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 14:42:15 INFO - Cleaning up... 14:42:15 INFO - Return code: 0 14:42:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:15 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:15 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 14:42:15 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 14:42:15 INFO - Using env: {'DISPLAY': ':0', 14:42:15 INFO - 'HOME': '/home/cltbld', 14:42:15 INFO - 'LANG': 'en_US.UTF-8', 14:42:15 INFO - 'LANGUAGE': 'en_US:en', 14:42:15 INFO - 'LOGNAME': 'cltbld', 14:42:15 INFO - 'MAIL': '/var/mail/cltbld', 14:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:15 INFO - 'MOZ_NO_REMOTE': '1', 14:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:15 INFO - 'NO_EM_RESTART': '1', 14:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:15 INFO - 'PWD': '/builds/slave/test', 14:42:15 INFO - 'SHELL': '/bin/bash', 14:42:15 INFO - 'SHLVL': '1', 14:42:15 INFO - 'TERM': 'linux', 14:42:15 INFO - 'TMOUT': '86400', 14:42:15 INFO - 'USER': 'cltbld', 14:42:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:15 INFO - '_': '/tools/buildbot/bin/python'} 14:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:15 INFO - Downloading/unpacking psutil>=3.1.1 14:42:15 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 14:42:15 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 14:42:15 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 14:42:15 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 14:42:15 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 14:42:15 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 14:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:42:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:42:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:42:17 INFO - Installing collected packages: psutil 14:42:17 INFO - Running setup.py install for psutil 14:42:17 INFO - building 'psutil._psutil_linux' extension 14:42:17 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 14:42:17 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 14:42:17 INFO - building 'psutil._psutil_posix' extension 14:42:17 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 14:42:18 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 14:42:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:42:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:42:18 INFO - Successfully installed psutil 14:42:18 INFO - Cleaning up... 14:42:18 INFO - Return code: 0 14:42:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:42:18 INFO - Using env: {'DISPLAY': ':0', 14:42:18 INFO - 'HOME': '/home/cltbld', 14:42:18 INFO - 'LANG': 'en_US.UTF-8', 14:42:18 INFO - 'LANGUAGE': 'en_US:en', 14:42:18 INFO - 'LOGNAME': 'cltbld', 14:42:18 INFO - 'MAIL': '/var/mail/cltbld', 14:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:18 INFO - 'MOZ_NO_REMOTE': '1', 14:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:18 INFO - 'NO_EM_RESTART': '1', 14:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:18 INFO - 'PWD': '/builds/slave/test', 14:42:18 INFO - 'SHELL': '/bin/bash', 14:42:18 INFO - 'SHLVL': '1', 14:42:18 INFO - 'TERM': 'linux', 14:42:18 INFO - 'TMOUT': '86400', 14:42:18 INFO - 'USER': 'cltbld', 14:42:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:18 INFO - '_': '/tools/buildbot/bin/python'} 14:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:42:18 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 14:42:18 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 14:42:18 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 14:42:18 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 14:42:18 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 14:42:18 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 14:42:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:42:20 INFO - Installing collected packages: mozsystemmonitor 14:42:20 INFO - Running setup.py install for mozsystemmonitor 14:42:20 INFO - Successfully installed mozsystemmonitor 14:42:20 INFO - Cleaning up... 14:42:20 INFO - Return code: 0 14:42:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:20 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:20 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 14:42:20 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 14:42:20 INFO - Using env: {'DISPLAY': ':0', 14:42:20 INFO - 'HOME': '/home/cltbld', 14:42:20 INFO - 'LANG': 'en_US.UTF-8', 14:42:20 INFO - 'LANGUAGE': 'en_US:en', 14:42:20 INFO - 'LOGNAME': 'cltbld', 14:42:20 INFO - 'MAIL': '/var/mail/cltbld', 14:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:20 INFO - 'MOZ_NO_REMOTE': '1', 14:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:20 INFO - 'NO_EM_RESTART': '1', 14:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:20 INFO - 'PWD': '/builds/slave/test', 14:42:20 INFO - 'SHELL': '/bin/bash', 14:42:20 INFO - 'SHLVL': '1', 14:42:20 INFO - 'TERM': 'linux', 14:42:20 INFO - 'TMOUT': '86400', 14:42:20 INFO - 'USER': 'cltbld', 14:42:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:20 INFO - '_': '/tools/buildbot/bin/python'} 14:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:20 INFO - Downloading/unpacking jsonschema==2.5.1 14:42:20 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 14:42:20 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 14:42:20 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 14:42:20 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 14:42:20 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 14:42:20 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 14:42:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:42:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:42:22 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 14:42:22 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 14:42:22 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 14:42:22 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 14:42:22 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 14:42:22 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 14:42:22 INFO - Downloading functools32-3.2.3-2.tar.gz 14:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:42:22 INFO - warning: no files found matching '*.txt' 14:42:22 INFO - no previously-included directories found matching 'build' 14:42:22 INFO - no previously-included directories found matching 'dist' 14:42:22 INFO - no previously-included directories found matching '.git*' 14:42:22 INFO - Installing collected packages: jsonschema, functools32 14:42:22 INFO - Running setup.py install for functools32 14:42:23 INFO - warning: no files found matching '*.txt' 14:42:23 INFO - no previously-included directories found matching 'build' 14:42:23 INFO - no previously-included directories found matching 'dist' 14:42:23 INFO - no previously-included directories found matching '.git*' 14:42:23 INFO - Successfully installed jsonschema functools32 14:42:23 INFO - Cleaning up... 14:42:23 INFO - Return code: 0 14:42:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:42:23 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')]} 14:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:23 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')]} 14:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:23 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:23 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 14:42:23 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 14:42:23 INFO - Using env: {'DISPLAY': ':0', 14:42:23 INFO - 'HOME': '/home/cltbld', 14:42:23 INFO - 'LANG': 'en_US.UTF-8', 14:42:23 INFO - 'LANGUAGE': 'en_US:en', 14:42:23 INFO - 'LOGNAME': 'cltbld', 14:42:23 INFO - 'MAIL': '/var/mail/cltbld', 14:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:23 INFO - 'MOZ_NO_REMOTE': '1', 14:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:23 INFO - 'NO_EM_RESTART': '1', 14:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:23 INFO - 'PWD': '/builds/slave/test', 14:42:23 INFO - 'SHELL': '/bin/bash', 14:42:23 INFO - 'SHLVL': '1', 14:42:23 INFO - 'TERM': 'linux', 14:42:23 INFO - 'TMOUT': '86400', 14:42:23 INFO - 'USER': 'cltbld', 14:42:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:23 INFO - '_': '/tools/buildbot/bin/python'} 14:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:42:23 INFO - Cleaning up... 14:42:23 INFO - Return code: 0 14:42:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:42:23 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')]} 14:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:23 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')]} 14:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:23 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:23 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 14:42:23 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 14:42:23 INFO - Using env: {'DISPLAY': ':0', 14:42:23 INFO - 'HOME': '/home/cltbld', 14:42:23 INFO - 'LANG': 'en_US.UTF-8', 14:42:23 INFO - 'LANGUAGE': 'en_US:en', 14:42:23 INFO - 'LOGNAME': 'cltbld', 14:42:23 INFO - 'MAIL': '/var/mail/cltbld', 14:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:23 INFO - 'MOZ_NO_REMOTE': '1', 14:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:23 INFO - 'NO_EM_RESTART': '1', 14:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:23 INFO - 'PWD': '/builds/slave/test', 14:42:23 INFO - 'SHELL': '/bin/bash', 14:42:23 INFO - 'SHLVL': '1', 14:42:23 INFO - 'TERM': 'linux', 14:42:23 INFO - 'TMOUT': '86400', 14:42:23 INFO - 'USER': 'cltbld', 14:42:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:23 INFO - '_': '/tools/buildbot/bin/python'} 14:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:42:23 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 14:42:23 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 14:42:23 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 14:42:23 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 14:42:23 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 14:42:23 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 14:42:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:42:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:42:25 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 14:42:25 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 14:42:25 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 14:42:25 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 14:42:25 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 14:42:25 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 14:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:42:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:42:25 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 14:42:25 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 14:42:25 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 14:42:25 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 14:42:25 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 14:42:25 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 14:42:26 INFO - Downloading docopt-0.6.1.tar.gz 14:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:42:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:42:26 INFO - Running setup.py install for blobuploader 14:42:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:42:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:42:26 INFO - Running setup.py install for requests 14:42:26 INFO - Running setup.py install for docopt 14:42:26 INFO - Successfully installed blobuploader requests docopt 14:42:26 INFO - Cleaning up... 14:42:26 INFO - Return code: 0 14:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:26 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:26 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 14:42:26 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 14:42:26 INFO - Using env: {'DISPLAY': ':0', 14:42:26 INFO - 'HOME': '/home/cltbld', 14:42:26 INFO - 'LANG': 'en_US.UTF-8', 14:42:26 INFO - 'LANGUAGE': 'en_US:en', 14:42:26 INFO - 'LOGNAME': 'cltbld', 14:42:26 INFO - 'MAIL': '/var/mail/cltbld', 14:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:26 INFO - 'MOZ_NO_REMOTE': '1', 14:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:26 INFO - 'NO_EM_RESTART': '1', 14:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:26 INFO - 'PWD': '/builds/slave/test', 14:42:26 INFO - 'SHELL': '/bin/bash', 14:42:26 INFO - 'SHLVL': '1', 14:42:26 INFO - 'TERM': 'linux', 14:42:26 INFO - 'TMOUT': '86400', 14:42:26 INFO - 'USER': 'cltbld', 14:42:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:26 INFO - '_': '/tools/buildbot/bin/python'} 14:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:42:27 INFO - Running setup.py (path:/tmp/pip-_CwrmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:42:27 INFO - Running setup.py (path:/tmp/pip-A4M8O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:42:27 INFO - Running setup.py (path:/tmp/pip-3pR3Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:42:27 INFO - Running setup.py (path:/tmp/pip-2ng_4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:42:27 INFO - Running setup.py (path:/tmp/pip-WOW879-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:42:27 INFO - Running setup.py (path:/tmp/pip-jciMEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:42:27 INFO - Running setup.py (path:/tmp/pip-gpZcIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:42:27 INFO - Running setup.py (path:/tmp/pip-0OUi4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:42:27 INFO - Running setup.py (path:/tmp/pip-9xABC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:42:27 INFO - Running setup.py (path:/tmp/pip-v8ha5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:42:27 INFO - Running setup.py (path:/tmp/pip-An1iQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:42:27 INFO - Running setup.py (path:/tmp/pip-_m4P1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:42:27 INFO - Running setup.py (path:/tmp/pip-9YLa8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:42:28 INFO - Running setup.py (path:/tmp/pip-jj1ZWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:28 INFO - Running setup.py (path:/tmp/pip-bLCrDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:42:28 INFO - Running setup.py (path:/tmp/pip-F3MhnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:42:28 INFO - Running setup.py (path:/tmp/pip-6aKS97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:42:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:42:28 INFO - Running setup.py install for manifestparser 14:42:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:42:28 INFO - Running setup.py install for mozcrash 14:42:28 INFO - Running setup.py install for mozdebug 14:42:28 INFO - Running setup.py install for mozdevice 14:42:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:42:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:42:28 INFO - Running setup.py install for mozfile 14:42:28 INFO - Running setup.py install for mozhttpd 14:42:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:42:28 INFO - Running setup.py install for mozinfo 14:42:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Running setup.py install for mozInstall 14:42:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Running setup.py install for mozleak 14:42:29 INFO - Running setup.py install for mozlog 14:42:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Running setup.py install for moznetwork 14:42:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Running setup.py install for mozprocess 14:42:29 INFO - Running setup.py install for mozprofile 14:42:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Running setup.py install for mozrunner 14:42:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:42:29 INFO - Running setup.py install for mozscreenshot 14:42:29 INFO - Running setup.py install for moztest 14:42:30 INFO - Running setup.py install for mozversion 14:42:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:42:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:42:30 INFO - Cleaning up... 14:42:30 INFO - Return code: 0 14:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:42:30 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')]} 14:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:30 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')]} 14:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:30 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:30 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 14:42:30 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 14:42:30 INFO - Using env: {'DISPLAY': ':0', 14:42:30 INFO - 'HOME': '/home/cltbld', 14:42:30 INFO - 'LANG': 'en_US.UTF-8', 14:42:30 INFO - 'LANGUAGE': 'en_US:en', 14:42:30 INFO - 'LOGNAME': 'cltbld', 14:42:30 INFO - 'MAIL': '/var/mail/cltbld', 14:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:30 INFO - 'MOZ_NO_REMOTE': '1', 14:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:30 INFO - 'NO_EM_RESTART': '1', 14:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:30 INFO - 'PWD': '/builds/slave/test', 14:42:30 INFO - 'SHELL': '/bin/bash', 14:42:30 INFO - 'SHLVL': '1', 14:42:30 INFO - 'TERM': 'linux', 14:42:30 INFO - 'TMOUT': '86400', 14:42:30 INFO - 'USER': 'cltbld', 14:42:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:30 INFO - '_': '/tools/buildbot/bin/python'} 14:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:42:30 INFO - Running setup.py (path:/tmp/pip-izg1ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:42:30 INFO - Running setup.py (path:/tmp/pip-6ehcHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:42:30 INFO - Running setup.py (path:/tmp/pip-7lmSSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:42:30 INFO - Running setup.py (path:/tmp/pip-KZyd0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:42:30 INFO - Running setup.py (path:/tmp/pip-Tf1I3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:42:30 INFO - Running setup.py (path:/tmp/pip-6WYcsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:42:30 INFO - Running setup.py (path:/tmp/pip-W9XzDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:42:30 INFO - Running setup.py (path:/tmp/pip-Ns1ViZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:42:30 INFO - Running setup.py (path:/tmp/pip-0FccRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:42:30 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)) 14:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:42:30 INFO - Running setup.py (path:/tmp/pip-6poT2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:42:31 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)) 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:42:31 INFO - Running setup.py (path:/tmp/pip-YoRN3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:42:31 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)) 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:42:31 INFO - Running setup.py (path:/tmp/pip-wzgdWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:42:31 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)) 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:42:31 INFO - Running setup.py (path:/tmp/pip-c5ro_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:42:31 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)) 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:42:31 INFO - Running setup.py (path:/tmp/pip-P1Nfdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:42:31 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)) 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:31 INFO - Running setup.py (path:/tmp/pip-VNsltm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:42:31 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)) 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:42:31 INFO - Running setup.py (path:/tmp/pip-Hxti5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:42:31 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)) 14:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:42:31 INFO - Running setup.py (path:/tmp/pip-B_n6Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:42:31 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)) 14:42:31 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)) 14:42:31 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)) 14:42:31 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)) 14:42:31 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)) 14:42:31 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)) 14:42:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:42:31 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 14:42:31 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 14:42:31 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 14:42:31 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 14:42:31 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 14:42:31 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 14:42:33 INFO - Downloading blessings-1.6.tar.gz 14:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:42:33 INFO - Installing collected packages: blessings 14:42:33 INFO - Running setup.py install for blessings 14:42:33 INFO - Successfully installed blessings 14:42:33 INFO - Cleaning up... 14:42:33 INFO - Return code: 0 14:42:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:42:33 INFO - Reading from file tmpfile_stdout 14:42:33 INFO - Current package versions: 14:42:33 INFO - argparse == 1.2.1 14:42:33 INFO - blessings == 1.6 14:42:33 INFO - blobuploader == 1.2.4 14:42:33 INFO - docopt == 0.6.1 14:42:33 INFO - functools32 == 3.2.3-2 14:42:33 INFO - jsonschema == 2.5.1 14:42:33 INFO - manifestparser == 1.1 14:42:33 INFO - mozInstall == 1.12 14:42:33 INFO - mozcrash == 0.17 14:42:33 INFO - mozdebug == 0.1 14:42:33 INFO - mozdevice == 0.48 14:42:33 INFO - mozfile == 1.2 14:42:33 INFO - mozhttpd == 0.7 14:42:33 INFO - mozinfo == 0.9 14:42:33 INFO - mozleak == 0.1 14:42:33 INFO - mozlog == 3.3 14:42:33 INFO - moznetwork == 0.27 14:42:33 INFO - mozprocess == 0.23 14:42:33 INFO - mozprofile == 0.28 14:42:33 INFO - mozrunner == 6.12 14:42:33 INFO - mozscreenshot == 0.1 14:42:33 INFO - mozsystemmonitor == 0.3 14:42:33 INFO - moztest == 0.7 14:42:33 INFO - mozversion == 1.4 14:42:33 INFO - psutil == 3.1.1 14:42:33 INFO - requests == 1.2.3 14:42:33 INFO - wsgiref == 0.1.2 14:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:42: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')]} 14:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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')]} 14:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:33 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 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:33 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 14:42:33 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 14:42:33 INFO - Using env: {'DISPLAY': ':0', 14:42:33 INFO - 'HOME': '/home/cltbld', 14:42:33 INFO - 'LANG': 'en_US.UTF-8', 14:42:33 INFO - 'LANGUAGE': 'en_US:en', 14:42:33 INFO - 'LOGNAME': 'cltbld', 14:42:33 INFO - 'MAIL': '/var/mail/cltbld', 14:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:33 INFO - 'MOZ_NO_REMOTE': '1', 14:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:33 INFO - 'NO_EM_RESTART': '1', 14:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:33 INFO - 'PWD': '/builds/slave/test', 14:42:33 INFO - 'SHELL': '/bin/bash', 14:42:33 INFO - 'SHLVL': '1', 14:42:33 INFO - 'TERM': 'linux', 14:42:33 INFO - 'TMOUT': '86400', 14:42:33 INFO - 'USER': 'cltbld', 14:42:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:33 INFO - '_': '/tools/buildbot/bin/python'} 14:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 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)) 14:42:34 INFO - Cleaning up... 14:42:34 INFO - Return code: 0 14:42:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effcaf69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, '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': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', '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 14:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:42:34 INFO - Using env: {'DISPLAY': ':0', 14:42:34 INFO - 'HOME': '/home/cltbld', 14:42:34 INFO - 'LANG': 'en_US.UTF-8', 14:42:34 INFO - 'LANGUAGE': 'en_US:en', 14:42:34 INFO - 'LOGNAME': 'cltbld', 14:42:34 INFO - 'MAIL': '/var/mail/cltbld', 14:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:34 INFO - 'MOZ_NO_REMOTE': '1', 14:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:34 INFO - 'NO_EM_RESTART': '1', 14:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:34 INFO - 'PWD': '/builds/slave/test', 14:42:34 INFO - 'SHELL': '/bin/bash', 14:42:34 INFO - 'SHLVL': '1', 14:42:34 INFO - 'TERM': 'linux', 14:42:34 INFO - 'TMOUT': '86400', 14:42:34 INFO - 'USER': 'cltbld', 14:42:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:34 INFO - '_': '/tools/buildbot/bin/python'} 14:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:42:34 INFO - Cleaning up... 14:42:34 INFO - Return code: 0 14:42:34 INFO - Running post-action listener: _resource_record_post_action 14:42:34 INFO - Running post-action listener: _start_resource_monitoring 14:42:34 INFO - Starting resource monitoring. 14:42:34 INFO - [mozharness: 2016-08-15 21:42:34.414760Z] Finished create-virtualenv step (success) 14:42:34 INFO - [mozharness: 2016-08-15 21:42:34.415267Z] Running install step. 14:42:34 INFO - Running pre-action listener: _resource_record_pre_action 14:42:34 INFO - Running main action method: install 14:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:42:34 INFO - Reading from file tmpfile_stdout 14:42:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:42:34 INFO - Reading from file tmpfile_stdout 14:42:34 INFO - Output received: 14:42:34 INFO - Usage: mozinstall [options] installer 14:42:34 INFO - Options: 14:42:34 INFO - -h, --help show this help message and exit 14:42:34 INFO - -d DEST, --destination=DEST 14:42:34 INFO - Directory to install application into. [default: 14:42:34 INFO - "/builds/slave/test"] 14:42:34 INFO - --app=APP Application being installed. [default: firefox] 14:42:34 INFO - mkdir: /builds/slave/test/build/application 14:42:34 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'] 14:42:34 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 14:42:51 INFO - Reading from file tmpfile_stdout 14:42:51 INFO - Output received: 14:42:51 INFO - /builds/slave/test/build/application/firefox/firefox 14:42:51 INFO - Running post-action listener: _resource_record_post_action 14:42:51 INFO - [mozharness: 2016-08-15 21:42:51.635986Z] Finished install step (success) 14:42:51 INFO - [mozharness: 2016-08-15 21:42:51.636234Z] Running run-tests step. 14:42:51 INFO - Running pre-action listener: _resource_record_pre_action 14:42:51 INFO - Running main action method: run_tests 14:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:42:51 INFO - Python 2.7.3 14:42:51 INFO - Return code: 0 14:42:51 INFO - grabbing minidump binary from tooltool 14:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:42:51 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 0x206e370>, '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 0x20718f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2071d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:42:51 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 14:42:51 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 14:42:51 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 14:42:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:42:51 INFO - Return code: 0 14:42:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:42:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:42:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:42:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:42:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 14:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 14:42:51 INFO - Using env: {'DISPLAY': ':0', 14:42:51 INFO - 'HOME': '/home/cltbld', 14:42:51 INFO - 'LANG': 'en_US.UTF-8', 14:42:51 INFO - 'LANGUAGE': 'en_US:en', 14:42:51 INFO - 'LOGNAME': 'cltbld', 14:42:51 INFO - 'MAIL': '/var/mail/cltbld', 14:42:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:42:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:51 INFO - 'MOZ_NO_REMOTE': '1', 14:42:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:51 INFO - 'NO_EM_RESTART': '1', 14:42:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:51 INFO - 'PWD': '/builds/slave/test', 14:42:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:42:51 INFO - 'SHELL': '/bin/bash', 14:42:51 INFO - 'SHLVL': '1', 14:42:51 INFO - 'TERM': 'linux', 14:42:51 INFO - 'TMOUT': '86400', 14:42:51 INFO - 'USER': 'cltbld', 14:42:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390', 14:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:51 INFO - '_': '/tools/buildbot/bin/python'} 14:42:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 14:42:51 INFO - mozversion application_buildid: 20160815113001 14:42:51 INFO - mozversion application_changeset: 59055929012280084afd040bfdf4216083a7636a 14:42:51 INFO - mozversion application_display_name: Nightly 14:42:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:42:51 INFO - mozversion application_name: Firefox 14:42:51 INFO - mozversion application_remotingname: firefox 14:42:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:42:51 INFO - mozversion application_vendor: Mozilla 14:42:51 INFO - mozversion application_version: 51.0a1 14:42:51 INFO - mozversion platform_buildid: 20160815113001 14:42:51 INFO - mozversion platform_changeset: 59055929012280084afd040bfdf4216083a7636a 14:42:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:42:51 INFO - mozversion platform_version: 51.0a1 14:42:51 INFO - using testdate: 1471297371 14:42:51 INFO - actual date: 1471297371 14:42:51 INFO - starting webserver on 'localhost:38753' 14:42:51 INFO - SUITE-START | Running 2 tests 14:42:51 INFO - TEST-START | dromaeo_css 14:42:51 INFO - operating with platform_type : linux_ 14:42:51 INFO - Initialising browser for dromaeo_css test... 14:42:51 INFO - TEST-INFO | started process 3890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppc3d0B/profile http://localhost:38753/getInfo.html) 14:42:56 INFO - PROCESS | 3890 | __metrics Screen width/height:1600/1200 14:42:56 INFO - PROCESS | 3890 | colorDepth:24 14:42:56 INFO - PROCESS | 3890 | Browser inner width/height: 1024/697 14:42:56 INFO - PROCESS | 3890 | __metrics 14:42:57 INFO - PROCESS | 3890 | 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" 14:42:57 INFO - PROCESS | 3890 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:58 INFO - TEST-INFO | 3890: exit 0 14:42:58 INFO - Browser initialized. 14:42:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:42:58 INFO - TEST-INFO | started process 3975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppc3d0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:09 INFO - PROCESS | 3975 | RSS: Main: 156094464 14:43:09 INFO - PROCESS | 3975 | 14:44:01 INFO - PROCESS | 3975 | 1471297441532 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] 14:46:11 INFO - PROCESS | 3975 | Cycle 1(1): loaded http://localhost:38753/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38753/tests/dromaeo/cssquery-ext.html) 14:46:12 INFO - PROCESS | 3975 | RSS: Main: 263196672 14:46:12 INFO - PROCESS | 3975 | 14:49:14 INFO - PROCESS | 3975 | Cycle 1(1): loaded http://localhost:38753/tests/dromaeo/cssquery-ext.html (next: http://localhost:38753/tests/dromaeo/cssquery-jquery.html) 14:49:15 INFO - PROCESS | 3975 | RSS: Main: 251195392 14:49:15 INFO - PROCESS | 3975 | 14:52:17 INFO - PROCESS | 3975 | Cycle 1(1): loaded http://localhost:38753/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38753/tests/dromaeo/cssquery-mootools.html) 14:52:18 INFO - PROCESS | 3975 | RSS: Main: 203747328 14:52:18 INFO - PROCESS | 3975 | 14:55:20 INFO - PROCESS | 3975 | Cycle 1(1): loaded http://localhost:38753/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38753/tests/dromaeo/cssquery-prototype.html) 14:55:20 INFO - PROCESS | 3975 | RSS: Main: 231092224 14:55:20 INFO - PROCESS | 3975 | 14:58:23 INFO - PROCESS | 3975 | Cycle 1(1): loaded http://localhost:38753/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38753/tests/dromaeo/cssquery-yui.html) 14:58:24 INFO - PROCESS | 3975 | RSS: Main: 186482688 14:58:24 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | Cycle 1(1): loaded http://localhost:38753/tests/dromaeo/cssquery-yui.html (next: http://localhost:38753/tests/dromaeo/cssquery-dojo.html) 15:01:27 INFO - PROCESS | 3975 | RSS: Main: 276267008 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | __start_tp_report 15:01:27 INFO - PROCESS | 3975 | _x_x_mozilla_page_load 15:01:27 INFO - PROCESS | 3975 | _x_x_mozilla_page_load_details 15:01:27 INFO - PROCESS | 3975 | |i|pagename|runs| 15:01:27 INFO - PROCESS | 3975 | |0;dojo.html;3071.8003329783564;3093.876244950202;3103.1621462205203;3116.329989052353;3120.2199450137464;5259.237410575464;5299.28459657946;5372.731363431827;5443.891122177554;5489.2040654105085;5299.311089558361;5316.441773613773;5340.359156901168;5379.838604841861;5389.434109418504;4779.402574678165;4839.346688197101;4882.096812089757;4889.804407823683;4980.975095124538;4950.702957822542;4982.153033984231;5002.424721157077;5016.322796422491;5035.219540971137;4775.14047471455;4833.299171620095;4870.853874383756;4919.11455937931;4927.6550641455115;4817.879553011167;4827.951720482785;4834.8791280218275;4908.067467181224;4960.627952903546;4846.345743324641;4865.099956508022;4899.828506002273;4928.950710492921;4930.137225985438;5238.711870847102;5254.0805359062015;5431;5437;5466.590005749585;5643.633163844337;5644;5687.772489100431;5692.37383887772;5707.600467967244;5628.549716022709;5827.3298570664065;5828.737706803204;5831.241938548004;5833.854153646151;5190.662606930499;5301.602379821452;5344.866378340573;5355.3305836770405;5395.487428694268;5874.353821079678;5875.353711091777;5924.407559244041;5925.792597259076;5938.61399009063;5673.546116310686;5676.063449530781;5726.914096288559;5727.6849773262875;5732.684702341411;5623.437656234344;5655.4344565543115;5694.829155125353;5734.5125664319;5777.480026797524;5708.229389032427;5713.457221563945;5731.8853622928145;5734.340550836624;5754.654720716687;5692.715364231772;5737.684427356452;5741.052726300197;5744.310682718101;5748.45389687979;4255.3616957456625;4333.371661109121;4403.867883963486;4425.09285596452;4437.800298986554;3931.5085614298214;3936.0159960009996;3938.1729836734035;3950.6839452843706;3991.1419044905483;5476.808311709071;5481.397046324901;5484.561235101182;5488.368837583649;5522.006038912954;5594.272744543184;5782.421757824268;5828.88342233153;5830.067189249699;5858.794942177088;5534.916976245359;5537.889242215133;5539.612227144142;5556.694381809039;5559.471850174227;5015.4733752956145;5041.117804384291;5043.672161309577;5046.167382381939;5081.822136225288;5798.333191682926;5984.790532331522;6064.939350606437;6080.48315893154;6093.146959425684;5864.9413505864395;5866.061430171152;5870.031444811559;5899.557533185114;5918.17145599625;6046.455818976313;6056.03103503455;6064.272287325549;6067.180930574316;6088.903997280355;5590.580706446952;5629.352624448241;5638.520725738358;5670.461306175906;5749.396313387201;5744.626599271034;5788.334341550775;5792.391798861059;5816.534677225727;5834.82495525118;5642.492175704207;5649.802256920988;5650.180723795109;5654.180143879197;5655.547556195576;5416.9729151353995;5525.0883604204855;5585.916211256753;5629.380768115586;5643.068893632505;5583.050881350099;5608.046632072476;5614.185943038318;5668.943310566841;5679.6876171810945;5654.46282603152;5671.234383358194;5704.686242256716;5705.372409035086;5719.685417302088;5397.487238712316;5413.675179489243;5523.972380138073;5546.389897111234;5547 15:01:27 INFO - PROCESS | 3975 | |1;ext.html;586.6040422714666;604.9758009679613;612.2713970375253;613.6287546034647;627.3036929008803;32386.028419147435;43150.352744708856;43912.99999999996;44033.7798311008;44105;43853.56146438535;43914.34128488067;44172.55827441725;44197.779011104896;44274.22903083881;8029.558374289411;8868.645254189825;9027.909720902773;9028.458292502472;10758.73103172423;10502.159827213805;10893.782124357507;10895.400752958583;10904.836427453594;10920.672379828578;10844.67465976022;10980.945095274552;10981.560737570488;10995.725106872313;11013.889861101406;8078.1921807819335;10626.043656070991;10863.51114199863;10896.727581810439;10954.507047182897;10707.946460267727;10790.892091079068;10790.946045269802;10794;10802.189835762349;42262.78868605668;42515;42617;42671.35992960108;42756.57243427557;3461.4115600348;3518.313928783888;3543.0965103898598;3550.538430004083;3598.604153543108;32033.679663203304;32678.509822352684;32777.01668949911;33022.50466243008;33108.6689133108;4457.754823484707;4518.096380723869;4528.32062774704;4657.953420465819;4692.319613656035;337885;339661;340923;341288;341710;56844;57267.42732572621;57376;57400.71299643475;57440.38394240814;59600.403995960354;59603.701981489816;59660;59681.701591491765;59740.402595973486;17364.91317543404;17562;17604.471865844047;17608.38370657021;17611.031393273235;11652.941735291439;11911.880881191077;11915.642530724092;13294.468221271041;13444.731105377838;16383.1329517334;17064.57338566546;17095.230714617872;17100.74348884768;17109.914450427666;5777.24895763548;6742.359475849787;6791.422729068085;6800.387965083166;6880.2431732509385;973.1873885305849;1007.1727435744289;1083.788661211072;1100.4937728644913;1113.4043286841502;31821.840890795396;32249.677503224666;32678.830232881657;32941.50587741186;33033;1092.808758467265;1097.3690128176331;1153.5904753812445;1194.146185477388;1196.682879037056;16043.518694439186;16814.24335904863;17400;17435.215415306342;17713.557161070818;519338;533358;533829;534345;565578;58646.12030819541;60114.69942650346;60140.398596014355;60198;60389.69805151034;1392.9721405571831;1406.711624117074;1414.8514405987223;1417.9220142892034;1432.885369170464;31900.202494937814;34214.657853421144;34277.314453710285;34648.653513464546;35126.824365878005;53623.73188134035;54352.45647543474;54476.455235448724;54547.72726136344;54740;385870;388045;388067;389157;391128;43424.78287608542;43824.56175438205;44573.77713111414;44787.55212447834;44876.55123448724;47223.29165062596;47927;49280.75359623179;49459;49736.25395618996;41040;41342;41586.83199475788;42901;43080.78459607682;40743.59256407517;40982.79508602438;41320.79339603283;41899.58100418957;42914;41360;41943.7902810484;43199.13601728011;43301.35047974346;43362.34956475718;34363.312733744686;36938.8153059233;37199.62800371962;37213.81393093017;38361.616383835804;28213.858930705213;28290.85854570714;28378.43243135167;28519.001834935676;28657.856710716314 15:01:27 INFO - PROCESS | 3975 | |2;jquery.html;384.09162331086986;390.20593093055635;410.85209324643125;414.958504149585;426.1668438203311;15302.387904483807;19013.52466188346;19245.326413575527;19537.413877583658;20053.699194512057;18266.360677376295;19444.027798610085;19452;19623.90188049058;19670.803291967077;5135.178371460548;5176;5320.441353657869;5366.70483123428;5375.489328513785;3926.175503144343;5257.447967963366;5328.813491527797;5332.253484512172;5520.751566179511;5729.541636669077;5847.26909136358;5856.677882716449;5858.238429004245;5871.4715675589405;5836.562257830658;5845.473907348338;6254.374562543755;6547.312532184147;6561.639109848957;5954.404559544011;5961.552883533709;5965.13505541694;5966.373530779249;5971.223740913653;22478;23685.526289474285;23700.76299237003;23840.284791456284;23938.401539961465;2143.2391501017228;2153.569286142762;2165.72928383952;2207.260567709803;2344.1326709117566;10415.739606509822;10446.373217606968;10610.840837387444;10617.78764424715;12855.807162892565;1800.738892860541;1929.6140771845687;1935.7193206985048;1952.4533130723278;1971.6451038813009;78958;84440;85565.57217213936;87077.56461217653;88848.11151888463;10138.341007834468;10579.57681692739;10676.733081673021;11304.36086767414;11327.32036077838;15340.232988350537;15812.130332831575;15820.525384238492;15849.920750396173;15853.128077955824;8298.170182981654;8413.15868413166;8447.408681392244;8616.870746938675;8636.870446943301;8143.263295900384;8163.306118979954;8174.427790054639;8387.370947178864;8423.915760842436;4763.571278584944;4839.588634965997;4861.829835955725;4893.608511319086;4986.426560945465;1918.7121931710076;1948.3375652278294;1980.9504762381055;1983.7817840037585;2005.8696184747944;875.5972252763672;984.6061575369766;1018.8318927376899;1030.2427715629008;1030.5465595138114;19308.4207473776;19644.3124490645;19677.704834427495;19726.605467890848;19772.50568735793;1006.0995409108807;1006.3609607899036;1013.4881884648205;1029.4080903480528;1080.4057768227444;10394.428306443218;10935.56257749697;11031.172662050218;11119.11047116245;11135.104872733147;440669;441507;448121;464876;465307;89099.55450222707;90507.54746226227;91853.54073229725;92830.53584732034;93094;984.8965858584745;1008.2740426892625;1023.4371095897227;1041.598984391015;1043.6816770884952;16608;16608.2526286315;16799.580010499347;17297.30810767555;17966.101694915462;41980.79009604932;42266.788666056476;43063.13873722571;43184.70445886628;43303.566964331214;57441.71279143578;58432.4156758427;59562.702186488794;60041;60638;8051.315638170587;8178.591070446573;8416.116307787594;8593.44142630727;8661.870071949052;11856.644300670994;13000.284984325954;13002.219866808022;13150.21098734079;13518.188908665512;11498.137639677225;11532.481038353126;11636.941815291208;11695.473703683185;12145.939270303592;8726.560117580528;11165.888341116484;11477.770444591228;11486.94256528712;11541.769164616828;10827.404492752974;11374.431278435879;11584.710382240512;11735.76528469443;12174.086943479451;8370.455920365157;8556.31549476028;8633.8704919425;8802.119788021148;9213;10387.740306492398;10810.29733067348;11394.544218231178;11841.348725820162;11932.343721095076 15:01:27 INFO - PROCESS | 3975 | |3;mootools.html;1265.4685032286438;1280.5518068675958;1371.4445649511952;1380.275355438395;1734.5836999120206;7933.127355990843;8300.70947516837;8330.375221858354;8331.333493320542;8555.95722021389;8177;8364.289035431995;8587.355948303886;8590.828183436328;8615.784605384853;1984.4542750743517;2248.955020899581;2306.5848147333472;2348.459854233519;2352.9647055294186;2298.839081264312;2299.1493147535434;2311.872846993415;2326.8254880884;2333.1600623775425;2280.247518318959;2280.703508543895;2280.8175345972363;2307.2270789285526;2344.800691941187;2132.925347612826;2209.3703294561133;2215.977840221601;2224.7775222477785;2247.29210298757;2241.35000849755;2255.537614788964;2259.0399080390766;2263.547290541882;2264.241479104502;8397.118302578203;8433.746987590383;8454.323654107719;8459;8459.11179326168;5094.79620815167;5200.557952574036;5206.349206349207;5220.2430647556275;5222.8694282642855;3247.918802029968;3342.9331413371838;3487.459443786217;3515.068506845688;3519.1026288296575;1160.1588848085155;1163.6276391554707;1170.7482891178438;1173.735909420382;1180.8582970043649;11930.582429614922;12031.819522707166;12112.576059837951;12119.697007574792;12125.93937030318;4432.13573353193;4557.908841823211;4724.196886529298;4737.928931066037;4740.099381117577;10178;10181.490925453698;10202.489875506195;10240.539175737109;10242.180625549938;5326.893462130735;5332.066888294533;5332.840014799563;5347.545458635982;5350.3312085989255;4198.181354635817;4667.533246675305;4724.480307166209;4895.510448955147;4910.508949105061;3895.7857317847224;3977.840886364571;4031;4076.816543255501;4093.85671501496;1290.0324756432676;1301.9283939383236;1307.8561358250586;1326.2241588670736;1341.7651910915552;963.5519483440094;994.5872462927948;998.3211416236884;1004.7789486313;1018.1651046142092;5829.417058294137;5954.136650185699;5981.940180598225;6048.395160483917;6143.938560614426;461.7045091141672;472.15012976641907;472.25148140197484;475.40099474662173;483.8500064979867;4089.0390758171807;4316.956830431718;4362.367456718822;4373.431453910971;4456.442944631921;10381.896181038244;10915.56337746497;10932.180086493387;10948.124150067975;10954.890451095547;10744.30162039465;10751.193660475496;10756;10781.299215550964;10794.73013174677;7642.388608911274;7978.960105199437;8099.230573095547;8178.46839955401;8185.3451723861945;6088.6042407243385;6233.2208473940755;6298.212723409574;6324.146240257691;6369.299377068426;9885.703428897144;10001.199904007808;10004.84992725095;10026.448545330077;10193.796124077626;9471.621135154517;9824.607015719577;9841.114299713061;10120.949395252977;10159.288849780445;6717;7417.888731669137;7508.474406791473;7612.657430415534;7673.846523069619;8379.078301386964;8562.229399354088;8580.828383432421;8588.699395521127;8589.65641374338;7568.21350328633;7638.618069096412;7732.613369331623;7835.059792824897;7956.482828616122;7312.415006799337;7440.107187137578;7481.925180748123;7489.325960663567;7777.805554860947;7100.7869763907165;7261;7275.490715649854;7282.781516554512;7283.308085731847;5242.68543887368;5317.415084340642;5406.0809662356705;5514.09017512106;5730.111832665943;5426.8371948841595;5450.672959622435;5477.561795056466;5584.888302234014;5750.683712395691 15:01:27 INFO - PROCESS | 3975 | |4;prototype.html;325.39314179056055;333.80138817403645;342.84743289236286;344.47811565478304;347.0906225688696;5154.252633368159;5210.8697282567955;5212.869678258041;5235.110031294679;5268.288781014571;4930.285108659242;5004.224345226496;5141.768620412081;5146.150885103953;5192.454792246816;4107.568705285947;4111.650509706664;4121.9175616487655;4130.173965206963;4137.482814648169;4083.7549747015128;4109.8972525686795;4117.341225403936;4125.814338354766;4145.502539695226;3896.4544963705102;3917.4319723640056;4045.757254564721;4069.857554985576;4085.9182816343655;4052.756834589934;4055.7972101395108;4079.73481723687;4080.4287399764057;4082.3672330788777;3653.963460365389;3655.574326012857;3667.1382225177063;3671.229041901204;3682.5949145593963;4791.0178413425165;5030.170021946375;5059.595232381401;5069.188929771256;5076.213186956028;4635.605973492257;4636.814527418899;4649.767511624439;4655.394798676184;4660.481336590852;5419.566434685215;5427.945720542783;5428.022955867942;5433.157860531624;5446.2919820423485;3772.6609502108868;3904.1996390739832;3925.8429662813455;3957.7427467214825;3959.0894094358173;5582.804601838916;5623.775048998076;5644.3508996465525;5647.519960803295;5652.943470565283;4040.8989775255855;4045.5145382554283;4048.9392659110135;4050.3721923101966;4054.614811592894;4000.659943904801;4095.5904409559403;4100.2414553307735;4109.746527309139;4119.134981653826;4617.2612382018715;4618.822200338892;4623.9075218495445;4634.351190833286;4643.674942754043;5418.214358917935;5424.240606315119;5444.373897001817;5445.393608885388;5498.917516237259;1354.674878029266;1363.8611759180997;1368.1244003837553;1368.322680273271;1369.7534443800212;943.429225318686;970.3983530211315;972.9610815567439;979.4466126638569;980.2158273381267;5175.378954525406;5195.428502864682;5197.896042079213;5241.9737901310245;5254.238135470412;5514.172874068921;5522.861928451821;5529.30883639545;5544.085225937756;5553.278073850373;5044.823431179964;5202.869928251748;5278.97360513195;5339.866503337447;5349.518543331119;2955.1725516855313;2959.5116805726816;2961.711655429895;2964.288570743049;2984.4329577380227;5673.546116310686;5762.567807414461;5787.958167529885;5788.18965344852;5790.899729051467;5692.402297758676;5696.8860622787315;5717.542596592262;5718.170865224519;5723.313202415654;5792.4497172768515;5801.6519008859605;5809.970950145223;5813.941860581509;5824.475797178275;5383.111786555174;5557.916631250454;5572.554195664418;5577.52591029767;5594.916076258941;5497.367802702581;5506.531944784578;5517;5532.391436942014;5543.695096769717;5515.365732940763;5741.598088133791;5759.078547432391;5785.652860828363;5789.623674461315;3937.153511994935;3968.2460332536725;3976.151089743283;3977.5425826030378;3978.761274323434;5330.706811125426;5467.976848566056;5538.944610553843;5584.274044374205;5610.102383618601;5456.372517160418;5463;5464.398916119303;5465.590080744039;5476.91784623223;5395.892082158413;5428.891422171613;5436.293281873489;5471.50756431923;5478.424765399575;5233.321845797353;5387.0572649785345;5449.700266485382;5458.6724796512335;5460.890782184413;5466.945330546644;5484.723839606519;5526.696031718294;5532.474414930575;5541.418151094077;5178.948210517847;5290.550303224115;5348.598855085962;5358;5420.620556561161 15:01:27 INFO - PROCESS | 3975 | |5;yui.html;706.1103010207138;706.194937770941;720.3660778514906;738.5790099643206;762.8893810397492;15211.46759863405;15591.1424871632;17034.31862725491;17117.05856177913;17154.742678859828;16194.271257793398;16194.514164575081;16827.15864206791;16832.158392080408;16859.915700421512;817.5135794202455;838.9958050209771;842.1999100854182;842.418731075559;843.0136740014198;660.3495556876472;780.0366547314063;819.4100247821589;819.9303059239942;825.9710910118117;867.5792240763225;870.7431307764193;871.3203701113142;871.5816408124105;871.9128087191293;858.4720396955889;860.2257967828941;861.2679222660782;861.4443683823961;863.2489733931457;502.5025225027233;599.6641880546907;624.1418050181001;624.6970219443566;627.1345543150469;15643.139627320494;15652.530424087296;15653;15678;15717.349678283845;14317.284135793168;14590.927045364811;14896.851031489654;15167;15172;13181.736365272642;13226.272555009471;13270.336483175803;13500;13683.04218704691;4565.4749703784155;4681.157391669498;4827.227643577011;4911.09144808208;4935.383077115361;64604;86260;86702.13297867004;87392.56303718504;87599.56200219021;11698.239614425205;12178.269303841798;12200.267983920992;12428.875711242772;12823.294718790556;23055.423614409774;23070.19254326124;23089.76910230876;23101.88449057744;23119.88440057789;9060.184583387527;9127;9175.265978721687;9226.400283981655;9360.204382627553;4993.275974983607;5083.542481176712;5115.769790359443;5140.948590514122;5351.866203344947;3508;3632.9091772705365;3634.945475817865;3638.1086633774894;3638.290533345972;613.190588423277;618.3785295777805;619.6096459230656;625.6340041076021;631.8420394901275;564.9661020338793;590.271015296109;643.2538255623455;643.5045015338256;651.2835880531378;9247.029061948533;9637.42175469474;9712.854307185398;9768.462734549526;10012.799744005079;622.17561730707;631.6557476175495;642.3672682407824;643.1381948189448;649.6232185332495;4398.2962725964335;4618.076384723069;4629.907401852011;4727.64542659302;4783.604773622271;125638;125926;129735.35132324467;130113;131693.68306316814;70830;110462.44768776266;110889;114846.85153148361;115877;73366.63316683382;74513.25486745172;75249.62375188089;97033.5148324268;98629;9688.660896868576;9826.901730982885;10012.59949602037;10026.448545330077;10226.284160109019;50875.491245087076;51504.48495514997;52262.47737522576;52805.47194528006;53049;59375.70312148584;74540;75896.62051689706;78609;78718.60640696759;12158.574449894566;12199.14605977573;12260.693482663004;12661.303628300164;12666.683332916751;13590.728185436039;14002.859971400156;14229.928850355682;14905.658490735452;15109.622259443602;13105.475780968654;13777.793333100211;13820.516281930084;14057.156570605797;14152.22162781057;13155.73688526205;13360.198388096745;13532.79700804469;14440.783388248974;14908.105513669214;13068.673283167996;13354.799678005033;13459.46162153542;13895.72208555803;14528.346224419714;10614.953298754504;10944.671659850217;11120.277181983145;11206.271592346471;11437.942810285895;9677.225821934087;9998.300118991601;10362.948185259025;10719.624813131815;11113.999740023437 15:01:27 INFO - PROCESS | 3975 | __end_tp_report 15:01:27 INFO - PROCESS | 3975 | __start_cc_report 15:01:27 INFO - PROCESS | 3975 | _x_x_mozilla_cycle_collect,942 15:01:27 INFO - PROCESS | 3975 | __end_cc_report 15:01:27 INFO - PROCESS | 3975 | __startTimestamp1471298487272__endTimestamp 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | ------- Summary: start ------- 15:01:27 INFO - PROCESS | 3975 | Number of tests: 6 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | [#0] dojo.html Cycles:165 Average:5358.93 Median:5583.05 stddev:615.85 (11.0%) stddev-sans-first:591.02 15:01:27 INFO - PROCESS | 3975 | Values: 3071.8 3093.9 3103.2 3116.3 3120.2 5259.2 5299.3 5372.7 5443.9 5489.2 5299.3 5316.4 5340.4 5379.8 5389.4 4779.4 4839.3 4882.1 4889.8 4981.0 4950.7 4982.2 5002.4 5016.3 5035.2 4775.1 4833.3 4870.9 4919.1 4927.7 4817.9 4828.0 4834.9 4908.1 4960.6 4846.3 4865.1 4899.8 4929.0 4930.1 5238.7 5254.1 5431.0 5437.0 5466.6 5643.6 5644.0 5687.8 5692.4 5707.6 5628.5 5827.3 5828.7 5831.2 5833.9 5190.7 5301.6 5344.9 5355.3 5395.5 5874.4 5875.4 5924.4 5925.8 5938.6 5673.5 5676.1 5726.9 5727.7 5732.7 5623.4 5655.4 5694.8 5734.5 5777.5 5708.2 5713.5 5731.9 5734.3 5754.7 5692.7 5737.7 5741.1 5744.3 5748.5 4255.4 4333.4 4403.9 4425.1 4437.8 3931.5 3936.0 3938.2 3950.7 3991.1 5476.8 5481.4 5484.6 5488.4 5522.0 5594.3 5782.4 5828.9 5830.1 5858.8 5534.9 5537.9 5539.6 5556.7 5559.5 5015.5 5041.1 5043.7 5046.2 5081.8 5798.3 5984.8 6064.9 6080.5 6093.1 5864.9 5866.1 5870.0 5899.6 5918.2 6046.5 6056.0 6064.3 6067.2 6088.9 5590.6 5629.4 5638.5 5670.5 5749.4 5744.6 5788.3 5792.4 5816.5 5834.8 5642.5 5649.8 5650.2 5654.2 5655.5 5417.0 5525.1 5585.9 5629.4 5643.1 5583.1 5608.0 5614.2 5668.9 5679.7 5654.5 5671.2 5704.7 5705.4 5719.7 5397.5 5413.7 5524.0 5546.4 5547.0 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | [#1] ext.html Cycles:180 Average:59557.30 Median:386957.50 stddev:113793.24 (29.4%) stddev-sans-first:114026.32 15:01:27 INFO - PROCESS | 3975 | Values: 586.6 605.0 612.3 613.6 627.3 32386.0 43150.4 43913.0 44033.8 44105.0 43853.6 43914.3 44172.6 44197.8 44274.2 8029.6 8868.6 9027.9 9028.5 10758.7 10502.2 10893.8 10895.4 10904.8 10920.7 10844.7 10980.9 10981.6 10995.7 11013.9 8078.2 10626.0 10863.5 10896.7 10954.5 10707.9 10790.9 10790.9 10794.0 10802.2 42262.8 42515.0 42617.0 42671.4 42756.6 3461.4 3518.3 3543.1 3550.5 3598.6 32033.7 32678.5 32777.0 33022.5 33108.7 4457.8 4518.1 4528.3 4658.0 4692.3 337885.0 339661.0 340923.0 341288.0 341710.0 56844.0 57267.4 57376.0 57400.7 57440.4 59600.4 59603.7 59660.0 59681.7 59740.4 17364.9 17562.0 17604.5 17608.4 17611.0 11652.9 11911.9 11915.6 13294.5 13444.7 16383.1 17064.6 17095.2 17100.7 17109.9 5777.2 6742.4 6791.4 6800.4 6880.2 973.2 1007.2 1083.8 1100.5 1113.4 31821.8 32249.7 32678.8 32941.5 33033.0 1092.8 1097.4 1153.6 1194.1 1196.7 16043.5 16814.2 17400.0 17435.2 17713.6 519338.0 533358.0 533829.0 534345.0 565578.0 58646.1 60114.7 60140.4 60198.0 60389.7 1393.0 1406.7 1414.9 1417.9 1432.9 31900.2 34214.7 34277.3 34648.7 35126.8 53623.7 54352.5 54476.5 54547.7 54740.0 385870.0 388045.0 388067.0 389157.0 391128.0 43424.8 43824.6 44573.8 44787.6 44876.6 47223.3 47927.0 49280.8 49459.0 49736.3 41040.0 41342.0 41586.8 42901.0 43080.8 40743.6 40982.8 41320.8 41899.6 42914.0 41360.0 41943.8 43199.1 43301.4 43362.3 34363.3 36938.8 37199.6 37213.8 38361.6 28213.9 28290.9 28378.4 28519.0 28657.9 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | [#2] jquery.html Cycles:180 Average:28111.29 Median:12411.07 stddev:74880.15 (603.3%) stddev-sans-first:75061.27 15:01:27 INFO - PROCESS | 3975 | Values: 384.1 390.2 410.9 415.0 426.2 15302.4 19013.5 19245.3 19537.4 20053.7 18266.4 19444.0 19452.0 19623.9 19670.8 5135.2 5176.0 5320.4 5366.7 5375.5 3926.2 5257.4 5328.8 5332.3 5520.8 5729.5 5847.3 5856.7 5858.2 5871.5 5836.6 5845.5 6254.4 6547.3 6561.6 5954.4 5961.6 5965.1 5966.4 5971.2 22478.0 23685.5 23700.8 23840.3 23938.4 2143.2 2153.6 2165.7 2207.3 2344.1 10415.7 10446.4 10610.8 10617.8 12855.8 1800.7 1929.6 1935.7 1952.5 1971.6 78958.0 84440.0 85565.6 87077.6 88848.1 10138.3 10579.6 10676.7 11304.4 11327.3 15340.2 15812.1 15820.5 15849.9 15853.1 8298.2 8413.2 8447.4 8616.9 8636.9 8143.3 8163.3 8174.4 8387.4 8423.9 4763.6 4839.6 4861.8 4893.6 4986.4 1918.7 1948.3 1981.0 1983.8 2005.9 875.6 984.6 1018.8 1030.2 1030.5 19308.4 19644.3 19677.7 19726.6 19772.5 1006.1 1006.4 1013.5 1029.4 1080.4 10394.4 10935.6 11031.2 11119.1 11135.1 440669.0 441507.0 448121.0 464876.0 465307.0 89099.6 90507.5 91853.5 92830.5 93094.0 984.9 1008.3 1023.4 1041.6 1043.7 16608.0 16608.3 16799.6 17297.3 17966.1 41980.8 42266.8 43063.1 43184.7 43303.6 57441.7 58432.4 59562.7 60041.0 60638.0 8051.3 8178.6 8416.1 8593.4 8661.9 11856.6 13000.3 13002.2 13150.2 13518.2 11498.1 11532.5 11636.9 11695.5 12145.9 8726.6 11165.9 11477.8 11486.9 11541.8 10827.4 11374.4 11584.7 11735.8 12174.1 8370.5 8556.3 8633.9 8802.1 9213.0 10387.7 10810.3 11394.5 11841.3 11932.3 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | [#3] mootools.html Cycles:180 Average:5747.72 Median:4724.34 stddev:3245.63 (68.7%) stddev-sans-first:3237.25 15:01:27 INFO - PROCESS | 3975 | Values: 1265.5 1280.6 1371.4 1380.3 1734.6 7933.1 8300.7 8330.4 8331.3 8556.0 8177.0 8364.3 8587.4 8590.8 8615.8 1984.5 2249.0 2306.6 2348.5 2353.0 2298.8 2299.1 2311.9 2326.8 2333.2 2280.2 2280.7 2280.8 2307.2 2344.8 2132.9 2209.4 2216.0 2224.8 2247.3 2241.4 2255.5 2259.0 2263.5 2264.2 8397.1 8433.7 8454.3 8459.0 8459.1 5094.8 5200.6 5206.3 5220.2 5222.9 3247.9 3342.9 3487.5 3515.1 3519.1 1160.2 1163.6 1170.7 1173.7 1180.9 11930.6 12031.8 12112.6 12119.7 12125.9 4432.1 4557.9 4724.2 4737.9 4740.1 10178.0 10181.5 10202.5 10240.5 10242.2 5326.9 5332.1 5332.8 5347.5 5350.3 4198.2 4667.5 4724.5 4895.5 4910.5 3895.8 3977.8 4031.0 4076.8 4093.9 1290.0 1301.9 1307.9 1326.2 1341.8 963.6 994.6 998.3 1004.8 1018.2 5829.4 5954.1 5981.9 6048.4 6143.9 461.7 472.2 472.3 475.4 483.9 4089.0 4317.0 4362.4 4373.4 4456.4 10381.9 10915.6 10932.2 10948.1 10954.9 10744.3 10751.2 10756.0 10781.3 10794.7 7642.4 7979.0 8099.2 8178.5 8185.3 6088.6 6233.2 6298.2 6324.1 6369.3 9885.7 10001.2 10004.8 10026.4 10193.8 9471.6 9824.6 9841.1 10120.9 10159.3 6717.0 7417.9 7508.5 7612.7 7673.8 8379.1 8562.2 8580.8 8588.7 8589.7 7568.2 7638.6 7732.6 7835.1 7956.5 7312.4 7440.1 7481.9 7489.3 7777.8 7100.8 7261.0 7275.5 7282.8 7283.3 5242.7 5317.4 5406.1 5514.1 5730.1 5426.8 5450.7 5477.6 5584.9 5750.7 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | [#4] prototype.html Cycles:180 Average:4594.21 Median:5238.54 stddev:1338.99 (25.6%) stddev-sans-first:1303.85 15:01:27 INFO - PROCESS | 3975 | Values: 325.4 333.8 342.8 344.5 347.1 5154.3 5210.9 5212.9 5235.1 5268.3 4930.3 5004.2 5141.8 5146.2 5192.5 4107.6 4111.7 4121.9 4130.2 4137.5 4083.8 4109.9 4117.3 4125.8 4145.5 3896.5 3917.4 4045.8 4069.9 4085.9 4052.8 4055.8 4079.7 4080.4 4082.4 3654.0 3655.6 3667.1 3671.2 3682.6 4791.0 5030.2 5059.6 5069.2 5076.2 4635.6 4636.8 4649.8 4655.4 4660.5 5419.6 5427.9 5428.0 5433.2 5446.3 3772.7 3904.2 3925.8 3957.7 3959.1 5582.8 5623.8 5644.4 5647.5 5652.9 4040.9 4045.5 4048.9 4050.4 4054.6 4000.7 4095.6 4100.2 4109.7 4119.1 4617.3 4618.8 4623.9 4634.4 4643.7 5418.2 5424.2 5444.4 5445.4 5498.9 1354.7 1363.9 1368.1 1368.3 1369.8 943.4 970.4 973.0 979.4 980.2 5175.4 5195.4 5197.9 5242.0 5254.2 5514.2 5522.9 5529.3 5544.1 5553.3 5044.8 5202.9 5279.0 5339.9 5349.5 2955.2 2959.5 2961.7 2964.3 2984.4 5673.5 5762.6 5788.0 5788.2 5790.9 5692.4 5696.9 5717.5 5718.2 5723.3 5792.4 5801.7 5810.0 5813.9 5824.5 5383.1 5557.9 5572.6 5577.5 5594.9 5497.4 5506.5 5517.0 5532.4 5543.7 5515.4 5741.6 5759.1 5785.7 5789.6 3937.2 3968.2 3976.2 3977.5 3978.8 5330.7 5468.0 5538.9 5584.3 5610.1 5456.4 5463.0 5464.4 5465.6 5476.9 5395.9 5428.9 5436.3 5471.5 5478.4 5233.3 5387.1 5449.7 5458.7 5460.9 5466.9 5484.7 5526.7 5532.5 5541.4 5178.9 5290.6 5348.6 5358.0 5420.6 15:01:27 INFO - PROCESS | 3975 | 15:01:27 INFO - PROCESS | 3975 | [#5] yui.html Cycles:180 Average:21674.47 Median:4704.40 stddev:31912.51 (678.4%) stddev-sans-first:31963.20 15:01:27 INFO - PROCESS | 3975 | Values: 706.1 706.2 720.4 738.6 762.9 15211.5 15591.1 17034.3 17117.1 17154.7 16194.3 16194.5 16827.2 16832.2 16859.9 817.5 839.0 842.2 842.4 843.0 660.3 780.0 819.4 819.9 826.0 867.6 870.7 871.3 871.6 871.9 858.5 860.2 861.3 861.4 863.2 502.5 599.7 624.1 624.7 627.1 15643.1 15652.5 15653.0 15678.0 15717.3 14317.3 14590.9 14896.9 15167.0 15172.0 13181.7 13226.3 13270.3 13500.0 13683.0 4565.5 4681.2 4827.2 4911.1 4935.4 64604.0 86260.0 86702.1 87392.6 87599.6 11698.2 12178.3 12200.3 12428.9 12823.3 23055.4 23070.2 23089.8 23101.9 23119.9 9060.2 9127.0 9175.3 9226.4 9360.2 4993.3 5083.5 5115.8 5140.9 5351.9 3508.0 3632.9 3634.9 3638.1 3638.3 613.2 618.4 619.6 625.6 631.8 565.0 590.3 643.3 643.5 651.3 9247.0 9637.4 9712.9 9768.5 10012.8 622.2 631.7 642.4 643.1 649.6 4398.3 4618.1 4629.9 4727.6 4783.6 125638.0 125926.0 129735.4 130113.0 131693.7 70830.0 110462.4 110889.0 114846.9 115877.0 73366.6 74513.3 75249.6 97033.5 98629.0 9688.7 9826.9 10012.6 10026.4 10226.3 50875.5 51504.5 52262.5 52805.5 53049.0 59375.7 74540.0 75896.6 78609.0 78718.6 12158.6 12199.1 12260.7 12661.3 12666.7 13590.7 14002.9 14229.9 14905.7 15109.6 13105.5 13777.8 13820.5 14057.2 14152.2 13155.7 13360.2 13532.8 14440.8 14908.1 13068.7 13354.8 13459.5 13895.7 14528.3 10615.0 10944.7 11120.3 11206.3 11437.9 9677.2 9998.3 10362.9 10719.6 11114.0 15:01:27 INFO - PROCESS | 3975 | -------- Summary: end -------- 15:01:27 INFO - PROCESS | 3975 | 15:01:28 INFO - TEST-INFO | 3975: exit 0 15:01:28 INFO - TEST-OK | dromaeo_css | took 1116135ms 15:01:28 INFO - TEST-START | kraken 15:01:28 INFO - operating with platform_type : linux_ 15:01:28 INFO - Initialising browser for kraken test... 15:01:28 INFO - TEST-INFO | started process 4277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpORNmwr/profile http://localhost:38753/getInfo.html) 15:01:32 INFO - PROCESS | 4277 | __metrics Screen width/height:1600/1200 15:01:32 INFO - PROCESS | 4277 | colorDepth:24 15:01:32 INFO - PROCESS | 4277 | Browser inner width/height: 1024/697 15:01:32 INFO - PROCESS | 4277 | __metrics 15:01:33 INFO - PROCESS | 4277 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:01:33 INFO - PROCESS | 4277 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:01:34 INFO - TEST-INFO | 4277: exit 0 15:01:34 INFO - Browser initialized. 15:01:34 INFO - Running cycle 1/1 for kraken test... 15:01:34 INFO - TEST-INFO | started process 4362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpORNmwr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:45 INFO - PROCESS | 4362 | RSS: Main: 156303360 15:01:45 INFO - PROCESS | 4362 | 15:01:48 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38753/tests/kraken/driver.html?testName=audio-beat-detection) 15:01:49 INFO - PROCESS | 4362 | RSS: Main: 203878400 15:01:49 INFO - PROCESS | 4362 | 15:01:51 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38753/tests/kraken/driver.html?testName=audio-dft) 15:01:52 INFO - PROCESS | 4362 | RSS: Main: 195342336 15:01:52 INFO - PROCESS | 4362 | 15:01:55 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38753/tests/kraken/driver.html?testName=audio-fft) 15:01:56 INFO - PROCESS | 4362 | RSS: Main: 275230720 15:01:56 INFO - PROCESS | 4362 | 15:01:58 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38753/tests/kraken/driver.html?testName=audio-oscillator) 15:01:59 INFO - PROCESS | 4362 | RSS: Main: 186454016 15:01:59 INFO - PROCESS | 4362 | 15:02:01 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38753/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:02:01 INFO - PROCESS | 4362 | RSS: Main: 190681088 15:02:01 INFO - PROCESS | 4362 | 15:02:04 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38753/tests/kraken/driver.html?testName=imaging-darkroom) 15:02:05 INFO - PROCESS | 4362 | RSS: Main: 225570816 15:02:05 INFO - PROCESS | 4362 | 15:02:08 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38753/tests/kraken/driver.html?testName=imaging-desaturate) 15:02:09 INFO - PROCESS | 4362 | RSS: Main: 225665024 15:02:09 INFO - PROCESS | 4362 | 15:02:12 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38753/tests/kraken/driver.html?testName=json-parse-financial) 15:02:12 INFO - PROCESS | 4362 | RSS: Main: 226111488 15:02:12 INFO - PROCESS | 4362 | 15:02:14 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38753/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:02:15 INFO - PROCESS | 4362 | RSS: Main: 188841984 15:02:15 INFO - PROCESS | 4362 | 15:02:16 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:02:17 INFO - PROCESS | 4362 | RSS: Main: 197099520 15:02:17 INFO - PROCESS | 4362 | 15:02:19 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:02:20 INFO - PROCESS | 4362 | RSS: Main: 193445888 15:02:20 INFO - PROCESS | 4362 | 15:02:22 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:02:23 INFO - PROCESS | 4362 | RSS: Main: 189358080 15:02:23 INFO - PROCESS | 4362 | 15:02:26 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:02:26 INFO - PROCESS | 4362 | RSS: Main: 192135168 15:02:26 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | Cycle 1(1): loaded http://localhost:38753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38753/tests/kraken/driver.html?testName=ai-astar) 15:02:28 INFO - PROCESS | 4362 | RSS: Main: 243474432 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | __start_tp_report 15:02:28 INFO - PROCESS | 4362 | _x_x_mozilla_page_load 15:02:28 INFO - PROCESS | 4362 | _x_x_mozilla_page_load_details 15:02:28 INFO - PROCESS | 4362 | |i|pagename|runs| 15:02:28 INFO - PROCESS | 4362 | |0;ai-astar;103;111;111;110;106;114;111;111;112;111 15:02:28 INFO - PROCESS | 4362 | |1;audio-beat-detection;152;118;121;180;120;119;157;121;161;117 15:02:28 INFO - PROCESS | 4362 | |2;audio-dft;161;160;161;161;161;161;163;162;163;161 15:02:28 INFO - PROCESS | 4362 | |3;audio-fft;74;78;76;112;77;76;77;75;104;75 15:02:28 INFO - PROCESS | 4362 | |4;audio-oscillator;84;85;126;85;85;86;117;86;86;124 15:02:28 INFO - PROCESS | 4362 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;118;117;117 15:02:28 INFO - PROCESS | 4362 | |6;imaging-darkroom;146;146;147;146;146;146;146;145;146;146 15:02:28 INFO - PROCESS | 4362 | |7;imaging-desaturate;96;96;95;96;95;95;94;96;96;95 15:02:28 INFO - PROCESS | 4362 | |8;json-parse-financial;52;51;52;52;52;52;52;51;52;53 15:02:28 INFO - PROCESS | 4362 | |9;json-stringify-tinderbox;63;64;63;63;63;62;63;63;63;65 15:02:28 INFO - PROCESS | 4362 | |10;stanford-crypto-aes;80;84;78;80;79;79;79;79;78;84 15:02:28 INFO - PROCESS | 4362 | |11;stanford-crypto-ccm;135;124;126;137;133;126;127;121;152;126 15:02:28 INFO - PROCESS | 4362 | |12;stanford-crypto-pbkdf2;165;167;162;165;167;163;168;162;161;168 15:02:28 INFO - PROCESS | 4362 | |13;stanford-crypto-sha256-iterative;68;64;66;64;66;66;64;71;63;67 15:02:28 INFO - PROCESS | 4362 | __end_tp_report 15:02:28 INFO - PROCESS | 4362 | __start_cc_report 15:02:28 INFO - PROCESS | 4362 | _x_x_mozilla_cycle_collect,1698 15:02:28 INFO - PROCESS | 4362 | __end_cc_report 15:02:28 INFO - PROCESS | 4362 | __startTimestamp1471298548701__endTimestamp 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | ------- Summary: start ------- 15:02:28 INFO - PROCESS | 4362 | Number of tests: 14 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.16 (2.8%) stddev-sans-first:2.11 15:02:28 INFO - PROCESS | 4362 | Values: 103.0 111.0 111.0 110.0 106.0 114.0 111.0 111.0 112.0 111.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:136.50 stddev:23.42 (17.2%) stddev-sans-first:24.16 15:02:28 INFO - PROCESS | 4362 | Values: 152.0 118.0 121.0 180.0 120.0 119.0 157.0 121.0 161.0 117.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 15:02:28 INFO - PROCESS | 4362 | Values: 161.0 160.0 161.0 161.0 161.0 161.0 163.0 162.0 163.0 161.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:13.67 (18.0%) stddev-sans-first:14.16 15:02:28 INFO - PROCESS | 4362 | Values: 74.0 78.0 76.0 112.0 77.0 76.0 77.0 75.0 104.0 75.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:85.00 stddev:18.04 (21.2%) stddev-sans-first:18.57 15:02:28 INFO - PROCESS | 4362 | Values: 84.0 85.0 126.0 85.0 85.0 86.0 117.0 86.0 86.0 124.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:02:28 INFO - PROCESS | 4362 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 15:02:28 INFO - PROCESS | 4362 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 15:02:28 INFO - PROCESS | 4362 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 94.0 96.0 96.0 95.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 15:02:28 INFO - PROCESS | 4362 | Values: 52.0 51.0 52.0 52.0 52.0 52.0 52.0 51.0 52.0 53.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 15:02:28 INFO - PROCESS | 4362 | Values: 63.0 64.0 63.0 63.0 63.0 62.0 63.0 63.0 63.0 65.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.21 (2.8%) stddev-sans-first:2.35 15:02:28 INFO - PROCESS | 4362 | Values: 80.0 84.0 78.0 80.0 79.0 79.0 79.0 79.0 78.0 84.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:130.00 stddev:9.04 (7.0%) stddev-sans-first:9.46 15:02:28 INFO - PROCESS | 4362 | Values: 135.0 124.0 126.0 137.0 133.0 126.0 127.0 121.0 152.0 126.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:166.00 stddev:2.66 (1.6%) stddev-sans-first:2.82 15:02:28 INFO - PROCESS | 4362 | Values: 165.0 167.0 162.0 165.0 167.0 163.0 168.0 162.0 161.0 168.0 15:02:28 INFO - PROCESS | 4362 | 15:02:28 INFO - PROCESS | 4362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:2.38 (3.6%) stddev-sans-first:2.40 15:02:28 INFO - PROCESS | 4362 | Values: 68.0 64.0 66.0 64.0 66.0 66.0 64.0 71.0 63.0 67.0 15:02:28 INFO - PROCESS | 4362 | -------- Summary: end -------- 15:02:28 INFO - PROCESS | 4362 | 15:02:29 INFO - TEST-INFO | 4362: exit 0 15:02:29 INFO - TEST-OK | kraken | took 61764ms 15:02:29 INFO - SUITE-END | took 1177s 15:02:29 INFO - Completed test suite (00:19:37) 15:02:29 INFO - javascript benchmark 15:02:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.8003329783564, 3093.876244950202, 3103.1621462205203, 3116.329989052353, 3120.2199450137464, 5259.237410575464, 5299.28459657946, 5372.731363431827, 5443.891122177554, 5489.2040654105085, 5299.311089558361, 5316.441773613773, 5340.359156901168, 5379.838604841861, 5389.434109418504, 4779.402574678165, 4839.346688197101, 4882.096812089757, 4889.804407823683, 4980.975095124538, 4950.702957822542, 4982.153033984231, 5002.424721157077, 5016.322796422491, 5035.219540971137, 4775.14047471455, 4833.299171620095, 4870.853874383756, 4919.11455937931, 4927.6550641455115, 4817.879553011167, 4827.951720482785, 4834.8791280218275, 4908.067467181224, 4960.627952903546, 4846.345743324641, 4865.099956508022, 4899.828506002273, 4928.950710492921, 4930.137225985438, 5238.711870847102, 5254.0805359062015, 5431.0, 5437.0, 5466.590005749585, 5643.633163844337, 5644.0, 5687.772489100431, 5692.37383887772, 5707.600467967244, 5628.549716022709, 5827.3298570664065, 5828.737706803204, 5831.241938548004, 5833.854153646151, 5190.662606930499, 5301.602379821452, 5344.866378340573, 5355.3305836770405, 5395.487428694268, 5874.353821079678, 5875.353711091777, 5924.407559244041, 5925.792597259076, 5938.61399009063, 5673.546116310686, 5676.063449530781, 5726.914096288559, 5727.6849773262875, 5732.684702341411, 5623.437656234344, 5655.4344565543115, 5694.829155125353, 5734.5125664319, 5777.480026797524, 5708.229389032427, 5713.457221563945, 5731.8853622928145, 5734.340550836624, 5754.654720716687, 5692.715364231772, 5737.684427356452, 5741.052726300197, 5744.310682718101, 5748.45389687979, 4255.3616957456625, 4333.371661109121, 4403.867883963486, 4425.09285596452, 4437.800298986554, 3931.5085614298214, 3936.0159960009996, 3938.1729836734035, 3950.6839452843706, 3991.1419044905483, 5476.808311709071, 5481.397046324901, 5484.561235101182, 5488.368837583649, 5522.006038912954, 5594.272744543184, 5782.421757824268, 5828.88342233153, 5830.067189249699, 5858.794942177088, 5534.916976245359, 5537.889242215133, 5539.612227144142, 5556.694381809039, 5559.471850174227, 5015.4733752956145, 5041.117804384291, 5043.672161309577, 5046.167382381939, 5081.822136225288, 5798.333191682926, 5984.790532331522, 6064.939350606437, 6080.48315893154, 6093.146959425684, 5864.9413505864395, 5866.061430171152, 5870.031444811559, 5899.557533185114, 5918.17145599625, 6046.455818976313, 6056.03103503455, 6064.272287325549, 6067.180930574316, 6088.903997280355, 5590.580706446952, 5629.352624448241, 5638.520725738358, 5670.461306175906, 5749.396313387201, 5744.626599271034, 5788.334341550775, 5792.391798861059, 5816.534677225727, 5834.82495525118, 5642.492175704207, 5649.802256920988, 5650.180723795109, 5654.180143879197, 5655.547556195576, 5416.9729151353995, 5525.0883604204855, 5585.916211256753, 5629.380768115586, 5643.068893632505, 5583.050881350099, 5608.046632072476, 5614.185943038318, 5668.943310566841, 5679.6876171810945, 5654.46282603152, 5671.234383358194, 5704.686242256716, 5705.372409035086, 5719.685417302088, 5397.487238712316, 5413.675179489243, 5523.972380138073, 5546.389897111234, 5547.0], "value": 5316.87230516796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6040422714666, 604.9758009679613, 612.2713970375253, 613.6287546034647, 627.3036929008803, 32386.028419147435, 43150.352744708856, 43912.99999999996, 44033.7798311008, 44105.0, 43853.56146438535, 43914.34128488067, 44172.55827441725, 44197.779011104896, 44274.22903083881, 8029.558374289411, 8868.645254189825, 9027.909720902773, 9028.458292502472, 10758.73103172423, 10502.159827213805, 10893.782124357507, 10895.400752958583, 10904.836427453594, 10920.672379828578, 10844.67465976022, 10980.945095274552, 10981.560737570488, 10995.725106872313, 11013.889861101406, 8078.1921807819335, 10626.043656070991, 10863.51114199863, 10896.727581810439, 10954.507047182897, 10707.946460267727, 10790.892091079068, 10790.946045269802, 10794.0, 10802.189835762349, 42262.78868605668, 42515.0, 42617.0, 42671.35992960108, 42756.57243427557, 3461.4115600348, 3518.313928783888, 3543.0965103898598, 3550.538430004083, 3598.604153543108, 32033.679663203304, 32678.509822352684, 32777.01668949911, 33022.50466243008, 33108.6689133108, 4457.754823484707, 4518.096380723869, 4528.32062774704, 4657.953420465819, 4692.319613656035, 337885.0, 339661.0, 340923.0, 341288.0, 341710.0, 56844.0, 57267.42732572621, 57376.0, 57400.71299643475, 57440.38394240814, 59600.403995960354, 59603.701981489816, 59660.0, 59681.701591491765, 59740.402595973486, 17364.91317543404, 17562.0, 17604.471865844047, 17608.38370657021, 17611.031393273235, 11652.941735291439, 11911.880881191077, 11915.642530724092, 13294.468221271041, 13444.731105377838, 16383.1329517334, 17064.57338566546, 17095.230714617872, 17100.74348884768, 17109.914450427666, 5777.24895763548, 6742.359475849787, 6791.422729068085, 6800.387965083166, 6880.2431732509385, 973.1873885305849, 1007.1727435744289, 1083.788661211072, 1100.4937728644913, 1113.4043286841502, 31821.840890795396, 32249.677503224666, 32678.830232881657, 32941.50587741186, 33033.0, 1092.808758467265, 1097.3690128176331, 1153.5904753812445, 1194.146185477388, 1196.682879037056, 16043.518694439186, 16814.24335904863, 17400.0, 17435.215415306342, 17713.557161070818, 519338.0, 533358.0, 533829.0, 534345.0, 565578.0, 58646.12030819541, 60114.69942650346, 60140.398596014355, 60198.0, 60389.69805151034, 1392.9721405571831, 1406.711624117074, 1414.8514405987223, 1417.9220142892034, 1432.885369170464, 31900.202494937814, 34214.657853421144, 34277.314453710285, 34648.653513464546, 35126.824365878005, 53623.73188134035, 54352.45647543474, 54476.455235448724, 54547.72726136344, 54740.0, 385870.0, 388045.0, 388067.0, 389157.0, 391128.0, 43424.78287608542, 43824.56175438205, 44573.77713111414, 44787.55212447834, 44876.55123448724, 47223.29165062596, 47927.0, 49280.75359623179, 49459.0, 49736.25395618996, 41040.0, 41342.0, 41586.83199475788, 42901.0, 43080.78459607682, 40743.59256407517, 40982.79508602438, 41320.79339603283, 41899.58100418957, 42914.0, 41360.0, 41943.7902810484, 43199.13601728011, 43301.35047974346, 43362.34956475718, 34363.312733744686, 36938.8153059233, 37199.62800371962, 37213.81393093017, 38361.616383835804, 28213.858930705213, 28290.85854570714, 28378.43243135167, 28519.001834935676, 28657.856710716314], "value": 20869.038705163883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.09162331086986, 390.20593093055635, 410.85209324643125, 414.958504149585, 426.1668438203311, 15302.387904483807, 19013.52466188346, 19245.326413575527, 19537.413877583658, 20053.699194512057, 18266.360677376295, 19444.027798610085, 19452.0, 19623.90188049058, 19670.803291967077, 5135.178371460548, 5176.0, 5320.441353657869, 5366.70483123428, 5375.489328513785, 3926.175503144343, 5257.447967963366, 5328.813491527797, 5332.253484512172, 5520.751566179511, 5729.541636669077, 5847.26909136358, 5856.677882716449, 5858.238429004245, 5871.4715675589405, 5836.562257830658, 5845.473907348338, 6254.374562543755, 6547.312532184147, 6561.639109848957, 5954.404559544011, 5961.552883533709, 5965.13505541694, 5966.373530779249, 5971.223740913653, 22478.0, 23685.526289474285, 23700.76299237003, 23840.284791456284, 23938.401539961465, 2143.2391501017228, 2153.569286142762, 2165.72928383952, 2207.260567709803, 2344.1326709117566, 10415.739606509822, 10446.373217606968, 10610.840837387444, 10617.78764424715, 12855.807162892565, 1800.738892860541, 1929.6140771845687, 1935.7193206985048, 1952.4533130723278, 1971.6451038813009, 78958.0, 84440.0, 85565.57217213936, 87077.56461217653, 88848.11151888463, 10138.341007834468, 10579.57681692739, 10676.733081673021, 11304.36086767414, 11327.32036077838, 15340.232988350537, 15812.130332831575, 15820.525384238492, 15849.920750396173, 15853.128077955824, 8298.170182981654, 8413.15868413166, 8447.408681392244, 8616.870746938675, 8636.870446943301, 8143.263295900384, 8163.306118979954, 8174.427790054639, 8387.370947178864, 8423.915760842436, 4763.571278584944, 4839.588634965997, 4861.829835955725, 4893.608511319086, 4986.426560945465, 1918.7121931710076, 1948.3375652278294, 1980.9504762381055, 1983.7817840037585, 2005.8696184747944, 875.5972252763672, 984.6061575369766, 1018.8318927376899, 1030.2427715629008, 1030.5465595138114, 19308.4207473776, 19644.3124490645, 19677.704834427495, 19726.605467890848, 19772.50568735793, 1006.0995409108807, 1006.3609607899036, 1013.4881884648205, 1029.4080903480528, 1080.4057768227444, 10394.428306443218, 10935.56257749697, 11031.172662050218, 11119.11047116245, 11135.104872733147, 440669.0, 441507.0, 448121.0, 464876.0, 465307.0, 89099.55450222707, 90507.54746226227, 91853.54073229725, 92830.53584732034, 93094.0, 984.8965858584745, 1008.2740426892625, 1023.4371095897227, 1041.598984391015, 1043.6816770884952, 16608.0, 16608.2526286315, 16799.580010499347, 17297.30810767555, 17966.101694915462, 41980.79009604932, 42266.788666056476, 43063.13873722571, 43184.70445886628, 43303.566964331214, 57441.71279143578, 58432.4156758427, 59562.702186488794, 60041.0, 60638.0, 8051.315638170587, 8178.591070446573, 8416.116307787594, 8593.44142630727, 8661.870071949052, 11856.644300670994, 13000.284984325954, 13002.219866808022, 13150.21098734079, 13518.188908665512, 11498.137639677225, 11532.481038353126, 11636.941815291208, 11695.473703683185, 12145.939270303592, 8726.560117580528, 11165.888341116484, 11477.770444591228, 11486.94256528712, 11541.769164616828, 10827.404492752974, 11374.431278435879, 11584.710382240512, 11735.76528469443, 12174.086943479451, 8370.455920365157, 8556.31549476028, 8633.8704919425, 8802.119788021148, 9213.0, 10387.740306492398, 10810.29733067348, 11394.544218231178, 11841.348725820162, 11932.343721095076], "value": 9228.26409982953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.4685032286438, 1280.5518068675958, 1371.4445649511952, 1380.275355438395, 1734.5836999120206, 7933.127355990843, 8300.70947516837, 8330.375221858354, 8331.333493320542, 8555.95722021389, 8177.0, 8364.289035431995, 8587.355948303886, 8590.828183436328, 8615.784605384853, 1984.4542750743517, 2248.955020899581, 2306.5848147333472, 2348.459854233519, 2352.9647055294186, 2298.839081264312, 2299.1493147535434, 2311.872846993415, 2326.8254880884, 2333.1600623775425, 2280.247518318959, 2280.703508543895, 2280.8175345972363, 2307.2270789285526, 2344.800691941187, 2132.925347612826, 2209.3703294561133, 2215.977840221601, 2224.7775222477785, 2247.29210298757, 2241.35000849755, 2255.537614788964, 2259.0399080390766, 2263.547290541882, 2264.241479104502, 8397.118302578203, 8433.746987590383, 8454.323654107719, 8459.0, 8459.11179326168, 5094.79620815167, 5200.557952574036, 5206.349206349207, 5220.2430647556275, 5222.8694282642855, 3247.918802029968, 3342.9331413371838, 3487.459443786217, 3515.068506845688, 3519.1026288296575, 1160.1588848085155, 1163.6276391554707, 1170.7482891178438, 1173.735909420382, 1180.8582970043649, 11930.582429614922, 12031.819522707166, 12112.576059837951, 12119.697007574792, 12125.93937030318, 4432.13573353193, 4557.908841823211, 4724.196886529298, 4737.928931066037, 4740.099381117577, 10178.0, 10181.490925453698, 10202.489875506195, 10240.539175737109, 10242.180625549938, 5326.893462130735, 5332.066888294533, 5332.840014799563, 5347.545458635982, 5350.3312085989255, 4198.181354635817, 4667.533246675305, 4724.480307166209, 4895.510448955147, 4910.508949105061, 3895.7857317847224, 3977.840886364571, 4031.0, 4076.816543255501, 4093.85671501496, 1290.0324756432676, 1301.9283939383236, 1307.8561358250586, 1326.2241588670736, 1341.7651910915552, 963.5519483440094, 994.5872462927948, 998.3211416236884, 1004.7789486313, 1018.1651046142092, 5829.417058294137, 5954.136650185699, 5981.940180598225, 6048.395160483917, 6143.938560614426, 461.7045091141672, 472.15012976641907, 472.25148140197484, 475.40099474662173, 483.8500064979867, 4089.0390758171807, 4316.956830431718, 4362.367456718822, 4373.431453910971, 4456.442944631921, 10381.896181038244, 10915.56337746497, 10932.180086493387, 10948.124150067975, 10954.890451095547, 10744.30162039465, 10751.193660475496, 10756.0, 10781.299215550964, 10794.73013174677, 7642.388608911274, 7978.960105199437, 8099.230573095547, 8178.46839955401, 8185.3451723861945, 6088.6042407243385, 6233.2208473940755, 6298.212723409574, 6324.146240257691, 6369.299377068426, 9885.703428897144, 10001.199904007808, 10004.84992725095, 10026.448545330077, 10193.796124077626, 9471.621135154517, 9824.607015719577, 9841.114299713061, 10120.949395252977, 10159.288849780445, 6717.0, 7417.888731669137, 7508.474406791473, 7612.657430415534, 7673.846523069619, 8379.078301386964, 8562.229399354088, 8580.828383432421, 8588.699395521127, 8589.65641374338, 7568.21350328633, 7638.618069096412, 7732.613369331623, 7835.059792824897, 7956.482828616122, 7312.415006799337, 7440.107187137578, 7481.925180748123, 7489.325960663567, 7777.805554860947, 7100.7869763907165, 7261.0, 7275.490715649854, 7282.781516554512, 7283.308085731847, 5242.68543887368, 5317.415084340642, 5406.0809662356705, 5514.09017512106, 5730.111832665943, 5426.8371948841595, 5450.672959622435, 5477.561795056466, 5584.888302234014, 5750.683712395691], "value": 4536.9608604190325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.39314179056055, 333.80138817403645, 342.84743289236286, 344.47811565478304, 347.0906225688696, 5154.252633368159, 5210.8697282567955, 5212.869678258041, 5235.110031294679, 5268.288781014571, 4930.285108659242, 5004.224345226496, 5141.768620412081, 5146.150885103953, 5192.454792246816, 4107.568705285947, 4111.650509706664, 4121.9175616487655, 4130.173965206963, 4137.482814648169, 4083.7549747015128, 4109.8972525686795, 4117.341225403936, 4125.814338354766, 4145.502539695226, 3896.4544963705102, 3917.4319723640056, 4045.757254564721, 4069.857554985576, 4085.9182816343655, 4052.756834589934, 4055.7972101395108, 4079.73481723687, 4080.4287399764057, 4082.3672330788777, 3653.963460365389, 3655.574326012857, 3667.1382225177063, 3671.229041901204, 3682.5949145593963, 4791.0178413425165, 5030.170021946375, 5059.595232381401, 5069.188929771256, 5076.213186956028, 4635.605973492257, 4636.814527418899, 4649.767511624439, 4655.394798676184, 4660.481336590852, 5419.566434685215, 5427.945720542783, 5428.022955867942, 5433.157860531624, 5446.2919820423485, 3772.6609502108868, 3904.1996390739832, 3925.8429662813455, 3957.7427467214825, 3959.0894094358173, 5582.804601838916, 5623.775048998076, 5644.3508996465525, 5647.519960803295, 5652.943470565283, 4040.8989775255855, 4045.5145382554283, 4048.9392659110135, 4050.3721923101966, 4054.614811592894, 4000.659943904801, 4095.5904409559403, 4100.2414553307735, 4109.746527309139, 4119.134981653826, 4617.2612382018715, 4618.822200338892, 4623.9075218495445, 4634.351190833286, 4643.674942754043, 5418.214358917935, 5424.240606315119, 5444.373897001817, 5445.393608885388, 5498.917516237259, 1354.674878029266, 1363.8611759180997, 1368.1244003837553, 1368.322680273271, 1369.7534443800212, 943.429225318686, 970.3983530211315, 972.9610815567439, 979.4466126638569, 980.2158273381267, 5175.378954525406, 5195.428502864682, 5197.896042079213, 5241.9737901310245, 5254.238135470412, 5514.172874068921, 5522.861928451821, 5529.30883639545, 5544.085225937756, 5553.278073850373, 5044.823431179964, 5202.869928251748, 5278.97360513195, 5339.866503337447, 5349.518543331119, 2955.1725516855313, 2959.5116805726816, 2961.711655429895, 2964.288570743049, 2984.4329577380227, 5673.546116310686, 5762.567807414461, 5787.958167529885, 5788.18965344852, 5790.899729051467, 5692.402297758676, 5696.8860622787315, 5717.542596592262, 5718.170865224519, 5723.313202415654, 5792.4497172768515, 5801.6519008859605, 5809.970950145223, 5813.941860581509, 5824.475797178275, 5383.111786555174, 5557.916631250454, 5572.554195664418, 5577.52591029767, 5594.916076258941, 5497.367802702581, 5506.531944784578, 5517.0, 5532.391436942014, 5543.695096769717, 5515.365732940763, 5741.598088133791, 5759.078547432391, 5785.652860828363, 5789.623674461315, 3937.153511994935, 3968.2460332536725, 3976.151089743283, 3977.5425826030378, 3978.761274323434, 5330.706811125426, 5467.976848566056, 5538.944610553843, 5584.274044374205, 5610.102383618601, 5456.372517160418, 5463.0, 5464.398916119303, 5465.590080744039, 5476.91784623223, 5395.892082158413, 5428.891422171613, 5436.293281873489, 5471.50756431923, 5478.424765399575, 5233.321845797353, 5387.0572649785345, 5449.700266485382, 5458.6724796512335, 5460.890782184413, 5466.945330546644, 5484.723839606519, 5526.696031718294, 5532.474414930575, 5541.418151094077, 5178.948210517847, 5290.550303224115, 5348.598855085962, 5358.0, 5420.620556561161], "value": 4172.09704865752, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.1103010207138, 706.194937770941, 720.3660778514906, 738.5790099643206, 762.8893810397492, 15211.46759863405, 15591.1424871632, 17034.31862725491, 17117.05856177913, 17154.742678859828, 16194.271257793398, 16194.514164575081, 16827.15864206791, 16832.158392080408, 16859.915700421512, 817.5135794202455, 838.9958050209771, 842.1999100854182, 842.418731075559, 843.0136740014198, 660.3495556876472, 780.0366547314063, 819.4100247821589, 819.9303059239942, 825.9710910118117, 867.5792240763225, 870.7431307764193, 871.3203701113142, 871.5816408124105, 871.9128087191293, 858.4720396955889, 860.2257967828941, 861.2679222660782, 861.4443683823961, 863.2489733931457, 502.5025225027233, 599.6641880546907, 624.1418050181001, 624.6970219443566, 627.1345543150469, 15643.139627320494, 15652.530424087296, 15653.0, 15678.0, 15717.349678283845, 14317.284135793168, 14590.927045364811, 14896.851031489654, 15167.0, 15172.0, 13181.736365272642, 13226.272555009471, 13270.336483175803, 13500.0, 13683.04218704691, 4565.4749703784155, 4681.157391669498, 4827.227643577011, 4911.09144808208, 4935.383077115361, 64604.0, 86260.0, 86702.13297867004, 87392.56303718504, 87599.56200219021, 11698.239614425205, 12178.269303841798, 12200.267983920992, 12428.875711242772, 12823.294718790556, 23055.423614409774, 23070.19254326124, 23089.76910230876, 23101.88449057744, 23119.88440057789, 9060.184583387527, 9127.0, 9175.265978721687, 9226.400283981655, 9360.204382627553, 4993.275974983607, 5083.542481176712, 5115.769790359443, 5140.948590514122, 5351.866203344947, 3508.0, 3632.9091772705365, 3634.945475817865, 3638.1086633774894, 3638.290533345972, 613.190588423277, 618.3785295777805, 619.6096459230656, 625.6340041076021, 631.8420394901275, 564.9661020338793, 590.271015296109, 643.2538255623455, 643.5045015338256, 651.2835880531378, 9247.029061948533, 9637.42175469474, 9712.854307185398, 9768.462734549526, 10012.799744005079, 622.17561730707, 631.6557476175495, 642.3672682407824, 643.1381948189448, 649.6232185332495, 4398.2962725964335, 4618.076384723069, 4629.907401852011, 4727.64542659302, 4783.604773622271, 125638.0, 125926.0, 129735.35132324467, 130113.0, 131693.68306316814, 70830.0, 110462.44768776266, 110889.0, 114846.85153148361, 115877.0, 73366.63316683382, 74513.25486745172, 75249.62375188089, 97033.5148324268, 98629.0, 9688.660896868576, 9826.901730982885, 10012.59949602037, 10026.448545330077, 10226.284160109019, 50875.491245087076, 51504.48495514997, 52262.47737522576, 52805.47194528006, 53049.0, 59375.70312148584, 74540.0, 75896.62051689706, 78609.0, 78718.60640696759, 12158.574449894566, 12199.14605977573, 12260.693482663004, 12661.303628300164, 12666.683332916751, 13590.728185436039, 14002.859971400156, 14229.928850355682, 14905.658490735452, 15109.622259443602, 13105.475780968654, 13777.793333100211, 13820.516281930084, 14057.156570605797, 14152.22162781057, 13155.73688526205, 13360.198388096745, 13532.79700804469, 14440.783388248974, 14908.105513669214, 13068.673283167996, 13354.799678005033, 13459.46162153542, 13895.72208555803, 14528.346224419714, 10614.953298754504, 10944.671659850217, 11120.277181983145, 11206.271592346471, 11437.942810285895, 9677.225821934087, 9998.300118991601, 10362.948185259025, 10719.624813131815, 11113.999740023437], "value": 7712.805979610878, "unit": "score"}], "name": "dromaeo_css", "value": 7285.226972060313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 110.0, 106.0, 114.0, 111.0, 111.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 121.0, 180.0, 120.0, 119.0, 157.0, 121.0, 161.0, 117.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 163.0, 162.0, 163.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 76.0, 112.0, 77.0, 76.0, 77.0, 75.0, 104.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 126.0, 85.0, 85.0, 86.0, 117.0, 86.0, 86.0, 124.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 51.0, 52.0, 53.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 65.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 78.0, 80.0, 79.0, 79.0, 79.0, 79.0, 78.0, 84.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 126.0, 137.0, 133.0, 126.0, 127.0, 121.0, 152.0, 126.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 162.0, 165.0, 167.0, 163.0, 168.0, 162.0, 161.0, 168.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 64.0, 66.0, 66.0, 64.0, 71.0, 63.0, 67.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1501.9, "alertThreshold": 2.0}]} 15:02:29 INFO - Return code: 0 15:02:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:02:29 INFO - # TBPL SUCCESS # 15:02:29 INFO - Running post-action listener: _resource_record_post_action 15:02:29 INFO - [mozharness: 2016-08-15 22:02:29.984632Z] Finished run-tests step (success) 15:02:29 INFO - Running post-run listener: _resource_record_post_run 15:02:30 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407171072; Read time: 8; Write time: 436864 15:02:30 INFO - TinderboxPrint: CPU usage
13.0% 15:02:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:02:30 INFO - TinderboxPrint: I/O write bytes / time
407,171,072 / 436,864 15:02:30 INFO - TinderboxPrint: CPU idle
8,291.9 (86.9%) 15:02:30 INFO - TinderboxPrint: CPU user
1,195.6 (12.5%) 15:02:30 INFO - TinderboxPrint: Swap in / out
0 / 0 15:02:30 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118075392; Read time: 0; Write time: 184048 15:02:30 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288735232; Read time: 0; Write time: 252812 15:02:30 INFO - Running post-run listener: _upload_blobber_files 15:02:30 INFO - Blob upload gear active. 15:02:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:02:30 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 15:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:02:31 INFO - (blobuploader) - INFO - Open directory for files ... 15:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:02:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:35 INFO - (blobuploader) - INFO - Done attempting. 15:02:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:02:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:37 INFO - (blobuploader) - INFO - Done attempting. 15:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:02:38 INFO - (blobuploader) - INFO - Done attempting. 15:02:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:02:38 INFO - Return code: 0 15:02:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:02:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:02:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b98c8e61483bea56b21bb3148c9c07ee2ddf2e4071b2bcc6d240be0b162976b5ff37f03412270caadd3dee94520f3367037e4fd32d330d196fb5a339491a463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce2c5165235284ec70adc7dd5f373962f152a7dee21afd8ab9db052933b7e5591c3d8efbd740e10012e27b4bc045e9a5ca8b6391c8da3c829189fd454cf68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3111d5fa18cfbd7ec8a58b9510b776b5370cf17ab8c028cfdb849dd56c3b51f5fd40d6fe11223f5efd25e0535443c606da8485da9a69b0d533648bf29b48c4fa"} 15:02:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:02:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:02:38 INFO - Contents: 15:02:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b98c8e61483bea56b21bb3148c9c07ee2ddf2e4071b2bcc6d240be0b162976b5ff37f03412270caadd3dee94520f3367037e4fd32d330d196fb5a339491a463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce2c5165235284ec70adc7dd5f373962f152a7dee21afd8ab9db052933b7e5591c3d8efbd740e10012e27b4bc045e9a5ca8b6391c8da3c829189fd454cf68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3111d5fa18cfbd7ec8a58b9510b776b5370cf17ab8c028cfdb849dd56c3b51f5fd40d6fe11223f5efd25e0535443c606da8485da9a69b0d533648bf29b48c4fa"} 15:02:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:02:38 INFO - Copying logs to upload dir... 15:02:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:02:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.711512 ========= master_lag: 29.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-15 15:03:07.022557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 15:03:07.029898) ========= 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=52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b98c8e61483bea56b21bb3148c9c07ee2ddf2e4071b2bcc6d240be0b162976b5ff37f03412270caadd3dee94520f3367037e4fd32d330d196fb5a339491a463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce2c5165235284ec70adc7dd5f373962f152a7dee21afd8ab9db052933b7e5591c3d8efbd740e10012e27b4bc045e9a5ca8b6391c8da3c829189fd454cf68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3111d5fa18cfbd7ec8a58b9510b776b5370cf17ab8c028cfdb849dd56c3b51f5fd40d6fe11223f5efd25e0535443c606da8485da9a69b0d533648bf29b48c4fa"} build_url:https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/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/Fx-Team/sha512/4b98c8e61483bea56b21bb3148c9c07ee2ddf2e4071b2bcc6d240be0b162976b5ff37f03412270caadd3dee94520f3367037e4fd32d330d196fb5a339491a463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce2c5165235284ec70adc7dd5f373962f152a7dee21afd8ab9db052933b7e5591c3d8efbd740e10012e27b4bc045e9a5ca8b6391c8da3c829189fd454cf68d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3111d5fa18cfbd7ec8a58b9510b776b5370cf17ab8c028cfdb849dd56c3b51f5fd40d6fe11223f5efd25e0535443c606da8485da9a69b0d533648bf29b48c4fa"}' ========= master_lag: 0.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 15:03:07.262047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:03:07.262442) ========= 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=52faae308a556c440401f8e5000001e8-1471297315.854871-2118905390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:03:07.291793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 15:03:07.292085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 15:03:07.296394) ========= ========= Total master_lag: 30.01 =========