builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1471631473.8 results: success (0) buildid: 20160819083003 builduid: 00dff21203fd4916b1a3fc6b592d3862 revision: 4d92551f854b80764c7b010c76043920c28c8e35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:13.798717) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:13.799183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:13.799459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:13.929358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:13.929690) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 11:31:14-- 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% 31.0M=0s 2016-08-19 11:31:14 (31.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132536 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:14.076959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:14.080489) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015514 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:14.130987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:14.131439) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d92551f854b80764c7b010c76043920c28c8e35 --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 4d92551f854b80764c7b010c76043920c28c8e35 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 11:31:14,361 truncating revision to first 12 chars 2016-08-19 11:31:14,361 Setting DEBUG logging. 2016-08-19 11:31:14,361 attempt 1/10 2016-08-19 11:31:14,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d92551f854b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 11:31:14,948 unpacking tar archive at: fx-team-4d92551f854b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.923518 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:15.068844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:15.072340) ========= script_repo_revision: 4d92551f854b80764c7b010c76043920c28c8e35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:15.072861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:15.073153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:31:15.083225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-19 11:31:15.083598) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:15 INFO - MultiFileLogger online at 20160819 11:31:15 in /builds/slave/test 11:31:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:31:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:15 INFO - {'append_to_log': False, 11:31:15 INFO - 'base_work_dir': '/builds/slave/test', 11:31:15 INFO - 'blob_upload_branch': 'Fx-Team', 11:31:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:15 INFO - 'branch': 'Fx-Team', 11:31:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:15 INFO - 'config_files': ('talos/linux_config.py',), 11:31:15 INFO - 'default_actions': ('clobber', 11:31:15 INFO - 'read-buildbot-config', 11:31:15 INFO - 'download-and-extract', 11:31:15 INFO - 'populate-webroot', 11:31:15 INFO - 'create-virtualenv', 11:31:15 INFO - 'install', 11:31:15 INFO - 'run-tests'), 11:31:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:15 INFO - 'download_minidump_stackwalk': True, 11:31:15 INFO - 'download_symbols': 'ondemand', 11:31:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:31:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:31:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:31:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:31:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:15 INFO - 'installer_path': 'installer.exe', 11:31:15 INFO - 'log_level': 'info', 11:31:15 INFO - 'log_name': 'talos', 11:31:15 INFO - 'log_to_console': True, 11:31:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:15 INFO - 'opt_config_files': (), 11:31:15 INFO - 'pip_index': False, 11:31:15 INFO - 'sps_profile': False, 11:31:15 INFO - 'sps_profile_interval': 0, 11:31:15 INFO - 'suite': 'dromaeojs', 11:31:15 INFO - 'system_bits': '32', 11:31:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:15 INFO - 'title': 'talos-linux64-ix-069', 11:31:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:15 INFO - 'use_talos_json': True, 11:31:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:15 INFO - 'work_dir': 'build'} 11:31:15 INFO - [mozharness: 2016-08-19 18:31:15.408383Z] Running clobber step. 11:31:15 INFO - Running pre-action listener: _resource_record_pre_action 11:31:15 INFO - Running main action method: clobber 11:31:15 INFO - rmtree: /builds/slave/test/build 11:31:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:15 INFO - Running post-action listener: _resource_record_post_action 11:31:15 INFO - [mozharness: 2016-08-19 18:31:15.862145Z] Finished clobber step (success) 11:31:15 INFO - [mozharness: 2016-08-19 18:31:15.862244Z] Running read-buildbot-config step. 11:31:15 INFO - Running pre-action listener: _resource_record_pre_action 11:31:15 INFO - Running main action method: read_buildbot_config 11:31:15 INFO - Using buildbot properties: 11:31:15 INFO - { 11:31:15 INFO - "project": "", 11:31:15 INFO - "product": "firefox", 11:31:15 INFO - "script_repo_revision": "production", 11:31:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:31:15 INFO - "repository": "", 11:31:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:31:15 INFO - "buildid": "20160819083003", 11:31:15 INFO - "pgo_build": "True", 11:31:15 INFO - "basedir": "/builds/slave/test", 11:31:15 INFO - "buildnumber": 375, 11:31:15 INFO - "slavename": "talos-linux64-ix-069", 11:31:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:31:15 INFO - "platform": "ubuntu64_hw", 11:31:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:31:15 INFO - "branch": "fx-team", 11:31:15 INFO - "repo_path": "integration/fx-team", 11:31:15 INFO - "revision": "4d92551f854b80764c7b010c76043920c28c8e35", 11:31:15 INFO - "stage_platform": "linux64-pgo", 11:31:15 INFO - "builduid": "00dff21203fd4916b1a3fc6b592d3862", 11:31:15 INFO - "slavebuilddir": "test" 11:31:15 INFO - } 11:31:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:31:15 INFO - Running post-action listener: _resource_record_post_action 11:31:15 INFO - [mozharness: 2016-08-19 18:31:15.864661Z] Finished read-buildbot-config step (success) 11:31:15 INFO - [mozharness: 2016-08-19 18:31:15.864748Z] Running download-and-extract step. 11:31:15 INFO - Running pre-action listener: _resource_record_pre_action 11:31:15 INFO - Running main action method: download_and_extract 11:31:15 INFO - mkdir: /builds/slave/test/build/tests 11:31: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')]} 11:31:15 INFO - trying https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:15 INFO - Downloading https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:31:16 INFO - Downloaded 1361 bytes. 11:31:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:16 INFO - Using the following test package requirements: 11:31:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:31:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:31:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'jsshell-linux-x86_64.zip'], 11:31:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:31:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:31:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:31:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:31:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:31:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:16 INFO - trying https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:16 INFO - Downloading https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:31:17 INFO - Downloaded 21918714 bytes. 11:31:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:31:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:21 INFO - trying https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:21 INFO - Downloading https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:31:22 INFO - Downloaded 21918714 bytes. 11:31:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:31: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')]} 11:31:27 INFO - trying https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:27 INFO - Downloading https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:31:28 INFO - Downloaded 14413981 bytes. 11:31:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:28 INFO - trying https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:28 INFO - Downloading https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:31:29 INFO - Downloaded 59652886 bytes. 11:31:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:29 INFO - mkdir: /builds/slave/test/properties 11:31:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:29 INFO - Contents: 11:31:29 INFO - build_url:https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:30 INFO - Running post-action listener: _resource_record_post_action 11:31:30 INFO - Running post-action listener: set_extra_try_arguments 11:31:30 INFO - [mozharness: 2016-08-19 18:31:30.425933Z] Finished download-and-extract step (success) 11:31:30 INFO - [mozharness: 2016-08-19 18:31:30.426156Z] Running populate-webroot step. 11:31:30 INFO - Running pre-action listener: _resource_record_pre_action 11:31:30 INFO - Running main action method: populate_webroot 11:31:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:31:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:31:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:31:30 INFO - '--tppagecycles', 11:31:30 INFO - '7'], 11:31:30 INFO - 'tests': ['tsvgm']}}, 11:31:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:31:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:31:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['damp', 'tps']}, 11:31:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'tests': ['damp', 'tps']}, 11:31:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['dromaeo_dom']}, 11:31:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['basic_compositor_video']}, 11:31:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:31:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['a11yr', 11:31:30 INFO - 'ts_paint', 11:31:30 INFO - 'tpaint', 11:31:30 INFO - 'sessionrestore', 11:31:30 INFO - 'sessionrestore_no_auto_restore', 11:31:30 INFO - 'tabpaint']}, 11:31:30 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:30 INFO - 'ts_paint', 11:31:30 INFO - 'tpaint', 11:31:30 INFO - 'sessionrestore', 11:31:30 INFO - 'sessionrestore_no_auto_restore', 11:31:30 INFO - 'tabpaint']}, 11:31:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:31:30 INFO - 'ts_paint', 11:31:30 INFO - 'tpaint', 11:31:30 INFO - 'sessionrestore', 11:31:30 INFO - 'sessionrestore_no_auto_restore', 11:31:30 INFO - 'tabpaint']}, 11:31:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:31:30 INFO - 'ts_paint', 11:31:30 INFO - 'tpaint', 11:31:30 INFO - 'sessionrestore', 11:31:30 INFO - 'sessionrestore_no_auto_restore', 11:31:30 INFO - 'tabpaint']}, 11:31:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['a11yr', 11:31:30 INFO - 'ts_paint', 11:31:30 INFO - 'tpaint', 11:31:30 INFO - 'sessionrestore', 11:31:30 INFO - 'sessionrestore_no_auto_restore', 11:31:30 INFO - 'tabpaint']}, 11:31:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['a11yr', 11:31:30 INFO - 'ts_paint', 11:31:30 INFO - 'tpaint', 11:31:30 INFO - 'sessionrestore', 11:31:30 INFO - 'sessionrestore_no_auto_restore', 11:31:30 INFO - 'tabpaint']}, 11:31:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['tsvgx', 11:31:30 INFO - 'tsvgr_opacity', 11:31:30 INFO - 'tart', 11:31:30 INFO - 'tscrollx', 11:31:30 INFO - 'cart']}, 11:31:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:30 INFO - 'tsvgr_opacity', 11:31:30 INFO - 'tart', 11:31:30 INFO - 'tscrollx', 11:31:30 INFO - 'cart']}, 11:31:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'talos_options': ['--disable-e10s'], 11:31:30 INFO - 'tests': ['tp5o']}, 11:31:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'tests': ['tp5o']}, 11:31:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'talos_options': ['--disable-e10s', 11:31:30 INFO - '--xperf_path', 11:31:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:30 INFO - 'tests': ['tp5n']}, 11:31:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:30 INFO - 'talos_options': ['--xperf_path', 11:31:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:30 INFO - 'tests': ['tp5n']}}, 11:31:30 INFO - 'talos.zip': {'path': '', 11:31:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:31:30 INFO - Running post-action listener: _resource_record_post_action 11:31:30 INFO - [mozharness: 2016-08-19 18:31:30.442656Z] Finished populate-webroot step (success) 11:31:30 INFO - [mozharness: 2016-08-19 18:31:30.442743Z] Running create-virtualenv step. 11:31:30 INFO - Running pre-action listener: _resource_record_pre_action 11:31:30 INFO - Running main action method: create_virtualenv 11:31:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:31:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:31:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:30 INFO - Using real prefix '/usr' 11:31:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:31 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:33 INFO - Installing pip.................done. 11:31:33 INFO - Return code: 0 11:31:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:33 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:31:33 INFO - Using env: {'DISPLAY': ':0', 11:31:33 INFO - 'HOME': '/home/cltbld', 11:31:33 INFO - 'LANG': 'en_US.UTF-8', 11:31:33 INFO - 'LANGUAGE': 'en_US:en', 11:31:33 INFO - 'LOGNAME': 'cltbld', 11:31:33 INFO - 'MAIL': '/var/mail/cltbld', 11:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:33 INFO - 'MOZ_NO_REMOTE': '1', 11:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:33 INFO - 'NO_EM_RESTART': '1', 11:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:33 INFO - 'PWD': '/builds/slave/test', 11:31:33 INFO - 'SHELL': '/bin/bash', 11:31:33 INFO - 'SHLVL': '1', 11:31:33 INFO - 'TERM': 'linux', 11:31:33 INFO - 'TMOUT': '86400', 11:31:33 INFO - 'USER': 'cltbld', 11:31:33 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:33 INFO - '_': '/tools/buildbot/bin/python'} 11:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:31:33 INFO - Cleaning up... 11:31:33 INFO - Return code: 0 11:31:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:33 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:31:33 INFO - Using env: {'DISPLAY': ':0', 11:31:33 INFO - 'HOME': '/home/cltbld', 11:31:33 INFO - 'LANG': 'en_US.UTF-8', 11:31:33 INFO - 'LANGUAGE': 'en_US:en', 11:31:33 INFO - 'LOGNAME': 'cltbld', 11:31:33 INFO - 'MAIL': '/var/mail/cltbld', 11:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:33 INFO - 'MOZ_NO_REMOTE': '1', 11:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:33 INFO - 'NO_EM_RESTART': '1', 11:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:33 INFO - 'PWD': '/builds/slave/test', 11:31:33 INFO - 'SHELL': '/bin/bash', 11:31:33 INFO - 'SHLVL': '1', 11:31:33 INFO - 'TERM': 'linux', 11:31:33 INFO - 'TMOUT': '86400', 11:31:33 INFO - 'USER': 'cltbld', 11:31:33 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:33 INFO - '_': '/tools/buildbot/bin/python'} 11:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:33 INFO - Downloading/unpacking psutil>=3.1.1 11:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:35 INFO - Installing collected packages: psutil 11:31:35 INFO - Running setup.py install for psutil 11:31:35 INFO - building 'psutil._psutil_linux' extension 11:31:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:31:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:31:35 INFO - building 'psutil._psutil_posix' extension 11:31:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:31:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:31:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:35 INFO - Successfully installed psutil 11:31:35 INFO - Cleaning up... 11:31:35 INFO - Return code: 0 11:31:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:35 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:31:35 INFO - Using env: {'DISPLAY': ':0', 11:31:35 INFO - 'HOME': '/home/cltbld', 11:31:35 INFO - 'LANG': 'en_US.UTF-8', 11:31:35 INFO - 'LANGUAGE': 'en_US:en', 11:31:35 INFO - 'LOGNAME': 'cltbld', 11:31:35 INFO - 'MAIL': '/var/mail/cltbld', 11:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:35 INFO - 'MOZ_NO_REMOTE': '1', 11:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:35 INFO - 'NO_EM_RESTART': '1', 11:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:35 INFO - 'PWD': '/builds/slave/test', 11:31:35 INFO - 'SHELL': '/bin/bash', 11:31:35 INFO - 'SHLVL': '1', 11:31:35 INFO - 'TERM': 'linux', 11:31:35 INFO - 'TMOUT': '86400', 11:31:35 INFO - 'USER': 'cltbld', 11:31:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:35 INFO - '_': '/tools/buildbot/bin/python'} 11:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:31:38 INFO - Installing collected packages: mozsystemmonitor 11:31:38 INFO - Running setup.py install for mozsystemmonitor 11:31:38 INFO - Successfully installed mozsystemmonitor 11:31:38 INFO - Cleaning up... 11:31:38 INFO - Return code: 0 11:31:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:38 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:31:38 INFO - Using env: {'DISPLAY': ':0', 11:31:38 INFO - 'HOME': '/home/cltbld', 11:31:38 INFO - 'LANG': 'en_US.UTF-8', 11:31:38 INFO - 'LANGUAGE': 'en_US:en', 11:31:38 INFO - 'LOGNAME': 'cltbld', 11:31:38 INFO - 'MAIL': '/var/mail/cltbld', 11:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:38 INFO - 'MOZ_NO_REMOTE': '1', 11:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:38 INFO - 'NO_EM_RESTART': '1', 11:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:38 INFO - 'PWD': '/builds/slave/test', 11:31:38 INFO - 'SHELL': '/bin/bash', 11:31:38 INFO - 'SHLVL': '1', 11:31:38 INFO - 'TERM': 'linux', 11:31:38 INFO - 'TMOUT': '86400', 11:31:38 INFO - 'USER': 'cltbld', 11:31:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:38 INFO - '_': '/tools/buildbot/bin/python'} 11:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:38 INFO - Downloading/unpacking jsonschema==2.5.1 11:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:40 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:40 INFO - warning: no files found matching '*.txt' 11:31:40 INFO - no previously-included directories found matching 'build' 11:31:40 INFO - no previously-included directories found matching 'dist' 11:31:40 INFO - no previously-included directories found matching '.git*' 11:31:40 INFO - Installing collected packages: jsonschema, functools32 11:31:40 INFO - Running setup.py install for functools32 11:31:40 INFO - warning: no files found matching '*.txt' 11:31:40 INFO - no previously-included directories found matching 'build' 11:31:40 INFO - no previously-included directories found matching 'dist' 11:31:40 INFO - no previously-included directories found matching '.git*' 11:31:40 INFO - Successfully installed jsonschema functools32 11:31:40 INFO - Cleaning up... 11:31:40 INFO - Return code: 0 11:31:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:40 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:31:40 INFO - Using env: {'DISPLAY': ':0', 11:31:40 INFO - 'HOME': '/home/cltbld', 11:31:40 INFO - 'LANG': 'en_US.UTF-8', 11:31:40 INFO - 'LANGUAGE': 'en_US:en', 11:31:40 INFO - 'LOGNAME': 'cltbld', 11:31:40 INFO - 'MAIL': '/var/mail/cltbld', 11:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:40 INFO - 'MOZ_NO_REMOTE': '1', 11:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:40 INFO - 'NO_EM_RESTART': '1', 11:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:40 INFO - 'PWD': '/builds/slave/test', 11:31:40 INFO - 'SHELL': '/bin/bash', 11:31:40 INFO - 'SHLVL': '1', 11:31:40 INFO - 'TERM': 'linux', 11:31:40 INFO - 'TMOUT': '86400', 11:31:40 INFO - 'USER': 'cltbld', 11:31:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:40 INFO - '_': '/tools/buildbot/bin/python'} 11:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:31:41 INFO - Cleaning up... 11:31:41 INFO - Return code: 0 11:31:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:41 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:31:41 INFO - Using env: {'DISPLAY': ':0', 11:31:41 INFO - 'HOME': '/home/cltbld', 11:31:41 INFO - 'LANG': 'en_US.UTF-8', 11:31:41 INFO - 'LANGUAGE': 'en_US:en', 11:31:41 INFO - 'LOGNAME': 'cltbld', 11:31:41 INFO - 'MAIL': '/var/mail/cltbld', 11:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:41 INFO - 'MOZ_NO_REMOTE': '1', 11:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:41 INFO - 'NO_EM_RESTART': '1', 11:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:41 INFO - 'PWD': '/builds/slave/test', 11:31:41 INFO - 'SHELL': '/bin/bash', 11:31:41 INFO - 'SHLVL': '1', 11:31:41 INFO - 'TERM': 'linux', 11:31:41 INFO - 'TMOUT': '86400', 11:31:41 INFO - 'USER': 'cltbld', 11:31:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:41 INFO - '_': '/tools/buildbot/bin/python'} 11:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:41 INFO - Downloading/unpacking blobuploader==1.2.4 11:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - Downloading docopt-0.6.1.tar.gz 11:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:43 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:43 INFO - Running setup.py install for blobuploader 11:31:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:44 INFO - Running setup.py install for requests 11:31:44 INFO - Running setup.py install for docopt 11:31:44 INFO - Successfully installed blobuploader requests docopt 11:31:44 INFO - Cleaning up... 11:31:44 INFO - Return code: 0 11:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:44 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:44 INFO - Using env: {'DISPLAY': ':0', 11:31:44 INFO - 'HOME': '/home/cltbld', 11:31:44 INFO - 'LANG': 'en_US.UTF-8', 11:31:44 INFO - 'LANGUAGE': 'en_US:en', 11:31:44 INFO - 'LOGNAME': 'cltbld', 11:31:44 INFO - 'MAIL': '/var/mail/cltbld', 11:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:44 INFO - 'MOZ_NO_REMOTE': '1', 11:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:44 INFO - 'NO_EM_RESTART': '1', 11:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:44 INFO - 'PWD': '/builds/slave/test', 11:31:44 INFO - 'SHELL': '/bin/bash', 11:31:44 INFO - 'SHLVL': '1', 11:31:44 INFO - 'TERM': 'linux', 11:31:44 INFO - 'TMOUT': '86400', 11:31:44 INFO - 'USER': 'cltbld', 11:31:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:44 INFO - '_': '/tools/buildbot/bin/python'} 11:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:44 INFO - Running setup.py (path:/tmp/pip-m4DXpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:44 INFO - Running setup.py (path:/tmp/pip-g8EN1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:44 INFO - Running setup.py (path:/tmp/pip-gUJSXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:44 INFO - Running setup.py (path:/tmp/pip-156iBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:45 INFO - Running setup.py (path:/tmp/pip-xqMMWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:45 INFO - Running setup.py (path:/tmp/pip-xuqpQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:45 INFO - Running setup.py (path:/tmp/pip-Dkcd6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:45 INFO - Running setup.py (path:/tmp/pip-PdBdan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:45 INFO - Running setup.py (path:/tmp/pip-jxSeht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:45 INFO - Running setup.py (path:/tmp/pip-a_DrZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:45 INFO - Running setup.py (path:/tmp/pip-gAfzmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:45 INFO - Running setup.py (path:/tmp/pip-G7wS7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:45 INFO - Running setup.py (path:/tmp/pip-keAGwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:45 INFO - Running setup.py (path:/tmp/pip-D8z8GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:45 INFO - Running setup.py (path:/tmp/pip-p9kWDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:45 INFO - Running setup.py (path:/tmp/pip-0GQPQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:45 INFO - Running setup.py (path:/tmp/pip-EH5Dz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:45 INFO - Running setup.py install for manifestparser 11:31:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozcrash 11:31:46 INFO - Running setup.py install for mozdebug 11:31:46 INFO - Running setup.py install for mozdevice 11:31:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozfile 11:31:46 INFO - Running setup.py install for mozhttpd 11:31:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozinfo 11:31:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozInstall 11:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozleak 11:31:46 INFO - Running setup.py install for mozlog 11:31:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for moznetwork 11:31:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for mozprocess 11:31:47 INFO - Running setup.py install for mozprofile 11:31:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for mozrunner 11:31:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for mozscreenshot 11:31:47 INFO - Running setup.py install for moztest 11:31:47 INFO - Running setup.py install for mozversion 11:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:47 INFO - Cleaning up... 11:31:47 INFO - Return code: 0 11:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:47 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:47 INFO - Using env: {'DISPLAY': ':0', 11:31:47 INFO - 'HOME': '/home/cltbld', 11:31:47 INFO - 'LANG': 'en_US.UTF-8', 11:31:47 INFO - 'LANGUAGE': 'en_US:en', 11:31:47 INFO - 'LOGNAME': 'cltbld', 11:31:47 INFO - 'MAIL': '/var/mail/cltbld', 11:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:47 INFO - 'MOZ_NO_REMOTE': '1', 11:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:47 INFO - 'NO_EM_RESTART': '1', 11:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:47 INFO - 'PWD': '/builds/slave/test', 11:31:47 INFO - 'SHELL': '/bin/bash', 11:31:47 INFO - 'SHLVL': '1', 11:31:47 INFO - 'TERM': 'linux', 11:31:47 INFO - 'TMOUT': '86400', 11:31:47 INFO - 'USER': 'cltbld', 11:31:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:47 INFO - '_': '/tools/buildbot/bin/python'} 11:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:47 INFO - Running setup.py (path:/tmp/pip-rO1Mfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:48 INFO - Running setup.py (path:/tmp/pip-4hDZji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:48 INFO - Running setup.py (path:/tmp/pip-3gWPPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:48 INFO - Running setup.py (path:/tmp/pip-yc2sWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:48 INFO - Running setup.py (path:/tmp/pip-MNcqFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:48 INFO - Running setup.py (path:/tmp/pip-5rGl1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:48 INFO - Running setup.py (path:/tmp/pip-DZGNyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:48 INFO - Running setup.py (path:/tmp/pip-ZshYTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:48 INFO - Running setup.py (path:/tmp/pip-VYbO13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:48 INFO - Running setup.py (path:/tmp/pip-aYx6Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:48 INFO - Running setup.py (path:/tmp/pip-EmLDEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:48 INFO - Running setup.py (path:/tmp/pip-8rYfoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:48 INFO - Running setup.py (path:/tmp/pip-2qGJlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:48 INFO - Running setup.py (path:/tmp/pip-UjthEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:48 INFO - Running setup.py (path:/tmp/pip-KaqgGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:49 INFO - Running setup.py (path:/tmp/pip-2tXHIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:49 INFO - Running setup.py (path:/tmp/pip-nzlO94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:51 INFO - Downloading blessings-1.6.tar.gz 11:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:31:51 INFO - Installing collected packages: blessings 11:31:51 INFO - Running setup.py install for blessings 11:31:51 INFO - Successfully installed blessings 11:31:51 INFO - Cleaning up... 11:31:51 INFO - Return code: 0 11:31:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:51 INFO - Reading from file tmpfile_stdout 11:31:51 INFO - Current package versions: 11:31:51 INFO - argparse == 1.2.1 11:31:51 INFO - blessings == 1.6 11:31:51 INFO - blobuploader == 1.2.4 11:31:51 INFO - docopt == 0.6.1 11:31:51 INFO - functools32 == 3.2.3-2 11:31:51 INFO - jsonschema == 2.5.1 11:31:51 INFO - manifestparser == 1.1 11:31:51 INFO - mozInstall == 1.12 11:31:51 INFO - mozcrash == 0.17 11:31:51 INFO - mozdebug == 0.1 11:31:51 INFO - mozdevice == 0.48 11:31:51 INFO - mozfile == 1.2 11:31:51 INFO - mozhttpd == 0.7 11:31:51 INFO - mozinfo == 0.9 11:31:51 INFO - mozleak == 0.1 11:31:51 INFO - mozlog == 3.3 11:31:51 INFO - moznetwork == 0.27 11:31:51 INFO - mozprocess == 0.23 11:31:51 INFO - mozprofile == 0.28 11:31:51 INFO - mozrunner == 6.12 11:31:51 INFO - mozscreenshot == 0.1 11:31:51 INFO - mozsystemmonitor == 0.3 11:31:51 INFO - moztest == 0.7 11:31:51 INFO - mozversion == 1.4 11:31:51 INFO - psutil == 3.1.1 11:31:51 INFO - requests == 1.2.3 11:31:51 INFO - wsgiref == 0.1.2 11:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:51 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:51 INFO - Using env: {'DISPLAY': ':0', 11:31:51 INFO - 'HOME': '/home/cltbld', 11:31:51 INFO - 'LANG': 'en_US.UTF-8', 11:31:51 INFO - 'LANGUAGE': 'en_US:en', 11:31:51 INFO - 'LOGNAME': 'cltbld', 11:31:51 INFO - 'MAIL': '/var/mail/cltbld', 11:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:51 INFO - 'MOZ_NO_REMOTE': '1', 11:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:51 INFO - 'NO_EM_RESTART': '1', 11:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:51 INFO - 'PWD': '/builds/slave/test', 11:31:51 INFO - 'SHELL': '/bin/bash', 11:31:51 INFO - 'SHLVL': '1', 11:31:51 INFO - 'TERM': 'linux', 11:31:51 INFO - 'TMOUT': '86400', 11:31:51 INFO - 'USER': 'cltbld', 11:31:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:51 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:31:51 INFO - Cleaning up... 11:31:51 INFO - Return code: 0 11:31:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:51 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 0x7f6e4bd65f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:31:51 INFO - Using env: {'DISPLAY': ':0', 11:31:51 INFO - 'HOME': '/home/cltbld', 11:31:51 INFO - 'LANG': 'en_US.UTF-8', 11:31:51 INFO - 'LANGUAGE': 'en_US:en', 11:31:51 INFO - 'LOGNAME': 'cltbld', 11:31:51 INFO - 'MAIL': '/var/mail/cltbld', 11:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:51 INFO - 'MOZ_NO_REMOTE': '1', 11:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:51 INFO - 'NO_EM_RESTART': '1', 11:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:51 INFO - 'PWD': '/builds/slave/test', 11:31:51 INFO - 'SHELL': '/bin/bash', 11:31:51 INFO - 'SHLVL': '1', 11:31:51 INFO - 'TERM': 'linux', 11:31:51 INFO - 'TMOUT': '86400', 11:31:51 INFO - 'USER': 'cltbld', 11:31:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:51 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:31:51 INFO - Cleaning up... 11:31:52 INFO - Return code: 0 11:31:52 INFO - Running post-action listener: _resource_record_post_action 11:31:52 INFO - Running post-action listener: _start_resource_monitoring 11:31:52 INFO - Starting resource monitoring. 11:31:52 INFO - [mozharness: 2016-08-19 18:31:52.026256Z] Finished create-virtualenv step (success) 11:31:52 INFO - [mozharness: 2016-08-19 18:31:52.026754Z] Running install step. 11:31:52 INFO - Running pre-action listener: _resource_record_pre_action 11:31:52 INFO - Running main action method: install 11:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:52 INFO - Reading from file tmpfile_stdout 11:31:52 INFO - Detecting whether we're running mozinstall >=1.0... 11:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:31:52 INFO - Reading from file tmpfile_stdout 11:31:52 INFO - Output received: 11:31:52 INFO - Usage: mozinstall [options] installer 11:31:52 INFO - Options: 11:31:52 INFO - -h, --help show this help message and exit 11:31:52 INFO - -d DEST, --destination=DEST 11:31:52 INFO - Directory to install application into. [default: 11:31:52 INFO - "/builds/slave/test"] 11:31:52 INFO - --app=APP Application being installed. [default: firefox] 11:31:52 INFO - mkdir: /builds/slave/test/build/application 11:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:32:09 INFO - Reading from file tmpfile_stdout 11:32:09 INFO - Output received: 11:32:09 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:09 INFO - Running post-action listener: _resource_record_post_action 11:32:09 INFO - [mozharness: 2016-08-19 18:32:09.293631Z] Finished install step (success) 11:32:09 INFO - [mozharness: 2016-08-19 18:32:09.293878Z] Running run-tests step. 11:32:09 INFO - Running pre-action listener: _resource_record_pre_action 11:32:09 INFO - Running main action method: run_tests 11:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:09 INFO - Python 2.7.3 11:32:09 INFO - Return code: 0 11:32:09 INFO - grabbing minidump binary from tooltool 11:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:09 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 0x220f370>, '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 0x22128f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2212d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:32:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:32:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:32:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:09 INFO - Return code: 0 11:32:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:32:09 INFO - Using env: {'DISPLAY': ':0', 11:32:09 INFO - 'HOME': '/home/cltbld', 11:32:09 INFO - 'LANG': 'en_US.UTF-8', 11:32:09 INFO - 'LANGUAGE': 'en_US:en', 11:32:09 INFO - 'LOGNAME': 'cltbld', 11:32:09 INFO - 'MAIL': '/var/mail/cltbld', 11:32:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:09 INFO - 'MOZ_NO_REMOTE': '1', 11:32:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:09 INFO - 'NO_EM_RESTART': '1', 11:32:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:09 INFO - 'PWD': '/builds/slave/test', 11:32:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:09 INFO - 'SHELL': '/bin/bash', 11:32:09 INFO - 'SHLVL': '1', 11:32:09 INFO - 'TERM': 'linux', 11:32:09 INFO - 'TMOUT': '86400', 11:32:09 INFO - 'USER': 'cltbld', 11:32:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034', 11:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:09 INFO - '_': '/tools/buildbot/bin/python'} 11:32:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:32:09 INFO - mozversion application_buildid: 20160819083003 11:32:09 INFO - mozversion application_changeset: 4d92551f854b80764c7b010c76043920c28c8e35 11:32:09 INFO - mozversion application_display_name: Nightly 11:32:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:09 INFO - mozversion application_name: Firefox 11:32:09 INFO - mozversion application_remotingname: firefox 11:32:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:32:09 INFO - mozversion application_vendor: Mozilla 11:32:09 INFO - mozversion application_version: 51.0a1 11:32:09 INFO - mozversion platform_buildid: 20160819083003 11:32:09 INFO - mozversion platform_changeset: 4d92551f854b80764c7b010c76043920c28c8e35 11:32:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:32:09 INFO - mozversion platform_version: 51.0a1 11:32:09 INFO - using testdate: 1471631529 11:32:09 INFO - actual date: 1471631529 11:32:09 INFO - starting webserver on 'localhost:53008' 11:32:09 INFO - SUITE-START | Running 2 tests 11:32:09 INFO - TEST-START | dromaeo_css 11:32:09 INFO - operating with platform_type : linux_ 11:32:09 INFO - Initialising browser for dromaeo_css test... 11:32:09 INFO - TEST-INFO | started process 18794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv802Kg/profile http://localhost:53008/getInfo.html) 11:32:13 INFO - PROCESS | 18794 | __metrics Screen width/height:1600/1200 11:32:13 INFO - PROCESS | 18794 | colorDepth:24 11:32:13 INFO - PROCESS | 18794 | Browser inner width/height: 1024/697 11:32:13 INFO - PROCESS | 18794 | __metrics 11:32:14 INFO - PROCESS | 18794 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:32:14 INFO - PROCESS | 18794 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:14 INFO - PROCESS | 18794 | console.error: PushService: 11:32:14 INFO - PROCESS | 18794 | stateChangeProcessEnqueue: Error transitioning state 11:32:14 INFO - PROCESS | 18794 | UnknownError 11:32:15 INFO - TEST-INFO | 18794: exit 0 11:32:15 INFO - Browser initialized. 11:32:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:15 INFO - TEST-INFO | started process 18877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv802Kg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:27 INFO - PROCESS | 18877 | RSS: Main: 155258880 11:32:27 INFO - PROCESS | 18877 | 11:33:18 INFO - PROCESS | 18877 | 1471631598783 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:35:27 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:53008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53008/tests/dromaeo/cssquery-ext.html) 11:35:28 INFO - PROCESS | 18877 | RSS: Main: 248926208 11:35:28 INFO - PROCESS | 18877 | 11:38:31 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:53008/tests/dromaeo/cssquery-ext.html (next: http://localhost:53008/tests/dromaeo/cssquery-jquery.html) 11:38:31 INFO - PROCESS | 18877 | RSS: Main: 244781056 11:38:31 INFO - PROCESS | 18877 | 11:41:33 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:53008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53008/tests/dromaeo/cssquery-mootools.html) 11:41:34 INFO - PROCESS | 18877 | RSS: Main: 188108800 11:41:34 INFO - PROCESS | 18877 | 11:44:36 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:53008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53008/tests/dromaeo/cssquery-prototype.html) 11:44:36 INFO - PROCESS | 18877 | RSS: Main: 228597760 11:44:36 INFO - PROCESS | 18877 | 11:47:39 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:53008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53008/tests/dromaeo/cssquery-yui.html) 11:47:40 INFO - PROCESS | 18877 | RSS: Main: 186859520 11:47:40 INFO - PROCESS | 18877 | 11:50:42 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:53008/tests/dromaeo/cssquery-yui.html (next: http://localhost:53008/tests/dromaeo/cssquery-dojo.html) 11:50:43 INFO - PROCESS | 18877 | RSS: Main: 313761792 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | __start_tp_report 11:50:43 INFO - PROCESS | 18877 | _x_x_mozilla_page_load 11:50:43 INFO - PROCESS | 18877 | _x_x_mozilla_page_load_details 11:50:43 INFO - PROCESS | 18877 | |i|pagename|runs| 11:50:43 INFO - PROCESS | 18877 | |0;dojo.html;3013.246688327918;3018.471767440699;3027.0918724382686;3055.694430556946;3077.907662770118;5145.125328694122;5246.606504512162;5270.604704647148;5297.788088476461;5307.20391941209;5264.447233040523;5314.335708036496;5328.120860058096;5344.22508736233;5363.302770639812;4816.662833601649;4874.171390863544;4878;4921.680090794105;4951.826686065989;4938.2098864181735;4966.627502937276;4975.029869175512;4975.7263350515705;4979.502049795028;4722.268048452495;4788.592969597554;4808.326834243174;4850.733209673466;4851.466338702758;4773.5226477352335;4774.976125119387;4784.928226076611;4829.661923665345;4834.830780922651;4786.401699787527;4803.253462299412;4837.274408838667;4841.152798260326;4869.756512174377;5092.6180536459915;5151.330327057496;5352.625316227865;5354.571634269288;5357.544608708265;5550.805721799758;5626.043572592628;5633.943660563424;5641.294838145232;5642.351129620105;5581.49766521015;5638.210650508932;5650.265465489501;5650.265465489501;5660.915086273709;5165;5219.373675159005;5272.578193744491;5273.31446911899;5291.3121294231505;5839.2992840858515;5854.385289544622;5862.648241105548;5868.383819698955;5872.442117998783;5604.495595396434;5616.241807356037;5621.8594535136945;5622.522085622768;5625.774969001194;5479;5552.222688823568;5681.431856814368;5683.090705487185;5686.829395118153;5604.187392828098;5675.4324567543745;5676.347220069745;5681.460261275172;5690.231818704422;5634.1830434586755;5634.464725851038;5652.9152062719095;5656.91514627281;5680.0627896397455;4298.484181898192;4339.7613131278085;4404.427424434803;4420.557944205554;4458.08609235106;3880.4761357216416;3935.842566297316;3937.5078115235597;3959.0498280412494;3985.3224951757693;5398.73006349681;5407.053765591006;5408.269883565668;5409.756560954766;5414.10667239901;5493.725313734377;5560.972195138998;5688.232088667977;5690.630109042899;5691.800786972436;5352.759125839347;5399.190121481731;5410;5417.241586177938;5426.945730542644;4928.728919909439;4936.259561065797;4936.679115857458;4937.086638971802;4941.085899108676;5659.943400566024;5780.94219057804;5903.144044113579;5903.58674892762;5907.3797251288;5642.294713160855;5694.629849059798;5703.08750599902;5705.857353566194;5708;5891.558133140117;5898.764049437975;5900.675462849585;5904.586678932434;5915.556333274935;5316.734163291742;5423.864403389789;5593.748281327432;5601.103823388238;5602.075657516464;5559.610827242216;5634.4365563443325;5637.8590535236945;5640.210370548045;5640.492355688008;5452.809151679672;5466.316710411199;5494.395616482104;5497.890042199054;5502.284702988746;5339.252504649275;5452.345718513804;5490.1764735288425;5495.6153069284765;5496.395396506461;5409.161579955114;5509.47659972302;5513.779448822002;5517.751701173376;5521.2270282159725;5549.750261238173;5560.443955604569;5566.192902029102;5569.888602228014;5580.693061881636;5390.51485366319;5448.536874365724;5458.61789674719;5463.153211252262;5470.671759694431 11:50:43 INFO - PROCESS | 18877 | |1;ext.html;569.9886002279954;585.8798946216026;594.0287629725399;600.9098635204722;614.5575185866178;44077.77961110194;44843.32735008978;44937.550624493786;45262.773686131564;48036.51963480364;46104.76947615266;46569.7671511642;46585.30122048172;46590.06819863601;46630.300545491846;8968.910310896872;8982.505962172077;8992.595333209989;9061.728148155566;9086.454812711225;8891.555422228863;8951.641934322619;8968.865467017968;8976.596053177622;8978.910210897873;8969.461832290084;9009.864852027225;9097.590608422637;9103.95448022759;9109.817803643924;9028.097190280985;9041.367104302668;9052.864207036866;9076.273898088137;9082.13719696631;8965.506897120657;9024.187823095886;9041.276697864156;9043.412178208395;9047.095290470901;42999.57000429987;43103.13793724108;43318;43366.56633433689;43378.783106084265;3647.4528820676846;3746.925061498755;4187.5184353799095;4255.064005835963;4303.548127446605;33132.503012454836;33164.50253246203;33325.16687082818;33402.49896251534;34873;4362.214801335758;4427.092446048585;4440.555944405566;4493.326001099861;4602.907941841145;354042;355070;355110.22444887867;355423;355900;58402;58949.41050589525;58989;58993;59059.40940590625;36511;36996.26007479835;62538.68730656317;62671.373286267466;62677.373226267155;15016.174110424032;15124.470643527424;15131.773023404658;15134.545963621109;15140.924295378452;12022;12129.090318226168;12143.878561214451;12145.14983951115;12145.514179432723;19497.972485508813;19516.3351705407;19562.141596548307;19566.758881043577;19567.608647826964;7351.558906465629;7356.301151390609;7356.372375133027;7513.2111128331835;7578.658960346797;936.9765755856022;974.9366291191192;1018.6129270877168;1047.9318844275099;1085.8696956365286;32375;32703.836480817445;32816.50775238373;32869;33092.503612445835;1052.5631862777016;1079.2607064161075;1096.2983690438125;1128.7178205448638;1187.0800129899396;16131.481398776275;16975;17138.40015599448;17296.654066918592;17385;611606;617032;617684;618760;621608;60488.697556511936;60570.394296057355;61020.38979610147;61095.38904610897;61202.69398652978;1215.4105258949403;1299.9220046797222;1322.1141834970592;1328.0968941120132;1332.7467781121557;31267.84366078246;33309.33381332408;34378;34448.31103377968;34635;52074.47925520696;56460.71769641126;58336.4166358331;58433.4156658428;63833.3616663846;538666;546335;546487;547115;547750;37002.814985924895;42613.57386426096;43039.56960430356;43905.56094439015;45703.77148114238;48844.75577622089;49397.75301123615;49482;49516.75241623769;49756.253656194465;41203.025561294045;41962.580374195866;42794.35808462938;43949.12101758011;44462;42194.78902605467;42403.363949540166;42461.363079553215;42636.360454592585;44555.331670025625;42443.787781062136;42800.78599606982;43009.784951075046;43132.137357253305;43406.56593434025;36070.27859442849;37228.83554897864;37949.430758539194;38054.619453805106;38794.418083728204;28248.71751282543;28313;28586.85706571454;28876.27809304784;28983.420331592828 11:50:43 INFO - PROCESS | 18877 | |2;jquery.html;357.9588347340055;367.1500476397139;379.30397720183464;385.27760449157836;401.92966230909605;18397.902593508552;20237.494062648442;20381.694274585894;20651;20774.610919744235;17174.055426951512;17317.480475585722;17556.209970551325;17584.296628134893;17853.821461785377;5636.689982050985;5695.0887857942635;5904.88190236195;5911.586188966774;5912.704364781765;5699.202111704365;5712.371639119693;5748.568857335696;5755.0504166812425;5784.855378615547;5526.364468086182;5723.570732195081;5723.742431590567;5732.283464566929;5770.105633626795;5689.402612725667;5716.942830571683;5757.280339957526;5758.74085666146;5765.2216950711745;5024.497550244982;5082.415522214956;5115.053715062725;5118.25785261135;5134.589232861362;23741;23955.640665390034;24063.27810165698;24099.87950060256;24149.637755433683;2232.151782322707;2246.48330883896;2257.5033492631596;2271.284545368204;2331.708536432946;14181.645458863508;14820.481283155146;14943;15060.246987650684;15343.846561534354;1904.419152158591;1946.2020571565731;1974.7037944308468;2015.1032790408274;2044.7118315461164;76167.61916190383;76323.6183819083;76672.23327766707;78012;81228.59385703092;9785.755356116011;9799.412035277906;9913.306068575275;10244.772896537566;10409.219308551888;13802.894348771446;13839.446422143;13849.238291894042;13871.306434678427;13880.930595347161;7575.772726818204;7615.657295421719;7833.255840695125;7852.254035866584;7878.330341920886;7389.963050184715;7476.364509016795;7524.473286869976;7681.193474685189;7697.692092316244;6373.776917807854;6451.677416129175;6465.288818229991;6471.126397936312;6660.9000864987065;1755.2276998121042;1804.7924488683707;1808.52074200337;1811.963760724778;1816.554944038719;1015.8984101589782;1043.337480699761;1049.92125590581;1072.447689439939;1081.9134469242442;19716;20385.388438346872;20515.076821543065;20585.89707051455;20620.875824835093;968.5060619084177;985.8373368394278;1002.659095907395;1055.9102476289602;1084.8969347911936;10593.364398136137;11228.438578071064;11435.656930292105;11442.94278528602;11700.29798212093;385313;385398;386446;495527;498861;101565;105665.47167264114;105924.47037764762;106935.46532267444;108642;985.3102828020271;996.1869397696269;1017;1045.5033858916954;1048.1352883870836;17233.91383043127;17745.201465934322;18382.172802223664;18410.631787364444;18474.261029558667;41632.583674162874;42364.576354236066;42759.57240427556;42794.35808462938;42932.570674294104;59974;60196;60685.39314606974;61120.38879611325;62662;8387.32901367877;8390.706325278587;8724.996625387908;8791.208791208823;8816.779580510538;13184.60446186616;13306.667333316744;13340.930446430295;13649.522266720616;13683.179009259477;11566.42167891619;11719;12023.519059237882;12026.939865300617;12067.75864482723;11558.248713833575;11589.594364197214;11789.351585662871;11832.230904991147;12130.75738485243;11964.162508624313;12027.939860300643;12338.409072884433;12563.560275390317;12691.682707932376;8390.61554843444;8444.408891377545;8708.085651006553;8792.252658523841;8821.558922053744;11346.319220846775;11644.184907056764;11672.591459298883;11763.705907352385;11896.464659090534 11:50:43 INFO - PROCESS | 18877 | |3;mootools.html;1369.6849724563356;1456.8834493240543;1502.8422015688352;1614.7820044294017;1747.9388221412253;8338.91661083389;8831;8867.379283450153;9130.315226358016;9149.085091490848;8919;9030.819383612325;9035.503047332393;9036.277097832173;9045.3668243223;2347.8121750260025;2366.893489792955;2371.5494056129364;2374.465745207332;2375.9881200593973;2351.6002279612508;2382.916597919073;2388.4745356021735;2406.5186962607463;2407.181558270188;2290.919817806377;2324.4886125052544;2332;2397.5924092904247;2400.0279886645935;2217.7227846519186;2247.6965609642652;2254.222293308798;2259.2431535435567;2334.2763743239652;2261.898214580348;2273.2498275569187;2276.7723227677266;2277.52172043871;2277.9658305125436;8696.521691307038;8939.463632182025;9012;9032.09679032098;9061.365704400694;4909.993451342466;5090.567301779316;5101.15830887903;5102.387713474407;5103.23451482277;3168;3305.4215512285255;3345.2138747394342;3367.191873950259;3380.881669141568;1165.8251262310637;1198.72429341252;1203.4343858386544;1209.6975756060986;1225.5894275417745;12400.751984960341;12410.689732756662;12526.68683282916;12545.31000794956;12558.183718058388;4164.875053748392;4326.134773045404;4439.7336159829865;4484.618807401343;4526.23054080807;9804.509774511245;9817.460039697886;9829.115379615869;9842.80314393708;9847.45838978863;5052.7726252318735;5103.260027296022;5105.412877519058;5107.770150343244;5114.514121158484;4295.78521073945;4692.131955588227;4781.043791241766;4863.878403039882;4902.852914412573;3724.1062145085525;3795.3737633290198;3810.9618903810606;3869.129445874712;3891.494105766232;1083.6207327435334;1089.3082892363248;1095.134843473647;1095.8301463273206;1101.9889801102047;973.7614284500343;977.5112443778111;995.0099650847453;996.7358649957768;1014.7361685961555;5689.317281926113;5735.283089613798;5871.765129394862;5968.7015649217365;5994.100884867217;487.1961263914569;490.6687985609699;495.4846959162431;500.4070176840383;501.5586284069995;3905.453236546886;3999.280129576704;4026.1545075534464;4026.295398305285;4028.315186418316;10897.564097436172;11400.372979486043;11407;11408.087353011739;11424.885751142549;11119.166062545342;11212.439378031066;11220.719482013015;11248.831267530994;11282.717932051764;7909.644066017043;8303.875441868377;8319.126491718403;8373;8384.706535271236;5948.470514347862;6054.485368743706;6057.57596968208;6071.483923866521;6203.96898015507;9970.451625160396;10006.399616023062;10037;10160.949195254272;10196.949015254877;9924.751881203028;9955.701328960144;10158.644447444303;10178.49107544605;10270.07569318765;7156.677949492181;7372.778816635509;7376.299251571092;7713.537187768752;7951.84096318082;8191.180881911761;8465.873011904949;8616.569171541523;8743.081976392641;8932.017478077536;7686.500377475446;7828.530288182727;7930.286274235346;7947.483413578099;8087.797805054921;7666.118396384487;7856.764297071097;7887.802804929923;7907.9604601976625;7987.400944929037;7109.28907109285;7173.748918787817;7195.064641596559;7198.380364417964;7200.7479738211005;5127.974360128324;5166.483351664803;5167.173252279767;5209.374875014871;5417.674939503642;5119.590432765295;5223.425423203521;5229.895402092013;5237.580993520433;5414.404415514369 11:50:43 INFO - PROCESS | 18877 | |4;prototype.html;304.65573901491297;314.1345592891584;322.56775920266836;322.58708852668593;324.7531875774412;5188.2995795567585;5246.606504512162;5252.553532949699;5260.736963151837;5302.787888484466;4918.311436398898;4935.605151587864;5077.746112694369;5104.8979020419565;5185.170372740362;4067.2068946555432;4096.303628383167;4099.118689481761;4106.527749308823;4108.938365924513;4086.6730661547153;4104.220198162355;4107.79461026949;4114.321137012389;4118.5057793064725;3871.6128387161198;3876.573576906538;4056.655184309337;4062.1266427718033;4069.69477289203;4045.615666511677;4049.473568436114;4056.1076563156057;4059.6143366380147;4066.7966601669946;3584.4981702561663;3592.8742494012586;3593.6226696197045;3597.812721801799;3599.7300202484917;4776.235802271654;5036.496350364971;5052.46949070346;5071.239314102877;5072.148665737016;4555.931661025087;4558.977205113986;4573.131105090022;4573.164637924475;4578.587927086545;5379.220013098118;5380;5392.191171324333;5404.83785486436;5420.186971954199;3718.3864662330684;3811.6177389131794;3829.9808500957597;3836.4270649034042;3840;5500.917486237709;5552.361478429952;5557.472040156179;5560.888782224373;5590.692511911843;3947.486826712509;3951.644352008333;3953.4069889516227;3961.2473630010204;3973.1854969731135;3995.300822356076;4006.8397264109108;4007.757595145514;4021.6983726220064;4023.893429306964;4425.822967081345;4582.2668373060815;4587.3348364486965;4591.540845915381;4596.49438561758;5357.249985002103;5374.113271310268;5390.595705322116;5392.514673679309;5408.675479471244;1373.32020649779;1380.2822532283358;1384.6884450998446;1385.1273697570466;1387.8126452928725;837.3970741066422;859.2138193552954;945.1210374351919;946.5125460387906;949.1742184299566;5153.330067091254;5170.948290517122;5177.508136727005;5218.139007063868;5224.059669259494;5457.799284157479;5497.36780270274;5500.7524661390335;5514.696691681996;5519.503244707996;5032.220005899091;5199.648091496162;5205.817796377109;5303.814366497231;5317.8404647860625;2922.3570814420796;2944.528875379929;2947.1600593831085;2947.9410411791646;2955.2611847038243;5581.4976652100695;5748.482636562646;5759.596828221985;5780.739866706008;5790.739416726257;5626.299376299317;5640.238567793377;5669.262995810518;5714.228579141846;5716.1997320375185;5764.596478246483;5775.5090817281;5802.4197580241635;5806.76772929095;5814.389489103753;5378.354597448331;5483.917741233964;5499.367572729027;5608.9158662619275;5625.718714064362;5401.270828438268;5403.4326395727885;5482.23248745184;5495.82914748664;5501.477359650827;5691.345495268097;5738.885222295614;5756.827295181151;5766.538676905921;5775;3863.8987888451657;3922.9215415692097;3957.5250969882645;3962.1679447316387;3987.2424239394422;5273.235380869675;5389.137737961907;5464.644798088111;5487.695168029517;5519.31008623922;5386.218998245311;5387.662931340309;5427.674339539641;5455.1271796512365;5465.426130256265;5217.973910130577;5398.54366263357;5402.59480538969;5439.3200849893765;5447.809326673548;5297.066570701743;5335.559398962181;5344.812931547377;5348.545373643284;5357.892842143057;5415.864603384947;5450.345958484849;5455.754491047833;5496.6701997880255;5502.477264659851;5214.634975551675;5297.735113244399;5335.866603334947;5379.973100134474;5387.973060134831 11:50:43 INFO - PROCESS | 18877 | |5;yui.html;723.9601821899797;734.9853002939941;765.4144579396763;777.7666699990009;860.0281681699679;14373.568792936203;14642.853571464282;14973.775393369107;15073.698526029473;15079.472218472341;14491.782623260633;14648.780268295957;14760.926195369007;14765.18791466469;14771.482998095069;817.0358976407852;822.7572866004513;829.5852073963018;830.4685001598981;832.7543374704477;666.070831190489;799.1768478467188;824.9422540422142;827.0447632983913;836.067784420373;868.7046404222563;869.3088994249555;870.4168207301092;870.4211699220011;871.1854416120947;865.9523726195057;867.0289276010908;867.8047439326195;867.9522626255554;868.5006121480111;512.7333786431072;616.7563812294119;629.1789215074326;630.4893036640336;632.1655414852397;13416.86583134166;13422;13439.462421503129;13445.529406470727;13447.327633618377;14029.719405611831;14475.493357732534;14516.637084072878;14654.413823447156;14742.852571474363;13237.338133093403;13405;13407.597772066756;13432.19406835593;13671.794923076062;3839.4432807243074;3900.4929359183125;4561.589456948857;4635.884102897455;4714.151452738506;76984;77430.22569774343;77845.61077194578;78267.99999999943;78279;11692.590759323382;11773.88226117745;11904.940475297568;11908.523659053713;11973.700657483458;22132.557348852934;22191.66712499314;22199.667004994615;22329.776702233095;22358.329250122522;9012.56660701607;9067.410618309788;9185.311101667401;9195.90804091964;9219.262459003263;4990.90018199634;5020;5090.745462726849;5153.561947234527;5205.9219111713355;3571.928561428757;3683.9447408288897;3722.641235948859;3724.5158129443;3726.124360775216;616.6269407008696;620.2433031701318;621.1335187413533;621.8227805075622;630.5239544144142;678.0879716780922;680.5610381304031;689.9517033807685;716.9749058782918;734.717133903451;9727.686607726084;9816.950915245377;10261.460338301902;10583.990778305058;10753.83869241962;727.5759215051776;736.1166600079926;764.323573637335;764.4075841223097;766.6626684258908;5005.624578156653;5101.387833460009;5186.481351864783;5232.843014709565;5233.842984710464;111332.88667113388;122846;125390;130483;134679.32660336635;106166;107547;108461;109486;110727;96423.5894102639;96778.51610742042;98084.50957745308;98730;99164;9715.36850104741;9728.659496917573;9985;9985.700428987142;9987.101160895554;48859;51228.48771512237;53886.730566346916;55788.16317755318;56093.719531403716;53920;55937.48281327431;61448.078278824956;63437.682811587496;72214.91677624735;13487.190768553919;14036.578902632937;14362.281885905453;14759.92620036893;14875.47935822241;14661.853381466475;15781;16108.405294768298;16473.67052658964;17657.735133973256;14090.36593353281;14949.775753363925;14973.587162363938;15511.84488155104;16161.075952500878;15336.15651139198;15349.462768803038;15837.366505339658;15947;16327.510174694778;14391.208483533506;14439.92780036093;14683.706325873636;14849.92575037161;15818.525444236691;12022.27866328023;12024.699382515508;12108.551171915886;12500.874991249972;12529.436175372313;11979.460924258256;12058.336791476202;12724.363781811058;12776.169548979287;13021.609351719464 11:50:43 INFO - PROCESS | 18877 | __end_tp_report 11:50:43 INFO - PROCESS | 18877 | __start_cc_report 11:50:43 INFO - PROCESS | 18877 | _x_x_mozilla_cycle_collect,900 11:50:43 INFO - PROCESS | 18877 | __end_cc_report 11:50:43 INFO - PROCESS | 18877 | __startTimestamp1471632643199__endTimestamp 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | ------- Summary: start ------- 11:50:43 INFO - PROCESS | 18877 | Number of tests: 6 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | [#0] dojo.html Cycles:165 Average:5265.62 Median:5452.81 stddev:585.15 (10.7%) stddev-sans-first:559.63 11:50:43 INFO - PROCESS | 18877 | Values: 3013.2 3018.5 3027.1 3055.7 3077.9 5145.1 5246.6 5270.6 5297.8 5307.2 5264.4 5314.3 5328.1 5344.2 5363.3 4816.7 4874.2 4878.0 4921.7 4951.8 4938.2 4966.6 4975.0 4975.7 4979.5 4722.3 4788.6 4808.3 4850.7 4851.5 4773.5 4775.0 4784.9 4829.7 4834.8 4786.4 4803.3 4837.3 4841.2 4869.8 5092.6 5151.3 5352.6 5354.6 5357.5 5550.8 5626.0 5633.9 5641.3 5642.4 5581.5 5638.2 5650.3 5650.3 5660.9 5165.0 5219.4 5272.6 5273.3 5291.3 5839.3 5854.4 5862.6 5868.4 5872.4 5604.5 5616.2 5621.9 5622.5 5625.8 5479.0 5552.2 5681.4 5683.1 5686.8 5604.2 5675.4 5676.3 5681.5 5690.2 5634.2 5634.5 5652.9 5656.9 5680.1 4298.5 4339.8 4404.4 4420.6 4458.1 3880.5 3935.8 3937.5 3959.0 3985.3 5398.7 5407.1 5408.3 5409.8 5414.1 5493.7 5561.0 5688.2 5690.6 5691.8 5352.8 5399.2 5410.0 5417.2 5426.9 4928.7 4936.3 4936.7 4937.1 4941.1 5659.9 5780.9 5903.1 5903.6 5907.4 5642.3 5694.6 5703.1 5705.9 5708.0 5891.6 5898.8 5900.7 5904.6 5915.6 5316.7 5423.9 5593.7 5601.1 5602.1 5559.6 5634.4 5637.9 5640.2 5640.5 5452.8 5466.3 5494.4 5497.9 5502.3 5339.3 5452.3 5490.2 5495.6 5496.4 5409.2 5509.5 5513.8 5517.8 5521.2 5549.8 5560.4 5566.2 5569.9 5580.7 5390.5 5448.5 5458.6 5463.2 5470.7 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | [#1] ext.html Cycles:180 Average:66618.28 Median:24133.89 stddev:137941.16 (571.6%) stddev-sans-first:138238.98 11:50:43 INFO - PROCESS | 18877 | Values: 570.0 585.9 594.0 600.9 614.6 44077.8 44843.3 44937.6 45262.8 48036.5 46104.8 46569.8 46585.3 46590.1 46630.3 8968.9 8982.5 8992.6 9061.7 9086.5 8891.6 8951.6 8968.9 8976.6 8978.9 8969.5 9009.9 9097.6 9104.0 9109.8 9028.1 9041.4 9052.9 9076.3 9082.1 8965.5 9024.2 9041.3 9043.4 9047.1 42999.6 43103.1 43318.0 43366.6 43378.8 3647.5 3746.9 4187.5 4255.1 4303.5 33132.5 33164.5 33325.2 33402.5 34873.0 4362.2 4427.1 4440.6 4493.3 4602.9 354042.0 355070.0 355110.2 355423.0 355900.0 58402.0 58949.4 58989.0 58993.0 59059.4 36511.0 36996.3 62538.7 62671.4 62677.4 15016.2 15124.5 15131.8 15134.5 15140.9 12022.0 12129.1 12143.9 12145.1 12145.5 19498.0 19516.3 19562.1 19566.8 19567.6 7351.6 7356.3 7356.4 7513.2 7578.7 937.0 974.9 1018.6 1047.9 1085.9 32375.0 32703.8 32816.5 32869.0 33092.5 1052.6 1079.3 1096.3 1128.7 1187.1 16131.5 16975.0 17138.4 17296.7 17385.0 611606.0 617032.0 617684.0 618760.0 621608.0 60488.7 60570.4 61020.4 61095.4 61202.7 1215.4 1299.9 1322.1 1328.1 1332.7 31267.8 33309.3 34378.0 34448.3 34635.0 52074.5 56460.7 58336.4 58433.4 63833.4 538666.0 546335.0 546487.0 547115.0 547750.0 37002.8 42613.6 43039.6 43905.6 45703.8 48844.8 49397.8 49482.0 49516.8 49756.3 41203.0 41962.6 42794.4 43949.1 44462.0 42194.8 42403.4 42461.4 42636.4 44555.3 42443.8 42800.8 43009.8 43132.1 43406.6 36070.3 37228.8 37949.4 38054.6 38794.4 28248.7 28313.0 28586.9 28876.3 28983.4 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | [#2] jquery.html Cycles:180 Average:27913.98 Median:2264.39 stddev:72223.73 (3189.5%) stddev-sans-first:72396.70 11:50:43 INFO - PROCESS | 18877 | Values: 358.0 367.2 379.3 385.3 401.9 18397.9 20237.5 20381.7 20651.0 20774.6 17174.1 17317.5 17556.2 17584.3 17853.8 5636.7 5695.1 5904.9 5911.6 5912.7 5699.2 5712.4 5748.6 5755.1 5784.9 5526.4 5723.6 5723.7 5732.3 5770.1 5689.4 5716.9 5757.3 5758.7 5765.2 5024.5 5082.4 5115.1 5118.3 5134.6 23741.0 23955.6 24063.3 24099.9 24149.6 2232.2 2246.5 2257.5 2271.3 2331.7 14181.6 14820.5 14943.0 15060.2 15343.8 1904.4 1946.2 1974.7 2015.1 2044.7 76167.6 76323.6 76672.2 78012.0 81228.6 9785.8 9799.4 9913.3 10244.8 10409.2 13802.9 13839.4 13849.2 13871.3 13880.9 7575.8 7615.7 7833.3 7852.3 7878.3 7390.0 7476.4 7524.5 7681.2 7697.7 6373.8 6451.7 6465.3 6471.1 6660.9 1755.2 1804.8 1808.5 1812.0 1816.6 1015.9 1043.3 1049.9 1072.4 1081.9 19716.0 20385.4 20515.1 20585.9 20620.9 968.5 985.8 1002.7 1055.9 1084.9 10593.4 11228.4 11435.7 11442.9 11700.3 385313.0 385398.0 386446.0 495527.0 498861.0 101565.0 105665.5 105924.5 106935.5 108642.0 985.3 996.2 1017.0 1045.5 1048.1 17233.9 17745.2 18382.2 18410.6 18474.3 41632.6 42364.6 42759.6 42794.4 42932.6 59974.0 60196.0 60685.4 61120.4 62662.0 8387.3 8390.7 8725.0 8791.2 8816.8 13184.6 13306.7 13340.9 13649.5 13683.2 11566.4 11719.0 12023.5 12026.9 12067.8 11558.2 11589.6 11789.4 11832.2 12130.8 11964.2 12027.9 12338.4 12563.6 12691.7 8390.6 8444.4 8708.1 8792.3 8821.6 11346.3 11644.2 11672.6 11763.7 11896.5 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | [#3] mootools.html Cycles:180 Average:5801.54 Median:2702.74 stddev:3368.25 (124.6%) stddev-sans-first:3361.23 11:50:43 INFO - PROCESS | 18877 | Values: 1369.7 1456.9 1502.8 1614.8 1747.9 8338.9 8831.0 8867.4 9130.3 9149.1 8919.0 9030.8 9035.5 9036.3 9045.4 2347.8 2366.9 2371.5 2374.5 2376.0 2351.6 2382.9 2388.5 2406.5 2407.2 2290.9 2324.5 2332.0 2397.6 2400.0 2217.7 2247.7 2254.2 2259.2 2334.3 2261.9 2273.2 2276.8 2277.5 2278.0 8696.5 8939.5 9012.0 9032.1 9061.4 4910.0 5090.6 5101.2 5102.4 5103.2 3168.0 3305.4 3345.2 3367.2 3380.9 1165.8 1198.7 1203.4 1209.7 1225.6 12400.8 12410.7 12526.7 12545.3 12558.2 4164.9 4326.1 4439.7 4484.6 4526.2 9804.5 9817.5 9829.1 9842.8 9847.5 5052.8 5103.3 5105.4 5107.8 5114.5 4295.8 4692.1 4781.0 4863.9 4902.9 3724.1 3795.4 3811.0 3869.1 3891.5 1083.6 1089.3 1095.1 1095.8 1102.0 973.8 977.5 995.0 996.7 1014.7 5689.3 5735.3 5871.8 5968.7 5994.1 487.2 490.7 495.5 500.4 501.6 3905.5 3999.3 4026.2 4026.3 4028.3 10897.6 11400.4 11407.0 11408.1 11424.9 11119.2 11212.4 11220.7 11248.8 11282.7 7909.6 8303.9 8319.1 8373.0 8384.7 5948.5 6054.5 6057.6 6071.5 6204.0 9970.5 10006.4 10037.0 10160.9 10196.9 9924.8 9955.7 10158.6 10178.5 10270.1 7156.7 7372.8 7376.3 7713.5 7951.8 8191.2 8465.9 8616.6 8743.1 8932.0 7686.5 7828.5 7930.3 7947.5 8087.8 7666.1 7856.8 7887.8 7908.0 7987.4 7109.3 7173.7 7195.1 7198.4 7200.7 5128.0 5166.5 5167.2 5209.4 5417.7 5119.6 5223.4 5229.9 5237.6 5414.4 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | [#4] prototype.html Cycles:180 Average:4556.46 Median:5235.33 stddev:1338.20 (25.6%) stddev-sans-first:1303.35 11:50:43 INFO - PROCESS | 18877 | Values: 304.7 314.1 322.6 322.6 324.8 5188.3 5246.6 5252.6 5260.7 5302.8 4918.3 4935.6 5077.7 5104.9 5185.2 4067.2 4096.3 4099.1 4106.5 4108.9 4086.7 4104.2 4107.8 4114.3 4118.5 3871.6 3876.6 4056.7 4062.1 4069.7 4045.6 4049.5 4056.1 4059.6 4066.8 3584.5 3592.9 3593.6 3597.8 3599.7 4776.2 5036.5 5052.5 5071.2 5072.1 4555.9 4559.0 4573.1 4573.2 4578.6 5379.2 5380.0 5392.2 5404.8 5420.2 3718.4 3811.6 3830.0 3836.4 3840.0 5500.9 5552.4 5557.5 5560.9 5590.7 3947.5 3951.6 3953.4 3961.2 3973.2 3995.3 4006.8 4007.8 4021.7 4023.9 4425.8 4582.3 4587.3 4591.5 4596.5 5357.2 5374.1 5390.6 5392.5 5408.7 1373.3 1380.3 1384.7 1385.1 1387.8 837.4 859.2 945.1 946.5 949.2 5153.3 5170.9 5177.5 5218.1 5224.1 5457.8 5497.4 5500.8 5514.7 5519.5 5032.2 5199.6 5205.8 5303.8 5317.8 2922.4 2944.5 2947.2 2947.9 2955.3 5581.5 5748.5 5759.6 5780.7 5790.7 5626.3 5640.2 5669.3 5714.2 5716.2 5764.6 5775.5 5802.4 5806.8 5814.4 5378.4 5483.9 5499.4 5608.9 5625.7 5401.3 5403.4 5482.2 5495.8 5501.5 5691.3 5738.9 5756.8 5766.5 5775.0 3863.9 3922.9 3957.5 3962.2 3987.2 5273.2 5389.1 5464.6 5487.7 5519.3 5386.2 5387.7 5427.7 5455.1 5465.4 5218.0 5398.5 5402.6 5439.3 5447.8 5297.1 5335.6 5344.8 5348.5 5357.9 5415.9 5450.3 5455.8 5496.7 5502.5 5214.6 5297.7 5335.9 5380.0 5388.0 11:50:43 INFO - PROCESS | 18877 | 11:50:43 INFO - PROCESS | 18877 | [#5] yui.html Cycles:180 Average:21771.57 Median:4598.74 stddev:31770.22 (690.8%) stddev-sans-first:31820.03 11:50:43 INFO - PROCESS | 18877 | Values: 724.0 735.0 765.4 777.8 860.0 14373.6 14642.9 14973.8 15073.7 15079.5 14491.8 14648.8 14760.9 14765.2 14771.5 817.0 822.8 829.6 830.5 832.8 666.1 799.2 824.9 827.0 836.1 868.7 869.3 870.4 870.4 871.2 866.0 867.0 867.8 868.0 868.5 512.7 616.8 629.2 630.5 632.2 13416.9 13422.0 13439.5 13445.5 13447.3 14029.7 14475.5 14516.6 14654.4 14742.9 13237.3 13405.0 13407.6 13432.2 13671.8 3839.4 3900.5 4561.6 4635.9 4714.2 76984.0 77430.2 77845.6 78268.0 78279.0 11692.6 11773.9 11904.9 11908.5 11973.7 22132.6 22191.7 22199.7 22329.8 22358.3 9012.6 9067.4 9185.3 9195.9 9219.3 4990.9 5020.0 5090.7 5153.6 5205.9 3571.9 3683.9 3722.6 3724.5 3726.1 616.6 620.2 621.1 621.8 630.5 678.1 680.6 690.0 717.0 734.7 9727.7 9817.0 10261.5 10584.0 10753.8 727.6 736.1 764.3 764.4 766.7 5005.6 5101.4 5186.5 5232.8 5233.8 111332.9 122846.0 125390.0 130483.0 134679.3 106166.0 107547.0 108461.0 109486.0 110727.0 96423.6 96778.5 98084.5 98730.0 99164.0 9715.4 9728.7 9985.0 9985.7 9987.1 48859.0 51228.5 53886.7 55788.2 56093.7 53920.0 55937.5 61448.1 63437.7 72214.9 13487.2 14036.6 14362.3 14759.9 14875.5 14661.9 15781.0 16108.4 16473.7 17657.7 14090.4 14949.8 14973.6 15511.8 16161.1 15336.2 15349.5 15837.4 15947.0 16327.5 14391.2 14439.9 14683.7 14849.9 15818.5 12022.3 12024.7 12108.6 12500.9 12529.4 11979.5 12058.3 12724.4 12776.2 13021.6 11:50:43 INFO - PROCESS | 18877 | -------- Summary: end -------- 11:50:43 INFO - PROCESS | 18877 | 11:50:44 INFO - TEST-INFO | 18877: exit 0 11:50:44 INFO - TEST-OK | dromaeo_css | took 1114450ms 11:50:44 INFO - TEST-START | kraken 11:50:44 INFO - operating with platform_type : linux_ 11:50:44 INFO - Initialising browser for kraken test... 11:50:44 INFO - TEST-INFO | started process 19183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUwENU9/profile http://localhost:53008/getInfo.html) 11:50:48 INFO - PROCESS | 19183 | __metrics Screen width/height:1600/1200 11:50:48 INFO - PROCESS | 19183 | colorDepth:24 11:50:48 INFO - PROCESS | 19183 | Browser inner width/height: 1024/697 11:50:48 INFO - PROCESS | 19183 | __metrics 11:50:48 INFO - PROCESS | 19183 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:50:48 INFO - PROCESS | 19183 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:49 INFO - PROCESS | 19183 | console.error: PushService: 11:50:49 INFO - PROCESS | 19183 | stateChangeProcessEnqueue: Error transitioning state 11:50:49 INFO - PROCESS | 19183 | UnknownError 11:50:49 INFO - TEST-INFO | 19183: exit 0 11:50:49 INFO - Browser initialized. 11:50:49 INFO - Running cycle 1/1 for kraken test... 11:50:49 INFO - TEST-INFO | started process 19266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUwENU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:01 INFO - PROCESS | 19266 | RSS: Main: 155983872 11:51:01 INFO - PROCESS | 19266 | 11:51:04 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53008/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:05 INFO - PROCESS | 19266 | RSS: Main: 210718720 11:51:05 INFO - PROCESS | 19266 | 11:51:07 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53008/tests/kraken/driver.html?testName=audio-dft) 11:51:08 INFO - PROCESS | 19266 | RSS: Main: 185950208 11:51:08 INFO - PROCESS | 19266 | 11:51:11 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53008/tests/kraken/driver.html?testName=audio-fft) 11:51:12 INFO - PROCESS | 19266 | RSS: Main: 268025856 11:51:12 INFO - PROCESS | 19266 | 11:51:14 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53008/tests/kraken/driver.html?testName=audio-oscillator) 11:51:14 INFO - PROCESS | 19266 | RSS: Main: 178298880 11:51:14 INFO - PROCESS | 19266 | 11:51:16 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:17 INFO - PROCESS | 19266 | RSS: Main: 183328768 11:51:17 INFO - PROCESS | 19266 | 11:51:20 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53008/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:21 INFO - PROCESS | 19266 | RSS: Main: 218284032 11:51:21 INFO - PROCESS | 19266 | 11:51:24 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53008/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:25 INFO - PROCESS | 19266 | RSS: Main: 218738688 11:51:25 INFO - PROCESS | 19266 | 11:51:27 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53008/tests/kraken/driver.html?testName=json-parse-financial) 11:51:28 INFO - PROCESS | 19266 | RSS: Main: 219381760 11:51:28 INFO - PROCESS | 19266 | 11:51:30 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:30 INFO - PROCESS | 19266 | RSS: Main: 181604352 11:51:30 INFO - PROCESS | 19266 | 11:51:32 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:51:33 INFO - PROCESS | 19266 | RSS: Main: 188510208 11:51:33 INFO - PROCESS | 19266 | 11:51:35 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:35 INFO - PROCESS | 19266 | RSS: Main: 193933312 11:51:35 INFO - PROCESS | 19266 | 11:51:38 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:38 INFO - PROCESS | 19266 | RSS: Main: 187404288 11:51:38 INFO - PROCESS | 19266 | 11:51:41 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:42 INFO - PROCESS | 19266 | RSS: Main: 191922176 11:51:42 INFO - PROCESS | 19266 | 11:51:43 INFO - PROCESS | 19266 | Cycle 1(1): loaded http://localhost:53008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53008/tests/kraken/driver.html?testName=ai-astar) 11:51:44 INFO - PROCESS | 19266 | RSS: Main: 243089408 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | __start_tp_report 11:51:44 INFO - PROCESS | 19266 | _x_x_mozilla_page_load 11:51:44 INFO - PROCESS | 19266 | _x_x_mozilla_page_load_details 11:51:44 INFO - PROCESS | 19266 | |i|pagename|runs| 11:51:44 INFO - PROCESS | 19266 | |0;ai-astar;104;112;113;111;111;111;113;112;113;111 11:51:44 INFO - PROCESS | 19266 | |1;audio-beat-detection;153;123;122;188;124;125;143;118;157;122 11:51:44 INFO - PROCESS | 19266 | |2;audio-dft;160;160;160;163;160;162;161;159;162;159 11:51:44 INFO - PROCESS | 19266 | |3;audio-fft;75;76;76;105;75;76;75;74;105;76 11:51:44 INFO - PROCESS | 19266 | |4;audio-oscillator;84;85;119;86;85;85;122;85;85;136 11:51:44 INFO - PROCESS | 19266 | |5;imaging-gaussian-blur;118;117;117;117;117;117;116;117;117;118 11:51:44 INFO - PROCESS | 19266 | |6;imaging-darkroom;146;145;145;146;146;146;145;145;146;145 11:51:44 INFO - PROCESS | 19266 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 11:51:44 INFO - PROCESS | 19266 | |8;json-parse-financial;51;51;52;51;51;56;52;52;50;51 11:51:44 INFO - PROCESS | 19266 | |9;json-stringify-tinderbox;61;62;61;61;61;60;62;61;61;61 11:51:44 INFO - PROCESS | 19266 | |10;stanford-crypto-aes;79;81;84;78;79;79;77;91;77;77 11:51:44 INFO - PROCESS | 19266 | |11;stanford-crypto-ccm;122;119;148;130;122;124;126;126;140;126 11:51:44 INFO - PROCESS | 19266 | |12;stanford-crypto-pbkdf2;162;170;165;163;162;168;175;167;164;159 11:51:44 INFO - PROCESS | 19266 | |13;stanford-crypto-sha256-iterative;66;65;64;65;65;64;63;63;63;64 11:51:44 INFO - PROCESS | 19266 | __end_tp_report 11:51:44 INFO - PROCESS | 19266 | __start_cc_report 11:51:44 INFO - PROCESS | 19266 | _x_x_mozilla_cycle_collect,1699 11:51:44 INFO - PROCESS | 19266 | __end_cc_report 11:51:44 INFO - PROCESS | 19266 | __startTimestamp1471632704180__endTimestamp 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | ------- Summary: start ------- 11:51:44 INFO - PROCESS | 19266 | Number of tests: 14 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 11:51:44 INFO - PROCESS | 19266 | Values: 104.0 112.0 113.0 111.0 111.0 111.0 113.0 112.0 113.0 111.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:134.00 stddev:22.63 (16.9%) stddev-sans-first:23.30 11:51:44 INFO - PROCESS | 19266 | Values: 153.0 123.0 122.0 188.0 124.0 125.0 143.0 118.0 157.0 122.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 11:51:44 INFO - PROCESS | 19266 | Values: 160.0 160.0 160.0 163.0 160.0 162.0 161.0 159.0 162.0 159.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:12.51 (16.6%) stddev-sans-first:13.06 11:51:44 INFO - PROCESS | 19266 | Values: 75.0 76.0 76.0 105.0 75.0 76.0 75.0 74.0 105.0 76.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.00 stddev:20.11 (23.7%) stddev-sans-first:20.75 11:51:44 INFO - PROCESS | 19266 | Values: 84.0 85.0 119.0 86.0 85.0 85.0 122.0 85.0 85.0 136.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 11:51:44 INFO - PROCESS | 19266 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:51:44 INFO - PROCESS | 19266 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:51:44 INFO - PROCESS | 19266 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:51.50 stddev:1.64 (3.2%) stddev-sans-first:1.72 11:51:44 INFO - PROCESS | 19266 | Values: 51.0 51.0 52.0 51.0 51.0 56.0 52.0 52.0 50.0 51.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 11:51:44 INFO - PROCESS | 19266 | Values: 61.0 62.0 61.0 61.0 61.0 60.0 62.0 61.0 61.0 61.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.00 stddev:4.37 (5.5%) stddev-sans-first:4.61 11:51:44 INFO - PROCESS | 19266 | Values: 79.0 81.0 84.0 78.0 79.0 79.0 77.0 91.0 77.0 77.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.00 stddev:8.99 (7.1%) stddev-sans-first:9.25 11:51:44 INFO - PROCESS | 19266 | Values: 122.0 119.0 148.0 130.0 122.0 124.0 126.0 126.0 140.0 126.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:166.00 stddev:4.65 (2.8%) stddev-sans-first:4.76 11:51:44 INFO - PROCESS | 19266 | Values: 162.0 170.0 165.0 163.0 162.0 168.0 175.0 167.0 164.0 159.0 11:51:44 INFO - PROCESS | 19266 | 11:51:44 INFO - PROCESS | 19266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.03 (1.6%) stddev-sans-first:0.87 11:51:44 INFO - PROCESS | 19266 | Values: 66.0 65.0 64.0 65.0 65.0 64.0 63.0 63.0 63.0 64.0 11:51:44 INFO - PROCESS | 19266 | -------- Summary: end -------- 11:51:44 INFO - PROCESS | 19266 | 11:51:45 INFO - TEST-INFO | 19266: exit 0 11:51:45 INFO - TEST-OK | kraken | took 61185ms 11:51:45 INFO - SUITE-END | took 1175s 11:51:45 INFO - Completed test suite (00:19:35) 11:51:45 INFO - javascript benchmark 11:51:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.246688327918, 3018.471767440699, 3027.0918724382686, 3055.694430556946, 3077.907662770118, 5145.125328694122, 5246.606504512162, 5270.604704647148, 5297.788088476461, 5307.20391941209, 5264.447233040523, 5314.335708036496, 5328.120860058096, 5344.22508736233, 5363.302770639812, 4816.662833601649, 4874.171390863544, 4878.0, 4921.680090794105, 4951.826686065989, 4938.2098864181735, 4966.627502937276, 4975.029869175512, 4975.7263350515705, 4979.502049795028, 4722.268048452495, 4788.592969597554, 4808.326834243174, 4850.733209673466, 4851.466338702758, 4773.5226477352335, 4774.976125119387, 4784.928226076611, 4829.661923665345, 4834.830780922651, 4786.401699787527, 4803.253462299412, 4837.274408838667, 4841.152798260326, 4869.756512174377, 5092.6180536459915, 5151.330327057496, 5352.625316227865, 5354.571634269288, 5357.544608708265, 5550.805721799758, 5626.043572592628, 5633.943660563424, 5641.294838145232, 5642.351129620105, 5581.49766521015, 5638.210650508932, 5650.265465489501, 5650.265465489501, 5660.915086273709, 5165.0, 5219.373675159005, 5272.578193744491, 5273.31446911899, 5291.3121294231505, 5839.2992840858515, 5854.385289544622, 5862.648241105548, 5868.383819698955, 5872.442117998783, 5604.495595396434, 5616.241807356037, 5621.8594535136945, 5622.522085622768, 5625.774969001194, 5479.0, 5552.222688823568, 5681.431856814368, 5683.090705487185, 5686.829395118153, 5604.187392828098, 5675.4324567543745, 5676.347220069745, 5681.460261275172, 5690.231818704422, 5634.1830434586755, 5634.464725851038, 5652.9152062719095, 5656.91514627281, 5680.0627896397455, 4298.484181898192, 4339.7613131278085, 4404.427424434803, 4420.557944205554, 4458.08609235106, 3880.4761357216416, 3935.842566297316, 3937.5078115235597, 3959.0498280412494, 3985.3224951757693, 5398.73006349681, 5407.053765591006, 5408.269883565668, 5409.756560954766, 5414.10667239901, 5493.725313734377, 5560.972195138998, 5688.232088667977, 5690.630109042899, 5691.800786972436, 5352.759125839347, 5399.190121481731, 5410.0, 5417.241586177938, 5426.945730542644, 4928.728919909439, 4936.259561065797, 4936.679115857458, 4937.086638971802, 4941.085899108676, 5659.943400566024, 5780.94219057804, 5903.144044113579, 5903.58674892762, 5907.3797251288, 5642.294713160855, 5694.629849059798, 5703.08750599902, 5705.857353566194, 5708.0, 5891.558133140117, 5898.764049437975, 5900.675462849585, 5904.586678932434, 5915.556333274935, 5316.734163291742, 5423.864403389789, 5593.748281327432, 5601.103823388238, 5602.075657516464, 5559.610827242216, 5634.4365563443325, 5637.8590535236945, 5640.210370548045, 5640.492355688008, 5452.809151679672, 5466.316710411199, 5494.395616482104, 5497.890042199054, 5502.284702988746, 5339.252504649275, 5452.345718513804, 5490.1764735288425, 5495.6153069284765, 5496.395396506461, 5409.161579955114, 5509.47659972302, 5513.779448822002, 5517.751701173376, 5521.2270282159725, 5549.750261238173, 5560.443955604569, 5566.192902029102, 5569.888602228014, 5580.693061881636, 5390.51485366319, 5448.536874365724, 5458.61789674719, 5463.153211252262, 5470.671759694431], "value": 5226.640343305846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9886002279954, 585.8798946216026, 594.0287629725399, 600.9098635204722, 614.5575185866178, 44077.77961110194, 44843.32735008978, 44937.550624493786, 45262.773686131564, 48036.51963480364, 46104.76947615266, 46569.7671511642, 46585.30122048172, 46590.06819863601, 46630.300545491846, 8968.910310896872, 8982.505962172077, 8992.595333209989, 9061.728148155566, 9086.454812711225, 8891.555422228863, 8951.641934322619, 8968.865467017968, 8976.596053177622, 8978.910210897873, 8969.461832290084, 9009.864852027225, 9097.590608422637, 9103.95448022759, 9109.817803643924, 9028.097190280985, 9041.367104302668, 9052.864207036866, 9076.273898088137, 9082.13719696631, 8965.506897120657, 9024.187823095886, 9041.276697864156, 9043.412178208395, 9047.095290470901, 42999.57000429987, 43103.13793724108, 43318.0, 43366.56633433689, 43378.783106084265, 3647.4528820676846, 3746.925061498755, 4187.5184353799095, 4255.064005835963, 4303.548127446605, 33132.503012454836, 33164.50253246203, 33325.16687082818, 33402.49896251534, 34873.0, 4362.214801335758, 4427.092446048585, 4440.555944405566, 4493.326001099861, 4602.907941841145, 354042.0, 355070.0, 355110.22444887867, 355423.0, 355900.0, 58402.0, 58949.41050589525, 58989.0, 58993.0, 59059.40940590625, 36511.0, 36996.26007479835, 62538.68730656317, 62671.373286267466, 62677.373226267155, 15016.174110424032, 15124.470643527424, 15131.773023404658, 15134.545963621109, 15140.924295378452, 12022.0, 12129.090318226168, 12143.878561214451, 12145.14983951115, 12145.514179432723, 19497.972485508813, 19516.3351705407, 19562.141596548307, 19566.758881043577, 19567.608647826964, 7351.558906465629, 7356.301151390609, 7356.372375133027, 7513.2111128331835, 7578.658960346797, 936.9765755856022, 974.9366291191192, 1018.6129270877168, 1047.9318844275099, 1085.8696956365286, 32375.0, 32703.836480817445, 32816.50775238373, 32869.0, 33092.503612445835, 1052.5631862777016, 1079.2607064161075, 1096.2983690438125, 1128.7178205448638, 1187.0800129899396, 16131.481398776275, 16975.0, 17138.40015599448, 17296.654066918592, 17385.0, 611606.0, 617032.0, 617684.0, 618760.0, 621608.0, 60488.697556511936, 60570.394296057355, 61020.38979610147, 61095.38904610897, 61202.69398652978, 1215.4105258949403, 1299.9220046797222, 1322.1141834970592, 1328.0968941120132, 1332.7467781121557, 31267.84366078246, 33309.33381332408, 34378.0, 34448.31103377968, 34635.0, 52074.47925520696, 56460.71769641126, 58336.4166358331, 58433.4156658428, 63833.3616663846, 538666.0, 546335.0, 546487.0, 547115.0, 547750.0, 37002.814985924895, 42613.57386426096, 43039.56960430356, 43905.56094439015, 45703.77148114238, 48844.75577622089, 49397.75301123615, 49482.0, 49516.75241623769, 49756.253656194465, 41203.025561294045, 41962.580374195866, 42794.35808462938, 43949.12101758011, 44462.0, 42194.78902605467, 42403.363949540166, 42461.363079553215, 42636.360454592585, 44555.331670025625, 42443.787781062136, 42800.78599606982, 43009.784951075046, 43132.137357253305, 43406.56593434025, 36070.27859442849, 37228.83554897864, 37949.430758539194, 38054.619453805106, 38794.418083728204, 28248.71751282543, 28313.0, 28586.85706571454, 28876.27809304784, 28983.420331592828], "value": 20889.064080524102, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.9588347340055, 367.1500476397139, 379.30397720183464, 385.27760449157836, 401.92966230909605, 18397.902593508552, 20237.494062648442, 20381.694274585894, 20651.0, 20774.610919744235, 17174.055426951512, 17317.480475585722, 17556.209970551325, 17584.296628134893, 17853.821461785377, 5636.689982050985, 5695.0887857942635, 5904.88190236195, 5911.586188966774, 5912.704364781765, 5699.202111704365, 5712.371639119693, 5748.568857335696, 5755.0504166812425, 5784.855378615547, 5526.364468086182, 5723.570732195081, 5723.742431590567, 5732.283464566929, 5770.105633626795, 5689.402612725667, 5716.942830571683, 5757.280339957526, 5758.74085666146, 5765.2216950711745, 5024.497550244982, 5082.415522214956, 5115.053715062725, 5118.25785261135, 5134.589232861362, 23741.0, 23955.640665390034, 24063.27810165698, 24099.87950060256, 24149.637755433683, 2232.151782322707, 2246.48330883896, 2257.5033492631596, 2271.284545368204, 2331.708536432946, 14181.645458863508, 14820.481283155146, 14943.0, 15060.246987650684, 15343.846561534354, 1904.419152158591, 1946.2020571565731, 1974.7037944308468, 2015.1032790408274, 2044.7118315461164, 76167.61916190383, 76323.6183819083, 76672.23327766707, 78012.0, 81228.59385703092, 9785.755356116011, 9799.412035277906, 9913.306068575275, 10244.772896537566, 10409.219308551888, 13802.894348771446, 13839.446422143, 13849.238291894042, 13871.306434678427, 13880.930595347161, 7575.772726818204, 7615.657295421719, 7833.255840695125, 7852.254035866584, 7878.330341920886, 7389.963050184715, 7476.364509016795, 7524.473286869976, 7681.193474685189, 7697.692092316244, 6373.776917807854, 6451.677416129175, 6465.288818229991, 6471.126397936312, 6660.9000864987065, 1755.2276998121042, 1804.7924488683707, 1808.52074200337, 1811.963760724778, 1816.554944038719, 1015.8984101589782, 1043.337480699761, 1049.92125590581, 1072.447689439939, 1081.9134469242442, 19716.0, 20385.388438346872, 20515.076821543065, 20585.89707051455, 20620.875824835093, 968.5060619084177, 985.8373368394278, 1002.659095907395, 1055.9102476289602, 1084.8969347911936, 10593.364398136137, 11228.438578071064, 11435.656930292105, 11442.94278528602, 11700.29798212093, 385313.0, 385398.0, 386446.0, 495527.0, 498861.0, 101565.0, 105665.47167264114, 105924.47037764762, 106935.46532267444, 108642.0, 985.3102828020271, 996.1869397696269, 1017.0, 1045.5033858916954, 1048.1352883870836, 17233.91383043127, 17745.201465934322, 18382.172802223664, 18410.631787364444, 18474.261029558667, 41632.583674162874, 42364.576354236066, 42759.57240427556, 42794.35808462938, 42932.570674294104, 59974.0, 60196.0, 60685.39314606974, 61120.38879611325, 62662.0, 8387.32901367877, 8390.706325278587, 8724.996625387908, 8791.208791208823, 8816.779580510538, 13184.60446186616, 13306.667333316744, 13340.930446430295, 13649.522266720616, 13683.179009259477, 11566.42167891619, 11719.0, 12023.519059237882, 12026.939865300617, 12067.75864482723, 11558.248713833575, 11589.594364197214, 11789.351585662871, 11832.230904991147, 12130.75738485243, 11964.162508624313, 12027.939860300643, 12338.409072884433, 12563.560275390317, 12691.682707932376, 8390.61554843444, 8444.408891377545, 8708.085651006553, 8792.252658523841, 8821.558922053744, 11346.319220846775, 11644.184907056764, 11672.591459298883, 11763.705907352385, 11896.464659090534], "value": 9364.504814639984, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.6849724563356, 1456.8834493240543, 1502.8422015688352, 1614.7820044294017, 1747.9388221412253, 8338.91661083389, 8831.0, 8867.379283450153, 9130.315226358016, 9149.085091490848, 8919.0, 9030.819383612325, 9035.503047332393, 9036.277097832173, 9045.3668243223, 2347.8121750260025, 2366.893489792955, 2371.5494056129364, 2374.465745207332, 2375.9881200593973, 2351.6002279612508, 2382.916597919073, 2388.4745356021735, 2406.5186962607463, 2407.181558270188, 2290.919817806377, 2324.4886125052544, 2332.0, 2397.5924092904247, 2400.0279886645935, 2217.7227846519186, 2247.6965609642652, 2254.222293308798, 2259.2431535435567, 2334.2763743239652, 2261.898214580348, 2273.2498275569187, 2276.7723227677266, 2277.52172043871, 2277.9658305125436, 8696.521691307038, 8939.463632182025, 9012.0, 9032.09679032098, 9061.365704400694, 4909.993451342466, 5090.567301779316, 5101.15830887903, 5102.387713474407, 5103.23451482277, 3168.0, 3305.4215512285255, 3345.2138747394342, 3367.191873950259, 3380.881669141568, 1165.8251262310637, 1198.72429341252, 1203.4343858386544, 1209.6975756060986, 1225.5894275417745, 12400.751984960341, 12410.689732756662, 12526.68683282916, 12545.31000794956, 12558.183718058388, 4164.875053748392, 4326.134773045404, 4439.7336159829865, 4484.618807401343, 4526.23054080807, 9804.509774511245, 9817.460039697886, 9829.115379615869, 9842.80314393708, 9847.45838978863, 5052.7726252318735, 5103.260027296022, 5105.412877519058, 5107.770150343244, 5114.514121158484, 4295.78521073945, 4692.131955588227, 4781.043791241766, 4863.878403039882, 4902.852914412573, 3724.1062145085525, 3795.3737633290198, 3810.9618903810606, 3869.129445874712, 3891.494105766232, 1083.6207327435334, 1089.3082892363248, 1095.134843473647, 1095.8301463273206, 1101.9889801102047, 973.7614284500343, 977.5112443778111, 995.0099650847453, 996.7358649957768, 1014.7361685961555, 5689.317281926113, 5735.283089613798, 5871.765129394862, 5968.7015649217365, 5994.100884867217, 487.1961263914569, 490.6687985609699, 495.4846959162431, 500.4070176840383, 501.5586284069995, 3905.453236546886, 3999.280129576704, 4026.1545075534464, 4026.295398305285, 4028.315186418316, 10897.564097436172, 11400.372979486043, 11407.0, 11408.087353011739, 11424.885751142549, 11119.166062545342, 11212.439378031066, 11220.719482013015, 11248.831267530994, 11282.717932051764, 7909.644066017043, 8303.875441868377, 8319.126491718403, 8373.0, 8384.706535271236, 5948.470514347862, 6054.485368743706, 6057.57596968208, 6071.483923866521, 6203.96898015507, 9970.451625160396, 10006.399616023062, 10037.0, 10160.949195254272, 10196.949015254877, 9924.751881203028, 9955.701328960144, 10158.644447444303, 10178.49107544605, 10270.07569318765, 7156.677949492181, 7372.778816635509, 7376.299251571092, 7713.537187768752, 7951.84096318082, 8191.180881911761, 8465.873011904949, 8616.569171541523, 8743.081976392641, 8932.017478077536, 7686.500377475446, 7828.530288182727, 7930.286274235346, 7947.483413578099, 8087.797805054921, 7666.118396384487, 7856.764297071097, 7887.802804929923, 7907.9604601976625, 7987.400944929037, 7109.28907109285, 7173.748918787817, 7195.064641596559, 7198.380364417964, 7200.7479738211005, 5127.974360128324, 5166.483351664803, 5167.173252279767, 5209.374875014871, 5417.674939503642, 5119.590432765295, 5223.425423203521, 5229.895402092013, 5237.580993520433, 5414.404415514369], "value": 4547.406586413678, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.65573901491297, 314.1345592891584, 322.56775920266836, 322.58708852668593, 324.7531875774412, 5188.2995795567585, 5246.606504512162, 5252.553532949699, 5260.736963151837, 5302.787888484466, 4918.311436398898, 4935.605151587864, 5077.746112694369, 5104.8979020419565, 5185.170372740362, 4067.2068946555432, 4096.303628383167, 4099.118689481761, 4106.527749308823, 4108.938365924513, 4086.6730661547153, 4104.220198162355, 4107.79461026949, 4114.321137012389, 4118.5057793064725, 3871.6128387161198, 3876.573576906538, 4056.655184309337, 4062.1266427718033, 4069.69477289203, 4045.615666511677, 4049.473568436114, 4056.1076563156057, 4059.6143366380147, 4066.7966601669946, 3584.4981702561663, 3592.8742494012586, 3593.6226696197045, 3597.812721801799, 3599.7300202484917, 4776.235802271654, 5036.496350364971, 5052.46949070346, 5071.239314102877, 5072.148665737016, 4555.931661025087, 4558.977205113986, 4573.131105090022, 4573.164637924475, 4578.587927086545, 5379.220013098118, 5380.0, 5392.191171324333, 5404.83785486436, 5420.186971954199, 3718.3864662330684, 3811.6177389131794, 3829.9808500957597, 3836.4270649034042, 3840.0, 5500.917486237709, 5552.361478429952, 5557.472040156179, 5560.888782224373, 5590.692511911843, 3947.486826712509, 3951.644352008333, 3953.4069889516227, 3961.2473630010204, 3973.1854969731135, 3995.300822356076, 4006.8397264109108, 4007.757595145514, 4021.6983726220064, 4023.893429306964, 4425.822967081345, 4582.2668373060815, 4587.3348364486965, 4591.540845915381, 4596.49438561758, 5357.249985002103, 5374.113271310268, 5390.595705322116, 5392.514673679309, 5408.675479471244, 1373.32020649779, 1380.2822532283358, 1384.6884450998446, 1385.1273697570466, 1387.8126452928725, 837.3970741066422, 859.2138193552954, 945.1210374351919, 946.5125460387906, 949.1742184299566, 5153.330067091254, 5170.948290517122, 5177.508136727005, 5218.139007063868, 5224.059669259494, 5457.799284157479, 5497.36780270274, 5500.7524661390335, 5514.696691681996, 5519.503244707996, 5032.220005899091, 5199.648091496162, 5205.817796377109, 5303.814366497231, 5317.8404647860625, 2922.3570814420796, 2944.528875379929, 2947.1600593831085, 2947.9410411791646, 2955.2611847038243, 5581.4976652100695, 5748.482636562646, 5759.596828221985, 5780.739866706008, 5790.739416726257, 5626.299376299317, 5640.238567793377, 5669.262995810518, 5714.228579141846, 5716.1997320375185, 5764.596478246483, 5775.5090817281, 5802.4197580241635, 5806.76772929095, 5814.389489103753, 5378.354597448331, 5483.917741233964, 5499.367572729027, 5608.9158662619275, 5625.718714064362, 5401.270828438268, 5403.4326395727885, 5482.23248745184, 5495.82914748664, 5501.477359650827, 5691.345495268097, 5738.885222295614, 5756.827295181151, 5766.538676905921, 5775.0, 3863.8987888451657, 3922.9215415692097, 3957.5250969882645, 3962.1679447316387, 3987.2424239394422, 5273.235380869675, 5389.137737961907, 5464.644798088111, 5487.695168029517, 5519.31008623922, 5386.218998245311, 5387.662931340309, 5427.674339539641, 5455.1271796512365, 5465.426130256265, 5217.973910130577, 5398.54366263357, 5402.59480538969, 5439.3200849893765, 5447.809326673548, 5297.066570701743, 5335.559398962181, 5344.812931547377, 5348.545373643284, 5357.892842143057, 5415.864603384947, 5450.345958484849, 5455.754491047833, 5496.6701997880255, 5502.477264659851, 5214.634975551675, 5297.735113244399, 5335.866603334947, 5379.973100134474, 5387.973060134831], "value": 4126.721705198669, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.9601821899797, 734.9853002939941, 765.4144579396763, 777.7666699990009, 860.0281681699679, 14373.568792936203, 14642.853571464282, 14973.775393369107, 15073.698526029473, 15079.472218472341, 14491.782623260633, 14648.780268295957, 14760.926195369007, 14765.18791466469, 14771.482998095069, 817.0358976407852, 822.7572866004513, 829.5852073963018, 830.4685001598981, 832.7543374704477, 666.070831190489, 799.1768478467188, 824.9422540422142, 827.0447632983913, 836.067784420373, 868.7046404222563, 869.3088994249555, 870.4168207301092, 870.4211699220011, 871.1854416120947, 865.9523726195057, 867.0289276010908, 867.8047439326195, 867.9522626255554, 868.5006121480111, 512.7333786431072, 616.7563812294119, 629.1789215074326, 630.4893036640336, 632.1655414852397, 13416.86583134166, 13422.0, 13439.462421503129, 13445.529406470727, 13447.327633618377, 14029.719405611831, 14475.493357732534, 14516.637084072878, 14654.413823447156, 14742.852571474363, 13237.338133093403, 13405.0, 13407.597772066756, 13432.19406835593, 13671.794923076062, 3839.4432807243074, 3900.4929359183125, 4561.589456948857, 4635.884102897455, 4714.151452738506, 76984.0, 77430.22569774343, 77845.61077194578, 78267.99999999943, 78279.0, 11692.590759323382, 11773.88226117745, 11904.940475297568, 11908.523659053713, 11973.700657483458, 22132.557348852934, 22191.66712499314, 22199.667004994615, 22329.776702233095, 22358.329250122522, 9012.56660701607, 9067.410618309788, 9185.311101667401, 9195.90804091964, 9219.262459003263, 4990.90018199634, 5020.0, 5090.745462726849, 5153.561947234527, 5205.9219111713355, 3571.928561428757, 3683.9447408288897, 3722.641235948859, 3724.5158129443, 3726.124360775216, 616.6269407008696, 620.2433031701318, 621.1335187413533, 621.8227805075622, 630.5239544144142, 678.0879716780922, 680.5610381304031, 689.9517033807685, 716.9749058782918, 734.717133903451, 9727.686607726084, 9816.950915245377, 10261.460338301902, 10583.990778305058, 10753.83869241962, 727.5759215051776, 736.1166600079926, 764.323573637335, 764.4075841223097, 766.6626684258908, 5005.624578156653, 5101.387833460009, 5186.481351864783, 5232.843014709565, 5233.842984710464, 111332.88667113388, 122846.0, 125390.0, 130483.0, 134679.32660336635, 106166.0, 107547.0, 108461.0, 109486.0, 110727.0, 96423.5894102639, 96778.51610742042, 98084.50957745308, 98730.0, 99164.0, 9715.36850104741, 9728.659496917573, 9985.0, 9985.700428987142, 9987.101160895554, 48859.0, 51228.48771512237, 53886.730566346916, 55788.16317755318, 56093.719531403716, 53920.0, 55937.48281327431, 61448.078278824956, 63437.682811587496, 72214.91677624735, 13487.190768553919, 14036.578902632937, 14362.281885905453, 14759.92620036893, 14875.47935822241, 14661.853381466475, 15781.0, 16108.405294768298, 16473.67052658964, 17657.735133973256, 14090.36593353281, 14949.775753363925, 14973.587162363938, 15511.84488155104, 16161.075952500878, 15336.15651139198, 15349.462768803038, 15837.366505339658, 15947.0, 16327.510174694778, 14391.208483533506, 14439.92780036093, 14683.706325873636, 14849.92575037161, 15818.525444236691, 12022.27866328023, 12024.699382515508, 12108.551171915886, 12500.874991249972, 12529.436175372313, 11979.460924258256, 12058.336791476202, 12724.363781811058, 12776.169548979287, 13021.609351719464], "value": 7877.117298940401, "unit": "score"}], "name": "dromaeo_css", "value": 7298.5283455845965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 111.0, 111.0, 111.0, 113.0, 112.0, 113.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 122.0, 188.0, 124.0, 125.0, 143.0, 118.0, 157.0, 122.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 163.0, 160.0, 162.0, 161.0, 159.0, 162.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 105.0, 75.0, 76.0, 75.0, 74.0, 105.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 119.0, 86.0, 85.0, 85.0, 122.0, 85.0, 85.0, 136.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 51.0, 56.0, 52.0, 52.0, 50.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 84.0, 78.0, 79.0, 79.0, 77.0, 91.0, 77.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 148.0, 130.0, 122.0, 124.0, 126.0, 126.0, 140.0, 126.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 170.0, 165.0, 163.0, 162.0, 168.0, 175.0, 167.0, 164.0, 159.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 65.0, 64.0, 63.0, 63.0, 63.0, 64.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1496.2, "alertThreshold": 2.0}]} 11:51:45 INFO - Return code: 0 11:51:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:51:45 INFO - # TBPL SUCCESS # 11:51:45 INFO - Running post-action listener: _resource_record_post_action 11:51:45 INFO - [mozharness: 2016-08-19 18:51:45.480619Z] Finished run-tests step (success) 11:51:45 INFO - Running post-run listener: _resource_record_post_run 11:51:45 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 415715328; Read time: 0; Write time: 488404 11:51:45 INFO - TinderboxPrint: CPU usage
13.0% 11:51:45 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:51:45 INFO - TinderboxPrint: I/O write bytes / time
415,715,328 / 488,404 11:51:45 INFO - TinderboxPrint: CPU idle
8,285.3 (87.0%) 11:51:45 INFO - TinderboxPrint: CPU user
1,187.3 (12.5%) 11:51:45 INFO - TinderboxPrint: Swap in / out
0 / 0 11:51:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 127184896; Read time: 0; Write time: 147496 11:51:45 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288198656; Read time: 0; Write time: 340904 11:51:46 INFO - Running post-run listener: _upload_blobber_files 11:51:46 INFO - Blob upload gear active. 11:51:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:51:46 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:47 INFO - (blobuploader) - INFO - Done attempting. 11:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:51 INFO - (blobuploader) - INFO - Done attempting. 11:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:52 INFO - (blobuploader) - INFO - Done attempting. 11:51:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:51:52 INFO - Return code: 0 11:51:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:51:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:51:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15def9fbdaf808fde55e57506e2a6b48c743e8676eba0db28a570a5a7427ea12662bc66bbb010690dd74af20fa36f2d7cb82ed5f55fa799a7f1c3747f295d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e9adf10aa652aac843e3ef9ec9be3e2d131113b46dcc981d5f7192ff953102b4071b7eaeac567434bf69b40e3c6a5c488312caaf50d8df02e3ce707d7f94130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c432d8eb18d0de802f8d310636c89f6e608a8d63c86b5fee166eb1cad552e70351d2517ca04c3549cc9631df736f44ebf10310430709d41582bd2ecfcd4fa192"} 11:51:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:51:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:51:52 INFO - Contents: 11:51:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15def9fbdaf808fde55e57506e2a6b48c743e8676eba0db28a570a5a7427ea12662bc66bbb010690dd74af20fa36f2d7cb82ed5f55fa799a7f1c3747f295d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e9adf10aa652aac843e3ef9ec9be3e2d131113b46dcc981d5f7192ff953102b4071b7eaeac567434bf69b40e3c6a5c488312caaf50d8df02e3ce707d7f94130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c432d8eb18d0de802f8d310636c89f6e608a8d63c86b5fee166eb1cad552e70351d2517ca04c3549cc9631df736f44ebf10310430709d41582bd2ecfcd4fa192"} 11:51:52 INFO - Running post-run listener: copy_logs_to_upload_dir 11:51:52 INFO - Copying logs to upload dir... 11:51:52 INFO - mkdir: /builds/slave/test/build/upload/logs 11:51:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.434393 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-19 11:51:52.521568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:51:52.525585) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15def9fbdaf808fde55e57506e2a6b48c743e8676eba0db28a570a5a7427ea12662bc66bbb010690dd74af20fa36f2d7cb82ed5f55fa799a7f1c3747f295d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e9adf10aa652aac843e3ef9ec9be3e2d131113b46dcc981d5f7192ff953102b4071b7eaeac567434bf69b40e3c6a5c488312caaf50d8df02e3ce707d7f94130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c432d8eb18d0de802f8d310636c89f6e608a8d63c86b5fee166eb1cad552e70351d2517ca04c3549cc9631df736f44ebf10310430709d41582bd2ecfcd4fa192"} build_url:https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/PJCbIsgQQ2WDWjqQujnzxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15def9fbdaf808fde55e57506e2a6b48c743e8676eba0db28a570a5a7427ea12662bc66bbb010690dd74af20fa36f2d7cb82ed5f55fa799a7f1c3747f295d840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e9adf10aa652aac843e3ef9ec9be3e2d131113b46dcc981d5f7192ff953102b4071b7eaeac567434bf69b40e3c6a5c488312caaf50d8df02e3ce707d7f94130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c432d8eb18d0de802f8d310636c89f6e608a8d63c86b5fee166eb1cad552e70351d2517ca04c3549cc9631df736f44ebf10310430709d41582bd2ecfcd4fa192"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:51:52.558122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:51:52.558673) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1471631472.488501-174857034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:51:52.647631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:51:52.648020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:51:52.648428) ========= ========= Total master_lag: 0.17 =========