builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1472624498.51 results: success (0) buildid: 20160830203009 builduid: 5f38ef484dae447fa0aed9d56e308f4f revision: 506facea63169a29e04eb140663da1730052db64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.508176) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.508612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.508923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.559380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.559665) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 23:21:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.4M=0s 2016-08-30 23:21:38 (66.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.658186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.658461) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018747 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:38.707820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 23:21:38.708178) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 506facea63169a29e04eb140663da1730052db64 --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 506facea63169a29e04eb140663da1730052db64 --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=4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 23:21:38,904 truncating revision to first 12 chars 2016-08-30 23:21:38,904 Setting DEBUG logging. 2016-08-30 23:21:38,904 attempt 1/10 2016-08-30 23:21:38,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/506facea6316?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 23:21:39,679 unpacking tar archive at: fx-team-506facea6316/testing/mozharness/ program finished with exit code 0 elapsedTime=1.102124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 23:21:39.826609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:39.827154) ========= script_repo_revision: 506facea63169a29e04eb140663da1730052db64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:39.827824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:39.828306) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 23:21:39.840185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-30 23:21:39.840702) ========= /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=4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:21:40 INFO - MultiFileLogger online at 20160830 23:21:40 in /builds/slave/test 23:21:40 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 23:21:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:21:40 INFO - {'append_to_log': False, 23:21:40 INFO - 'base_work_dir': '/builds/slave/test', 23:21:40 INFO - 'blob_upload_branch': 'Fx-Team', 23:21:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:21:40 INFO - 'branch': 'Fx-Team', 23:21:40 INFO - 'buildbot_json_path': 'buildprops.json', 23:21:40 INFO - 'config_files': ('talos/linux_config.py',), 23:21:40 INFO - 'default_actions': ('clobber', 23:21:40 INFO - 'read-buildbot-config', 23:21:40 INFO - 'download-and-extract', 23:21:40 INFO - 'populate-webroot', 23:21:40 INFO - 'create-virtualenv', 23:21:40 INFO - 'install', 23:21:40 INFO - 'run-tests'), 23:21:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:21:40 INFO - 'download_minidump_stackwalk': True, 23:21:40 INFO - 'download_symbols': 'ondemand', 23:21:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:21:40 INFO - 'tooltool.py': '/tools/tooltool.py', 23:21:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:21:40 INFO - '/tools/misc-python/virtualenv.py')}, 23:21:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:21:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:21:40 INFO - 'installer_path': 'installer.exe', 23:21:40 INFO - 'log_level': 'info', 23:21:40 INFO - 'log_name': 'talos', 23:21:40 INFO - 'log_to_console': True, 23:21:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:21:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:21:40 INFO - 'opt_config_files': (), 23:21:40 INFO - 'pip_index': False, 23:21:40 INFO - 'sps_profile': False, 23:21:40 INFO - 'sps_profile_interval': 0, 23:21:40 INFO - 'suite': 'dromaeojs', 23:21:40 INFO - 'system_bits': '32', 23:21:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:21:40 INFO - 'title': 'talos-linux64-ix-030', 23:21:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:21:40 INFO - 'use_talos_json': True, 23:21:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:21:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:21:40 INFO - 'work_dir': 'build'} 23:21:40 INFO - [mozharness: 2016-08-31 06:21:40.131316Z] Running clobber step. 23:21:40 INFO - Running pre-action listener: _resource_record_pre_action 23:21:40 INFO - Running main action method: clobber 23:21:40 INFO - rmtree: /builds/slave/test/build 23:21:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:21:40 INFO - Running post-action listener: _resource_record_post_action 23:21:40 INFO - [mozharness: 2016-08-31 06:21:40.590979Z] Finished clobber step (success) 23:21:40 INFO - [mozharness: 2016-08-31 06:21:40.591082Z] Running read-buildbot-config step. 23:21:40 INFO - Running pre-action listener: _resource_record_pre_action 23:21:40 INFO - Running main action method: read_buildbot_config 23:21:40 INFO - Using buildbot properties: 23:21:40 INFO - { 23:21:40 INFO - "project": "", 23:21:40 INFO - "product": "firefox", 23:21:40 INFO - "script_repo_revision": "production", 23:21:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:21:40 INFO - "repository": "", 23:21:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:21:40 INFO - "buildid": "20160830203009", 23:21:40 INFO - "pgo_build": "True", 23:21:40 INFO - "basedir": "/builds/slave/test", 23:21:40 INFO - "buildnumber": 410, 23:21:40 INFO - "slavename": "talos-linux64-ix-030", 23:21:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:21:40 INFO - "platform": "ubuntu64_hw", 23:21:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:21:40 INFO - "branch": "fx-team", 23:21:40 INFO - "repo_path": "integration/fx-team", 23:21:40 INFO - "revision": "506facea63169a29e04eb140663da1730052db64", 23:21:40 INFO - "stage_platform": "linux64-pgo", 23:21:40 INFO - "builduid": "5f38ef484dae447fa0aed9d56e308f4f", 23:21:40 INFO - "slavebuilddir": "test" 23:21:40 INFO - } 23:21:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:21:40 INFO - Running post-action listener: _resource_record_post_action 23:21:40 INFO - [mozharness: 2016-08-31 06:21:40.593523Z] Finished read-buildbot-config step (success) 23:21:40 INFO - [mozharness: 2016-08-31 06:21:40.593614Z] Running download-and-extract step. 23:21:40 INFO - Running pre-action listener: _resource_record_pre_action 23:21:40 INFO - Running main action method: download_and_extract 23:21:40 INFO - mkdir: /builds/slave/test/build/tests 23:21:40 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')]} 23:21:40 INFO - trying https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:21:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:41 INFO - Downloaded 1361 bytes. 23:21:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:21:41 INFO - Using the following test package requirements: 23:21:41 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:21:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:21:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:21:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'jsshell-linux-x86_64.zip'], 23:21:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:21:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:21:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:21:41 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:21:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:21:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:21:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:41 INFO - trying https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:21:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:42 INFO - Downloaded 21897502 bytes. 23:21:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 23:21:46 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 23:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:46 INFO - trying https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:21:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:47 INFO - Downloaded 21897502 bytes. 23:21:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 23:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:52 INFO - trying https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:21:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:53 INFO - Downloaded 14413998 bytes. 23:21:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 23:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:54 INFO - trying https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:21:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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 23:21:56 INFO - Downloaded 59743017 bytes. 23:21:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:21:56 INFO - mkdir: /builds/slave/test/properties 23:21:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:21:56 INFO - Writing to file /builds/slave/test/properties/build_url 23:21:56 INFO - Contents: 23:21:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:21:57 INFO - Running post-action listener: _resource_record_post_action 23:21:57 INFO - Running post-action listener: set_extra_try_arguments 23:21:57 INFO - [mozharness: 2016-08-31 06:21:57.108602Z] Finished download-and-extract step (success) 23:21:57 INFO - [mozharness: 2016-08-31 06:21:57.108831Z] Running populate-webroot step. 23:21:57 INFO - Running pre-action listener: _resource_record_pre_action 23:21:57 INFO - Running main action method: populate_webroot 23:21:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:21:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:21:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:21:57 INFO - '--tppagecycles', 23:21:57 INFO - '7'], 23:21:57 INFO - 'tests': ['tsvgm']}}, 23:21:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:21:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:21:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:21:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:21:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:21:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:21:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['damp', 'tps']}, 23:21:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'tests': ['damp', 'tps']}, 23:21:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['dromaeo_dom']}, 23:21:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:21:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['basic_compositor_video']}, 23:21:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:21:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['a11yr', 23:21:57 INFO - 'ts_paint', 23:21:57 INFO - 'tpaint', 23:21:57 INFO - 'sessionrestore', 23:21:57 INFO - 'sessionrestore_no_auto_restore', 23:21:57 INFO - 'tabpaint']}, 23:21:57 INFO - 'other-e10s': {'tests': ['a11yr', 23:21:57 INFO - 'ts_paint', 23:21:57 INFO - 'tpaint', 23:21:57 INFO - 'sessionrestore', 23:21:57 INFO - 'sessionrestore_no_auto_restore', 23:21:57 INFO - 'tabpaint']}, 23:21:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:21:57 INFO - 'ts_paint', 23:21:57 INFO - 'tpaint', 23:21:57 INFO - 'sessionrestore', 23:21:57 INFO - 'sessionrestore_no_auto_restore', 23:21:57 INFO - 'tabpaint']}, 23:21:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:21:57 INFO - 'ts_paint', 23:21:57 INFO - 'tpaint', 23:21:57 INFO - 'sessionrestore', 23:21:57 INFO - 'sessionrestore_no_auto_restore', 23:21:57 INFO - 'tabpaint']}, 23:21:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['a11yr', 23:21:57 INFO - 'ts_paint', 23:21:57 INFO - 'tpaint', 23:21:57 INFO - 'sessionrestore', 23:21:57 INFO - 'sessionrestore_no_auto_restore', 23:21:57 INFO - 'tabpaint']}, 23:21:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['a11yr', 23:21:57 INFO - 'ts_paint', 23:21:57 INFO - 'tpaint', 23:21:57 INFO - 'sessionrestore', 23:21:57 INFO - 'sessionrestore_no_auto_restore', 23:21:57 INFO - 'tabpaint']}, 23:21:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['tsvgx', 23:21:57 INFO - 'tsvgr_opacity', 23:21:57 INFO - 'tart', 23:21:57 INFO - 'tscrollx', 23:21:57 INFO - 'cart']}, 23:21:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:21:57 INFO - 'tsvgr_opacity', 23:21:57 INFO - 'tart', 23:21:57 INFO - 'tscrollx', 23:21:57 INFO - 'cart']}, 23:21:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'talos_options': ['--disable-e10s'], 23:21:57 INFO - 'tests': ['tp5o']}, 23:21:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'tests': ['tp5o']}, 23:21:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'talos_options': ['--disable-e10s', 23:21:57 INFO - '--xperf_path', 23:21:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:21:57 INFO - 'tests': ['tp5n']}, 23:21:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:57 INFO - 'talos_options': ['--xperf_path', 23:21:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:21:57 INFO - 'tests': ['tp5n']}}, 23:21:57 INFO - 'talos.zip': {'path': '', 23:21:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:21:57 INFO - Running post-action listener: _resource_record_post_action 23:21:57 INFO - [mozharness: 2016-08-31 06:21:57.129964Z] Finished populate-webroot step (success) 23:21:57 INFO - [mozharness: 2016-08-31 06:21:57.130053Z] Running create-virtualenv step. 23:21:57 INFO - Running pre-action listener: _resource_record_pre_action 23:21:57 INFO - Running main action method: create_virtualenv 23:21:57 INFO - Creating virtualenv /builds/slave/test/build/venv 23:21:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:21:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:21:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:21:57 INFO - Using real prefix '/usr' 23:21:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:21:57 INFO - Installing distribute.............................................................................................................................................................................................done. 23:21:59 INFO - Installing pip.................done. 23:21:59 INFO - Return code: 0 23:21:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:21:59 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')]} 23:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:59 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')]} 23:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:59 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 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:21:59 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 23:21:59 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 23:21:59 INFO - Using env: {'DISPLAY': ':0', 23:21:59 INFO - 'HOME': '/home/cltbld', 23:21:59 INFO - 'LANG': 'en_US.UTF-8', 23:21:59 INFO - 'LANGUAGE': 'en_US:en', 23:21:59 INFO - 'LOGNAME': 'cltbld', 23:21:59 INFO - 'MAIL': '/var/mail/cltbld', 23:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:59 INFO - 'MOZ_NO_REMOTE': '1', 23:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:59 INFO - 'NO_EM_RESTART': '1', 23:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:59 INFO - 'PWD': '/builds/slave/test', 23:21:59 INFO - 'SHELL': '/bin/bash', 23:21:59 INFO - 'SHLVL': '1', 23:21:59 INFO - 'TERM': 'linux', 23:21:59 INFO - 'TMOUT': '86400', 23:21:59 INFO - 'USER': 'cltbld', 23:21:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:59 INFO - '_': '/tools/buildbot/bin/python'} 23:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:59 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 23:21:59 INFO - Cleaning up... 23:21:59 INFO - Return code: 0 23:21:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:21:59 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')]} 23:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:59 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')]} 23:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:59 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 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:21:59 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 23:21:59 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 23:21:59 INFO - Using env: {'DISPLAY': ':0', 23:21:59 INFO - 'HOME': '/home/cltbld', 23:21:59 INFO - 'LANG': 'en_US.UTF-8', 23:21:59 INFO - 'LANGUAGE': 'en_US:en', 23:21:59 INFO - 'LOGNAME': 'cltbld', 23:21:59 INFO - 'MAIL': '/var/mail/cltbld', 23:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:59 INFO - 'MOZ_NO_REMOTE': '1', 23:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:59 INFO - 'NO_EM_RESTART': '1', 23:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:59 INFO - 'PWD': '/builds/slave/test', 23:21:59 INFO - 'SHELL': '/bin/bash', 23:21:59 INFO - 'SHLVL': '1', 23:21:59 INFO - 'TERM': 'linux', 23:21:59 INFO - 'TMOUT': '86400', 23:21:59 INFO - 'USER': 'cltbld', 23:21:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:59 INFO - '_': '/tools/buildbot/bin/python'} 23:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:00 INFO - Downloading/unpacking psutil>=3.1.1 23:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:22:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:02 INFO - Installing collected packages: psutil 23:22:02 INFO - Running setup.py install for psutil 23:22:02 INFO - building 'psutil._psutil_linux' extension 23:22:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:22:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:22:02 INFO - building 'psutil._psutil_posix' extension 23:22:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:22:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:22:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:02 INFO - Successfully installed psutil 23:22:02 INFO - Cleaning up... 23:22:02 INFO - Return code: 0 23:22:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:02 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 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:02 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 23:22:02 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 23:22:02 INFO - Using env: {'DISPLAY': ':0', 23:22:02 INFO - 'HOME': '/home/cltbld', 23:22:02 INFO - 'LANG': 'en_US.UTF-8', 23:22:02 INFO - 'LANGUAGE': 'en_US:en', 23:22:02 INFO - 'LOGNAME': 'cltbld', 23:22:02 INFO - 'MAIL': '/var/mail/cltbld', 23:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:02 INFO - 'MOZ_NO_REMOTE': '1', 23:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:02 INFO - 'NO_EM_RESTART': '1', 23:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:02 INFO - 'PWD': '/builds/slave/test', 23:22:02 INFO - 'SHELL': '/bin/bash', 23:22:02 INFO - 'SHLVL': '1', 23:22:02 INFO - 'TERM': 'linux', 23:22:02 INFO - 'TMOUT': '86400', 23:22:02 INFO - 'USER': 'cltbld', 23:22:02 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:02 INFO - '_': '/tools/buildbot/bin/python'} 23:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:22:02 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 23:22:02 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 23:22:02 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 23:22:02 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 23:22:02 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 23:22:02 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 23:22:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:22:04 INFO - Installing collected packages: mozsystemmonitor 23:22:04 INFO - Running setup.py install for mozsystemmonitor 23:22:04 INFO - Successfully installed mozsystemmonitor 23:22:04 INFO - Cleaning up... 23:22:05 INFO - Return code: 0 23:22:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:22:05 INFO - Using env: {'DISPLAY': ':0', 23:22:05 INFO - 'HOME': '/home/cltbld', 23:22:05 INFO - 'LANG': 'en_US.UTF-8', 23:22:05 INFO - 'LANGUAGE': 'en_US:en', 23:22:05 INFO - 'LOGNAME': 'cltbld', 23:22:05 INFO - 'MAIL': '/var/mail/cltbld', 23:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:05 INFO - 'MOZ_NO_REMOTE': '1', 23:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:05 INFO - 'NO_EM_RESTART': '1', 23:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:05 INFO - 'PWD': '/builds/slave/test', 23:22:05 INFO - 'SHELL': '/bin/bash', 23:22:05 INFO - 'SHLVL': '1', 23:22:05 INFO - 'TERM': 'linux', 23:22:05 INFO - 'TMOUT': '86400', 23:22:05 INFO - 'USER': 'cltbld', 23:22:05 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:05 INFO - '_': '/tools/buildbot/bin/python'} 23:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:05 INFO - Downloading/unpacking jsonschema==2.5.1 23:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:22:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:07 INFO - Downloading functools32-3.2.3-2.tar.gz 23:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:22:07 INFO - warning: no files found matching '*.txt' 23:22:07 INFO - no previously-included directories found matching 'build' 23:22:07 INFO - no previously-included directories found matching 'dist' 23:22:07 INFO - no previously-included directories found matching '.git*' 23:22:07 INFO - Installing collected packages: jsonschema, functools32 23:22:07 INFO - Running setup.py install for functools32 23:22:07 INFO - warning: no files found matching '*.txt' 23:22:07 INFO - no previously-included directories found matching 'build' 23:22:07 INFO - no previously-included directories found matching 'dist' 23:22:07 INFO - no previously-included directories found matching '.git*' 23:22:07 INFO - Successfully installed jsonschema functools32 23:22:07 INFO - Cleaning up... 23:22:07 INFO - Return code: 0 23:22:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:07 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 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:07 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 23:22:07 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 23:22:07 INFO - Using env: {'DISPLAY': ':0', 23:22:07 INFO - 'HOME': '/home/cltbld', 23:22:07 INFO - 'LANG': 'en_US.UTF-8', 23:22:07 INFO - 'LANGUAGE': 'en_US:en', 23:22:07 INFO - 'LOGNAME': 'cltbld', 23:22:07 INFO - 'MAIL': '/var/mail/cltbld', 23:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:07 INFO - 'MOZ_NO_REMOTE': '1', 23:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:07 INFO - 'NO_EM_RESTART': '1', 23:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:07 INFO - 'PWD': '/builds/slave/test', 23:22:07 INFO - 'SHELL': '/bin/bash', 23:22:07 INFO - 'SHLVL': '1', 23:22:07 INFO - 'TERM': 'linux', 23:22:07 INFO - 'TMOUT': '86400', 23:22:07 INFO - 'USER': 'cltbld', 23:22:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:07 INFO - '_': '/tools/buildbot/bin/python'} 23:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:22:07 INFO - Cleaning up... 23:22:07 INFO - Return code: 0 23:22:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:07 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 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:07 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 23:22:07 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 23:22:07 INFO - Using env: {'DISPLAY': ':0', 23:22:07 INFO - 'HOME': '/home/cltbld', 23:22:07 INFO - 'LANG': 'en_US.UTF-8', 23:22:07 INFO - 'LANGUAGE': 'en_US:en', 23:22:07 INFO - 'LOGNAME': 'cltbld', 23:22:07 INFO - 'MAIL': '/var/mail/cltbld', 23:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:07 INFO - 'MOZ_NO_REMOTE': '1', 23:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:07 INFO - 'NO_EM_RESTART': '1', 23:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:07 INFO - 'PWD': '/builds/slave/test', 23:22:07 INFO - 'SHELL': '/bin/bash', 23:22:07 INFO - 'SHLVL': '1', 23:22:07 INFO - 'TERM': 'linux', 23:22:07 INFO - 'TMOUT': '86400', 23:22:07 INFO - 'USER': 'cltbld', 23:22:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:07 INFO - '_': '/tools/buildbot/bin/python'} 23:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:07 INFO - Downloading/unpacking blobuploader==1.2.4 23:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:09 INFO - Downloading blobuploader-1.2.4.tar.gz 23:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:22:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:22:09 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 23:22:09 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 23:22:09 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 23:22:09 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 23:22:09 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 23:22:09 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 23:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:22:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:10 INFO - Downloading docopt-0.6.1.tar.gz 23:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:22:10 INFO - Installing collected packages: blobuploader, requests, docopt 23:22:10 INFO - Running setup.py install for blobuploader 23:22:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:22:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:22:10 INFO - Running setup.py install for requests 23:22:11 INFO - Running setup.py install for docopt 23:22:11 INFO - Successfully installed blobuploader requests docopt 23:22:11 INFO - Cleaning up... 23:22:11 INFO - Return code: 0 23:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:22:11 INFO - Using env: {'DISPLAY': ':0', 23:22:11 INFO - 'HOME': '/home/cltbld', 23:22:11 INFO - 'LANG': 'en_US.UTF-8', 23:22:11 INFO - 'LANGUAGE': 'en_US:en', 23:22:11 INFO - 'LOGNAME': 'cltbld', 23:22:11 INFO - 'MAIL': '/var/mail/cltbld', 23:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:11 INFO - 'MOZ_NO_REMOTE': '1', 23:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:11 INFO - 'NO_EM_RESTART': '1', 23:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:11 INFO - 'PWD': '/builds/slave/test', 23:22:11 INFO - 'SHELL': '/bin/bash', 23:22:11 INFO - 'SHLVL': '1', 23:22:11 INFO - 'TERM': 'linux', 23:22:11 INFO - 'TMOUT': '86400', 23:22:11 INFO - 'USER': 'cltbld', 23:22:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:11 INFO - '_': '/tools/buildbot/bin/python'} 23:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:22:11 INFO - Running setup.py (path:/tmp/pip-D1fSzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:22:11 INFO - Running setup.py (path:/tmp/pip-PyM2qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:22:11 INFO - Running setup.py (path:/tmp/pip-N91yAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:22:11 INFO - Running setup.py (path:/tmp/pip-0knFGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:22:11 INFO - Running setup.py (path:/tmp/pip-oHmv6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:22:11 INFO - Running setup.py (path:/tmp/pip-ulTNoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:22:11 INFO - Running setup.py (path:/tmp/pip-fCBx1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:22:11 INFO - Running setup.py (path:/tmp/pip-RPij3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:22:12 INFO - Running setup.py (path:/tmp/pip-xv4v_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:22:12 INFO - Running setup.py (path:/tmp/pip-wuMiDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:22:12 INFO - Running setup.py (path:/tmp/pip-__Vny8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:22:12 INFO - Running setup.py (path:/tmp/pip-n0zfd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:22:12 INFO - Running setup.py (path:/tmp/pip-bhVjfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:22:12 INFO - Running setup.py (path:/tmp/pip-TnRm6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:12 INFO - Running setup.py (path:/tmp/pip-cSDCcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:22:12 INFO - Running setup.py (path:/tmp/pip-oYy2G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:22:12 INFO - Running setup.py (path:/tmp/pip-Cd26JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:22:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:22:12 INFO - Running setup.py install for manifestparser 23:22:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:22:12 INFO - Running setup.py install for mozcrash 23:22:12 INFO - Running setup.py install for mozdebug 23:22:13 INFO - Running setup.py install for mozdevice 23:22:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Running setup.py install for mozfile 23:22:13 INFO - Running setup.py install for mozhttpd 23:22:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Running setup.py install for mozinfo 23:22:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Running setup.py install for mozInstall 23:22:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Running setup.py install for mozleak 23:22:13 INFO - Running setup.py install for mozlog 23:22:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Running setup.py install for moznetwork 23:22:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:22:13 INFO - Running setup.py install for mozprocess 23:22:13 INFO - Running setup.py install for mozprofile 23:22:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:22:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:22:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:22:14 INFO - Running setup.py install for mozrunner 23:22:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:22:14 INFO - Running setup.py install for mozscreenshot 23:22:14 INFO - Running setup.py install for moztest 23:22:14 INFO - Running setup.py install for mozversion 23:22:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:22:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:22:14 INFO - Cleaning up... 23:22:14 INFO - Return code: 0 23:22:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:22:14 INFO - Using env: {'DISPLAY': ':0', 23:22:14 INFO - 'HOME': '/home/cltbld', 23:22:14 INFO - 'LANG': 'en_US.UTF-8', 23:22:14 INFO - 'LANGUAGE': 'en_US:en', 23:22:14 INFO - 'LOGNAME': 'cltbld', 23:22:14 INFO - 'MAIL': '/var/mail/cltbld', 23:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:14 INFO - 'MOZ_NO_REMOTE': '1', 23:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:14 INFO - 'NO_EM_RESTART': '1', 23:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:14 INFO - 'PWD': '/builds/slave/test', 23:22:14 INFO - 'SHELL': '/bin/bash', 23:22:14 INFO - 'SHLVL': '1', 23:22:14 INFO - 'TERM': 'linux', 23:22:14 INFO - 'TMOUT': '86400', 23:22:14 INFO - 'USER': 'cltbld', 23:22:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:14 INFO - '_': '/tools/buildbot/bin/python'} 23:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:22:14 INFO - Running setup.py (path:/tmp/pip-cBlxaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:22:14 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)) 23:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:22:14 INFO - Running setup.py (path:/tmp/pip-URJ4IJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:22:14 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)) 23:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:22:14 INFO - Running setup.py (path:/tmp/pip-zzwCEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:22:14 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)) 23:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:22:14 INFO - Running setup.py (path:/tmp/pip-D0oJJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:22:14 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)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:22:15 INFO - Running setup.py (path:/tmp/pip-8t8kwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:22:15 INFO - Running setup.py (path:/tmp/pip-8sBoc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:22:15 INFO - Running setup.py (path:/tmp/pip-nzq3Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:22:15 INFO - Running setup.py (path:/tmp/pip-ouJehS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:22:15 INFO - Running setup.py (path:/tmp/pip-gYafdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:22:15 INFO - Running setup.py (path:/tmp/pip-9pHTpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:22:15 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)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:22:15 INFO - Running setup.py (path:/tmp/pip-L6_tOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:22:15 INFO - Running setup.py (path:/tmp/pip-fN14Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:22:15 INFO - Running setup.py (path:/tmp/pip-fspQQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:22:15 INFO - Running setup.py (path:/tmp/pip-ck4yiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:22:15 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)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:15 INFO - Running setup.py (path:/tmp/pip-bLirqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:15 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)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:22:15 INFO - Running setup.py (path:/tmp/pip-T0IiaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:22:15 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)) 23:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:22:15 INFO - Running setup.py (path:/tmp/pip-gwgvDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:22:15 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)) 23:22:15 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)) 23:22:15 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)) 23:22:15 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)) 23:22:15 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)) 23:22:15 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)) 23:22:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22:17 INFO - Downloading blessings-1.6.tar.gz 23:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:22:17 INFO - Installing collected packages: blessings 23:22:17 INFO - Running setup.py install for blessings 23:22:18 INFO - Successfully installed blessings 23:22:18 INFO - Cleaning up... 23:22:18 INFO - Return code: 0 23:22:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:22:18 INFO - Reading from file tmpfile_stdout 23:22:18 INFO - Current package versions: 23:22:18 INFO - argparse == 1.2.1 23:22:18 INFO - blessings == 1.6 23:22:18 INFO - blobuploader == 1.2.4 23:22:18 INFO - docopt == 0.6.1 23:22:18 INFO - functools32 == 3.2.3-2 23:22:18 INFO - jsonschema == 2.5.1 23:22:18 INFO - manifestparser == 1.1 23:22:18 INFO - mozInstall == 1.12 23:22:18 INFO - mozcrash == 0.17 23:22:18 INFO - mozdebug == 0.1 23:22:18 INFO - mozdevice == 0.48 23:22:18 INFO - mozfile == 1.2 23:22:18 INFO - mozhttpd == 0.7 23:22:18 INFO - mozinfo == 0.9 23:22:18 INFO - mozleak == 0.1 23:22:18 INFO - mozlog == 3.3 23:22:18 INFO - moznetwork == 0.27 23:22:18 INFO - mozprocess == 0.23 23:22:18 INFO - mozprofile == 0.28 23:22:18 INFO - mozrunner == 6.12 23:22:18 INFO - mozscreenshot == 0.1 23:22:18 INFO - mozsystemmonitor == 0.3 23:22:18 INFO - moztest == 0.7 23:22:18 INFO - mozversion == 1.4 23:22:18 INFO - psutil == 3.1.1 23:22:18 INFO - requests == 1.2.3 23:22:18 INFO - wsgiref == 0.1.2 23:22:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:22: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')]} 23:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:22:18 INFO - Using env: {'DISPLAY': ':0', 23:22:18 INFO - 'HOME': '/home/cltbld', 23:22:18 INFO - 'LANG': 'en_US.UTF-8', 23:22:18 INFO - 'LANGUAGE': 'en_US:en', 23:22:18 INFO - 'LOGNAME': 'cltbld', 23:22:18 INFO - 'MAIL': '/var/mail/cltbld', 23:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:18 INFO - 'MOZ_NO_REMOTE': '1', 23:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:18 INFO - 'NO_EM_RESTART': '1', 23:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:18 INFO - 'PWD': '/builds/slave/test', 23:22:18 INFO - 'SHELL': '/bin/bash', 23:22:18 INFO - 'SHLVL': '1', 23:22:18 INFO - 'TERM': 'linux', 23:22:18 INFO - 'TMOUT': '86400', 23:22:18 INFO - 'USER': 'cltbld', 23:22:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:18 INFO - '_': '/tools/buildbot/bin/python'} 23:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:22:18 INFO - Cleaning up... 23:22:18 INFO - Return code: 0 23:22:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:22: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')]} 23:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4377a11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, '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': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', '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 23:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:22:18 INFO - Using env: {'DISPLAY': ':0', 23:22:18 INFO - 'HOME': '/home/cltbld', 23:22:18 INFO - 'LANG': 'en_US.UTF-8', 23:22:18 INFO - 'LANGUAGE': 'en_US:en', 23:22:18 INFO - 'LOGNAME': 'cltbld', 23:22:18 INFO - 'MAIL': '/var/mail/cltbld', 23:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:18 INFO - 'MOZ_NO_REMOTE': '1', 23:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:18 INFO - 'NO_EM_RESTART': '1', 23:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:18 INFO - 'PWD': '/builds/slave/test', 23:22:18 INFO - 'SHELL': '/bin/bash', 23:22:18 INFO - 'SHLVL': '1', 23:22:18 INFO - 'TERM': 'linux', 23:22:18 INFO - 'TMOUT': '86400', 23:22:18 INFO - 'USER': 'cltbld', 23:22:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:18 INFO - '_': '/tools/buildbot/bin/python'} 23:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:22:18 INFO - Cleaning up... 23:22:18 INFO - Return code: 0 23:22:18 INFO - Running post-action listener: _resource_record_post_action 23:22:18 INFO - Running post-action listener: _start_resource_monitoring 23:22:18 INFO - Starting resource monitoring. 23:22:18 INFO - [mozharness: 2016-08-31 06:22:18.754554Z] Finished create-virtualenv step (success) 23:22:18 INFO - [mozharness: 2016-08-31 06:22:18.755015Z] Running install step. 23:22:18 INFO - Running pre-action listener: _resource_record_pre_action 23:22:18 INFO - Running main action method: install 23:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:22:18 INFO - Reading from file tmpfile_stdout 23:22:18 INFO - Detecting whether we're running mozinstall >=1.0... 23:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:22:19 INFO - Reading from file tmpfile_stdout 23:22:19 INFO - Output received: 23:22:19 INFO - Usage: mozinstall [options] installer 23:22:19 INFO - Options: 23:22:19 INFO - -h, --help show this help message and exit 23:22:19 INFO - -d DEST, --destination=DEST 23:22:19 INFO - Directory to install application into. [default: 23:22:19 INFO - "/builds/slave/test"] 23:22:19 INFO - --app=APP Application being installed. [default: firefox] 23:22:19 INFO - mkdir: /builds/slave/test/build/application 23:22:19 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'] 23:22:19 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 23:22:36 INFO - Reading from file tmpfile_stdout 23:22:36 INFO - Output received: 23:22:36 INFO - /builds/slave/test/build/application/firefox/firefox 23:22:36 INFO - Running post-action listener: _resource_record_post_action 23:22:36 INFO - [mozharness: 2016-08-31 06:22:36.058134Z] Finished install step (success) 23:22:36 INFO - [mozharness: 2016-08-31 06:22:36.058419Z] Running run-tests step. 23:22:36 INFO - Running pre-action listener: _resource_record_pre_action 23:22:36 INFO - Running main action method: run_tests 23:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:22:36 INFO - Python 2.7.3 23:22:36 INFO - Return code: 0 23:22:36 INFO - grabbing minidump binary from tooltool 23:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda370>, '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 0xedd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeddd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:22:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:22:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:22:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:22:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:22:36 INFO - Return code: 0 23:22:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:22:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:22:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:22:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:22:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 23:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 23:22:36 INFO - Using env: {'DISPLAY': ':0', 23:22:36 INFO - 'HOME': '/home/cltbld', 23:22:36 INFO - 'LANG': 'en_US.UTF-8', 23:22:36 INFO - 'LANGUAGE': 'en_US:en', 23:22:36 INFO - 'LOGNAME': 'cltbld', 23:22:36 INFO - 'MAIL': '/var/mail/cltbld', 23:22:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:22:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:36 INFO - 'MOZ_NO_REMOTE': '1', 23:22:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:36 INFO - 'NO_EM_RESTART': '1', 23:22:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:36 INFO - 'PWD': '/builds/slave/test', 23:22:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:22:36 INFO - 'SHELL': '/bin/bash', 23:22:36 INFO - 'SHLVL': '1', 23:22:36 INFO - 'TERM': 'linux', 23:22:36 INFO - 'TMOUT': '86400', 23:22:36 INFO - 'USER': 'cltbld', 23:22:36 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090', 23:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:36 INFO - '_': '/tools/buildbot/bin/python'} 23:22:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 23:22:36 INFO - mozversion application_buildid: 20160830203009 23:22:36 INFO - mozversion application_changeset: 506facea63169a29e04eb140663da1730052db64 23:22:36 INFO - mozversion application_display_name: Nightly 23:22:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:22:36 INFO - mozversion application_name: Firefox 23:22:36 INFO - mozversion application_remotingname: firefox 23:22:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:22:36 INFO - mozversion application_vendor: Mozilla 23:22:36 INFO - mozversion application_version: 51.0a1 23:22:36 INFO - mozversion platform_buildid: 20160830203009 23:22:36 INFO - mozversion platform_changeset: 506facea63169a29e04eb140663da1730052db64 23:22:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:22:36 INFO - mozversion platform_version: 51.0a1 23:22:36 INFO - using testdate: 1472624556 23:22:36 INFO - actual date: 1472624556 23:22:36 INFO - starting webserver on 'localhost:54297' 23:22:36 INFO - SUITE-START | Running 2 tests 23:22:36 INFO - TEST-START | dromaeo_css 23:22:36 INFO - operating with platform_type : linux_ 23:22:36 INFO - Initialising browser for dromaeo_css test... 23:22:36 INFO - TEST-INFO | started process 26115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBq80D6/profile http://localhost:54297/getInfo.html) 23:22:40 INFO - PROCESS | 26115 | __metrics Screen width/height:1600/1200 23:22:40 INFO - PROCESS | 26115 | colorDepth:24 23:22:40 INFO - PROCESS | 26115 | Browser inner width/height: 1024/697 23:22:40 INFO - PROCESS | 26115 | __metrics 23:22:41 INFO - PROCESS | 26115 | 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" 23:22:41 INFO - PROCESS | 26115 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:22:41 INFO - PROCESS | 26115 | console.error: PushService: 23:22:41 INFO - PROCESS | 26115 | stateChangeProcessEnqueue: Error transitioning state 23:22:41 INFO - PROCESS | 26115 | UnknownError 23:22:42 INFO - TEST-INFO | 26115: exit 0 23:22:42 INFO - Browser initialized. 23:22:42 INFO - Running cycle 1/1 for dromaeo_css test... 23:22:42 INFO - TEST-INFO | started process 26193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBq80D6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:54 INFO - PROCESS | 26193 | RSS: Main: 180199424 23:22:54 INFO - PROCESS | 26193 | 23:23:46 INFO - PROCESS | 26193 | 1472624626138 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] 23:25:55 INFO - PROCESS | 26193 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54297/tests/dromaeo/cssquery-ext.html) 23:25:56 INFO - PROCESS | 26193 | RSS: Main: 287195136 23:25:56 INFO - PROCESS | 26193 | 23:28:59 INFO - PROCESS | 26193 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-ext.html (next: http://localhost:54297/tests/dromaeo/cssquery-jquery.html) 23:28:59 INFO - PROCESS | 26193 | RSS: Main: 276717568 23:28:59 INFO - PROCESS | 26193 | 23:32:01 INFO - PROCESS | 26193 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54297/tests/dromaeo/cssquery-mootools.html) 23:32:02 INFO - PROCESS | 26193 | RSS: Main: 212873216 23:32:02 INFO - PROCESS | 26193 | 23:35:04 INFO - PROCESS | 26193 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54297/tests/dromaeo/cssquery-prototype.html) 23:35:05 INFO - PROCESS | 26193 | RSS: Main: 214503424 23:35:05 INFO - PROCESS | 26193 | 23:38:07 INFO - PROCESS | 26193 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54297/tests/dromaeo/cssquery-yui.html) 23:38:08 INFO - PROCESS | 26193 | RSS: Main: 214884352 23:38:08 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | Cycle 1(1): loaded http://localhost:54297/tests/dromaeo/cssquery-yui.html (next: http://localhost:54297/tests/dromaeo/cssquery-dojo.html) 23:41:11 INFO - PROCESS | 26193 | RSS: Main: 310247424 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | __start_tp_report 23:41:11 INFO - PROCESS | 26193 | _x_x_mozilla_page_load 23:41:11 INFO - PROCESS | 26193 | _x_x_mozilla_page_load_details 23:41:11 INFO - PROCESS | 26193 | |i|pagename|runs| 23:41:11 INFO - PROCESS | 26193 | |0;dojo.html;3036.939261214776;3055.083474957513;3070.4166208420397;3098.0550931965768;3128.327409606934;5278.445763194867;5331;5360.865978350544;5428.185772134177;5447.891042179154;5349.732513374325;5387.0841956867325;5427.701476418805;5432.185172224168;5462.426445223244;4837.903241935159;4856.271559266103;4867.8783030424165;4925.187344088221;5051.520105589963;4997.875053123665;5006.949930500685;5013.09764242438;5013.273075404064;5019.29729837823;4778.904421911577;4814.398200224972;4827.010462855106;4876.195427754416;4916.262560615918;4731.148393289207;4732.881677958044;4765.69023013503;4783.784729687172;4786.856394308176;4698.271767875985;4714.575688188045;4746;4783.1868582341085;4829.1790395632825;5137.280780690707;5262.105442074857;5271.341082364705;5294.54996325309;5347.812826551052;5624.15637654351;5680.091185410314;5693.117566777156;5695.857603559903;5702.971485142589;5671.829845104653;5707.857303567403;5728.42715728428;5732.22614946981;5734.827955161351;5197.1164901966;5206.583473322125;5318.521333080042;5322.414534401213;5332.200169974496;5733.770649173986;5780.306363236438;5782.190493330937;5862.032764593794;5862.472377486047;5533.501984821385;5545.944540554543;5547.916781248285;5551.500364967092;5554.305711786027;5485.945140548543;5612.635178713371;5620.100783874561;5621.606487545914;5635;5666.801661941812;5740.712964351766;5741.971290143522;5747.195392645033;5749.051406517961;5647.604667673306;5692.743826527733;5700.3444603871085;5702.344230413472;5703.030484817591;4351.282038463618;4395.824167033346;4416.6908316418185;4425.690201685916;4452.265376212888;3804.1060350817534;3915.92168156641;3966.504186976628;3991.4012898064943;4067.7559346439307;5366.946330536723;5372.435894231049;5380.946190538123;5390.299261096033;5393.191021346751;5756.378797853489;5772.278465191851;5784.2769653793275;5786.884262314814;5794.159846822272;5252.684838909601;5339.41266460689;5378.435264297271;5385.973070134624;5441.863953401117;4969.950300496948;4984.4267909190185;4989.825356112518;4991.276264941564;5041.6722913010535;5945.940540594539;5955.285365756137;5959.195508606283;5959.791407300723;5976.342602313742;5534.05920993424;5564.19319198722;5571.721413929206;5601.495865372136;5683.1759394886685;5745.885082298247;5756.481916627524;5762.279715035621;5775.624584402;5777.62445441045;5455.727213639381;5503.3120859892515;5515.806946756844;5516.558675306046;5519;5591.329040515164;5654.038813401649;5681.460261275172;5687.687177205294;5780.468175933297;5519.751611177427;5545.1682247663175;5549.861253468695;5562.22128901946;5570.721463926707;5555.749991250323;5561.499465048165;5565.0817615094675;5569.415211402745;5630.014747419267;5455.263539422127;5468.152436372368;5494.2857428535635;5510.366307874486;5552.028395030934;5605.355384130877;5606.831795046155;5625.437456254342;5627.606067575394;5632.042552765957;5486.177073439016;5487.396386397573;5493.7802487900035;5500.559955203654;5502.697351645538 23:41:11 INFO - PROCESS | 26193 | |1;ext.html;578.9131630255464;597.6653074278404;607.2803727582815;616.9784057557987;621.0342916764432;43381;45156.32265516012;45215.54784452155;45313;48030.51969480304;45828.31257531131;46284.074318513696;46289.07421851561;46357;46368.53631463693;8107.148749381318;8660.826783464327;8809.251213646849;8810.471371717686;10515.421651809147;10368.896311036868;10786.892131078706;10795.460226988658;10799.352038877652;10806.243562950596;10823.67528974132;10883.346999180036;10883.4423910381;10886.455677216147;10890.128789696806;10769.676909692682;10814.026737593615;10816.621418250403;10822.72943176419;10830.566777328897;10775.137988960943;10854.728631784268;10857.837132443019;10860;10861.076808471289;42520.362194567104;42812.35781463281;42881.35677964833;42972.57027429748;42973.57026429727;3360.5967283925843;3509.31568344173;3514.139035936212;3537.2925414917117;3577.266660334625;32570.83714581412;32643;32706.6729332706;32908.17729556756;32948.83525582357;4128.91742165158;4222.746635201897;4269.829206831754;4344.565543445662;4394.099209662011;244772;245295;246283;246400;247352.9999999982;34423.13942151416;35100.82449587787;58557;59206.703966479894;59478.70260648755;36904.261914761555;36994.26011479755;37031.62968370336;37150.814245928595;37190.814045930136;13617.319134043259;13619.727605447835;13711.725765484634;13726.93136534331;13740.725185496234;9539.809203816023;10273.486325683836;10323.84514232287;10391.324563903474;11080.501377438035;8527.232549070613;8527.360447966428;8564.186402291773;8621.655133794578;8626.137386261324;3258.6741325867224;3294.357600267973;3297.8186199759243;3313.6355000949875;3334.283129127249;915.876356691838;978.3885071830106;1008.6368907193405;1025.205465764024;1065.6110519660424;32685.673143268737;32736.672633273363;32768;32886.342273154405;32982.67017329844;1030.6083688198437;1064.9361038337724;1112.2158877990996;1114.403793970222;1149.2989276541302;16335.395353714006;17285.308587656604;17321.393751218646;17327;17341.132943352783;518396;523017;523070;524799;524808;57763.711181443825;58234.417655823745;58390.41609583935;58436.70781646064;58444.7077764617;1176.3647630279554;1304.8108024336607;1335.9732805343838;1336.8395792504962;1341.7182391697659;31720.36559268848;33306.167345816546;34108.488372673935;34148.31703365968;34337.54068429059;49884.25173622326;50329.74835125801;50330;50481.49518504768;50491.49508505015;318863;320798;321454;321505;321590;28148.43703125885;28192.29519262035;28296.575551366335;28629.713702862704;30326.54510182305;47218.52781472141;47379.52620473889;47395.289070663275;47679.28481072717;48348.75825620849;39983.20033599254;40151.397729034674;40643;40669.79665101656;42364.576354236066;40183.77151541516;40494.79752601218;40816.79591602023;42076;42865.78567107145;40542.39186412265;40866.59133408747;41489.58510414857;41828.37257441202;42002.369964451165;33318;36278.8186059068;36315.62520126681;36463.635363646026;37165.44251836279;27851.721482784913;28083.297917552223;29372;30075.699243008166;30119.849400752857 23:41:11 INFO - PROCESS | 26193 | |2;jquery.html;370.4757767758622;393.205724436638;401.4359824446652;406.06807377069623;419.84465747673363;16201.351945922164;19169.42491725247;19680.704789428153;19738.210471581155;19924.50188745282;17930.462086137402;18755.3435629753;19093.904530477328;19301.22795088195;19339.613207735838;5222.060029194753;5393.568514518849;5402.945970540303;5668.773249070032;5925.4963328117165;3975.681945444372;5820.592558520905;5852.648841069528;5854.414558544154;5855.824325270249;5702.059160238556;5934.970325148368;5963.671998040106;6041.758329666808;6047.183630209931;5807.709614519257;5889.234399528077;5930.525557955353;6025.5782095253135;6037.094435834638;5764.625299355528;5768.048272035109;5769.596128271022;5772.191893134965;5772.422757724236;12593.874061259361;13819.309034548332;22839.543209135725;23338.183163589194;23489;2333.10175582402;2395.796357309631;2409.6506006629115;2411.646536544229;2877.7122287771263;10355.585776568929;10527.578896844117;12054.975327097207;12559.56041538551;14799.70400591982;1885.566319746466;1907.4087033019669;1920.0879582198484;1935.806419358067;1987.9403617891487;67748;73746.99999999946;80767.5961620194;83034.58482707548;85736.57131714301;10871.891281087246;11245.775084498264;11308.491117899714;11333.206675532634;11485.598004069818;16086.276117574736;16091.919540402458;16122.77544491083;16137.435189768301;16149.434769783002;7624.428167887319;7892.329152022143;7929.532722211143;7984.800379990546;8151.5109093454585;7267.418606511466;7298.817529561803;7348.7218962121915;7528.134264559646;7544.660490277951;4870.780814863339;4919.950800492021;4924.3105965164905;4952.913846077001;5009.499050094962;1955.2276850643916;1966.9508262293557;2001.2595339724105;2013.788552202027;2056.126146387779;723.3706675192616;842.928351090152;857.4212406625503;891.3910391742966;894.2264940826138;19528;19783.20867165326;19814.50463738418;19894.60210795776;19922;982.5824024789435;1013.6502906497394;1035.53918506264;1038.9324693894873;1067.0556557446716;10218.18254539635;10881.347119172875;10988.945055274673;10997.725056873642;11016.17378696601;375000;376534;379471;413377;463327;70597.64701176461;83464;85245.14754852497;94140;97004;944.2021491839522;950.9286803489766;971.4754032822196;974.1184228273424;984.104464936904;17150.485485435456;17674.911625442306;18084.90957545204;18191.181396837437;18354.449366519028;43009.3548596765;43697.56302436935;43890;44218.77890610526;44566.77716611396;59428;60361.69819150876;60879.39120608737;60929.08606370819;61976;5901.262342207224;7165.749198778018;7494.063242094739;8541.572921353783;8719.869201962103;12330.568430104904;13607.047506674438;13990.160590364203;14027.649308767363;14161.504347347793;11159.330440173291;11647.301161929972;11700.70748231301;11759.470823812779;12196;11731.23746956445;11744.701161940966;11815.527378904748;11866.406679666155;12129.21160124589;11639.941800290944;11810.704732381759;11983.460744266704;12005.75988480243;12303.75392492163;8475.194856488624;8559.61481733336;8656;8737.825243494968;9085.318601105077;9946.303758736818;11676.70808229801;11814;11823.586174483851;11977.161598688008 23:41:11 INFO - PROCESS | 26193 | |3;mootools.html;1458.256289292461;1475.3508456279237;1589.9284532196057;1750.4836073358374;1765.6203916158015;7600.92399076009;8158.428909976304;8295.253427191552;9320.48737319448;9323.160915517603;8104.837903241932;8739.082396348387;8749.95625021874;8763.255123314526;8764.91235087649;2346.718393792747;2369.7156341239074;2371.2530552875874;2375.2043065573052;2377.9167729129485;2037.602667479842;2335.4628435459854;2340.1458467659268;2346.2374728213313;2419.2258477287187;2404.3770454942933;2428.0530593068715;2428.1501474483875;2432.8661923594195;2439.658447817307;2347.471818840764;2379.0364902214633;2382.4877651304964;2382.5354055959097;2383.4518060846103;2322.047960336271;2324.023909957805;2340.847844890077;2347.7534858839745;2349.048635302705;8645.567721613894;8695.043545210021;8712.607932642983;8716.738497845075;8718.651253949834;5164.870878228075;5237.580993520509;5253.3170687810725;5258.2638430619745;5264.710440925747;3273.378058168964;3339.482380231068;3343.21434462901;3352.966470335314;3360.8319584020946;993.8409854423257;1061.4215252687227;1067.140951534015;1067.2315932528645;1088.5917780832187;12458.442694663167;12472.189307694971;12475.064370172273;12491.437885295183;12537.811932821014;4531.501534831166;4596.37948876904;4610.285405762045;4721.220998535203;4722.716637001791;10016.198704103654;10039.69880903574;10040.849387259197;10045.347052441713;10051.949740251252;5371.677699338053;5384.300040994645;5389.326334208224;5429.83710488678;5434.157705555645;4910.165271903785;4941.888075183055;4963.652544321935;4973.204287314013;4984.626153038536;3964.742291751085;3988.6210809973004;3989.4467540773926;4095.0990782027907;4096.631303182728;1151.3379806611233;1302.7655022095923;1333.3466601365456;1336.9933150334186;1342.2080972226238;849.8130411309502;861.9008813986346;878.7978764884112;879.6173664455982;887.0818702642863;5771.307443106854;5921.171036054956;6026.126211699367;6033.849153771191;6291.1192433059405;943.2736792669606;970.6699722094522;1002.4937406609761;1005.8189525885265;1017.6743442098457;4148.668106551469;4228.471441069866;4243.560840332754;4276.657867370603;4337.696361254745;10877.0754485868;11122.721931951604;11275.943620281847;11289.096872250364;11335.603253886075;10041.648542300984;11184.664460066211;11192.944035279772;11200.831987520194;11212.887871121184;8064.395170362246;8359.456635318686;8371.414001019992;8381.622826972678;8384.245417912418;5801.245838041028;5832.912506312494;5934.7922822701;5968.70156492165;6041.9395806041375;9653;9762.609495620096;9812.65655702047;9900.900990989998;9971.800563988825;9778.41329520231;10271;10328.845067323846;10553.419561924167;10619.787604248026;7685.730999414994;7820.17888121739;7848.254415830487;7848.64681089341;7855.646495907812;8371.121032291765;8436.114208008315;8493.278071364004;8570.057293697813;8577.142285771373;6782.050512928293;6787.389134977876;7344.596047217455;7624.390048795972;7695.115061767969;7400.555966642019;7419.629018549159;7500.249975002456;7524.887126692995;7601.505902116345;7012.193597736122;7019.719211231493;7038.190608080136;7041.225465198926;7050;5170.400678608762;5180.792768289377;5271.519496380653;5360.865978350573;5429.7556609953435;5186.429492755869;5199.92200116991;5303.7082960436;5335.279737235423;5338.813141540183 23:41:11 INFO - PROCESS | 26193 | |4;prototype.html;327.64614216646027;331.5424713894825;334.8576854836694;342.3273268028324;345.5576861617129;5365.382980957191;5395.271638328824;5422;5438.619296649236;5440.455954404562;5287.250629672568;5327.440618735035;5344.22508736233;5370.489803468674;5379.515843574078;3977.2244412339605;4100.507939047318;4208.726432781875;4241.388272456477;4258.190943720683;4208.347706105558;4217.743507223636;4219.556946520617;4240.5759424057505;4253.659707223414;4174.645155161815;4189.141226048668;4207.810648520808;4212.389203565481;4229.936550951738;4022.9597704022876;4027.7986100694993;4165.271077561415;4191.1768380754165;4215.3887686285625;3697.279030589036;3707.14735610811;3710.5732840723394;3720.4977328060636;3728.2543491301576;5251.55361794248;5253.6322457428;5277.366715994105;5284.260203571503;5299.496547827989;4730.577064713269;4777.307290442866;4802.639802014863;4826.372571565709;4844.425561692464;5502;5518.475744804237;5550.555955523549;5577.330720313547;5579.9163012554845;4096.487939007624;4132.648724858391;4135.648469880064;4152.792360381969;4155.750654960712;5592.608517403743;5788.42115788422;5834.4165583441745;5847.26909136358;5912.3496415394275;4213.789310534461;4229.682773791917;4236.915261694749;4243.936340954888;4262.211490874198;4321.351797230378;4327.5239723630375;4329.246655104687;4330.718503297338;4332.566743325642;4790.592799612003;4883.194272944925;4894.1679914414635;4912.631552633567;4923.655344125948;5660.179274005246;5661.716914154358;5663.66018038919;5681;5682.715864206773;1475.5647084110212;1501.196859680066;1501.8498150185112;1507.8190617125795;1507.8492150785053;963.8457846744487;976.6093562574885;982.4105536677936;984.6455276100598;996.3872218585518;5218.739063046833;5291.523762861284;5329.493698098674;5371.516563509303;5382.461753824587;5764.07774756037;5768.971155144198;5769.1923130761725;5770.336411312669;5772.191893134965;5117.747991942919;5337.919931201035;5366.7853285868905;5368.355797304349;5386.245925570423;3005.520445632362;3008.5637582550844;3017.215523963785;3043.3761078978755;3052.6947305269296;5918.585699001114;5927.110933360031;5950.4049595041015;5950.8809823803285;5978.654802669452;5570.830125673654;5862.941370586324;5875.676837773878;5879.382664820132;5894.705264736746;5943.652257358319;5944.227250457499;5964.910526342108;5969.940300597025;6002.969985150046;5588.916166257591;5760.94239057604;5776.306843178677;5816.284196162227;5831;5725.828225153252;5729;5750.137479378127;5751.971240143773;5755.165501002415;5831.679257640701;5931.673757943355;5999.460048595647;6006.228162692104;6013.158157857991;4106.794660266915;4115.73247738896;4152.6055024772595;4169.45797046382;4174.601508494567;5826.359100499027;5837.182794408701;5846.619969701956;5846.649201047951;5913.763449462145;5579.605098725318;5677.574181936454;5700.144978253295;5761.769529218785;5775.94224057754;5553.527950124123;5633.859153521031;5637.267155269788;5638.351589567253;5667.773289068391;5566.443355664401;5573.442655734556;5576.191452239322;5624.437556244507;5631.267935168402;5402.378726446352;5421.292292927715;5645.1532270159805;5684.317881854204;5692.7722891083895;5519.254900588369;5540.584456165884;5541.916871246854;5556.555475561864;5560.860023695213 23:41:11 INFO - PROCESS | 26193 | |5;yui.html;768.4774353439659;801.8556659801235;812.7074253268825;820.2248874813297;820.9958950205245;15057.548273551783;15798.84201157988;16772.993620382786;16949.661006779857;17055.914720426397;15325.92337038316;15368.769468457982;15454;15458.690826183469;15600.219989000532;809.0614886731378;821.876718492228;823.6869989404018;824.46821799939;824.5506199121493;651.1079820645698;786.1195461083565;812.0336799208923;813.0852790610563;813.9918600814004;849.7068511363569;850.3537311643165;850.9149085091473;851.0213254757048;851.1743608699583;844.7888027993001;844.8437039147777;845.2603971524916;845.3152946113668;846.2130218896424;499.071726588545;608.2093278737624;614.7141579165709;618.703022549179;620.4818976154916;14095.365708543037;14113.435462581485;14131.081479703786;14145.434182632682;14151.646208844759;14080.225587592678;14586.695444689778;14971.326290316852;15242.847571524253;15313.846861531465;12625.873741262561;12671.936640316831;12820.743585128244;13172.934135329262;13585.116967397087;4379.562043795627;4418.403515525395;4420.491643461011;4617.8152873885;4628.490866004737;82990;83041;83584.58207708983;85028.57485712532;87333;10912.29070110456;10996.175286853519;11030.834537481944;11101.555937762561;11205.551777928955;21413.143474261167;21491.140354385963;21505;21549.67675484869;21576.35270941874;7900.367970562456;8253.876191857127;8464.661413543512;8516.148385161434;8537.445066070686;4463.018136010072;4522.615577675934;4549.226631472658;4598.425196850394;4610.170169369479;3199.168216263788;3320.701136897691;3320.9335813284083;3324.1855745342546;3344.6320904700465;596.352957041606;603.1917230910601;609.8379900217299;624.6720471752367;625.5714835337808;656.8916128838688;657.8059472455637;703.3142685881224;707.8088915992756;713.1121753416926;9266.171011117453;9615.9038409615;9825.852612210823;9903.207743380512;10162.4918754062;686.629220221075;689.396777819408;701.137600751079;715.3990647855826;719.5610677486729;4502.257127573979;4884.0476107158765;4935.555799977948;4941.604671626261;4954.801807927714;73937.63031184918;74317.62841185868;74625;83981.58009209915;126142;111189;111390;111694.44152779346;111700;115853;59039.70480147572;59110.704446478354;64090.67954660197;89506;98590.5070474643;9211.631534738803;9212.355135140477;9219.17027467531;9282.814343713222;9323.953380233055;39744;54087.45912540982;54802.45197548133;55553.72223138859;56414.43585564256;78192;82143.5892820532;82344.58827705822;83340;84148.57925710332;11140.832887506856;11400.258983166068;11436;11572.59495917639;11913.285202887855;12145.514179433078;12338.50645974187;12406.875931240933;12480.126391152533;12937.741245175232;11722.43789982125;12460.43928023223;12703.237805731686;12906.612801615967;12950.287734174333;12440.75592440785;12530;12841.229526228457;12879.871201287868;13258.60224193237;12459.822745199916;12878.356082195665;12882.549110781078;13020.804687929878;13281;9884;9985.251106166921;10356.948215258875;10367.222458315506;10698.197635177548;8561.055222867893;9593.616255349707;10175.847362289423;10308.673291752571;10434.269601127848 23:41:11 INFO - PROCESS | 26193 | __end_tp_report 23:41:11 INFO - PROCESS | 26193 | __start_cc_report 23:41:11 INFO - PROCESS | 26193 | _x_x_mozilla_cycle_collect,954 23:41:11 INFO - PROCESS | 26193 | __end_cc_report 23:41:11 INFO - PROCESS | 26193 | __startTimestamp1472625671467__endTimestamp 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | ------- Summary: start ------- 23:41:11 INFO - PROCESS | 26193 | Number of tests: 6 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | [#0] dojo.html Cycles:165 Average:5288.87 Median:5494.29 stddev:586.67 (10.7%) stddev-sans-first:561.24 23:41:11 INFO - PROCESS | 26193 | Values: 3036.9 3055.1 3070.4 3098.1 3128.3 5278.4 5331.0 5360.9 5428.2 5447.9 5349.7 5387.1 5427.7 5432.2 5462.4 4837.9 4856.3 4867.9 4925.2 5051.5 4997.9 5006.9 5013.1 5013.3 5019.3 4778.9 4814.4 4827.0 4876.2 4916.3 4731.1 4732.9 4765.7 4783.8 4786.9 4698.3 4714.6 4746.0 4783.2 4829.2 5137.3 5262.1 5271.3 5294.5 5347.8 5624.2 5680.1 5693.1 5695.9 5703.0 5671.8 5707.9 5728.4 5732.2 5734.8 5197.1 5206.6 5318.5 5322.4 5332.2 5733.8 5780.3 5782.2 5862.0 5862.5 5533.5 5545.9 5547.9 5551.5 5554.3 5485.9 5612.6 5620.1 5621.6 5635.0 5666.8 5740.7 5742.0 5747.2 5749.1 5647.6 5692.7 5700.3 5702.3 5703.0 4351.3 4395.8 4416.7 4425.7 4452.3 3804.1 3915.9 3966.5 3991.4 4067.8 5366.9 5372.4 5380.9 5390.3 5393.2 5756.4 5772.3 5784.3 5786.9 5794.2 5252.7 5339.4 5378.4 5386.0 5441.9 4970.0 4984.4 4989.8 4991.3 5041.7 5945.9 5955.3 5959.2 5959.8 5976.3 5534.1 5564.2 5571.7 5601.5 5683.2 5745.9 5756.5 5762.3 5775.6 5777.6 5455.7 5503.3 5515.8 5516.6 5519.0 5591.3 5654.0 5681.5 5687.7 5780.5 5519.8 5545.2 5549.9 5562.2 5570.7 5555.7 5561.5 5565.1 5569.4 5630.0 5455.3 5468.2 5494.3 5510.4 5552.0 5605.4 5606.8 5625.4 5627.6 5632.0 5486.2 5487.4 5493.8 5500.6 5502.7 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | [#1] ext.html Cycles:180 Average:52775.77 Median:18966.23 stddev:101289.34 (534.1%) stddev-sans-first:101497.67 23:41:11 INFO - PROCESS | 26193 | Values: 578.9 597.7 607.3 617.0 621.0 43381.0 45156.3 45215.5 45313.0 48030.5 45828.3 46284.1 46289.1 46357.0 46368.5 8107.1 8660.8 8809.3 8810.5 10515.4 10368.9 10786.9 10795.5 10799.4 10806.2 10823.7 10883.3 10883.4 10886.5 10890.1 10769.7 10814.0 10816.6 10822.7 10830.6 10775.1 10854.7 10857.8 10860.0 10861.1 42520.4 42812.4 42881.4 42972.6 42973.6 3360.6 3509.3 3514.1 3537.3 3577.3 32570.8 32643.0 32706.7 32908.2 32948.8 4128.9 4222.7 4269.8 4344.6 4394.1 244772.0 245295.0 246283.0 246400.0 247353.0 34423.1 35100.8 58557.0 59206.7 59478.7 36904.3 36994.3 37031.6 37150.8 37190.8 13617.3 13619.7 13711.7 13726.9 13740.7 9539.8 10273.5 10323.8 10391.3 11080.5 8527.2 8527.4 8564.2 8621.7 8626.1 3258.7 3294.4 3297.8 3313.6 3334.3 915.9 978.4 1008.6 1025.2 1065.6 32685.7 32736.7 32768.0 32886.3 32982.7 1030.6 1064.9 1112.2 1114.4 1149.3 16335.4 17285.3 17321.4 17327.0 17341.1 518396.0 523017.0 523070.0 524799.0 524808.0 57763.7 58234.4 58390.4 58436.7 58444.7 1176.4 1304.8 1336.0 1336.8 1341.7 31720.4 33306.2 34108.5 34148.3 34337.5 49884.3 50329.7 50330.0 50481.5 50491.5 318863.0 320798.0 321454.0 321505.0 321590.0 28148.4 28192.3 28296.6 28629.7 30326.5 47218.5 47379.5 47395.3 47679.3 48348.8 39983.2 40151.4 40643.0 40669.8 42364.6 40183.8 40494.8 40816.8 42076.0 42865.8 40542.4 40866.6 41489.6 41828.4 42002.4 33318.0 36278.8 36315.6 36463.6 37165.4 27851.7 28083.3 29372.0 30075.7 30119.8 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | [#2] jquery.html Cycles:180 Average:26410.27 Median:378002.50 stddev:66898.66 (17.7%) stddev-sans-first:67057.76 23:41:11 INFO - PROCESS | 26193 | Values: 370.5 393.2 401.4 406.1 419.8 16201.4 19169.4 19680.7 19738.2 19924.5 17930.5 18755.3 19093.9 19301.2 19339.6 5222.1 5393.6 5402.9 5668.8 5925.5 3975.7 5820.6 5852.6 5854.4 5855.8 5702.1 5935.0 5963.7 6041.8 6047.2 5807.7 5889.2 5930.5 6025.6 6037.1 5764.6 5768.0 5769.6 5772.2 5772.4 12593.9 13819.3 22839.5 23338.2 23489.0 2333.1 2395.8 2409.7 2411.6 2877.7 10355.6 10527.6 12055.0 12559.6 14799.7 1885.6 1907.4 1920.1 1935.8 1987.9 67748.0 73747.0 80767.6 83034.6 85736.6 10871.9 11245.8 11308.5 11333.2 11485.6 16086.3 16091.9 16122.8 16137.4 16149.4 7624.4 7892.3 7929.5 7984.8 8151.5 7267.4 7298.8 7348.7 7528.1 7544.7 4870.8 4920.0 4924.3 4952.9 5009.5 1955.2 1967.0 2001.3 2013.8 2056.1 723.4 842.9 857.4 891.4 894.2 19528.0 19783.2 19814.5 19894.6 19922.0 982.6 1013.7 1035.5 1038.9 1067.1 10218.2 10881.3 10988.9 10997.7 11016.2 375000.0 376534.0 379471.0 413377.0 463327.0 70597.6 83464.0 85245.1 94140.0 97004.0 944.2 950.9 971.5 974.1 984.1 17150.5 17674.9 18084.9 18191.2 18354.4 43009.4 43697.6 43890.0 44218.8 44566.8 59428.0 60361.7 60879.4 60929.1 61976.0 5901.3 7165.7 7494.1 8541.6 8719.9 12330.6 13607.0 13990.2 14027.6 14161.5 11159.3 11647.3 11700.7 11759.5 12196.0 11731.2 11744.7 11815.5 11866.4 12129.2 11639.9 11810.7 11983.5 12005.8 12303.8 8475.2 8559.6 8656.0 8737.8 9085.3 9946.3 11676.7 11814.0 11823.6 11977.2 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | [#3] mootools.html Cycles:180 Average:5805.05 Median:5074.75 stddev:3282.42 (64.7%) stddev-sans-first:3275.37 23:41:11 INFO - PROCESS | 26193 | Values: 1458.3 1475.4 1589.9 1750.5 1765.6 7600.9 8158.4 8295.3 9320.5 9323.2 8104.8 8739.1 8750.0 8763.3 8764.9 2346.7 2369.7 2371.3 2375.2 2377.9 2037.6 2335.5 2340.1 2346.2 2419.2 2404.4 2428.1 2428.2 2432.9 2439.7 2347.5 2379.0 2382.5 2382.5 2383.5 2322.0 2324.0 2340.8 2347.8 2349.0 8645.6 8695.0 8712.6 8716.7 8718.7 5164.9 5237.6 5253.3 5258.3 5264.7 3273.4 3339.5 3343.2 3353.0 3360.8 993.8 1061.4 1067.1 1067.2 1088.6 12458.4 12472.2 12475.1 12491.4 12537.8 4531.5 4596.4 4610.3 4721.2 4722.7 10016.2 10039.7 10040.8 10045.3 10051.9 5371.7 5384.3 5389.3 5429.8 5434.2 4910.2 4941.9 4963.7 4973.2 4984.6 3964.7 3988.6 3989.4 4095.1 4096.6 1151.3 1302.8 1333.3 1337.0 1342.2 849.8 861.9 878.8 879.6 887.1 5771.3 5921.2 6026.1 6033.8 6291.1 943.3 970.7 1002.5 1005.8 1017.7 4148.7 4228.5 4243.6 4276.7 4337.7 10877.1 11122.7 11275.9 11289.1 11335.6 10041.6 11184.7 11192.9 11200.8 11212.9 8064.4 8359.5 8371.4 8381.6 8384.2 5801.2 5832.9 5934.8 5968.7 6041.9 9653.0 9762.6 9812.7 9900.9 9971.8 9778.4 10271.0 10328.8 10553.4 10619.8 7685.7 7820.2 7848.3 7848.6 7855.6 8371.1 8436.1 8493.3 8570.1 8577.1 6782.1 6787.4 7344.6 7624.4 7695.1 7400.6 7419.6 7500.2 7524.9 7601.5 7012.2 7019.7 7038.2 7041.2 7050.0 5170.4 5180.8 5271.5 5360.9 5429.8 5186.4 5199.9 5303.7 5335.3 5338.8 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | [#4] prototype.html Cycles:180 Average:4758.23 Median:5390.76 stddev:1384.69 (25.7%) stddev-sans-first:1348.05 23:41:11 INFO - PROCESS | 26193 | Values: 327.6 331.5 334.9 342.3 345.6 5365.4 5395.3 5422.0 5438.6 5440.5 5287.3 5327.4 5344.2 5370.5 5379.5 3977.2 4100.5 4208.7 4241.4 4258.2 4208.3 4217.7 4219.6 4240.6 4253.7 4174.6 4189.1 4207.8 4212.4 4229.9 4023.0 4027.8 4165.3 4191.2 4215.4 3697.3 3707.1 3710.6 3720.5 3728.3 5251.6 5253.6 5277.4 5284.3 5299.5 4730.6 4777.3 4802.6 4826.4 4844.4 5502.0 5518.5 5550.6 5577.3 5579.9 4096.5 4132.6 4135.6 4152.8 4155.8 5592.6 5788.4 5834.4 5847.3 5912.3 4213.8 4229.7 4236.9 4243.9 4262.2 4321.4 4327.5 4329.2 4330.7 4332.6 4790.6 4883.2 4894.2 4912.6 4923.7 5660.2 5661.7 5663.7 5681.0 5682.7 1475.6 1501.2 1501.8 1507.8 1507.8 963.8 976.6 982.4 984.6 996.4 5218.7 5291.5 5329.5 5371.5 5382.5 5764.1 5769.0 5769.2 5770.3 5772.2 5117.7 5337.9 5366.8 5368.4 5386.2 3005.5 3008.6 3017.2 3043.4 3052.7 5918.6 5927.1 5950.4 5950.9 5978.7 5570.8 5862.9 5875.7 5879.4 5894.7 5943.7 5944.2 5964.9 5969.9 6003.0 5588.9 5760.9 5776.3 5816.3 5831.0 5725.8 5729.0 5750.1 5752.0 5755.2 5831.7 5931.7 5999.5 6006.2 6013.2 4106.8 4115.7 4152.6 4169.5 4174.6 5826.4 5837.2 5846.6 5846.6 5913.8 5579.6 5677.6 5700.1 5761.8 5775.9 5553.5 5633.9 5637.3 5638.4 5667.8 5566.4 5573.4 5576.2 5624.4 5631.3 5402.4 5421.3 5645.2 5684.3 5692.8 5519.3 5540.6 5541.9 5556.6 5560.9 23:41:11 INFO - PROCESS | 26193 | 23:41:11 INFO - PROCESS | 26193 | [#5] yui.html Cycles:180 Average:20314.94 Median:4909.80 stddev:29446.41 (599.7%) stddev-sans-first:29492.44 23:41:11 INFO - PROCESS | 26193 | Values: 768.5 801.9 812.7 820.2 821.0 15057.5 15798.8 16773.0 16949.7 17055.9 15325.9 15368.8 15454.0 15458.7 15600.2 809.1 821.9 823.7 824.5 824.6 651.1 786.1 812.0 813.1 814.0 849.7 850.4 850.9 851.0 851.2 844.8 844.8 845.3 845.3 846.2 499.1 608.2 614.7 618.7 620.5 14095.4 14113.4 14131.1 14145.4 14151.6 14080.2 14586.7 14971.3 15242.8 15313.8 12625.9 12671.9 12820.7 13172.9 13585.1 4379.6 4418.4 4420.5 4617.8 4628.5 82990.0 83041.0 83584.6 85028.6 87333.0 10912.3 10996.2 11030.8 11101.6 11205.6 21413.1 21491.1 21505.0 21549.7 21576.4 7900.4 8253.9 8464.7 8516.1 8537.4 4463.0 4522.6 4549.2 4598.4 4610.2 3199.2 3320.7 3320.9 3324.2 3344.6 596.4 603.2 609.8 624.7 625.6 656.9 657.8 703.3 707.8 713.1 9266.2 9615.9 9825.9 9903.2 10162.5 686.6 689.4 701.1 715.4 719.6 4502.3 4884.0 4935.6 4941.6 4954.8 73937.6 74317.6 74625.0 83981.6 126142.0 111189.0 111390.0 111694.4 111700.0 115853.0 59039.7 59110.7 64090.7 89506.0 98590.5 9211.6 9212.4 9219.2 9282.8 9324.0 39744.0 54087.5 54802.5 55553.7 56414.4 78192.0 82143.6 82344.6 83340.0 84148.6 11140.8 11400.3 11436.0 11572.6 11913.3 12145.5 12338.5 12406.9 12480.1 12937.7 11722.4 12460.4 12703.2 12906.6 12950.3 12440.8 12530.0 12841.2 12879.9 13258.6 12459.8 12878.4 12882.5 13020.8 13281.0 9884.0 9985.3 10356.9 10367.2 10698.2 8561.1 9593.6 10175.8 10308.7 10434.3 23:41:11 INFO - PROCESS | 26193 | -------- Summary: end -------- 23:41:11 INFO - PROCESS | 26193 | 23:41:12 INFO - TEST-INFO | 26193: exit 0 23:41:12 INFO - TEST-OK | dromaeo_css | took 1116012ms 23:41:12 INFO - TEST-START | kraken 23:41:12 INFO - operating with platform_type : linux_ 23:41:12 INFO - Initialising browser for kraken test... 23:41:12 INFO - TEST-INFO | started process 26494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoBwuOW/profile http://localhost:54297/getInfo.html) 23:41:16 INFO - PROCESS | 26494 | __metrics Screen width/height:1600/1200 23:41:16 INFO - PROCESS | 26494 | colorDepth:24 23:41:16 INFO - PROCESS | 26494 | Browser inner width/height: 1024/697 23:41:16 INFO - PROCESS | 26494 | __metrics 23:41:16 INFO - PROCESS | 26494 | 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" 23:41:16 INFO - PROCESS | 26494 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:41:17 INFO - PROCESS | 26494 | console.error: PushService: 23:41:17 INFO - PROCESS | 26494 | stateChangeProcessEnqueue: Error transitioning state 23:41:17 INFO - PROCESS | 26494 | UnknownError 23:41:18 INFO - TEST-INFO | 26494: exit 0 23:41:18 INFO - Browser initialized. 23:41:18 INFO - Running cycle 1/1 for kraken test... 23:41:18 INFO - TEST-INFO | started process 26575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoBwuOW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:41:30 INFO - PROCESS | 26575 | RSS: Main: 180109312 23:41:30 INFO - PROCESS | 26575 | 23:41:32 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-beat-detection) 23:41:33 INFO - PROCESS | 26575 | RSS: Main: 233594880 23:41:33 INFO - PROCESS | 26575 | 23:41:36 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-dft) 23:41:36 INFO - PROCESS | 26575 | RSS: Main: 223969280 23:41:36 INFO - PROCESS | 26575 | 23:41:40 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-fft) 23:41:40 INFO - PROCESS | 26575 | RSS: Main: 301363200 23:41:40 INFO - PROCESS | 26575 | 23:41:42 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54297/tests/kraken/driver.html?testName=audio-oscillator) 23:41:43 INFO - PROCESS | 26575 | RSS: Main: 211988480 23:41:43 INFO - PROCESS | 26575 | 23:41:45 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:41:46 INFO - PROCESS | 26575 | RSS: Main: 213848064 23:41:46 INFO - PROCESS | 26575 | 23:41:49 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54297/tests/kraken/driver.html?testName=imaging-darkroom) 23:41:49 INFO - PROCESS | 26575 | RSS: Main: 251678720 23:41:49 INFO - PROCESS | 26575 | 23:41:53 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54297/tests/kraken/driver.html?testName=imaging-desaturate) 23:41:53 INFO - PROCESS | 26575 | RSS: Main: 250388480 23:41:53 INFO - PROCESS | 26575 | 23:41:56 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54297/tests/kraken/driver.html?testName=json-parse-financial) 23:41:57 INFO - PROCESS | 26575 | RSS: Main: 250769408 23:41:57 INFO - PROCESS | 26575 | 23:41:58 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:41:59 INFO - PROCESS | 26575 | RSS: Main: 213831680 23:41:59 INFO - PROCESS | 26575 | 23:42:01 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:42:01 INFO - PROCESS | 26575 | RSS: Main: 221958144 23:42:01 INFO - PROCESS | 26575 | 23:42:03 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:42:04 INFO - PROCESS | 26575 | RSS: Main: 221958144 23:42:04 INFO - PROCESS | 26575 | 23:42:06 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:42:07 INFO - PROCESS | 26575 | RSS: Main: 222490624 23:42:07 INFO - PROCESS | 26575 | 23:42:10 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:42:10 INFO - PROCESS | 26575 | RSS: Main: 220479488 23:42:10 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | Cycle 1(1): loaded http://localhost:54297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54297/tests/kraken/driver.html?testName=ai-astar) 23:42:12 INFO - PROCESS | 26575 | RSS: Main: 271663104 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | __start_tp_report 23:42:12 INFO - PROCESS | 26575 | _x_x_mozilla_page_load 23:42:12 INFO - PROCESS | 26575 | _x_x_mozilla_page_load_details 23:42:12 INFO - PROCESS | 26575 | |i|pagename|runs| 23:42:12 INFO - PROCESS | 26575 | |0;ai-astar;112;111;128;111;112;109;111;110;111;111 23:42:12 INFO - PROCESS | 26575 | |1;audio-beat-detection;153;118;145;174;120;149;157;120;173;119 23:42:12 INFO - PROCESS | 26575 | |2;audio-dft;162;163;165;160;162;163;160;161;160;163 23:42:12 INFO - PROCESS | 26575 | |3;audio-fft;75;75;75;181;77;75;75;74;162;77 23:42:12 INFO - PROCESS | 26575 | |4;audio-oscillator;82;83;152;84;84;82;147;82;82;152 23:42:12 INFO - PROCESS | 26575 | |5;imaging-gaussian-blur;116;116;116;117;116;116;117;117;116;117 23:42:12 INFO - PROCESS | 26575 | |6;imaging-darkroom;151;158;152;151;156;158;156;160;151;151 23:42:12 INFO - PROCESS | 26575 | |7;imaging-desaturate;96;96;95;97;96;96;96;96;96;96 23:42:12 INFO - PROCESS | 26575 | |8;json-parse-financial;51;52;54;55;52;53;53;53;52;53 23:42:12 INFO - PROCESS | 26575 | |9;json-stringify-tinderbox;67;67;66;66;66;66;66;66;67;66 23:42:12 INFO - PROCESS | 26575 | |10;stanford-crypto-aes;79;78;78;79;81;78;79;78;81;78 23:42:12 INFO - PROCESS | 26575 | |11;stanford-crypto-ccm;128;124;129;124;131;138;137;128;163;134 23:42:12 INFO - PROCESS | 26575 | |12;stanford-crypto-pbkdf2;166;167;166;167;163;165;164;164;165;167 23:42:12 INFO - PROCESS | 26575 | |13;stanford-crypto-sha256-iterative;65;69;69;65;66;66;67;66;64;63 23:42:12 INFO - PROCESS | 26575 | __end_tp_report 23:42:12 INFO - PROCESS | 26575 | __start_cc_report 23:42:12 INFO - PROCESS | 26575 | _x_x_mozilla_cycle_collect,1734 23:42:12 INFO - PROCESS | 26575 | __end_cc_report 23:42:12 INFO - PROCESS | 26575 | __startTimestamp1472625732844__endTimestamp 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | ------- Summary: start ------- 23:42:12 INFO - PROCESS | 26575 | Number of tests: 14 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#0] ai-astar Cycles:10 Average:112.60 Median:111.00 stddev:5.48 (4.9%) stddev-sans-first:5.81 23:42:12 INFO - PROCESS | 26575 | Values: 112.0 111.0 128.0 111.0 112.0 109.0 111.0 110.0 111.0 111.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:151.00 stddev:22.25 (14.7%) stddev-sans-first:23.29 23:42:12 INFO - PROCESS | 26575 | Values: 153.0 118.0 145.0 174.0 120.0 149.0 157.0 120.0 173.0 119.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.66 (1.0%) stddev-sans-first:1.76 23:42:12 INFO - PROCESS | 26575 | Values: 162.0 163.0 165.0 160.0 162.0 163.0 160.0 161.0 160.0 163.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:40.79 (54.4%) stddev-sans-first:42.64 23:42:12 INFO - PROCESS | 26575 | Values: 75.0 75.0 75.0 181.0 77.0 75.0 75.0 74.0 162.0 77.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:82.00 stddev:32.70 (39.9%) stddev-sans-first:33.79 23:42:12 INFO - PROCESS | 26575 | Values: 82.0 83.0 152.0 84.0 84.0 82.0 147.0 82.0 82.0 152.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:42:12 INFO - PROCESS | 26575 | Values: 116.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#6] imaging-darkroom Cycles:10 Average:154.40 Median:156.00 stddev:3.57 (2.3%) stddev-sans-first:3.56 23:42:12 INFO - PROCESS | 26575 | Values: 151.0 158.0 152.0 151.0 156.0 158.0 156.0 160.0 151.0 151.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 23:42:12 INFO - PROCESS | 26575 | Values: 96.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.14 (2.1%) stddev-sans-first:1.00 23:42:12 INFO - PROCESS | 26575 | Values: 51.0 52.0 54.0 55.0 52.0 53.0 53.0 53.0 52.0 53.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 23:42:12 INFO - PROCESS | 26575 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:1.20 (1.5%) stddev-sans-first:1.27 23:42:12 INFO - PROCESS | 26575 | Values: 79.0 78.0 78.0 79.0 81.0 78.0 79.0 78.0 81.0 78.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.50 stddev:11.40 (8.6%) stddev-sans-first:11.91 23:42:12 INFO - PROCESS | 26575 | Values: 128.0 124.0 129.0 124.0 131.0 138.0 137.0 128.0 163.0 134.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:166.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 23:42:12 INFO - PROCESS | 26575 | Values: 166.0 167.0 166.0 167.0 163.0 165.0 164.0 164.0 165.0 167.0 23:42:12 INFO - PROCESS | 26575 | 23:42:12 INFO - PROCESS | 26575 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.94 (2.9%) stddev-sans-first:2.03 23:42:12 INFO - PROCESS | 26575 | Values: 65.0 69.0 69.0 65.0 66.0 66.0 67.0 66.0 64.0 63.0 23:42:12 INFO - PROCESS | 26575 | -------- Summary: end -------- 23:42:12 INFO - PROCESS | 26575 | 23:42:13 INFO - TEST-INFO | 26575: exit 0 23:42:14 INFO - TEST-OK | kraken | took 61697ms 23:42:14 INFO - SUITE-END | took 1177s 23:42:14 INFO - Completed test suite (00:19:38) 23:42:14 INFO - javascript benchmark 23:42:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.939261214776, 3055.083474957513, 3070.4166208420397, 3098.0550931965768, 3128.327409606934, 5278.445763194867, 5331.0, 5360.865978350544, 5428.185772134177, 5447.891042179154, 5349.732513374325, 5387.0841956867325, 5427.701476418805, 5432.185172224168, 5462.426445223244, 4837.903241935159, 4856.271559266103, 4867.8783030424165, 4925.187344088221, 5051.520105589963, 4997.875053123665, 5006.949930500685, 5013.09764242438, 5013.273075404064, 5019.29729837823, 4778.904421911577, 4814.398200224972, 4827.010462855106, 4876.195427754416, 4916.262560615918, 4731.148393289207, 4732.881677958044, 4765.69023013503, 4783.784729687172, 4786.856394308176, 4698.271767875985, 4714.575688188045, 4746.0, 4783.1868582341085, 4829.1790395632825, 5137.280780690707, 5262.105442074857, 5271.341082364705, 5294.54996325309, 5347.812826551052, 5624.15637654351, 5680.091185410314, 5693.117566777156, 5695.857603559903, 5702.971485142589, 5671.829845104653, 5707.857303567403, 5728.42715728428, 5732.22614946981, 5734.827955161351, 5197.1164901966, 5206.583473322125, 5318.521333080042, 5322.414534401213, 5332.200169974496, 5733.770649173986, 5780.306363236438, 5782.190493330937, 5862.032764593794, 5862.472377486047, 5533.501984821385, 5545.944540554543, 5547.916781248285, 5551.500364967092, 5554.305711786027, 5485.945140548543, 5612.635178713371, 5620.100783874561, 5621.606487545914, 5635.0, 5666.801661941812, 5740.712964351766, 5741.971290143522, 5747.195392645033, 5749.051406517961, 5647.604667673306, 5692.743826527733, 5700.3444603871085, 5702.344230413472, 5703.030484817591, 4351.282038463618, 4395.824167033346, 4416.6908316418185, 4425.690201685916, 4452.265376212888, 3804.1060350817534, 3915.92168156641, 3966.504186976628, 3991.4012898064943, 4067.7559346439307, 5366.946330536723, 5372.435894231049, 5380.946190538123, 5390.299261096033, 5393.191021346751, 5756.378797853489, 5772.278465191851, 5784.2769653793275, 5786.884262314814, 5794.159846822272, 5252.684838909601, 5339.41266460689, 5378.435264297271, 5385.973070134624, 5441.863953401117, 4969.950300496948, 4984.4267909190185, 4989.825356112518, 4991.276264941564, 5041.6722913010535, 5945.940540594539, 5955.285365756137, 5959.195508606283, 5959.791407300723, 5976.342602313742, 5534.05920993424, 5564.19319198722, 5571.721413929206, 5601.495865372136, 5683.1759394886685, 5745.885082298247, 5756.481916627524, 5762.279715035621, 5775.624584402, 5777.62445441045, 5455.727213639381, 5503.3120859892515, 5515.806946756844, 5516.558675306046, 5519.0, 5591.329040515164, 5654.038813401649, 5681.460261275172, 5687.687177205294, 5780.468175933297, 5519.751611177427, 5545.1682247663175, 5549.861253468695, 5562.22128901946, 5570.721463926707, 5555.749991250323, 5561.499465048165, 5565.0817615094675, 5569.415211402745, 5630.014747419267, 5455.263539422127, 5468.152436372368, 5494.2857428535635, 5510.366307874486, 5552.028395030934, 5605.355384130877, 5606.831795046155, 5625.437456254342, 5627.606067575394, 5632.042552765957, 5486.177073439016, 5487.396386397573, 5493.7802487900035, 5500.559955203654, 5502.697351645538], "value": 5249.937807491116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9131630255464, 597.6653074278404, 607.2803727582815, 616.9784057557987, 621.0342916764432, 43381.0, 45156.32265516012, 45215.54784452155, 45313.0, 48030.51969480304, 45828.31257531131, 46284.074318513696, 46289.07421851561, 46357.0, 46368.53631463693, 8107.148749381318, 8660.826783464327, 8809.251213646849, 8810.471371717686, 10515.421651809147, 10368.896311036868, 10786.892131078706, 10795.460226988658, 10799.352038877652, 10806.243562950596, 10823.67528974132, 10883.346999180036, 10883.4423910381, 10886.455677216147, 10890.128789696806, 10769.676909692682, 10814.026737593615, 10816.621418250403, 10822.72943176419, 10830.566777328897, 10775.137988960943, 10854.728631784268, 10857.837132443019, 10860.0, 10861.076808471289, 42520.362194567104, 42812.35781463281, 42881.35677964833, 42972.57027429748, 42973.57026429727, 3360.5967283925843, 3509.31568344173, 3514.139035936212, 3537.2925414917117, 3577.266660334625, 32570.83714581412, 32643.0, 32706.6729332706, 32908.17729556756, 32948.83525582357, 4128.91742165158, 4222.746635201897, 4269.829206831754, 4344.565543445662, 4394.099209662011, 244772.0, 245295.0, 246283.0, 246400.0, 247352.9999999982, 34423.13942151416, 35100.82449587787, 58557.0, 59206.703966479894, 59478.70260648755, 36904.261914761555, 36994.26011479755, 37031.62968370336, 37150.814245928595, 37190.814045930136, 13617.319134043259, 13619.727605447835, 13711.725765484634, 13726.93136534331, 13740.725185496234, 9539.809203816023, 10273.486325683836, 10323.84514232287, 10391.324563903474, 11080.501377438035, 8527.232549070613, 8527.360447966428, 8564.186402291773, 8621.655133794578, 8626.137386261324, 3258.6741325867224, 3294.357600267973, 3297.8186199759243, 3313.6355000949875, 3334.283129127249, 915.876356691838, 978.3885071830106, 1008.6368907193405, 1025.205465764024, 1065.6110519660424, 32685.673143268737, 32736.672633273363, 32768.0, 32886.342273154405, 32982.67017329844, 1030.6083688198437, 1064.9361038337724, 1112.2158877990996, 1114.403793970222, 1149.2989276541302, 16335.395353714006, 17285.308587656604, 17321.393751218646, 17327.0, 17341.132943352783, 518396.0, 523017.0, 523070.0, 524799.0, 524808.0, 57763.711181443825, 58234.417655823745, 58390.41609583935, 58436.70781646064, 58444.7077764617, 1176.3647630279554, 1304.8108024336607, 1335.9732805343838, 1336.8395792504962, 1341.7182391697659, 31720.36559268848, 33306.167345816546, 34108.488372673935, 34148.31703365968, 34337.54068429059, 49884.25173622326, 50329.74835125801, 50330.0, 50481.49518504768, 50491.49508505015, 318863.0, 320798.0, 321454.0, 321505.0, 321590.0, 28148.43703125885, 28192.29519262035, 28296.575551366335, 28629.713702862704, 30326.54510182305, 47218.52781472141, 47379.52620473889, 47395.289070663275, 47679.28481072717, 48348.75825620849, 39983.20033599254, 40151.397729034674, 40643.0, 40669.79665101656, 42364.576354236066, 40183.77151541516, 40494.79752601218, 40816.79591602023, 42076.0, 42865.78567107145, 40542.39186412265, 40866.59133408747, 41489.58510414857, 41828.37257441202, 42002.369964451165, 33318.0, 36278.8186059068, 36315.62520126681, 36463.635363646026, 37165.44251836279, 27851.721482784913, 28083.297917552223, 29372.0, 30075.699243008166, 30119.849400752857], "value": 18820.176331067687, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4757767758622, 393.205724436638, 401.4359824446652, 406.06807377069623, 419.84465747673363, 16201.351945922164, 19169.42491725247, 19680.704789428153, 19738.210471581155, 19924.50188745282, 17930.462086137402, 18755.3435629753, 19093.904530477328, 19301.22795088195, 19339.613207735838, 5222.060029194753, 5393.568514518849, 5402.945970540303, 5668.773249070032, 5925.4963328117165, 3975.681945444372, 5820.592558520905, 5852.648841069528, 5854.414558544154, 5855.824325270249, 5702.059160238556, 5934.970325148368, 5963.671998040106, 6041.758329666808, 6047.183630209931, 5807.709614519257, 5889.234399528077, 5930.525557955353, 6025.5782095253135, 6037.094435834638, 5764.625299355528, 5768.048272035109, 5769.596128271022, 5772.191893134965, 5772.422757724236, 12593.874061259361, 13819.309034548332, 22839.543209135725, 23338.183163589194, 23489.0, 2333.10175582402, 2395.796357309631, 2409.6506006629115, 2411.646536544229, 2877.7122287771263, 10355.585776568929, 10527.578896844117, 12054.975327097207, 12559.56041538551, 14799.70400591982, 1885.566319746466, 1907.4087033019669, 1920.0879582198484, 1935.806419358067, 1987.9403617891487, 67748.0, 73746.99999999946, 80767.5961620194, 83034.58482707548, 85736.57131714301, 10871.891281087246, 11245.775084498264, 11308.491117899714, 11333.206675532634, 11485.598004069818, 16086.276117574736, 16091.919540402458, 16122.77544491083, 16137.435189768301, 16149.434769783002, 7624.428167887319, 7892.329152022143, 7929.532722211143, 7984.800379990546, 8151.5109093454585, 7267.418606511466, 7298.817529561803, 7348.7218962121915, 7528.134264559646, 7544.660490277951, 4870.780814863339, 4919.950800492021, 4924.3105965164905, 4952.913846077001, 5009.499050094962, 1955.2276850643916, 1966.9508262293557, 2001.2595339724105, 2013.788552202027, 2056.126146387779, 723.3706675192616, 842.928351090152, 857.4212406625503, 891.3910391742966, 894.2264940826138, 19528.0, 19783.20867165326, 19814.50463738418, 19894.60210795776, 19922.0, 982.5824024789435, 1013.6502906497394, 1035.53918506264, 1038.9324693894873, 1067.0556557446716, 10218.18254539635, 10881.347119172875, 10988.945055274673, 10997.725056873642, 11016.17378696601, 375000.0, 376534.0, 379471.0, 413377.0, 463327.0, 70597.64701176461, 83464.0, 85245.14754852497, 94140.0, 97004.0, 944.2021491839522, 950.9286803489766, 971.4754032822196, 974.1184228273424, 984.104464936904, 17150.485485435456, 17674.911625442306, 18084.90957545204, 18191.181396837437, 18354.449366519028, 43009.3548596765, 43697.56302436935, 43890.0, 44218.77890610526, 44566.77716611396, 59428.0, 60361.69819150876, 60879.39120608737, 60929.08606370819, 61976.0, 5901.262342207224, 7165.749198778018, 7494.063242094739, 8541.572921353783, 8719.869201962103, 12330.568430104904, 13607.047506674438, 13990.160590364203, 14027.649308767363, 14161.504347347793, 11159.330440173291, 11647.301161929972, 11700.70748231301, 11759.470823812779, 12196.0, 11731.23746956445, 11744.701161940966, 11815.527378904748, 11866.406679666155, 12129.21160124589, 11639.941800290944, 11810.704732381759, 11983.460744266704, 12005.75988480243, 12303.75392492163, 8475.194856488624, 8559.61481733336, 8656.0, 8737.825243494968, 9085.318601105077, 9946.303758736818, 11676.70808229801, 11814.0, 11823.586174483851, 11977.161598688008], "value": 9145.417659122624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.256289292461, 1475.3508456279237, 1589.9284532196057, 1750.4836073358374, 1765.6203916158015, 7600.92399076009, 8158.428909976304, 8295.253427191552, 9320.48737319448, 9323.160915517603, 8104.837903241932, 8739.082396348387, 8749.95625021874, 8763.255123314526, 8764.91235087649, 2346.718393792747, 2369.7156341239074, 2371.2530552875874, 2375.2043065573052, 2377.9167729129485, 2037.602667479842, 2335.4628435459854, 2340.1458467659268, 2346.2374728213313, 2419.2258477287187, 2404.3770454942933, 2428.0530593068715, 2428.1501474483875, 2432.8661923594195, 2439.658447817307, 2347.471818840764, 2379.0364902214633, 2382.4877651304964, 2382.5354055959097, 2383.4518060846103, 2322.047960336271, 2324.023909957805, 2340.847844890077, 2347.7534858839745, 2349.048635302705, 8645.567721613894, 8695.043545210021, 8712.607932642983, 8716.738497845075, 8718.651253949834, 5164.870878228075, 5237.580993520509, 5253.3170687810725, 5258.2638430619745, 5264.710440925747, 3273.378058168964, 3339.482380231068, 3343.21434462901, 3352.966470335314, 3360.8319584020946, 993.8409854423257, 1061.4215252687227, 1067.140951534015, 1067.2315932528645, 1088.5917780832187, 12458.442694663167, 12472.189307694971, 12475.064370172273, 12491.437885295183, 12537.811932821014, 4531.501534831166, 4596.37948876904, 4610.285405762045, 4721.220998535203, 4722.716637001791, 10016.198704103654, 10039.69880903574, 10040.849387259197, 10045.347052441713, 10051.949740251252, 5371.677699338053, 5384.300040994645, 5389.326334208224, 5429.83710488678, 5434.157705555645, 4910.165271903785, 4941.888075183055, 4963.652544321935, 4973.204287314013, 4984.626153038536, 3964.742291751085, 3988.6210809973004, 3989.4467540773926, 4095.0990782027907, 4096.631303182728, 1151.3379806611233, 1302.7655022095923, 1333.3466601365456, 1336.9933150334186, 1342.2080972226238, 849.8130411309502, 861.9008813986346, 878.7978764884112, 879.6173664455982, 887.0818702642863, 5771.307443106854, 5921.171036054956, 6026.126211699367, 6033.849153771191, 6291.1192433059405, 943.2736792669606, 970.6699722094522, 1002.4937406609761, 1005.8189525885265, 1017.6743442098457, 4148.668106551469, 4228.471441069866, 4243.560840332754, 4276.657867370603, 4337.696361254745, 10877.0754485868, 11122.721931951604, 11275.943620281847, 11289.096872250364, 11335.603253886075, 10041.648542300984, 11184.664460066211, 11192.944035279772, 11200.831987520194, 11212.887871121184, 8064.395170362246, 8359.456635318686, 8371.414001019992, 8381.622826972678, 8384.245417912418, 5801.245838041028, 5832.912506312494, 5934.7922822701, 5968.70156492165, 6041.9395806041375, 9653.0, 9762.609495620096, 9812.65655702047, 9900.900990989998, 9971.800563988825, 9778.41329520231, 10271.0, 10328.845067323846, 10553.419561924167, 10619.787604248026, 7685.730999414994, 7820.17888121739, 7848.254415830487, 7848.64681089341, 7855.646495907812, 8371.121032291765, 8436.114208008315, 8493.278071364004, 8570.057293697813, 8577.142285771373, 6782.050512928293, 6787.389134977876, 7344.596047217455, 7624.390048795972, 7695.115061767969, 7400.555966642019, 7419.629018549159, 7500.249975002456, 7524.887126692995, 7601.505902116345, 7012.193597736122, 7019.719211231493, 7038.190608080136, 7041.225465198926, 7050.0, 5170.400678608762, 5180.792768289377, 5271.519496380653, 5360.865978350573, 5429.7556609953435, 5186.429492755869, 5199.92200116991, 5303.7082960436, 5335.279737235423, 5338.813141540183], "value": 4650.0353017187945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.64614216646027, 331.5424713894825, 334.8576854836694, 342.3273268028324, 345.5576861617129, 5365.382980957191, 5395.271638328824, 5422.0, 5438.619296649236, 5440.455954404562, 5287.250629672568, 5327.440618735035, 5344.22508736233, 5370.489803468674, 5379.515843574078, 3977.2244412339605, 4100.507939047318, 4208.726432781875, 4241.388272456477, 4258.190943720683, 4208.347706105558, 4217.743507223636, 4219.556946520617, 4240.5759424057505, 4253.659707223414, 4174.645155161815, 4189.141226048668, 4207.810648520808, 4212.389203565481, 4229.936550951738, 4022.9597704022876, 4027.7986100694993, 4165.271077561415, 4191.1768380754165, 4215.3887686285625, 3697.279030589036, 3707.14735610811, 3710.5732840723394, 3720.4977328060636, 3728.2543491301576, 5251.55361794248, 5253.6322457428, 5277.366715994105, 5284.260203571503, 5299.496547827989, 4730.577064713269, 4777.307290442866, 4802.639802014863, 4826.372571565709, 4844.425561692464, 5502.0, 5518.475744804237, 5550.555955523549, 5577.330720313547, 5579.9163012554845, 4096.487939007624, 4132.648724858391, 4135.648469880064, 4152.792360381969, 4155.750654960712, 5592.608517403743, 5788.42115788422, 5834.4165583441745, 5847.26909136358, 5912.3496415394275, 4213.789310534461, 4229.682773791917, 4236.915261694749, 4243.936340954888, 4262.211490874198, 4321.351797230378, 4327.5239723630375, 4329.246655104687, 4330.718503297338, 4332.566743325642, 4790.592799612003, 4883.194272944925, 4894.1679914414635, 4912.631552633567, 4923.655344125948, 5660.179274005246, 5661.716914154358, 5663.66018038919, 5681.0, 5682.715864206773, 1475.5647084110212, 1501.196859680066, 1501.8498150185112, 1507.8190617125795, 1507.8492150785053, 963.8457846744487, 976.6093562574885, 982.4105536677936, 984.6455276100598, 996.3872218585518, 5218.739063046833, 5291.523762861284, 5329.493698098674, 5371.516563509303, 5382.461753824587, 5764.07774756037, 5768.971155144198, 5769.1923130761725, 5770.336411312669, 5772.191893134965, 5117.747991942919, 5337.919931201035, 5366.7853285868905, 5368.355797304349, 5386.245925570423, 3005.520445632362, 3008.5637582550844, 3017.215523963785, 3043.3761078978755, 3052.6947305269296, 5918.585699001114, 5927.110933360031, 5950.4049595041015, 5950.8809823803285, 5978.654802669452, 5570.830125673654, 5862.941370586324, 5875.676837773878, 5879.382664820132, 5894.705264736746, 5943.652257358319, 5944.227250457499, 5964.910526342108, 5969.940300597025, 6002.969985150046, 5588.916166257591, 5760.94239057604, 5776.306843178677, 5816.284196162227, 5831.0, 5725.828225153252, 5729.0, 5750.137479378127, 5751.971240143773, 5755.165501002415, 5831.679257640701, 5931.673757943355, 5999.460048595647, 6006.228162692104, 6013.158157857991, 4106.794660266915, 4115.73247738896, 4152.6055024772595, 4169.45797046382, 4174.601508494567, 5826.359100499027, 5837.182794408701, 5846.619969701956, 5846.649201047951, 5913.763449462145, 5579.605098725318, 5677.574181936454, 5700.144978253295, 5761.769529218785, 5775.94224057754, 5553.527950124123, 5633.859153521031, 5637.267155269788, 5638.351589567253, 5667.773289068391, 5566.443355664401, 5573.442655734556, 5576.191452239322, 5624.437556244507, 5631.267935168402, 5402.378726446352, 5421.292292927715, 5645.1532270159805, 5684.317881854204, 5692.7722891083895, 5519.254900588369, 5540.584456165884, 5541.916871246854, 5556.555475561864, 5560.860023695213], "value": 4318.503860633421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.4774353439659, 801.8556659801235, 812.7074253268825, 820.2248874813297, 820.9958950205245, 15057.548273551783, 15798.84201157988, 16772.993620382786, 16949.661006779857, 17055.914720426397, 15325.92337038316, 15368.769468457982, 15454.0, 15458.690826183469, 15600.219989000532, 809.0614886731378, 821.876718492228, 823.6869989404018, 824.46821799939, 824.5506199121493, 651.1079820645698, 786.1195461083565, 812.0336799208923, 813.0852790610563, 813.9918600814004, 849.7068511363569, 850.3537311643165, 850.9149085091473, 851.0213254757048, 851.1743608699583, 844.7888027993001, 844.8437039147777, 845.2603971524916, 845.3152946113668, 846.2130218896424, 499.071726588545, 608.2093278737624, 614.7141579165709, 618.703022549179, 620.4818976154916, 14095.365708543037, 14113.435462581485, 14131.081479703786, 14145.434182632682, 14151.646208844759, 14080.225587592678, 14586.695444689778, 14971.326290316852, 15242.847571524253, 15313.846861531465, 12625.873741262561, 12671.936640316831, 12820.743585128244, 13172.934135329262, 13585.116967397087, 4379.562043795627, 4418.403515525395, 4420.491643461011, 4617.8152873885, 4628.490866004737, 82990.0, 83041.0, 83584.58207708983, 85028.57485712532, 87333.0, 10912.29070110456, 10996.175286853519, 11030.834537481944, 11101.555937762561, 11205.551777928955, 21413.143474261167, 21491.140354385963, 21505.0, 21549.67675484869, 21576.35270941874, 7900.367970562456, 8253.876191857127, 8464.661413543512, 8516.148385161434, 8537.445066070686, 4463.018136010072, 4522.615577675934, 4549.226631472658, 4598.425196850394, 4610.170169369479, 3199.168216263788, 3320.701136897691, 3320.9335813284083, 3324.1855745342546, 3344.6320904700465, 596.352957041606, 603.1917230910601, 609.8379900217299, 624.6720471752367, 625.5714835337808, 656.8916128838688, 657.8059472455637, 703.3142685881224, 707.8088915992756, 713.1121753416926, 9266.171011117453, 9615.9038409615, 9825.852612210823, 9903.207743380512, 10162.4918754062, 686.629220221075, 689.396777819408, 701.137600751079, 715.3990647855826, 719.5610677486729, 4502.257127573979, 4884.0476107158765, 4935.555799977948, 4941.604671626261, 4954.801807927714, 73937.63031184918, 74317.62841185868, 74625.0, 83981.58009209915, 126142.0, 111189.0, 111390.0, 111694.44152779346, 111700.0, 115853.0, 59039.70480147572, 59110.704446478354, 64090.67954660197, 89506.0, 98590.5070474643, 9211.631534738803, 9212.355135140477, 9219.17027467531, 9282.814343713222, 9323.953380233055, 39744.0, 54087.45912540982, 54802.45197548133, 55553.72223138859, 56414.43585564256, 78192.0, 82143.5892820532, 82344.58827705822, 83340.0, 84148.57925710332, 11140.832887506856, 11400.258983166068, 11436.0, 11572.59495917639, 11913.285202887855, 12145.514179433078, 12338.50645974187, 12406.875931240933, 12480.126391152533, 12937.741245175232, 11722.43789982125, 12460.43928023223, 12703.237805731686, 12906.612801615967, 12950.287734174333, 12440.75592440785, 12530.0, 12841.229526228457, 12879.871201287868, 13258.60224193237, 12459.822745199916, 12878.356082195665, 12882.549110781078, 13020.804687929878, 13281.0, 9884.0, 9985.251106166921, 10356.948215258875, 10367.222458315506, 10698.197635177548, 8561.055222867893, 9593.616255349707, 10175.847362289423, 10308.673291752571, 10434.269601127848], "value": 7406.752807382653, "unit": "score"}], "name": "dromaeo_css", "value": 7157.14967587764, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 128.0, 111.0, 112.0, 109.0, 111.0, 110.0, 111.0, 111.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 145.0, 174.0, 120.0, 149.0, 157.0, 120.0, 173.0, 119.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 160.0, 162.0, 163.0, 160.0, 161.0, 160.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 181.0, 77.0, 75.0, 75.0, 74.0, 162.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 152.0, 84.0, 84.0, 82.0, 147.0, 82.0, 82.0, 152.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 158.0, 152.0, 151.0, 156.0, 158.0, 156.0, 160.0, 151.0, 151.0], "value": 154.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 55.0, 52.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 81.0, 78.0, 79.0, 78.0, 81.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 129.0, 124.0, 131.0, 138.0, 137.0, 128.0, 163.0, 134.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 166.0, 167.0, 163.0, 165.0, 164.0, 164.0, 165.0, 167.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 69.0, 65.0, 66.0, 66.0, 67.0, 66.0, 64.0, 63.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1544.7, "alertThreshold": 2.0}]} 23:42:14 INFO - Return code: 0 23:42:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:42:14 INFO - # TBPL SUCCESS # 23:42:14 INFO - Running post-action listener: _resource_record_post_action 23:42:14 INFO - [mozharness: 2016-08-31 06:42:14.638184Z] Finished run-tests step (success) 23:42:14 INFO - Running post-run listener: _resource_record_post_run 23:42:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407224320; Read time: 16; Write time: 295588 23:42:14 INFO - TinderboxPrint: CPU usage
13.0% 23:42:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:42:14 INFO - TinderboxPrint: I/O write bytes / time
407,224,320 / 295,588 23:42:14 INFO - TinderboxPrint: CPU idle
8,292.5 (87.0%) 23:42:14 INFO - TinderboxPrint: CPU user
1,193.6 (12.5%) 23:42:14 INFO - TinderboxPrint: Swap in / out
0 / 0 23:42:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118362112; Read time: 0; Write time: 118916 23:42:14 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288862208; Read time: 0; Write time: 176672 23:42:15 INFO - Running post-run listener: _upload_blobber_files 23:42:15 INFO - Blob upload gear active. 23:42:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:42:15 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 23:42:15 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'] 23:42:15 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 23:42:15 INFO - (blobuploader) - INFO - Open directory for files ... 23:42:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:42:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:42:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:16 INFO - (blobuploader) - INFO - Done attempting. 23:42:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:42:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:42:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:17 INFO - (blobuploader) - INFO - Done attempting. 23:42:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:42:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:42:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:20 INFO - (blobuploader) - INFO - Done attempting. 23:42:20 INFO - (blobuploader) - INFO - Iteration through files over. 23:42:20 INFO - Return code: 0 23:42:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:42:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:42:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce4e7d4066d2545cc9f2ef5c4f4002cc60fa8c69c09878639316dfff18380488652b786d515324e6e9ae439102f7d0542647b5f6b721658ae9059cd09ec0b52e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f1da97a530a4452c296142bfb8bf311e2224b12e45c949a2bf1fc2b049fec81feeb308c1ec75de1575e5e2dea474a1e2c8c063ac6a59fcc8587112662470f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/366cc7ab9b32455e48c1eee4885c2ddb9cc13cd697748d699775d6f7f7e25abe891c29f0ea15ae026ddfdc069372080c3070aff0764676f61f2bafd8115be94f"} 23:42:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:42:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:42:20 INFO - Contents: 23:42:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce4e7d4066d2545cc9f2ef5c4f4002cc60fa8c69c09878639316dfff18380488652b786d515324e6e9ae439102f7d0542647b5f6b721658ae9059cd09ec0b52e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f1da97a530a4452c296142bfb8bf311e2224b12e45c949a2bf1fc2b049fec81feeb308c1ec75de1575e5e2dea474a1e2c8c063ac6a59fcc8587112662470f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/366cc7ab9b32455e48c1eee4885c2ddb9cc13cd697748d699775d6f7f7e25abe891c29f0ea15ae026ddfdc069372080c3070aff0764676f61f2bafd8115be94f"} 23:42:20 INFO - Running post-run listener: copy_logs_to_upload_dir 23:42:20 INFO - Copying logs to upload dir... 23:42:20 INFO - mkdir: /builds/slave/test/build/upload/logs 23:42:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.946556 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-30 23:42:20.811651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 23:42:20.815535) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090 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/ce4e7d4066d2545cc9f2ef5c4f4002cc60fa8c69c09878639316dfff18380488652b786d515324e6e9ae439102f7d0542647b5f6b721658ae9059cd09ec0b52e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f1da97a530a4452c296142bfb8bf311e2224b12e45c949a2bf1fc2b049fec81feeb308c1ec75de1575e5e2dea474a1e2c8c063ac6a59fcc8587112662470f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/366cc7ab9b32455e48c1eee4885c2ddb9cc13cd697748d699775d6f7f7e25abe891c29f0ea15ae026ddfdc069372080c3070aff0764676f61f2bafd8115be94f"} build_url:https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/Gp78yKsuQT6B1QSMA3pCiQ/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/ce4e7d4066d2545cc9f2ef5c4f4002cc60fa8c69c09878639316dfff18380488652b786d515324e6e9ae439102f7d0542647b5f6b721658ae9059cd09ec0b52e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f1da97a530a4452c296142bfb8bf311e2224b12e45c949a2bf1fc2b049fec81feeb308c1ec75de1575e5e2dea474a1e2c8c063ac6a59fcc8587112662470f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/366cc7ab9b32455e48c1eee4885c2ddb9cc13cd697748d699775d6f7f7e25abe891c29f0ea15ae026ddfdc069372080c3070aff0764676f61f2bafd8115be94f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 23:42:20.840832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 23:42:20.841197) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472618349.275000-866050090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004359 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 23:42:20.925169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 23:42:20.925540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 23:42:20.925855) ========= ========= Total master_lag: 0.18 =========