builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1471607211.01 results: success (0) buildid: 20160819042856 builduid: 30a71efb8d2e444cb32c57eb37a982f1 revision: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.012738) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.013234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.013530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.046406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.046715) ========= 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=232498196343f89f466a4a9a000001c8-1471605331.843893-566756928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 04:46:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-08-19 04:46:51 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102394 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.163087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.163407) ========= 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=232498196343f89f466a4a9a000001c8-1471605331.843893-566756928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020036 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.212933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.213309) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a3b356bd3fbac6745f671c756dc799ad5aa94bc --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 5a3b356bd3fbac6745f671c756dc799ad5aa94bc --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=232498196343f89f466a4a9a000001c8-1471605331.843893-566756928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 04:46:51,715 truncating revision to first 12 chars 2016-08-19 04:46:51,716 Setting DEBUG logging. 2016-08-19 04:46:51,716 attempt 1/10 2016-08-19 04:46:51,716 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a3b356bd3fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 04:46:52,036 unpacking tar archive at: fx-team-5a3b356bd3fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.868831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.869132) ========= script_repo_revision: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.869575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.869968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 04:46:51.884915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-19 04:46:51.885298) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1471605331.843893-566756928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:52 INFO - MultiFileLogger online at 20160819 04:46:52 in /builds/slave/test 04:46:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:46:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:52 INFO - {'append_to_log': False, 04:46:52 INFO - 'base_work_dir': '/builds/slave/test', 04:46:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:46:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:52 INFO - 'branch': 'Fx-Team-Non-PGO', 04:46:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:52 INFO - 'config_files': ('talos/linux_config.py',), 04:46:52 INFO - 'default_actions': ('clobber', 04:46:52 INFO - 'read-buildbot-config', 04:46:52 INFO - 'download-and-extract', 04:46:52 INFO - 'populate-webroot', 04:46:52 INFO - 'create-virtualenv', 04:46:52 INFO - 'install', 04:46:52 INFO - 'run-tests'), 04:46:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:52 INFO - 'download_minidump_stackwalk': True, 04:46:52 INFO - 'download_symbols': 'ondemand', 04:46:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:52 INFO - 'installer_path': 'installer.exe', 04:46:52 INFO - 'log_level': 'info', 04:46:52 INFO - 'log_name': 'talos', 04:46:52 INFO - 'log_to_console': True, 04:46:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:52 INFO - 'opt_config_files': (), 04:46:52 INFO - 'pip_index': False, 04:46:52 INFO - 'sps_profile': False, 04:46:52 INFO - 'sps_profile_interval': 0, 04:46:52 INFO - 'suite': 'dromaeojs', 04:46:52 INFO - 'system_bits': '32', 04:46:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:52 INFO - 'title': 'talos-linux64-ix-025', 04:46:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:52 INFO - 'use_talos_json': True, 04:46:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:52 INFO - 'work_dir': 'build'} 04:46:52 INFO - [mozharness: 2016-08-19 11:46:52.485608Z] Running clobber step. 04:46:52 INFO - Running pre-action listener: _resource_record_pre_action 04:46:52 INFO - Running main action method: clobber 04:46:52 INFO - rmtree: /builds/slave/test/build 04:46:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:52 INFO - Running post-action listener: _resource_record_post_action 04:46:52 INFO - [mozharness: 2016-08-19 11:46:52.940687Z] Finished clobber step (success) 04:46:52 INFO - [mozharness: 2016-08-19 11:46:52.940788Z] Running read-buildbot-config step. 04:46:52 INFO - Running pre-action listener: _resource_record_pre_action 04:46:52 INFO - Running main action method: read_buildbot_config 04:46:52 INFO - Using buildbot properties: 04:46:52 INFO - { 04:46:52 INFO - "project": "", 04:46:52 INFO - "product": "firefox", 04:46:52 INFO - "script_repo_revision": "production", 04:46:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:46:52 INFO - "repository": "", 04:46:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:46:52 INFO - "buildid": "20160819042856", 04:46:52 INFO - "pgo_build": "False", 04:46:52 INFO - "basedir": "/builds/slave/test", 04:46:52 INFO - "buildnumber": 1873, 04:46:52 INFO - "slavename": "talos-linux64-ix-025", 04:46:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:46:52 INFO - "platform": "ubuntu64_hw", 04:46:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:46:52 INFO - "branch": "fx-team", 04:46:52 INFO - "repo_path": "integration/fx-team", 04:46:52 INFO - "revision": "5a3b356bd3fbac6745f671c756dc799ad5aa94bc", 04:46:52 INFO - "stage_platform": "linux64", 04:46:52 INFO - "builduid": "30a71efb8d2e444cb32c57eb37a982f1", 04:46:52 INFO - "slavebuilddir": "test" 04:46:52 INFO - } 04:46:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:46:52 INFO - Running post-action listener: _resource_record_post_action 04:46:52 INFO - [mozharness: 2016-08-19 11:46:52.943204Z] Finished read-buildbot-config step (success) 04:46:52 INFO - [mozharness: 2016-08-19 11:46:52.943292Z] Running download-and-extract step. 04:46:52 INFO - Running pre-action listener: _resource_record_pre_action 04:46:52 INFO - Running main action method: download_and_extract 04:46:52 INFO - mkdir: /builds/slave/test/build/tests 04:46: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')]} 04:46:52 INFO - trying https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:46:52 INFO - Downloading https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:46:53 INFO - Downloaded 1361 bytes. 04:46:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:46:53 INFO - Using the following test package requirements: 04:46:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'jsshell-linux-x86_64.zip'], 04:46:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:53 INFO - trying https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:46:53 INFO - Downloading https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:46:55 INFO - Downloaded 20318052 bytes. 04:46:55 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 04:46:59 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 04:46: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')]} 04:46:59 INFO - trying https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:46:59 INFO - Downloading https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:47:00 INFO - Downloaded 20318052 bytes. 04:47:00 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 04:47:04 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')]} 04:47:04 INFO - trying https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:47:04 INFO - Downloading https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:47:06 INFO - Downloaded 14413981 bytes. 04:47:06 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 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:06 INFO - trying https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:47:06 INFO - Downloading https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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 04:47:09 INFO - Downloaded 55764437 bytes. 04:47:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:47:09 INFO - mkdir: /builds/slave/test/properties 04:47:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:09 INFO - Contents: 04:47:09 INFO - build_url:https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:47:09 INFO - Running post-action listener: _resource_record_post_action 04:47:09 INFO - Running post-action listener: set_extra_try_arguments 04:47:09 INFO - [mozharness: 2016-08-19 11:47:09.860429Z] Finished download-and-extract step (success) 04:47:09 INFO - [mozharness: 2016-08-19 11:47:09.860690Z] Running populate-webroot step. 04:47:09 INFO - Running pre-action listener: _resource_record_pre_action 04:47:09 INFO - Running main action method: populate_webroot 04:47:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:09 INFO - '--tppagecycles', 04:47:09 INFO - '7'], 04:47:09 INFO - 'tests': ['tsvgm']}}, 04:47:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['damp', 'tps']}, 04:47:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'tests': ['damp', 'tps']}, 04:47:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['dromaeo_dom']}, 04:47:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['basic_compositor_video']}, 04:47:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:47:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['a11yr', 04:47:09 INFO - 'ts_paint', 04:47:09 INFO - 'tpaint', 04:47:09 INFO - 'sessionrestore', 04:47:09 INFO - 'sessionrestore_no_auto_restore', 04:47:09 INFO - 'tabpaint']}, 04:47:09 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:09 INFO - 'ts_paint', 04:47:09 INFO - 'tpaint', 04:47:09 INFO - 'sessionrestore', 04:47:09 INFO - 'sessionrestore_no_auto_restore', 04:47:09 INFO - 'tabpaint']}, 04:47:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:09 INFO - 'ts_paint', 04:47:09 INFO - 'tpaint', 04:47:09 INFO - 'sessionrestore', 04:47:09 INFO - 'sessionrestore_no_auto_restore', 04:47:09 INFO - 'tabpaint']}, 04:47:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:09 INFO - 'ts_paint', 04:47:09 INFO - 'tpaint', 04:47:09 INFO - 'sessionrestore', 04:47:09 INFO - 'sessionrestore_no_auto_restore', 04:47:09 INFO - 'tabpaint']}, 04:47:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['a11yr', 04:47:09 INFO - 'ts_paint', 04:47:09 INFO - 'tpaint', 04:47:09 INFO - 'sessionrestore', 04:47:09 INFO - 'sessionrestore_no_auto_restore', 04:47:09 INFO - 'tabpaint']}, 04:47:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['a11yr', 04:47:09 INFO - 'ts_paint', 04:47:09 INFO - 'tpaint', 04:47:09 INFO - 'sessionrestore', 04:47:09 INFO - 'sessionrestore_no_auto_restore', 04:47:09 INFO - 'tabpaint']}, 04:47:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['tsvgx', 04:47:09 INFO - 'tsvgr_opacity', 04:47:09 INFO - 'tart', 04:47:09 INFO - 'tscrollx', 04:47:09 INFO - 'cart']}, 04:47:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:09 INFO - 'tsvgr_opacity', 04:47:09 INFO - 'tart', 04:47:09 INFO - 'tscrollx', 04:47:09 INFO - 'cart']}, 04:47:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'talos_options': ['--disable-e10s'], 04:47:09 INFO - 'tests': ['tp5o']}, 04:47:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'tests': ['tp5o']}, 04:47:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'talos_options': ['--disable-e10s', 04:47:09 INFO - '--xperf_path', 04:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:09 INFO - 'tests': ['tp5n']}, 04:47:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:09 INFO - 'talos_options': ['--xperf_path', 04:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:09 INFO - 'tests': ['tp5n']}}, 04:47:09 INFO - 'talos.zip': {'path': '', 04:47:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:09 INFO - Running post-action listener: _resource_record_post_action 04:47:09 INFO - [mozharness: 2016-08-19 11:47:09.881503Z] Finished populate-webroot step (success) 04:47:09 INFO - [mozharness: 2016-08-19 11:47:09.881590Z] Running create-virtualenv step. 04:47:09 INFO - Running pre-action listener: _resource_record_pre_action 04:47:09 INFO - Running main action method: create_virtualenv 04:47:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:09 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 04:47:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:09 INFO - Using real prefix '/usr' 04:47:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:12 INFO - Installing pip.................done. 04:47:12 INFO - Return code: 0 04:47:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:12 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 04:47:12 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 04:47:12 INFO - Using env: {'DISPLAY': ':0', 04:47:12 INFO - 'HOME': '/home/cltbld', 04:47:12 INFO - 'LANG': 'en_US.UTF-8', 04:47:12 INFO - 'LANGUAGE': 'en_US:en', 04:47:12 INFO - 'LOGNAME': 'cltbld', 04:47:12 INFO - 'MAIL': '/var/mail/cltbld', 04:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:12 INFO - 'MOZ_NO_REMOTE': '1', 04:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:12 INFO - 'NO_EM_RESTART': '1', 04:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:12 INFO - 'PWD': '/builds/slave/test', 04:47:12 INFO - 'SHELL': '/bin/bash', 04:47:12 INFO - 'SHLVL': '1', 04:47:12 INFO - 'TERM': 'linux', 04:47:12 INFO - 'TMOUT': '86400', 04:47:12 INFO - 'USER': 'cltbld', 04:47:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:12 INFO - '_': '/tools/buildbot/bin/python'} 04:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:12 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 04:47:12 INFO - Cleaning up... 04:47:12 INFO - Return code: 0 04:47:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:12 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 04:47:12 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 04:47:12 INFO - Using env: {'DISPLAY': ':0', 04:47:12 INFO - 'HOME': '/home/cltbld', 04:47:12 INFO - 'LANG': 'en_US.UTF-8', 04:47:12 INFO - 'LANGUAGE': 'en_US:en', 04:47:12 INFO - 'LOGNAME': 'cltbld', 04:47:12 INFO - 'MAIL': '/var/mail/cltbld', 04:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:12 INFO - 'MOZ_NO_REMOTE': '1', 04:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:12 INFO - 'NO_EM_RESTART': '1', 04:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:12 INFO - 'PWD': '/builds/slave/test', 04:47:12 INFO - 'SHELL': '/bin/bash', 04:47:12 INFO - 'SHLVL': '1', 04:47:12 INFO - 'TERM': 'linux', 04:47:12 INFO - 'TMOUT': '86400', 04:47:12 INFO - 'USER': 'cltbld', 04:47:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:12 INFO - '_': '/tools/buildbot/bin/python'} 04:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:12 INFO - Downloading/unpacking psutil>=3.1.1 04:47:12 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 04:47:12 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 04:47:12 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 04:47:12 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 04:47:12 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 04:47:12 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 04:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:14 INFO - Installing collected packages: psutil 04:47:14 INFO - Running setup.py install for psutil 04:47:14 INFO - building 'psutil._psutil_linux' extension 04:47:14 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 04:47:15 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 04:47:15 INFO - building 'psutil._psutil_posix' extension 04:47:15 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 04:47:15 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 04:47:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:15 INFO - Successfully installed psutil 04:47:15 INFO - Cleaning up... 04:47:15 INFO - Return code: 0 04:47:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:47:15 INFO - Using env: {'DISPLAY': ':0', 04:47:15 INFO - 'HOME': '/home/cltbld', 04:47:15 INFO - 'LANG': 'en_US.UTF-8', 04:47:15 INFO - 'LANGUAGE': 'en_US:en', 04:47:15 INFO - 'LOGNAME': 'cltbld', 04:47:15 INFO - 'MAIL': '/var/mail/cltbld', 04:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:15 INFO - 'MOZ_NO_REMOTE': '1', 04:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:15 INFO - 'NO_EM_RESTART': '1', 04:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:15 INFO - 'PWD': '/builds/slave/test', 04:47:15 INFO - 'SHELL': '/bin/bash', 04:47:15 INFO - 'SHLVL': '1', 04:47:15 INFO - 'TERM': 'linux', 04:47:15 INFO - 'TMOUT': '86400', 04:47:15 INFO - 'USER': 'cltbld', 04:47:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:15 INFO - '_': '/tools/buildbot/bin/python'} 04:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:17 INFO - Installing collected packages: mozsystemmonitor 04:47:17 INFO - Running setup.py install for mozsystemmonitor 04:47:17 INFO - Successfully installed mozsystemmonitor 04:47:17 INFO - Cleaning up... 04:47:17 INFO - Return code: 0 04:47:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:17 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')]} 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:17 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')]} 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:17 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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:17 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 04:47:17 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 04:47:17 INFO - Using env: {'DISPLAY': ':0', 04:47:17 INFO - 'HOME': '/home/cltbld', 04:47:17 INFO - 'LANG': 'en_US.UTF-8', 04:47:17 INFO - 'LANGUAGE': 'en_US:en', 04:47:17 INFO - 'LOGNAME': 'cltbld', 04:47:17 INFO - 'MAIL': '/var/mail/cltbld', 04:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:17 INFO - 'MOZ_NO_REMOTE': '1', 04:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:17 INFO - 'NO_EM_RESTART': '1', 04:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:17 INFO - 'PWD': '/builds/slave/test', 04:47:17 INFO - 'SHELL': '/bin/bash', 04:47:17 INFO - 'SHLVL': '1', 04:47:17 INFO - 'TERM': 'linux', 04:47:17 INFO - 'TMOUT': '86400', 04:47:17 INFO - 'USER': 'cltbld', 04:47:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:17 INFO - '_': '/tools/buildbot/bin/python'} 04:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:17 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 04:47:17 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 04:47:17 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 04:47:17 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 04:47:17 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 04:47:17 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 04:47:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:19 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 04:47:19 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 04:47:19 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 04:47:19 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 04:47:19 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 04:47:19 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 04:47:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:20 INFO - warning: no files found matching '*.txt' 04:47:20 INFO - no previously-included directories found matching 'build' 04:47:20 INFO - no previously-included directories found matching 'dist' 04:47:20 INFO - no previously-included directories found matching '.git*' 04:47:20 INFO - Installing collected packages: jsonschema, functools32 04:47:20 INFO - Running setup.py install for functools32 04:47:20 INFO - warning: no files found matching '*.txt' 04:47:20 INFO - no previously-included directories found matching 'build' 04:47:20 INFO - no previously-included directories found matching 'dist' 04:47:20 INFO - no previously-included directories found matching '.git*' 04:47:20 INFO - Successfully installed jsonschema functools32 04:47:20 INFO - Cleaning up... 04:47:20 INFO - Return code: 0 04:47:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:47:20 INFO - Using env: {'DISPLAY': ':0', 04:47:20 INFO - 'HOME': '/home/cltbld', 04:47:20 INFO - 'LANG': 'en_US.UTF-8', 04:47:20 INFO - 'LANGUAGE': 'en_US:en', 04:47:20 INFO - 'LOGNAME': 'cltbld', 04:47:20 INFO - 'MAIL': '/var/mail/cltbld', 04:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:20 INFO - 'MOZ_NO_REMOTE': '1', 04:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:20 INFO - 'NO_EM_RESTART': '1', 04:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:20 INFO - 'PWD': '/builds/slave/test', 04:47:20 INFO - 'SHELL': '/bin/bash', 04:47:20 INFO - 'SHLVL': '1', 04:47:20 INFO - 'TERM': 'linux', 04:47:20 INFO - 'TMOUT': '86400', 04:47:20 INFO - 'USER': 'cltbld', 04:47:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:20 INFO - '_': '/tools/buildbot/bin/python'} 04:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:20 INFO - Cleaning up... 04:47:20 INFO - Return code: 0 04:47:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:20 INFO - Using env: {'DISPLAY': ':0', 04:47:20 INFO - 'HOME': '/home/cltbld', 04:47:20 INFO - 'LANG': 'en_US.UTF-8', 04:47:20 INFO - 'LANGUAGE': 'en_US:en', 04:47:20 INFO - 'LOGNAME': 'cltbld', 04:47:20 INFO - 'MAIL': '/var/mail/cltbld', 04:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:20 INFO - 'MOZ_NO_REMOTE': '1', 04:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:20 INFO - 'NO_EM_RESTART': '1', 04:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:20 INFO - 'PWD': '/builds/slave/test', 04:47:20 INFO - 'SHELL': '/bin/bash', 04:47:20 INFO - 'SHLVL': '1', 04:47:20 INFO - 'TERM': 'linux', 04:47:20 INFO - 'TMOUT': '86400', 04:47:20 INFO - 'USER': 'cltbld', 04:47:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:20 INFO - '_': '/tools/buildbot/bin/python'} 04:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:23 INFO - Downloading docopt-0.6.1.tar.gz 04:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:23 INFO - Running setup.py install for blobuploader 04:47:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:23 INFO - Running setup.py install for requests 04:47:23 INFO - Running setup.py install for docopt 04:47:23 INFO - Successfully installed blobuploader requests docopt 04:47:23 INFO - Cleaning up... 04:47:23 INFO - Return code: 0 04:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:23 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 04:47:23 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 04:47:23 INFO - Using env: {'DISPLAY': ':0', 04:47:23 INFO - 'HOME': '/home/cltbld', 04:47:23 INFO - 'LANG': 'en_US.UTF-8', 04:47:23 INFO - 'LANGUAGE': 'en_US:en', 04:47:23 INFO - 'LOGNAME': 'cltbld', 04:47:23 INFO - 'MAIL': '/var/mail/cltbld', 04:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:23 INFO - 'MOZ_NO_REMOTE': '1', 04:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:23 INFO - 'NO_EM_RESTART': '1', 04:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:23 INFO - 'PWD': '/builds/slave/test', 04:47:23 INFO - 'SHELL': '/bin/bash', 04:47:23 INFO - 'SHLVL': '1', 04:47:23 INFO - 'TERM': 'linux', 04:47:23 INFO - 'TMOUT': '86400', 04:47:23 INFO - 'USER': 'cltbld', 04:47:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:23 INFO - '_': '/tools/buildbot/bin/python'} 04:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:24 INFO - Running setup.py (path:/tmp/pip-wgEPTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:24 INFO - Running setup.py (path:/tmp/pip-8IetDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:24 INFO - Running setup.py (path:/tmp/pip-LLKQCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:24 INFO - Running setup.py (path:/tmp/pip-JQJANF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:24 INFO - Running setup.py (path:/tmp/pip-YkLtDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:24 INFO - Running setup.py (path:/tmp/pip-NZAaTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:24 INFO - Running setup.py (path:/tmp/pip-kcyd0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:24 INFO - Running setup.py (path:/tmp/pip-dB22KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:24 INFO - Running setup.py (path:/tmp/pip-LVUbcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:24 INFO - Running setup.py (path:/tmp/pip-QFWc4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:24 INFO - Running setup.py (path:/tmp/pip-SEmIIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:24 INFO - Running setup.py (path:/tmp/pip-9I3VPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:25 INFO - Running setup.py (path:/tmp/pip-5K4e76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:25 INFO - Running setup.py (path:/tmp/pip-tPR2Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:25 INFO - Running setup.py (path:/tmp/pip-bXXhl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:25 INFO - Running setup.py (path:/tmp/pip-z_eMgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:25 INFO - Running setup.py (path:/tmp/pip-bMOJUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:25 INFO - Running setup.py install for manifestparser 04:47:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:25 INFO - Running setup.py install for mozcrash 04:47:25 INFO - Running setup.py install for mozdebug 04:47:25 INFO - Running setup.py install for mozdevice 04:47:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:25 INFO - Running setup.py install for mozfile 04:47:25 INFO - Running setup.py install for mozhttpd 04:47:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Running setup.py install for mozinfo 04:47:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Running setup.py install for mozInstall 04:47:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Running setup.py install for mozleak 04:47:26 INFO - Running setup.py install for mozlog 04:47:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Running setup.py install for moznetwork 04:47:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Running setup.py install for mozprocess 04:47:26 INFO - Running setup.py install for mozprofile 04:47:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Running setup.py install for mozrunner 04:47:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:26 INFO - Running setup.py install for mozscreenshot 04:47:27 INFO - Running setup.py install for moztest 04:47:27 INFO - Running setup.py install for mozversion 04:47:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:27 INFO - Cleaning up... 04:47:27 INFO - Return code: 0 04:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:27 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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:27 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 04:47:27 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 04:47:27 INFO - Using env: {'DISPLAY': ':0', 04:47:27 INFO - 'HOME': '/home/cltbld', 04:47:27 INFO - 'LANG': 'en_US.UTF-8', 04:47:27 INFO - 'LANGUAGE': 'en_US:en', 04:47:27 INFO - 'LOGNAME': 'cltbld', 04:47:27 INFO - 'MAIL': '/var/mail/cltbld', 04:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:27 INFO - 'MOZ_NO_REMOTE': '1', 04:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:27 INFO - 'NO_EM_RESTART': '1', 04:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:27 INFO - 'PWD': '/builds/slave/test', 04:47:27 INFO - 'SHELL': '/bin/bash', 04:47:27 INFO - 'SHLVL': '1', 04:47:27 INFO - 'TERM': 'linux', 04:47:27 INFO - 'TMOUT': '86400', 04:47:27 INFO - 'USER': 'cltbld', 04:47:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:27 INFO - '_': '/tools/buildbot/bin/python'} 04:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:27 INFO - Running setup.py (path:/tmp/pip-hUjB3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:27 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)) 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:27 INFO - Running setup.py (path:/tmp/pip-C17glP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:27 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)) 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:27 INFO - Running setup.py (path:/tmp/pip-C0EWGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:27 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)) 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:27 INFO - Running setup.py (path:/tmp/pip-rwkrS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:27 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)) 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:27 INFO - Running setup.py (path:/tmp/pip-SDtz2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:27 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)) 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:27 INFO - Running setup.py (path:/tmp/pip-jm4gtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:27 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)) 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:27 INFO - Running setup.py (path:/tmp/pip-zDNRXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:27 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)) 04:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:27 INFO - Running setup.py (path:/tmp/pip-uogpR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:28 INFO - Running setup.py (path:/tmp/pip-n1hEPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:28 INFO - Running setup.py (path:/tmp/pip-BRm0UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:28 INFO - Running setup.py (path:/tmp/pip-t9kFmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:28 INFO - Running setup.py (path:/tmp/pip-DkWUSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:28 INFO - Running setup.py (path:/tmp/pip-38pRaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:28 INFO - Running setup.py (path:/tmp/pip-Rw_3v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:28 INFO - Running setup.py (path:/tmp/pip-weH361-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:28 INFO - Running setup.py (path:/tmp/pip-F6nFo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:28 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)) 04:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:28 INFO - Running setup.py (path:/tmp/pip-9PLS1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 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)) 04:47:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:28 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 04:47:28 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 04:47:28 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 04:47:28 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 04:47:28 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 04:47:28 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 04:47:30 INFO - Downloading blessings-1.6.tar.gz 04:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:30 INFO - Installing collected packages: blessings 04:47:30 INFO - Running setup.py install for blessings 04:47:30 INFO - Successfully installed blessings 04:47:30 INFO - Cleaning up... 04:47:30 INFO - Return code: 0 04:47:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:31 INFO - Reading from file tmpfile_stdout 04:47:31 INFO - Current package versions: 04:47:31 INFO - argparse == 1.2.1 04:47:31 INFO - blessings == 1.6 04:47:31 INFO - blobuploader == 1.2.4 04:47:31 INFO - docopt == 0.6.1 04:47:31 INFO - functools32 == 3.2.3-2 04:47:31 INFO - jsonschema == 2.5.1 04:47:31 INFO - manifestparser == 1.1 04:47:31 INFO - mozInstall == 1.12 04:47:31 INFO - mozcrash == 0.17 04:47:31 INFO - mozdebug == 0.1 04:47:31 INFO - mozdevice == 0.48 04:47:31 INFO - mozfile == 1.2 04:47:31 INFO - mozhttpd == 0.7 04:47:31 INFO - mozinfo == 0.9 04:47:31 INFO - mozleak == 0.1 04:47:31 INFO - mozlog == 3.3 04:47:31 INFO - moznetwork == 0.27 04:47:31 INFO - mozprocess == 0.23 04:47:31 INFO - mozprofile == 0.28 04:47:31 INFO - mozrunner == 6.12 04:47:31 INFO - mozscreenshot == 0.1 04:47:31 INFO - mozsystemmonitor == 0.3 04:47:31 INFO - moztest == 0.7 04:47:31 INFO - mozversion == 1.4 04:47:31 INFO - psutil == 3.1.1 04:47:31 INFO - requests == 1.2.3 04:47:31 INFO - wsgiref == 0.1.2 04:47:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:31 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')]} 04:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:31 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')]} 04:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:31 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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:31 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 04:47:31 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 04:47:31 INFO - Using env: {'DISPLAY': ':0', 04:47:31 INFO - 'HOME': '/home/cltbld', 04:47:31 INFO - 'LANG': 'en_US.UTF-8', 04:47:31 INFO - 'LANGUAGE': 'en_US:en', 04:47:31 INFO - 'LOGNAME': 'cltbld', 04:47:31 INFO - 'MAIL': '/var/mail/cltbld', 04:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:31 INFO - 'MOZ_NO_REMOTE': '1', 04:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:31 INFO - 'NO_EM_RESTART': '1', 04:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:31 INFO - 'PWD': '/builds/slave/test', 04:47:31 INFO - 'SHELL': '/bin/bash', 04:47:31 INFO - 'SHLVL': '1', 04:47:31 INFO - 'TERM': 'linux', 04:47:31 INFO - 'TMOUT': '86400', 04:47:31 INFO - 'USER': 'cltbld', 04:47:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:31 INFO - '_': '/tools/buildbot/bin/python'} 04:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 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)) 04:47:31 INFO - Cleaning up... 04:47:31 INFO - Return code: 0 04:47:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:31 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')]} 04:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:31 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')]} 04:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:31 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 0x7f7cedda4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1131230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, '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': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', '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 04:47:31 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 04:47:31 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 04:47:31 INFO - Using env: {'DISPLAY': ':0', 04:47:31 INFO - 'HOME': '/home/cltbld', 04:47:31 INFO - 'LANG': 'en_US.UTF-8', 04:47:31 INFO - 'LANGUAGE': 'en_US:en', 04:47:31 INFO - 'LOGNAME': 'cltbld', 04:47:31 INFO - 'MAIL': '/var/mail/cltbld', 04:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:31 INFO - 'MOZ_NO_REMOTE': '1', 04:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:31 INFO - 'NO_EM_RESTART': '1', 04:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:31 INFO - 'PWD': '/builds/slave/test', 04:47:31 INFO - 'SHELL': '/bin/bash', 04:47:31 INFO - 'SHLVL': '1', 04:47:31 INFO - 'TERM': 'linux', 04:47:31 INFO - 'TMOUT': '86400', 04:47:31 INFO - 'USER': 'cltbld', 04:47:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:31 INFO - '_': '/tools/buildbot/bin/python'} 04:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:31 INFO - Cleaning up... 04:47:31 INFO - Return code: 0 04:47:31 INFO - Running post-action listener: _resource_record_post_action 04:47:31 INFO - Running post-action listener: _start_resource_monitoring 04:47:31 INFO - Starting resource monitoring. 04:47:31 INFO - [mozharness: 2016-08-19 11:47:31.465142Z] Finished create-virtualenv step (success) 04:47:31 INFO - [mozharness: 2016-08-19 11:47:31.465597Z] Running install step. 04:47:31 INFO - Running pre-action listener: _resource_record_pre_action 04:47:31 INFO - Running main action method: install 04:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:31 INFO - Reading from file tmpfile_stdout 04:47:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:31 INFO - Reading from file tmpfile_stdout 04:47:31 INFO - Output received: 04:47:31 INFO - Usage: mozinstall [options] installer 04:47:31 INFO - Options: 04:47:31 INFO - -h, --help show this help message and exit 04:47:31 INFO - -d DEST, --destination=DEST 04:47:31 INFO - Directory to install application into. [default: 04:47:31 INFO - "/builds/slave/test"] 04:47:31 INFO - --app=APP Application being installed. [default: firefox] 04:47:31 INFO - mkdir: /builds/slave/test/build/application 04:47:31 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'] 04:47:31 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 04:47:47 INFO - Reading from file tmpfile_stdout 04:47:47 INFO - Output received: 04:47:47 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:47 INFO - Running post-action listener: _resource_record_post_action 04:47:47 INFO - [mozharness: 2016-08-19 11:47:47.821371Z] Finished install step (success) 04:47:47 INFO - [mozharness: 2016-08-19 11:47:47.821616Z] Running run-tests step. 04:47:47 INFO - Running pre-action listener: _resource_record_pre_action 04:47:47 INFO - Running main action method: run_tests 04:47:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:47 INFO - Python 2.7.3 04:47:47 INFO - Return code: 0 04:47:47 INFO - grabbing minidump binary from tooltool 04:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:47 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 0x112b090>, '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 0x112e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:47 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 04:47:47 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 04:47:47 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 04:47:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:47 INFO - Return code: 0 04:47:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 04:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 04:47:47 INFO - Using env: {'DISPLAY': ':0', 04:47:47 INFO - 'HOME': '/home/cltbld', 04:47:47 INFO - 'LANG': 'en_US.UTF-8', 04:47:47 INFO - 'LANGUAGE': 'en_US:en', 04:47:47 INFO - 'LOGNAME': 'cltbld', 04:47:47 INFO - 'MAIL': '/var/mail/cltbld', 04:47:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:47 INFO - 'MOZ_NO_REMOTE': '1', 04:47:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:47 INFO - 'NO_EM_RESTART': '1', 04:47:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:47 INFO - 'PWD': '/builds/slave/test', 04:47:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:47 INFO - 'SHELL': '/bin/bash', 04:47:47 INFO - 'SHLVL': '1', 04:47:47 INFO - 'TERM': 'linux', 04:47:47 INFO - 'TMOUT': '86400', 04:47:47 INFO - 'USER': 'cltbld', 04:47:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471605331.843893-566756928', 04:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:47 INFO - '_': '/tools/buildbot/bin/python'} 04:47:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 04:47:48 INFO - mozversion application_buildid: 20160819042856 04:47:48 INFO - mozversion application_changeset: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc 04:47:48 INFO - mozversion application_display_name: Nightly 04:47:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:48 INFO - mozversion application_name: Firefox 04:47:48 INFO - mozversion application_remotingname: firefox 04:47:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:47:48 INFO - mozversion application_vendor: Mozilla 04:47:48 INFO - mozversion application_version: 51.0a1 04:47:48 INFO - mozversion platform_buildid: 20160819042856 04:47:48 INFO - mozversion platform_changeset: 5a3b356bd3fbac6745f671c756dc799ad5aa94bc 04:47:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:47:48 INFO - mozversion platform_version: 51.0a1 04:47:48 INFO - using testdate: 1471607268 04:47:48 INFO - actual date: 1471607268 04:47:48 INFO - starting webserver on 'localhost:49567' 04:47:48 INFO - SUITE-START | Running 2 tests 04:47:48 INFO - TEST-START | dromaeo_css 04:47:48 INFO - operating with platform_type : linux_ 04:47:48 INFO - Initialising browser for dromaeo_css test... 04:47:48 INFO - TEST-INFO | started process 31508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprHwPF7/profile http://localhost:49567/getInfo.html) 04:47:52 INFO - PROCESS | 31508 | __metrics Screen width/height:1600/1200 04:47:52 INFO - PROCESS | 31508 | colorDepth:24 04:47:52 INFO - PROCESS | 31508 | Browser inner width/height: 1024/697 04:47:52 INFO - PROCESS | 31508 | __metrics 04:47:52 INFO - PROCESS | 31508 | 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" 04:47:52 INFO - PROCESS | 31508 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:53 INFO - PROCESS | 31508 | console.error: PushService: 04:47:53 INFO - PROCESS | 31508 | stateChangeProcessEnqueue: Error transitioning state 04:47:53 INFO - PROCESS | 31508 | UnknownError 04:47:54 INFO - TEST-INFO | 31508: exit 0 04:47:54 INFO - Browser initialized. 04:47:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:54 INFO - TEST-INFO | started process 31593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprHwPF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:06 INFO - PROCESS | 31593 | RSS: Main: 157650944 04:48:06 INFO - PROCESS | 31593 | 04:48:57 INFO - PROCESS | 31593 | 1471607337076 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] 04:51:10 INFO - PROCESS | 31593 | Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49567/tests/dromaeo/cssquery-ext.html) 04:51:11 INFO - PROCESS | 31593 | RSS: Main: 243666944 04:51:11 INFO - PROCESS | 31593 | 04:54:14 INFO - PROCESS | 31593 | Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-ext.html (next: http://localhost:49567/tests/dromaeo/cssquery-jquery.html) 04:54:14 INFO - PROCESS | 31593 | RSS: Main: 244576256 04:54:14 INFO - PROCESS | 31593 | 04:57:17 INFO - PROCESS | 31593 | Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49567/tests/dromaeo/cssquery-mootools.html) 04:57:17 INFO - PROCESS | 31593 | RSS: Main: 188964864 04:57:17 INFO - PROCESS | 31593 | 05:00:20 INFO - PROCESS | 31593 | Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49567/tests/dromaeo/cssquery-prototype.html) 05:00:20 INFO - PROCESS | 31593 | RSS: Main: 187625472 05:00:20 INFO - PROCESS | 31593 | 05:03:23 INFO - PROCESS | 31593 | Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49567/tests/dromaeo/cssquery-yui.html) 05:03:24 INFO - PROCESS | 31593 | RSS: Main: 188411904 05:03:24 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-yui.html (next: http://localhost:49567/tests/dromaeo/cssquery-dojo.html) 05:06:27 INFO - PROCESS | 31593 | RSS: Main: 280514560 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | __start_tp_report 05:06:27 INFO - PROCESS | 31593 | _x_x_mozilla_page_load 05:06:27 INFO - PROCESS | 31593 | _x_x_mozilla_page_load_details 05:06:27 INFO - PROCESS | 31593 | |i|pagename|runs| 05:06:27 INFO - PROCESS | 31593 | |0;dojo.html;2578.2651944195904;2591.3262551736543;2620.882060307286;2623.0819213275354;2637.2615667613063;4509.436320459942;4593.173228818811;4658.464276608191;4707.105649926516;4715.03341814928;4539.818407263706;4588.151192029477;4637.188492013901;4659.068186362732;4666.2767271073035;4185.560516145806;4210.368444733299;4287.764172970486;4339.869803905888;4422.11557688462;4353.978230108861;4375.1031038637;4405.405270288502;4426.136903303857;4426.424564806571;4161.313383291753;4206.305959516676;4331.523532411432;4340.739555626673;4415.86752397427;4192.28731115708;4265.552117027699;4274.123804620077;4295.2912769393015;4295.78521073945;4258.659307255443;4303.526612072669;4322.848700295474;4335.219660461115;4352.194843953847;4528.56978587037;4714.316424118484;4743.454502732196;4761.6904901181315;4772.522747725235;4916.606671466274;4933.087378834891;4967.652264341497;5053.545180933734;5054.267131265982;5030.773615187289;5056.469070747592;5074.543291103819;5080.212567052113;5088.491150884919;4577.244754615451;4661.836835710734;4703.482616912137;4734.692245004098;4745.572898439157;5089.109405853961;5185.740712964337;5210.192420174879;5223.190405487156;5240.109181439165;4950.529699678596;4957.90084198314;4970.751462426864;4974.303597496281;4980.950190498121;4805.711657300503;4893.804247830119;5098.719570423662;5106.565941894981;5112.8721781955;4930.580900623416;5007.1988481843455;5011.924821127686;5036.546710796046;5038.672486288379;4946.08497427977;4974.602031837444;4977.452480227172;4985.90028199434;5026.974865125651;4272.743635381887;4279.743215407086;4282.186384586918;4293.141371725667;4319.784010799511;3659.304732100892;3687.391580389206;3705.5182826232417;3706.1105334720014;3775.5846856845724;4296.162248361602;4297.67767417445;4298.4412026436985;4330.415393921843;4339.913201735948;5029.0947629427055;5032.924506132411;5038.546530812245;5038.722870242172;5083.644144909821;4182.498100227992;4243.7029407941145;4276.700630955803;4296.527381988041;4333.046729719456;4554.4990051094355;4565.452145742533;4580.839670611513;4580.862574122782;4619.076184763061;4698.577128058423;4713.905721885474;4725.9291110632685;4726.456457507431;4759.262314341283;4854.563089321978;4925.5320744530645;4960.8759781005765;4982.501749825134;4985.501449854985;4698;4713.905721885474;4715.3869996900185;4739.194336962656;4746.501617330131;4934;4938.2839488273285;4941.431735350337;4941.901161976669;4984.22744474607;4884.902301954012;4969.652124351261;4991.15150424436;5006.799728010838;5020.472850350807;4905.607551395951;4908.631852610997;4921.680090794087;4923.236898280772;4946.851594452172;4902.068606964665;4907.527741677411;4908.779104940358;4910.238912968495;4927.236278376858;4616.6075883550275;4793.161196790478;4846.127697014571;4860.198067318995;4867.780949857194;4983.277424773315;4989.825356112518;4990.15167421532;5002.274670172877;5030.496950304941;4882.389701287339;4890.24201248807;4890.486498917705;4894.583960363267;4923.876903077452 05:06:27 INFO - PROCESS | 31593 | |1;ext.html;570.284293212019;574.8016934157716;584.4944123333318;587.1310460518432;589.9675517846522;28313.85843070784;38850;40144.598554014454;40262.99342516435;44370.55629443705;40544;40924.38613420801;40957;41021.58978410222;41043.58956410435;7639.770806875803;7788.3379912707205;7793.766187014398;7793.922060779405;7795.88306175405;7342.375898048672;9777.413355198676;10041.648542301022;10046.196304295676;10356.067953884149;9779.217662586976;9861.161801246903;9878.604855805796;9885.159761420287;9888.11007009369;9852.655157069505;9915.25635577331;9920.45437500937;9923.156531694814;9943.701688949342;9942.304038717293;9991.700248992469;9993.950030249875;10011.449370284632;10011.49942502872;36630.8168459156;36878.893633191045;36997.81501092477;36999.81500092509;37012;2929.8828046878098;2963.199936017263;3219.227385427504;3669.486271921933;3755.267722794056;26689.332766680793;27281.181564553095;29000.27499312513;29905.850470747726;30093.398132037455;3177.4280629486684;3208.1017315151794;3223.9194020149685;3351.7318614511023;3387.119348969261;250432;259903;262209;262241.68879155675;262494;54907.176392354144;55138.72430637821;55459.16811247834;55460.445395545525;55553.44446555483;33641;34812;58176.4182358171;58494.4150558489;58564.12153817696;13755.449782008807;13939.675730805557;13941.954353423534;13954.720905581831;13959.232242226572;9096.272298216127;9243.121903419164;10206.438645874548;10385.169186465217;10407.947960260302;18360.540986475444;18717.438476845444;18963.810361896205;19156.83912154479;19262.518437039187;7252.166000909963;7381.66782494789;7438.814029649194;7509.36170425509;7540.962295188599;770.8227107765246;840.9453385529921;881.7751473374249;918.2332752152028;961.053362437998;25720.356991074997;27165.592516112276;27602.5859612106;27902.16293511198;28086.43827123446;917.8118485710413;927.8144371125667;967.3953778888194;1011.3931641015332;1050.4957620342125;13555.186688798703;14607.342669579895;14689.338979745937;14696.829333890959;14900.627484312761;393029;396658;397463;397705;398383;48063.279050814264;48488.515114849106;48507.84698994554;48526.75736621365;48591;1036.3678156324636;1090.4929207918356;1136.9829452558383;1156.3986726901965;1156.7397335599592;25134.874325628254;28068.85965570159;28190.295242619097;28220.472755609662;29109.272268193465;41181.382279265235;41728.3740743883;41738;41762.37356439717;41775.58224417717;294735;296013;296210;296218;296455;24967.875160624808;25337.113201037875;25375.238742837744;25728.485430290915;26378.604320935585;40885.1822963545;40960.1807963845;40987.38518922159;41114;41786;33952.66047339495;34008;34325;34533.48199776955;34570.82714586411;32478.512822308156;33989.83005084959;34147.829260853534;34240.828795855865;34374.82812585921;33930.66069339275;34791.304173916884;34817.47773783446;34994.82502587471;35296.82351588226;30529.542056868722;31802.522962155123;32019;32229.35541289208;32352;24097.638535422335;25137.87431062833;25443.807677510667;26884.865575671996;26976 05:06:27 INFO - PROCESS | 31593 | |2;jquery.html;345.7735183454838;363.75628329019554;370.63492459926977;371.96466335698113;383.7371400590594;12562.937185314073;15318.46385376512;15608.609784755386;16919.238634261455;17060.23228954697;15378.538643840675;15383.230838458061;15479.690406191869;15508.922455387707;15757.133357665352;4853.5389138031915;5013.724245166514;5066.97466512667;5091.84724458265;5171.508706672879;3735.6077611850774;4995.625328100389;5075.746212689369;5080.974595127038;5082.390113186404;5705.5435565154685;5967.075103358986;5988.820335389945;6068.423499767515;6076.088586711984;5813.069908814612;5925.585209035369;5989.161517387525;6052.636841789506;6062.636241825505;5238.895222095575;5260.342457192851;5263.210518422229;5264.31563896691;5267.078261304257;20613.175472981064;20769.58460830775;20941.371758847257;21015.159393624235;21103.788962110335;1738.2438639191992;1865.253898440621;1892.6214757048645;1912.8660993730443;1919.280269898788;13191.40638671262;13205.933970330183;13414.664633384145;13487.527936522174;14082.366293516816;1732.2205007746566;1737.5829800847832;1739.5477175934348;1740.9390671326444;1762.9559261018449;43175.67333784769;56454;65801.67099164521;67286.32713672849;68322.65838670774;9671;9746.512674366253;9753.756156096013;9895.703128906145;10126.392416455037;13382.197068175941;13391.986802969253;13407.32963351848;13415.865841341656;13417.779732864043;7055.835787095174;7139.750108746272;7254.746083887038;7281.308275713799;7340.4861659684375;6726.663666816639;6742.325767423218;6942.06282151903;6965.373116419547;6968.442524598121;5920.851978700481;6263.561550691499;6272.686365681698;6296.685165741695;6297.779577714758;1773.8492228160492;1775.14792899409;1777.2269062957655;1789.4721057288132;1797.0834874214245;837.3092198935781;855.1918437076903;900.0999000999001;905.4838741917044;983.3804703037041;16201.918990404973;16851.949709363173;18089;18164.727529087075;18347.266109355744;817.3665409307833;843.9662413503514;851.7955690634327;912.5710915869531;929.6513807322254;9477.526123693788;9493.762655933657;10119.494025298705;10128.291019628703;10149.695509134737;396372;416154;417106;417681;417764;76174.61912690401;76296.61851690707;77447;77543;78169;903.5572569441058;906.4153620914605;936.1293996583242;936.2790651198675;936.7704912296394;15257.694846103237;15434.536963891102;15769;16253.918730406273;16269.105199214157;37153.442698360086;37407;37420.43869341908;37444.43833342448;37565.81217093897;51321.486785131674;51582;52598.47401525936;52834.471655282956;53078.93842123213;6415.935840641534;6617.974213996838;6782.084418603623;6957.686904089429;6996.125484314461;10037.949810250902;10936;11610.88389116098;11932.343721095423;12503.687407814878;9819.263555233529;9921.503924803586;9984.400935943866;10009.599616015568;10357.585696572354;9916.900830991597;9924.652637157666;10150.238732094975;10531.94734026325;10625.309354891908;9636.180924621205;9941.602335906482;9990.200783937122;10020.899791002288;10186.33788803755;7651.081870175614;7837.49056311338;7842.176571459914;8038.276555110068;8199.22107399796;9334.813303733752;9852.162566181669;10020.148287395654;10160.796784064425;10597.41714205726 05:06:27 INFO - PROCESS | 31593 | |3;mootools.html;1259.5969289827246;1376.2430663135276;1392.0742706100443;1483.6513419346452;1685.705001624716;6489.415952564268;7358.595277259748;7629.618519074038;7650.579218143;7869.645865936032;7741.1871753465775;7792.805179870506;7806.648700808463;7810.882836757439;7818.491798033124;2229.554089182162;2253.5380247049316;2255.7293124825046;2255.740589832166;2257.0407576779885;2158.136745301876;2187.57342318248;2216.3018649125556;2219.5006123622215;2224.9110035598555;2163.4158777130165;2182.0617134632103;2199.1093607089156;2199.285232299501;2200.7359116905996;2145.5816115857415;2149.451889768107;2153.935381938544;2155.1594877997595;2158.190678495564;2106.147010460766;2149.451889768099;2154.310620601408;2154.34292540775;2155.7736437673975;7525.5860927648955;7602.353799927013;7637.15991240963;7724.536527808294;7743.457957942946;4436.711613745097;4620.399348084761;4621.306803979396;4621.676482646216;4622.098690755304;2805.466961277371;2904.941901161965;2950.2476868398635;2956.571297161921;2966.42154779818;913.4610579757974;917.1516347378648;935.0322416299098;942.6512190489494;945.0832692288469;10293.330933489298;10393.064624183784;10421.426821524814;10447.686569402855;10464.058234758832;3809.7523660961947;3904.7461914975434;3982.522097348337;3984.2629113614075;3994.8202330894596;8292.460990035628;8303;8330.916690833013;8347.081820999685;8347.83304333922;4459.620932220798;4461.353103799931;4461.687681862239;4466.218411777926;4472.105578884236;3534.593521744981;3632.7093832493865;3672.7429079964145;4141.64795992338;4142.565030671796;3121.8907338243052;3166.176794033568;3476.0881515166557;3499.4400895856543;3507.15828201235;1029.0892560084378;1048.2557384257111;1059.9735006624896;1075.510642657589;1083.4366129612558;808.7412028150935;865.4158443050916;875.7898104454885;876.6055275126218;877.7937184761576;5244.213367994755;5271.6309858310315;5322.414534401213;5446.673199608036;5463.125899856004;403.81020920167475;409.9344104943195;411.916659186338;418.02599942134754;423.12413304460085;3586.8027258501033;3612.3497770401054;3660.7803531788177;3727.366347720894;3785.9242815143543;9093.909060909438;9339.206167475704;9483.430994140374;9488.762780930532;9503.049695030442;8712;9407.2003879671;9408.95295523518;9422.104900034486;9431.858522122173;6866.965665171642;7205.351518363268;7211.67547460376;7213.350798428167;7220.638968051577;5406.918896216638;5541.168824676331;5623.634463759842;5646.661200327993;5704.80033198836;8400.579971001303;8461.280791132822;8670.783230419038;8764.868526971974;8769.868451973098;8728.956355218183;8792.560371981503;8891.288696904361;8904.688335908471;8935.017148113833;6048.6975651218145;6667.799966001027;6856.314368563104;6876.759313424006;7002.334778196063;7354.521956072838;7408.888866666896;7415;7430.145533263528;7438.1818000018875;6252.499800015897;6308.589941653778;6390.712417941297;6438.581492202992;6564.704588293443;6173.228346456693;6306.400891915261;6306.684665766602;6336.936630633819;6381.1704478417505;6123.081537769192;6174.8147555573405;6177.876442471215;6187.257529096537;6203.658798766111;4649.976750116228;4853.466118727008;4975.129352363394;4995.400551933792;5039.664488910515;4591.380163677861;4777.522247775195;4789.521047895182;4831.637627177905;5062.949370506248 05:06:27 INFO - PROCESS | 31593 | |4;prototype.html;295.5124045325213;304.40033134724587;305.375507088005;311.0683502908787;311.1753852291429;4895.632827537931;4916;4930.309756634074;4938.851834444972;4950.55445009949;4854.660173787836;4879.60899159412;4884.78018489168;4905.435874874391;4909.386326709161;3632.691221246197;3744.288585168823;3754.793486358249;3758.7180961427866;3768.453574231735;3689.446583012556;3749.343864823659;3819.52255968004;3856.2094770572107;3879.4374815651713;3780.996072081787;3786.413105968579;3795.430685397199;3821.8280177391944;3828.349180639298;3569.3575156471825;3738;3791.924161516768;3799.7530160539613;3822.178231680174;3263.8694452221885;3278.344331133783;3279.4914339403904;3282.868685252587;3302.290007648343;4697.342372067879;4697.7181369117625;4700.670953033289;4702.27114797207;4716.52834716529;4271.914561708749;4300.892562644313;4306.633936115434;4309.707087873626;4316.158349121891;4932.457429682732;5024.71869673231;5033.697978121288;5036.798528058874;5054.368203974504;3556.466530020492;3562.5546806649168;3568.589612194605;3574.7318951078514;3577.499150118985;5256.553192978601;5264.736763161826;5317.840464786024;5348.786048558053;5368.167933970201;3457.4640930655787;3631.6913062389463;3641.326354624403;3702.7593206441493;3706.8517259309865;3678.889633311005;3689.6679298862696;3690.4833323334756;3693.9815300923324;3710.5547334320054;4269.509006464296;4284.592963668447;4285.6785741068925;4294.935575966363;4302.161078589645;4943.036107958914;5169.586433085344;5170.948290517122;5182.559482444034;5197.870053248699;1272.7263638317806;1281.88463038327;1282.755726944862;1283.8509533967233;1290.5934630591335;791.8535071011881;816.7345612675904;835.0959811629494;836.995815020921;840.357126798;4276.87169384919;4339.956600434019;4485.394471746337;4513.593776560126;4526.072155208174;5265.315508983807;5279.732864112585;5279.881692280028;5309.070912590281;5314.468553144732;4507.5267096955;4517.480489743656;4517.887052823706;4524.47968483622;4533.637309015271;2653.9469210616066;2776.1255204610484;2791.6510436195476;2809.550471924523;2812.1141840320233;4958.826441074545;4961.4046314441775;4962.553370196628;4976.154053810861;5000.524950129732;5144.768485418165;5364.249005139283;5383.946160538423;5434.293541839615;5438.374586922476;4931.358923340014;4942.308076869242;4969.925451118236;4982.701037937735;4988.226824842155;5286.603504737083;5292.814751483679;5293.729504918869;5315.6279060465395;5328.360596728262;4942.948676299296;5179.637425380338;5193.766280517461;5227.398849132398;5246.554042906396;4919.926201106915;4923.292189295801;4928.236123400879;4942.382202224722;4951.9257211142585;3674.4672022557115;3693.390590552529;3719.888403347904;3720.776753394805;3722.9813850930573;5004.84985450437;5317.175837745156;5326;5336.706481143575;5341.118715412069;5146.150885103916;5146.202338637517;5152.4847515248175;5153.330067091254;5171.482851714798;5139.665921715076;5147.2536482209125;5156.819511317086;5179.689218646893;5183.222516622537;4922.704637721748;5039.571636410946;5114.15616423286;5114.488551144856;5118.232265160255;4938.777755001105;4991;5138.8972220556125;5152.613553983391;5154.329937108152;4982.7259500727805;5037.949620503895;5047.621428392812;5062.215356619729;5074.792465277616 05:06:27 INFO - PROCESS | 31593 | |5;yui.html;618.3661746709622;694.3889377347933;727.2037119354305;741.1587847792754;753.8266198774281;11743.119266055037;12374.38128093594;12600.306983115925;12725.30010849403;12759.936200319009;13325.666858328546;13623.455061797516;13633.659158521043;13641.113327633697;13644.590662280147;631.4821846086211;772.7797577690359;793.1394437035794;795.1174196641723;795.8288967871906;755.8186035351504;778.7352300217925;784.6116172494624;785.8035491127218;787.248177990021;813.7396033269356;816.1104396208132;818.97133600324;822.9053658829222;825.0635528674967;661.5336187987457;820.1470470710454;820.4175035724643;820.5117954816934;821.4742564758529;581.1718301420501;598.2432223237608;598.3448124303924;600.2826622186489;600.6516220592046;12449.502019919193;12468.875311246862;12476.126671133025;12493.375331233492;12504.124711270215;12452.626421207287;12849.678758031125;13024.739505209938;13205.33973301331;13558.11872228312;11855.881441185564;12026.398680065962;12147.514099436012;12362.567310144103;12429.440675169639;3955.7230993830444;3988.5213774346976;4039.7374170678813;4117.97941010296;4164.7917604119975;64115.35884641141;66044.3395566043;66084.33915660878;66100.6694966522;66460.66769666121;9200.263978881674;9530.523473826419;9563.569639366246;9570;10207.438590877424;17102;17344.653106938043;17349.306027759;17377.47867563975;17390.65218695619;6847.452203823682;6868.347506986828;6875.7937261881225;7050.294970502909;7162.319579639926;3592.479090531858;3598.208394153282;3730.2539492101687;3754.4931434256573;3762.078290818767;2653.7213592572502;2739.904103356373;2743.1222008957343;2746;2749.134022782817;482.1273494974108;483.9008003359303;485.5993805110798;494.1722614620496;502.77877733797743;446.37730366139056;460.7903403951194;503.0994519809573;516.927375695426;554.2849723856261;7849.265348304208;7925.603719813987;8269.99330809727;8499.447535910145;8518.80736696863;527.9204027763234;530.3927003580878;536.919462080691;543.6982474726485;574.2907509226102;3848.6259851473733;3960.346542820402;4031.5766844481495;4046.4537287465814;4126.66986641068;84380;104265;106373;106808.46595766972;107116.46441767742;90964;93366;97284.51357743166;97747;98002.50998744961;74660.62669686617;76551.61724191566;80873;82107.19981601738;84943.57528212319;8064.516129032277;8167;8420.368472364475;8476.406651534333;8566.871496927426;29741.702582973892;30499.390012199186;41985.641148708644;42137;42450.78774606107;52755.47244527659;59162.70418647879;61361;62268;64525.354746451936;10502.789944201226;10580.947095264475;10765.46172691378;11053.447327633747;11185.832212516982;12004.2197257178;12338;12392.636809951078;12643.241405515699;13066.477340906258;11763.941180294043;11958.58144964922;12020.996081717076;12211.450484728386;12443.004559635026;11293.491792869505;11603.88396116028;11754.471048802654;13078;13091.345432728516;11383.772324553629;11423.608526266094;11898.940505297418;11904.940475297568;11995.820062698893;9469;9572.808543828945;9905.554250058909;9906.603735850485;10097.444640544547;9616.567254473426;10110.342827716175;10158.695239142837;10192.541335639766;10232.897671023195 05:06:27 INFO - PROCESS | 31593 | __end_tp_report 05:06:27 INFO - PROCESS | 31593 | __start_cc_report 05:06:27 INFO - PROCESS | 31593 | _x_x_mozilla_cycle_collect,1025 05:06:27 INFO - PROCESS | 31593 | __end_cc_report 05:06:27 INFO - PROCESS | 31593 | __startTimestamp1471608387887__endTimestamp 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | ------- Summary: start ------- 05:06:27 INFO - PROCESS | 31593 | Number of tests: 6 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | [#0] dojo.html Cycles:165 Average:4637.74 Median:4746.50 stddev:492.23 (10.4%) stddev-sans-first:466.48 05:06:27 INFO - PROCESS | 31593 | Values: 2578.3 2591.3 2620.9 2623.1 2637.3 4509.4 4593.2 4658.5 4707.1 4715.0 4539.8 4588.2 4637.2 4659.1 4666.3 4185.6 4210.4 4287.8 4339.9 4422.1 4354.0 4375.1 4405.4 4426.1 4426.4 4161.3 4206.3 4331.5 4340.7 4415.9 4192.3 4265.6 4274.1 4295.3 4295.8 4258.7 4303.5 4322.8 4335.2 4352.2 4528.6 4714.3 4743.5 4761.7 4772.5 4916.6 4933.1 4967.7 5053.5 5054.3 5030.8 5056.5 5074.5 5080.2 5088.5 4577.2 4661.8 4703.5 4734.7 4745.6 5089.1 5185.7 5210.2 5223.2 5240.1 4950.5 4957.9 4970.8 4974.3 4981.0 4805.7 4893.8 5098.7 5106.6 5112.9 4930.6 5007.2 5011.9 5036.5 5038.7 4946.1 4974.6 4977.5 4985.9 5027.0 4272.7 4279.7 4282.2 4293.1 4319.8 3659.3 3687.4 3705.5 3706.1 3775.6 4296.2 4297.7 4298.4 4330.4 4339.9 5029.1 5032.9 5038.5 5038.7 5083.6 4182.5 4243.7 4276.7 4296.5 4333.0 4554.5 4565.5 4580.8 4580.9 4619.1 4698.6 4713.9 4725.9 4726.5 4759.3 4854.6 4925.5 4960.9 4982.5 4985.5 4698.0 4713.9 4715.4 4739.2 4746.5 4934.0 4938.3 4941.4 4941.9 4984.2 4884.9 4969.7 4991.2 5006.8 5020.5 4905.6 4908.6 4921.7 4923.2 4946.9 4902.1 4907.5 4908.8 4910.2 4927.2 4616.6 4793.2 4846.1 4860.2 4867.8 4983.3 4989.8 4990.2 5002.3 5030.5 4882.4 4890.2 4890.5 4894.6 4923.9 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | [#1] ext.html Cycles:180 Average:47077.78 Median:34681.07 stddev:84879.18 (244.7%) stddev-sans-first:85045.46 05:06:27 INFO - PROCESS | 31593 | Values: 570.3 574.8 584.5 587.1 590.0 28313.9 38850.0 40144.6 40263.0 44370.6 40544.0 40924.4 40957.0 41021.6 41043.6 7639.8 7788.3 7793.8 7793.9 7795.9 7342.4 9777.4 10041.6 10046.2 10356.1 9779.2 9861.2 9878.6 9885.2 9888.1 9852.7 9915.3 9920.5 9923.2 9943.7 9942.3 9991.7 9994.0 10011.4 10011.5 36630.8 36878.9 36997.8 36999.8 37012.0 2929.9 2963.2 3219.2 3669.5 3755.3 26689.3 27281.2 29000.3 29905.9 30093.4 3177.4 3208.1 3223.9 3351.7 3387.1 250432.0 259903.0 262209.0 262241.7 262494.0 54907.2 55138.7 55459.2 55460.4 55553.4 33641.0 34812.0 58176.4 58494.4 58564.1 13755.4 13939.7 13942.0 13954.7 13959.2 9096.3 9243.1 10206.4 10385.2 10407.9 18360.5 18717.4 18963.8 19156.8 19262.5 7252.2 7381.7 7438.8 7509.4 7541.0 770.8 840.9 881.8 918.2 961.1 25720.4 27165.6 27602.6 27902.2 28086.4 917.8 927.8 967.4 1011.4 1050.5 13555.2 14607.3 14689.3 14696.8 14900.6 393029.0 396658.0 397463.0 397705.0 398383.0 48063.3 48488.5 48507.8 48526.8 48591.0 1036.4 1090.5 1137.0 1156.4 1156.7 25134.9 28068.9 28190.3 28220.5 29109.3 41181.4 41728.4 41738.0 41762.4 41775.6 294735.0 296013.0 296210.0 296218.0 296455.0 24967.9 25337.1 25375.2 25728.5 26378.6 40885.2 40960.2 40987.4 41114.0 41786.0 33952.7 34008.0 34325.0 34533.5 34570.8 32478.5 33989.8 34147.8 34240.8 34374.8 33930.7 34791.3 34817.5 34994.8 35296.8 30529.5 31802.5 32019.0 32229.4 32352.0 24097.6 25137.9 25443.8 26884.9 26976.0 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | [#2] jquery.html Cycles:180 Average:24829.66 Median:5078.36 stddev:67936.01 (1337.8%) stddev-sans-first:68101.71 05:06:27 INFO - PROCESS | 31593 | Values: 345.8 363.8 370.6 372.0 383.7 12562.9 15318.5 15608.6 16919.2 17060.2 15378.5 15383.2 15479.7 15508.9 15757.1 4853.5 5013.7 5067.0 5091.8 5171.5 3735.6 4995.6 5075.7 5081.0 5082.4 5705.5 5967.1 5988.8 6068.4 6076.1 5813.1 5925.6 5989.2 6052.6 6062.6 5238.9 5260.3 5263.2 5264.3 5267.1 20613.2 20769.6 20941.4 21015.2 21103.8 1738.2 1865.3 1892.6 1912.9 1919.3 13191.4 13205.9 13414.7 13487.5 14082.4 1732.2 1737.6 1739.5 1740.9 1763.0 43175.7 56454.0 65801.7 67286.3 68322.7 9671.0 9746.5 9753.8 9895.7 10126.4 13382.2 13392.0 13407.3 13415.9 13417.8 7055.8 7139.8 7254.7 7281.3 7340.5 6726.7 6742.3 6942.1 6965.4 6968.4 5920.9 6263.6 6272.7 6296.7 6297.8 1773.8 1775.1 1777.2 1789.5 1797.1 837.3 855.2 900.1 905.5 983.4 16201.9 16851.9 18089.0 18164.7 18347.3 817.4 844.0 851.8 912.6 929.7 9477.5 9493.8 10119.5 10128.3 10149.7 396372.0 416154.0 417106.0 417681.0 417764.0 76174.6 76296.6 77447.0 77543.0 78169.0 903.6 906.4 936.1 936.3 936.8 15257.7 15434.5 15769.0 16253.9 16269.1 37153.4 37407.0 37420.4 37444.4 37565.8 51321.5 51582.0 52598.5 52834.5 53078.9 6415.9 6618.0 6782.1 6957.7 6996.1 10037.9 10936.0 11610.9 11932.3 12503.7 9819.3 9921.5 9984.4 10009.6 10357.6 9916.9 9924.7 10150.2 10531.9 10625.3 9636.2 9941.6 9990.2 10020.9 10186.3 7651.1 7837.5 7842.2 8038.3 8199.2 9334.8 9852.2 10020.1 10160.8 10597.4 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | [#3] mootools.html Cycles:180 Average:5023.37 Median:5257.92 stddev:2796.41 (53.2%) stddev-sans-first:2789.95 05:06:27 INFO - PROCESS | 31593 | Values: 1259.6 1376.2 1392.1 1483.7 1685.7 6489.4 7358.6 7629.6 7650.6 7869.6 7741.2 7792.8 7806.6 7810.9 7818.5 2229.6 2253.5 2255.7 2255.7 2257.0 2158.1 2187.6 2216.3 2219.5 2224.9 2163.4 2182.1 2199.1 2199.3 2200.7 2145.6 2149.5 2153.9 2155.2 2158.2 2106.1 2149.5 2154.3 2154.3 2155.8 7525.6 7602.4 7637.2 7724.5 7743.5 4436.7 4620.4 4621.3 4621.7 4622.1 2805.5 2904.9 2950.2 2956.6 2966.4 913.5 917.2 935.0 942.7 945.1 10293.3 10393.1 10421.4 10447.7 10464.1 3809.8 3904.7 3982.5 3984.3 3994.8 8292.5 8303.0 8330.9 8347.1 8347.8 4459.6 4461.4 4461.7 4466.2 4472.1 3534.6 3632.7 3672.7 4141.6 4142.6 3121.9 3166.2 3476.1 3499.4 3507.2 1029.1 1048.3 1060.0 1075.5 1083.4 808.7 865.4 875.8 876.6 877.8 5244.2 5271.6 5322.4 5446.7 5463.1 403.8 409.9 411.9 418.0 423.1 3586.8 3612.3 3660.8 3727.4 3785.9 9093.9 9339.2 9483.4 9488.8 9503.0 8712.0 9407.2 9409.0 9422.1 9431.9 6867.0 7205.4 7211.7 7213.4 7220.6 5406.9 5541.2 5623.6 5646.7 5704.8 8400.6 8461.3 8670.8 8764.9 8769.9 8729.0 8792.6 8891.3 8904.7 8935.0 6048.7 6667.8 6856.3 6876.8 7002.3 7354.5 7408.9 7415.0 7430.1 7438.2 6252.5 6308.6 6390.7 6438.6 6564.7 6173.2 6306.4 6306.7 6336.9 6381.2 6123.1 6174.8 6177.9 6187.3 6203.7 4650.0 4853.5 4975.1 4995.4 5039.7 4591.4 4777.5 4789.5 4831.6 5062.9 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | [#4] prototype.html Cycles:180 Average:4232.74 Median:4912.69 stddev:1248.05 (25.4%) stddev-sans-first:1216.06 05:06:27 INFO - PROCESS | 31593 | Values: 295.5 304.4 305.4 311.1 311.2 4895.6 4916.0 4930.3 4938.9 4950.6 4854.7 4879.6 4884.8 4905.4 4909.4 3632.7 3744.3 3754.8 3758.7 3768.5 3689.4 3749.3 3819.5 3856.2 3879.4 3781.0 3786.4 3795.4 3821.8 3828.3 3569.4 3738.0 3791.9 3799.8 3822.2 3263.9 3278.3 3279.5 3282.9 3302.3 4697.3 4697.7 4700.7 4702.3 4716.5 4271.9 4300.9 4306.6 4309.7 4316.2 4932.5 5024.7 5033.7 5036.8 5054.4 3556.5 3562.6 3568.6 3574.7 3577.5 5256.6 5264.7 5317.8 5348.8 5368.2 3457.5 3631.7 3641.3 3702.8 3706.9 3678.9 3689.7 3690.5 3694.0 3710.6 4269.5 4284.6 4285.7 4294.9 4302.2 4943.0 5169.6 5170.9 5182.6 5197.9 1272.7 1281.9 1282.8 1283.9 1290.6 791.9 816.7 835.1 837.0 840.4 4276.9 4340.0 4485.4 4513.6 4526.1 5265.3 5279.7 5279.9 5309.1 5314.5 4507.5 4517.5 4517.9 4524.5 4533.6 2653.9 2776.1 2791.7 2809.6 2812.1 4958.8 4961.4 4962.6 4976.2 5000.5 5144.8 5364.2 5383.9 5434.3 5438.4 4931.4 4942.3 4969.9 4982.7 4988.2 5286.6 5292.8 5293.7 5315.6 5328.4 4942.9 5179.6 5193.8 5227.4 5246.6 4919.9 4923.3 4928.2 4942.4 4951.9 3674.5 3693.4 3719.9 3720.8 3723.0 5004.8 5317.2 5326.0 5336.7 5341.1 5146.2 5146.2 5152.5 5153.3 5171.5 5139.7 5147.3 5156.8 5179.7 5183.2 4922.7 5039.6 5114.2 5114.5 5118.2 4938.8 4991.0 5138.9 5152.6 5154.3 4982.7 5037.9 5047.6 5062.2 5074.8 05:06:27 INFO - PROCESS | 31593 | 05:06:27 INFO - PROCESS | 31593 | [#5] yui.html Cycles:180 Average:18164.22 Median:453.58 stddev:26842.03 (5917.8%) stddev-sans-first:26885.00 05:06:27 INFO - PROCESS | 31593 | Values: 618.4 694.4 727.2 741.2 753.8 11743.1 12374.4 12600.3 12725.3 12759.9 13325.7 13623.5 13633.7 13641.1 13644.6 631.5 772.8 793.1 795.1 795.8 755.8 778.7 784.6 785.8 787.2 813.7 816.1 819.0 822.9 825.1 661.5 820.1 820.4 820.5 821.5 581.2 598.2 598.3 600.3 600.7 12449.5 12468.9 12476.1 12493.4 12504.1 12452.6 12849.7 13024.7 13205.3 13558.1 11855.9 12026.4 12147.5 12362.6 12429.4 3955.7 3988.5 4039.7 4118.0 4164.8 64115.4 66044.3 66084.3 66100.7 66460.7 9200.3 9530.5 9563.6 9570.0 10207.4 17102.0 17344.7 17349.3 17377.5 17390.7 6847.5 6868.3 6875.8 7050.3 7162.3 3592.5 3598.2 3730.3 3754.5 3762.1 2653.7 2739.9 2743.1 2746.0 2749.1 482.1 483.9 485.6 494.2 502.8 446.4 460.8 503.1 516.9 554.3 7849.3 7925.6 8270.0 8499.4 8518.8 527.9 530.4 536.9 543.7 574.3 3848.6 3960.3 4031.6 4046.5 4126.7 84380.0 104265.0 106373.0 106808.5 107116.5 90964.0 93366.0 97284.5 97747.0 98002.5 74660.6 76551.6 80873.0 82107.2 84943.6 8064.5 8167.0 8420.4 8476.4 8566.9 29741.7 30499.4 41985.6 42137.0 42450.8 52755.5 59162.7 61361.0 62268.0 64525.4 10502.8 10580.9 10765.5 11053.4 11185.8 12004.2 12338.0 12392.6 12643.2 13066.5 11763.9 11958.6 12021.0 12211.5 12443.0 11293.5 11603.9 11754.5 13078.0 13091.3 11383.8 11423.6 11898.9 11904.9 11995.8 9469.0 9572.8 9905.6 9906.6 10097.4 9616.6 10110.3 10158.7 10192.5 10232.9 05:06:27 INFO - PROCESS | 31593 | -------- Summary: end -------- 05:06:27 INFO - PROCESS | 31593 | 05:06:28 INFO - TEST-INFO | 31593: exit 0 05:06:28 INFO - TEST-OK | dromaeo_css | took 1120687ms 05:06:28 INFO - TEST-START | kraken 05:06:28 INFO - operating with platform_type : linux_ 05:06:28 INFO - Initialising browser for kraken test... 05:06:28 INFO - TEST-INFO | started process 31900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_LzPhj/profile http://localhost:49567/getInfo.html) 05:06:32 INFO - PROCESS | 31900 | __metrics Screen width/height:1600/1200 05:06:32 INFO - PROCESS | 31900 | colorDepth:24 05:06:32 INFO - PROCESS | 31900 | Browser inner width/height: 1024/697 05:06:32 INFO - PROCESS | 31900 | __metrics 05:06:33 INFO - PROCESS | 31900 | 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" 05:06:33 INFO - PROCESS | 31900 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:34 INFO - PROCESS | 31900 | console.error: PushService: 05:06:34 INFO - PROCESS | 31900 | stateChangeProcessEnqueue: Error transitioning state 05:06:34 INFO - PROCESS | 31900 | UnknownError 05:06:34 INFO - TEST-INFO | 31900: exit 0 05:06:34 INFO - Browser initialized. 05:06:34 INFO - Running cycle 1/1 for kraken test... 05:06:34 INFO - TEST-INFO | started process 31984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_LzPhj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:46 INFO - PROCESS | 31984 | RSS: Main: 157409280 05:06:46 INFO - PROCESS | 31984 | 05:06:49 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:50 INFO - PROCESS | 31984 | RSS: Main: 204963840 05:06:50 INFO - PROCESS | 31984 | 05:06:52 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-dft) 05:06:53 INFO - PROCESS | 31984 | RSS: Main: 196276224 05:06:53 INFO - PROCESS | 31984 | 05:06:56 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-fft) 05:06:57 INFO - PROCESS | 31984 | RSS: Main: 277700608 05:06:57 INFO - PROCESS | 31984 | 05:06:59 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-oscillator) 05:07:00 INFO - PROCESS | 31984 | RSS: Main: 187305984 05:07:00 INFO - PROCESS | 31984 | 05:07:02 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:03 INFO - PROCESS | 31984 | RSS: Main: 192479232 05:07:03 INFO - PROCESS | 31984 | 05:07:06 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49567/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:06 INFO - PROCESS | 31984 | RSS: Main: 228368384 05:07:06 INFO - PROCESS | 31984 | 05:07:10 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49567/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:11 INFO - PROCESS | 31984 | RSS: Main: 227360768 05:07:11 INFO - PROCESS | 31984 | 05:07:13 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49567/tests/kraken/driver.html?testName=json-parse-financial) 05:07:14 INFO - PROCESS | 31984 | RSS: Main: 227921920 05:07:14 INFO - PROCESS | 31984 | 05:07:16 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:16 INFO - PROCESS | 31984 | RSS: Main: 190386176 05:07:16 INFO - PROCESS | 31984 | 05:07:18 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:19 INFO - PROCESS | 31984 | RSS: Main: 197124096 05:07:19 INFO - PROCESS | 31984 | 05:07:21 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:22 INFO - PROCESS | 31984 | RSS: Main: 195383296 05:07:22 INFO - PROCESS | 31984 | 05:07:25 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:25 INFO - PROCESS | 31984 | RSS: Main: 189722624 05:07:25 INFO - PROCESS | 31984 | 05:07:28 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:29 INFO - PROCESS | 31984 | RSS: Main: 193024000 05:07:29 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49567/tests/kraken/driver.html?testName=ai-astar) 05:07:31 INFO - PROCESS | 31984 | RSS: Main: 243339264 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | __start_tp_report 05:07:31 INFO - PROCESS | 31984 | _x_x_mozilla_page_load 05:07:31 INFO - PROCESS | 31984 | _x_x_mozilla_page_load_details 05:07:31 INFO - PROCESS | 31984 | |i|pagename|runs| 05:07:31 INFO - PROCESS | 31984 | |0;ai-astar;109;113;115;116;109;114;113;113;116;115 05:07:31 INFO - PROCESS | 31984 | |1;audio-beat-detection;153;122;124;189;123;125;144;123;177;124 05:07:31 INFO - PROCESS | 31984 | |2;audio-dft;161;162;160;162;161;160;162;162;162;162 05:07:31 INFO - PROCESS | 31984 | |3;audio-fft;77;78;76;115;75;78;75;75;100;76 05:07:31 INFO - PROCESS | 31984 | |4;audio-oscillator;86;88;139;86;86;87;127;86;86;134 05:07:31 INFO - PROCESS | 31984 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 05:07:31 INFO - PROCESS | 31984 | |6;imaging-darkroom;146;146;147;145;145;147;146;146;146;147 05:07:31 INFO - PROCESS | 31984 | |7;imaging-desaturate;94;94;94;95;96;95;95;95;96;95 05:07:31 INFO - PROCESS | 31984 | |8;json-parse-financial;65;63;65;64;65;67;64;63;66;65 05:07:31 INFO - PROCESS | 31984 | |9;json-stringify-tinderbox;65;65;66;66;66;65;66;66;66;66 05:07:31 INFO - PROCESS | 31984 | |10;stanford-crypto-aes;84;85;89;84;85;85;86;85;94;87 05:07:31 INFO - PROCESS | 31984 | |11;stanford-crypto-ccm;150;135;140;134;144;132;137;135;160;132 05:07:31 INFO - PROCESS | 31984 | |12;stanford-crypto-pbkdf2;180;180;179;179;180;179;180;179;181;176 05:07:31 INFO - PROCESS | 31984 | |13;stanford-crypto-sha256-iterative;69;68;74;70;68;70;69;68;69;69 05:07:31 INFO - PROCESS | 31984 | __end_tp_report 05:07:31 INFO - PROCESS | 31984 | __start_cc_report 05:07:31 INFO - PROCESS | 31984 | _x_x_mozilla_cycle_collect,1979 05:07:31 INFO - PROCESS | 31984 | __end_cc_report 05:07:31 INFO - PROCESS | 31984 | __startTimestamp1471608451476__endTimestamp 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | ------- Summary: start ------- 05:07:31 INFO - PROCESS | 31984 | Number of tests: 14 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.50 stddev:2.54 (2.2%) stddev-sans-first:2.17 05:07:31 INFO - PROCESS | 31984 | Values: 109.0 113.0 115.0 116.0 109.0 114.0 113.0 113.0 116.0 115.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:134.50 stddev:24.93 (18.5%) stddev-sans-first:26.02 05:07:31 INFO - PROCESS | 31984 | Values: 153.0 122.0 124.0 189.0 123.0 125.0 144.0 123.0 177.0 124.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 05:07:31 INFO - PROCESS | 31984 | Values: 161.0 162.0 160.0 162.0 161.0 160.0 162.0 162.0 162.0 162.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:13.69 (18.0%) stddev-sans-first:14.37 05:07:31 INFO - PROCESS | 31984 | Values: 77.0 78.0 76.0 115.0 75.0 78.0 75.0 75.0 100.0 76.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:86.00 stddev:22.84 (26.6%) stddev-sans-first:23.62 05:07:31 INFO - PROCESS | 31984 | Values: 86.0 88.0 139.0 86.0 86.0 87.0 127.0 86.0 86.0 134.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:07:31 INFO - PROCESS | 31984 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:07:31 INFO - PROCESS | 31984 | Values: 146.0 146.0 147.0 145.0 145.0 147.0 146.0 146.0 146.0 147.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 05:07:31 INFO - PROCESS | 31984 | Values: 94.0 94.0 94.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 05:07:31 INFO - PROCESS | 31984 | Values: 65.0 63.0 65.0 64.0 65.0 67.0 64.0 63.0 66.0 65.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 05:07:31 INFO - PROCESS | 31984 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.50 stddev:3.06 (3.6%) stddev-sans-first:3.12 05:07:31 INFO - PROCESS | 31984 | Values: 84.0 85.0 89.0 84.0 85.0 85.0 86.0 85.0 94.0 87.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:138.50 stddev:9.06 (6.5%) stddev-sans-first:8.84 05:07:31 INFO - PROCESS | 31984 | Values: 150.0 135.0 140.0 134.0 144.0 132.0 137.0 135.0 160.0 132.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:180.00 stddev:1.34 (0.7%) stddev-sans-first:1.39 05:07:31 INFO - PROCESS | 31984 | Values: 180.0 180.0 179.0 179.0 180.0 179.0 180.0 179.0 181.0 176.0 05:07:31 INFO - PROCESS | 31984 | 05:07:31 INFO - PROCESS | 31984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.88 05:07:31 INFO - PROCESS | 31984 | Values: 69.0 68.0 74.0 70.0 68.0 70.0 69.0 68.0 69.0 69.0 05:07:31 INFO - PROCESS | 31984 | -------- Summary: end -------- 05:07:31 INFO - PROCESS | 31984 | 05:07:32 INFO - TEST-INFO | 31984: exit 0 05:07:32 INFO - TEST-OK | kraken | took 63977ms 05:07:32 INFO - SUITE-END | took 1184s 05:07:33 INFO - Completed test suite (00:19:45) 05:07:33 INFO - javascript benchmark 05:07:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.2651944195904, 2591.3262551736543, 2620.882060307286, 2623.0819213275354, 2637.2615667613063, 4509.436320459942, 4593.173228818811, 4658.464276608191, 4707.105649926516, 4715.03341814928, 4539.818407263706, 4588.151192029477, 4637.188492013901, 4659.068186362732, 4666.2767271073035, 4185.560516145806, 4210.368444733299, 4287.764172970486, 4339.869803905888, 4422.11557688462, 4353.978230108861, 4375.1031038637, 4405.405270288502, 4426.136903303857, 4426.424564806571, 4161.313383291753, 4206.305959516676, 4331.523532411432, 4340.739555626673, 4415.86752397427, 4192.28731115708, 4265.552117027699, 4274.123804620077, 4295.2912769393015, 4295.78521073945, 4258.659307255443, 4303.526612072669, 4322.848700295474, 4335.219660461115, 4352.194843953847, 4528.56978587037, 4714.316424118484, 4743.454502732196, 4761.6904901181315, 4772.522747725235, 4916.606671466274, 4933.087378834891, 4967.652264341497, 5053.545180933734, 5054.267131265982, 5030.773615187289, 5056.469070747592, 5074.543291103819, 5080.212567052113, 5088.491150884919, 4577.244754615451, 4661.836835710734, 4703.482616912137, 4734.692245004098, 4745.572898439157, 5089.109405853961, 5185.740712964337, 5210.192420174879, 5223.190405487156, 5240.109181439165, 4950.529699678596, 4957.90084198314, 4970.751462426864, 4974.303597496281, 4980.950190498121, 4805.711657300503, 4893.804247830119, 5098.719570423662, 5106.565941894981, 5112.8721781955, 4930.580900623416, 5007.1988481843455, 5011.924821127686, 5036.546710796046, 5038.672486288379, 4946.08497427977, 4974.602031837444, 4977.452480227172, 4985.90028199434, 5026.974865125651, 4272.743635381887, 4279.743215407086, 4282.186384586918, 4293.141371725667, 4319.784010799511, 3659.304732100892, 3687.391580389206, 3705.5182826232417, 3706.1105334720014, 3775.5846856845724, 4296.162248361602, 4297.67767417445, 4298.4412026436985, 4330.415393921843, 4339.913201735948, 5029.0947629427055, 5032.924506132411, 5038.546530812245, 5038.722870242172, 5083.644144909821, 4182.498100227992, 4243.7029407941145, 4276.700630955803, 4296.527381988041, 4333.046729719456, 4554.4990051094355, 4565.452145742533, 4580.839670611513, 4580.862574122782, 4619.076184763061, 4698.577128058423, 4713.905721885474, 4725.9291110632685, 4726.456457507431, 4759.262314341283, 4854.563089321978, 4925.5320744530645, 4960.8759781005765, 4982.501749825134, 4985.501449854985, 4698.0, 4713.905721885474, 4715.3869996900185, 4739.194336962656, 4746.501617330131, 4934.0, 4938.2839488273285, 4941.431735350337, 4941.901161976669, 4984.22744474607, 4884.902301954012, 4969.652124351261, 4991.15150424436, 5006.799728010838, 5020.472850350807, 4905.607551395951, 4908.631852610997, 4921.680090794087, 4923.236898280772, 4946.851594452172, 4902.068606964665, 4907.527741677411, 4908.779104940358, 4910.238912968495, 4927.236278376858, 4616.6075883550275, 4793.161196790478, 4846.127697014571, 4860.198067318995, 4867.780949857194, 4983.277424773315, 4989.825356112518, 4990.15167421532, 5002.274670172877, 5030.496950304941, 4882.389701287339, 4890.24201248807, 4890.486498917705, 4894.583960363267, 4923.876903077452], "value": 4605.987142819507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.284293212019, 574.8016934157716, 584.4944123333318, 587.1310460518432, 589.9675517846522, 28313.85843070784, 38850.0, 40144.598554014454, 40262.99342516435, 44370.55629443705, 40544.0, 40924.38613420801, 40957.0, 41021.58978410222, 41043.58956410435, 7639.770806875803, 7788.3379912707205, 7793.766187014398, 7793.922060779405, 7795.88306175405, 7342.375898048672, 9777.413355198676, 10041.648542301022, 10046.196304295676, 10356.067953884149, 9779.217662586976, 9861.161801246903, 9878.604855805796, 9885.159761420287, 9888.11007009369, 9852.655157069505, 9915.25635577331, 9920.45437500937, 9923.156531694814, 9943.701688949342, 9942.304038717293, 9991.700248992469, 9993.950030249875, 10011.449370284632, 10011.49942502872, 36630.8168459156, 36878.893633191045, 36997.81501092477, 36999.81500092509, 37012.0, 2929.8828046878098, 2963.199936017263, 3219.227385427504, 3669.486271921933, 3755.267722794056, 26689.332766680793, 27281.181564553095, 29000.27499312513, 29905.850470747726, 30093.398132037455, 3177.4280629486684, 3208.1017315151794, 3223.9194020149685, 3351.7318614511023, 3387.119348969261, 250432.0, 259903.0, 262209.0, 262241.68879155675, 262494.0, 54907.176392354144, 55138.72430637821, 55459.16811247834, 55460.445395545525, 55553.44446555483, 33641.0, 34812.0, 58176.4182358171, 58494.4150558489, 58564.12153817696, 13755.449782008807, 13939.675730805557, 13941.954353423534, 13954.720905581831, 13959.232242226572, 9096.272298216127, 9243.121903419164, 10206.438645874548, 10385.169186465217, 10407.947960260302, 18360.540986475444, 18717.438476845444, 18963.810361896205, 19156.83912154479, 19262.518437039187, 7252.166000909963, 7381.66782494789, 7438.814029649194, 7509.36170425509, 7540.962295188599, 770.8227107765246, 840.9453385529921, 881.7751473374249, 918.2332752152028, 961.053362437998, 25720.356991074997, 27165.592516112276, 27602.5859612106, 27902.16293511198, 28086.43827123446, 917.8118485710413, 927.8144371125667, 967.3953778888194, 1011.3931641015332, 1050.4957620342125, 13555.186688798703, 14607.342669579895, 14689.338979745937, 14696.829333890959, 14900.627484312761, 393029.0, 396658.0, 397463.0, 397705.0, 398383.0, 48063.279050814264, 48488.515114849106, 48507.84698994554, 48526.75736621365, 48591.0, 1036.3678156324636, 1090.4929207918356, 1136.9829452558383, 1156.3986726901965, 1156.7397335599592, 25134.874325628254, 28068.85965570159, 28190.295242619097, 28220.472755609662, 29109.272268193465, 41181.382279265235, 41728.3740743883, 41738.0, 41762.37356439717, 41775.58224417717, 294735.0, 296013.0, 296210.0, 296218.0, 296455.0, 24967.875160624808, 25337.113201037875, 25375.238742837744, 25728.485430290915, 26378.604320935585, 40885.1822963545, 40960.1807963845, 40987.38518922159, 41114.0, 41786.0, 33952.66047339495, 34008.0, 34325.0, 34533.48199776955, 34570.82714586411, 32478.512822308156, 33989.83005084959, 34147.829260853534, 34240.828795855865, 34374.82812585921, 33930.66069339275, 34791.304173916884, 34817.47773783446, 34994.82502587471, 35296.82351588226, 30529.542056868722, 31802.522962155123, 32019.0, 32229.35541289208, 32352.0, 24097.638535422335, 25137.87431062833, 25443.807677510667, 26884.865575671996, 26976.0], "value": 17713.988458946373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7735183454838, 363.75628329019554, 370.63492459926977, 371.96466335698113, 383.7371400590594, 12562.937185314073, 15318.46385376512, 15608.609784755386, 16919.238634261455, 17060.23228954697, 15378.538643840675, 15383.230838458061, 15479.690406191869, 15508.922455387707, 15757.133357665352, 4853.5389138031915, 5013.724245166514, 5066.97466512667, 5091.84724458265, 5171.508706672879, 3735.6077611850774, 4995.625328100389, 5075.746212689369, 5080.974595127038, 5082.390113186404, 5705.5435565154685, 5967.075103358986, 5988.820335389945, 6068.423499767515, 6076.088586711984, 5813.069908814612, 5925.585209035369, 5989.161517387525, 6052.636841789506, 6062.636241825505, 5238.895222095575, 5260.342457192851, 5263.210518422229, 5264.31563896691, 5267.078261304257, 20613.175472981064, 20769.58460830775, 20941.371758847257, 21015.159393624235, 21103.788962110335, 1738.2438639191992, 1865.253898440621, 1892.6214757048645, 1912.8660993730443, 1919.280269898788, 13191.40638671262, 13205.933970330183, 13414.664633384145, 13487.527936522174, 14082.366293516816, 1732.2205007746566, 1737.5829800847832, 1739.5477175934348, 1740.9390671326444, 1762.9559261018449, 43175.67333784769, 56454.0, 65801.67099164521, 67286.32713672849, 68322.65838670774, 9671.0, 9746.512674366253, 9753.756156096013, 9895.703128906145, 10126.392416455037, 13382.197068175941, 13391.986802969253, 13407.32963351848, 13415.865841341656, 13417.779732864043, 7055.835787095174, 7139.750108746272, 7254.746083887038, 7281.308275713799, 7340.4861659684375, 6726.663666816639, 6742.325767423218, 6942.06282151903, 6965.373116419547, 6968.442524598121, 5920.851978700481, 6263.561550691499, 6272.686365681698, 6296.685165741695, 6297.779577714758, 1773.8492228160492, 1775.14792899409, 1777.2269062957655, 1789.4721057288132, 1797.0834874214245, 837.3092198935781, 855.1918437076903, 900.0999000999001, 905.4838741917044, 983.3804703037041, 16201.918990404973, 16851.949709363173, 18089.0, 18164.727529087075, 18347.266109355744, 817.3665409307833, 843.9662413503514, 851.7955690634327, 912.5710915869531, 929.6513807322254, 9477.526123693788, 9493.762655933657, 10119.494025298705, 10128.291019628703, 10149.695509134737, 396372.0, 416154.0, 417106.0, 417681.0, 417764.0, 76174.61912690401, 76296.61851690707, 77447.0, 77543.0, 78169.0, 903.5572569441058, 906.4153620914605, 936.1293996583242, 936.2790651198675, 936.7704912296394, 15257.694846103237, 15434.536963891102, 15769.0, 16253.918730406273, 16269.105199214157, 37153.442698360086, 37407.0, 37420.43869341908, 37444.43833342448, 37565.81217093897, 51321.486785131674, 51582.0, 52598.47401525936, 52834.471655282956, 53078.93842123213, 6415.935840641534, 6617.974213996838, 6782.084418603623, 6957.686904089429, 6996.125484314461, 10037.949810250902, 10936.0, 11610.88389116098, 11932.343721095423, 12503.687407814878, 9819.263555233529, 9921.503924803586, 9984.400935943866, 10009.599616015568, 10357.585696572354, 9916.900830991597, 9924.652637157666, 10150.238732094975, 10531.94734026325, 10625.309354891908, 9636.180924621205, 9941.602335906482, 9990.200783937122, 10020.899791002288, 10186.33788803755, 7651.081870175614, 7837.49056311338, 7842.176571459914, 8038.276555110068, 8199.22107399796, 9334.813303733752, 9852.162566181669, 10020.148287395654, 10160.796784064425, 10597.41714205726], "value": 8299.899132856628, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.5969289827246, 1376.2430663135276, 1392.0742706100443, 1483.6513419346452, 1685.705001624716, 6489.415952564268, 7358.595277259748, 7629.618519074038, 7650.579218143, 7869.645865936032, 7741.1871753465775, 7792.805179870506, 7806.648700808463, 7810.882836757439, 7818.491798033124, 2229.554089182162, 2253.5380247049316, 2255.7293124825046, 2255.740589832166, 2257.0407576779885, 2158.136745301876, 2187.57342318248, 2216.3018649125556, 2219.5006123622215, 2224.9110035598555, 2163.4158777130165, 2182.0617134632103, 2199.1093607089156, 2199.285232299501, 2200.7359116905996, 2145.5816115857415, 2149.451889768107, 2153.935381938544, 2155.1594877997595, 2158.190678495564, 2106.147010460766, 2149.451889768099, 2154.310620601408, 2154.34292540775, 2155.7736437673975, 7525.5860927648955, 7602.353799927013, 7637.15991240963, 7724.536527808294, 7743.457957942946, 4436.711613745097, 4620.399348084761, 4621.306803979396, 4621.676482646216, 4622.098690755304, 2805.466961277371, 2904.941901161965, 2950.2476868398635, 2956.571297161921, 2966.42154779818, 913.4610579757974, 917.1516347378648, 935.0322416299098, 942.6512190489494, 945.0832692288469, 10293.330933489298, 10393.064624183784, 10421.426821524814, 10447.686569402855, 10464.058234758832, 3809.7523660961947, 3904.7461914975434, 3982.522097348337, 3984.2629113614075, 3994.8202330894596, 8292.460990035628, 8303.0, 8330.916690833013, 8347.081820999685, 8347.83304333922, 4459.620932220798, 4461.353103799931, 4461.687681862239, 4466.218411777926, 4472.105578884236, 3534.593521744981, 3632.7093832493865, 3672.7429079964145, 4141.64795992338, 4142.565030671796, 3121.8907338243052, 3166.176794033568, 3476.0881515166557, 3499.4400895856543, 3507.15828201235, 1029.0892560084378, 1048.2557384257111, 1059.9735006624896, 1075.510642657589, 1083.4366129612558, 808.7412028150935, 865.4158443050916, 875.7898104454885, 876.6055275126218, 877.7937184761576, 5244.213367994755, 5271.6309858310315, 5322.414534401213, 5446.673199608036, 5463.125899856004, 403.81020920167475, 409.9344104943195, 411.916659186338, 418.02599942134754, 423.12413304460085, 3586.8027258501033, 3612.3497770401054, 3660.7803531788177, 3727.366347720894, 3785.9242815143543, 9093.909060909438, 9339.206167475704, 9483.430994140374, 9488.762780930532, 9503.049695030442, 8712.0, 9407.2003879671, 9408.95295523518, 9422.104900034486, 9431.858522122173, 6866.965665171642, 7205.351518363268, 7211.67547460376, 7213.350798428167, 7220.638968051577, 5406.918896216638, 5541.168824676331, 5623.634463759842, 5646.661200327993, 5704.80033198836, 8400.579971001303, 8461.280791132822, 8670.783230419038, 8764.868526971974, 8769.868451973098, 8728.956355218183, 8792.560371981503, 8891.288696904361, 8904.688335908471, 8935.017148113833, 6048.6975651218145, 6667.799966001027, 6856.314368563104, 6876.759313424006, 7002.334778196063, 7354.521956072838, 7408.888866666896, 7415.0, 7430.145533263528, 7438.1818000018875, 6252.499800015897, 6308.589941653778, 6390.712417941297, 6438.581492202992, 6564.704588293443, 6173.228346456693, 6306.400891915261, 6306.684665766602, 6336.936630633819, 6381.1704478417505, 6123.081537769192, 6174.8147555573405, 6177.876442471215, 6187.257529096537, 6203.658798766111, 4649.976750116228, 4853.466118727008, 4975.129352363394, 4995.400551933792, 5039.664488910515, 4591.380163677861, 4777.522247775195, 4789.521047895182, 4831.637627177905, 5062.949370506248], "value": 3992.5649803230135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5124045325213, 304.40033134724587, 305.375507088005, 311.0683502908787, 311.1753852291429, 4895.632827537931, 4916.0, 4930.309756634074, 4938.851834444972, 4950.55445009949, 4854.660173787836, 4879.60899159412, 4884.78018489168, 4905.435874874391, 4909.386326709161, 3632.691221246197, 3744.288585168823, 3754.793486358249, 3758.7180961427866, 3768.453574231735, 3689.446583012556, 3749.343864823659, 3819.52255968004, 3856.2094770572107, 3879.4374815651713, 3780.996072081787, 3786.413105968579, 3795.430685397199, 3821.8280177391944, 3828.349180639298, 3569.3575156471825, 3738.0, 3791.924161516768, 3799.7530160539613, 3822.178231680174, 3263.8694452221885, 3278.344331133783, 3279.4914339403904, 3282.868685252587, 3302.290007648343, 4697.342372067879, 4697.7181369117625, 4700.670953033289, 4702.27114797207, 4716.52834716529, 4271.914561708749, 4300.892562644313, 4306.633936115434, 4309.707087873626, 4316.158349121891, 4932.457429682732, 5024.71869673231, 5033.697978121288, 5036.798528058874, 5054.368203974504, 3556.466530020492, 3562.5546806649168, 3568.589612194605, 3574.7318951078514, 3577.499150118985, 5256.553192978601, 5264.736763161826, 5317.840464786024, 5348.786048558053, 5368.167933970201, 3457.4640930655787, 3631.6913062389463, 3641.326354624403, 3702.7593206441493, 3706.8517259309865, 3678.889633311005, 3689.6679298862696, 3690.4833323334756, 3693.9815300923324, 3710.5547334320054, 4269.509006464296, 4284.592963668447, 4285.6785741068925, 4294.935575966363, 4302.161078589645, 4943.036107958914, 5169.586433085344, 5170.948290517122, 5182.559482444034, 5197.870053248699, 1272.7263638317806, 1281.88463038327, 1282.755726944862, 1283.8509533967233, 1290.5934630591335, 791.8535071011881, 816.7345612675904, 835.0959811629494, 836.995815020921, 840.357126798, 4276.87169384919, 4339.956600434019, 4485.394471746337, 4513.593776560126, 4526.072155208174, 5265.315508983807, 5279.732864112585, 5279.881692280028, 5309.070912590281, 5314.468553144732, 4507.5267096955, 4517.480489743656, 4517.887052823706, 4524.47968483622, 4533.637309015271, 2653.9469210616066, 2776.1255204610484, 2791.6510436195476, 2809.550471924523, 2812.1141840320233, 4958.826441074545, 4961.4046314441775, 4962.553370196628, 4976.154053810861, 5000.524950129732, 5144.768485418165, 5364.249005139283, 5383.946160538423, 5434.293541839615, 5438.374586922476, 4931.358923340014, 4942.308076869242, 4969.925451118236, 4982.701037937735, 4988.226824842155, 5286.603504737083, 5292.814751483679, 5293.729504918869, 5315.6279060465395, 5328.360596728262, 4942.948676299296, 5179.637425380338, 5193.766280517461, 5227.398849132398, 5246.554042906396, 4919.926201106915, 4923.292189295801, 4928.236123400879, 4942.382202224722, 4951.9257211142585, 3674.4672022557115, 3693.390590552529, 3719.888403347904, 3720.776753394805, 3722.9813850930573, 5004.84985450437, 5317.175837745156, 5326.0, 5336.706481143575, 5341.118715412069, 5146.150885103916, 5146.202338637517, 5152.4847515248175, 5153.330067091254, 5171.482851714798, 5139.665921715076, 5147.2536482209125, 5156.819511317086, 5179.689218646893, 5183.222516622537, 4922.704637721748, 5039.571636410946, 5114.15616423286, 5114.488551144856, 5118.232265160255, 4938.777755001105, 4991.0, 5138.8972220556125, 5152.613553983391, 5154.329937108152, 4982.7259500727805, 5037.949620503895, 5047.621428392812, 5062.215356619729, 5074.792465277616], "value": 3834.2026969738326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.3661746709622, 694.3889377347933, 727.2037119354305, 741.1587847792754, 753.8266198774281, 11743.119266055037, 12374.38128093594, 12600.306983115925, 12725.30010849403, 12759.936200319009, 13325.666858328546, 13623.455061797516, 13633.659158521043, 13641.113327633697, 13644.590662280147, 631.4821846086211, 772.7797577690359, 793.1394437035794, 795.1174196641723, 795.8288967871906, 755.8186035351504, 778.7352300217925, 784.6116172494624, 785.8035491127218, 787.248177990021, 813.7396033269356, 816.1104396208132, 818.97133600324, 822.9053658829222, 825.0635528674967, 661.5336187987457, 820.1470470710454, 820.4175035724643, 820.5117954816934, 821.4742564758529, 581.1718301420501, 598.2432223237608, 598.3448124303924, 600.2826622186489, 600.6516220592046, 12449.502019919193, 12468.875311246862, 12476.126671133025, 12493.375331233492, 12504.124711270215, 12452.626421207287, 12849.678758031125, 13024.739505209938, 13205.33973301331, 13558.11872228312, 11855.881441185564, 12026.398680065962, 12147.514099436012, 12362.567310144103, 12429.440675169639, 3955.7230993830444, 3988.5213774346976, 4039.7374170678813, 4117.97941010296, 4164.7917604119975, 64115.35884641141, 66044.3395566043, 66084.33915660878, 66100.6694966522, 66460.66769666121, 9200.263978881674, 9530.523473826419, 9563.569639366246, 9570.0, 10207.438590877424, 17102.0, 17344.653106938043, 17349.306027759, 17377.47867563975, 17390.65218695619, 6847.452203823682, 6868.347506986828, 6875.7937261881225, 7050.294970502909, 7162.319579639926, 3592.479090531858, 3598.208394153282, 3730.2539492101687, 3754.4931434256573, 3762.078290818767, 2653.7213592572502, 2739.904103356373, 2743.1222008957343, 2746.0, 2749.134022782817, 482.1273494974108, 483.9008003359303, 485.5993805110798, 494.1722614620496, 502.77877733797743, 446.37730366139056, 460.7903403951194, 503.0994519809573, 516.927375695426, 554.2849723856261, 7849.265348304208, 7925.603719813987, 8269.99330809727, 8499.447535910145, 8518.80736696863, 527.9204027763234, 530.3927003580878, 536.919462080691, 543.6982474726485, 574.2907509226102, 3848.6259851473733, 3960.346542820402, 4031.5766844481495, 4046.4537287465814, 4126.66986641068, 84380.0, 104265.0, 106373.0, 106808.46595766972, 107116.46441767742, 90964.0, 93366.0, 97284.51357743166, 97747.0, 98002.50998744961, 74660.62669686617, 76551.61724191566, 80873.0, 82107.19981601738, 84943.57528212319, 8064.516129032277, 8167.0, 8420.368472364475, 8476.406651534333, 8566.871496927426, 29741.702582973892, 30499.390012199186, 41985.641148708644, 42137.0, 42450.78774606107, 52755.47244527659, 59162.70418647879, 61361.0, 62268.0, 64525.354746451936, 10502.789944201226, 10580.947095264475, 10765.46172691378, 11053.447327633747, 11185.832212516982, 12004.2197257178, 12338.0, 12392.636809951078, 12643.241405515699, 13066.477340906258, 11763.941180294043, 11958.58144964922, 12020.996081717076, 12211.450484728386, 12443.004559635026, 11293.491792869505, 11603.88396116028, 11754.471048802654, 13078.0, 13091.345432728516, 11383.772324553629, 11423.608526266094, 11898.940505297418, 11904.940475297568, 11995.820062698893, 9469.0, 9572.808543828945, 9905.554250058909, 9906.603735850485, 10097.444640544547, 9616.567254473426, 10110.342827716175, 10158.695239142837, 10192.541335639766, 10232.897671023195], "value": 6550.045572075271, "unit": "score"}], "name": "dromaeo_css", "value": 6387.37573508839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 115.0, 116.0, 109.0, 114.0, 113.0, 113.0, 116.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 124.0, 189.0, 123.0, 125.0, 144.0, 123.0, 177.0, 124.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 115.0, 75.0, 78.0, 75.0, 75.0, 100.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 139.0, 86.0, 86.0, 87.0, 127.0, 86.0, 86.0, 134.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 65.0, 67.0, 64.0, 63.0, 66.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 89.0, 84.0, 85.0, 85.0, 86.0, 85.0, 94.0, 87.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 135.0, 140.0, 134.0, 144.0, 132.0, 137.0, 135.0, 160.0, 132.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 179.0, 179.0, 180.0, 179.0, 180.0, 179.0, 181.0, 176.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 74.0, 70.0, 68.0, 70.0, 69.0, 68.0, 69.0, 69.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1561.6000000000004, "alertThreshold": 2.0}]} 05:07:33 INFO - Return code: 0 05:07:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:33 INFO - # TBPL SUCCESS # 05:07:33 INFO - Running post-action listener: _resource_record_post_action 05:07:33 INFO - [mozharness: 2016-08-19 12:07:33.255822Z] Finished run-tests step (success) 05:07:33 INFO - Running post-run listener: _resource_record_post_run 05:07:33 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407687168; Read time: 12; Write time: 301500 05:07:33 INFO - TinderboxPrint: CPU usage
13.0% 05:07:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:07:33 INFO - TinderboxPrint: I/O write bytes / time
407,687,168 / 301,500 05:07:33 INFO - TinderboxPrint: CPU idle
8,341.8 (87.0%) 05:07:33 INFO - TinderboxPrint: CPU user
1,201.2 (12.5%) 05:07:33 INFO - TinderboxPrint: Swap in / out
0 / 0 05:07:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114397184; Read time: 0; Write time: 116892 05:07:33 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 282025984; Read time: 0; Write time: 182656 05:07:33 INFO - Running post-run listener: _upload_blobber_files 05:07:33 INFO - Blob upload gear active. 05:07:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:33 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 05:07:33 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:33 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:35 INFO - (blobuploader) - INFO - Done attempting. 05:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:39 INFO - (blobuploader) - INFO - Done attempting. 05:07:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:39 INFO - (blobuploader) - INFO - Done attempting. 05:07:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:39 INFO - Return code: 0 05:07:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f788ec1b50ac815de9b744b417c38af32ca34abc151c078eb851f9eefa8c262165e33fa285b54b4bdbb6723088470d3e8f0819ed72e08e9472943c75097cadd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2173bf72500a2be0a9b37c398ac4713807aa6f4d72a25f98e075aab3e74c1f84f74136eea1513209fbf0550e3b57e71b21c0db070195362707d545de942d5171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88adfe176b6ad469920c92f6085f1b787e1a06bcf7e869c09ce44f6532b50bd54cf157d3c44c27c3ce557822a219d6b76317195dcaa32a030a7567137e1eaefa"} 05:07:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:39 INFO - Contents: 05:07:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f788ec1b50ac815de9b744b417c38af32ca34abc151c078eb851f9eefa8c262165e33fa285b54b4bdbb6723088470d3e8f0819ed72e08e9472943c75097cadd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2173bf72500a2be0a9b37c398ac4713807aa6f4d72a25f98e075aab3e74c1f84f74136eea1513209fbf0550e3b57e71b21c0db070195362707d545de942d5171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88adfe176b6ad469920c92f6085f1b787e1a06bcf7e869c09ce44f6532b50bd54cf157d3c44c27c3ce557822a219d6b76317195dcaa32a030a7567137e1eaefa"} 05:07:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:39 INFO - Copying logs to upload dir... 05:07:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.550751 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-19 05:07:39.436679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 05:07:39.440623) ========= 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=232498196343f89f466a4a9a000001c8-1471605331.843893-566756928 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-Non-PGO/sha512/1f788ec1b50ac815de9b744b417c38af32ca34abc151c078eb851f9eefa8c262165e33fa285b54b4bdbb6723088470d3e8f0819ed72e08e9472943c75097cadd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2173bf72500a2be0a9b37c398ac4713807aa6f4d72a25f98e075aab3e74c1f84f74136eea1513209fbf0550e3b57e71b21c0db070195362707d545de942d5171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88adfe176b6ad469920c92f6085f1b787e1a06bcf7e869c09ce44f6532b50bd54cf157d3c44c27c3ce557822a219d6b76317195dcaa32a030a7567137e1eaefa"} build_url:https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/D9XiLlklSe-rQfOJILBcJw/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-Non-PGO/sha512/1f788ec1b50ac815de9b744b417c38af32ca34abc151c078eb851f9eefa8c262165e33fa285b54b4bdbb6723088470d3e8f0819ed72e08e9472943c75097cadd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2173bf72500a2be0a9b37c398ac4713807aa6f4d72a25f98e075aab3e74c1f84f74136eea1513209fbf0550e3b57e71b21c0db070195362707d545de942d5171", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88adfe176b6ad469920c92f6085f1b787e1a06bcf7e869c09ce44f6532b50bd54cf157d3c44c27c3ce557822a219d6b76317195dcaa32a030a7567137e1eaefa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 05:07:39.466023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:07:39.466360) ========= 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=232498196343f89f466a4a9a000001c8-1471605331.843893-566756928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:07:39.550920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 05:07:39.551260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 05:07:39.551563) ========= ========= Total master_lag: 0.15 =========