builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1471562635.26 results: success (0) buildid: 20160818143003 builduid: 1febe02b051a447da10946125d329dac revision: e7cfd78dee27a013c4e5be92e56d76080ffaf85d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.264791) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.265297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.265584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.280698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.281085) ========= 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=41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 16:23:55-- 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% 38.7M=0s 2016-08-18 16:23:55 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.401681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.405030) ========= 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=41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.457107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:55.457479) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e7cfd78dee27a013c4e5be92e56d76080ffaf85d --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 e7cfd78dee27a013c4e5be92e56d76080ffaf85d --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=41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 16:23:55,578 truncating revision to first 12 chars 2016-08-18 16:23:55,578 Setting DEBUG logging. 2016-08-18 16:23:55,578 attempt 1/10 2016-08-18 16:23:55,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e7cfd78dee27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 16:23:55,991 unpacking tar archive at: fx-team-e7cfd78dee27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.761993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:56.237485) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:56.237823) ========= script_repo_revision: e7cfd78dee27a013c4e5be92e56d76080ffaf85d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:56.238235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:56.238517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 16:23:56.248850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-18 16:23:56.249144) ========= /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=41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:23:56 INFO - MultiFileLogger online at 20160818 16:23:56 in /builds/slave/test 16:23:56 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 16:23:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:56 INFO - {'append_to_log': False, 16:23:56 INFO - 'base_work_dir': '/builds/slave/test', 16:23:56 INFO - 'blob_upload_branch': 'Fx-Team', 16:23:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:56 INFO - 'branch': 'Fx-Team', 16:23:56 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:56 INFO - 'config_files': ('talos/linux_config.py',), 16:23:56 INFO - 'default_actions': ('clobber', 16:23:56 INFO - 'read-buildbot-config', 16:23:56 INFO - 'download-and-extract', 16:23:56 INFO - 'populate-webroot', 16:23:56 INFO - 'create-virtualenv', 16:23:56 INFO - 'install', 16:23:56 INFO - 'run-tests'), 16:23:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:56 INFO - 'download_minidump_stackwalk': True, 16:23:56 INFO - 'download_symbols': 'ondemand', 16:23:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:56 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:56 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:56 INFO - 'installer_path': 'installer.exe', 16:23:56 INFO - 'log_level': 'info', 16:23:56 INFO - 'log_name': 'talos', 16:23:56 INFO - 'log_to_console': True, 16:23:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:23:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:23:56 INFO - 'opt_config_files': (), 16:23:56 INFO - 'pip_index': False, 16:23:56 INFO - 'sps_profile': False, 16:23:56 INFO - 'sps_profile_interval': 0, 16:23:56 INFO - 'suite': 'dromaeojs', 16:23:56 INFO - 'system_bits': '32', 16:23:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:56 INFO - 'title': 'talos-linux64-ix-026', 16:23:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:56 INFO - 'use_talos_json': True, 16:23:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:56 INFO - 'work_dir': 'build'} 16:23:56 INFO - [mozharness: 2016-08-18 23:23:56.459309Z] Running clobber step. 16:23:56 INFO - Running pre-action listener: _resource_record_pre_action 16:23:56 INFO - Running main action method: clobber 16:23:56 INFO - rmtree: /builds/slave/test/build 16:23:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:57 INFO - Running post-action listener: _resource_record_post_action 16:23:57 INFO - [mozharness: 2016-08-18 23:23:57.441291Z] Finished clobber step (success) 16:23:57 INFO - [mozharness: 2016-08-18 23:23:57.441390Z] Running read-buildbot-config step. 16:23:57 INFO - Running pre-action listener: _resource_record_pre_action 16:23:57 INFO - Running main action method: read_buildbot_config 16:23:57 INFO - Using buildbot properties: 16:23:57 INFO - { 16:23:57 INFO - "project": "", 16:23:57 INFO - "product": "firefox", 16:23:57 INFO - "script_repo_revision": "production", 16:23:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:23:57 INFO - "repository": "", 16:23:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:23:57 INFO - "buildid": "20160818143003", 16:23:57 INFO - "pgo_build": "True", 16:23:57 INFO - "basedir": "/builds/slave/test", 16:23:57 INFO - "buildnumber": 992, 16:23:57 INFO - "slavename": "talos-linux64-ix-026", 16:23:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:23:57 INFO - "platform": "ubuntu64_hw", 16:23:57 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:23:57 INFO - "branch": "fx-team", 16:23:57 INFO - "repo_path": "integration/fx-team", 16:23:57 INFO - "revision": "e7cfd78dee27a013c4e5be92e56d76080ffaf85d", 16:23:57 INFO - "stage_platform": "linux64-pgo", 16:23:57 INFO - "builduid": "1febe02b051a447da10946125d329dac", 16:23:57 INFO - "slavebuilddir": "test" 16:23:57 INFO - } 16:23:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:23:57 INFO - Running post-action listener: _resource_record_post_action 16:23:57 INFO - [mozharness: 2016-08-18 23:23:57.443795Z] Finished read-buildbot-config step (success) 16:23:57 INFO - [mozharness: 2016-08-18 23:23:57.443883Z] Running download-and-extract step. 16:23:57 INFO - Running pre-action listener: _resource_record_pre_action 16:23:57 INFO - Running main action method: download_and_extract 16:23:57 INFO - mkdir: /builds/slave/test/build/tests 16:23:57 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')]} 16:23:57 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:23:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:23:58 INFO - Downloaded 1361 bytes. 16:23:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:23:58 INFO - Using the following test package requirements: 16:23:58 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:23:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:23:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'jsshell-linux-x86_64.zip'], 16:23:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:23:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:23:58 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:23:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:23:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:58 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:23:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:23: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')]} 16:23:58 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:23:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:23:59 INFO - Downloaded 21907579 bytes. 16:23:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:24:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:03 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:24:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:24:04 INFO - Downloaded 21907579 bytes. 16:24:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:24: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')]} 16:24:08 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:24:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:24:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:24:09 INFO - Downloaded 14413981 bytes. 16:24:09 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 16:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:09 INFO - trying https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:24:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:24:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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 16:24:11 INFO - Downloaded 59594219 bytes. 16:24:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:24:11 INFO - mkdir: /builds/slave/test/properties 16:24:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:24:11 INFO - Writing to file /builds/slave/test/properties/build_url 16:24:11 INFO - Contents: 16:24:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:24:12 INFO - Running post-action listener: _resource_record_post_action 16:24:12 INFO - Running post-action listener: set_extra_try_arguments 16:24:12 INFO - [mozharness: 2016-08-18 23:24:12.448672Z] Finished download-and-extract step (success) 16:24:12 INFO - [mozharness: 2016-08-18 23:24:12.448896Z] Running populate-webroot step. 16:24:12 INFO - Running pre-action listener: _resource_record_pre_action 16:24:12 INFO - Running main action method: populate_webroot 16:24:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:24:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:24:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:24:12 INFO - '--tppagecycles', 16:24:12 INFO - '7'], 16:24:12 INFO - 'tests': ['tsvgm']}}, 16:24:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:24:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:24:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:24:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:24:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['damp', 'tps']}, 16:24:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'tests': ['damp', 'tps']}, 16:24:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['dromaeo_dom']}, 16:24:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:24:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['basic_compositor_video']}, 16:24:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:24:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['a11yr', 16:24:12 INFO - 'ts_paint', 16:24:12 INFO - 'tpaint', 16:24:12 INFO - 'sessionrestore', 16:24:12 INFO - 'sessionrestore_no_auto_restore', 16:24:12 INFO - 'tabpaint']}, 16:24:12 INFO - 'other-e10s': {'tests': ['a11yr', 16:24:12 INFO - 'ts_paint', 16:24:12 INFO - 'tpaint', 16:24:12 INFO - 'sessionrestore', 16:24:12 INFO - 'sessionrestore_no_auto_restore', 16:24:12 INFO - 'tabpaint']}, 16:24:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:24:12 INFO - 'ts_paint', 16:24:12 INFO - 'tpaint', 16:24:12 INFO - 'sessionrestore', 16:24:12 INFO - 'sessionrestore_no_auto_restore', 16:24:12 INFO - 'tabpaint']}, 16:24:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:24:12 INFO - 'ts_paint', 16:24:12 INFO - 'tpaint', 16:24:12 INFO - 'sessionrestore', 16:24:12 INFO - 'sessionrestore_no_auto_restore', 16:24:12 INFO - 'tabpaint']}, 16:24:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['a11yr', 16:24:12 INFO - 'ts_paint', 16:24:12 INFO - 'tpaint', 16:24:12 INFO - 'sessionrestore', 16:24:12 INFO - 'sessionrestore_no_auto_restore', 16:24:12 INFO - 'tabpaint']}, 16:24:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['a11yr', 16:24:12 INFO - 'ts_paint', 16:24:12 INFO - 'tpaint', 16:24:12 INFO - 'sessionrestore', 16:24:12 INFO - 'sessionrestore_no_auto_restore', 16:24:12 INFO - 'tabpaint']}, 16:24:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['tsvgx', 16:24:12 INFO - 'tsvgr_opacity', 16:24:12 INFO - 'tart', 16:24:12 INFO - 'tscrollx', 16:24:12 INFO - 'cart']}, 16:24:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:24:12 INFO - 'tsvgr_opacity', 16:24:12 INFO - 'tart', 16:24:12 INFO - 'tscrollx', 16:24:12 INFO - 'cart']}, 16:24:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'talos_options': ['--disable-e10s'], 16:24:12 INFO - 'tests': ['tp5o']}, 16:24:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'tests': ['tp5o']}, 16:24:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'talos_options': ['--disable-e10s', 16:24:12 INFO - '--xperf_path', 16:24:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:12 INFO - 'tests': ['tp5n']}, 16:24:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:12 INFO - 'talos_options': ['--xperf_path', 16:24:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:12 INFO - 'tests': ['tp5n']}}, 16:24:12 INFO - 'talos.zip': {'path': '', 16:24:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:24:12 INFO - Running post-action listener: _resource_record_post_action 16:24:12 INFO - [mozharness: 2016-08-18 23:24:12.464901Z] Finished populate-webroot step (success) 16:24:12 INFO - [mozharness: 2016-08-18 23:24:12.465008Z] Running create-virtualenv step. 16:24:12 INFO - Running pre-action listener: _resource_record_pre_action 16:24:12 INFO - Running main action method: create_virtualenv 16:24:12 INFO - Creating virtualenv /builds/slave/test/build/venv 16:24:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:24:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:24:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:24:12 INFO - Using real prefix '/usr' 16:24:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:24:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:24:15 INFO - Installing pip.................done. 16:24:15 INFO - Return code: 0 16:24:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:24:15 INFO - Using env: {'DISPLAY': ':0', 16:24:15 INFO - 'HOME': '/home/cltbld', 16:24:15 INFO - 'LANG': 'en_US.UTF-8', 16:24:15 INFO - 'LANGUAGE': 'en_US:en', 16:24:15 INFO - 'LOGNAME': 'cltbld', 16:24:15 INFO - 'MAIL': '/var/mail/cltbld', 16:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:15 INFO - 'MOZ_NO_REMOTE': '1', 16:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:15 INFO - 'NO_EM_RESTART': '1', 16:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:15 INFO - 'PWD': '/builds/slave/test', 16:24:15 INFO - 'SHELL': '/bin/bash', 16:24:15 INFO - 'SHLVL': '1', 16:24:15 INFO - 'TERM': 'linux', 16:24:15 INFO - 'TMOUT': '86400', 16:24:15 INFO - 'USER': 'cltbld', 16:24:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:15 INFO - '_': '/tools/buildbot/bin/python'} 16:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:24:15 INFO - Cleaning up... 16:24:15 INFO - Return code: 0 16:24:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:24:15 INFO - Using env: {'DISPLAY': ':0', 16:24:15 INFO - 'HOME': '/home/cltbld', 16:24:15 INFO - 'LANG': 'en_US.UTF-8', 16:24:15 INFO - 'LANGUAGE': 'en_US:en', 16:24:15 INFO - 'LOGNAME': 'cltbld', 16:24:15 INFO - 'MAIL': '/var/mail/cltbld', 16:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:15 INFO - 'MOZ_NO_REMOTE': '1', 16:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:15 INFO - 'NO_EM_RESTART': '1', 16:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:15 INFO - 'PWD': '/builds/slave/test', 16:24:15 INFO - 'SHELL': '/bin/bash', 16:24:15 INFO - 'SHLVL': '1', 16:24:15 INFO - 'TERM': 'linux', 16:24:15 INFO - 'TMOUT': '86400', 16:24:15 INFO - 'USER': 'cltbld', 16:24:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:15 INFO - '_': '/tools/buildbot/bin/python'} 16:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:15 INFO - Downloading/unpacking psutil>=3.1.1 16:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:24:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:17 INFO - Installing collected packages: psutil 16:24:17 INFO - Running setup.py install for psutil 16:24:17 INFO - building 'psutil._psutil_linux' extension 16:24:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:24:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:24:17 INFO - building 'psutil._psutil_posix' extension 16:24:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:24:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:24:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:17 INFO - Successfully installed psutil 16:24:17 INFO - Cleaning up... 16:24:17 INFO - Return code: 0 16:24:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:24:18 INFO - Using env: {'DISPLAY': ':0', 16:24:18 INFO - 'HOME': '/home/cltbld', 16:24:18 INFO - 'LANG': 'en_US.UTF-8', 16:24:18 INFO - 'LANGUAGE': 'en_US:en', 16:24:18 INFO - 'LOGNAME': 'cltbld', 16:24:18 INFO - 'MAIL': '/var/mail/cltbld', 16:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:18 INFO - 'MOZ_NO_REMOTE': '1', 16:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:18 INFO - 'NO_EM_RESTART': '1', 16:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:18 INFO - 'PWD': '/builds/slave/test', 16:24:18 INFO - 'SHELL': '/bin/bash', 16:24:18 INFO - 'SHLVL': '1', 16:24:18 INFO - 'TERM': 'linux', 16:24:18 INFO - 'TMOUT': '86400', 16:24:18 INFO - 'USER': 'cltbld', 16:24:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:18 INFO - '_': '/tools/buildbot/bin/python'} 16:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:24:20 INFO - Installing collected packages: mozsystemmonitor 16:24:20 INFO - Running setup.py install for mozsystemmonitor 16:24:20 INFO - Successfully installed mozsystemmonitor 16:24:20 INFO - Cleaning up... 16:24:20 INFO - Return code: 0 16:24:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:24:20 INFO - Using env: {'DISPLAY': ':0', 16:24:20 INFO - 'HOME': '/home/cltbld', 16:24:20 INFO - 'LANG': 'en_US.UTF-8', 16:24:20 INFO - 'LANGUAGE': 'en_US:en', 16:24:20 INFO - 'LOGNAME': 'cltbld', 16:24:20 INFO - 'MAIL': '/var/mail/cltbld', 16:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:20 INFO - 'MOZ_NO_REMOTE': '1', 16:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:20 INFO - 'NO_EM_RESTART': '1', 16:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:20 INFO - 'PWD': '/builds/slave/test', 16:24:20 INFO - 'SHELL': '/bin/bash', 16:24:20 INFO - 'SHLVL': '1', 16:24:20 INFO - 'TERM': 'linux', 16:24:20 INFO - 'TMOUT': '86400', 16:24:20 INFO - 'USER': 'cltbld', 16:24:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:20 INFO - '_': '/tools/buildbot/bin/python'} 16:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:20 INFO - Downloading/unpacking jsonschema==2.5.1 16:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:24:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:24:22 INFO - warning: no files found matching '*.txt' 16:24:22 INFO - no previously-included directories found matching 'build' 16:24:22 INFO - no previously-included directories found matching 'dist' 16:24:22 INFO - no previously-included directories found matching '.git*' 16:24:22 INFO - Installing collected packages: jsonschema, functools32 16:24:22 INFO - Running setup.py install for functools32 16:24:22 INFO - warning: no files found matching '*.txt' 16:24:22 INFO - no previously-included directories found matching 'build' 16:24:22 INFO - no previously-included directories found matching 'dist' 16:24:22 INFO - no previously-included directories found matching '.git*' 16:24:22 INFO - Successfully installed jsonschema functools32 16:24:22 INFO - Cleaning up... 16:24:22 INFO - Return code: 0 16:24:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:24:22 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')]} 16:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:22 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')]} 16:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:22 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 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:22 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 16:24:22 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 16:24:22 INFO - Using env: {'DISPLAY': ':0', 16:24:22 INFO - 'HOME': '/home/cltbld', 16:24:22 INFO - 'LANG': 'en_US.UTF-8', 16:24:22 INFO - 'LANGUAGE': 'en_US:en', 16:24:22 INFO - 'LOGNAME': 'cltbld', 16:24:22 INFO - 'MAIL': '/var/mail/cltbld', 16:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:22 INFO - 'MOZ_NO_REMOTE': '1', 16:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:22 INFO - 'NO_EM_RESTART': '1', 16:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:22 INFO - 'PWD': '/builds/slave/test', 16:24:22 INFO - 'SHELL': '/bin/bash', 16:24:22 INFO - 'SHLVL': '1', 16:24:22 INFO - 'TERM': 'linux', 16:24:22 INFO - 'TMOUT': '86400', 16:24:22 INFO - 'USER': 'cltbld', 16:24:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:22 INFO - '_': '/tools/buildbot/bin/python'} 16:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:24:23 INFO - Cleaning up... 16:24:23 INFO - Return code: 0 16:24:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:24:23 INFO - Using env: {'DISPLAY': ':0', 16:24:23 INFO - 'HOME': '/home/cltbld', 16:24:23 INFO - 'LANG': 'en_US.UTF-8', 16:24:23 INFO - 'LANGUAGE': 'en_US:en', 16:24:23 INFO - 'LOGNAME': 'cltbld', 16:24:23 INFO - 'MAIL': '/var/mail/cltbld', 16:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:23 INFO - 'MOZ_NO_REMOTE': '1', 16:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:23 INFO - 'NO_EM_RESTART': '1', 16:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:23 INFO - 'PWD': '/builds/slave/test', 16:24:23 INFO - 'SHELL': '/bin/bash', 16:24:23 INFO - 'SHLVL': '1', 16:24:23 INFO - 'TERM': 'linux', 16:24:23 INFO - 'TMOUT': '86400', 16:24:23 INFO - 'USER': 'cltbld', 16:24:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:23 INFO - '_': '/tools/buildbot/bin/python'} 16:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 16:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:24:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:25 INFO - Downloading docopt-0.6.1.tar.gz 16:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:24:25 INFO - Installing collected packages: blobuploader, requests, docopt 16:24:25 INFO - Running setup.py install for blobuploader 16:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:24:26 INFO - Running setup.py install for requests 16:24:26 INFO - Running setup.py install for docopt 16:24:26 INFO - Successfully installed blobuploader requests docopt 16:24:26 INFO - Cleaning up... 16:24:26 INFO - Return code: 0 16:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:24:26 INFO - Using env: {'DISPLAY': ':0', 16:24:26 INFO - 'HOME': '/home/cltbld', 16:24:26 INFO - 'LANG': 'en_US.UTF-8', 16:24:26 INFO - 'LANGUAGE': 'en_US:en', 16:24:26 INFO - 'LOGNAME': 'cltbld', 16:24:26 INFO - 'MAIL': '/var/mail/cltbld', 16:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:26 INFO - 'MOZ_NO_REMOTE': '1', 16:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:26 INFO - 'NO_EM_RESTART': '1', 16:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:26 INFO - 'PWD': '/builds/slave/test', 16:24:26 INFO - 'SHELL': '/bin/bash', 16:24:26 INFO - 'SHLVL': '1', 16:24:26 INFO - 'TERM': 'linux', 16:24:26 INFO - 'TMOUT': '86400', 16:24:26 INFO - 'USER': 'cltbld', 16:24:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:26 INFO - '_': '/tools/buildbot/bin/python'} 16:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:26 INFO - Running setup.py (path:/tmp/pip-1jdeSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:26 INFO - Running setup.py (path:/tmp/pip-SEkQ6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:26 INFO - Running setup.py (path:/tmp/pip-wtaEVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:27 INFO - Running setup.py (path:/tmp/pip-eG4LXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:27 INFO - Running setup.py (path:/tmp/pip-6DyKmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:27 INFO - Running setup.py (path:/tmp/pip-T0p8Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:27 INFO - Running setup.py (path:/tmp/pip-OZNW9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:27 INFO - Running setup.py (path:/tmp/pip-waMjQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:27 INFO - Running setup.py (path:/tmp/pip-qpxW2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:27 INFO - Running setup.py (path:/tmp/pip-5u7Ip8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:27 INFO - Running setup.py (path:/tmp/pip-Zczzp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:27 INFO - Running setup.py (path:/tmp/pip-u9ffgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:27 INFO - Running setup.py (path:/tmp/pip-Heetdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:27 INFO - Running setup.py (path:/tmp/pip-XRBP7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:27 INFO - Running setup.py (path:/tmp/pip-Rdl5nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:27 INFO - Running setup.py (path:/tmp/pip-hkl0d2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:27 INFO - Running setup.py (path:/tmp/pip-5F80Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:24:28 INFO - Running setup.py install for manifestparser 16:24:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Running setup.py install for mozcrash 16:24:28 INFO - Running setup.py install for mozdebug 16:24:28 INFO - Running setup.py install for mozdevice 16:24:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Running setup.py install for mozfile 16:24:28 INFO - Running setup.py install for mozhttpd 16:24:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Running setup.py install for mozinfo 16:24:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Running setup.py install for mozInstall 16:24:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Running setup.py install for mozleak 16:24:28 INFO - Running setup.py install for mozlog 16:24:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for moznetwork 16:24:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozprocess 16:24:29 INFO - Running setup.py install for mozprofile 16:24:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozrunner 16:24:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozscreenshot 16:24:29 INFO - Running setup.py install for moztest 16:24:29 INFO - Running setup.py install for mozversion 16:24:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:24:29 INFO - Cleaning up... 16:24:29 INFO - Return code: 0 16:24:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:29 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 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:29 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 16:24:29 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 16:24:29 INFO - Using env: {'DISPLAY': ':0', 16:24:29 INFO - 'HOME': '/home/cltbld', 16:24:29 INFO - 'LANG': 'en_US.UTF-8', 16:24:29 INFO - 'LANGUAGE': 'en_US:en', 16:24:29 INFO - 'LOGNAME': 'cltbld', 16:24:29 INFO - 'MAIL': '/var/mail/cltbld', 16:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:29 INFO - 'MOZ_NO_REMOTE': '1', 16:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:29 INFO - 'NO_EM_RESTART': '1', 16:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:29 INFO - 'PWD': '/builds/slave/test', 16:24:29 INFO - 'SHELL': '/bin/bash', 16:24:29 INFO - 'SHLVL': '1', 16:24:29 INFO - 'TERM': 'linux', 16:24:29 INFO - 'TMOUT': '86400', 16:24:29 INFO - 'USER': 'cltbld', 16:24:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:29 INFO - '_': '/tools/buildbot/bin/python'} 16:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:30 INFO - Running setup.py (path:/tmp/pip-VvxBso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:30 INFO - Running setup.py (path:/tmp/pip-92vQNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:30 INFO - Running setup.py (path:/tmp/pip-iZRMnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:30 INFO - Running setup.py (path:/tmp/pip-hpMTpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:30 INFO - Running setup.py (path:/tmp/pip-cjxj6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:30 INFO - Running setup.py (path:/tmp/pip-D5zmeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:30 INFO - Running setup.py (path:/tmp/pip-peLO4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:30 INFO - Running setup.py (path:/tmp/pip-xFFwHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:30 INFO - Running setup.py (path:/tmp/pip-U7xKIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:30 INFO - Running setup.py (path:/tmp/pip-jOaF0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:30 INFO - Running setup.py (path:/tmp/pip-OhYw9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:30 INFO - Running setup.py (path:/tmp/pip-h70BsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:30 INFO - Running setup.py (path:/tmp/pip-OXMwmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:30 INFO - Running setup.py (path:/tmp/pip-NY3kVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:31 INFO - Running setup.py (path:/tmp/pip-7entbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:31 INFO - Running setup.py (path:/tmp/pip-SaO5oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:31 INFO - Running setup.py (path:/tmp/pip-MS_Vj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:24:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:33 INFO - Downloading blessings-1.6.tar.gz 16:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:24:33 INFO - Installing collected packages: blessings 16:24:33 INFO - Running setup.py install for blessings 16:24:33 INFO - Successfully installed blessings 16:24:33 INFO - Cleaning up... 16:24:33 INFO - Return code: 0 16:24:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:24:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:33 INFO - Reading from file tmpfile_stdout 16:24:33 INFO - Current package versions: 16:24:33 INFO - argparse == 1.2.1 16:24:33 INFO - blessings == 1.6 16:24:33 INFO - blobuploader == 1.2.4 16:24:33 INFO - docopt == 0.6.1 16:24:33 INFO - functools32 == 3.2.3-2 16:24:33 INFO - jsonschema == 2.5.1 16:24:33 INFO - manifestparser == 1.1 16:24:33 INFO - mozInstall == 1.12 16:24:33 INFO - mozcrash == 0.17 16:24:33 INFO - mozdebug == 0.1 16:24:33 INFO - mozdevice == 0.48 16:24:33 INFO - mozfile == 1.2 16:24:33 INFO - mozhttpd == 0.7 16:24:33 INFO - mozinfo == 0.9 16:24:33 INFO - mozleak == 0.1 16:24:33 INFO - mozlog == 3.3 16:24:33 INFO - moznetwork == 0.27 16:24:33 INFO - mozprocess == 0.23 16:24:33 INFO - mozprofile == 0.28 16:24:33 INFO - mozrunner == 6.12 16:24:33 INFO - mozscreenshot == 0.1 16:24:33 INFO - mozsystemmonitor == 0.3 16:24:33 INFO - moztest == 0.7 16:24:33 INFO - mozversion == 1.4 16:24:33 INFO - psutil == 3.1.1 16:24:33 INFO - requests == 1.2.3 16:24:33 INFO - wsgiref == 0.1.2 16:24:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:24:33 INFO - Using env: {'DISPLAY': ':0', 16:24:33 INFO - 'HOME': '/home/cltbld', 16:24:33 INFO - 'LANG': 'en_US.UTF-8', 16:24:33 INFO - 'LANGUAGE': 'en_US:en', 16:24:33 INFO - 'LOGNAME': 'cltbld', 16:24:33 INFO - 'MAIL': '/var/mail/cltbld', 16:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:33 INFO - 'MOZ_NO_REMOTE': '1', 16:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:33 INFO - 'NO_EM_RESTART': '1', 16:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:33 INFO - 'PWD': '/builds/slave/test', 16:24:33 INFO - 'SHELL': '/bin/bash', 16:24:33 INFO - 'SHLVL': '1', 16:24:33 INFO - 'TERM': 'linux', 16:24:33 INFO - 'TMOUT': '86400', 16:24:33 INFO - 'USER': 'cltbld', 16:24:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:33 INFO - '_': '/tools/buildbot/bin/python'} 16:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 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)) 16:24:33 INFO - Cleaning up... 16:24:33 INFO - Return code: 0 16:24:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b58875f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, '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': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', '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 16:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:24:33 INFO - Using env: {'DISPLAY': ':0', 16:24:33 INFO - 'HOME': '/home/cltbld', 16:24:33 INFO - 'LANG': 'en_US.UTF-8', 16:24:33 INFO - 'LANGUAGE': 'en_US:en', 16:24:33 INFO - 'LOGNAME': 'cltbld', 16:24:33 INFO - 'MAIL': '/var/mail/cltbld', 16:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:33 INFO - 'MOZ_NO_REMOTE': '1', 16:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:33 INFO - 'NO_EM_RESTART': '1', 16:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:33 INFO - 'PWD': '/builds/slave/test', 16:24:33 INFO - 'SHELL': '/bin/bash', 16:24:33 INFO - 'SHLVL': '1', 16:24:33 INFO - 'TERM': 'linux', 16:24:33 INFO - 'TMOUT': '86400', 16:24:33 INFO - 'USER': 'cltbld', 16:24:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:33 INFO - '_': '/tools/buildbot/bin/python'} 16:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:24:34 INFO - Cleaning up... 16:24:34 INFO - Return code: 0 16:24:34 INFO - Running post-action listener: _resource_record_post_action 16:24:34 INFO - Running post-action listener: _start_resource_monitoring 16:24:34 INFO - Starting resource monitoring. 16:24:34 INFO - [mozharness: 2016-08-18 23:24:34.069090Z] Finished create-virtualenv step (success) 16:24:34 INFO - [mozharness: 2016-08-18 23:24:34.069615Z] Running install step. 16:24:34 INFO - Running pre-action listener: _resource_record_pre_action 16:24:34 INFO - Running main action method: install 16:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:34 INFO - Reading from file tmpfile_stdout 16:24:34 INFO - Detecting whether we're running mozinstall >=1.0... 16:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:24:34 INFO - Reading from file tmpfile_stdout 16:24:34 INFO - Output received: 16:24:34 INFO - Usage: mozinstall [options] installer 16:24:34 INFO - Options: 16:24:34 INFO - -h, --help show this help message and exit 16:24:34 INFO - -d DEST, --destination=DEST 16:24:34 INFO - Directory to install application into. [default: 16:24:34 INFO - "/builds/slave/test"] 16:24:34 INFO - --app=APP Application being installed. [default: firefox] 16:24:34 INFO - mkdir: /builds/slave/test/build/application 16:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:24:51 INFO - Reading from file tmpfile_stdout 16:24:51 INFO - Output received: 16:24:51 INFO - /builds/slave/test/build/application/firefox/firefox 16:24:51 INFO - Running post-action listener: _resource_record_post_action 16:24:51 INFO - [mozharness: 2016-08-18 23:24:51.306892Z] Finished install step (success) 16:24:51 INFO - [mozharness: 2016-08-18 23:24:51.307139Z] Running run-tests step. 16:24:51 INFO - Running pre-action listener: _resource_record_pre_action 16:24:51 INFO - Running main action method: run_tests 16:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:24:51 INFO - Python 2.7.3 16:24:51 INFO - Return code: 0 16:24:51 INFO - grabbing minidump binary from tooltool 16:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5c370>, '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 0x2a5f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a5fd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:24:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:24:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:24:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:24:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:24:51 INFO - Return code: 0 16:24:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:24:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:24:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:24:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:24:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 16:24:51 INFO - Using env: {'DISPLAY': ':0', 16:24:51 INFO - 'HOME': '/home/cltbld', 16:24:51 INFO - 'LANG': 'en_US.UTF-8', 16:24:51 INFO - 'LANGUAGE': 'en_US:en', 16:24:51 INFO - 'LOGNAME': 'cltbld', 16:24:51 INFO - 'MAIL': '/var/mail/cltbld', 16:24:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:24:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:51 INFO - 'MOZ_NO_REMOTE': '1', 16:24:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:51 INFO - 'NO_EM_RESTART': '1', 16:24:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:51 INFO - 'PWD': '/builds/slave/test', 16:24:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:24:51 INFO - 'SHELL': '/bin/bash', 16:24:51 INFO - 'SHLVL': '1', 16:24:51 INFO - 'TERM': 'linux', 16:24:51 INFO - 'TMOUT': '86400', 16:24:51 INFO - 'USER': 'cltbld', 16:24:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317', 16:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:51 INFO - '_': '/tools/buildbot/bin/python'} 16:24:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:24:51 INFO - mozversion application_buildid: 20160818143003 16:24:51 INFO - mozversion application_changeset: e7cfd78dee27a013c4e5be92e56d76080ffaf85d 16:24:51 INFO - mozversion application_display_name: Nightly 16:24:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:24:51 INFO - mozversion application_name: Firefox 16:24:51 INFO - mozversion application_remotingname: firefox 16:24:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:24:51 INFO - mozversion application_vendor: Mozilla 16:24:51 INFO - mozversion application_version: 51.0a1 16:24:51 INFO - mozversion platform_buildid: 20160818143003 16:24:51 INFO - mozversion platform_changeset: e7cfd78dee27a013c4e5be92e56d76080ffaf85d 16:24:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:24:51 INFO - mozversion platform_version: 51.0a1 16:24:51 INFO - using testdate: 1471562691 16:24:51 INFO - actual date: 1471562691 16:24:51 INFO - starting webserver on 'localhost:47284' 16:24:51 INFO - SUITE-START | Running 2 tests 16:24:51 INFO - TEST-START | dromaeo_css 16:24:51 INFO - operating with platform_type : linux_ 16:24:51 INFO - Initialising browser for dromaeo_css test... 16:24:51 INFO - TEST-INFO | started process 30456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJR3YWJ/profile http://localhost:47284/getInfo.html) 16:24:55 INFO - PROCESS | 30456 | __metrics Screen width/height:1600/1200 16:24:55 INFO - PROCESS | 30456 | colorDepth:24 16:24:55 INFO - PROCESS | 30456 | Browser inner width/height: 1024/697 16:24:55 INFO - PROCESS | 30456 | __metrics 16:24:55 INFO - PROCESS | 30456 | 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" 16:24:55 INFO - PROCESS | 30456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:56 INFO - PROCESS | 30456 | console.error: PushService: 16:24:56 INFO - PROCESS | 30456 | stateChangeProcessEnqueue: Error transitioning state 16:24:56 INFO - PROCESS | 30456 | UnknownError 16:24:57 INFO - TEST-INFO | 30456: exit 0 16:24:57 INFO - Browser initialized. 16:24:57 INFO - Running cycle 1/1 for dromaeo_css test... 16:24:57 INFO - TEST-INFO | started process 30537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJR3YWJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:08 INFO - PROCESS | 30537 | RSS: Main: 156078080 16:25:08 INFO - PROCESS | 30537 | 16:26:00 INFO - PROCESS | 30537 | 1471562760451 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] 16:28:09 INFO - PROCESS | 30537 | Cycle 1(1): loaded http://localhost:47284/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47284/tests/dromaeo/cssquery-ext.html) 16:28:10 INFO - PROCESS | 30537 | RSS: Main: 261144576 16:28:10 INFO - PROCESS | 30537 | 16:31:13 INFO - PROCESS | 30537 | Cycle 1(1): loaded http://localhost:47284/tests/dromaeo/cssquery-ext.html (next: http://localhost:47284/tests/dromaeo/cssquery-jquery.html) 16:31:14 INFO - PROCESS | 30537 | RSS: Main: 244842496 16:31:14 INFO - PROCESS | 30537 | 16:34:16 INFO - PROCESS | 30537 | Cycle 1(1): loaded http://localhost:47284/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47284/tests/dromaeo/cssquery-mootools.html) 16:34:16 INFO - PROCESS | 30537 | RSS: Main: 211722240 16:34:16 INFO - PROCESS | 30537 | 16:37:18 INFO - PROCESS | 30537 | Cycle 1(1): loaded http://localhost:47284/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47284/tests/dromaeo/cssquery-prototype.html) 16:37:19 INFO - PROCESS | 30537 | RSS: Main: 209240064 16:37:19 INFO - PROCESS | 30537 | 16:40:22 INFO - PROCESS | 30537 | Cycle 1(1): loaded http://localhost:47284/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47284/tests/dromaeo/cssquery-yui.html) 16:40:22 INFO - PROCESS | 30537 | RSS: Main: 186265600 16:40:22 INFO - PROCESS | 30537 | 16:43:25 INFO - PROCESS | 30537 | Cycle 1(1): loaded http://localhost:47284/tests/dromaeo/cssquery-yui.html (next: http://localhost:47284/tests/dromaeo/cssquery-dojo.html) 16:43:26 INFO - PROCESS | 30537 | RSS: Main: 278548480 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | __start_tp_report 16:43:26 INFO - PROCESS | 30537 | _x_x_mozilla_page_load 16:43:26 INFO - PROCESS | 30537 | _x_x_mozilla_page_load_details 16:43:26 INFO - PROCESS | 30537 | |i|pagename|runs| 16:43:26 INFO - PROCESS | 30537 | |0;dojo.html;3019.501782205936;3053.282478617523;3072.2319420144972;3078.892238771642;3084.5373194020895;5131.615128865331;5273.5781137509;5339.70631615261;5463.071277882759;5485.369182544004;5264.289320941682;5347.278117454142;5350.384705758829;5383.67697938123;5413.810516631918;4840.806367745286;4887.1447496688115;4955.677880937746;4978.726170060645;5090.0328937501945;4976.178930476467;5007.4491805901325;5021.723805190713;5034.42104158021;5039.848804535852;4740.952590474086;4769.737664428455;4847.466778654345;4899.951000489985;4931.334269873575;4841.878953026167;4849.733264670442;4857.781399837016;4966.652334336598;4980.452150263468;4838.903221935577;4861.392325959255;4871.342368780205;4919.26211068339;4931.186354251544;5228.764705588258;5240.449752775941;5364.758585863646;5366.91949620756;5408.864778380533;5712.200291959129;5762.654240745527;5772.278465191851;5777.768889244425;5786.247787787561;5735.799247026334;5794.217780599607;5805.187273781632;5807.854803629901;5807.941920580783;5145.845624631267;5314.043472175045;5361.973190134025;5405.432429594875;5411.026015317241;5915.852103697356;5916.023856063787;5916.585838991229;5961;5968.045112782021;5633.718314084279;5633.971830140823;5669.177969194526;5680.204771332017;5681.545476361881;5564.054110801174;5677.80127695537;5728.312602487645;5797.36229014808;5801.3328467225965;5788.450097240755;5792.594518383757;5795.536357091422;5810.477057064884;5837.503812176013;5754.683492407958;5784.421557844266;5801.593888427769;5805.593608447368;5810.448007439287;4289.077848262638;4349.782510874507;4385.101054283864;4451.710638808532;4463.888402789891;3907.1013666856784;3932.3511620582854;3933.685305175636;3959.4060890866026;3978.5424676162033;5413.593980451482;5420.105682562333;5423.240746295522;5428.891422171534;5472.015037293326;5583.776648934078;5732.226149469851;5737.88524229513;5748.7125643717645;5815.476607105296;5503.036968530491;5523.199136125239;5527.640703354269;5547.057000309957;5547.223388725582;5041.269015992661;5048.873778155502;5054.873628159326;5059.19052951526;5090.08378491875;5747.568932330092;5958.463738263577;6018.428249316308;6090.634561926298;6101.359357267512;5839.15332276809;5849.181114644039;5850.619709718854;5879.147523609138;5900.586958912835;6047.697615119138;6059.909101363572;6060.333363329942;6066.302375226729;6066.332703402711;5455.454454554513;5647.576431767552;5658.405867383865;5695.288088988877;5743.483086522066;5809.186713860147;5848.064309710426;5850.619709718854;5872.148538461814;5899.085641725539;5695.117256825199;5701.7434215461235;5702.230198923092;5706.828795136153;5707.714614269187;5354.196870469461;5510.559155267649;5558.166275058774;5667.03660377745;5670.149477578396;5603.131514615241;5611.1022236443605;5611.971940140274;5653.689047102449;5665.036943719495;5611.775528978795;5641.548676105819;5669.34802497718;5682.147677848356;5687.402822703557;5486.862828429321;5487.807926722546;5520.199571062093;5524.33707955048;5531.917021244765 16:43:26 INFO - PROCESS | 30537 | |1;ext.html;570.7545755325211;587.8265911556091;590.1914377303095;598.5989387110635;618.7370367593775;43638.563614363884;45672;45779.08441831161;45833.77083114584;49473;47126.764366178206;47617.523824761745;47621;47623.28565071527;47719;8994.3703940724;9095;9108.043655416186;9135.451872887616;9143.222826059793;9004.054574269705;9076.954615226914;9087;9092.090790920887;9092.681756138536;9121.543922803834;9165.31260155491;9167.816643667122;9176.357654964155;9180.219681327095;9068.501232432214;9097.363184577081;9103.226225770817;9105;9116.133967273165;9004.594793234255;9057.275417966546;9069.319801014884;9072.8639070414;9081.954590227073;44130.338044929355;44482;44486;44486;44560.108797824185;3542.8582856685703;3940.054386947112;4068.4304197412384;4112.506499220083;4119.814608342602;33969.15077123067;34037.489437658456;34047.14882127942;34664.653353466645;34733;4302.849400270976;4473.373727678128;4479.480594031012;4523.751193684346;4629.444466664022;376305;377206;377256;377339;377590;60930;61757;61768;61771;61836.69081654653;64531;64712.352876471574;64792.676036619516;64948;64976;15480.690386192213;15651.295691693902;15682.294296756674;15688.843111568967;15698;11289.322640641587;11562.942185289188;11564.94217528907;12145.089118316162;12460.563880264148;17458.825411745718;17787.911060444872;18377.26490940374;18534.351297704787;18539.536511587317;5588.804391846347;6029.758809647565;6082.847928801727;6190.380961903864;6274.905876411857;895.9507227102572;948.8671585977969;1042.7975259703408;1063.2663462211203;1087.6193332333619;32121.51817722736;32982;33131.17172070669;33228.01895658756;33282.66717332796;1071.3090056913247;1146.8337091121741;1156.8785277545906;1158.7392836611864;1182.7043239190202;16829.495115146565;17230.827691723174;17356.13219339028;17507.060911294855;17630.294788208328;506171;506760;508579;508844;509993;61734;61740;61777.382226177164;62073.37926620676;62138;1237.5915947737226;1277.9936100319626;1291.5221368093864;1367.596559015093;1410.8730214280763;25787.484250314512;33943.83028084844;34304.65695343114;36664.63335366612;36943;59191.40808591859;59729;59894.70052649709;59900.40099599123;60044.699776500835;493630.9776766685;496513;498666;498697;499197;29489.410211795213;29693;30007.699923001364;30109.397812044073;30144.84927575348;50525.49474505208;51235.487645123074;51548;52134.47865521296;52655.048641731766;42848.35727464153;44259.55740442554;44515.554844451144;44804.55195448004;45017.23854867906;43178;43389.566104339814;43888.34167487554;44019.55980440155;45588.31617525673;37248;41816.37275440932;42508.5749142517;42863;44037.779811100736;33591.99224023283;37180.25639487141;37965.24069518649;38575.6142438572;38931;28758.281042974093;29103.417931640826;29150.562741558468;29248.707512925448;29351.559726604544 16:43:26 INFO - PROCESS | 30537 | |2;jquery.html;369.33150996695963;377.3509563550692;396.8749843799203;400.2415422773844;418.81781425080095;16887.915560422196;19503.902480487595;19886.502837429052;20405.48986275344;20565.074571644276;18390.448286551393;18413.355532556365;18690.53273668159;18803.811961880376;19062.809371906278;5678.233438485813;5783.855403614912;5796.391378905218;5998.190244317027;6000.099985002241;5866.120081987693;5876.177335173079;5906.232189815318;5910.645361278315;5911.556633252523;5641.830745077655;5770.451807078321;5835.737391817357;5862.706864656771;5881.411858814127;5807.622504537213;5855.2973643163095;5859.384764599719;5859.589828711992;5863.706814659271;5182.948170518284;5184.818531351422;5464.016477034133;5487.780488780444;5580.497755202011;14282.57152285433;14289.142651440947;14353.067050641675;14373.712525749426;14566.927165364212;2347.624380099193;2349.9819270247963;2499.7250302466714;2788.8286919493657;2844.9288767780763;10027.298089133763;10687.83968240477;11045.171612129123;12448.25310481365;14891.023163153039;1842.2630947620926;1908.427471758467;1980.386080315107;1986.7218589397496;1995.1420889017716;59856;83086.58456707677;83425;83829;84611;11012;11090.722731931766;11210.607628732956;11273.985341319321;11435.14236432271;15207.619809504851;15253;15254.313555890012;15274.007189532645;15290.617734556725;7921.841563168704;8192.795180120545;8218.424710270343;8371.288440482627;8420.915790842135;7781.844363112706;7787.649555770004;7878.409119316074;7993.160718124629;8075.394345423999;4572.542745725467;4638.257878739386;4678.274867395559;4727.976360118178;4752.762361881962;1952.326447375653;1997.7003449482404;2007.578408534224;2007.8795272283417;2033.888136152526;836.1053672570291;929.3076657889916;937.437537477508;971.4656938683696;1010.9949450252701;18680.249414194303;19993.900030499753;20072.598548028956;20223.4944126398;20466.897665511875;946.6592026870321;973.5764942250144;975.4001289207229;984.1487113646645;1034.7361422837128;10668.253222274367;11020.338779673086;11135.559454075026;11244.156688248415;11262.718432039264;431100;455551;484108;493166;494171;89081.55459222662;93156.53421732847;94279;95516.52241738886;97209;961.427950369529;987.5852142100191;995.9601615935426;996.5748978960156;1012.7670635753818;16878.831211687724;16940.322387104872;17571.385001524886;17927.193276302336;18258.36095736643;38962.80518597389;43047.56952430436;43575.56424435715;43976.12047759091;44585.10829783451;56826.43173568211;58810;60529;62019;63262.05106923492;8179.672813087648;8478.194571515696;8561.700340488052;8565.828683426422;8948.5078320693;9521.523923803921;13170.407331669907;13367.131136476099;13844.446222151404;13988.58034258974;11638.592649257236;11649.88350116488;11976.880231197576;11989.820152697543;12467.314297713712;5463.180522921593;9880.913099558898;10827.458627068772;11407;12249.816252756395;11765.176437649283;11910.940445298065;11940.820887686517;12069.456874440495;12189;7426.2945020223;7742.690292388242;8259;8670.739877803424;8741.125887411208;11816.881831181578;12143.757124857277;12162.75674486523;12281.447334869774;12583.182093164281 16:43:26 INFO - PROCESS | 30537 | |3;mootools.html;1368.1585824717802;1499.3627708224005;1508.4795745467814;1652.7686123942651;1767.328415202223;8421.831563368729;8774.605142768574;8862.423942443746;9101.317401194903;9116.544172791368;8905.91094089059;9001.50491722955;9018.68434604789;9021.774455638611;9023.819523609523;2407.6388541718793;2433.598456254716;2433.9391515212083;2435.1598698449006;2437.768412000857;2355.611324131516;2385.010220758383;2413.6620873077695;2419.395151212197;2421.2736179146273;2396.9640455393096;2398.772116648924;2407.0251548123038;2431.2463136427677;2431.5380077785253;2337.614293641564;2364.810815134785;2366.1718398560365;2372.2171683344454;2372.323887692008;2305.988470057639;2306.7808558186944;2315.3632750993443;2316.7104111986;2323.2449453927543;8587.613557389932;8849.955750221208;9001.59492822818;9007.594658240328;9012.369134160612;5091.592672586221;5242.397124330674;5305.257263983045;5306.548943339821;5311.548518375943;3630.6369363063745;3643.526341575605;3705.6109108543483;3712.4988126602834;3718.5909549949483;1167.200467679642;1173.3605185174101;1178.8113901775675;1188.0792385900995;1189.244829533244;12429.502819887284;12654.55709050188;12675.17611355259;12685.873141268654;12707.618771436872;4512.142692888341;4722.763861806965;4796.760161991887;4797.328374027639;4867.561919427198;10603.310784799118;10608.57565697379;10609.734756631146;10610.787784244427;10615.575376984989;5352.518273355417;5354.651947623392;5357.062514060024;5359.222912677717;5360.571154307646;4429.689921705514;4611.400517932647;4724.102420540086;4739.241721324572;4928.901421971612;3867.5358956925347;3875.379939209713;4047.392891066305;4094.8362065517044;4165.625093741578;1272.7200015996466;1277.482619539088;1313.3105119811985;1316.7498175346846;1320.8877245434053;959.7744530035436;969.413504829582;972.7179118055826;985.1527686189871;999.4552968632113;6015.368386319374;6041.697915104227;6044.123602077762;6061.7575296987625;6119.77604479106;441.6510956344452;442.82065763365887;462.8333799832125;464.3313628375129;467.82690404550533;4031.697622678311;4046.9190616188102;4065.10567675111;4069.104796944667;4083.0813067059676;10171.694849154537;10567.894321056845;10572.15422766177;10580.470976451146;10612.41631710248;10440.112590429899;10464.790704185874;10466.895331046744;10469.895301047045;10473.68578942633;7649.464537482323;7877.094134174528;7914.604269786488;7915.010623672041;7993.440459167802;5761.596688231783;5951.077582974646;5965.433283838029;6031.095335699505;6251.281102673251;10014.749631259278;10249.33379330341;10261.58953641846;10265.897341026493;10295.794084118426;10113.494325283853;10245.846312305172;10416.062554370143;10418.114460270659;10440.112590429595;7151.213366529573;7769.689212431439;7892.526448413114;7994.720184793504;8050.7923811428755;8987.505687187268;9040.954795225982;9047.230985366054;9054.366194366332;9054.366194366594;7945.0863150736095;8004.159563245776;8139.552324622203;8267;8317.500949943023;7828.608569571613;7942.44402891792;7943.642536086006;7980.760577182694;8002.679892804223;7306.97702321686;7317.304856038668;7416.48084634092;7425.294597013275;7428.33145016951;5117.2068329409;5215.400228973716;5269.104252277199;5281.287026251407;5384.185080113546;5198.636095473281;5205.271262023244;5234.7906083756225;5258.447862974485;5367.355917289794 16:43:26 INFO - PROCESS | 30537 | |4;prototype.html;326.5428400239663;335.64086427522545;338.28115255082946;342.9931401371972;345.925625990412;5079.898402031957;5111.718855462948;5142.202958541432;5191.974040129803;5197.324347834786;4814.1334559779225;4972.552470277675;4985.351904252442;4989.151844186497;5115.744212789365;3924.274009308287;3976.622220889011;4011.799410029487;4040.797960101998;4047.615476529725;4050.250703619825;4055.3308704063793;4059.8782036538805;4072.755634661915;4079.938800917989;3867.45855580219;4016.196760647882;4050.716449848497;4053.695972802037;4054.9189016219657;4027.496562929634;4033.2740106780766;4034.394840773878;4045.5145382554283;4046.8956142805723;3580.1228698968657;3585.982070089659;3587.9727953706074;3588.049166970755;3605.675489205958;4787.80848766049;5008.499150084962;5009.724465154415;5023.497650234984;5081.74591270435;4547.658925580595;4588.977055114737;4596.4024676791805;4596.414237088199;4607.999999999966;5336.9733151334385;5353.437889021675;5360.91958620621;5363.892722145574;5367.651102678353;3887.9696880326455;3905.1018265798743;3906.238283534712;3913.728038387507;3919.431682406035;5259.684418934876;5519.972400137974;5523.585731070146;5526.309211348582;5530.069063396406;3929.9607003929596;3960.1683646433994;3960.881173564798;3962.9603703963166;3986.1629057897585;4039.3940908863906;4045.3122969094734;4057.5190055630073;4057.8173982170874;4065.4511640928686;4433;4542.545745425431;4552.3171524270965;4593.47175074864;4630.240508606708;5341.626086174008;5352.411234764173;5358.464153584689;5372.059889519397;5378.838634840961;1312.566852938528;1374.305975482375;1374.6940406613758;1389.2567476400077;1396.5112210726165;937.6202637931649;954.5465903695828;966.2028826218398;972.6158167523788;974.0989584634185;5141.38303403594;5151.150060240018;5185.2999845021195;5188.325517682677;5220.869478262998;5401.891962160735;5420.512153906167;5457.317835270591;5465.699386533779;5511.421300763443;4966.8758281043265;5078.5175408336145;5126.513640884168;5127.512886275797;5129;2853.315204350982;2859.8999035033676;2861.8712157952527;2862.9427411451657;2869.4548035873536;5418.864528386822;5555.666660000413;5586.888262234733;5618.410066942994;5625.240592520039;5466.34403871538;5474.479924407175;5496.972515137399;5497.47773961473;5504.779808807683;5590.2453168821685;5598.972005139948;5612.130119831432;5622.128570071645;5671.51792097668;5246.947530524646;5355.062863998863;5423.159410291411;5444.50999410055;5467.5625949923115;5379.300690910157;5390.946090539202;5394.757235924314;5401.459854014567;5403.486668766461;5493.2034854946605;5621.044422448112;5642.379338272869;5649.54803615718;5656.43435656431;3954.8813535593977;3957.9010524737114;3962.465067215889;3983.9601603984747;3994.540627827837;5340.2256672783005;5376.301080859464;5401.594880383908;5440.319960004999;5451.182322651634;5048.8990220194655;5292.470752924677;5299.5230429261555;5311.521963023347;5324.920126198032;5222.138347172674;5225.190095535198;5255.737213139251;5258.212207849349;5261.394939581997;5089.745512724275;5228.686278823283;5248.9737551312;5266.710330931835;5268.341457317835;5197.4542673020305;5251.684898906078;5269.841904742864;5341.626086174086;5371.62398632092;5234.895302093861;5264.947350526446;5273.156294992783;5274.446183150714;5284.920726189033 16:43:26 INFO - PROCESS | 30537 | |5;yui.html;707.9044329015585;718.5796309159142;735.5623404074573;807.1000834070012;818.373943932891;15648.21758912054;16634.50096497104;16692.499225023268;16696.415625453126;16841.578960525978;15737;15995.200239988013;16001.519954401358;16004.959677620947;16029.759553606706;616.9629822210682;748.1994266135238;791.1337085890955;795.0380040151424;795.0538858758059;809.2312303311847;812.9715459958902;813.3208770676463;813.3858936502932;813.5200231863199;846.4413487098516;849.2653854415947;851.4976164063202;853.9658413663446;854.7136709202425;685.8388278754488;710.7583421636668;714.4034730999622;806.4999700185864;851.6593362654926;609.0529227051933;613.4816080412045;614.4869034356318;614.7233744814806;615.6860001399318;15238.314275857501;15289.311980960883;15297.770533442008;15306.540803775793;15316.081035137817;14477.276136193148;14599.562013139517;14651.560453186421;14808.481703140338;14824.703505929821;13237.669058273525;13247.271400073088;13382.263975481344;13536.661583460394;13772.655683607889;4489.618382437497;4616;4670.229412147026;4763.924723401925;4791.281307803857;86749.56625216897;87746.12253877443;87772;87877;88136;11070.39112848801;11206.43967801623;11783.764324713458;11862.466189021514;11970.40147992597;22018.889905550368;22084.779152208273;22310.88844555767;22376.55246895053;22445.43886402853;8129.227723366271;8417.284530814826;8505.489670619783;8526.40315177944;8537.487750734976;4624.375709279271;4656.743879086615;4761.976190119097;4821.63837712166;4836.709797412166;3479.251960828434;3593.1196856770257;3593.8562457501407;3818.6372294631965;3994.660453861396;675.3651567526607;689.3038031588133;690.6443181761397;691.8616276744672;696.3350000749273;687.2303020616941;688.9242183359827;702.8910518869584;740.1525253584615;752.9021227240534;9989.350692204984;10157.695269141937;10707.250492465453;10773;10821.67534973952;641.4836056974087;726.1830440754152;734.6914295995695;756.5460723565817;765.4259305520859;4978.278149668277;5163.225516172604;5206.479352064839;5220.895582088337;5226.895462090737;73393.89909151367;73460.49969603626;123443;124750;127110;68809;109925.45037274923;113920.75990501187;116856;117108.41445792717;95976;96480.51759741157;98721.50639246758;100196.49901750445;102013.48993254986;9450.102240287162;9785.85321220168;9841.311108222355;9927.40435573868;9928.15610673072;56473.71763141158;57313.713431432574;57598.7120064397;57635.71182144062;58590.4140958602;49471;50500.49499504958;71831;73342.63328683322;74527.62736186285;13396.464141434233;13599.320033998458;13786.103903246258;13850.445982161003;14120.293985300488;15490.690186196438;15757.448489303279;15881.126538040518;15881.920590396974;16069;13983.650408739455;14085.788713169515;14564.563063108124;14654.413823447368;14838.332275047866;14228.786568201278;14377.209253491159;14788.11271323724;14808.185549794865;15053.924730376279;14078.859211408164;14485.591807573097;14513;14673.339699713326;14805.259737012891;10873.945630272114;10887.074598659203;11132.833007504732;11164.218504704593;11520.539178433104;12012.699682507659;12079.154459187772;12083;12318.445669944695;12614.810777838524 16:43:26 INFO - PROCESS | 30537 | __end_tp_report 16:43:26 INFO - PROCESS | 30537 | __start_cc_report 16:43:26 INFO - PROCESS | 30537 | _x_x_mozilla_cycle_collect,985 16:43:26 INFO - PROCESS | 30537 | __end_cc_report 16:43:26 INFO - PROCESS | 30537 | __startTimestamp1471563806099__endTimestamp 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | ------- Summary: start ------- 16:43:26 INFO - PROCESS | 30537 | Number of tests: 6 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | [#0] dojo.html Cycles:165 Average:5362.93 Median:5547.22 stddev:621.87 (11.2%) stddev-sans-first:595.98 16:43:26 INFO - PROCESS | 30537 | Values: 3019.5 3053.3 3072.2 3078.9 3084.5 5131.6 5273.6 5339.7 5463.1 5485.4 5264.3 5347.3 5350.4 5383.7 5413.8 4840.8 4887.1 4955.7 4978.7 5090.0 4976.2 5007.4 5021.7 5034.4 5039.8 4741.0 4769.7 4847.5 4900.0 4931.3 4841.9 4849.7 4857.8 4966.7 4980.5 4838.9 4861.4 4871.3 4919.3 4931.2 5228.8 5240.4 5364.8 5366.9 5408.9 5712.2 5762.7 5772.3 5777.8 5786.2 5735.8 5794.2 5805.2 5807.9 5807.9 5145.8 5314.0 5362.0 5405.4 5411.0 5915.9 5916.0 5916.6 5961.0 5968.0 5633.7 5634.0 5669.2 5680.2 5681.5 5564.1 5677.8 5728.3 5797.4 5801.3 5788.5 5792.6 5795.5 5810.5 5837.5 5754.7 5784.4 5801.6 5805.6 5810.4 4289.1 4349.8 4385.1 4451.7 4463.9 3907.1 3932.4 3933.7 3959.4 3978.5 5413.6 5420.1 5423.2 5428.9 5472.0 5583.8 5732.2 5737.9 5748.7 5815.5 5503.0 5523.2 5527.6 5547.1 5547.2 5041.3 5048.9 5054.9 5059.2 5090.1 5747.6 5958.5 6018.4 6090.6 6101.4 5839.2 5849.2 5850.6 5879.1 5900.6 6047.7 6059.9 6060.3 6066.3 6066.3 5455.5 5647.6 5658.4 5695.3 5743.5 5809.2 5848.1 5850.6 5872.1 5899.1 5695.1 5701.7 5702.2 5706.8 5707.7 5354.2 5510.6 5558.2 5667.0 5670.1 5603.1 5611.1 5612.0 5653.7 5665.0 5611.8 5641.5 5669.3 5682.1 5687.4 5486.9 5487.8 5520.2 5524.3 5531.9 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | [#1] ext.html Cycles:180 Average:63172.34 Median:44537.83 stddev:123061.52 (276.3%) stddev-sans-first:123316.98 16:43:26 INFO - PROCESS | 30537 | Values: 570.8 587.8 590.2 598.6 618.7 43638.6 45672.0 45779.1 45833.8 49473.0 47126.8 47617.5 47621.0 47623.3 47719.0 8994.4 9095.0 9108.0 9135.5 9143.2 9004.1 9077.0 9087.0 9092.1 9092.7 9121.5 9165.3 9167.8 9176.4 9180.2 9068.5 9097.4 9103.2 9105.0 9116.1 9004.6 9057.3 9069.3 9072.9 9082.0 44130.3 44482.0 44486.0 44486.0 44560.1 3542.9 3940.1 4068.4 4112.5 4119.8 33969.2 34037.5 34047.1 34664.7 34733.0 4302.8 4473.4 4479.5 4523.8 4629.4 376305.0 377206.0 377256.0 377339.0 377590.0 60930.0 61757.0 61768.0 61771.0 61836.7 64531.0 64712.4 64792.7 64948.0 64976.0 15480.7 15651.3 15682.3 15688.8 15698.0 11289.3 11562.9 11564.9 12145.1 12460.6 17458.8 17787.9 18377.3 18534.4 18539.5 5588.8 6029.8 6082.8 6190.4 6274.9 896.0 948.9 1042.8 1063.3 1087.6 32121.5 32982.0 33131.2 33228.0 33282.7 1071.3 1146.8 1156.9 1158.7 1182.7 16829.5 17230.8 17356.1 17507.1 17630.3 506171.0 506760.0 508579.0 508844.0 509993.0 61734.0 61740.0 61777.4 62073.4 62138.0 1237.6 1278.0 1291.5 1367.6 1410.9 25787.5 33943.8 34304.7 36664.6 36943.0 59191.4 59729.0 59894.7 59900.4 60044.7 493631.0 496513.0 498666.0 498697.0 499197.0 29489.4 29693.0 30007.7 30109.4 30144.8 50525.5 51235.5 51548.0 52134.5 52655.0 42848.4 44259.6 44515.6 44804.6 45017.2 43178.0 43389.6 43888.3 44019.6 45588.3 37248.0 41816.4 42508.6 42863.0 44037.8 33592.0 37180.3 37965.2 38575.6 38931.0 28758.3 29103.4 29150.6 29248.7 29351.6 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | [#2] jquery.html Cycles:180 Average:28382.10 Median:21733.19 stddev:78051.32 (359.1%) stddev-sans-first:78241.93 16:43:26 INFO - PROCESS | 30537 | Values: 369.3 377.4 396.9 400.2 418.8 16887.9 19503.9 19886.5 20405.5 20565.1 18390.4 18413.4 18690.5 18803.8 19062.8 5678.2 5783.9 5796.4 5998.2 6000.1 5866.1 5876.2 5906.2 5910.6 5911.6 5641.8 5770.5 5835.7 5862.7 5881.4 5807.6 5855.3 5859.4 5859.6 5863.7 5182.9 5184.8 5464.0 5487.8 5580.5 14282.6 14289.1 14353.1 14373.7 14566.9 2347.6 2350.0 2499.7 2788.8 2844.9 10027.3 10687.8 11045.2 12448.3 14891.0 1842.3 1908.4 1980.4 1986.7 1995.1 59856.0 83086.6 83425.0 83829.0 84611.0 11012.0 11090.7 11210.6 11274.0 11435.1 15207.6 15253.0 15254.3 15274.0 15290.6 7921.8 8192.8 8218.4 8371.3 8420.9 7781.8 7787.6 7878.4 7993.2 8075.4 4572.5 4638.3 4678.3 4728.0 4752.8 1952.3 1997.7 2007.6 2007.9 2033.9 836.1 929.3 937.4 971.5 1011.0 18680.2 19993.9 20072.6 20223.5 20466.9 946.7 973.6 975.4 984.1 1034.7 10668.3 11020.3 11135.6 11244.2 11262.7 431100.0 455551.0 484108.0 493166.0 494171.0 89081.6 93156.5 94279.0 95516.5 97209.0 961.4 987.6 996.0 996.6 1012.8 16878.8 16940.3 17571.4 17927.2 18258.4 38962.8 43047.6 43575.6 43976.1 44585.1 56826.4 58810.0 60529.0 62019.0 63262.1 8179.7 8478.2 8561.7 8565.8 8948.5 9521.5 13170.4 13367.1 13844.4 13988.6 11638.6 11649.9 11976.9 11989.8 12467.3 5463.2 9880.9 10827.5 11407.0 12249.8 11765.2 11910.9 11940.8 12069.5 12189.0 7426.3 7742.7 8259.0 8670.7 8741.1 11816.9 12143.8 12162.8 12281.4 12583.2 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | [#3] mootools.html Cycles:180 Average:5870.90 Median:463.58 stddev:3335.12 (719.4%) stddev-sans-first:3327.31 16:43:26 INFO - PROCESS | 30537 | Values: 1368.2 1499.4 1508.5 1652.8 1767.3 8421.8 8774.6 8862.4 9101.3 9116.5 8905.9 9001.5 9018.7 9021.8 9023.8 2407.6 2433.6 2433.9 2435.2 2437.8 2355.6 2385.0 2413.7 2419.4 2421.3 2397.0 2398.8 2407.0 2431.2 2431.5 2337.6 2364.8 2366.2 2372.2 2372.3 2306.0 2306.8 2315.4 2316.7 2323.2 8587.6 8850.0 9001.6 9007.6 9012.4 5091.6 5242.4 5305.3 5306.5 5311.5 3630.6 3643.5 3705.6 3712.5 3718.6 1167.2 1173.4 1178.8 1188.1 1189.2 12429.5 12654.6 12675.2 12685.9 12707.6 4512.1 4722.8 4796.8 4797.3 4867.6 10603.3 10608.6 10609.7 10610.8 10615.6 5352.5 5354.7 5357.1 5359.2 5360.6 4429.7 4611.4 4724.1 4739.2 4928.9 3867.5 3875.4 4047.4 4094.8 4165.6 1272.7 1277.5 1313.3 1316.7 1320.9 959.8 969.4 972.7 985.2 999.5 6015.4 6041.7 6044.1 6061.8 6119.8 441.7 442.8 462.8 464.3 467.8 4031.7 4046.9 4065.1 4069.1 4083.1 10171.7 10567.9 10572.2 10580.5 10612.4 10440.1 10464.8 10466.9 10469.9 10473.7 7649.5 7877.1 7914.6 7915.0 7993.4 5761.6 5951.1 5965.4 6031.1 6251.3 10014.7 10249.3 10261.6 10265.9 10295.8 10113.5 10245.8 10416.1 10418.1 10440.1 7151.2 7769.7 7892.5 7994.7 8050.8 8987.5 9041.0 9047.2 9054.4 9054.4 7945.1 8004.2 8139.6 8267.0 8317.5 7828.6 7942.4 7943.6 7980.8 8002.7 7307.0 7317.3 7416.5 7425.3 7428.3 5117.2 5215.4 5269.1 5281.3 5384.2 5198.6 5205.3 5234.8 5258.4 5367.4 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | [#4] prototype.html Cycles:180 Average:4500.02 Median:5146.68 stddev:1295.94 (25.2%) stddev-sans-first:1261.15 16:43:26 INFO - PROCESS | 30537 | Values: 326.5 335.6 338.3 343.0 345.9 5079.9 5111.7 5142.2 5192.0 5197.3 4814.1 4972.6 4985.4 4989.2 5115.7 3924.3 3976.6 4011.8 4040.8 4047.6 4050.3 4055.3 4059.9 4072.8 4079.9 3867.5 4016.2 4050.7 4053.7 4054.9 4027.5 4033.3 4034.4 4045.5 4046.9 3580.1 3586.0 3588.0 3588.0 3605.7 4787.8 5008.5 5009.7 5023.5 5081.7 4547.7 4589.0 4596.4 4596.4 4608.0 5337.0 5353.4 5360.9 5363.9 5367.7 3888.0 3905.1 3906.2 3913.7 3919.4 5259.7 5520.0 5523.6 5526.3 5530.1 3930.0 3960.2 3960.9 3963.0 3986.2 4039.4 4045.3 4057.5 4057.8 4065.5 4433.0 4542.5 4552.3 4593.5 4630.2 5341.6 5352.4 5358.5 5372.1 5378.8 1312.6 1374.3 1374.7 1389.3 1396.5 937.6 954.5 966.2 972.6 974.1 5141.4 5151.2 5185.3 5188.3 5220.9 5401.9 5420.5 5457.3 5465.7 5511.4 4966.9 5078.5 5126.5 5127.5 5129.0 2853.3 2859.9 2861.9 2862.9 2869.5 5418.9 5555.7 5586.9 5618.4 5625.2 5466.3 5474.5 5497.0 5497.5 5504.8 5590.2 5599.0 5612.1 5622.1 5671.5 5246.9 5355.1 5423.2 5444.5 5467.6 5379.3 5390.9 5394.8 5401.5 5403.5 5493.2 5621.0 5642.4 5649.5 5656.4 3954.9 3957.9 3962.5 3984.0 3994.5 5340.2 5376.3 5401.6 5440.3 5451.2 5048.9 5292.5 5299.5 5311.5 5324.9 5222.1 5225.2 5255.7 5258.2 5261.4 5089.7 5228.7 5249.0 5266.7 5268.3 5197.5 5251.7 5269.8 5341.6 5371.6 5234.9 5264.9 5273.2 5274.4 5284.9 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - PROCESS | 30537 | [#5] yui.html Cycles:180 Average:21592.90 Median:4640.56 stddev:31109.91 (670.4%) stddev-sans-first:31157.66 16:43:26 INFO - PROCESS | 30537 | Values: 707.9 718.6 735.6 807.1 818.4 15648.2 16634.5 16692.5 16696.4 16841.6 15737.0 15995.2 16001.5 16005.0 16029.8 617.0 748.2 791.1 795.0 795.1 809.2 813.0 813.3 813.4 813.5 846.4 849.3 851.5 854.0 854.7 685.8 710.8 714.4 806.5 851.7 609.1 613.5 614.5 614.7 615.7 15238.3 15289.3 15297.8 15306.5 15316.1 14477.3 14599.6 14651.6 14808.5 14824.7 13237.7 13247.3 13382.3 13536.7 13772.7 4489.6 4616.0 4670.2 4763.9 4791.3 86749.6 87746.1 87772.0 87877.0 88136.0 11070.4 11206.4 11783.8 11862.5 11970.4 22018.9 22084.8 22310.9 22376.6 22445.4 8129.2 8417.3 8505.5 8526.4 8537.5 4624.4 4656.7 4762.0 4821.6 4836.7 3479.3 3593.1 3593.9 3818.6 3994.7 675.4 689.3 690.6 691.9 696.3 687.2 688.9 702.9 740.2 752.9 9989.4 10157.7 10707.3 10773.0 10821.7 641.5 726.2 734.7 756.5 765.4 4978.3 5163.2 5206.5 5220.9 5226.9 73393.9 73460.5 123443.0 124750.0 127110.0 68809.0 109925.5 113920.8 116856.0 117108.4 95976.0 96480.5 98721.5 100196.5 102013.5 9450.1 9785.9 9841.3 9927.4 9928.2 56473.7 57313.7 57598.7 57635.7 58590.4 49471.0 50500.5 71831.0 73342.6 74527.6 13396.5 13599.3 13786.1 13850.4 14120.3 15490.7 15757.4 15881.1 15881.9 16069.0 13983.7 14085.8 14564.6 14654.4 14838.3 14228.8 14377.2 14788.1 14808.2 15053.9 14078.9 14485.6 14513.0 14673.3 14805.3 10873.9 10887.1 11132.8 11164.2 11520.5 12012.7 12079.2 12083.0 12318.4 12614.8 16:43:26 INFO - PROCESS | 30537 | -------- Summary: end -------- 16:43:26 INFO - PROCESS | 30537 | 16:43:26 INFO - TEST-INFO | 30537: exit 0 16:43:26 INFO - TEST-OK | dromaeo_css | took 1115349ms 16:43:26 INFO - TEST-START | kraken 16:43:26 INFO - operating with platform_type : linux_ 16:43:26 INFO - Initialising browser for kraken test... 16:43:26 INFO - TEST-INFO | started process 30849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbf4fGO/profile http://localhost:47284/getInfo.html) 16:43:30 INFO - PROCESS | 30849 | __metrics Screen width/height:1600/1200 16:43:30 INFO - PROCESS | 30849 | colorDepth:24 16:43:30 INFO - PROCESS | 30849 | Browser inner width/height: 1024/697 16:43:30 INFO - PROCESS | 30849 | __metrics 16:43:31 INFO - PROCESS | 30849 | 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" 16:43:31 INFO - PROCESS | 30849 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:32 INFO - TEST-INFO | 30849: exit 0 16:43:32 INFO - Browser initialized. 16:43:32 INFO - Running cycle 1/1 for kraken test... 16:43:32 INFO - TEST-INFO | started process 30928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbf4fGO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:44 INFO - PROCESS | 30928 | RSS: Main: 156012544 16:43:44 INFO - PROCESS | 30928 | 16:43:46 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47284/tests/kraken/driver.html?testName=audio-beat-detection) 16:43:47 INFO - PROCESS | 30928 | RSS: Main: 203640832 16:43:47 INFO - PROCESS | 30928 | 16:43:50 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47284/tests/kraken/driver.html?testName=audio-dft) 16:43:50 INFO - PROCESS | 30928 | RSS: Main: 194449408 16:43:50 INFO - PROCESS | 30928 | 16:43:53 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47284/tests/kraken/driver.html?testName=audio-fft) 16:43:54 INFO - PROCESS | 30928 | RSS: Main: 275947520 16:43:54 INFO - PROCESS | 30928 | 16:43:56 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47284/tests/kraken/driver.html?testName=audio-oscillator) 16:43:57 INFO - PROCESS | 30928 | RSS: Main: 186187776 16:43:57 INFO - PROCESS | 30928 | 16:43:59 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47284/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:59 INFO - PROCESS | 30928 | RSS: Main: 190582784 16:43:59 INFO - PROCESS | 30928 | 16:44:02 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47284/tests/kraken/driver.html?testName=imaging-darkroom) 16:44:03 INFO - PROCESS | 30928 | RSS: Main: 225779712 16:44:03 INFO - PROCESS | 30928 | 16:44:06 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47284/tests/kraken/driver.html?testName=imaging-desaturate) 16:44:07 INFO - PROCESS | 30928 | RSS: Main: 226385920 16:44:07 INFO - PROCESS | 30928 | 16:44:10 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47284/tests/kraken/driver.html?testName=json-parse-financial) 16:44:10 INFO - PROCESS | 30928 | RSS: Main: 225927168 16:44:10 INFO - PROCESS | 30928 | 16:44:12 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47284/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:44:13 INFO - PROCESS | 30928 | RSS: Main: 188715008 16:44:13 INFO - PROCESS | 30928 | 16:44:14 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:44:15 INFO - PROCESS | 30928 | RSS: Main: 196157440 16:44:15 INFO - PROCESS | 30928 | 16:44:17 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:18 INFO - PROCESS | 30928 | RSS: Main: 193642496 16:44:18 INFO - PROCESS | 30928 | 16:44:20 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:21 INFO - PROCESS | 30928 | RSS: Main: 187703296 16:44:21 INFO - PROCESS | 30928 | 16:44:24 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:24 INFO - PROCESS | 30928 | RSS: Main: 191332352 16:44:24 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | Cycle 1(1): loaded http://localhost:47284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47284/tests/kraken/driver.html?testName=ai-astar) 16:44:26 INFO - PROCESS | 30928 | RSS: Main: 242450432 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | __start_tp_report 16:44:26 INFO - PROCESS | 30928 | _x_x_mozilla_page_load 16:44:26 INFO - PROCESS | 30928 | _x_x_mozilla_page_load_details 16:44:26 INFO - PROCESS | 30928 | |i|pagename|runs| 16:44:26 INFO - PROCESS | 30928 | |0;ai-astar;105;113;111;112;106;112;112;113;111;112 16:44:26 INFO - PROCESS | 30928 | |1;audio-beat-detection;144;118;122;179;118;119;152;119;155;122 16:44:26 INFO - PROCESS | 30928 | |2;audio-dft;162;161;161;161;162;161;162;162;164;163 16:44:26 INFO - PROCESS | 30928 | |3;audio-fft;76;75;75;115;76;76;77;76;105;74 16:44:26 INFO - PROCESS | 30928 | |4;audio-oscillator;84;84;137;85;86;86;115;85;85;127 16:44:26 INFO - PROCESS | 30928 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;117;117;117 16:44:26 INFO - PROCESS | 30928 | |6;imaging-darkroom;146;146;145;147;145;145;145;147;145;145 16:44:26 INFO - PROCESS | 30928 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 16:44:26 INFO - PROCESS | 30928 | |8;json-parse-financial;58;48;51;51;51;53;50;50;53;50 16:44:26 INFO - PROCESS | 30928 | |9;json-stringify-tinderbox;62;62;61;62;62;62;61;62;61;61 16:44:26 INFO - PROCESS | 30928 | |10;stanford-crypto-aes;78;78;81;78;84;78;84;78;81;77 16:44:26 INFO - PROCESS | 30928 | |11;stanford-crypto-ccm;126;122;136;130;123;121;121;120;149;123 16:44:26 INFO - PROCESS | 30928 | |12;stanford-crypto-pbkdf2;165;167;167;170;172;174;165;167;167;164 16:44:26 INFO - PROCESS | 30928 | |13;stanford-crypto-sha256-iterative;63;66;66;64;65;65;72;64;63;63 16:44:26 INFO - PROCESS | 30928 | __end_tp_report 16:44:26 INFO - PROCESS | 30928 | __start_cc_report 16:44:26 INFO - PROCESS | 30928 | _x_x_mozilla_cycle_collect,1701 16:44:26 INFO - PROCESS | 30928 | __end_cc_report 16:44:26 INFO - PROCESS | 30928 | __startTimestamp1471563866584__endTimestamp 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | ------- Summary: start ------- 16:44:26 INFO - PROCESS | 30928 | Number of tests: 14 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.83 (2.5%) stddev-sans-first:2.12 16:44:26 INFO - PROCESS | 30928 | Values: 105.0 113.0 111.0 112.0 106.0 112.0 112.0 113.0 111.0 112.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:133.00 stddev:21.43 (16.1%) stddev-sans-first:22.47 16:44:26 INFO - PROCESS | 30928 | Values: 144.0 118.0 122.0 179.0 118.0 119.0 152.0 119.0 155.0 122.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 16:44:26 INFO - PROCESS | 30928 | Values: 162.0 161.0 161.0 161.0 162.0 161.0 162.0 162.0 164.0 163.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.71 (19.4%) stddev-sans-first:15.41 16:44:26 INFO - PROCESS | 30928 | Values: 76.0 75.0 75.0 115.0 76.0 76.0 77.0 76.0 105.0 74.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:85.00 stddev:20.64 (24.3%) stddev-sans-first:21.32 16:44:26 INFO - PROCESS | 30928 | Values: 84.0 84.0 137.0 85.0 86.0 86.0 115.0 85.0 85.0 127.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 16:44:26 INFO - PROCESS | 30928 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 16:44:26 INFO - PROCESS | 30928 | Values: 146.0 146.0 145.0 147.0 145.0 145.0 145.0 147.0 145.0 145.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:44:26 INFO - PROCESS | 30928 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:2.72 (5.3%) stddev-sans-first:1.56 16:44:26 INFO - PROCESS | 30928 | Values: 58.0 48.0 51.0 51.0 51.0 53.0 50.0 50.0 53.0 50.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 16:44:26 INFO - PROCESS | 30928 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 61.0 62.0 61.0 61.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.63 (3.3%) stddev-sans-first:2.71 16:44:26 INFO - PROCESS | 30928 | Values: 78.0 78.0 81.0 78.0 84.0 78.0 84.0 78.0 81.0 77.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:124.50 stddev:9.15 (7.3%) stddev-sans-first:9.69 16:44:26 INFO - PROCESS | 30928 | Values: 126.0 122.0 136.0 130.0 123.0 121.0 121.0 120.0 149.0 123.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:167.00 stddev:3.22 (1.9%) stddev-sans-first:3.26 16:44:26 INFO - PROCESS | 30928 | Values: 165.0 167.0 167.0 170.0 172.0 174.0 165.0 167.0 167.0 164.0 16:44:26 INFO - PROCESS | 30928 | 16:44:26 INFO - PROCESS | 30928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:2.69 (4.1%) stddev-sans-first:2.74 16:44:26 INFO - PROCESS | 30928 | Values: 63.0 66.0 66.0 64.0 65.0 65.0 72.0 64.0 63.0 63.0 16:44:26 INFO - PROCESS | 30928 | -------- Summary: end -------- 16:44:26 INFO - PROCESS | 30928 | 16:44:27 INFO - TEST-INFO | 30928: exit 0 16:44:27 INFO - TEST-OK | kraken | took 60718ms 16:44:27 INFO - SUITE-END | took 1176s 16:44:27 INFO - Completed test suite (00:19:36) 16:44:27 INFO - javascript benchmark 16:44:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.501782205936, 3053.282478617523, 3072.2319420144972, 3078.892238771642, 3084.5373194020895, 5131.615128865331, 5273.5781137509, 5339.70631615261, 5463.071277882759, 5485.369182544004, 5264.289320941682, 5347.278117454142, 5350.384705758829, 5383.67697938123, 5413.810516631918, 4840.806367745286, 4887.1447496688115, 4955.677880937746, 4978.726170060645, 5090.0328937501945, 4976.178930476467, 5007.4491805901325, 5021.723805190713, 5034.42104158021, 5039.848804535852, 4740.952590474086, 4769.737664428455, 4847.466778654345, 4899.951000489985, 4931.334269873575, 4841.878953026167, 4849.733264670442, 4857.781399837016, 4966.652334336598, 4980.452150263468, 4838.903221935577, 4861.392325959255, 4871.342368780205, 4919.26211068339, 4931.186354251544, 5228.764705588258, 5240.449752775941, 5364.758585863646, 5366.91949620756, 5408.864778380533, 5712.200291959129, 5762.654240745527, 5772.278465191851, 5777.768889244425, 5786.247787787561, 5735.799247026334, 5794.217780599607, 5805.187273781632, 5807.854803629901, 5807.941920580783, 5145.845624631267, 5314.043472175045, 5361.973190134025, 5405.432429594875, 5411.026015317241, 5915.852103697356, 5916.023856063787, 5916.585838991229, 5961.0, 5968.045112782021, 5633.718314084279, 5633.971830140823, 5669.177969194526, 5680.204771332017, 5681.545476361881, 5564.054110801174, 5677.80127695537, 5728.312602487645, 5797.36229014808, 5801.3328467225965, 5788.450097240755, 5792.594518383757, 5795.536357091422, 5810.477057064884, 5837.503812176013, 5754.683492407958, 5784.421557844266, 5801.593888427769, 5805.593608447368, 5810.448007439287, 4289.077848262638, 4349.782510874507, 4385.101054283864, 4451.710638808532, 4463.888402789891, 3907.1013666856784, 3932.3511620582854, 3933.685305175636, 3959.4060890866026, 3978.5424676162033, 5413.593980451482, 5420.105682562333, 5423.240746295522, 5428.891422171534, 5472.015037293326, 5583.776648934078, 5732.226149469851, 5737.88524229513, 5748.7125643717645, 5815.476607105296, 5503.036968530491, 5523.199136125239, 5527.640703354269, 5547.057000309957, 5547.223388725582, 5041.269015992661, 5048.873778155502, 5054.873628159326, 5059.19052951526, 5090.08378491875, 5747.568932330092, 5958.463738263577, 6018.428249316308, 6090.634561926298, 6101.359357267512, 5839.15332276809, 5849.181114644039, 5850.619709718854, 5879.147523609138, 5900.586958912835, 6047.697615119138, 6059.909101363572, 6060.333363329942, 6066.302375226729, 6066.332703402711, 5455.454454554513, 5647.576431767552, 5658.405867383865, 5695.288088988877, 5743.483086522066, 5809.186713860147, 5848.064309710426, 5850.619709718854, 5872.148538461814, 5899.085641725539, 5695.117256825199, 5701.7434215461235, 5702.230198923092, 5706.828795136153, 5707.714614269187, 5354.196870469461, 5510.559155267649, 5558.166275058774, 5667.03660377745, 5670.149477578396, 5603.131514615241, 5611.1022236443605, 5611.971940140274, 5653.689047102449, 5665.036943719495, 5611.775528978795, 5641.548676105819, 5669.34802497718, 5682.147677848356, 5687.402822703557, 5486.862828429321, 5487.807926722546, 5520.199571062093, 5524.33707955048, 5531.917021244765], "value": 5319.898551739153, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7545755325211, 587.8265911556091, 590.1914377303095, 598.5989387110635, 618.7370367593775, 43638.563614363884, 45672.0, 45779.08441831161, 45833.77083114584, 49473.0, 47126.764366178206, 47617.523824761745, 47621.0, 47623.28565071527, 47719.0, 8994.3703940724, 9095.0, 9108.043655416186, 9135.451872887616, 9143.222826059793, 9004.054574269705, 9076.954615226914, 9087.0, 9092.090790920887, 9092.681756138536, 9121.543922803834, 9165.31260155491, 9167.816643667122, 9176.357654964155, 9180.219681327095, 9068.501232432214, 9097.363184577081, 9103.226225770817, 9105.0, 9116.133967273165, 9004.594793234255, 9057.275417966546, 9069.319801014884, 9072.8639070414, 9081.954590227073, 44130.338044929355, 44482.0, 44486.0, 44486.0, 44560.108797824185, 3542.8582856685703, 3940.054386947112, 4068.4304197412384, 4112.506499220083, 4119.814608342602, 33969.15077123067, 34037.489437658456, 34047.14882127942, 34664.653353466645, 34733.0, 4302.849400270976, 4473.373727678128, 4479.480594031012, 4523.751193684346, 4629.444466664022, 376305.0, 377206.0, 377256.0, 377339.0, 377590.0, 60930.0, 61757.0, 61768.0, 61771.0, 61836.69081654653, 64531.0, 64712.352876471574, 64792.676036619516, 64948.0, 64976.0, 15480.690386192213, 15651.295691693902, 15682.294296756674, 15688.843111568967, 15698.0, 11289.322640641587, 11562.942185289188, 11564.94217528907, 12145.089118316162, 12460.563880264148, 17458.825411745718, 17787.911060444872, 18377.26490940374, 18534.351297704787, 18539.536511587317, 5588.804391846347, 6029.758809647565, 6082.847928801727, 6190.380961903864, 6274.905876411857, 895.9507227102572, 948.8671585977969, 1042.7975259703408, 1063.2663462211203, 1087.6193332333619, 32121.51817722736, 32982.0, 33131.17172070669, 33228.01895658756, 33282.66717332796, 1071.3090056913247, 1146.8337091121741, 1156.8785277545906, 1158.7392836611864, 1182.7043239190202, 16829.495115146565, 17230.827691723174, 17356.13219339028, 17507.060911294855, 17630.294788208328, 506171.0, 506760.0, 508579.0, 508844.0, 509993.0, 61734.0, 61740.0, 61777.382226177164, 62073.37926620676, 62138.0, 1237.5915947737226, 1277.9936100319626, 1291.5221368093864, 1367.596559015093, 1410.8730214280763, 25787.484250314512, 33943.83028084844, 34304.65695343114, 36664.63335366612, 36943.0, 59191.40808591859, 59729.0, 59894.70052649709, 59900.40099599123, 60044.699776500835, 493630.9776766685, 496513.0, 498666.0, 498697.0, 499197.0, 29489.410211795213, 29693.0, 30007.699923001364, 30109.397812044073, 30144.84927575348, 50525.49474505208, 51235.487645123074, 51548.0, 52134.47865521296, 52655.048641731766, 42848.35727464153, 44259.55740442554, 44515.554844451144, 44804.55195448004, 45017.23854867906, 43178.0, 43389.566104339814, 43888.34167487554, 44019.55980440155, 45588.31617525673, 37248.0, 41816.37275440932, 42508.5749142517, 42863.0, 44037.779811100736, 33591.99224023283, 37180.25639487141, 37965.24069518649, 38575.6142438572, 38931.0, 28758.281042974093, 29103.417931640826, 29150.562741558468, 29248.707512925448, 29351.559726604544], "value": 20722.327064157547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.33150996695963, 377.3509563550692, 396.8749843799203, 400.2415422773844, 418.81781425080095, 16887.915560422196, 19503.902480487595, 19886.502837429052, 20405.48986275344, 20565.074571644276, 18390.448286551393, 18413.355532556365, 18690.53273668159, 18803.811961880376, 19062.809371906278, 5678.233438485813, 5783.855403614912, 5796.391378905218, 5998.190244317027, 6000.099985002241, 5866.120081987693, 5876.177335173079, 5906.232189815318, 5910.645361278315, 5911.556633252523, 5641.830745077655, 5770.451807078321, 5835.737391817357, 5862.706864656771, 5881.411858814127, 5807.622504537213, 5855.2973643163095, 5859.384764599719, 5859.589828711992, 5863.706814659271, 5182.948170518284, 5184.818531351422, 5464.016477034133, 5487.780488780444, 5580.497755202011, 14282.57152285433, 14289.142651440947, 14353.067050641675, 14373.712525749426, 14566.927165364212, 2347.624380099193, 2349.9819270247963, 2499.7250302466714, 2788.8286919493657, 2844.9288767780763, 10027.298089133763, 10687.83968240477, 11045.171612129123, 12448.25310481365, 14891.023163153039, 1842.2630947620926, 1908.427471758467, 1980.386080315107, 1986.7218589397496, 1995.1420889017716, 59856.0, 83086.58456707677, 83425.0, 83829.0, 84611.0, 11012.0, 11090.722731931766, 11210.607628732956, 11273.985341319321, 11435.14236432271, 15207.619809504851, 15253.0, 15254.313555890012, 15274.007189532645, 15290.617734556725, 7921.841563168704, 8192.795180120545, 8218.424710270343, 8371.288440482627, 8420.915790842135, 7781.844363112706, 7787.649555770004, 7878.409119316074, 7993.160718124629, 8075.394345423999, 4572.542745725467, 4638.257878739386, 4678.274867395559, 4727.976360118178, 4752.762361881962, 1952.326447375653, 1997.7003449482404, 2007.578408534224, 2007.8795272283417, 2033.888136152526, 836.1053672570291, 929.3076657889916, 937.437537477508, 971.4656938683696, 1010.9949450252701, 18680.249414194303, 19993.900030499753, 20072.598548028956, 20223.4944126398, 20466.897665511875, 946.6592026870321, 973.5764942250144, 975.4001289207229, 984.1487113646645, 1034.7361422837128, 10668.253222274367, 11020.338779673086, 11135.559454075026, 11244.156688248415, 11262.718432039264, 431100.0, 455551.0, 484108.0, 493166.0, 494171.0, 89081.55459222662, 93156.53421732847, 94279.0, 95516.52241738886, 97209.0, 961.427950369529, 987.5852142100191, 995.9601615935426, 996.5748978960156, 1012.7670635753818, 16878.831211687724, 16940.322387104872, 17571.385001524886, 17927.193276302336, 18258.36095736643, 38962.80518597389, 43047.56952430436, 43575.56424435715, 43976.12047759091, 44585.10829783451, 56826.43173568211, 58810.0, 60529.0, 62019.0, 63262.05106923492, 8179.672813087648, 8478.194571515696, 8561.700340488052, 8565.828683426422, 8948.5078320693, 9521.523923803921, 13170.407331669907, 13367.131136476099, 13844.446222151404, 13988.58034258974, 11638.592649257236, 11649.88350116488, 11976.880231197576, 11989.820152697543, 12467.314297713712, 5463.180522921593, 9880.913099558898, 10827.458627068772, 11407.0, 12249.816252756395, 11765.176437649283, 11910.940445298065, 11940.820887686517, 12069.456874440495, 12189.0, 7426.2945020223, 7742.690292388242, 8259.0, 8670.739877803424, 8741.125887411208, 11816.881831181578, 12143.757124857277, 12162.75674486523, 12281.447334869774, 12583.182093164281], "value": 9138.778896881697, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.1585824717802, 1499.3627708224005, 1508.4795745467814, 1652.7686123942651, 1767.328415202223, 8421.831563368729, 8774.605142768574, 8862.423942443746, 9101.317401194903, 9116.544172791368, 8905.91094089059, 9001.50491722955, 9018.68434604789, 9021.774455638611, 9023.819523609523, 2407.6388541718793, 2433.598456254716, 2433.9391515212083, 2435.1598698449006, 2437.768412000857, 2355.611324131516, 2385.010220758383, 2413.6620873077695, 2419.395151212197, 2421.2736179146273, 2396.9640455393096, 2398.772116648924, 2407.0251548123038, 2431.2463136427677, 2431.5380077785253, 2337.614293641564, 2364.810815134785, 2366.1718398560365, 2372.2171683344454, 2372.323887692008, 2305.988470057639, 2306.7808558186944, 2315.3632750993443, 2316.7104111986, 2323.2449453927543, 8587.613557389932, 8849.955750221208, 9001.59492822818, 9007.594658240328, 9012.369134160612, 5091.592672586221, 5242.397124330674, 5305.257263983045, 5306.548943339821, 5311.548518375943, 3630.6369363063745, 3643.526341575605, 3705.6109108543483, 3712.4988126602834, 3718.5909549949483, 1167.200467679642, 1173.3605185174101, 1178.8113901775675, 1188.0792385900995, 1189.244829533244, 12429.502819887284, 12654.55709050188, 12675.17611355259, 12685.873141268654, 12707.618771436872, 4512.142692888341, 4722.763861806965, 4796.760161991887, 4797.328374027639, 4867.561919427198, 10603.310784799118, 10608.57565697379, 10609.734756631146, 10610.787784244427, 10615.575376984989, 5352.518273355417, 5354.651947623392, 5357.062514060024, 5359.222912677717, 5360.571154307646, 4429.689921705514, 4611.400517932647, 4724.102420540086, 4739.241721324572, 4928.901421971612, 3867.5358956925347, 3875.379939209713, 4047.392891066305, 4094.8362065517044, 4165.625093741578, 1272.7200015996466, 1277.482619539088, 1313.3105119811985, 1316.7498175346846, 1320.8877245434053, 959.7744530035436, 969.413504829582, 972.7179118055826, 985.1527686189871, 999.4552968632113, 6015.368386319374, 6041.697915104227, 6044.123602077762, 6061.7575296987625, 6119.77604479106, 441.6510956344452, 442.82065763365887, 462.8333799832125, 464.3313628375129, 467.82690404550533, 4031.697622678311, 4046.9190616188102, 4065.10567675111, 4069.104796944667, 4083.0813067059676, 10171.694849154537, 10567.894321056845, 10572.15422766177, 10580.470976451146, 10612.41631710248, 10440.112590429899, 10464.790704185874, 10466.895331046744, 10469.895301047045, 10473.68578942633, 7649.464537482323, 7877.094134174528, 7914.604269786488, 7915.010623672041, 7993.440459167802, 5761.596688231783, 5951.077582974646, 5965.433283838029, 6031.095335699505, 6251.281102673251, 10014.749631259278, 10249.33379330341, 10261.58953641846, 10265.897341026493, 10295.794084118426, 10113.494325283853, 10245.846312305172, 10416.062554370143, 10418.114460270659, 10440.112590429595, 7151.213366529573, 7769.689212431439, 7892.526448413114, 7994.720184793504, 8050.7923811428755, 8987.505687187268, 9040.954795225982, 9047.230985366054, 9054.366194366332, 9054.366194366594, 7945.0863150736095, 8004.159563245776, 8139.552324622203, 8267.0, 8317.500949943023, 7828.608569571613, 7942.44402891792, 7943.642536086006, 7980.760577182694, 8002.679892804223, 7306.97702321686, 7317.304856038668, 7416.48084634092, 7425.294597013275, 7428.33145016951, 5117.2068329409, 5215.400228973716, 5269.104252277199, 5281.287026251407, 5384.185080113546, 5198.636095473281, 5205.271262023244, 5234.7906083756225, 5258.447862974485, 5367.355917289794], "value": 4627.105713243661, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5428400239663, 335.64086427522545, 338.28115255082946, 342.9931401371972, 345.925625990412, 5079.898402031957, 5111.718855462948, 5142.202958541432, 5191.974040129803, 5197.324347834786, 4814.1334559779225, 4972.552470277675, 4985.351904252442, 4989.151844186497, 5115.744212789365, 3924.274009308287, 3976.622220889011, 4011.799410029487, 4040.797960101998, 4047.615476529725, 4050.250703619825, 4055.3308704063793, 4059.8782036538805, 4072.755634661915, 4079.938800917989, 3867.45855580219, 4016.196760647882, 4050.716449848497, 4053.695972802037, 4054.9189016219657, 4027.496562929634, 4033.2740106780766, 4034.394840773878, 4045.5145382554283, 4046.8956142805723, 3580.1228698968657, 3585.982070089659, 3587.9727953706074, 3588.049166970755, 3605.675489205958, 4787.80848766049, 5008.499150084962, 5009.724465154415, 5023.497650234984, 5081.74591270435, 4547.658925580595, 4588.977055114737, 4596.4024676791805, 4596.414237088199, 4607.999999999966, 5336.9733151334385, 5353.437889021675, 5360.91958620621, 5363.892722145574, 5367.651102678353, 3887.9696880326455, 3905.1018265798743, 3906.238283534712, 3913.728038387507, 3919.431682406035, 5259.684418934876, 5519.972400137974, 5523.585731070146, 5526.309211348582, 5530.069063396406, 3929.9607003929596, 3960.1683646433994, 3960.881173564798, 3962.9603703963166, 3986.1629057897585, 4039.3940908863906, 4045.3122969094734, 4057.5190055630073, 4057.8173982170874, 4065.4511640928686, 4433.0, 4542.545745425431, 4552.3171524270965, 4593.47175074864, 4630.240508606708, 5341.626086174008, 5352.411234764173, 5358.464153584689, 5372.059889519397, 5378.838634840961, 1312.566852938528, 1374.305975482375, 1374.6940406613758, 1389.2567476400077, 1396.5112210726165, 937.6202637931649, 954.5465903695828, 966.2028826218398, 972.6158167523788, 974.0989584634185, 5141.38303403594, 5151.150060240018, 5185.2999845021195, 5188.325517682677, 5220.869478262998, 5401.891962160735, 5420.512153906167, 5457.317835270591, 5465.699386533779, 5511.421300763443, 4966.8758281043265, 5078.5175408336145, 5126.513640884168, 5127.512886275797, 5129.0, 2853.315204350982, 2859.8999035033676, 2861.8712157952527, 2862.9427411451657, 2869.4548035873536, 5418.864528386822, 5555.666660000413, 5586.888262234733, 5618.410066942994, 5625.240592520039, 5466.34403871538, 5474.479924407175, 5496.972515137399, 5497.47773961473, 5504.779808807683, 5590.2453168821685, 5598.972005139948, 5612.130119831432, 5622.128570071645, 5671.51792097668, 5246.947530524646, 5355.062863998863, 5423.159410291411, 5444.50999410055, 5467.5625949923115, 5379.300690910157, 5390.946090539202, 5394.757235924314, 5401.459854014567, 5403.486668766461, 5493.2034854946605, 5621.044422448112, 5642.379338272869, 5649.54803615718, 5656.43435656431, 3954.8813535593977, 3957.9010524737114, 3962.465067215889, 3983.9601603984747, 3994.540627827837, 5340.2256672783005, 5376.301080859464, 5401.594880383908, 5440.319960004999, 5451.182322651634, 5048.8990220194655, 5292.470752924677, 5299.5230429261555, 5311.521963023347, 5324.920126198032, 5222.138347172674, 5225.190095535198, 5255.737213139251, 5258.212207849349, 5261.394939581997, 5089.745512724275, 5228.686278823283, 5248.9737551312, 5266.710330931835, 5268.341457317835, 5197.4542673020305, 5251.684898906078, 5269.841904742864, 5341.626086174086, 5371.62398632092, 5234.895302093861, 5264.947350526446, 5273.156294992783, 5274.446183150714, 5284.920726189033], "value": 4094.0687340150853, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.9044329015585, 718.5796309159142, 735.5623404074573, 807.1000834070012, 818.373943932891, 15648.21758912054, 16634.50096497104, 16692.499225023268, 16696.415625453126, 16841.578960525978, 15737.0, 15995.200239988013, 16001.519954401358, 16004.959677620947, 16029.759553606706, 616.9629822210682, 748.1994266135238, 791.1337085890955, 795.0380040151424, 795.0538858758059, 809.2312303311847, 812.9715459958902, 813.3208770676463, 813.3858936502932, 813.5200231863199, 846.4413487098516, 849.2653854415947, 851.4976164063202, 853.9658413663446, 854.7136709202425, 685.8388278754488, 710.7583421636668, 714.4034730999622, 806.4999700185864, 851.6593362654926, 609.0529227051933, 613.4816080412045, 614.4869034356318, 614.7233744814806, 615.6860001399318, 15238.314275857501, 15289.311980960883, 15297.770533442008, 15306.540803775793, 15316.081035137817, 14477.276136193148, 14599.562013139517, 14651.560453186421, 14808.481703140338, 14824.703505929821, 13237.669058273525, 13247.271400073088, 13382.263975481344, 13536.661583460394, 13772.655683607889, 4489.618382437497, 4616.0, 4670.229412147026, 4763.924723401925, 4791.281307803857, 86749.56625216897, 87746.12253877443, 87772.0, 87877.0, 88136.0, 11070.39112848801, 11206.43967801623, 11783.764324713458, 11862.466189021514, 11970.40147992597, 22018.889905550368, 22084.779152208273, 22310.88844555767, 22376.55246895053, 22445.43886402853, 8129.227723366271, 8417.284530814826, 8505.489670619783, 8526.40315177944, 8537.487750734976, 4624.375709279271, 4656.743879086615, 4761.976190119097, 4821.63837712166, 4836.709797412166, 3479.251960828434, 3593.1196856770257, 3593.8562457501407, 3818.6372294631965, 3994.660453861396, 675.3651567526607, 689.3038031588133, 690.6443181761397, 691.8616276744672, 696.3350000749273, 687.2303020616941, 688.9242183359827, 702.8910518869584, 740.1525253584615, 752.9021227240534, 9989.350692204984, 10157.695269141937, 10707.250492465453, 10773.0, 10821.67534973952, 641.4836056974087, 726.1830440754152, 734.6914295995695, 756.5460723565817, 765.4259305520859, 4978.278149668277, 5163.225516172604, 5206.479352064839, 5220.895582088337, 5226.895462090737, 73393.89909151367, 73460.49969603626, 123443.0, 124750.0, 127110.0, 68809.0, 109925.45037274923, 113920.75990501187, 116856.0, 117108.41445792717, 95976.0, 96480.51759741157, 98721.50639246758, 100196.49901750445, 102013.48993254986, 9450.102240287162, 9785.85321220168, 9841.311108222355, 9927.40435573868, 9928.15610673072, 56473.71763141158, 57313.713431432574, 57598.7120064397, 57635.71182144062, 58590.4140958602, 49471.0, 50500.49499504958, 71831.0, 73342.63328683322, 74527.62736186285, 13396.464141434233, 13599.320033998458, 13786.103903246258, 13850.445982161003, 14120.293985300488, 15490.690186196438, 15757.448489303279, 15881.126538040518, 15881.920590396974, 16069.0, 13983.650408739455, 14085.788713169515, 14564.563063108124, 14654.413823447368, 14838.332275047866, 14228.786568201278, 14377.209253491159, 14788.11271323724, 14808.185549794865, 15053.924730376279, 14078.859211408164, 14485.591807573097, 14513.0, 14673.339699713326, 14805.259737012891, 10873.945630272114, 10887.074598659203, 11132.833007504732, 11164.218504704593, 11520.539178433104, 12012.699682507659, 12079.154459187772, 12083.0, 12318.445669944695, 12614.810777838524], "value": 7836.82345992587, "unit": "score"}], "name": "dromaeo_css", "value": 7285.853117823926, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 112.0, 106.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 122.0, 179.0, 118.0, 119.0, 152.0, 119.0, 155.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 164.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 115.0, 76.0, 76.0, 77.0, 76.0, 105.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 137.0, 85.0, 86.0, 86.0, 115.0, 85.0, 85.0, 127.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 48.0, 51.0, 51.0, 51.0, 53.0, 50.0, 50.0, 53.0, 50.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 81.0, 78.0, 84.0, 78.0, 84.0, 78.0, 81.0, 77.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 136.0, 130.0, 123.0, 121.0, 121.0, 120.0, 149.0, 123.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 167.0, 170.0, 172.0, 174.0, 165.0, 167.0, 167.0, 164.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 66.0, 64.0, 65.0, 65.0, 72.0, 64.0, 63.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1497.7999999999997, "alertThreshold": 2.0}]} 16:44:27 INFO - Return code: 0 16:44:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:44:27 INFO - # TBPL SUCCESS # 16:44:27 INFO - Running post-action listener: _resource_record_post_action 16:44:27 INFO - [mozharness: 2016-08-18 23:44:27.891524Z] Finished run-tests step (success) 16:44:27 INFO - Running post-run listener: _resource_record_post_run 16:44:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 410099712; Read time: 320; Write time: 289992 16:44:27 INFO - TinderboxPrint: CPU usage
13.0% 16:44:27 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 320 16:44:27 INFO - TinderboxPrint: I/O write bytes / time
410,099,712 / 289,992 16:44:27 INFO - TinderboxPrint: CPU idle
8,285.2 (87.0%) 16:44:27 INFO - TinderboxPrint: CPU user
1,194.0 (12.5%) 16:44:27 INFO - TinderboxPrint: Swap in / out
0 / 0 16:44:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118099968; Read time: 104; Write time: 108156 16:44:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291647488; Read time: 204; Write time: 181836 16:44:28 INFO - Running post-run listener: _upload_blobber_files 16:44:28 INFO - Blob upload gear active. 16:44:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:28 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:44:28 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:44:28 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:44:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:29 INFO - (blobuploader) - INFO - Done attempting. 16:44:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:44:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:30 INFO - (blobuploader) - INFO - Done attempting. 16:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:44:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:35 INFO - (blobuploader) - INFO - Done attempting. 16:44:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:44:35 INFO - Return code: 0 16:44:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:44:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:44:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0adf1ced9c6bf903557453b6c392cfe1c331860509363f8faa789b38a8d25175c3bcf34ce7e3e903d58cacbace654e3c29ce9d6292794ada45e71cb03c185fec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ba0847ff0885acfa24bb718823172d3705e7c451ad4c699ccea3ee4f62f172fce13bca5e8eb3d6578a0bddd813d5f28ad3a1a9527b1f701ad9628d799a4c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b0311e240f1ce501c4da973e8c96d4907482313861378dbb41bb629b288898115e776a62d4ffea964fe971b42d4c4187eccf592aa2c27aede0e14a8fc01b98"} 16:44:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:44:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:44:35 INFO - Contents: 16:44:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0adf1ced9c6bf903557453b6c392cfe1c331860509363f8faa789b38a8d25175c3bcf34ce7e3e903d58cacbace654e3c29ce9d6292794ada45e71cb03c185fec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ba0847ff0885acfa24bb718823172d3705e7c451ad4c699ccea3ee4f62f172fce13bca5e8eb3d6578a0bddd813d5f28ad3a1a9527b1f701ad9628d799a4c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b0311e240f1ce501c4da973e8c96d4907482313861378dbb41bb629b288898115e776a62d4ffea964fe971b42d4c4187eccf592aa2c27aede0e14a8fc01b98"} 16:44:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:44:35 INFO - Copying logs to upload dir... 16:44:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:44:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.167947 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-18 16:44:35.431421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 16:44:35.435474) ========= 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=41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317 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/0adf1ced9c6bf903557453b6c392cfe1c331860509363f8faa789b38a8d25175c3bcf34ce7e3e903d58cacbace654e3c29ce9d6292794ada45e71cb03c185fec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ba0847ff0885acfa24bb718823172d3705e7c451ad4c699ccea3ee4f62f172fce13bca5e8eb3d6578a0bddd813d5f28ad3a1a9527b1f701ad9628d799a4c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b0311e240f1ce501c4da973e8c96d4907482313861378dbb41bb629b288898115e776a62d4ffea964fe971b42d4c4187eccf592aa2c27aede0e14a8fc01b98"} build_url:https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/Irx5_DPwRWCf8kIT7kPn8Q/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/0adf1ced9c6bf903557453b6c392cfe1c331860509363f8faa789b38a8d25175c3bcf34ce7e3e903d58cacbace654e3c29ce9d6292794ada45e71cb03c185fec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ba0847ff0885acfa24bb718823172d3705e7c451ad4c699ccea3ee4f62f172fce13bca5e8eb3d6578a0bddd813d5f28ad3a1a9527b1f701ad9628d799a4c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b0311e240f1ce501c4da973e8c96d4907482313861378dbb41bb629b288898115e776a62d4ffea964fe971b42d4c4187eccf592aa2c27aede0e14a8fc01b98"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 16:44:35.461565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:44:35.461884) ========= 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=41bf3e9aed84707956354da8000001c5-1471562634.332478-1831252317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:44:35.546018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 16:44:35.546365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 16:44:35.546692) ========= ========= Total master_lag: 0.18 =========