builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1471300773.91 results: success (0) buildid: 20160815113001 builduid: 7c7fd4f8f8c84f6ab6ae85d40126e6f4 revision: 59055929012280084afd040bfdf4216083a7636a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:33.912790) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:33.913261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:33.913550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.022218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.022621) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 15:39:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-08-15 15:39:35 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120491 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.157233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.157608) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.208374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.208910) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 59055929012280084afd040bfdf4216083a7636a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 59055929012280084afd040bfdf4216083a7636a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 15:39:35,288 truncating revision to first 12 chars 2016-08-15 15:39:35,288 Setting DEBUG logging. 2016-08-15 15:39:35,289 attempt 1/10 2016-08-15 15:39:35,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/590559290122?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 15:39:35,606 unpacking tar archive at: fx-team-590559290122/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663635 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.887637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.887942) ========= script_repo_revision: 59055929012280084afd040bfdf4216083a7636a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.888397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.888671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 15:39:34.898059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-15 15:39:34.898396) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:36 INFO - MultiFileLogger online at 20160815 15:39:36 in /builds/slave/test 15:39:36 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 15:39:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:36 INFO - {'append_to_log': False, 15:39:36 INFO - 'base_work_dir': '/builds/slave/test', 15:39:36 INFO - 'blob_upload_branch': 'Fx-Team', 15:39:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:36 INFO - 'branch': 'Fx-Team', 15:39:36 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:36 INFO - 'config_files': ('talos/linux_config.py',), 15:39:36 INFO - 'default_actions': ('clobber', 15:39:36 INFO - 'read-buildbot-config', 15:39:36 INFO - 'download-and-extract', 15:39:36 INFO - 'populate-webroot', 15:39:36 INFO - 'create-virtualenv', 15:39:36 INFO - 'install', 15:39:36 INFO - 'run-tests'), 15:39:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:36 INFO - 'download_minidump_stackwalk': True, 15:39:36 INFO - 'download_symbols': 'ondemand', 15:39:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:36 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:36 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:36 INFO - 'installer_path': 'installer.exe', 15:39:36 INFO - 'log_level': 'info', 15:39:36 INFO - 'log_name': 'talos', 15:39:36 INFO - 'log_to_console': True, 15:39:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:36 INFO - 'opt_config_files': (), 15:39:36 INFO - 'pip_index': False, 15:39:36 INFO - 'sps_profile': False, 15:39:36 INFO - 'sps_profile_interval': 0, 15:39:36 INFO - 'suite': 'dromaeojs', 15:39:36 INFO - 'system_bits': '32', 15:39:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:36 INFO - 'title': 'talos-linux64-ix-068', 15:39:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:36 INFO - 'use_talos_json': True, 15:39:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:36 INFO - 'work_dir': 'build'} 15:39:36 INFO - [mozharness: 2016-08-15 22:39:36.072760Z] Running clobber step. 15:39:36 INFO - Running pre-action listener: _resource_record_pre_action 15:39:36 INFO - Running main action method: clobber 15:39:36 INFO - rmtree: /builds/slave/test/build 15:39:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:36 INFO - Running post-action listener: _resource_record_post_action 15:39:36 INFO - [mozharness: 2016-08-15 22:39:36.538580Z] Finished clobber step (success) 15:39:36 INFO - [mozharness: 2016-08-15 22:39:36.538682Z] Running read-buildbot-config step. 15:39:36 INFO - Running pre-action listener: _resource_record_pre_action 15:39:36 INFO - Running main action method: read_buildbot_config 15:39:36 INFO - Using buildbot properties: 15:39:36 INFO - { 15:39:36 INFO - "project": "", 15:39:36 INFO - "product": "firefox", 15:39:36 INFO - "script_repo_revision": "production", 15:39:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:39:36 INFO - "repository": "", 15:39:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:39:36 INFO - "buildid": "20160815113001", 15:39:36 INFO - "pgo_build": "True", 15:39:36 INFO - "basedir": "/builds/slave/test", 15:39:36 INFO - "buildnumber": 1457, 15:39:36 INFO - "slavename": "talos-linux64-ix-068", 15:39:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:39:36 INFO - "platform": "ubuntu64_hw", 15:39:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:39:36 INFO - "branch": "fx-team", 15:39:36 INFO - "repo_path": "integration/fx-team", 15:39:36 INFO - "revision": "59055929012280084afd040bfdf4216083a7636a", 15:39:36 INFO - "stage_platform": "linux64-pgo", 15:39:36 INFO - "builduid": "7c7fd4f8f8c84f6ab6ae85d40126e6f4", 15:39:36 INFO - "slavebuilddir": "test" 15:39:36 INFO - } 15:39:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:39:36 INFO - Running post-action listener: _resource_record_post_action 15:39:36 INFO - [mozharness: 2016-08-15 22:39:36.541133Z] Finished read-buildbot-config step (success) 15:39:36 INFO - [mozharness: 2016-08-15 22:39:36.541221Z] Running download-and-extract step. 15:39:36 INFO - Running pre-action listener: _resource_record_pre_action 15:39:36 INFO - Running main action method: download_and_extract 15:39:36 INFO - mkdir: /builds/slave/test/build/tests 15:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:36 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:39:36 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:39:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:39:37 INFO - Downloaded 1361 bytes. 15:39:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:39:37 INFO - Using the following test package requirements: 15:39:37 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:39:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:39:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'jsshell-linux-x86_64.zip'], 15:39:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:39:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:39:37 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:39:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:39:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:39:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:39:37 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')]} 15:39:37 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:37 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:39:38 INFO - Downloaded 21836062 bytes. 15:39:38 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 15:39:42 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 15:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:42 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:42 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:39:43 INFO - Downloaded 21836062 bytes. 15:39:43 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 15:39: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')]} 15:39:47 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:47 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:39:48 INFO - Downloaded 14413719 bytes. 15:39:48 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 15:39:48 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')]} 15:39:48 INFO - trying https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:48 INFO - Downloading https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:39:50 INFO - Downloaded 59412184 bytes. 15:39:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:50 INFO - mkdir: /builds/slave/test/properties 15:39:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:50 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:50 INFO - Contents: 15:39:50 INFO - build_url:https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:50 INFO - Running post-action listener: _resource_record_post_action 15:39:50 INFO - Running post-action listener: set_extra_try_arguments 15:39:50 INFO - [mozharness: 2016-08-15 22:39:50.786406Z] Finished download-and-extract step (success) 15:39:50 INFO - [mozharness: 2016-08-15 22:39:50.786630Z] Running populate-webroot step. 15:39:50 INFO - Running pre-action listener: _resource_record_pre_action 15:39:50 INFO - Running main action method: populate_webroot 15:39:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:50 INFO - '--tppagecycles', 15:39:50 INFO - '7'], 15:39:50 INFO - 'tests': ['tsvgm']}}, 15:39:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['damp', 'tps']}, 15:39:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'tests': ['damp', 'tps']}, 15:39:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['dromaeo_dom']}, 15:39:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['basic_compositor_video']}, 15:39:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:39:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['a11yr', 15:39:50 INFO - 'ts_paint', 15:39:50 INFO - 'tpaint', 15:39:50 INFO - 'sessionrestore', 15:39:50 INFO - 'sessionrestore_no_auto_restore', 15:39:50 INFO - 'tabpaint']}, 15:39:50 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:50 INFO - 'ts_paint', 15:39:50 INFO - 'tpaint', 15:39:50 INFO - 'sessionrestore', 15:39:50 INFO - 'sessionrestore_no_auto_restore', 15:39:50 INFO - 'tabpaint']}, 15:39:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:39:50 INFO - 'ts_paint', 15:39:50 INFO - 'tpaint', 15:39:50 INFO - 'sessionrestore', 15:39:50 INFO - 'sessionrestore_no_auto_restore', 15:39:50 INFO - 'tabpaint']}, 15:39:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:39:50 INFO - 'ts_paint', 15:39:50 INFO - 'tpaint', 15:39:50 INFO - 'sessionrestore', 15:39:50 INFO - 'sessionrestore_no_auto_restore', 15:39:50 INFO - 'tabpaint']}, 15:39:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['a11yr', 15:39:50 INFO - 'ts_paint', 15:39:50 INFO - 'tpaint', 15:39:50 INFO - 'sessionrestore', 15:39:50 INFO - 'sessionrestore_no_auto_restore', 15:39:50 INFO - 'tabpaint']}, 15:39:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['a11yr', 15:39:50 INFO - 'ts_paint', 15:39:50 INFO - 'tpaint', 15:39:50 INFO - 'sessionrestore', 15:39:50 INFO - 'sessionrestore_no_auto_restore', 15:39:50 INFO - 'tabpaint']}, 15:39:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['tsvgx', 15:39:50 INFO - 'tsvgr_opacity', 15:39:50 INFO - 'tart', 15:39:50 INFO - 'tscrollx', 15:39:50 INFO - 'cart']}, 15:39:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:50 INFO - 'tsvgr_opacity', 15:39:50 INFO - 'tart', 15:39:50 INFO - 'tscrollx', 15:39:50 INFO - 'cart']}, 15:39:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'talos_options': ['--disable-e10s'], 15:39:50 INFO - 'tests': ['tp5o']}, 15:39:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'tests': ['tp5o']}, 15:39:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'talos_options': ['--disable-e10s', 15:39:50 INFO - '--xperf_path', 15:39:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:50 INFO - 'tests': ['tp5n']}, 15:39:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:50 INFO - 'talos_options': ['--xperf_path', 15:39:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:50 INFO - 'tests': ['tp5n']}}, 15:39:50 INFO - 'talos.zip': {'path': '', 15:39:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:50 INFO - Running post-action listener: _resource_record_post_action 15:39:50 INFO - [mozharness: 2016-08-15 22:39:50.805738Z] Finished populate-webroot step (success) 15:39:50 INFO - [mozharness: 2016-08-15 22:39:50.805825Z] Running create-virtualenv step. 15:39:50 INFO - Running pre-action listener: _resource_record_pre_action 15:39:50 INFO - Running main action method: create_virtualenv 15:39:50 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:50 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 15:39:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:50 INFO - Using real prefix '/usr' 15:39:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:53 INFO - Installing pip.................done. 15:39:53 INFO - Return code: 0 15:39:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:53 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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:39:53 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 15:39:53 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 15:39:53 INFO - Using env: {'DISPLAY': ':0', 15:39:53 INFO - 'HOME': '/home/cltbld', 15:39:53 INFO - 'LANG': 'en_US.UTF-8', 15:39:53 INFO - 'LANGUAGE': 'en_US:en', 15:39:53 INFO - 'LOGNAME': 'cltbld', 15:39:53 INFO - 'MAIL': '/var/mail/cltbld', 15:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:53 INFO - 'MOZ_NO_REMOTE': '1', 15:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:53 INFO - 'NO_EM_RESTART': '1', 15:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:53 INFO - 'PWD': '/builds/slave/test', 15:39:53 INFO - 'SHELL': '/bin/bash', 15:39:53 INFO - 'SHLVL': '1', 15:39:53 INFO - 'TERM': 'linux', 15:39:53 INFO - 'TMOUT': '86400', 15:39:53 INFO - 'USER': 'cltbld', 15:39:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:53 INFO - '_': '/tools/buildbot/bin/python'} 15:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:53 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 15:39:53 INFO - Cleaning up... 15:39:53 INFO - Return code: 0 15:39:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:53 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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:39:53 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 15:39:53 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 15:39:53 INFO - Using env: {'DISPLAY': ':0', 15:39:53 INFO - 'HOME': '/home/cltbld', 15:39:53 INFO - 'LANG': 'en_US.UTF-8', 15:39:53 INFO - 'LANGUAGE': 'en_US:en', 15:39:53 INFO - 'LOGNAME': 'cltbld', 15:39:53 INFO - 'MAIL': '/var/mail/cltbld', 15:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:53 INFO - 'MOZ_NO_REMOTE': '1', 15:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:53 INFO - 'NO_EM_RESTART': '1', 15:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:53 INFO - 'PWD': '/builds/slave/test', 15:39:53 INFO - 'SHELL': '/bin/bash', 15:39:53 INFO - 'SHLVL': '1', 15:39:53 INFO - 'TERM': 'linux', 15:39:53 INFO - 'TMOUT': '86400', 15:39:53 INFO - 'USER': 'cltbld', 15:39:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:53 INFO - '_': '/tools/buildbot/bin/python'} 15:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:53 INFO - Downloading/unpacking psutil>=3.1.1 15:39:53 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 15:39:53 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 15:39:53 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 15:39:53 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 15:39:53 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 15:39:53 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 15:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:55 INFO - Installing collected packages: psutil 15:39:55 INFO - Running setup.py install for psutil 15:39:55 INFO - building 'psutil._psutil_linux' extension 15:39:55 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 15:39:56 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 15:39:56 INFO - building 'psutil._psutil_posix' extension 15:39:56 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 15:39:56 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 15:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:56 INFO - Successfully installed psutil 15:39:56 INFO - Cleaning up... 15:39:56 INFO - Return code: 0 15:39:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:39:56 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')]} 15:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:56 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')]} 15:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:56 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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:39:56 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 15:39:56 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 15:39:56 INFO - Using env: {'DISPLAY': ':0', 15:39:56 INFO - 'HOME': '/home/cltbld', 15:39:56 INFO - 'LANG': 'en_US.UTF-8', 15:39:56 INFO - 'LANGUAGE': 'en_US:en', 15:39:56 INFO - 'LOGNAME': 'cltbld', 15:39:56 INFO - 'MAIL': '/var/mail/cltbld', 15:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:56 INFO - 'MOZ_NO_REMOTE': '1', 15:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:56 INFO - 'NO_EM_RESTART': '1', 15:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:56 INFO - 'PWD': '/builds/slave/test', 15:39:56 INFO - 'SHELL': '/bin/bash', 15:39:56 INFO - 'SHLVL': '1', 15:39:56 INFO - 'TERM': 'linux', 15:39:56 INFO - 'TMOUT': '86400', 15:39:56 INFO - 'USER': 'cltbld', 15:39:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:56 INFO - '_': '/tools/buildbot/bin/python'} 15:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:39:56 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 15:39:56 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 15:39:56 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 15:39:56 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 15:39:56 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 15:39:56 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 15:39:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:39:58 INFO - Installing collected packages: mozsystemmonitor 15:39:58 INFO - Running setup.py install for mozsystemmonitor 15:39:58 INFO - Successfully installed mozsystemmonitor 15:39:58 INFO - Cleaning up... 15:39:58 INFO - Return code: 0 15:39:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:39:58 INFO - Using env: {'DISPLAY': ':0', 15:39:58 INFO - 'HOME': '/home/cltbld', 15:39:58 INFO - 'LANG': 'en_US.UTF-8', 15:39:58 INFO - 'LANGUAGE': 'en_US:en', 15:39:58 INFO - 'LOGNAME': 'cltbld', 15:39:58 INFO - 'MAIL': '/var/mail/cltbld', 15:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:58 INFO - 'MOZ_NO_REMOTE': '1', 15:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:58 INFO - 'NO_EM_RESTART': '1', 15:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:58 INFO - 'PWD': '/builds/slave/test', 15:39:58 INFO - 'SHELL': '/bin/bash', 15:39:58 INFO - 'SHLVL': '1', 15:39:58 INFO - 'TERM': 'linux', 15:39:58 INFO - 'TMOUT': '86400', 15:39:58 INFO - 'USER': 'cltbld', 15:39:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:58 INFO - '_': '/tools/buildbot/bin/python'} 15:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:58 INFO - Downloading/unpacking jsonschema==2.5.1 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:40:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:40:01 INFO - warning: no files found matching '*.txt' 15:40:01 INFO - no previously-included directories found matching 'build' 15:40:01 INFO - no previously-included directories found matching 'dist' 15:40:01 INFO - no previously-included directories found matching '.git*' 15:40:01 INFO - Installing collected packages: jsonschema, functools32 15:40:01 INFO - Running setup.py install for functools32 15:40:01 INFO - warning: no files found matching '*.txt' 15:40:01 INFO - no previously-included directories found matching 'build' 15:40:01 INFO - no previously-included directories found matching 'dist' 15:40:01 INFO - no previously-included directories found matching '.git*' 15:40:01 INFO - Successfully installed jsonschema functools32 15:40:01 INFO - Cleaning up... 15:40:01 INFO - Return code: 0 15:40:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:40:01 INFO - Using env: {'DISPLAY': ':0', 15:40:01 INFO - 'HOME': '/home/cltbld', 15:40:01 INFO - 'LANG': 'en_US.UTF-8', 15:40:01 INFO - 'LANGUAGE': 'en_US:en', 15:40:01 INFO - 'LOGNAME': 'cltbld', 15:40:01 INFO - 'MAIL': '/var/mail/cltbld', 15:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:01 INFO - 'MOZ_NO_REMOTE': '1', 15:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:01 INFO - 'NO_EM_RESTART': '1', 15:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:01 INFO - 'PWD': '/builds/slave/test', 15:40:01 INFO - 'SHELL': '/bin/bash', 15:40:01 INFO - 'SHLVL': '1', 15:40:01 INFO - 'TERM': 'linux', 15:40:01 INFO - 'TMOUT': '86400', 15:40:01 INFO - 'USER': 'cltbld', 15:40:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:01 INFO - '_': '/tools/buildbot/bin/python'} 15:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:40:01 INFO - Cleaning up... 15:40:01 INFO - Return code: 0 15:40:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:40:01 INFO - Using env: {'DISPLAY': ':0', 15:40:01 INFO - 'HOME': '/home/cltbld', 15:40:01 INFO - 'LANG': 'en_US.UTF-8', 15:40:01 INFO - 'LANGUAGE': 'en_US:en', 15:40:01 INFO - 'LOGNAME': 'cltbld', 15:40:01 INFO - 'MAIL': '/var/mail/cltbld', 15:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:01 INFO - 'MOZ_NO_REMOTE': '1', 15:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:01 INFO - 'NO_EM_RESTART': '1', 15:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:01 INFO - 'PWD': '/builds/slave/test', 15:40:01 INFO - 'SHELL': '/bin/bash', 15:40:01 INFO - 'SHLVL': '1', 15:40:01 INFO - 'TERM': 'linux', 15:40:01 INFO - 'TMOUT': '86400', 15:40:01 INFO - 'USER': 'cltbld', 15:40:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:01 INFO - '_': '/tools/buildbot/bin/python'} 15:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:40:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:40:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:40:04 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 15:40:04 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 15:40:04 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 15:40:04 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 15:40:04 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 15:40:04 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 15:40:04 INFO - Downloading docopt-0.6.1.tar.gz 15:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:04 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:04 INFO - Running setup.py install for blobuploader 15:40:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:04 INFO - Running setup.py install for requests 15:40:04 INFO - Running setup.py install for docopt 15:40:05 INFO - Successfully installed blobuploader requests docopt 15:40:05 INFO - Cleaning up... 15:40:05 INFO - Return code: 0 15:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:05 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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:40:05 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 15:40:05 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 15:40:05 INFO - Using env: {'DISPLAY': ':0', 15:40:05 INFO - 'HOME': '/home/cltbld', 15:40:05 INFO - 'LANG': 'en_US.UTF-8', 15:40:05 INFO - 'LANGUAGE': 'en_US:en', 15:40:05 INFO - 'LOGNAME': 'cltbld', 15:40:05 INFO - 'MAIL': '/var/mail/cltbld', 15:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:05 INFO - 'MOZ_NO_REMOTE': '1', 15:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:05 INFO - 'NO_EM_RESTART': '1', 15:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:05 INFO - 'PWD': '/builds/slave/test', 15:40:05 INFO - 'SHELL': '/bin/bash', 15:40:05 INFO - 'SHLVL': '1', 15:40:05 INFO - 'TERM': 'linux', 15:40:05 INFO - 'TMOUT': '86400', 15:40:05 INFO - 'USER': 'cltbld', 15:40:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:05 INFO - '_': '/tools/buildbot/bin/python'} 15:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:05 INFO - Running setup.py (path:/tmp/pip-4GzaHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:05 INFO - Running setup.py (path:/tmp/pip-ywcWp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:05 INFO - Running setup.py (path:/tmp/pip-9cRnxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:05 INFO - Running setup.py (path:/tmp/pip-_InBdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:05 INFO - Running setup.py (path:/tmp/pip-X0QlYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:05 INFO - Running setup.py (path:/tmp/pip-ulfhhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:05 INFO - Running setup.py (path:/tmp/pip-v2J5g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:05 INFO - Running setup.py (path:/tmp/pip-UVVWlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:05 INFO - Running setup.py (path:/tmp/pip-b9X3zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:06 INFO - Running setup.py (path:/tmp/pip-jxofpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:06 INFO - Running setup.py (path:/tmp/pip-g6ZyYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:06 INFO - Running setup.py (path:/tmp/pip-WMgR9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:06 INFO - Running setup.py (path:/tmp/pip-lymA1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:06 INFO - Running setup.py (path:/tmp/pip-sJUVxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:06 INFO - Running setup.py (path:/tmp/pip-gGXjbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:06 INFO - Running setup.py (path:/tmp/pip-aakt7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:06 INFO - Running setup.py (path:/tmp/pip-Sl6JUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:06 INFO - Running setup.py install for manifestparser 15:40:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:06 INFO - Running setup.py install for mozcrash 15:40:06 INFO - Running setup.py install for mozdebug 15:40:06 INFO - Running setup.py install for mozdevice 15:40:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Running setup.py install for mozfile 15:40:07 INFO - Running setup.py install for mozhttpd 15:40:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Running setup.py install for mozinfo 15:40:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Running setup.py install for mozInstall 15:40:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Running setup.py install for mozleak 15:40:07 INFO - Running setup.py install for mozlog 15:40:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Running setup.py install for moznetwork 15:40:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Running setup.py install for mozprocess 15:40:07 INFO - Running setup.py install for mozprofile 15:40:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:40:07 INFO - Running setup.py install for mozrunner 15:40:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Running setup.py install for mozscreenshot 15:40:08 INFO - Running setup.py install for moztest 15:40:08 INFO - Running setup.py install for mozversion 15:40:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:08 INFO - Cleaning up... 15:40:08 INFO - Return code: 0 15:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:08 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')]} 15:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:08 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')]} 15:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:08 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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:40:08 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 15:40:08 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 15:40:08 INFO - Using env: {'DISPLAY': ':0', 15:40:08 INFO - 'HOME': '/home/cltbld', 15:40:08 INFO - 'LANG': 'en_US.UTF-8', 15:40:08 INFO - 'LANGUAGE': 'en_US:en', 15:40:08 INFO - 'LOGNAME': 'cltbld', 15:40:08 INFO - 'MAIL': '/var/mail/cltbld', 15:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:08 INFO - 'MOZ_NO_REMOTE': '1', 15:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:08 INFO - 'NO_EM_RESTART': '1', 15:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:08 INFO - 'PWD': '/builds/slave/test', 15:40:08 INFO - 'SHELL': '/bin/bash', 15:40:08 INFO - 'SHLVL': '1', 15:40:08 INFO - 'TERM': 'linux', 15:40:08 INFO - 'TMOUT': '86400', 15:40:08 INFO - 'USER': 'cltbld', 15:40:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:08 INFO - '_': '/tools/buildbot/bin/python'} 15:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:08 INFO - Running setup.py (path:/tmp/pip-4vSySS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:08 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)) 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:08 INFO - Running setup.py (path:/tmp/pip-BTbmAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:08 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)) 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:08 INFO - Running setup.py (path:/tmp/pip-17LN0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:08 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)) 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:08 INFO - Running setup.py (path:/tmp/pip-RgtfEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:08 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)) 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:08 INFO - Running setup.py (path:/tmp/pip-EO_8uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:08 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)) 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:08 INFO - Running setup.py (path:/tmp/pip-7oPuAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:09 INFO - Running setup.py (path:/tmp/pip-Jy6sun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:09 INFO - Running setup.py (path:/tmp/pip-JBMTCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:09 INFO - Running setup.py (path:/tmp/pip-TIbQ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:09 INFO - Running setup.py (path:/tmp/pip-cfdUQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:09 INFO - Running setup.py (path:/tmp/pip-dPJvaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:09 INFO - Running setup.py (path:/tmp/pip-SgD1jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:09 INFO - Running setup.py (path:/tmp/pip-TJSx4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:09 INFO - Running setup.py (path:/tmp/pip-93uBFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:09 INFO - Running setup.py (path:/tmp/pip-hqakSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:09 INFO - Running setup.py (path:/tmp/pip-dyyxMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:09 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)) 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:09 INFO - Running setup.py (path:/tmp/pip-RIChuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 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)) 15:40:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:11 INFO - Downloading blessings-1.6.tar.gz 15:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:11 INFO - Installing collected packages: blessings 15:40:11 INFO - Running setup.py install for blessings 15:40:11 INFO - Successfully installed blessings 15:40:11 INFO - Cleaning up... 15:40:11 INFO - Return code: 0 15:40:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:12 INFO - Reading from file tmpfile_stdout 15:40:12 INFO - Current package versions: 15:40:12 INFO - argparse == 1.2.1 15:40:12 INFO - blessings == 1.6 15:40:12 INFO - blobuploader == 1.2.4 15:40:12 INFO - docopt == 0.6.1 15:40:12 INFO - functools32 == 3.2.3-2 15:40:12 INFO - jsonschema == 2.5.1 15:40:12 INFO - manifestparser == 1.1 15:40:12 INFO - mozInstall == 1.12 15:40:12 INFO - mozcrash == 0.17 15:40:12 INFO - mozdebug == 0.1 15:40:12 INFO - mozdevice == 0.48 15:40:12 INFO - mozfile == 1.2 15:40:12 INFO - mozhttpd == 0.7 15:40:12 INFO - mozinfo == 0.9 15:40:12 INFO - mozleak == 0.1 15:40:12 INFO - mozlog == 3.3 15:40:12 INFO - moznetwork == 0.27 15:40:12 INFO - mozprocess == 0.23 15:40:12 INFO - mozprofile == 0.28 15:40:12 INFO - mozrunner == 6.12 15:40:12 INFO - mozscreenshot == 0.1 15:40:12 INFO - mozsystemmonitor == 0.3 15:40:12 INFO - moztest == 0.7 15:40:12 INFO - mozversion == 1.4 15:40:12 INFO - psutil == 3.1.1 15:40:12 INFO - requests == 1.2.3 15:40:12 INFO - wsgiref == 0.1.2 15:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 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 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:40:12 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 15:40:12 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 15:40:12 INFO - Using env: {'DISPLAY': ':0', 15:40:12 INFO - 'HOME': '/home/cltbld', 15:40:12 INFO - 'LANG': 'en_US.UTF-8', 15:40:12 INFO - 'LANGUAGE': 'en_US:en', 15:40:12 INFO - 'LOGNAME': 'cltbld', 15:40:12 INFO - 'MAIL': '/var/mail/cltbld', 15:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:12 INFO - 'MOZ_NO_REMOTE': '1', 15:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:12 INFO - 'NO_EM_RESTART': '1', 15:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:12 INFO - 'PWD': '/builds/slave/test', 15:40:12 INFO - 'SHELL': '/bin/bash', 15:40:12 INFO - 'SHLVL': '1', 15:40:12 INFO - 'TERM': 'linux', 15:40:12 INFO - 'TMOUT': '86400', 15:40:12 INFO - 'USER': 'cltbld', 15:40:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:12 INFO - '_': '/tools/buildbot/bin/python'} 15:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 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)) 15:40:12 INFO - Cleaning up... 15:40:12 INFO - Return code: 0 15:40:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42c059f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19af850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', '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 15:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:40:12 INFO - Using env: {'DISPLAY': ':0', 15:40:12 INFO - 'HOME': '/home/cltbld', 15:40:12 INFO - 'LANG': 'en_US.UTF-8', 15:40:12 INFO - 'LANGUAGE': 'en_US:en', 15:40:12 INFO - 'LOGNAME': 'cltbld', 15:40:12 INFO - 'MAIL': '/var/mail/cltbld', 15:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:12 INFO - 'MOZ_NO_REMOTE': '1', 15:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:12 INFO - 'NO_EM_RESTART': '1', 15:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:12 INFO - 'PWD': '/builds/slave/test', 15:40:12 INFO - 'SHELL': '/bin/bash', 15:40:12 INFO - 'SHLVL': '1', 15:40:12 INFO - 'TERM': 'linux', 15:40:12 INFO - 'TMOUT': '86400', 15:40:12 INFO - 'USER': 'cltbld', 15:40:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:12 INFO - '_': '/tools/buildbot/bin/python'} 15:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:40:12 INFO - Cleaning up... 15:40:12 INFO - Return code: 0 15:40:12 INFO - Running post-action listener: _resource_record_post_action 15:40:12 INFO - Running post-action listener: _start_resource_monitoring 15:40:12 INFO - Starting resource monitoring. 15:40:12 INFO - [mozharness: 2016-08-15 22:40:12.687385Z] Finished create-virtualenv step (success) 15:40:12 INFO - [mozharness: 2016-08-15 22:40:12.687921Z] Running install step. 15:40:12 INFO - Running pre-action listener: _resource_record_pre_action 15:40:12 INFO - Running main action method: install 15:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:12 INFO - Reading from file tmpfile_stdout 15:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:12 INFO - Reading from file tmpfile_stdout 15:40:12 INFO - Output received: 15:40:12 INFO - Usage: mozinstall [options] installer 15:40:12 INFO - Options: 15:40:12 INFO - -h, --help show this help message and exit 15:40:12 INFO - -d DEST, --destination=DEST 15:40:12 INFO - Directory to install application into. [default: 15:40:12 INFO - "/builds/slave/test"] 15:40:12 INFO - --app=APP Application being installed. [default: firefox] 15:40:12 INFO - mkdir: /builds/slave/test/build/application 15:40:12 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'] 15:40:12 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 15:40:29 INFO - Reading from file tmpfile_stdout 15:40:29 INFO - Output received: 15:40:29 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:29 INFO - Running post-action listener: _resource_record_post_action 15:40:29 INFO - [mozharness: 2016-08-15 22:40:29.888732Z] Finished install step (success) 15:40:29 INFO - [mozharness: 2016-08-15 22:40:29.888978Z] Running run-tests step. 15:40:29 INFO - Running pre-action listener: _resource_record_pre_action 15:40:29 INFO - Running main action method: run_tests 15:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:29 INFO - Python 2.7.3 15:40:29 INFO - Return code: 0 15:40:29 INFO - grabbing minidump binary from tooltool 15:40:29 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')]} 15:40:29 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 0x19aa370>, '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 0x19ad8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19add80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:29 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 15:40:29 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 15:40:29 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 15:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:29 INFO - Return code: 0 15:40:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 15:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 15:40:29 INFO - Using env: {'DISPLAY': ':0', 15:40:29 INFO - 'HOME': '/home/cltbld', 15:40:29 INFO - 'LANG': 'en_US.UTF-8', 15:40:29 INFO - 'LANGUAGE': 'en_US:en', 15:40:29 INFO - 'LOGNAME': 'cltbld', 15:40:29 INFO - 'MAIL': '/var/mail/cltbld', 15:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:29 INFO - 'MOZ_NO_REMOTE': '1', 15:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:29 INFO - 'NO_EM_RESTART': '1', 15:40:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:29 INFO - 'PWD': '/builds/slave/test', 15:40:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:29 INFO - 'SHELL': '/bin/bash', 15:40:29 INFO - 'SHLVL': '1', 15:40:29 INFO - 'TERM': 'linux', 15:40:29 INFO - 'TMOUT': '86400', 15:40:29 INFO - 'USER': 'cltbld', 15:40:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370', 15:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:29 INFO - '_': '/tools/buildbot/bin/python'} 15:40:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 15:40:30 INFO - mozversion application_buildid: 20160815113001 15:40:30 INFO - mozversion application_changeset: 59055929012280084afd040bfdf4216083a7636a 15:40:30 INFO - mozversion application_display_name: Nightly 15:40:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:30 INFO - mozversion application_name: Firefox 15:40:30 INFO - mozversion application_remotingname: firefox 15:40:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:40:30 INFO - mozversion application_vendor: Mozilla 15:40:30 INFO - mozversion application_version: 51.0a1 15:40:30 INFO - mozversion platform_buildid: 20160815113001 15:40:30 INFO - mozversion platform_changeset: 59055929012280084afd040bfdf4216083a7636a 15:40:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:40:30 INFO - mozversion platform_version: 51.0a1 15:40:30 INFO - using testdate: 1471300830 15:40:30 INFO - actual date: 1471300830 15:40:30 INFO - starting webserver on 'localhost:41711' 15:40:30 INFO - SUITE-START | Running 2 tests 15:40:30 INFO - TEST-START | dromaeo_css 15:40:30 INFO - operating with platform_type : linux_ 15:40:30 INFO - Initialising browser for dromaeo_css test... 15:40:30 INFO - TEST-INFO | started process 5021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpniXK8T/profile http://localhost:41711/getInfo.html) 15:40:34 INFO - PROCESS | 5021 | __metrics Screen width/height:1600/1200 15:40:34 INFO - PROCESS | 5021 | colorDepth:24 15:40:34 INFO - PROCESS | 5021 | Browser inner width/height: 1024/697 15:40:34 INFO - PROCESS | 5021 | __metrics 15:40:35 INFO - PROCESS | 5021 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:40:35 INFO - PROCESS | 5021 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:40:36 INFO - TEST-INFO | 5021: exit 0 15:40:36 INFO - Browser initialized. 15:40:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:36 INFO - TEST-INFO | started process 5104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpniXK8T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:48 INFO - PROCESS | 5104 | RSS: Main: 155828224 15:40:48 INFO - PROCESS | 5104 | 15:41:40 INFO - PROCESS | 5104 | 1471300900223 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] 15:43:49 INFO - PROCESS | 5104 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41711/tests/dromaeo/cssquery-ext.html) 15:43:50 INFO - PROCESS | 5104 | RSS: Main: 254517248 15:43:50 INFO - PROCESS | 5104 | 15:46:53 INFO - PROCESS | 5104 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-ext.html (next: http://localhost:41711/tests/dromaeo/cssquery-jquery.html) 15:46:53 INFO - PROCESS | 5104 | RSS: Main: 246943744 15:46:53 INFO - PROCESS | 5104 | 15:49:55 INFO - PROCESS | 5104 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41711/tests/dromaeo/cssquery-mootools.html) 15:49:56 INFO - PROCESS | 5104 | RSS: Main: 185393152 15:49:56 INFO - PROCESS | 5104 | 15:52:58 INFO - PROCESS | 5104 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41711/tests/dromaeo/cssquery-prototype.html) 15:52:59 INFO - PROCESS | 5104 | RSS: Main: 183156736 15:52:59 INFO - PROCESS | 5104 | 15:56:01 INFO - PROCESS | 5104 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41711/tests/dromaeo/cssquery-yui.html) 15:56:02 INFO - PROCESS | 5104 | RSS: Main: 186843136 15:56:02 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-yui.html (next: http://localhost:41711/tests/dromaeo/cssquery-dojo.html) 15:59:05 INFO - PROCESS | 5104 | RSS: Main: 276869120 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | __start_tp_report 15:59:05 INFO - PROCESS | 5104 | _x_x_mozilla_page_load 15:59:05 INFO - PROCESS | 5104 | _x_x_mozilla_page_load_details 15:59:05 INFO - PROCESS | 5104 | |i|pagename|runs| 15:59:05 INFO - PROCESS | 5104 | |0;dojo.html;3053.862576184072;3067.3251884585384;3077.507598784195;3088.9806363899916;3098.5352197170437;5241.42344342122;5272.736363181844;5273.9736301318535;5346.198070289453;5440.945590544094;5338.359396872381;5365.517103460687;5373.596980226479;5401.837944861651;5438.864028399292;4824.686395384307;4883.8779030524165;4916.557509824115;4929.2359684248995;5003.974980125095;4911.852644420673;4953.702777833323;4974.950250497503;4987.975060124694;4993.1262029144755;4744.742643199555;4798.856034318976;4810.086083644096;4835.758212089381;4945.480724523927;4771.832985845479;4775.904481910342;4782.378290822206;4842.564169224786;4931.65478416511;4774.952250477486;4819.542143496362;4834.178189707723;4860.027994401098;4888.41339039314;5250.133727934886;5308.814191503279;5328.6269961102735;5337.039332920072;5385.138377859563;5811.302643682743;5858;5863.120531920204;5863.8534036649;5864.824055278348;5903.026000709878;5905.793297234576;5917;5922.526197904157;5925.940740592625;5134.537891589737;5289.523942845162;5347;5368.221607866837;5475.698836563987;5932.5550583705535;5941.732622032019;5965.13505541694;5989;5990.73041713124;5710.7430165642645;5730.312362516524;5733.541316694655;5733.942660573424;5741.5406767459335;5596.58025648078;5665.603407761417;5712.428757124254;5714.714264286769;5816.272965879265;5747.5114615257335;5754.251947246831;5756.453136951983;5758.856028599234;5796.1595568642315;5731.684757338303;5762.855928601734;5769;5776.942230577724;5787.971060144672;4342.088161486124;4387.890302742457;4388;4390.560943905648;4447.199504089295;3886.145048089416;3921.098147426051;3942.3100957332927;3945.1715139820385;3945.546262179829;5458.590605704509;5473.562115030788;5473.75368108436;5513.9448605514235;5522.364928033247;5641.576881733887;5799.101139323411;5800.216970708984;5802.506786923159;5810.941890581124;5323.3079699639575;5378.220158077135;5382.085045542267;5422.295101636762;5463.808766693147;4870.756462176877;4881.9023619528125;4891.486393928586;4893.584045356113;4901.779419926112;5839.970800145972;5907.675077870758;5916.497097746654;5919.585629006015;5919.852003699942;5625.381208067191;5689.089745640677;5691.7438715257085;5742.224799651994;5783.566232532493;5894.204282421818;5915.290165180034;5951.583389162717;5953.077273022688;5960.701964901651;5552.750126244409;5675.31896172462;5677.432256774455;5682.147677848356;5687.402822703557;5661.037623604079;5666.518345940642;5703.173039909107;5771.711414429178;5809.157672137601;5587.245721827664;5639.351474580311;5643.3792282848035;5645.68948707825;5658.8965151795;5493.121100623881;5619.353774316006;5623.325200975745;5628.521575666115;5640.759033012895;5473.562115030868;5500.862478438071;5517.337919449692;5563.916541251803;5608.355039170385;5597.776088956396;5607.074832652566;5642.88714225705;5651.519620832275;5660.51885589713;5404.351477822686;5474.91787623178;5487.725613719218;5493.615446918837;5494.340679118532 15:59:05 INFO - PROCESS | 5104 | |1;ext.html;580.7764010855822;604.3352312456299;617.1822335405586;627.1345543150453;628.949684025278;43143.137137257276;44234.55765442344;44238.999999999956;44294.778526107366;48128;45012.0997580049;45600.087998240095;45610.543894561044;45626.31560526595;45766;8814.33892458065;8986.281097512216;8987.460752354848;8987.640494380217;8989.056149104348;8798.164174403422;8883.555822208864;8891.288696904265;8892.421992570462;8907.421017633866;8954.86567701485;8995;9001.684941027066;9007.819843603123;9014.459132452073;8858.601362938683;8880.111988801133;8882.333824963154;8886.333524985652;8894.466332020067;8892.15524525169;8942;8966.282697384258;8969.372143949926;8978.910210897873;42401.36397954033;42724;42875.142497149885;42897;42904.570954290684;3339.93320133596;3365;3472.5832900052155;3526.4710293455933;3949.9605003949882;32258;32461;32593.185170370693;32717.18207044819;32797.3440531188;3839.155385815116;3939.1333906540517;3943.7633741975574;3963.2271707017144;4036.89679772112;361446;365617;366451;367339;367746;56542.518622206175;56856;57158.142627860616;57205.713971429876;57361.13958290629;59497.40502595005;60210.096848547306;60270;60291;60298.397016030154;16914.407995720092;16985.575360616083;17087.658246835243;17133.82866171322;17138.40015599473;12399.628011159679;12402;12403.689907752198;12405.069619778553;12419.31693756834;15345;16248.268827902773;16251.51245462638;16363.34546618122;16393.180340982904;5990.6705131218205;6028.336882942873;6085.2393450818645;6101.786437474667;6243.158268310859;968.6803354892868;1012.5342342522375;1017.3743147964096;1109.7225693576606;1122.8490796933208;30723;30737.385252295277;31037.46210588863;31156;31227.68772312248;871.4379225399582;1024.1192574386023;1057.9947100264603;1102.3055475050828;1166.3643314393676;15715.68568628621;15804.683906321809;15852.52442426729;15868.668963731712;15990.920045399931;485510.72446378245;489622;490109;490359;490974;58145.41854581485;58244;58371.41628583745;58461;58463.415365846646;1202.5971299614728;1276.6361586947862;1329.0762919770666;1357.762391581489;1369.5069774881035;28819.423611528073;32462.675373245966;32836;33011.66988330086;33268.833655831564;51213.74393128011;51623.483765161865;51730;51738.482615173365;51775.48224517707;384009;384308;385171;386389;386471;41177;41698.1660366797;42411;42550.14899702051;42671.57328426676;48552;48988.510114898396;49724;49880;50008.74995624999;40625.59374406218;41758.791206043774;42342.57657423386;42672.35991460068;43331.566684332756;41083;41491;41749.37375939303;42364.576354237295;42535.787321063195;41419.792901035304;42242;42671.786641066596;43358;43598.782006089765;32405.513917290788;36972.815135924146;37384;37865.432018520296;38061;27266;27763.44473110486;27788.861055694593;28176.436471270048;28189.43621127525 15:59:05 INFO - PROCESS | 5104 | |2;jquery.html;377.78466274223706;382.70149283558834;405.13503669665266;409.68044924958525;421.29853793433915;13438.798418023725;17552.47342579723;19526;19547.315843945464;19596.510087247843;19050.714239286386;19053.333133340337;19061.904690476527;19300.420987370402;19318.710219346685;5718;5771.913421298684;5839.124131380285;5906.616069955439;5946.881062378749;5689.6017278790505;5738.651416917021;5773.740181691834;5776.451237132486;5784.4504772046585;5697.388365678499;5704.600677952545;5749.195112684228;5752.712364381785;5808.506276966442;5811.244538210027;5843.18195452637;5844.824655260349;5845.707714614274;5853.151293062482;5015.348004759395;5176.7929282828645;5213.296205012351;5213.348331458567;5232.686038837682;22215.22246721357;22666.546669066527;22706;23279.3016209514;23404;2309.5034567568055;2349.5066036132434;2375.0974629640627;2375.560521303564;2378.892949817245;10015.699529014068;10432.113270372027;10923.39921304328;11986.52053917851;14090.506832260924;1852.6109517001446;1906.4566598519355;1938.1278424708796;1968.271739456396;1976.8418526517844;52961.73519132418;63467.07716754385;69044.6547767263;79796.60101699454;80467;10189.490525473697;10825.512851921683;11087.50106245221;11137.443127843575;11293.887061129448;15923.840761592468;15944.123073230852;15951.840481595267;15963.521094367188;15982;8007.399445041528;8388.07731149573;8403.14306123764;8641.265492433213;8643.56782160902;8097.919020809716;8129.227723366389;8219.136990616018;8426.747197584082;8441.366897482714;4760.166970780099;4845.5881250094135;4906.699724572991;5027.472115427828;5044.520770526794;1865.5802444450162;1994.411648563677;1994.6908229224493;2040.6734922412343;2083.7707852136255;942.5428667096453;965.6378857928277;969.6557722008727;993.5876611206413;1066.1204506282347;19402.70895936562;20284.695729564068;20356.69464958027;20484.283050093472;20731.792682072984;976.4922240434934;1018.4245901065874;1029.6550655530332;1043.4052590023766;1057.3444464432102;10382.169426445866;10775.461226938622;11170.664880053611;11233;11278.887211127947;433992;439601;483000;486884;488418;58139.4186058134;66554;94702;99191;100496;1016.7153197104823;1037.8391349340714;1071.8981696738797;1075.3171735947728;1086.6848613902196;18033.729494057337;18357.54106147357;18916.905415472833;18963;18974.335898243495;45332.546674534155;45777.54222457866;46068.30897536607;46139.53860461487;46892.29661555011;62625.37374626378;64381.35618643754;65011;65218.34781652123;65617;8432.873506897278;8684.43551169172;8787.780305492413;8834.823303533765;8922.509261990654;12650.557230496888;13263.66840828987;13423.932880335537;13632.182069075887;14005.929970350084;11775.23460975034;11904.76190476203;12049;12069.155159138776;12538;11500.079993600659;11677.88322116768;11842.230255033395;12004.699882503008;12374.13381063317;12094.75810483803;12109.0918181135;12119.81820272679;12172.330521821385;12650.367481625697;8388.874166887379;8734.344924130843;8736.69421570242;8873.682688039456;9072.546372681472;9320.906790932004;11263.324200547993;11798.587049453228;12004.279743215435;12032.518699251932 15:59:05 INFO - PROCESS | 5104 | |3;mootools.html;1324.4834514539336;1448.8406275309715;1456.5775924981756;1575.747880339146;1729.2477772169107;8183.018037835461;8688.782780430492;8725.432846864956;8872.512011839346;8883.333749968746;8708.95645521773;8816.823663526726;8849.380543361967;8849.867251991209;8852.690155844546;2294.9541009179848;2331.743508214095;2332.3469428559947;2344.2498400511845;2344.4724936889234;2256.808171305433;2275.8065564427043;2359.221456919221;2359.6224604063354;2360.1739391213023;2309.7574754650773;2333.4866329407587;2336.9298921032396;2337.3805941425535;2337.777911098443;2251.448395143184;2271.784180502858;2276.408133885185;2282.417983414227;2285.0517035430275;2276.4877902471976;2277.578647950118;2282.4179834142356;2283.246528645543;2284.942876428086;8753.868691969625;8821.735347939572;8844.646214151426;8907.643694252221;8971.506567138806;5152.716600586966;5398.595105367074;5399.244105825188;5417.945820541783;5425.403205647375;3361.9831900840586;3400.6429324920773;3413.743969202295;3466.584009918826;3469.9479507807405;1135.9432028398546;1158.6581958322315;1164.4585267850491;1165.1960147498198;1176.8528933883265;12415.31715755633;12482.875171248354;12503.562375316911;12506.437210325466;12553.435095420728;4415.448068991376;4546.181687296253;4669.813207471663;4704.882377940579;4709.222978208557;9630.32587718867;9648.469334186688;9650.227981761442;9706.660266890625;9728.173105285989;5244.187150991603;5245.895082098336;5248.6325957182635;5249.291345668286;5251.159814429673;4178.310578754532;4621.30680397943;4740.786664600101;4777.737224452619;4917.729524876167;3747.8500859965843;3811.6569508744346;3841.4621952926614;3885.786281754474;3893.863714770026;1170.373849990251;1179.0626451970704;1182.9112816538793;1188.3464094748026;1190.4285942747356;757.5530437042172;902.2466240689098;907.3920473282784;939.3847030195233;995.6564985080136;6013.969930150409;6083.665398403042;6121.112438696364;6337.017762246859;6435.678216089271;942.9764255893521;953.5184731710442;973.5910917414703;985.2512090810892;990.2226751999646;4142.233686767958;4204.747715137101;4319.719218250803;4391.451068616423;4440.800163992628;11102.111831053497;11300.491477883515;11393.772124557629;11416.543338266543;11422.086233101332;11252.26860254081;11263.324200547993;11285.266457680225;11305.32168069902;11318.32090074598;7720.112187098555;8001.919980800118;8008.7597372078935;8113.107558168596;8213.096559378464;6100.481459076028;6157.692115394123;6212.012156110001;6299.96850015747;6549.345065493412;9857.457839818879;9935.304528683211;10155.39067655943;10156.644517441853;10159.7460063499;9848.901510984799;9859.35914165577;10124.746881328027;10124.848127278245;10258.17934565248;6937.89593156093;7721.112072111779;7892.4869883457395;7952.244536768998;8304.086550479322;8333.208345207195;8619.353548483763;8657.22085012352;8671.956640216758;8696.956515217384;7469.215732348242;7497.475176737576;7763.262490063435;7775.183605721544;7789.221077892165;7409.147947986051;7608.2391760825685;7643.617819109134;7662.463627546018;7816.218378162138;7103.751368702071;7148.320909513588;7156.105486814148;7161.641917904188;7176.4258859290085;5372.355317361941;5412.079946409199;5531.834044978657;5571.693556854412;5616.157576363578;5415.891682166413;5585.832425027255;5601.7759289629585;5620.718964051863;5750.367459579359 15:59:05 INFO - PROCESS | 5104 | |4;prototype.html;333.38324100414235;342.4811410712769;344.3887100396796;348.09321716927417;350.5285391148905;5194.818181363653;5233.371995360557;5245.344331958505;5254.369475662917;5254.868628284295;5179.482051794818;5182.740862956846;5192.065428222918;5198.220266959958;5211.609129315307;3628.3468975584383;3925.5878132796;3925.7840818754958;3933.6853051755934;4008.7193896427116;4058.086930440642;4072.5927407259187;4085.53016403113;4089.1821635672836;4094.6928980326447;4049.6152865477734;4065.1706731970585;4066.369712694537;4090.1206240658253;4090.754554726726;3874.7093967952515;4007.3788562772816;4075.3683179107284;4089.1208390196102;4091.2635725569385;3635.472856435802;3642.8724994625327;3643.9453408198897;3647.544056992876;3659.7072234221464;5054.519820617035;5075;5090.363704536933;5092.159793634046;5106.183010718267;4679.60223381013;4681.438227412732;4703.764811759398;4714.811407543694;4717.174494463455;5382.19696401702;5405.891882162374;5440.238366628675;5454.645448045904;5468.234447177399;4010.19796040793;4013.257547353749;4018.176273863851;4021.8391264349393;4024.1549274652357;4991.276264941599;5179.663321884065;5603;5608.523275521586;5667.149927510865;4048.149888523443;4051.6353528182017;4064.532578753481;4065.7560546367313;4081.9387709184384;4088.6115818997146;4098.856540021085;4101.384792281182;4108.876733697994;4135.6898232632075;4434.0268580482025;4680.251159814414;4693.178693728584;4699.201135806921;4699.271612900006;5314.449064449086;5354.384245811703;5362.517373436332;5381.246625472437;5385.192221166778;1400.271858633505;1413.5123382433044;1417.7873319002233;1425.7880801319004;1430.6852492451644;838.3544670603601;899.1862364560084;906.1391677906016;907.3376435202207;914.3599480363772;4555.223462849492;4588.26587745959;4592.7933243004145;4607.470140933769;4614.469336026333;4824.95175048245;4862.659613827069;4871.732054737024;4900.411950565955;4946.777395017233;4449.844255451044;4580.58774710271;4610.792514336863;4629.398178236807;4646.233371493733;2544.75824796644;2568.820182587201;2579.877753177374;2600.687917449918;2601.9089331873292;4998.525140111684;5014.774335154927;5034.640647025282;5037.370328708911;5040.344755181803;4779.617630589544;4943.629227807929;4944.975275123601;4960.528749768766;4984.975075124674;4965.702057876539;4975.865204920949;5002.624803139779;5009.824656137018;5018.648694591417;4837.854864354075;4841.394825646794;4845.878853028703;4903.33804936329;4905.288733133747;4510.932336015028;4800.591949684176;4814.759262036814;4831.178699621002;4852.781624826821;4937.703737775745;5497.835064948058;5589.5248903842;5710.857228569319;5729.908583366958;4088.632023117934;4096.365063415056;4120.670346372343;4121.423000779953;4128.02991297051;5548.750306236309;5591.608587398843;5604.887902242014;5606.103023516381;5609.485438931384;5219.81730639441;5448.618596698193;5470.480304371078;5471.85091130851;5473.343198816167;5412.296401467942;5413.404525502113;5429.022775900376;5440.775825439245;5445.918311225414;5185.199992004275;5412.485813847836;5451.918221226605;5457.699826509422;5464.754086066216;5454.836354909359;5491.478309560585;5495.560355171497;5496.532794712494;5503.165869577091;5324.440933701905;5345.118055520796;5373.313343328336;5381.838544843661;5403.702796346239 15:59:05 INFO - PROCESS | 5104 | |5;yui.html;632.5603705424729;648.3322178156501;665.3479590001798;698.944084473242;737.2921994884911;13571.999999999987;14581.270936453187;14635.121892686446;14652.78020829687;15716.449924252653;14608.342624581892;14654;14685.486007989723;14698.853011469882;14712.411503539846;793.6785601831267;828.5401602110826;838.2413915406536;838.279079991207;838.3837879158814;673.818069121337;784.8548018616546;817.0236567302077;817.5748610722421;820.8563501387263;863.6459051788768;865.8528050231475;866.9046404895456;867.0289276010876;867.6052396159732;859.1365677494141;860.3332417376521;860.3418384935561;860.5955201055494;861.1990848510883;510.6144860630238;525.3774277481197;526.5287567626953;528.2235114381853;607.8510764862593;13643.454261829615;13720.313984300845;14296.714065718628;14326.785098223534;14338.354774035193;13319.467221311135;13388.263645499494;13823.308834558231;14090;14100.788488172686;12605.11764176508;12941;12994.740105197938;13075.673108172277;13193;4447.288433850568;4483.910321793578;4503.527129651405;4556.589906908394;4696.295555666643;84893;85372.57313713392;85727;86496.99999999937;87658.56170719105;11101.83347249792;11102.244735107297;11591.594294199662;11609.187356884937;11634.883651163549;21058.684119738216;21413.143474261167;21445.14219431205;21470.677939830915;21473.463163420725;7929.1277959424415;7939.404544659058;8218.876716849252;8384.580770961427;8390.958045209856;4727.267273572602;4876.82931097417;5034.345535080416;5041.974790126026;5042.470540593258;3333.449980753197;3417.3848707232937;3423.281110966675;3426.777259478176;3427.9314413711586;610.7251736718495;632.7785275153659;632.9208848893888;634.5938599296454;639.354252205276;597.8684689368419;606.6996836565839;606.9094304388478;611.6696983628791;622.710439645567;8642.740717778477;9362.314783338928;9782.219570405672;9851.325274703318;9865.901340986498;525.6373102559222;611.2267981003945;616.2297128589263;639.4500729372736;641.7914177892204;4642.396488456479;4821.325014497973;4846.636502262344;4873.585745211697;4894.853154405374;118729;119021.40489297498;119809.40095299642;120860;122699.38650306691;85833;89165.55417222873;99917.50041249892;105967;107008;53848.73075634597;83400;84824;85969.57015215009;87707.56146219229;9621.56702948355;10290.176785857264;10502.789944201226;10503.73740656459;10516.631917882838;49132;50204.24693629672;50475.74762126166;50571.24143137782;51913.22130167975;61784;63690.68154659383;66355;70875.29124708688;71827.28172718205;13061.608151755463;13249.735005300034;13302.135361201492;13691;14156.646083847987;13671.111377760413;13735;13779;14320.641983950485;14415.207163606103;13765.174089554659;13809.861901380858;14215;14873.405063797327;14879.181645009628;8827.823443531222;13487.32563371847;14108.788368174692;14683.265836708335;14771.187584682515;13432.462701492223;13447.125936814076;13586.184828909902;13683.021609222997;13977.790333144807;11187.72030699239;11209.439528023404;11720.589779357682;11771;11877.465514051715;11654.592089276835;11924;11947.940260298643;12176.330301833485;12276.631701048982 15:59:05 INFO - PROCESS | 5104 | __end_tp_report 15:59:05 INFO - PROCESS | 5104 | __start_cc_report 15:59:05 INFO - PROCESS | 5104 | _x_x_mozilla_cycle_collect,1029 15:59:05 INFO - PROCESS | 5104 | __end_cc_report 15:59:05 INFO - PROCESS | 5104 | __startTimestamp1471301945720__endTimestamp 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | ------- Summary: start ------- 15:59:05 INFO - PROCESS | 5104 | Number of tests: 6 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | [#0] dojo.html Cycles:165 Average:5337.03 Median:5517.34 stddev:619.29 (11.2%) stddev-sans-first:594.73 15:59:05 INFO - PROCESS | 5104 | Values: 3053.9 3067.3 3077.5 3089.0 3098.5 5241.4 5272.7 5274.0 5346.2 5440.9 5338.4 5365.5 5373.6 5401.8 5438.9 4824.7 4883.9 4916.6 4929.2 5004.0 4911.9 4953.7 4975.0 4988.0 4993.1 4744.7 4798.9 4810.1 4835.8 4945.5 4771.8 4775.9 4782.4 4842.6 4931.7 4775.0 4819.5 4834.2 4860.0 4888.4 5250.1 5308.8 5328.6 5337.0 5385.1 5811.3 5858.0 5863.1 5863.9 5864.8 5903.0 5905.8 5917.0 5922.5 5925.9 5134.5 5289.5 5347.0 5368.2 5475.7 5932.6 5941.7 5965.1 5989.0 5990.7 5710.7 5730.3 5733.5 5733.9 5741.5 5596.6 5665.6 5712.4 5714.7 5816.3 5747.5 5754.3 5756.5 5758.9 5796.2 5731.7 5762.9 5769.0 5776.9 5788.0 4342.1 4387.9 4388.0 4390.6 4447.2 3886.1 3921.1 3942.3 3945.2 3945.5 5458.6 5473.6 5473.8 5513.9 5522.4 5641.6 5799.1 5800.2 5802.5 5810.9 5323.3 5378.2 5382.1 5422.3 5463.8 4870.8 4881.9 4891.5 4893.6 4901.8 5840.0 5907.7 5916.5 5919.6 5919.9 5625.4 5689.1 5691.7 5742.2 5783.6 5894.2 5915.3 5951.6 5953.1 5960.7 5552.8 5675.3 5677.4 5682.1 5687.4 5661.0 5666.5 5703.2 5771.7 5809.2 5587.2 5639.4 5643.4 5645.7 5658.9 5493.1 5619.4 5623.3 5628.5 5640.8 5473.6 5500.9 5517.3 5563.9 5608.4 5597.8 5607.1 5642.9 5651.5 5660.5 5404.4 5474.9 5487.7 5493.6 5494.3 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | [#1] ext.html Cycles:180 Average:58397.66 Median:42473.39 stddev:110085.40 (259.2%) stddev-sans-first:110308.63 15:59:05 INFO - PROCESS | 5104 | Values: 580.8 604.3 617.2 627.1 628.9 43143.1 44234.6 44239.0 44294.8 48128.0 45012.1 45600.1 45610.5 45626.3 45766.0 8814.3 8986.3 8987.5 8987.6 8989.1 8798.2 8883.6 8891.3 8892.4 8907.4 8954.9 8995.0 9001.7 9007.8 9014.5 8858.6 8880.1 8882.3 8886.3 8894.5 8892.2 8942.0 8966.3 8969.4 8978.9 42401.4 42724.0 42875.1 42897.0 42904.6 3339.9 3365.0 3472.6 3526.5 3950.0 32258.0 32461.0 32593.2 32717.2 32797.3 3839.2 3939.1 3943.8 3963.2 4036.9 361446.0 365617.0 366451.0 367339.0 367746.0 56542.5 56856.0 57158.1 57205.7 57361.1 59497.4 60210.1 60270.0 60291.0 60298.4 16914.4 16985.6 17087.7 17133.8 17138.4 12399.6 12402.0 12403.7 12405.1 12419.3 15345.0 16248.3 16251.5 16363.3 16393.2 5990.7 6028.3 6085.2 6101.8 6243.2 968.7 1012.5 1017.4 1109.7 1122.8 30723.0 30737.4 31037.5 31156.0 31227.7 871.4 1024.1 1058.0 1102.3 1166.4 15715.7 15804.7 15852.5 15868.7 15990.9 485510.7 489622.0 490109.0 490359.0 490974.0 58145.4 58244.0 58371.4 58461.0 58463.4 1202.6 1276.6 1329.1 1357.8 1369.5 28819.4 32462.7 32836.0 33011.7 33268.8 51213.7 51623.5 51730.0 51738.5 51775.5 384009.0 384308.0 385171.0 386389.0 386471.0 41177.0 41698.2 42411.0 42550.1 42671.6 48552.0 48988.5 49724.0 49880.0 50008.7 40625.6 41758.8 42342.6 42672.4 43331.6 41083.0 41491.0 41749.4 42364.6 42535.8 41419.8 42242.0 42671.8 43358.0 43598.8 32405.5 36972.8 37384.0 37865.4 38061.0 27266.0 27763.4 27788.9 28176.4 28189.4 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | [#2] jquery.html Cycles:180 Average:28226.57 Median:12876.75 stddev:76913.32 (597.3%) stddev-sans-first:77100.65 15:59:05 INFO - PROCESS | 5104 | Values: 377.8 382.7 405.1 409.7 421.3 13438.8 17552.5 19526.0 19547.3 19596.5 19050.7 19053.3 19061.9 19300.4 19318.7 5718.0 5771.9 5839.1 5906.6 5946.9 5689.6 5738.7 5773.7 5776.5 5784.5 5697.4 5704.6 5749.2 5752.7 5808.5 5811.2 5843.2 5844.8 5845.7 5853.2 5015.3 5176.8 5213.3 5213.3 5232.7 22215.2 22666.5 22706.0 23279.3 23404.0 2309.5 2349.5 2375.1 2375.6 2378.9 10015.7 10432.1 10923.4 11986.5 14090.5 1852.6 1906.5 1938.1 1968.3 1976.8 52961.7 63467.1 69044.7 79796.6 80467.0 10189.5 10825.5 11087.5 11137.4 11293.9 15923.8 15944.1 15951.8 15963.5 15982.0 8007.4 8388.1 8403.1 8641.3 8643.6 8097.9 8129.2 8219.1 8426.7 8441.4 4760.2 4845.6 4906.7 5027.5 5044.5 1865.6 1994.4 1994.7 2040.7 2083.8 942.5 965.6 969.7 993.6 1066.1 19402.7 20284.7 20356.7 20484.3 20731.8 976.5 1018.4 1029.7 1043.4 1057.3 10382.2 10775.5 11170.7 11233.0 11278.9 433992.0 439601.0 483000.0 486884.0 488418.0 58139.4 66554.0 94702.0 99191.0 100496.0 1016.7 1037.8 1071.9 1075.3 1086.7 18033.7 18357.5 18916.9 18963.0 18974.3 45332.5 45777.5 46068.3 46139.5 46892.3 62625.4 64381.4 65011.0 65218.3 65617.0 8432.9 8684.4 8787.8 8834.8 8922.5 12650.6 13263.7 13423.9 13632.2 14005.9 11775.2 11904.8 12049.0 12069.2 12538.0 11500.1 11677.9 11842.2 12004.7 12374.1 12094.8 12109.1 12119.8 12172.3 12650.4 8388.9 8734.3 8736.7 8873.7 9072.5 9320.9 11263.3 11798.6 12004.3 12032.5 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | [#3] mootools.html Cycles:180 Average:5840.54 Median:5250.23 stddev:3317.78 (63.2%) stddev-sans-first:3309.73 15:59:05 INFO - PROCESS | 5104 | Values: 1324.5 1448.8 1456.6 1575.7 1729.2 8183.0 8688.8 8725.4 8872.5 8883.3 8709.0 8816.8 8849.4 8849.9 8852.7 2295.0 2331.7 2332.3 2344.2 2344.5 2256.8 2275.8 2359.2 2359.6 2360.2 2309.8 2333.5 2336.9 2337.4 2337.8 2251.4 2271.8 2276.4 2282.4 2285.1 2276.5 2277.6 2282.4 2283.2 2284.9 8753.9 8821.7 8844.6 8907.6 8971.5 5152.7 5398.6 5399.2 5417.9 5425.4 3362.0 3400.6 3413.7 3466.6 3469.9 1135.9 1158.7 1164.5 1165.2 1176.9 12415.3 12482.9 12503.6 12506.4 12553.4 4415.4 4546.2 4669.8 4704.9 4709.2 9630.3 9648.5 9650.2 9706.7 9728.2 5244.2 5245.9 5248.6 5249.3 5251.2 4178.3 4621.3 4740.8 4777.7 4917.7 3747.9 3811.7 3841.5 3885.8 3893.9 1170.4 1179.1 1182.9 1188.3 1190.4 757.6 902.2 907.4 939.4 995.7 6014.0 6083.7 6121.1 6337.0 6435.7 943.0 953.5 973.6 985.3 990.2 4142.2 4204.7 4319.7 4391.5 4440.8 11102.1 11300.5 11393.8 11416.5 11422.1 11252.3 11263.3 11285.3 11305.3 11318.3 7720.1 8001.9 8008.8 8113.1 8213.1 6100.5 6157.7 6212.0 6300.0 6549.3 9857.5 9935.3 10155.4 10156.6 10159.7 9848.9 9859.4 10124.7 10124.8 10258.2 6937.9 7721.1 7892.5 7952.2 8304.1 8333.2 8619.4 8657.2 8672.0 8697.0 7469.2 7497.5 7763.3 7775.2 7789.2 7409.1 7608.2 7643.6 7662.5 7816.2 7103.8 7148.3 7156.1 7161.6 7176.4 5372.4 5412.1 5531.8 5571.7 5616.2 5415.9 5585.8 5601.8 5620.7 5750.4 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | [#4] prototype.html Cycles:180 Average:4419.48 Median:4867.20 stddev:1264.46 (26.0%) stddev-sans-first:1230.26 15:59:05 INFO - PROCESS | 5104 | Values: 333.4 342.5 344.4 348.1 350.5 5194.8 5233.4 5245.3 5254.4 5254.9 5179.5 5182.7 5192.1 5198.2 5211.6 3628.3 3925.6 3925.8 3933.7 4008.7 4058.1 4072.6 4085.5 4089.2 4094.7 4049.6 4065.2 4066.4 4090.1 4090.8 3874.7 4007.4 4075.4 4089.1 4091.3 3635.5 3642.9 3643.9 3647.5 3659.7 5054.5 5075.0 5090.4 5092.2 5106.2 4679.6 4681.4 4703.8 4714.8 4717.2 5382.2 5405.9 5440.2 5454.6 5468.2 4010.2 4013.3 4018.2 4021.8 4024.2 4991.3 5179.7 5603.0 5608.5 5667.1 4048.1 4051.6 4064.5 4065.8 4081.9 4088.6 4098.9 4101.4 4108.9 4135.7 4434.0 4680.3 4693.2 4699.2 4699.3 5314.4 5354.4 5362.5 5381.2 5385.2 1400.3 1413.5 1417.8 1425.8 1430.7 838.4 899.2 906.1 907.3 914.4 4555.2 4588.3 4592.8 4607.5 4614.5 4825.0 4862.7 4871.7 4900.4 4946.8 4449.8 4580.6 4610.8 4629.4 4646.2 2544.8 2568.8 2579.9 2600.7 2601.9 4998.5 5014.8 5034.6 5037.4 5040.3 4779.6 4943.6 4945.0 4960.5 4985.0 4965.7 4975.9 5002.6 5009.8 5018.6 4837.9 4841.4 4845.9 4903.3 4905.3 4510.9 4800.6 4814.8 4831.2 4852.8 4937.7 5497.8 5589.5 5710.9 5729.9 4088.6 4096.4 4120.7 4121.4 4128.0 5548.8 5591.6 5604.9 5606.1 5609.5 5219.8 5448.6 5470.5 5471.9 5473.3 5412.3 5413.4 5429.0 5440.8 5445.9 5185.2 5412.5 5451.9 5457.7 5464.8 5454.8 5491.5 5495.6 5496.5 5503.2 5324.4 5345.1 5373.3 5381.8 5403.7 15:59:05 INFO - PROCESS | 5104 | 15:59:05 INFO - PROCESS | 5104 | [#5] yui.html Cycles:180 Average:20761.13 Median:4711.78 stddev:30151.80 (639.9%) stddev-sans-first:30198.51 15:59:05 INFO - PROCESS | 5104 | Values: 632.6 648.3 665.3 698.9 737.3 13572.0 14581.3 14635.1 14652.8 15716.4 14608.3 14654.0 14685.5 14698.9 14712.4 793.7 828.5 838.2 838.3 838.4 673.8 784.9 817.0 817.6 820.9 863.6 865.9 866.9 867.0 867.6 859.1 860.3 860.3 860.6 861.2 510.6 525.4 526.5 528.2 607.9 13643.5 13720.3 14296.7 14326.8 14338.4 13319.5 13388.3 13823.3 14090.0 14100.8 12605.1 12941.0 12994.7 13075.7 13193.0 4447.3 4483.9 4503.5 4556.6 4696.3 84893.0 85372.6 85727.0 86497.0 87658.6 11101.8 11102.2 11591.6 11609.2 11634.9 21058.7 21413.1 21445.1 21470.7 21473.5 7929.1 7939.4 8218.9 8384.6 8391.0 4727.3 4876.8 5034.3 5042.0 5042.5 3333.4 3417.4 3423.3 3426.8 3427.9 610.7 632.8 632.9 634.6 639.4 597.9 606.7 606.9 611.7 622.7 8642.7 9362.3 9782.2 9851.3 9865.9 525.6 611.2 616.2 639.5 641.8 4642.4 4821.3 4846.6 4873.6 4894.9 118729.0 119021.4 119809.4 120860.0 122699.4 85833.0 89165.6 99917.5 105967.0 107008.0 53848.7 83400.0 84824.0 85969.6 87707.6 9621.6 10290.2 10502.8 10503.7 10516.6 49132.0 50204.2 50475.7 50571.2 51913.2 61784.0 63690.7 66355.0 70875.3 71827.3 13061.6 13249.7 13302.1 13691.0 14156.6 13671.1 13735.0 13779.0 14320.6 14415.2 13765.2 13809.9 14215.0 14873.4 14879.2 8827.8 13487.3 14108.8 14683.3 14771.2 13432.5 13447.1 13586.2 13683.0 13977.8 11187.7 11209.4 11720.6 11771.0 11877.5 11654.6 11924.0 11947.9 12176.3 12276.6 15:59:05 INFO - PROCESS | 5104 | -------- Summary: end -------- 15:59:05 INFO - PROCESS | 5104 | 15:59:06 INFO - TEST-INFO | 5104: exit 0 15:59:06 INFO - TEST-OK | dromaeo_css | took 1116338ms 15:59:06 INFO - TEST-START | kraken 15:59:06 INFO - operating with platform_type : linux_ 15:59:06 INFO - Initialising browser for kraken test... 15:59:06 INFO - TEST-INFO | started process 5411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR9cnF7/profile http://localhost:41711/getInfo.html) 15:59:10 INFO - PROCESS | 5411 | __metrics Screen width/height:1600/1200 15:59:10 INFO - PROCESS | 5411 | colorDepth:24 15:59:10 INFO - PROCESS | 5411 | Browser inner width/height: 1024/697 15:59:10 INFO - PROCESS | 5411 | __metrics 15:59:11 INFO - PROCESS | 5411 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:59:11 INFO - PROCESS | 5411 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:59:12 INFO - TEST-INFO | 5411: exit 0 15:59:12 INFO - Browser initialized. 15:59:12 INFO - Running cycle 1/1 for kraken test... 15:59:12 INFO - TEST-INFO | started process 5492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR9cnF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:24 INFO - PROCESS | 5492 | RSS: Main: 155787264 15:59:24 INFO - PROCESS | 5492 | 15:59:26 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:27 INFO - PROCESS | 5492 | RSS: Main: 203132928 15:59:27 INFO - PROCESS | 5492 | 15:59:30 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-dft) 15:59:30 INFO - PROCESS | 5492 | RSS: Main: 194736128 15:59:30 INFO - PROCESS | 5492 | 15:59:33 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-fft) 15:59:34 INFO - PROCESS | 5492 | RSS: Main: 274636800 15:59:34 INFO - PROCESS | 5492 | 15:59:36 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-oscillator) 15:59:37 INFO - PROCESS | 5492 | RSS: Main: 186200064 15:59:37 INFO - PROCESS | 5492 | 15:59:39 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:40 INFO - PROCESS | 5492 | RSS: Main: 190545920 15:59:40 INFO - PROCESS | 5492 | 15:59:42 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41711/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:43 INFO - PROCESS | 5492 | RSS: Main: 225509376 15:59:43 INFO - PROCESS | 5492 | 15:59:46 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41711/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:47 INFO - PROCESS | 5492 | RSS: Main: 225918976 15:59:47 INFO - PROCESS | 5492 | 15:59:50 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41711/tests/kraken/driver.html?testName=json-parse-financial) 15:59:50 INFO - PROCESS | 5492 | RSS: Main: 226586624 15:59:50 INFO - PROCESS | 5492 | 15:59:52 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:53 INFO - PROCESS | 5492 | RSS: Main: 188772352 15:59:53 INFO - PROCESS | 5492 | 15:59:54 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:55 INFO - PROCESS | 5492 | RSS: Main: 196456448 15:59:55 INFO - PROCESS | 5492 | 15:59:57 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:58 INFO - PROCESS | 5492 | RSS: Main: 193331200 15:59:58 INFO - PROCESS | 5492 | 16:00:00 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:00:01 INFO - PROCESS | 5492 | RSS: Main: 187584512 16:00:01 INFO - PROCESS | 5492 | 16:00:04 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:04 INFO - PROCESS | 5492 | RSS: Main: 192057344 16:00:04 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41711/tests/kraken/driver.html?testName=ai-astar) 16:00:06 INFO - PROCESS | 5492 | RSS: Main: 242880512 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | __start_tp_report 16:00:06 INFO - PROCESS | 5492 | _x_x_mozilla_page_load 16:00:06 INFO - PROCESS | 5492 | _x_x_mozilla_page_load_details 16:00:06 INFO - PROCESS | 5492 | |i|pagename|runs| 16:00:06 INFO - PROCESS | 5492 | |0;ai-astar;103;113;111;111;106;112;111;111;112;111 16:00:06 INFO - PROCESS | 5492 | |1;audio-beat-detection;157;115;122;191;122;124;151;116;150;117 16:00:06 INFO - PROCESS | 5492 | |2;audio-dft;161;160;161;160;159;160;159;162;161;161 16:00:06 INFO - PROCESS | 5492 | |3;audio-fft;75;76;75;113;76;76;74;75;108;76 16:00:06 INFO - PROCESS | 5492 | |4;audio-oscillator;85;84;126;85;85;85;114;84;84;123 16:00:06 INFO - PROCESS | 5492 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;117;117;116 16:00:06 INFO - PROCESS | 5492 | |6;imaging-darkroom;145;145;145;145;145;146;146;145;146;145 16:00:06 INFO - PROCESS | 5492 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 16:00:06 INFO - PROCESS | 5492 | |8;json-parse-financial;51;51;52;51;51;53;52;51;53;52 16:00:06 INFO - PROCESS | 5492 | |9;json-stringify-tinderbox;63;64;64;63;64;64;63;63;64;63 16:00:06 INFO - PROCESS | 5492 | |10;stanford-crypto-aes;79;87;81;78;84;79;84;77;78;86 16:00:06 INFO - PROCESS | 5492 | |11;stanford-crypto-ccm;132;121;130;127;137;132;125;123;139;139 16:00:06 INFO - PROCESS | 5492 | |12;stanford-crypto-pbkdf2;168;164;165;161;165;166;164;170;165;162 16:00:06 INFO - PROCESS | 5492 | |13;stanford-crypto-sha256-iterative;64;63;66;63;63;63;64;65;68;63 16:00:06 INFO - PROCESS | 5492 | __end_tp_report 16:00:06 INFO - PROCESS | 5492 | __start_cc_report 16:00:06 INFO - PROCESS | 5492 | _x_x_mozilla_cycle_collect,1684 16:00:06 INFO - PROCESS | 5492 | __end_cc_report 16:00:06 INFO - PROCESS | 5492 | __startTimestamp1471302006788__endTimestamp 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | ------- Summary: start ------- 16:00:06 INFO - PROCESS | 5492 | Number of tests: 14 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.11 (2.8%) stddev-sans-first:1.96 16:00:06 INFO - PROCESS | 5492 | Values: 103.0 113.0 111.0 111.0 106.0 112.0 111.0 111.0 112.0 111.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:137.00 stddev:24.99 (18.2%) stddev-sans-first:25.39 16:00:06 INFO - PROCESS | 5492 | Values: 157.0 115.0 122.0 191.0 122.0 124.0 151.0 116.0 150.0 117.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 16:00:06 INFO - PROCESS | 5492 | Values: 161.0 160.0 161.0 160.0 159.0 160.0 159.0 162.0 161.0 161.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:14.87 (19.7%) stddev-sans-first:15.53 16:00:06 INFO - PROCESS | 5492 | Values: 75.0 76.0 75.0 113.0 76.0 76.0 74.0 75.0 108.0 76.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.50 stddev:17.85 (21.1%) stddev-sans-first:18.52 16:00:06 INFO - PROCESS | 5492 | Values: 85.0 84.0 126.0 85.0 85.0 85.0 114.0 84.0 84.0 123.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 16:00:06 INFO - PROCESS | 5492 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 116.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:00:06 INFO - PROCESS | 5492 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:00:06 INFO - PROCESS | 5492 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 16:00:06 INFO - PROCESS | 5492 | Values: 51.0 51.0 52.0 51.0 51.0 53.0 52.0 51.0 53.0 52.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:00:06 INFO - PROCESS | 5492 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 63.0 63.0 64.0 63.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.50 stddev:3.65 (4.4%) stddev-sans-first:3.78 16:00:06 INFO - PROCESS | 5492 | Values: 79.0 87.0 81.0 78.0 84.0 79.0 84.0 77.0 78.0 86.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:132.00 stddev:6.50 (4.9%) stddev-sans-first:6.87 16:00:06 INFO - PROCESS | 5492 | Values: 132.0 121.0 130.0 127.0 137.0 132.0 125.0 123.0 139.0 139.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.62 (1.6%) stddev-sans-first:2.55 16:00:06 INFO - PROCESS | 5492 | Values: 168.0 164.0 165.0 161.0 165.0 166.0 164.0 170.0 165.0 162.0 16:00:06 INFO - PROCESS | 5492 | 16:00:06 INFO - PROCESS | 5492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.69 (2.6%) stddev-sans-first:1.79 16:00:06 INFO - PROCESS | 5492 | Values: 64.0 63.0 66.0 63.0 63.0 63.0 64.0 65.0 68.0 63.0 16:00:06 INFO - PROCESS | 5492 | -------- Summary: end -------- 16:00:06 INFO - PROCESS | 5492 | 16:00:07 INFO - TEST-INFO | 5492: exit 0 16:00:07 INFO - TEST-OK | kraken | took 61357ms 16:00:07 INFO - SUITE-END | took 1177s 16:00:07 INFO - Completed test suite (00:19:37) 16:00:07 INFO - javascript benchmark 16:00:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.862576184072, 3067.3251884585384, 3077.507598784195, 3088.9806363899916, 3098.5352197170437, 5241.42344342122, 5272.736363181844, 5273.9736301318535, 5346.198070289453, 5440.945590544094, 5338.359396872381, 5365.517103460687, 5373.596980226479, 5401.837944861651, 5438.864028399292, 4824.686395384307, 4883.8779030524165, 4916.557509824115, 4929.2359684248995, 5003.974980125095, 4911.852644420673, 4953.702777833323, 4974.950250497503, 4987.975060124694, 4993.1262029144755, 4744.742643199555, 4798.856034318976, 4810.086083644096, 4835.758212089381, 4945.480724523927, 4771.832985845479, 4775.904481910342, 4782.378290822206, 4842.564169224786, 4931.65478416511, 4774.952250477486, 4819.542143496362, 4834.178189707723, 4860.027994401098, 4888.41339039314, 5250.133727934886, 5308.814191503279, 5328.6269961102735, 5337.039332920072, 5385.138377859563, 5811.302643682743, 5858.0, 5863.120531920204, 5863.8534036649, 5864.824055278348, 5903.026000709878, 5905.793297234576, 5917.0, 5922.526197904157, 5925.940740592625, 5134.537891589737, 5289.523942845162, 5347.0, 5368.221607866837, 5475.698836563987, 5932.5550583705535, 5941.732622032019, 5965.13505541694, 5989.0, 5990.73041713124, 5710.7430165642645, 5730.312362516524, 5733.541316694655, 5733.942660573424, 5741.5406767459335, 5596.58025648078, 5665.603407761417, 5712.428757124254, 5714.714264286769, 5816.272965879265, 5747.5114615257335, 5754.251947246831, 5756.453136951983, 5758.856028599234, 5796.1595568642315, 5731.684757338303, 5762.855928601734, 5769.0, 5776.942230577724, 5787.971060144672, 4342.088161486124, 4387.890302742457, 4388.0, 4390.560943905648, 4447.199504089295, 3886.145048089416, 3921.098147426051, 3942.3100957332927, 3945.1715139820385, 3945.546262179829, 5458.590605704509, 5473.562115030788, 5473.75368108436, 5513.9448605514235, 5522.364928033247, 5641.576881733887, 5799.101139323411, 5800.216970708984, 5802.506786923159, 5810.941890581124, 5323.3079699639575, 5378.220158077135, 5382.085045542267, 5422.295101636762, 5463.808766693147, 4870.756462176877, 4881.9023619528125, 4891.486393928586, 4893.584045356113, 4901.779419926112, 5839.970800145972, 5907.675077870758, 5916.497097746654, 5919.585629006015, 5919.852003699942, 5625.381208067191, 5689.089745640677, 5691.7438715257085, 5742.224799651994, 5783.566232532493, 5894.204282421818, 5915.290165180034, 5951.583389162717, 5953.077273022688, 5960.701964901651, 5552.750126244409, 5675.31896172462, 5677.432256774455, 5682.147677848356, 5687.402822703557, 5661.037623604079, 5666.518345940642, 5703.173039909107, 5771.711414429178, 5809.157672137601, 5587.245721827664, 5639.351474580311, 5643.3792282848035, 5645.68948707825, 5658.8965151795, 5493.121100623881, 5619.353774316006, 5623.325200975745, 5628.521575666115, 5640.759033012895, 5473.562115030868, 5500.862478438071, 5517.337919449692, 5563.916541251803, 5608.355039170385, 5597.776088956396, 5607.074832652566, 5642.88714225705, 5651.519620832275, 5660.51885589713, 5404.351477822686, 5474.91787623178, 5487.725613719218, 5493.615446918837, 5494.340679118532], "value": 5294.304226433849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.7764010855822, 604.3352312456299, 617.1822335405586, 627.1345543150453, 628.949684025278, 43143.137137257276, 44234.55765442344, 44238.999999999956, 44294.778526107366, 48128.0, 45012.0997580049, 45600.087998240095, 45610.543894561044, 45626.31560526595, 45766.0, 8814.33892458065, 8986.281097512216, 8987.460752354848, 8987.640494380217, 8989.056149104348, 8798.164174403422, 8883.555822208864, 8891.288696904265, 8892.421992570462, 8907.421017633866, 8954.86567701485, 8995.0, 9001.684941027066, 9007.819843603123, 9014.459132452073, 8858.601362938683, 8880.111988801133, 8882.333824963154, 8886.333524985652, 8894.466332020067, 8892.15524525169, 8942.0, 8966.282697384258, 8969.372143949926, 8978.910210897873, 42401.36397954033, 42724.0, 42875.142497149885, 42897.0, 42904.570954290684, 3339.93320133596, 3365.0, 3472.5832900052155, 3526.4710293455933, 3949.9605003949882, 32258.0, 32461.0, 32593.185170370693, 32717.18207044819, 32797.3440531188, 3839.155385815116, 3939.1333906540517, 3943.7633741975574, 3963.2271707017144, 4036.89679772112, 361446.0, 365617.0, 366451.0, 367339.0, 367746.0, 56542.518622206175, 56856.0, 57158.142627860616, 57205.713971429876, 57361.13958290629, 59497.40502595005, 60210.096848547306, 60270.0, 60291.0, 60298.397016030154, 16914.407995720092, 16985.575360616083, 17087.658246835243, 17133.82866171322, 17138.40015599473, 12399.628011159679, 12402.0, 12403.689907752198, 12405.069619778553, 12419.31693756834, 15345.0, 16248.268827902773, 16251.51245462638, 16363.34546618122, 16393.180340982904, 5990.6705131218205, 6028.336882942873, 6085.2393450818645, 6101.786437474667, 6243.158268310859, 968.6803354892868, 1012.5342342522375, 1017.3743147964096, 1109.7225693576606, 1122.8490796933208, 30723.0, 30737.385252295277, 31037.46210588863, 31156.0, 31227.68772312248, 871.4379225399582, 1024.1192574386023, 1057.9947100264603, 1102.3055475050828, 1166.3643314393676, 15715.68568628621, 15804.683906321809, 15852.52442426729, 15868.668963731712, 15990.920045399931, 485510.72446378245, 489622.0, 490109.0, 490359.0, 490974.0, 58145.41854581485, 58244.0, 58371.41628583745, 58461.0, 58463.415365846646, 1202.5971299614728, 1276.6361586947862, 1329.0762919770666, 1357.762391581489, 1369.5069774881035, 28819.423611528073, 32462.675373245966, 32836.0, 33011.66988330086, 33268.833655831564, 51213.74393128011, 51623.483765161865, 51730.0, 51738.482615173365, 51775.48224517707, 384009.0, 384308.0, 385171.0, 386389.0, 386471.0, 41177.0, 41698.1660366797, 42411.0, 42550.14899702051, 42671.57328426676, 48552.0, 48988.510114898396, 49724.0, 49880.0, 50008.74995624999, 40625.59374406218, 41758.791206043774, 42342.57657423386, 42672.35991460068, 43331.566684332756, 41083.0, 41491.0, 41749.37375939303, 42364.576354237295, 42535.787321063195, 41419.792901035304, 42242.0, 42671.786641066596, 43358.0, 43598.782006089765, 32405.513917290788, 36972.815135924146, 37384.0, 37865.432018520296, 38061.0, 27266.0, 27763.44473110486, 27788.861055694593, 28176.436471270048, 28189.43621127525], "value": 20034.16956119765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.78466274223706, 382.70149283558834, 405.13503669665266, 409.68044924958525, 421.29853793433915, 13438.798418023725, 17552.47342579723, 19526.0, 19547.315843945464, 19596.510087247843, 19050.714239286386, 19053.333133340337, 19061.904690476527, 19300.420987370402, 19318.710219346685, 5718.0, 5771.913421298684, 5839.124131380285, 5906.616069955439, 5946.881062378749, 5689.6017278790505, 5738.651416917021, 5773.740181691834, 5776.451237132486, 5784.4504772046585, 5697.388365678499, 5704.600677952545, 5749.195112684228, 5752.712364381785, 5808.506276966442, 5811.244538210027, 5843.18195452637, 5844.824655260349, 5845.707714614274, 5853.151293062482, 5015.348004759395, 5176.7929282828645, 5213.296205012351, 5213.348331458567, 5232.686038837682, 22215.22246721357, 22666.546669066527, 22706.0, 23279.3016209514, 23404.0, 2309.5034567568055, 2349.5066036132434, 2375.0974629640627, 2375.560521303564, 2378.892949817245, 10015.699529014068, 10432.113270372027, 10923.39921304328, 11986.52053917851, 14090.506832260924, 1852.6109517001446, 1906.4566598519355, 1938.1278424708796, 1968.271739456396, 1976.8418526517844, 52961.73519132418, 63467.07716754385, 69044.6547767263, 79796.60101699454, 80467.0, 10189.490525473697, 10825.512851921683, 11087.50106245221, 11137.443127843575, 11293.887061129448, 15923.840761592468, 15944.123073230852, 15951.840481595267, 15963.521094367188, 15982.0, 8007.399445041528, 8388.07731149573, 8403.14306123764, 8641.265492433213, 8643.56782160902, 8097.919020809716, 8129.227723366389, 8219.136990616018, 8426.747197584082, 8441.366897482714, 4760.166970780099, 4845.5881250094135, 4906.699724572991, 5027.472115427828, 5044.520770526794, 1865.5802444450162, 1994.411648563677, 1994.6908229224493, 2040.6734922412343, 2083.7707852136255, 942.5428667096453, 965.6378857928277, 969.6557722008727, 993.5876611206413, 1066.1204506282347, 19402.70895936562, 20284.695729564068, 20356.69464958027, 20484.283050093472, 20731.792682072984, 976.4922240434934, 1018.4245901065874, 1029.6550655530332, 1043.4052590023766, 1057.3444464432102, 10382.169426445866, 10775.461226938622, 11170.664880053611, 11233.0, 11278.887211127947, 433992.0, 439601.0, 483000.0, 486884.0, 488418.0, 58139.4186058134, 66554.0, 94702.0, 99191.0, 100496.0, 1016.7153197104823, 1037.8391349340714, 1071.8981696738797, 1075.3171735947728, 1086.6848613902196, 18033.729494057337, 18357.54106147357, 18916.905415472833, 18963.0, 18974.335898243495, 45332.546674534155, 45777.54222457866, 46068.30897536607, 46139.53860461487, 46892.29661555011, 62625.37374626378, 64381.35618643754, 65011.0, 65218.34781652123, 65617.0, 8432.873506897278, 8684.43551169172, 8787.780305492413, 8834.823303533765, 8922.509261990654, 12650.557230496888, 13263.66840828987, 13423.932880335537, 13632.182069075887, 14005.929970350084, 11775.23460975034, 11904.76190476203, 12049.0, 12069.155159138776, 12538.0, 11500.079993600659, 11677.88322116768, 11842.230255033395, 12004.699882503008, 12374.13381063317, 12094.75810483803, 12109.0918181135, 12119.81820272679, 12172.330521821385, 12650.367481625697, 8388.874166887379, 8734.344924130843, 8736.69421570242, 8873.682688039456, 9072.546372681472, 9320.906790932004, 11263.324200547993, 11798.587049453228, 12004.279743215435, 12032.518699251932], "value": 9329.690066565134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.4834514539336, 1448.8406275309715, 1456.5775924981756, 1575.747880339146, 1729.2477772169107, 8183.018037835461, 8688.782780430492, 8725.432846864956, 8872.512011839346, 8883.333749968746, 8708.95645521773, 8816.823663526726, 8849.380543361967, 8849.867251991209, 8852.690155844546, 2294.9541009179848, 2331.743508214095, 2332.3469428559947, 2344.2498400511845, 2344.4724936889234, 2256.808171305433, 2275.8065564427043, 2359.221456919221, 2359.6224604063354, 2360.1739391213023, 2309.7574754650773, 2333.4866329407587, 2336.9298921032396, 2337.3805941425535, 2337.777911098443, 2251.448395143184, 2271.784180502858, 2276.408133885185, 2282.417983414227, 2285.0517035430275, 2276.4877902471976, 2277.578647950118, 2282.4179834142356, 2283.246528645543, 2284.942876428086, 8753.868691969625, 8821.735347939572, 8844.646214151426, 8907.643694252221, 8971.506567138806, 5152.716600586966, 5398.595105367074, 5399.244105825188, 5417.945820541783, 5425.403205647375, 3361.9831900840586, 3400.6429324920773, 3413.743969202295, 3466.584009918826, 3469.9479507807405, 1135.9432028398546, 1158.6581958322315, 1164.4585267850491, 1165.1960147498198, 1176.8528933883265, 12415.31715755633, 12482.875171248354, 12503.562375316911, 12506.437210325466, 12553.435095420728, 4415.448068991376, 4546.181687296253, 4669.813207471663, 4704.882377940579, 4709.222978208557, 9630.32587718867, 9648.469334186688, 9650.227981761442, 9706.660266890625, 9728.173105285989, 5244.187150991603, 5245.895082098336, 5248.6325957182635, 5249.291345668286, 5251.159814429673, 4178.310578754532, 4621.30680397943, 4740.786664600101, 4777.737224452619, 4917.729524876167, 3747.8500859965843, 3811.6569508744346, 3841.4621952926614, 3885.786281754474, 3893.863714770026, 1170.373849990251, 1179.0626451970704, 1182.9112816538793, 1188.3464094748026, 1190.4285942747356, 757.5530437042172, 902.2466240689098, 907.3920473282784, 939.3847030195233, 995.6564985080136, 6013.969930150409, 6083.665398403042, 6121.112438696364, 6337.017762246859, 6435.678216089271, 942.9764255893521, 953.5184731710442, 973.5910917414703, 985.2512090810892, 990.2226751999646, 4142.233686767958, 4204.747715137101, 4319.719218250803, 4391.451068616423, 4440.800163992628, 11102.111831053497, 11300.491477883515, 11393.772124557629, 11416.543338266543, 11422.086233101332, 11252.26860254081, 11263.324200547993, 11285.266457680225, 11305.32168069902, 11318.32090074598, 7720.112187098555, 8001.919980800118, 8008.7597372078935, 8113.107558168596, 8213.096559378464, 6100.481459076028, 6157.692115394123, 6212.012156110001, 6299.96850015747, 6549.345065493412, 9857.457839818879, 9935.304528683211, 10155.39067655943, 10156.644517441853, 10159.7460063499, 9848.901510984799, 9859.35914165577, 10124.746881328027, 10124.848127278245, 10258.17934565248, 6937.89593156093, 7721.112072111779, 7892.4869883457395, 7952.244536768998, 8304.086550479322, 8333.208345207195, 8619.353548483763, 8657.22085012352, 8671.956640216758, 8696.956515217384, 7469.215732348242, 7497.475176737576, 7763.262490063435, 7775.183605721544, 7789.221077892165, 7409.147947986051, 7608.2391760825685, 7643.617819109134, 7662.463627546018, 7816.218378162138, 7103.751368702071, 7148.320909513588, 7156.105486814148, 7161.641917904188, 7176.4258859290085, 5372.355317361941, 5412.079946409199, 5531.834044978657, 5571.693556854412, 5616.157576363578, 5415.891682166413, 5585.832425027255, 5601.7759289629585, 5620.718964051863, 5750.367459579359], "value": 4657.748548404002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.38324100414235, 342.4811410712769, 344.3887100396796, 348.09321716927417, 350.5285391148905, 5194.818181363653, 5233.371995360557, 5245.344331958505, 5254.369475662917, 5254.868628284295, 5179.482051794818, 5182.740862956846, 5192.065428222918, 5198.220266959958, 5211.609129315307, 3628.3468975584383, 3925.5878132796, 3925.7840818754958, 3933.6853051755934, 4008.7193896427116, 4058.086930440642, 4072.5927407259187, 4085.53016403113, 4089.1821635672836, 4094.6928980326447, 4049.6152865477734, 4065.1706731970585, 4066.369712694537, 4090.1206240658253, 4090.754554726726, 3874.7093967952515, 4007.3788562772816, 4075.3683179107284, 4089.1208390196102, 4091.2635725569385, 3635.472856435802, 3642.8724994625327, 3643.9453408198897, 3647.544056992876, 3659.7072234221464, 5054.519820617035, 5075.0, 5090.363704536933, 5092.159793634046, 5106.183010718267, 4679.60223381013, 4681.438227412732, 4703.764811759398, 4714.811407543694, 4717.174494463455, 5382.19696401702, 5405.891882162374, 5440.238366628675, 5454.645448045904, 5468.234447177399, 4010.19796040793, 4013.257547353749, 4018.176273863851, 4021.8391264349393, 4024.1549274652357, 4991.276264941599, 5179.663321884065, 5603.0, 5608.523275521586, 5667.149927510865, 4048.149888523443, 4051.6353528182017, 4064.532578753481, 4065.7560546367313, 4081.9387709184384, 4088.6115818997146, 4098.856540021085, 4101.384792281182, 4108.876733697994, 4135.6898232632075, 4434.0268580482025, 4680.251159814414, 4693.178693728584, 4699.201135806921, 4699.271612900006, 5314.449064449086, 5354.384245811703, 5362.517373436332, 5381.246625472437, 5385.192221166778, 1400.271858633505, 1413.5123382433044, 1417.7873319002233, 1425.7880801319004, 1430.6852492451644, 838.3544670603601, 899.1862364560084, 906.1391677906016, 907.3376435202207, 914.3599480363772, 4555.223462849492, 4588.26587745959, 4592.7933243004145, 4607.470140933769, 4614.469336026333, 4824.95175048245, 4862.659613827069, 4871.732054737024, 4900.411950565955, 4946.777395017233, 4449.844255451044, 4580.58774710271, 4610.792514336863, 4629.398178236807, 4646.233371493733, 2544.75824796644, 2568.820182587201, 2579.877753177374, 2600.687917449918, 2601.9089331873292, 4998.525140111684, 5014.774335154927, 5034.640647025282, 5037.370328708911, 5040.344755181803, 4779.617630589544, 4943.629227807929, 4944.975275123601, 4960.528749768766, 4984.975075124674, 4965.702057876539, 4975.865204920949, 5002.624803139779, 5009.824656137018, 5018.648694591417, 4837.854864354075, 4841.394825646794, 4845.878853028703, 4903.33804936329, 4905.288733133747, 4510.932336015028, 4800.591949684176, 4814.759262036814, 4831.178699621002, 4852.781624826821, 4937.703737775745, 5497.835064948058, 5589.5248903842, 5710.857228569319, 5729.908583366958, 4088.632023117934, 4096.365063415056, 4120.670346372343, 4121.423000779953, 4128.02991297051, 5548.750306236309, 5591.608587398843, 5604.887902242014, 5606.103023516381, 5609.485438931384, 5219.81730639441, 5448.618596698193, 5470.480304371078, 5471.85091130851, 5473.343198816167, 5412.296401467942, 5413.404525502113, 5429.022775900376, 5440.775825439245, 5445.918311225414, 5185.199992004275, 5412.485813847836, 5451.918221226605, 5457.699826509422, 5464.754086066216, 5454.836354909359, 5491.478309560585, 5495.560355171497, 5496.532794712494, 5503.165869577091, 5324.440933701905, 5345.118055520796, 5373.313343328336, 5381.838544843661, 5403.702796346239], "value": 4024.6393659681207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.5603705424729, 648.3322178156501, 665.3479590001798, 698.944084473242, 737.2921994884911, 13571.999999999987, 14581.270936453187, 14635.121892686446, 14652.78020829687, 15716.449924252653, 14608.342624581892, 14654.0, 14685.486007989723, 14698.853011469882, 14712.411503539846, 793.6785601831267, 828.5401602110826, 838.2413915406536, 838.279079991207, 838.3837879158814, 673.818069121337, 784.8548018616546, 817.0236567302077, 817.5748610722421, 820.8563501387263, 863.6459051788768, 865.8528050231475, 866.9046404895456, 867.0289276010876, 867.6052396159732, 859.1365677494141, 860.3332417376521, 860.3418384935561, 860.5955201055494, 861.1990848510883, 510.6144860630238, 525.3774277481197, 526.5287567626953, 528.2235114381853, 607.8510764862593, 13643.454261829615, 13720.313984300845, 14296.714065718628, 14326.785098223534, 14338.354774035193, 13319.467221311135, 13388.263645499494, 13823.308834558231, 14090.0, 14100.788488172686, 12605.11764176508, 12941.0, 12994.740105197938, 13075.673108172277, 13193.0, 4447.288433850568, 4483.910321793578, 4503.527129651405, 4556.589906908394, 4696.295555666643, 84893.0, 85372.57313713392, 85727.0, 86496.99999999937, 87658.56170719105, 11101.83347249792, 11102.244735107297, 11591.594294199662, 11609.187356884937, 11634.883651163549, 21058.684119738216, 21413.143474261167, 21445.14219431205, 21470.677939830915, 21473.463163420725, 7929.1277959424415, 7939.404544659058, 8218.876716849252, 8384.580770961427, 8390.958045209856, 4727.267273572602, 4876.82931097417, 5034.345535080416, 5041.974790126026, 5042.470540593258, 3333.449980753197, 3417.3848707232937, 3423.281110966675, 3426.777259478176, 3427.9314413711586, 610.7251736718495, 632.7785275153659, 632.9208848893888, 634.5938599296454, 639.354252205276, 597.8684689368419, 606.6996836565839, 606.9094304388478, 611.6696983628791, 622.710439645567, 8642.740717778477, 9362.314783338928, 9782.219570405672, 9851.325274703318, 9865.901340986498, 525.6373102559222, 611.2267981003945, 616.2297128589263, 639.4500729372736, 641.7914177892204, 4642.396488456479, 4821.325014497973, 4846.636502262344, 4873.585745211697, 4894.853154405374, 118729.0, 119021.40489297498, 119809.40095299642, 120860.0, 122699.38650306691, 85833.0, 89165.55417222873, 99917.50041249892, 105967.0, 107008.0, 53848.73075634597, 83400.0, 84824.0, 85969.57015215009, 87707.56146219229, 9621.56702948355, 10290.176785857264, 10502.789944201226, 10503.73740656459, 10516.631917882838, 49132.0, 50204.24693629672, 50475.74762126166, 50571.24143137782, 51913.22130167975, 61784.0, 63690.68154659383, 66355.0, 70875.29124708688, 71827.28172718205, 13061.608151755463, 13249.735005300034, 13302.135361201492, 13691.0, 14156.646083847987, 13671.111377760413, 13735.0, 13779.0, 14320.641983950485, 14415.207163606103, 13765.174089554659, 13809.861901380858, 14215.0, 14873.405063797327, 14879.181645009628, 8827.823443531222, 13487.32563371847, 14108.788368174692, 14683.265836708335, 14771.187584682515, 13432.462701492223, 13447.125936814076, 13586.184828909902, 13683.021609222997, 13977.790333144807, 11187.72030699239, 11209.439528023404, 11720.589779357682, 11771.0, 11877.465514051715, 11654.592089276835, 11924.0, 11947.940260298643, 12176.330301833485, 12276.631701048982], "value": 7480.7107141825445, "unit": "score"}], "name": "dromaeo_css", "value": 7195.430328804432, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 111.0, 106.0, 112.0, 111.0, 111.0, 112.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 115.0, 122.0, 191.0, 122.0, 124.0, 151.0, 116.0, 150.0, 117.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 159.0, 160.0, 159.0, 162.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 113.0, 76.0, 76.0, 74.0, 75.0, 108.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 126.0, 85.0, 85.0, 85.0, 114.0, 84.0, 84.0, 123.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 51.0, 53.0, 52.0, 51.0, 53.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 81.0, 78.0, 84.0, 79.0, 84.0, 77.0, 78.0, 86.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 130.0, 127.0, 137.0, 132.0, 125.0, 123.0, 139.0, 139.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 165.0, 161.0, 165.0, 166.0, 164.0, 170.0, 165.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 63.0, 63.0, 63.0, 64.0, 65.0, 68.0, 63.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1498.3000000000002, "alertThreshold": 2.0}]} 16:00:08 INFO - Return code: 0 16:00:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:00:08 INFO - # TBPL SUCCESS # 16:00:08 INFO - Running post-action listener: _resource_record_post_action 16:00:08 INFO - [mozharness: 2016-08-15 23:00:08.089956Z] Finished run-tests step (success) 16:00:08 INFO - Running post-run listener: _resource_record_post_run 16:00:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407957504; Read time: 28; Write time: 377156 16:00:08 INFO - TinderboxPrint: CPU usage
13.1% 16:00:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 16:00:08 INFO - TinderboxPrint: I/O write bytes / time
407,957,504 / 377,156 16:00:08 INFO - TinderboxPrint: CPU idle
8,289.8 (86.9%) 16:00:08 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 16:00:08 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117178368; Read time: 0; Write time: 106956 16:00:08 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289542144; Read time: 0; Write time: 270140 16:00:08 INFO - Running post-run listener: _upload_blobber_files 16:00:08 INFO - Blob upload gear active. 16:00:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:08 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 16:00:08 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'] 16:00:08 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 16:00:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:15 INFO - (blobuploader) - INFO - Done attempting. 16:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:16 INFO - (blobuploader) - INFO - Done attempting. 16:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:16 INFO - (blobuploader) - INFO - Done attempting. 16:00:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:16 INFO - Return code: 0 16:00:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5b5986025e3733ead9e82d2fb48811d917553985b03e6fd647ae6429db3fab028165e4338f48729ad0fc31e3e3a81aed107b74136a2df1435c433ccc6f60d4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49992734b1fab3fdb7c8c27f79748cb53f69caea357794c8a1eff02e1e7f45f6cbf75238609b5f4fc8f813820904cb21fe712b26718db36d2ba0853838a4b52a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4128d72640f4f3b06cf5b008dde9258c0c4575390bf1a06f7bb920db4a49a6fae1b9ade7b8ad3cc6566c45afdf5dc940fb51c370f82b26fe9219a27c226554ed"} 16:00:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:16 INFO - Contents: 16:00:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5b5986025e3733ead9e82d2fb48811d917553985b03e6fd647ae6429db3fab028165e4338f48729ad0fc31e3e3a81aed107b74136a2df1435c433ccc6f60d4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49992734b1fab3fdb7c8c27f79748cb53f69caea357794c8a1eff02e1e7f45f6cbf75238609b5f4fc8f813820904cb21fe712b26718db36d2ba0853838a4b52a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4128d72640f4f3b06cf5b008dde9258c0c4575390bf1a06f7bb920db4a49a6fae1b9ade7b8ad3cc6566c45afdf5dc940fb51c370f82b26fe9219a27c226554ed"} 16:00:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:16 INFO - Copying logs to upload dir... 16:00:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.037313 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-15 16:00:15.956872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:00:15.961852) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370 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/e5b5986025e3733ead9e82d2fb48811d917553985b03e6fd647ae6429db3fab028165e4338f48729ad0fc31e3e3a81aed107b74136a2df1435c433ccc6f60d4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49992734b1fab3fdb7c8c27f79748cb53f69caea357794c8a1eff02e1e7f45f6cbf75238609b5f4fc8f813820904cb21fe712b26718db36d2ba0853838a4b52a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4128d72640f4f3b06cf5b008dde9258c0c4575390bf1a06f7bb920db4a49a6fae1b9ade7b8ad3cc6566c45afdf5dc940fb51c370f82b26fe9219a27c226554ed"} build_url:https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/cdEeSmXpRZ2e6jMC6tzE8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5b5986025e3733ead9e82d2fb48811d917553985b03e6fd647ae6429db3fab028165e4338f48729ad0fc31e3e3a81aed107b74136a2df1435c433ccc6f60d4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49992734b1fab3fdb7c8c27f79748cb53f69caea357794c8a1eff02e1e7f45f6cbf75238609b5f4fc8f813820904cb21fe712b26718db36d2ba0853838a4b52a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4128d72640f4f3b06cf5b008dde9258c0c4575390bf1a06f7bb920db4a49a6fae1b9ade7b8ad3cc6566c45afdf5dc940fb51c370f82b26fe9219a27c226554ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:00:15.990479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:00:15.990906) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471300773.875657-159487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004687 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:00:16.072139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:00:16.072456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:00:16.072749) ========= ========= Total master_lag: 0.18 =========