builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1471897588.96 results: success (0) buildid: 20160822113002 builduid: 6ded628d48694e3e85ef738378ab98e2 revision: 74f16e8aed180aaf153827a6e5eedfb818c0cb11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:28.959866) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:28.960325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:28.960612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:28.975267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:28.975587) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 13:26:29-- 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% 40.1M=0s 2016-08-22 13:26:30 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.424712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:29.416264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:29.416817) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018599 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:29.469122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:29.469740) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 74f16e8aed180aaf153827a6e5eedfb818c0cb11 --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 74f16e8aed180aaf153827a6e5eedfb818c0cb11 --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=17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 13:26:30,330 truncating revision to first 12 chars 2016-08-22 13:26:30,330 Setting DEBUG logging. 2016-08-22 13:26:30,330 attempt 1/10 2016-08-22 13:26:30,330 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/74f16e8aed18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 13:26:30,611 unpacking tar archive at: fx-team-74f16e8aed18/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:30.119120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:30.119463) ========= script_repo_revision: 74f16e8aed180aaf153827a6e5eedfb818c0cb11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:30.119885) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:30.120154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 13:26:30.130444) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-22 13:26:30.130854) ========= /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=17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:26:31 INFO - MultiFileLogger online at 20160822 13:26:31 in /builds/slave/test 13:26:31 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 13:26:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:26:31 INFO - {'append_to_log': False, 13:26:31 INFO - 'base_work_dir': '/builds/slave/test', 13:26:31 INFO - 'blob_upload_branch': 'Fx-Team', 13:26:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:26:31 INFO - 'branch': 'Fx-Team', 13:26:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:26:31 INFO - 'config_files': ('talos/linux_config.py',), 13:26:31 INFO - 'default_actions': ('clobber', 13:26:31 INFO - 'read-buildbot-config', 13:26:31 INFO - 'download-and-extract', 13:26:31 INFO - 'populate-webroot', 13:26:31 INFO - 'create-virtualenv', 13:26:31 INFO - 'install', 13:26:31 INFO - 'run-tests'), 13:26:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:26:31 INFO - 'download_minidump_stackwalk': True, 13:26:31 INFO - 'download_symbols': 'ondemand', 13:26:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:26:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:26:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:26:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:26:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:26:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:26:31 INFO - 'installer_path': 'installer.exe', 13:26:31 INFO - 'log_level': 'info', 13:26:31 INFO - 'log_name': 'talos', 13:26:31 INFO - 'log_to_console': True, 13:26:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:26:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:26:31 INFO - 'opt_config_files': (), 13:26:31 INFO - 'pip_index': False, 13:26:31 INFO - 'sps_profile': False, 13:26:31 INFO - 'sps_profile_interval': 0, 13:26:31 INFO - 'suite': 'dromaeojs', 13:26:31 INFO - 'system_bits': '32', 13:26:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:26:31 INFO - 'title': 'talos-linux64-ix-009', 13:26:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:26:31 INFO - 'use_talos_json': True, 13:26:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:26:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:26:31 INFO - 'work_dir': 'build'} 13:26:31 INFO - [mozharness: 2016-08-22 20:26:31.079831Z] Running clobber step. 13:26:31 INFO - Running pre-action listener: _resource_record_pre_action 13:26:31 INFO - Running main action method: clobber 13:26:31 INFO - rmtree: /builds/slave/test/build 13:26:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:31 INFO - Running post-action listener: _resource_record_post_action 13:26:31 INFO - [mozharness: 2016-08-22 20:26:31.537462Z] Finished clobber step (success) 13:26:31 INFO - [mozharness: 2016-08-22 20:26:31.537569Z] Running read-buildbot-config step. 13:26:31 INFO - Running pre-action listener: _resource_record_pre_action 13:26:31 INFO - Running main action method: read_buildbot_config 13:26:31 INFO - Using buildbot properties: 13:26:31 INFO - { 13:26:31 INFO - "project": "", 13:26:31 INFO - "product": "firefox", 13:26:31 INFO - "script_repo_revision": "production", 13:26:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:26:31 INFO - "repository": "", 13:26:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:26:31 INFO - "buildid": "20160822113002", 13:26:31 INFO - "pgo_build": "True", 13:26:31 INFO - "basedir": "/builds/slave/test", 13:26:31 INFO - "buildnumber": 1486, 13:26:31 INFO - "slavename": "talos-linux64-ix-009", 13:26:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:26:31 INFO - "platform": "ubuntu64_hw", 13:26:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:26:31 INFO - "branch": "fx-team", 13:26:31 INFO - "repo_path": "integration/fx-team", 13:26:31 INFO - "revision": "74f16e8aed180aaf153827a6e5eedfb818c0cb11", 13:26:31 INFO - "stage_platform": "linux64-pgo", 13:26:31 INFO - "builduid": "6ded628d48694e3e85ef738378ab98e2", 13:26:31 INFO - "slavebuilddir": "test" 13:26:31 INFO - } 13:26:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:26:31 INFO - Running post-action listener: _resource_record_post_action 13:26:31 INFO - [mozharness: 2016-08-22 20:26:31.539975Z] Finished read-buildbot-config step (success) 13:26:31 INFO - [mozharness: 2016-08-22 20:26:31.540063Z] Running download-and-extract step. 13:26:31 INFO - Running pre-action listener: _resource_record_pre_action 13:26:31 INFO - Running main action method: download_and_extract 13:26:31 INFO - mkdir: /builds/slave/test/build/tests 13:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:31 INFO - trying https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:26:31 INFO - Downloading https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:32 INFO - Downloaded 1361 bytes. 13:26:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:26:32 INFO - Using the following test package requirements: 13:26:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:26:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:26:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:26:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'jsshell-linux-x86_64.zip'], 13:26:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:26:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:26:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:26:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:26:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:26:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:26:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:26:32 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')]} 13:26:32 INFO - trying https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:26:32 INFO - Downloading https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:32 INFO - Downloaded 21921105 bytes. 13:26:32 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 13:26:37 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 13:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:37 INFO - trying https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:26:37 INFO - Downloading https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:38 INFO - Downloaded 21921105 bytes. 13:26:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:26:43 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')]} 13:26:43 INFO - trying https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:26:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:44 INFO - Downloaded 14413981 bytes. 13:26:44 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 13:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:44 INFO - trying https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:26:44 INFO - Downloading https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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 13:26:45 INFO - Downloaded 59791254 bytes. 13:26:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:26:45 INFO - mkdir: /builds/slave/test/properties 13:26:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:45 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:45 INFO - Contents: 13:26:45 INFO - build_url:https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:26:46 INFO - Running post-action listener: _resource_record_post_action 13:26:46 INFO - Running post-action listener: set_extra_try_arguments 13:26:46 INFO - [mozharness: 2016-08-22 20:26:46.152156Z] Finished download-and-extract step (success) 13:26:46 INFO - [mozharness: 2016-08-22 20:26:46.152379Z] Running populate-webroot step. 13:26:46 INFO - Running pre-action listener: _resource_record_pre_action 13:26:46 INFO - Running main action method: populate_webroot 13:26:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:46 INFO - '--tppagecycles', 13:26:46 INFO - '7'], 13:26:46 INFO - 'tests': ['tsvgm']}}, 13:26:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['damp', 'tps']}, 13:26:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'tests': ['damp', 'tps']}, 13:26:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['dromaeo_dom']}, 13:26:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['basic_compositor_video']}, 13:26:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:26:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['a11yr', 13:26:46 INFO - 'ts_paint', 13:26:46 INFO - 'tpaint', 13:26:46 INFO - 'sessionrestore', 13:26:46 INFO - 'sessionrestore_no_auto_restore', 13:26:46 INFO - 'tabpaint']}, 13:26:46 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:46 INFO - 'ts_paint', 13:26:46 INFO - 'tpaint', 13:26:46 INFO - 'sessionrestore', 13:26:46 INFO - 'sessionrestore_no_auto_restore', 13:26:46 INFO - 'tabpaint']}, 13:26:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:46 INFO - 'ts_paint', 13:26:46 INFO - 'tpaint', 13:26:46 INFO - 'sessionrestore', 13:26:46 INFO - 'sessionrestore_no_auto_restore', 13:26:46 INFO - 'tabpaint']}, 13:26:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:46 INFO - 'ts_paint', 13:26:46 INFO - 'tpaint', 13:26:46 INFO - 'sessionrestore', 13:26:46 INFO - 'sessionrestore_no_auto_restore', 13:26:46 INFO - 'tabpaint']}, 13:26:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['a11yr', 13:26:46 INFO - 'ts_paint', 13:26:46 INFO - 'tpaint', 13:26:46 INFO - 'sessionrestore', 13:26:46 INFO - 'sessionrestore_no_auto_restore', 13:26:46 INFO - 'tabpaint']}, 13:26:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['a11yr', 13:26:46 INFO - 'ts_paint', 13:26:46 INFO - 'tpaint', 13:26:46 INFO - 'sessionrestore', 13:26:46 INFO - 'sessionrestore_no_auto_restore', 13:26:46 INFO - 'tabpaint']}, 13:26:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['tsvgx', 13:26:46 INFO - 'tsvgr_opacity', 13:26:46 INFO - 'tart', 13:26:46 INFO - 'tscrollx', 13:26:46 INFO - 'cart']}, 13:26:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:46 INFO - 'tsvgr_opacity', 13:26:46 INFO - 'tart', 13:26:46 INFO - 'tscrollx', 13:26:46 INFO - 'cart']}, 13:26:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'talos_options': ['--disable-e10s'], 13:26:46 INFO - 'tests': ['tp5o']}, 13:26:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'tests': ['tp5o']}, 13:26:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'talos_options': ['--disable-e10s', 13:26:46 INFO - '--xperf_path', 13:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:46 INFO - 'tests': ['tp5n']}, 13:26:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:46 INFO - 'talos_options': ['--xperf_path', 13:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:46 INFO - 'tests': ['tp5n']}}, 13:26:46 INFO - 'talos.zip': {'path': '', 13:26:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:46 INFO - Running post-action listener: _resource_record_post_action 13:26:46 INFO - [mozharness: 2016-08-22 20:26:46.171507Z] Finished populate-webroot step (success) 13:26:46 INFO - [mozharness: 2016-08-22 20:26:46.171595Z] Running create-virtualenv step. 13:26:46 INFO - Running pre-action listener: _resource_record_pre_action 13:26:46 INFO - Running main action method: create_virtualenv 13:26:46 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:46 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 13:26:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:46 INFO - Using real prefix '/usr' 13:26:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:26:46 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:48 INFO - Installing pip.................done. 13:26:48 INFO - Return code: 0 13:26:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:48 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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:26:48 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 13:26:48 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 13:26:48 INFO - Using env: {'DISPLAY': ':0', 13:26:48 INFO - 'HOME': '/home/cltbld', 13:26:48 INFO - 'LANG': 'en_US.UTF-8', 13:26:48 INFO - 'LANGUAGE': 'en_US:en', 13:26:48 INFO - 'LOGNAME': 'cltbld', 13:26:48 INFO - 'MAIL': '/var/mail/cltbld', 13:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:48 INFO - 'MOZ_NO_REMOTE': '1', 13:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:48 INFO - 'NO_EM_RESTART': '1', 13:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:48 INFO - 'PWD': '/builds/slave/test', 13:26:48 INFO - 'SHELL': '/bin/bash', 13:26:48 INFO - 'SHLVL': '1', 13:26:48 INFO - 'TERM': 'linux', 13:26:48 INFO - 'TMOUT': '86400', 13:26:48 INFO - 'USER': 'cltbld', 13:26:48 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:48 INFO - '_': '/tools/buildbot/bin/python'} 13:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:48 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 13:26:48 INFO - Cleaning up... 13:26:48 INFO - Return code: 0 13:26:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:48 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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:26:48 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 13:26:48 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 13:26:48 INFO - Using env: {'DISPLAY': ':0', 13:26:48 INFO - 'HOME': '/home/cltbld', 13:26:48 INFO - 'LANG': 'en_US.UTF-8', 13:26:48 INFO - 'LANGUAGE': 'en_US:en', 13:26:48 INFO - 'LOGNAME': 'cltbld', 13:26:48 INFO - 'MAIL': '/var/mail/cltbld', 13:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:48 INFO - 'MOZ_NO_REMOTE': '1', 13:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:48 INFO - 'NO_EM_RESTART': '1', 13:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:48 INFO - 'PWD': '/builds/slave/test', 13:26:48 INFO - 'SHELL': '/bin/bash', 13:26:48 INFO - 'SHLVL': '1', 13:26:48 INFO - 'TERM': 'linux', 13:26:48 INFO - 'TMOUT': '86400', 13:26:48 INFO - 'USER': 'cltbld', 13:26:48 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:48 INFO - '_': '/tools/buildbot/bin/python'} 13:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:49 INFO - Downloading/unpacking psutil>=3.1.1 13:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:51 INFO - Installing collected packages: psutil 13:26:51 INFO - Running setup.py install for psutil 13:26:51 INFO - building 'psutil._psutil_linux' extension 13:26:51 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 13:26:51 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 13:26:51 INFO - building 'psutil._psutil_posix' extension 13:26:51 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 13:26:51 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 13:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:51 INFO - Successfully installed psutil 13:26:51 INFO - Cleaning up... 13:26:51 INFO - Return code: 0 13:26:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:26:51 INFO - Using env: {'DISPLAY': ':0', 13:26:51 INFO - 'HOME': '/home/cltbld', 13:26:51 INFO - 'LANG': 'en_US.UTF-8', 13:26:51 INFO - 'LANGUAGE': 'en_US:en', 13:26:51 INFO - 'LOGNAME': 'cltbld', 13:26:51 INFO - 'MAIL': '/var/mail/cltbld', 13:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:51 INFO - 'MOZ_NO_REMOTE': '1', 13:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:51 INFO - 'NO_EM_RESTART': '1', 13:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:51 INFO - 'PWD': '/builds/slave/test', 13:26:51 INFO - 'SHELL': '/bin/bash', 13:26:51 INFO - 'SHLVL': '1', 13:26:51 INFO - 'TERM': 'linux', 13:26:51 INFO - 'TMOUT': '86400', 13:26:51 INFO - 'USER': 'cltbld', 13:26:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:51 INFO - '_': '/tools/buildbot/bin/python'} 13:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:26:52 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 13:26:52 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 13:26:52 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 13:26:52 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 13:26:52 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 13:26:52 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 13:26:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:26:54 INFO - Installing collected packages: mozsystemmonitor 13:26:54 INFO - Running setup.py install for mozsystemmonitor 13:26:54 INFO - Successfully installed mozsystemmonitor 13:26:54 INFO - Cleaning up... 13:26:54 INFO - Return code: 0 13:26:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:26:54 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 13:26:54 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 13:26:54 INFO - Using env: {'DISPLAY': ':0', 13:26:54 INFO - 'HOME': '/home/cltbld', 13:26:54 INFO - 'LANG': 'en_US.UTF-8', 13:26:54 INFO - 'LANGUAGE': 'en_US:en', 13:26:54 INFO - 'LOGNAME': 'cltbld', 13:26:54 INFO - 'MAIL': '/var/mail/cltbld', 13:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:54 INFO - 'MOZ_NO_REMOTE': '1', 13:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:54 INFO - 'NO_EM_RESTART': '1', 13:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:54 INFO - 'PWD': '/builds/slave/test', 13:26:54 INFO - 'SHELL': '/bin/bash', 13:26:54 INFO - 'SHLVL': '1', 13:26:54 INFO - 'TERM': 'linux', 13:26:54 INFO - 'TMOUT': '86400', 13:26:54 INFO - 'USER': 'cltbld', 13:26:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:54 INFO - '_': '/tools/buildbot/bin/python'} 13:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:54 INFO - Downloading/unpacking jsonschema==2.5.1 13:26:54 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 13:26:54 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 13:26:54 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 13:26:54 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 13:26:54 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 13:26:54 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 13:26:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:56 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:56 INFO - warning: no files found matching '*.txt' 13:26:56 INFO - no previously-included directories found matching 'build' 13:26:56 INFO - no previously-included directories found matching 'dist' 13:26:56 INFO - no previously-included directories found matching '.git*' 13:26:56 INFO - Installing collected packages: jsonschema, functools32 13:26:56 INFO - Running setup.py install for functools32 13:26:56 INFO - warning: no files found matching '*.txt' 13:26:56 INFO - no previously-included directories found matching 'build' 13:26:56 INFO - no previously-included directories found matching 'dist' 13:26:56 INFO - no previously-included directories found matching '.git*' 13:26:56 INFO - Successfully installed jsonschema functools32 13:26:56 INFO - Cleaning up... 13:26:56 INFO - Return code: 0 13:26:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:26:56 INFO - Using env: {'DISPLAY': ':0', 13:26:56 INFO - 'HOME': '/home/cltbld', 13:26:56 INFO - 'LANG': 'en_US.UTF-8', 13:26:56 INFO - 'LANGUAGE': 'en_US:en', 13:26:56 INFO - 'LOGNAME': 'cltbld', 13:26:56 INFO - 'MAIL': '/var/mail/cltbld', 13:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:56 INFO - 'MOZ_NO_REMOTE': '1', 13:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:56 INFO - 'NO_EM_RESTART': '1', 13:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:56 INFO - 'PWD': '/builds/slave/test', 13:26:56 INFO - 'SHELL': '/bin/bash', 13:26:56 INFO - 'SHLVL': '1', 13:26:56 INFO - 'TERM': 'linux', 13:26:56 INFO - 'TMOUT': '86400', 13:26:56 INFO - 'USER': 'cltbld', 13:26:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:56 INFO - '_': '/tools/buildbot/bin/python'} 13:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:26:56 INFO - Cleaning up... 13:26:56 INFO - Return code: 0 13:26:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:26:56 INFO - Using env: {'DISPLAY': ':0', 13:26:56 INFO - 'HOME': '/home/cltbld', 13:26:56 INFO - 'LANG': 'en_US.UTF-8', 13:26:56 INFO - 'LANGUAGE': 'en_US:en', 13:26:56 INFO - 'LOGNAME': 'cltbld', 13:26:56 INFO - 'MAIL': '/var/mail/cltbld', 13:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:56 INFO - 'MOZ_NO_REMOTE': '1', 13:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:56 INFO - 'NO_EM_RESTART': '1', 13:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:56 INFO - 'PWD': '/builds/slave/test', 13:26:56 INFO - 'SHELL': '/bin/bash', 13:26:56 INFO - 'SHLVL': '1', 13:26:56 INFO - 'TERM': 'linux', 13:26:56 INFO - 'TMOUT': '86400', 13:26:56 INFO - 'USER': 'cltbld', 13:26:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:56 INFO - '_': '/tools/buildbot/bin/python'} 13:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:57 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:57 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 13:26:57 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 13:26:57 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 13:26:57 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 13:26:57 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 13:26:57 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 13:26:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 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 13:26:59 INFO - Downloading docopt-0.6.1.tar.gz 13:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:59 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:59 INFO - Running setup.py install for blobuploader 13:26:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:59 INFO - Running setup.py install for requests 13:27:00 INFO - Running setup.py install for docopt 13:27:00 INFO - Successfully installed blobuploader requests docopt 13:27:00 INFO - Cleaning up... 13:27:00 INFO - Return code: 0 13:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:00 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')]} 13:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:00 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')]} 13:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:00 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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:27:00 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 13:27:00 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 13:27:00 INFO - Using env: {'DISPLAY': ':0', 13:27:00 INFO - 'HOME': '/home/cltbld', 13:27:00 INFO - 'LANG': 'en_US.UTF-8', 13:27:00 INFO - 'LANGUAGE': 'en_US:en', 13:27:00 INFO - 'LOGNAME': 'cltbld', 13:27:00 INFO - 'MAIL': '/var/mail/cltbld', 13:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:00 INFO - 'MOZ_NO_REMOTE': '1', 13:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:00 INFO - 'NO_EM_RESTART': '1', 13:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:00 INFO - 'PWD': '/builds/slave/test', 13:27:00 INFO - 'SHELL': '/bin/bash', 13:27:00 INFO - 'SHLVL': '1', 13:27:00 INFO - 'TERM': 'linux', 13:27:00 INFO - 'TMOUT': '86400', 13:27:00 INFO - 'USER': 'cltbld', 13:27:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:00 INFO - '_': '/tools/buildbot/bin/python'} 13:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:00 INFO - Running setup.py (path:/tmp/pip-7eJyKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:00 INFO - Running setup.py (path:/tmp/pip-AG1s2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:00 INFO - Running setup.py (path:/tmp/pip-6fpYZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:00 INFO - Running setup.py (path:/tmp/pip-CuBhIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:00 INFO - Running setup.py (path:/tmp/pip-O0ThYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:00 INFO - Running setup.py (path:/tmp/pip-FCeUUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:01 INFO - Running setup.py (path:/tmp/pip-9K8bnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:01 INFO - Running setup.py (path:/tmp/pip-ZiAoZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:01 INFO - Running setup.py (path:/tmp/pip-2TAJSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:01 INFO - Running setup.py (path:/tmp/pip-rdT9yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:01 INFO - Running setup.py (path:/tmp/pip-cdmC4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:01 INFO - Running setup.py (path:/tmp/pip-97g94z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:01 INFO - Running setup.py (path:/tmp/pip-5dQ7S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:01 INFO - Running setup.py (path:/tmp/pip-kz1xP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:01 INFO - Running setup.py (path:/tmp/pip-PPnKix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:01 INFO - Running setup.py (path:/tmp/pip-WjqipO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:01 INFO - Running setup.py (path:/tmp/pip-N4xP4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:01 INFO - Running setup.py install for manifestparser 13:27:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:27:01 INFO - Running setup.py install for mozcrash 13:27:02 INFO - Running setup.py install for mozdebug 13:27:02 INFO - Running setup.py install for mozdevice 13:27:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Running setup.py install for mozfile 13:27:02 INFO - Running setup.py install for mozhttpd 13:27:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Running setup.py install for mozinfo 13:27:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Running setup.py install for mozInstall 13:27:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Running setup.py install for mozleak 13:27:02 INFO - Running setup.py install for mozlog 13:27:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Running setup.py install for moznetwork 13:27:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Running setup.py install for mozprocess 13:27:03 INFO - Running setup.py install for mozprofile 13:27:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:27:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:27:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:27:03 INFO - Running setup.py install for mozrunner 13:27:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:27:03 INFO - Running setup.py install for mozscreenshot 13:27:03 INFO - Running setup.py install for moztest 13:27:03 INFO - Running setup.py install for mozversion 13:27:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:27:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:27:03 INFO - Cleaning up... 13:27:03 INFO - Return code: 0 13:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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')]} 13:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:03 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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:27:03 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 13:27:03 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 13:27:03 INFO - Using env: {'DISPLAY': ':0', 13:27:03 INFO - 'HOME': '/home/cltbld', 13:27:03 INFO - 'LANG': 'en_US.UTF-8', 13:27:03 INFO - 'LANGUAGE': 'en_US:en', 13:27:03 INFO - 'LOGNAME': 'cltbld', 13:27:03 INFO - 'MAIL': '/var/mail/cltbld', 13:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:03 INFO - 'MOZ_NO_REMOTE': '1', 13:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:03 INFO - 'NO_EM_RESTART': '1', 13:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:03 INFO - 'PWD': '/builds/slave/test', 13:27:03 INFO - 'SHELL': '/bin/bash', 13:27:03 INFO - 'SHLVL': '1', 13:27:03 INFO - 'TERM': 'linux', 13:27:03 INFO - 'TMOUT': '86400', 13:27:03 INFO - 'USER': 'cltbld', 13:27:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:03 INFO - '_': '/tools/buildbot/bin/python'} 13:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:03 INFO - Running setup.py (path:/tmp/pip-LOOEVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:03 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)) 13:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:03 INFO - Running setup.py (path:/tmp/pip-RCXCT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:03 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)) 13:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:03 INFO - Running setup.py (path:/tmp/pip-fehRbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:04 INFO - Running setup.py (path:/tmp/pip-Aot_3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:04 INFO - Running setup.py (path:/tmp/pip-bfxAHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:04 INFO - Running setup.py (path:/tmp/pip-JO_ClA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:04 INFO - Running setup.py (path:/tmp/pip-1lJOMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:04 INFO - Running setup.py (path:/tmp/pip-lapjED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:04 INFO - Running setup.py (path:/tmp/pip-wukPVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:04 INFO - Running setup.py (path:/tmp/pip-JxvZt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:04 INFO - Running setup.py (path:/tmp/pip-0_0Moj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:04 INFO - Running setup.py (path:/tmp/pip-oIUElV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:04 INFO - Running setup.py (path:/tmp/pip-A3KkyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:04 INFO - Running setup.py (path:/tmp/pip-bgYXJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:04 INFO - Running setup.py (path:/tmp/pip-dTiODK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:04 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)) 13:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:04 INFO - Running setup.py (path:/tmp/pip-Kyw142-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:05 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)) 13:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:05 INFO - Running setup.py (path:/tmp/pip-ycWyWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:05 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)) 13:27:05 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)) 13:27:05 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)) 13:27:05 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)) 13:27:05 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)) 13:27:05 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)) 13:27:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:06 INFO - Downloading blessings-1.6.tar.gz 13:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:27:07 INFO - Installing collected packages: blessings 13:27:07 INFO - Running setup.py install for blessings 13:27:07 INFO - Successfully installed blessings 13:27:07 INFO - Cleaning up... 13:27:07 INFO - Return code: 0 13:27:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:07 INFO - Reading from file tmpfile_stdout 13:27:07 INFO - Current package versions: 13:27:07 INFO - argparse == 1.2.1 13:27:07 INFO - blessings == 1.6 13:27:07 INFO - blobuploader == 1.2.4 13:27:07 INFO - docopt == 0.6.1 13:27:07 INFO - functools32 == 3.2.3-2 13:27:07 INFO - jsonschema == 2.5.1 13:27:07 INFO - manifestparser == 1.1 13:27:07 INFO - mozInstall == 1.12 13:27:07 INFO - mozcrash == 0.17 13:27:07 INFO - mozdebug == 0.1 13:27:07 INFO - mozdevice == 0.48 13:27:07 INFO - mozfile == 1.2 13:27:07 INFO - mozhttpd == 0.7 13:27:07 INFO - mozinfo == 0.9 13:27:07 INFO - mozleak == 0.1 13:27:07 INFO - mozlog == 3.3 13:27:07 INFO - moznetwork == 0.27 13:27:07 INFO - mozprocess == 0.23 13:27:07 INFO - mozprofile == 0.28 13:27:07 INFO - mozrunner == 6.12 13:27:07 INFO - mozscreenshot == 0.1 13:27:07 INFO - mozsystemmonitor == 0.3 13:27:07 INFO - moztest == 0.7 13:27:07 INFO - mozversion == 1.4 13:27:07 INFO - psutil == 3.1.1 13:27:07 INFO - requests == 1.2.3 13:27:07 INFO - wsgiref == 0.1.2 13:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:07 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 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:27:07 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 13:27:07 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 13:27:07 INFO - Using env: {'DISPLAY': ':0', 13:27:07 INFO - 'HOME': '/home/cltbld', 13:27:07 INFO - 'LANG': 'en_US.UTF-8', 13:27:07 INFO - 'LANGUAGE': 'en_US:en', 13:27:07 INFO - 'LOGNAME': 'cltbld', 13:27:07 INFO - 'MAIL': '/var/mail/cltbld', 13:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:07 INFO - 'MOZ_NO_REMOTE': '1', 13:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:07 INFO - 'NO_EM_RESTART': '1', 13:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:07 INFO - 'PWD': '/builds/slave/test', 13:27:07 INFO - 'SHELL': '/bin/bash', 13:27:07 INFO - 'SHLVL': '1', 13:27:07 INFO - 'TERM': 'linux', 13:27:07 INFO - 'TMOUT': '86400', 13:27:07 INFO - 'USER': 'cltbld', 13:27:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:07 INFO - '_': '/tools/buildbot/bin/python'} 13:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 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)) 13:27:07 INFO - Cleaning up... 13:27:07 INFO - Return code: 0 13:27:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff934d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, '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': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', '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 13:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:27:07 INFO - Using env: {'DISPLAY': ':0', 13:27:07 INFO - 'HOME': '/home/cltbld', 13:27:07 INFO - 'LANG': 'en_US.UTF-8', 13:27:07 INFO - 'LANGUAGE': 'en_US:en', 13:27:07 INFO - 'LOGNAME': 'cltbld', 13:27:07 INFO - 'MAIL': '/var/mail/cltbld', 13:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:07 INFO - 'MOZ_NO_REMOTE': '1', 13:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:07 INFO - 'NO_EM_RESTART': '1', 13:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:07 INFO - 'PWD': '/builds/slave/test', 13:27:07 INFO - 'SHELL': '/bin/bash', 13:27:07 INFO - 'SHLVL': '1', 13:27:07 INFO - 'TERM': 'linux', 13:27:07 INFO - 'TMOUT': '86400', 13:27:07 INFO - 'USER': 'cltbld', 13:27:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:07 INFO - '_': '/tools/buildbot/bin/python'} 13:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:27:07 INFO - Cleaning up... 13:27:07 INFO - Return code: 0 13:27:07 INFO - Running post-action listener: _resource_record_post_action 13:27:07 INFO - Running post-action listener: _start_resource_monitoring 13:27:07 INFO - Starting resource monitoring. 13:27:07 INFO - [mozharness: 2016-08-22 20:27:07.931051Z] Finished create-virtualenv step (success) 13:27:07 INFO - [mozharness: 2016-08-22 20:27:07.931513Z] Running install step. 13:27:07 INFO - Running pre-action listener: _resource_record_pre_action 13:27:07 INFO - Running main action method: install 13:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:08 INFO - Reading from file tmpfile_stdout 13:27:08 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:08 INFO - Reading from file tmpfile_stdout 13:27:08 INFO - Output received: 13:27:08 INFO - Usage: mozinstall [options] installer 13:27:08 INFO - Options: 13:27:08 INFO - -h, --help show this help message and exit 13:27:08 INFO - -d DEST, --destination=DEST 13:27:08 INFO - Directory to install application into. [default: 13:27:08 INFO - "/builds/slave/test"] 13:27:08 INFO - --app=APP Application being installed. [default: firefox] 13:27:08 INFO - mkdir: /builds/slave/test/build/application 13:27:08 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'] 13:27:08 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 13:27:25 INFO - Reading from file tmpfile_stdout 13:27:25 INFO - Output received: 13:27:25 INFO - /builds/slave/test/build/application/firefox/firefox 13:27:25 INFO - Running post-action listener: _resource_record_post_action 13:27:25 INFO - [mozharness: 2016-08-22 20:27:25.244098Z] Finished install step (success) 13:27:25 INFO - [mozharness: 2016-08-22 20:27:25.244344Z] Running run-tests step. 13:27:25 INFO - Running pre-action listener: _resource_record_pre_action 13:27:25 INFO - Running main action method: run_tests 13:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:27:25 INFO - Python 2.7.3 13:27:25 INFO - Return code: 0 13:27:25 INFO - grabbing minidump binary from tooltool 13:27:25 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')]} 13:27:25 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 0x19f8370>, '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 0x19fb8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19fbd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:27:25 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 13:27:25 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 13:27:25 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 13:27:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:27:25 INFO - Return code: 0 13:27:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:27:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:27:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:27:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:27:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:27:25 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/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 13:27:25 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/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 13:27:25 INFO - Using env: {'DISPLAY': ':0', 13:27:25 INFO - 'HOME': '/home/cltbld', 13:27:25 INFO - 'LANG': 'en_US.UTF-8', 13:27:25 INFO - 'LANGUAGE': 'en_US:en', 13:27:25 INFO - 'LOGNAME': 'cltbld', 13:27:25 INFO - 'MAIL': '/var/mail/cltbld', 13:27:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:27:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:25 INFO - 'MOZ_NO_REMOTE': '1', 13:27:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:25 INFO - 'NO_EM_RESTART': '1', 13:27:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:25 INFO - 'PWD': '/builds/slave/test', 13:27:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:27:25 INFO - 'SHELL': '/bin/bash', 13:27:25 INFO - 'SHLVL': '1', 13:27:25 INFO - 'TERM': 'linux', 13:27:25 INFO - 'TMOUT': '86400', 13:27:25 INFO - 'USER': 'cltbld', 13:27:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409', 13:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:25 INFO - '_': '/tools/buildbot/bin/python'} 13:27:25 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/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 13:27:25 INFO - mozversion application_buildid: 20160822113002 13:27:25 INFO - mozversion application_changeset: 74f16e8aed180aaf153827a6e5eedfb818c0cb11 13:27:25 INFO - mozversion application_display_name: Nightly 13:27:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:27:25 INFO - mozversion application_name: Firefox 13:27:25 INFO - mozversion application_remotingname: firefox 13:27:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:27:25 INFO - mozversion application_vendor: Mozilla 13:27:25 INFO - mozversion application_version: 51.0a1 13:27:25 INFO - mozversion platform_buildid: 20160822113002 13:27:25 INFO - mozversion platform_changeset: 74f16e8aed180aaf153827a6e5eedfb818c0cb11 13:27:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:27:25 INFO - mozversion platform_version: 51.0a1 13:27:25 INFO - using testdate: 1471897645 13:27:25 INFO - actual date: 1471897645 13:27:25 INFO - starting webserver on 'localhost:38609' 13:27:25 INFO - SUITE-START | Running 2 tests 13:27:25 INFO - TEST-START | dromaeo_css 13:27:25 INFO - operating with platform_type : linux_ 13:27:25 INFO - Initialising browser for dromaeo_css test... 13:27:25 INFO - TEST-INFO | started process 29325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQIMC4/profile http://localhost:38609/getInfo.html) 13:27:29 INFO - PROCESS | 29325 | __metrics Screen width/height:1600/1200 13:27:29 INFO - PROCESS | 29325 | colorDepth:24 13:27:29 INFO - PROCESS | 29325 | Browser inner width/height: 1024/697 13:27:29 INFO - PROCESS | 29325 | __metrics 13:27:30 INFO - PROCESS | 29325 | 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" 13:27:30 INFO - PROCESS | 29325 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:27:30 INFO - PROCESS | 29325 | console.error: PushService: 13:27:30 INFO - PROCESS | 29325 | stateChangeProcessEnqueue: Error transitioning state 13:27:30 INFO - PROCESS | 29325 | UnknownError 13:27:31 INFO - TEST-INFO | 29325: exit 0 13:27:31 INFO - Browser initialized. 13:27:31 INFO - Running cycle 1/1 for dromaeo_css test... 13:27:31 INFO - TEST-INFO | started process 29410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQIMC4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:43 INFO - PROCESS | 29410 | RSS: Main: 176365568 13:27:43 INFO - PROCESS | 29410 | 13:28:35 INFO - PROCESS | 29410 | 1471897715158 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] 13:30:44 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:38609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38609/tests/dromaeo/cssquery-ext.html) 13:30:45 INFO - PROCESS | 29410 | RSS: Main: 283160576 13:30:45 INFO - PROCESS | 29410 | 13:33:47 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:38609/tests/dromaeo/cssquery-ext.html (next: http://localhost:38609/tests/dromaeo/cssquery-jquery.html) 13:33:48 INFO - PROCESS | 29410 | RSS: Main: 272424960 13:33:48 INFO - PROCESS | 29410 | 13:36:50 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:38609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38609/tests/dromaeo/cssquery-mootools.html) 13:36:51 INFO - PROCESS | 29410 | RSS: Main: 216776704 13:36:51 INFO - PROCESS | 29410 | 13:39:53 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:38609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38609/tests/dromaeo/cssquery-prototype.html) 13:39:54 INFO - PROCESS | 29410 | RSS: Main: 249479168 13:39:54 INFO - PROCESS | 29410 | 13:42:56 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:38609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38609/tests/dromaeo/cssquery-yui.html) 13:42:57 INFO - PROCESS | 29410 | RSS: Main: 216936448 13:42:57 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | Cycle 1(1): loaded http://localhost:38609/tests/dromaeo/cssquery-yui.html (next: http://localhost:38609/tests/dromaeo/cssquery-dojo.html) 13:46:00 INFO - PROCESS | 29410 | RSS: Main: 304099328 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | __start_tp_report 13:46:00 INFO - PROCESS | 29410 | _x_x_mozilla_page_load 13:46:00 INFO - PROCESS | 29410 | _x_x_mozilla_page_load_details 13:46:00 INFO - PROCESS | 29410 | |i|pagename|runs| 13:46:00 INFO - PROCESS | 29410 | |0;dojo.html;2959.8224106553607;2975.8363290019056;3017.766852529128;3020.199647093522;3032.2570970112324;5060.822871199509;5118.897622047557;5189.948100518998;5270.920936185956;5297.231901374304;5186.662866913657;5223.6343455958095;5245.423003469616;5261.184516399954;5298.841034768963;4751.572358487735;4807.78364973577;4856.344393506866;4913.091078150554;4932.926006109893;4912.189488734354;4929.4824043475455;4953.900921981558;4957.553820156185;4960.107180707471;4679.064187162581;4753.857384278443;4756.239001759702;4797.11253418117;4808.519148085198;4700.858974230779;4701.318308845232;4736.976315118402;4789.37738094049;4804.279358096279;4758.762061896891;4762.38089048425;4832.806687732486;4847.636427267969;4851.781669824866;5062.2406639004075;5284.260203571503;5291.894162116736;5301.257823904656;5301.3373328333955;5368.758405871706;5409.323834520685;5460.26286451328;5520.66875987442;5545.168224766277;5523.669658779298;5556.72216389183;5562.332520097574;5587.413321601254;5589.0219211637805;5078.5175408336145;5114.897702045938;5209.895802083975;5212.426633070321;5221.71280579568;5664.20701101846;5749.137629355547;5768.221290125864;5770.913436298459;5772.595918285764;5524.751386187631;5537.556995440355;5543.2793736814765;5544.944550554443;5547.2511210986;5363.517283444508;5455.645383050089;5599.300087489064;5602.439756024365;5610.298712660918;5475.288212532345;5583.944160558423;5584.720763961785;5585.385607583163;5590.413006634326;5592.748326325325;5606.24315717373;5606.831795046155;5608.298962629671;5609.102543593006;4247.193033323659;4301.65586753059;4378.014946636981;4380.408644832907;4389.868303950822;3825.8087095645105;3877.3020856245585;3908.3746600543777;3921.058945852975;3921.9215615687526;5380.3274590676165;5407.405185429599;5415.052365836042;5418.4039755626845;5422.267993820863;5486.259354987105;5505.944940550543;5544.140658197985;5670.291213598301;5715.799947001835;5271.841844744664;5285.603579731535;5295.393008082992;5299.894002119936;5309.283246761638;4821.180399332122;4829.975850120727;4833.96069844978;4837.2260438329695;4840.6127509799135;5553.916691249635;5667.574931880125;5715.599908006566;5751.511121554715;5756.5682573807135;5612.045952188057;5632.380438151882;5642.520385767256;5643.463870932255;5659.688717120598;5812.389699081705;5842.2405087338375;5847.06446968483;5849.093390524476;5858.560607954506;5348.5186333230195;5391.9460805391445;5443.863903402288;5572.331320241597;5574.665520068809;5630.915536266877;5651.57613179005;5651.8304450866535;5661.547076233974;5678.403767604342;5474.069408200695;5539.224508568723;5550.306211723535;5558.888822223452;5561.416051314553;5242.659227150223;5352.223927530564;5424.783008679608;5479.643823151482;5527.281453411031;5445.59158063139;5452.5365343946205;5457.7271136443815;5460.808871689472;5463.617546771847;5585.804496842591;5592.217089607377;5596.972015139898;5602.355729091207;5609.523190528851;5209.973950130377;5266.236395722675;5305.70818604965;5474.069408200695;5484.643498172606 13:46:00 INFO - PROCESS | 29410 | |1;ext.html;575.3297408519076;584.8362458511617;602.3195285154419;604.3231580629696;607.5625549604283;42837.78581107094;43682.781586092024;43809.34285985709;43877.78061109694;46637.703909972144;45034;45529.317060244124;45592.61703361532;45641.31538026924;45671;8879.289656827454;9043.276537876955;9051.321150913675;9070;9071.727848164566;8956.596953137092;9054.094590540926;9062.45625262483;9063.365564410495;9063.365564410495;9094.49980251086;9139.771505712344;9141.360104792668;9143.451392916413;9143.954280228623;9057.275417966579;9071.455712657262;9094.86357704635;9096.727098187064;9096.772580685536;8944.373893827435;9000.594973226154;9016.639334426614;9017.458952462874;9018.413803102778;42566.78716606397;42969.57030429687;42993.57006429927;43005.13989720219;43013.13973720539;3116.3144108296137;3215.871365145415;3271.6401195868434;3404.0128362774767;3575.5173051637958;32848.83575582107;33476.6652333476;33488.83255583731;33658.66341336604;34570.135746606284;3896.7661940283674;4102.3026085565525;4127.8968025799295;4138.689598280141;4295.78521073945;331204;335410;336473;336788;339355.3032234848;59163;59531.70234148888;59633.40366596278;59644.40355596475;59739;36335;36936.261274774355;36980;38865;63252.683736581945;14533.636659083608;14814.703705925822;14824.3329050193;14831.184284864436;14832.25838708082;11267.436628168558;11324.263922844988;11326.886731132749;11337.433128343715;11340.886591134147;19001.14494847735;19005;19016.61966760657;19019.33432329862;19200.327988520614;7013.228544860061;7029.472789540805;7073.893891591631;7281.308275713799;7319.451041171933;941.8493041113389;1016.2733645443543;1032.8812186598486;1042.280826229899;1114.2812885688686;32051;32562.837185814395;32564.511532327033;32809;33219.833900830345;1075.5912753153907;1093.8632670916136;1102.9172812039128;1107.1917500224881;1170.795110855597;16611.41860034893;17185.484435466955;17228.569285767957;17259.3959211427;17511.824881751276;549220;551068;553330;555412;555540;58887.41112588819;59568.70215648981;59571.40428595659;59669.701651491465;59691.70154149202;1202.4168278384977;1204.2593804810153;1302.5636411801963;1304.6347022833622;1348.3190988550718;31217.375652487277;33462.49806252957;33744.831275844444;33950.320993580484;34269;45143;45570.772146139054;45626;45643.77178114088;45646.54353456423;397355;397486;398897;399235;399523;25580.10469633554;27808.384909961576;28632.57051144193;28652.99714509982;29266;39815.60184398119;40058;40357.39463907985;40420;41143.7942810284;40177.59822401738;40615;41085.58914410818;42565.36151957785;42595;39886.202275953736;41208.49727773173;41395.793021034704;41569.58430415778;42233.788831055645;41329.1734165321;41478.1704365917;41812.58187418087;42168.578314216466;42301.153976920905;34819.65180348265;36501.45247821232;36695.63304366922;36728.63271367252;37529.249415011;27685;27979.580306295014;28089.57865631976;28240.29399265035;28510.857445712638 13:46:00 INFO - PROCESS | 29410 | |2;jquery.html;389.3750530398708;393.2135728542912;396.13642259873484;402.97380670256433;418.2137581347069;13094.66705294003;18283.26866925323;19927.202911883527;20039;20732.689009664828;15244.923775381136;15827.683446331095;16046.679066418665;16315.184240787943;16613.252403641836;5725.427457254283;5932.228810254661;5932.614380065282;5933.376995415484;5934.198883150784;5688.317401911776;5807;5886.587938844283;5888;5890.823275301726;5831.183634291203;5871.119332100197;5875.618084824494;5878.235829342201;5880.8235752927485;5578.581606379537;5794.420557944214;5872.060470324749;5875.764969401219;5878.5297176225795;5218.66078704883;5218.921716174261;5219.556337711299;5224.320838291036;5227.059129356714;23757.524849503086;23923.64114538266;24082.397940051465;24566.263012109488;25025;2408.927732168038;2417.1177520205174;2424.1394305021818;2464.642626819119;3014.3669829335868;14253;15080.849191508163;15346.923265383602;15418;15557.29992150356;1908.6659834528903;1952.4142757172933;1971.0932970833435;2007.2372498450495;2045.5704302096578;79210.60394698047;79938.99999999942;81306.59346703287;83210.58394708048;83564.58217708873;10222.897771022195;10303.896961030443;10403.791924161475;10433.478326083665;10870.021698047214;14575.635609109857;14579.854201457849;14581.85418145805;14594.854051459562;14596.12423254608;7372.447066470037;7470.4770666052855;7489.513181643176;7766.922330776733;7787.961060194776;7083.610401427971;7119.71521139159;7311.707531698672;7336.926630733625;7337.3029562191505;5864.912026319608;6406.167198264196;6661.000849872461;6765.458763298924;6970.860582788316;1911.8852868827637;1916.33279047227;1928;1928.4503916383762;1972.5265936175215;968.7820240445984;998.4907697074544;1012.0941757127476;1016.6695823857276;1036.108946306176;20412.897935510526;22091.558168836535;22272;22334.55330893373;22417;995.5022488755623;1022.672744721682;1026.861373714539;1057.5558265528496;1078.4607696151925;10824.051670699193;11955.64133076009;12036.157468977262;12130.696732581757;12171.687379397887;445908;453085;455473;469939;472876;95608;96840;98225;98246;100901;950.3062764182185;981.788915383196;999.7950420163849;1000.5797565022708;1019.1490105761771;18153;18247.178876950835;19065.14206860667;19271;19280.517987050436;34229.144271393416;39869.60130398659;43805;44059.03468687834;44122;59953.700231498566;59957.40042599693;61406.69296653488;62197.689011554656;62531.37468625256;8435.45169564001;8845.778855528662;9015.233705135137;9022.684206052756;9156.130167634064;9377.202937750368;13945.651358716113;14084.647883802578;14765.704685906436;14918.477853275082;12345.814812777995;12436.937815310866;12617.278204944374;12649.557265496032;13080.542181023618;12164.452599633214;12211.145219834882;12260.570880019513;12392.81410778821;12823.93588032054;12475.625731228078;12652.746945061232;12725.236485810881;12762.936185319015;12873.742525149632;8584.91415085841;8691.956540217512;8790.164934331227;8830.249428798625;9194.12655797698;12165.330906799856;12290.508379664714;12369.319687417279;12462.626121216377;12714.012207131502 13:46:00 INFO - PROCESS | 29410 | |3;mootools.html;1330.3082397153487;1462.1957923142272;1488.5087920986075;1584.1683116363909;1747.9300827966874;8238.835223295539;8663.74008779736;8689.73930782076;8958.372913896013;8968;8385.0357208921;8556.058833528306;8565.314774818014;8571.571421428935;8574.442661227016;2370.2415227127326;2397.9160729374476;2399.7120345558556;2400.5918993771015;2402.4474370894704;2289.599320118981;2345.1323010486144;2358.9764102359013;2362.917297894574;2367.242482405631;2302.4013756423283;2310.3992961829963;2310.526342099874;2370.7273663528745;2375.192434572245;2292.873891935943;2310.861348319106;2320.385097949045;2321.1759825262043;2348.4011577047745;2238.2837492002564;2248.87631180285;2251.662250662414;2255.4474153832252;2262;8148.633311500997;8618.956905215433;8817.250533704642;8820.073892241286;8821.07378725231;4921.286413470062;5111.616628752821;5114.181730923035;5120.539151476385;5121.129408000649;3357.1607098225445;3368.781029233092;3414.4195486767308;3423.2811109667;3428.8285585720864;1177.5878442545127;1179.3631439022918;1193.146899966528;1203.145766505782;1210.751795881851;11784.764304713943;11828.763424731544;11850.644480665595;11881.158420444845;11927.105467090003;4205.936910946339;4335.82656693735;4442.755648439303;4467.173572889026;4492.3710680504755;9320.95339523298;9358.11097945694;9361.485118318558;9362.016988216275;9371.437713737198;4909.877253068702;4912.312276281324;4927.088488629615;4948.727819969936;4950.777215025332;4090.1206240658403;4463.464384273908;4539.523350048264;4585.81656733727;4618.076384723069;3554.5734511858227;3635.636436356396;3664.340418724655;3685.4840322354894;3746.793926334023;1089.8310761831929;1108.6175269531998;1110.5335758981248;1127.2391135983178;1128.4357821089454;842.8946381702287;910.1717437132311;949.6296444386695;983.8770153730641;986.2208855004609;5475.616706830563;5486.753096110685;5836.066229403275;5841.7371218295275;5861.062230043172;436.975966321849;438.9793729578742;440.61226121013306;443.50992153670376;446.4174252600388;3927.155661532784;4207.495100587949;4216.2832318505925;4303.419038429772;4365.515724653633;10866.348019118721;10942.890571094187;11027.669169924915;11042.558297668164;11056.281341712764;10547.630832920811;10877.564897404174;10896.727581810359;10980.780384392267;10995.505202265917;7884.684612615546;8267.545285009382;8308.21071998147;8310.8337833243;8333.8333233335;6036.517078633787;6078.696065196811;6088.756449741961;6168.753249869955;6267.561270711007;9618.663346782829;9929;10091.293609447268;10132.240081993732;10197.898021019992;10051.648192313234;10194.082532572103;10251.128654064489;10320.329178603366;10327.173826093744;7136.7145314186855;7753.961230193813;7923.088844782924;7989.2010798921965;8220.83558328842;7990.600469976362;8383.077861435358;8388.119247478928;8391.496510209407;8398.328133749163;7280.708771649075;7429.5542267464125;7467.962660186664;7483.102027756704;7537.321641052332;7154.105736782903;7287.562746235243;7328.523645962995;7362.77911662651;7528.585927774025;6690.732370705117;6864.21061577925;6864.931350686629;6865.622390768555;6867.965660171667;4970.204767237225;5107.387113546398;5185.585153187812;5235.581153507634;5241.030409374278;5171.405288391883;5196.870078247923;5231.253591864302;5252.9737351313;5277.947220527899 13:46:00 INFO - PROCESS | 29410 | |4;prototype.html;320.1899195036557;326.4906745477056;336.40792205717935;338.6630302848665;344.43512639271614;4986.875328116799;5076.619253555979;5161.922571161431;5230.110881150209;5236.31927849379;5079.1365467870455;5088.847334579968;5174.172132458807;5185.299984502091;5185.403678576965;4136.73111247768;4159.355299928501;4159.708820382574;4168;4181.435506206662;3981.4625025621604;4117.608827161415;4153.210889930919;4161.521425036114;4180.324592260956;4119.464469618961;4128.442660240874;4133.627973482386;4137.234611596849;4145.606167414091;4098.918021639581;4107.075907920739;4120.979395103021;4121.62905338521;4147.149834283965;3717.1078941054225;3722;3735.1782607826235;3735.682466990309;3735.962640373589;4928.207226174702;5009.599232061463;5021.372328458942;5038.722870242135;5056.519630635084;4661;4667.929981050287;4684.531546845323;4724.71651700899;4728.66899317048;5334.199870019489;5337.973310133424;5341.572674186055;5348.705821179834;5353.732313384316;3810.1427178884805;3943.4084887266854;3956.9802150989062;3957.485526881516;3959.722819402643;5521.923224971132;5528.198411230389;5542;5557.138643510262;5558.6942718150485;4069.4709687740997;4082.632563069338;4087.896268007621;4136.6483848872585;4160.750354978711;4082.9591704082577;4114.958850411457;4140.660526802347;4145.958540414557;4198.916021679611;4605.194091034055;4618.930716039262;4636.724900652348;4649.95350046502;4650.488446270908;5362;5386.5152136307925;5395.514403703607;5431.592630552725;5443.401225865152;1378.427952399743;1390.8261467316586;1424.3946322812762;1440.7838824176458;1444.2129039673403;985.2315194148575;990.3166814897697;1020.2093377632394;1020.4234607446768;1021.7088129883097;5140.717260550706;5154.690718556899;5168.9741551292;5179.507946745053;5187.092258854761;5425.403205647375;5446.373667028342;5451.890962180813;5463.945360546423;5471.50756431915;4977.477364876709;5140.280360749498;5150.381954165449;5155.401825434127;5236.92144617831;2916.1105862712075;2924.7715959297147;2930.750886174699;2936.6329208848892;2939.8383088930314;5697.601167918206;5706.457886500859;5716.657000579979;5719.19931209631;5733.598648094677;5538.47384498472;5566.860828479321;5603.159526071122;5631.929933312657;5653.773849046074;5674.240985294572;5681.687507187062;5718.199452076629;5737.3975732548315;5760.337561180434;5313.442088580643;5422.511973922208;5462.91805622908;5552.973164794902;5581.5255703265675;5397.163439666858;5444.50999410055;5449.400565937823;5460.7542660579575;5476.397596264328;5683.2895888014;5702.6863522506665;5703.62926409782;5760.913586296293;5789.56578256624;3887.436321733276;3948.5459172194414;3960.4851369321805;3961.2869683457257;3962.405639154035;5265.3944796348915;5376.220448035091;5485.725713714219;5488.17677348401;5511.311086114236;5374.7312634367345;5380.192971054216;5422.891542169214;5451.809186678447;5473.233747275305;5439.5648348132845;5444.455554444682;5448.83653490396;5462.180672899097;5491.423400542885;5149.56228720548;5326.201069839555;5345.679259244458;5365.22204280385;5366.838994830161;5334.1732031535175;5449.918251226314;5453.672779633234;5457.399686034453;5461.754221059982;5165.210786175573;5302.1781623848365;5306.628536002443;5361.705106219196;5369.892602148013 13:46:00 INFO - PROCESS | 29410 | |5;yui.html;654.9148610680611;699.6991293743691;712.5688958180302;736.2269616902252;738.3354980517533;13784.310784460775;14905.105693658388;14974.101553906774;14976.850231497681;15016.324265408055;13581.117227380213;13713.931430342835;13714.58856234312;13728.45086196551;14398.784018239709;659.8812213801514;779.4972242903324;799.760071978407;801.6312496251702;802.0976401548259;784.4822417204646;809.9392545559107;809.9635516401746;813.7436707437168;814.5845618734459;822.7038266224155;829.6432534010373;829.7593697827623;830.887830142932;831.1024093978519;686.7939618114546;826.7809030606894;830.1034882327102;830.2818062376061;830.4519017448486;594.5065595555678;605.0863196573163;606.4148097086289;606.5420607441354;608.4189598933052;13531.661708457268;13554.59336219915;14081.929590352085;14093.2953352333;14100.506482273071;13348.532801351907;13755.656108597264;14024.789628155586;14077.225752583603;14316.21260830654;11444.198906076577;12297.631071067883;12584.056195785353;12811.87188128116;13558.93220533891;4470.575295346936;4519.231730605805;4554.931676024862;4717.952820471785;4784.425868895755;66855.66572167157;68453;69661.30338696598;79789.20210797933;80131;10809.297395669257;11081.944590276997;11083.833742493869;11337.26307789991;11489.712757181138;21454.463638409165;21755.564888702138;21766.89116554407;21768.78231217699;21779.564408711736;8704.42928459196;8831.867521987175;8872.911270887338;8956.462612243286;9301.209397201314;4742.407199100113;4829.227323628273;4836.274558816135;4856.708597484162;5173.068847607392;3532.717382609385;3628.401313783249;3633.8728144514816;3634.436662317345;3646.9452958205648;608.6682757896868;612.6569121292091;612.8437248501604;620.460199626319;628.2398298059308;604.3291945940003;724.4457989637931;768.8846672999094;783.8001309665999;785.0073532334349;9130.954345228363;9496.192823609932;9690.512430238536;9709.563069661883;10010.599576017023;565.4515120333352;660.6564586415134;675.7330854312519;683.2040672616346;731.8499707560044;4738.123447162286;4881.585065269421;4905.3623029006;4951.282064100757;4986.650934434555;123220.38389807993;123310;123698.38150809189;126426.36786816007;127180;105353;108770.45614771875;108937;111412;111684;93864.53067734755;96739;98720.50639746756;98867.50566247123;101586;8999.37004409685;9094.363394562317;9312.860307095534;9320.580573874056;9338.112879276458;38883.41674874823;42201.78899105485;51678.22482662688;52773;53728;73138;77466.6126669363;83314;83384;86630;11497.252678575866;12391;13025.934870325587;13035.674108147372;13441.596752097452;14207.64480887986;14265.57203283903;14303.642408939444;15289.923550382176;15492.612684682974;12492.937535312265;12623.242605443702;12775.105742597929;12959.481620735442;13367.331633418096;12939.482420703067;13342.733145337234;13538.932305338803;13780.173189608655;13854.376553054935;13805.17168969865;13879.375428105961;14011;14121.717565648834;14146.575602731935;10730.624428144978;10988.725281867697;11150.442477876237;11188.1608879336;11535.538578456768;11241.156913231704;11462.541498339973;11623.941880290544;11729.178957472895;11777.882221177679 13:46:00 INFO - PROCESS | 29410 | __end_tp_report 13:46:00 INFO - PROCESS | 29410 | __start_cc_report 13:46:00 INFO - PROCESS | 29410 | _x_x_mozilla_cycle_collect,977 13:46:00 INFO - PROCESS | 29410 | __end_cc_report 13:46:00 INFO - PROCESS | 29410 | __startTimestamp1471898760823__endTimestamp 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | ------- Summary: start ------- 13:46:00 INFO - PROCESS | 29410 | Number of tests: 6 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | [#0] dojo.html Cycles:165 Average:5210.46 Median:5415.05 stddev:579.24 (10.7%) stddev-sans-first:553.46 13:46:00 INFO - PROCESS | 29410 | Values: 2959.8 2975.8 3017.8 3020.2 3032.3 5060.8 5118.9 5189.9 5270.9 5297.2 5186.7 5223.6 5245.4 5261.2 5298.8 4751.6 4807.8 4856.3 4913.1 4932.9 4912.2 4929.5 4953.9 4957.6 4960.1 4679.1 4753.9 4756.2 4797.1 4808.5 4700.9 4701.3 4737.0 4789.4 4804.3 4758.8 4762.4 4832.8 4847.6 4851.8 5062.2 5284.3 5291.9 5301.3 5301.3 5368.8 5409.3 5460.3 5520.7 5545.2 5523.7 5556.7 5562.3 5587.4 5589.0 5078.5 5114.9 5209.9 5212.4 5221.7 5664.2 5749.1 5768.2 5770.9 5772.6 5524.8 5537.6 5543.3 5544.9 5547.3 5363.5 5455.6 5599.3 5602.4 5610.3 5475.3 5583.9 5584.7 5585.4 5590.4 5592.7 5606.2 5606.8 5608.3 5609.1 4247.2 4301.7 4378.0 4380.4 4389.9 3825.8 3877.3 3908.4 3921.1 3921.9 5380.3 5407.4 5415.1 5418.4 5422.3 5486.3 5505.9 5544.1 5670.3 5715.8 5271.8 5285.6 5295.4 5299.9 5309.3 4821.2 4830.0 4834.0 4837.2 4840.6 5553.9 5667.6 5715.6 5751.5 5756.6 5612.0 5632.4 5642.5 5643.5 5659.7 5812.4 5842.2 5847.1 5849.1 5858.6 5348.5 5391.9 5443.9 5572.3 5574.7 5630.9 5651.6 5651.8 5661.5 5678.4 5474.1 5539.2 5550.3 5558.9 5561.4 5242.7 5352.2 5424.8 5479.6 5527.3 5445.6 5452.5 5457.7 5460.8 5463.6 5585.8 5592.2 5597.0 5602.4 5609.5 5210.0 5266.2 5305.7 5474.1 5484.6 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | [#1] ext.html Cycles:180 Average:58610.28 Median:22358.65 stddev:116404.86 (520.6%) stddev-sans-first:116649.85 13:46:00 INFO - PROCESS | 29410 | Values: 575.3 584.8 602.3 604.3 607.6 42837.8 43682.8 43809.3 43877.8 46637.7 45034.0 45529.3 45592.6 45641.3 45671.0 8879.3 9043.3 9051.3 9070.0 9071.7 8956.6 9054.1 9062.5 9063.4 9063.4 9094.5 9139.8 9141.4 9143.5 9144.0 9057.3 9071.5 9094.9 9096.7 9096.8 8944.4 9000.6 9016.6 9017.5 9018.4 42566.8 42969.6 42993.6 43005.1 43013.1 3116.3 3215.9 3271.6 3404.0 3575.5 32848.8 33476.7 33488.8 33658.7 34570.1 3896.8 4102.3 4127.9 4138.7 4295.8 331204.0 335410.0 336473.0 336788.0 339355.3 59163.0 59531.7 59633.4 59644.4 59739.0 36335.0 36936.3 36980.0 38865.0 63252.7 14533.6 14814.7 14824.3 14831.2 14832.3 11267.4 11324.3 11326.9 11337.4 11340.9 19001.1 19005.0 19016.6 19019.3 19200.3 7013.2 7029.5 7073.9 7281.3 7319.5 941.8 1016.3 1032.9 1042.3 1114.3 32051.0 32562.8 32564.5 32809.0 33219.8 1075.6 1093.9 1102.9 1107.2 1170.8 16611.4 17185.5 17228.6 17259.4 17511.8 549220.0 551068.0 553330.0 555412.0 555540.0 58887.4 59568.7 59571.4 59669.7 59691.7 1202.4 1204.3 1302.6 1304.6 1348.3 31217.4 33462.5 33744.8 33950.3 34269.0 45143.0 45570.8 45626.0 45643.8 45646.5 397355.0 397486.0 398897.0 399235.0 399523.0 25580.1 27808.4 28632.6 28653.0 29266.0 39815.6 40058.0 40357.4 40420.0 41143.8 40177.6 40615.0 41085.6 42565.4 42595.0 39886.2 41208.5 41395.8 41569.6 42233.8 41329.2 41478.2 41812.6 42168.6 42301.2 34819.7 36501.5 36695.6 36728.6 37529.2 27685.0 27979.6 28089.6 28240.3 28510.9 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | [#2] jquery.html Cycles:180 Average:28715.57 Median:13515.45 stddev:76084.34 (562.9%) stddev-sans-first:76268.05 13:46:00 INFO - PROCESS | 29410 | Values: 389.4 393.2 396.1 403.0 418.2 13094.7 18283.3 19927.2 20039.0 20732.7 15244.9 15827.7 16046.7 16315.2 16613.3 5725.4 5932.2 5932.6 5933.4 5934.2 5688.3 5807.0 5886.6 5888.0 5890.8 5831.2 5871.1 5875.6 5878.2 5880.8 5578.6 5794.4 5872.1 5875.8 5878.5 5218.7 5218.9 5219.6 5224.3 5227.1 23757.5 23923.6 24082.4 24566.3 25025.0 2408.9 2417.1 2424.1 2464.6 3014.4 14253.0 15080.8 15346.9 15418.0 15557.3 1908.7 1952.4 1971.1 2007.2 2045.6 79210.6 79939.0 81306.6 83210.6 83564.6 10222.9 10303.9 10403.8 10433.5 10870.0 14575.6 14579.9 14581.9 14594.9 14596.1 7372.4 7470.5 7489.5 7766.9 7788.0 7083.6 7119.7 7311.7 7336.9 7337.3 5864.9 6406.2 6661.0 6765.5 6970.9 1911.9 1916.3 1928.0 1928.5 1972.5 968.8 998.5 1012.1 1016.7 1036.1 20412.9 22091.6 22272.0 22334.6 22417.0 995.5 1022.7 1026.9 1057.6 1078.5 10824.1 11955.6 12036.2 12130.7 12171.7 445908.0 453085.0 455473.0 469939.0 472876.0 95608.0 96840.0 98225.0 98246.0 100901.0 950.3 981.8 999.8 1000.6 1019.1 18153.0 18247.2 19065.1 19271.0 19280.5 34229.1 39869.6 43805.0 44059.0 44122.0 59953.7 59957.4 61406.7 62197.7 62531.4 8435.5 8845.8 9015.2 9022.7 9156.1 9377.2 13945.7 14084.6 14765.7 14918.5 12345.8 12436.9 12617.3 12649.6 13080.5 12164.5 12211.1 12260.6 12392.8 12823.9 12475.6 12652.7 12725.2 12762.9 12873.7 8584.9 8692.0 8790.2 8830.2 9194.1 12165.3 12290.5 12369.3 12462.6 12714.0 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | [#3] mootools.html Cycles:180 Average:5673.94 Median:4562.67 stddev:3250.64 (71.2%) stddev-sans-first:3243.37 13:46:00 INFO - PROCESS | 29410 | Values: 1330.3 1462.2 1488.5 1584.2 1747.9 8238.8 8663.7 8689.7 8958.4 8968.0 8385.0 8556.1 8565.3 8571.6 8574.4 2370.2 2397.9 2399.7 2400.6 2402.4 2289.6 2345.1 2359.0 2362.9 2367.2 2302.4 2310.4 2310.5 2370.7 2375.2 2292.9 2310.9 2320.4 2321.2 2348.4 2238.3 2248.9 2251.7 2255.4 2262.0 8148.6 8619.0 8817.3 8820.1 8821.1 4921.3 5111.6 5114.2 5120.5 5121.1 3357.2 3368.8 3414.4 3423.3 3428.8 1177.6 1179.4 1193.1 1203.1 1210.8 11784.8 11828.8 11850.6 11881.2 11927.1 4205.9 4335.8 4442.8 4467.2 4492.4 9321.0 9358.1 9361.5 9362.0 9371.4 4909.9 4912.3 4927.1 4948.7 4950.8 4090.1 4463.5 4539.5 4585.8 4618.1 3554.6 3635.6 3664.3 3685.5 3746.8 1089.8 1108.6 1110.5 1127.2 1128.4 842.9 910.2 949.6 983.9 986.2 5475.6 5486.8 5836.1 5841.7 5861.1 437.0 439.0 440.6 443.5 446.4 3927.2 4207.5 4216.3 4303.4 4365.5 10866.3 10942.9 11027.7 11042.6 11056.3 10547.6 10877.6 10896.7 10980.8 10995.5 7884.7 8267.5 8308.2 8310.8 8333.8 6036.5 6078.7 6088.8 6168.8 6267.6 9618.7 9929.0 10091.3 10132.2 10197.9 10051.6 10194.1 10251.1 10320.3 10327.2 7136.7 7754.0 7923.1 7989.2 8220.8 7990.6 8383.1 8388.1 8391.5 8398.3 7280.7 7429.6 7468.0 7483.1 7537.3 7154.1 7287.6 7328.5 7362.8 7528.6 6690.7 6864.2 6864.9 6865.6 6868.0 4970.2 5107.4 5185.6 5235.6 5241.0 5171.4 5196.9 5231.3 5253.0 5277.9 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | [#4] prototype.html Cycles:180 Average:4575.89 Median:5167.09 stddev:1307.97 (25.3%) stddev-sans-first:1272.03 13:46:00 INFO - PROCESS | 29410 | Values: 320.2 326.5 336.4 338.7 344.4 4986.9 5076.6 5161.9 5230.1 5236.3 5079.1 5088.8 5174.2 5185.3 5185.4 4136.7 4159.4 4159.7 4168.0 4181.4 3981.5 4117.6 4153.2 4161.5 4180.3 4119.5 4128.4 4133.6 4137.2 4145.6 4098.9 4107.1 4121.0 4121.6 4147.1 3717.1 3722.0 3735.2 3735.7 3736.0 4928.2 5009.6 5021.4 5038.7 5056.5 4661.0 4667.9 4684.5 4724.7 4728.7 5334.2 5338.0 5341.6 5348.7 5353.7 3810.1 3943.4 3957.0 3957.5 3959.7 5521.9 5528.2 5542.0 5557.1 5558.7 4069.5 4082.6 4087.9 4136.6 4160.8 4083.0 4115.0 4140.7 4146.0 4198.9 4605.2 4618.9 4636.7 4650.0 4650.5 5362.0 5386.5 5395.5 5431.6 5443.4 1378.4 1390.8 1424.4 1440.8 1444.2 985.2 990.3 1020.2 1020.4 1021.7 5140.7 5154.7 5169.0 5179.5 5187.1 5425.4 5446.4 5451.9 5463.9 5471.5 4977.5 5140.3 5150.4 5155.4 5236.9 2916.1 2924.8 2930.8 2936.6 2939.8 5697.6 5706.5 5716.7 5719.2 5733.6 5538.5 5566.9 5603.2 5631.9 5653.8 5674.2 5681.7 5718.2 5737.4 5760.3 5313.4 5422.5 5462.9 5553.0 5581.5 5397.2 5444.5 5449.4 5460.8 5476.4 5683.3 5702.7 5703.6 5760.9 5789.6 3887.4 3948.5 3960.5 3961.3 3962.4 5265.4 5376.2 5485.7 5488.2 5511.3 5374.7 5380.2 5422.9 5451.8 5473.2 5439.6 5444.5 5448.8 5462.2 5491.4 5149.6 5326.2 5345.7 5365.2 5366.8 5334.2 5449.9 5453.7 5457.4 5461.8 5165.2 5302.2 5306.6 5361.7 5369.9 13:46:00 INFO - PROCESS | 29410 | 13:46:00 INFO - PROCESS | 29410 | [#5] yui.html Cycles:180 Average:21611.23 Median:4537.08 stddev:32408.47 (714.3%) stddev-sans-first:32461.18 13:46:00 INFO - PROCESS | 29410 | Values: 654.9 699.7 712.6 736.2 738.3 13784.3 14905.1 14974.1 14976.9 15016.3 13581.1 13713.9 13714.6 13728.5 14398.8 659.9 779.5 799.8 801.6 802.1 784.5 809.9 810.0 813.7 814.6 822.7 829.6 829.8 830.9 831.1 686.8 826.8 830.1 830.3 830.5 594.5 605.1 606.4 606.5 608.4 13531.7 13554.6 14081.9 14093.3 14100.5 13348.5 13755.7 14024.8 14077.2 14316.2 11444.2 12297.6 12584.1 12811.9 13558.9 4470.6 4519.2 4554.9 4718.0 4784.4 66855.7 68453.0 69661.3 79789.2 80131.0 10809.3 11081.9 11083.8 11337.3 11489.7 21454.5 21755.6 21766.9 21768.8 21779.6 8704.4 8831.9 8872.9 8956.5 9301.2 4742.4 4829.2 4836.3 4856.7 5173.1 3532.7 3628.4 3633.9 3634.4 3646.9 608.7 612.7 612.8 620.5 628.2 604.3 724.4 768.9 783.8 785.0 9131.0 9496.2 9690.5 9709.6 10010.6 565.5 660.7 675.7 683.2 731.8 4738.1 4881.6 4905.4 4951.3 4986.7 123220.4 123310.0 123698.4 126426.4 127180.0 105353.0 108770.5 108937.0 111412.0 111684.0 93864.5 96739.0 98720.5 98867.5 101586.0 8999.4 9094.4 9312.9 9320.6 9338.1 38883.4 42201.8 51678.2 52773.0 53728.0 73138.0 77466.6 83314.0 83384.0 86630.0 11497.3 12391.0 13025.9 13035.7 13441.6 14207.6 14265.6 14303.6 15289.9 15492.6 12492.9 12623.2 12775.1 12959.5 13367.3 12939.5 13342.7 13538.9 13780.2 13854.4 13805.2 13879.4 14011.0 14121.7 14146.6 10730.6 10988.7 11150.4 11188.2 11535.5 11241.2 11462.5 11623.9 11729.2 11777.9 13:46:00 INFO - PROCESS | 29410 | -------- Summary: end -------- 13:46:00 INFO - PROCESS | 29410 | 13:46:01 INFO - TEST-INFO | 29410: exit 0 13:46:01 INFO - TEST-OK | dromaeo_css | took 1116261ms 13:46:01 INFO - TEST-START | kraken 13:46:01 INFO - operating with platform_type : linux_ 13:46:01 INFO - Initialising browser for kraken test... 13:46:01 INFO - TEST-INFO | started process 29714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFbd5n/profile http://localhost:38609/getInfo.html) 13:46:05 INFO - PROCESS | 29714 | __metrics Screen width/height:1600/1200 13:46:05 INFO - PROCESS | 29714 | colorDepth:24 13:46:05 INFO - PROCESS | 29714 | Browser inner width/height: 1024/697 13:46:05 INFO - PROCESS | 29714 | __metrics 13:46:06 INFO - PROCESS | 29714 | 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" 13:46:06 INFO - PROCESS | 29714 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:07 INFO - TEST-INFO | 29714: exit 0 13:46:07 INFO - Browser initialized. 13:46:07 INFO - Running cycle 1/1 for kraken test... 13:46:07 INFO - TEST-INFO | started process 29796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFbd5n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:19 INFO - PROCESS | 29796 | RSS: Main: 176238592 13:46:19 INFO - PROCESS | 29796 | 13:46:21 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38609/tests/kraken/driver.html?testName=audio-beat-detection) 13:46:22 INFO - PROCESS | 29796 | RSS: Main: 243183616 13:46:22 INFO - PROCESS | 29796 | 13:46:25 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38609/tests/kraken/driver.html?testName=audio-dft) 13:46:26 INFO - PROCESS | 29796 | RSS: Main: 225857536 13:46:26 INFO - PROCESS | 29796 | 13:46:29 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38609/tests/kraken/driver.html?testName=audio-fft) 13:46:29 INFO - PROCESS | 29796 | RSS: Main: 303112192 13:46:29 INFO - PROCESS | 29796 | 13:46:32 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38609/tests/kraken/driver.html?testName=audio-oscillator) 13:46:32 INFO - PROCESS | 29796 | RSS: Main: 209584128 13:46:32 INFO - PROCESS | 29796 | 13:46:34 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:46:35 INFO - PROCESS | 29796 | RSS: Main: 212942848 13:46:35 INFO - PROCESS | 29796 | 13:46:38 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38609/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:39 INFO - PROCESS | 29796 | RSS: Main: 250294272 13:46:39 INFO - PROCESS | 29796 | 13:46:42 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38609/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:43 INFO - PROCESS | 29796 | RSS: Main: 243478528 13:46:43 INFO - PROCESS | 29796 | 13:46:45 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38609/tests/kraken/driver.html?testName=json-parse-financial) 13:46:46 INFO - PROCESS | 29796 | RSS: Main: 246693888 13:46:46 INFO - PROCESS | 29796 | 13:46:48 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:48 INFO - PROCESS | 29796 | RSS: Main: 210522112 13:46:48 INFO - PROCESS | 29796 | 13:46:50 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:51 INFO - PROCESS | 29796 | RSS: Main: 217632768 13:46:51 INFO - PROCESS | 29796 | 13:46:53 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:53 INFO - PROCESS | 29796 | RSS: Main: 222998528 13:46:53 INFO - PROCESS | 29796 | 13:46:56 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:57 INFO - PROCESS | 29796 | RSS: Main: 217485312 13:46:57 INFO - PROCESS | 29796 | 13:47:00 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:00 INFO - PROCESS | 29796 | RSS: Main: 221491200 13:47:00 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | Cycle 1(1): loaded http://localhost:38609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38609/tests/kraken/driver.html?testName=ai-astar) 13:47:02 INFO - PROCESS | 29796 | RSS: Main: 271806464 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | __start_tp_report 13:47:02 INFO - PROCESS | 29796 | _x_x_mozilla_page_load 13:47:02 INFO - PROCESS | 29796 | _x_x_mozilla_page_load_details 13:47:02 INFO - PROCESS | 29796 | |i|pagename|runs| 13:47:02 INFO - PROCESS | 29796 | |0;ai-astar;99;112;108;117;116;109;117;111;111;111 13:47:02 INFO - PROCESS | 29796 | |1;audio-beat-detection;150;123;145;191;120;147;146;121;177;122 13:47:02 INFO - PROCESS | 29796 | |2;audio-dft;162;162;160;161;162;163;161;161;161;161 13:47:02 INFO - PROCESS | 29796 | |3;audio-fft;76;75;76;179;77;79;84;78;162;76 13:47:02 INFO - PROCESS | 29796 | |4;audio-oscillator;85;85;148;85;86;86;145;87;86;142 13:47:02 INFO - PROCESS | 29796 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;116;117;116 13:47:02 INFO - PROCESS | 29796 | |6;imaging-darkroom;145;146;146;146;145;145;147;146;146;146 13:47:02 INFO - PROCESS | 29796 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 13:47:02 INFO - PROCESS | 29796 | |8;json-parse-financial;56;50;50;52;53;51;50;50;51;51 13:47:02 INFO - PROCESS | 29796 | |9;json-stringify-tinderbox;61;62;63;63;63;63;62;63;62;62 13:47:02 INFO - PROCESS | 29796 | |10;stanford-crypto-aes;84;80;80;78;83;79;79;78;78;77 13:47:02 INFO - PROCESS | 29796 | |11;stanford-crypto-ccm;132;123;140;123;123;125;131;132;146;128 13:47:02 INFO - PROCESS | 29796 | |12;stanford-crypto-pbkdf2;168;166;167;164;163;164;164;161;164;163 13:47:02 INFO - PROCESS | 29796 | |13;stanford-crypto-sha256-iterative;65;65;66;65;65;66;68;66;64;73 13:47:02 INFO - PROCESS | 29796 | __end_tp_report 13:47:02 INFO - PROCESS | 29796 | __start_cc_report 13:47:02 INFO - PROCESS | 29796 | _x_x_mozilla_cycle_collect,1747 13:47:02 INFO - PROCESS | 29796 | __end_cc_report 13:47:02 INFO - PROCESS | 29796 | __startTimestamp1471898822667__endTimestamp 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | ------- Summary: start ------- 13:47:02 INFO - PROCESS | 29796 | Number of tests: 14 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#0] ai-astar Cycles:10 Average:111.10 Median:114.00 stddev:5.32 (4.7%) stddev-sans-first:3.40 13:47:02 INFO - PROCESS | 29796 | Values: 99.0 112.0 108.0 117.0 116.0 109.0 117.0 111.0 111.0 111.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:146.50 stddev:24.44 (16.7%) stddev-sans-first:25.84 13:47:02 INFO - PROCESS | 29796 | Values: 150.0 123.0 145.0 191.0 120.0 147.0 146.0 121.0 177.0 122.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 13:47:02 INFO - PROCESS | 29796 | Values: 162.0 162.0 160.0 161.0 162.0 163.0 161.0 161.0 161.0 161.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#3] audio-fft Cycles:10 Average:96.20 Median:76.50 stddev:39.45 (51.6%) stddev-sans-first:41.16 13:47:02 INFO - PROCESS | 29796 | Values: 76.0 75.0 76.0 179.0 77.0 79.0 84.0 78.0 162.0 76.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.50 stddev:28.68 (33.5%) stddev-sans-first:29.63 13:47:02 INFO - PROCESS | 29796 | Values: 85.0 85.0 148.0 85.0 86.0 86.0 145.0 87.0 86.0 142.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:47:02 INFO - PROCESS | 29796 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:47:02 INFO - PROCESS | 29796 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 13:47:02 INFO - PROCESS | 29796 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:1.90 (3.7%) stddev-sans-first:1.05 13:47:02 INFO - PROCESS | 29796 | Values: 56.0 50.0 50.0 52.0 53.0 51.0 50.0 50.0 51.0 51.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 13:47:02 INFO - PROCESS | 29796 | Values: 61.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 62.0 62.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:2.27 (2.9%) stddev-sans-first:1.76 13:47:02 INFO - PROCESS | 29796 | Values: 84.0 80.0 80.0 78.0 83.0 79.0 79.0 78.0 78.0 77.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:131.50 stddev:7.75 (5.9%) stddev-sans-first:8.19 13:47:02 INFO - PROCESS | 29796 | Values: 132.0 123.0 140.0 123.0 123.0 125.0 131.0 132.0 146.0 128.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.00 stddev:2.07 (1.3%) stddev-sans-first:1.73 13:47:02 INFO - PROCESS | 29796 | Values: 168.0 166.0 167.0 164.0 163.0 164.0 164.0 161.0 164.0 163.0 13:47:02 INFO - PROCESS | 29796 | 13:47:02 INFO - PROCESS | 29796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:2.58 (3.9%) stddev-sans-first:2.70 13:47:02 INFO - PROCESS | 29796 | Values: 65.0 65.0 66.0 65.0 65.0 66.0 68.0 66.0 64.0 73.0 13:47:02 INFO - PROCESS | 29796 | -------- Summary: end -------- 13:47:02 INFO - PROCESS | 29796 | 13:47:03 INFO - TEST-INFO | 29796: exit 0 13:47:03 INFO - TEST-OK | kraken | took 62076ms 13:47:03 INFO - SUITE-END | took 1178s 13:47:04 INFO - Completed test suite (00:19:38) 13:47:04 INFO - javascript benchmark 13:47:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2959.8224106553607, 2975.8363290019056, 3017.766852529128, 3020.199647093522, 3032.2570970112324, 5060.822871199509, 5118.897622047557, 5189.948100518998, 5270.920936185956, 5297.231901374304, 5186.662866913657, 5223.6343455958095, 5245.423003469616, 5261.184516399954, 5298.841034768963, 4751.572358487735, 4807.78364973577, 4856.344393506866, 4913.091078150554, 4932.926006109893, 4912.189488734354, 4929.4824043475455, 4953.900921981558, 4957.553820156185, 4960.107180707471, 4679.064187162581, 4753.857384278443, 4756.239001759702, 4797.11253418117, 4808.519148085198, 4700.858974230779, 4701.318308845232, 4736.976315118402, 4789.37738094049, 4804.279358096279, 4758.762061896891, 4762.38089048425, 4832.806687732486, 4847.636427267969, 4851.781669824866, 5062.2406639004075, 5284.260203571503, 5291.894162116736, 5301.257823904656, 5301.3373328333955, 5368.758405871706, 5409.323834520685, 5460.26286451328, 5520.66875987442, 5545.168224766277, 5523.669658779298, 5556.72216389183, 5562.332520097574, 5587.413321601254, 5589.0219211637805, 5078.5175408336145, 5114.897702045938, 5209.895802083975, 5212.426633070321, 5221.71280579568, 5664.20701101846, 5749.137629355547, 5768.221290125864, 5770.913436298459, 5772.595918285764, 5524.751386187631, 5537.556995440355, 5543.2793736814765, 5544.944550554443, 5547.2511210986, 5363.517283444508, 5455.645383050089, 5599.300087489064, 5602.439756024365, 5610.298712660918, 5475.288212532345, 5583.944160558423, 5584.720763961785, 5585.385607583163, 5590.413006634326, 5592.748326325325, 5606.24315717373, 5606.831795046155, 5608.298962629671, 5609.102543593006, 4247.193033323659, 4301.65586753059, 4378.014946636981, 4380.408644832907, 4389.868303950822, 3825.8087095645105, 3877.3020856245585, 3908.3746600543777, 3921.058945852975, 3921.9215615687526, 5380.3274590676165, 5407.405185429599, 5415.052365836042, 5418.4039755626845, 5422.267993820863, 5486.259354987105, 5505.944940550543, 5544.140658197985, 5670.291213598301, 5715.799947001835, 5271.841844744664, 5285.603579731535, 5295.393008082992, 5299.894002119936, 5309.283246761638, 4821.180399332122, 4829.975850120727, 4833.96069844978, 4837.2260438329695, 4840.6127509799135, 5553.916691249635, 5667.574931880125, 5715.599908006566, 5751.511121554715, 5756.5682573807135, 5612.045952188057, 5632.380438151882, 5642.520385767256, 5643.463870932255, 5659.688717120598, 5812.389699081705, 5842.2405087338375, 5847.06446968483, 5849.093390524476, 5858.560607954506, 5348.5186333230195, 5391.9460805391445, 5443.863903402288, 5572.331320241597, 5574.665520068809, 5630.915536266877, 5651.57613179005, 5651.8304450866535, 5661.547076233974, 5678.403767604342, 5474.069408200695, 5539.224508568723, 5550.306211723535, 5558.888822223452, 5561.416051314553, 5242.659227150223, 5352.223927530564, 5424.783008679608, 5479.643823151482, 5527.281453411031, 5445.59158063139, 5452.5365343946205, 5457.7271136443815, 5460.808871689472, 5463.617546771847, 5585.804496842591, 5592.217089607377, 5596.972015139898, 5602.355729091207, 5609.523190528851, 5209.973950130377, 5266.236395722675, 5305.70818604965, 5474.069408200695, 5484.643498172606], "value": 5171.84244293999, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.3297408519076, 584.8362458511617, 602.3195285154419, 604.3231580629696, 607.5625549604283, 42837.78581107094, 43682.781586092024, 43809.34285985709, 43877.78061109694, 46637.703909972144, 45034.0, 45529.317060244124, 45592.61703361532, 45641.31538026924, 45671.0, 8879.289656827454, 9043.276537876955, 9051.321150913675, 9070.0, 9071.727848164566, 8956.596953137092, 9054.094590540926, 9062.45625262483, 9063.365564410495, 9063.365564410495, 9094.49980251086, 9139.771505712344, 9141.360104792668, 9143.451392916413, 9143.954280228623, 9057.275417966579, 9071.455712657262, 9094.86357704635, 9096.727098187064, 9096.772580685536, 8944.373893827435, 9000.594973226154, 9016.639334426614, 9017.458952462874, 9018.413803102778, 42566.78716606397, 42969.57030429687, 42993.57006429927, 43005.13989720219, 43013.13973720539, 3116.3144108296137, 3215.871365145415, 3271.6401195868434, 3404.0128362774767, 3575.5173051637958, 32848.83575582107, 33476.6652333476, 33488.83255583731, 33658.66341336604, 34570.135746606284, 3896.7661940283674, 4102.3026085565525, 4127.8968025799295, 4138.689598280141, 4295.78521073945, 331204.0, 335410.0, 336473.0, 336788.0, 339355.3032234848, 59163.0, 59531.70234148888, 59633.40366596278, 59644.40355596475, 59739.0, 36335.0, 36936.261274774355, 36980.0, 38865.0, 63252.683736581945, 14533.636659083608, 14814.703705925822, 14824.3329050193, 14831.184284864436, 14832.25838708082, 11267.436628168558, 11324.263922844988, 11326.886731132749, 11337.433128343715, 11340.886591134147, 19001.14494847735, 19005.0, 19016.61966760657, 19019.33432329862, 19200.327988520614, 7013.228544860061, 7029.472789540805, 7073.893891591631, 7281.308275713799, 7319.451041171933, 941.8493041113389, 1016.2733645443543, 1032.8812186598486, 1042.280826229899, 1114.2812885688686, 32051.0, 32562.837185814395, 32564.511532327033, 32809.0, 33219.833900830345, 1075.5912753153907, 1093.8632670916136, 1102.9172812039128, 1107.1917500224881, 1170.795110855597, 16611.41860034893, 17185.484435466955, 17228.569285767957, 17259.3959211427, 17511.824881751276, 549220.0, 551068.0, 553330.0, 555412.0, 555540.0, 58887.41112588819, 59568.70215648981, 59571.40428595659, 59669.701651491465, 59691.70154149202, 1202.4168278384977, 1204.2593804810153, 1302.5636411801963, 1304.6347022833622, 1348.3190988550718, 31217.375652487277, 33462.49806252957, 33744.831275844444, 33950.320993580484, 34269.0, 45143.0, 45570.772146139054, 45626.0, 45643.77178114088, 45646.54353456423, 397355.0, 397486.0, 398897.0, 399235.0, 399523.0, 25580.10469633554, 27808.384909961576, 28632.57051144193, 28652.99714509982, 29266.0, 39815.60184398119, 40058.0, 40357.39463907985, 40420.0, 41143.7942810284, 40177.59822401738, 40615.0, 41085.58914410818, 42565.36151957785, 42595.0, 39886.202275953736, 41208.49727773173, 41395.793021034704, 41569.58430415778, 42233.788831055645, 41329.1734165321, 41478.1704365917, 41812.58187418087, 42168.578314216466, 42301.153976920905, 34819.65180348265, 36501.45247821232, 36695.63304366922, 36728.63271367252, 37529.249415011, 27685.0, 27979.580306295014, 28089.57865631976, 28240.29399265035, 28510.857445712638], "value": 19661.932027654253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3750530398708, 393.2135728542912, 396.13642259873484, 402.97380670256433, 418.2137581347069, 13094.66705294003, 18283.26866925323, 19927.202911883527, 20039.0, 20732.689009664828, 15244.923775381136, 15827.683446331095, 16046.679066418665, 16315.184240787943, 16613.252403641836, 5725.427457254283, 5932.228810254661, 5932.614380065282, 5933.376995415484, 5934.198883150784, 5688.317401911776, 5807.0, 5886.587938844283, 5888.0, 5890.823275301726, 5831.183634291203, 5871.119332100197, 5875.618084824494, 5878.235829342201, 5880.8235752927485, 5578.581606379537, 5794.420557944214, 5872.060470324749, 5875.764969401219, 5878.5297176225795, 5218.66078704883, 5218.921716174261, 5219.556337711299, 5224.320838291036, 5227.059129356714, 23757.524849503086, 23923.64114538266, 24082.397940051465, 24566.263012109488, 25025.0, 2408.927732168038, 2417.1177520205174, 2424.1394305021818, 2464.642626819119, 3014.3669829335868, 14253.0, 15080.849191508163, 15346.923265383602, 15418.0, 15557.29992150356, 1908.6659834528903, 1952.4142757172933, 1971.0932970833435, 2007.2372498450495, 2045.5704302096578, 79210.60394698047, 79938.99999999942, 81306.59346703287, 83210.58394708048, 83564.58217708873, 10222.897771022195, 10303.896961030443, 10403.791924161475, 10433.478326083665, 10870.021698047214, 14575.635609109857, 14579.854201457849, 14581.85418145805, 14594.854051459562, 14596.12423254608, 7372.447066470037, 7470.4770666052855, 7489.513181643176, 7766.922330776733, 7787.961060194776, 7083.610401427971, 7119.71521139159, 7311.707531698672, 7336.926630733625, 7337.3029562191505, 5864.912026319608, 6406.167198264196, 6661.000849872461, 6765.458763298924, 6970.860582788316, 1911.8852868827637, 1916.33279047227, 1928.0, 1928.4503916383762, 1972.5265936175215, 968.7820240445984, 998.4907697074544, 1012.0941757127476, 1016.6695823857276, 1036.108946306176, 20412.897935510526, 22091.558168836535, 22272.0, 22334.55330893373, 22417.0, 995.5022488755623, 1022.672744721682, 1026.861373714539, 1057.5558265528496, 1078.4607696151925, 10824.051670699193, 11955.64133076009, 12036.157468977262, 12130.696732581757, 12171.687379397887, 445908.0, 453085.0, 455473.0, 469939.0, 472876.0, 95608.0, 96840.0, 98225.0, 98246.0, 100901.0, 950.3062764182185, 981.788915383196, 999.7950420163849, 1000.5797565022708, 1019.1490105761771, 18153.0, 18247.178876950835, 19065.14206860667, 19271.0, 19280.517987050436, 34229.144271393416, 39869.60130398659, 43805.0, 44059.03468687834, 44122.0, 59953.700231498566, 59957.40042599693, 61406.69296653488, 62197.689011554656, 62531.37468625256, 8435.45169564001, 8845.778855528662, 9015.233705135137, 9022.684206052756, 9156.130167634064, 9377.202937750368, 13945.651358716113, 14084.647883802578, 14765.704685906436, 14918.477853275082, 12345.814812777995, 12436.937815310866, 12617.278204944374, 12649.557265496032, 13080.542181023618, 12164.452599633214, 12211.145219834882, 12260.570880019513, 12392.81410778821, 12823.93588032054, 12475.625731228078, 12652.746945061232, 12725.236485810881, 12762.936185319015, 12873.742525149632, 8584.91415085841, 8691.956540217512, 8790.164934331227, 8830.249428798625, 9194.12655797698, 12165.330906799856, 12290.508379664714, 12369.319687417279, 12462.626121216377, 12714.012207131502], "value": 9519.651413051013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.3082397153487, 1462.1957923142272, 1488.5087920986075, 1584.1683116363909, 1747.9300827966874, 8238.835223295539, 8663.74008779736, 8689.73930782076, 8958.372913896013, 8968.0, 8385.0357208921, 8556.058833528306, 8565.314774818014, 8571.571421428935, 8574.442661227016, 2370.2415227127326, 2397.9160729374476, 2399.7120345558556, 2400.5918993771015, 2402.4474370894704, 2289.599320118981, 2345.1323010486144, 2358.9764102359013, 2362.917297894574, 2367.242482405631, 2302.4013756423283, 2310.3992961829963, 2310.526342099874, 2370.7273663528745, 2375.192434572245, 2292.873891935943, 2310.861348319106, 2320.385097949045, 2321.1759825262043, 2348.4011577047745, 2238.2837492002564, 2248.87631180285, 2251.662250662414, 2255.4474153832252, 2262.0, 8148.633311500997, 8618.956905215433, 8817.250533704642, 8820.073892241286, 8821.07378725231, 4921.286413470062, 5111.616628752821, 5114.181730923035, 5120.539151476385, 5121.129408000649, 3357.1607098225445, 3368.781029233092, 3414.4195486767308, 3423.2811109667, 3428.8285585720864, 1177.5878442545127, 1179.3631439022918, 1193.146899966528, 1203.145766505782, 1210.751795881851, 11784.764304713943, 11828.763424731544, 11850.644480665595, 11881.158420444845, 11927.105467090003, 4205.936910946339, 4335.82656693735, 4442.755648439303, 4467.173572889026, 4492.3710680504755, 9320.95339523298, 9358.11097945694, 9361.485118318558, 9362.016988216275, 9371.437713737198, 4909.877253068702, 4912.312276281324, 4927.088488629615, 4948.727819969936, 4950.777215025332, 4090.1206240658403, 4463.464384273908, 4539.523350048264, 4585.81656733727, 4618.076384723069, 3554.5734511858227, 3635.636436356396, 3664.340418724655, 3685.4840322354894, 3746.793926334023, 1089.8310761831929, 1108.6175269531998, 1110.5335758981248, 1127.2391135983178, 1128.4357821089454, 842.8946381702287, 910.1717437132311, 949.6296444386695, 983.8770153730641, 986.2208855004609, 5475.616706830563, 5486.753096110685, 5836.066229403275, 5841.7371218295275, 5861.062230043172, 436.975966321849, 438.9793729578742, 440.61226121013306, 443.50992153670376, 446.4174252600388, 3927.155661532784, 4207.495100587949, 4216.2832318505925, 4303.419038429772, 4365.515724653633, 10866.348019118721, 10942.890571094187, 11027.669169924915, 11042.558297668164, 11056.281341712764, 10547.630832920811, 10877.564897404174, 10896.727581810359, 10980.780384392267, 10995.505202265917, 7884.684612615546, 8267.545285009382, 8308.21071998147, 8310.8337833243, 8333.8333233335, 6036.517078633787, 6078.696065196811, 6088.756449741961, 6168.753249869955, 6267.561270711007, 9618.663346782829, 9929.0, 10091.293609447268, 10132.240081993732, 10197.898021019992, 10051.648192313234, 10194.082532572103, 10251.128654064489, 10320.329178603366, 10327.173826093744, 7136.7145314186855, 7753.961230193813, 7923.088844782924, 7989.2010798921965, 8220.83558328842, 7990.600469976362, 8383.077861435358, 8388.119247478928, 8391.496510209407, 8398.328133749163, 7280.708771649075, 7429.5542267464125, 7467.962660186664, 7483.102027756704, 7537.321641052332, 7154.105736782903, 7287.562746235243, 7328.523645962995, 7362.77911662651, 7528.585927774025, 6690.732370705117, 6864.21061577925, 6864.931350686629, 6865.622390768555, 6867.965660171667, 4970.204767237225, 5107.387113546398, 5185.585153187812, 5235.581153507634, 5241.030409374278, 5171.405288391883, 5196.870078247923, 5231.253591864302, 5252.9737351313, 5277.947220527899], "value": 4459.906089799244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.1899195036557, 326.4906745477056, 336.40792205717935, 338.6630302848665, 344.43512639271614, 4986.875328116799, 5076.619253555979, 5161.922571161431, 5230.110881150209, 5236.31927849379, 5079.1365467870455, 5088.847334579968, 5174.172132458807, 5185.299984502091, 5185.403678576965, 4136.73111247768, 4159.355299928501, 4159.708820382574, 4168.0, 4181.435506206662, 3981.4625025621604, 4117.608827161415, 4153.210889930919, 4161.521425036114, 4180.324592260956, 4119.464469618961, 4128.442660240874, 4133.627973482386, 4137.234611596849, 4145.606167414091, 4098.918021639581, 4107.075907920739, 4120.979395103021, 4121.62905338521, 4147.149834283965, 3717.1078941054225, 3722.0, 3735.1782607826235, 3735.682466990309, 3735.962640373589, 4928.207226174702, 5009.599232061463, 5021.372328458942, 5038.722870242135, 5056.519630635084, 4661.0, 4667.929981050287, 4684.531546845323, 4724.71651700899, 4728.66899317048, 5334.199870019489, 5337.973310133424, 5341.572674186055, 5348.705821179834, 5353.732313384316, 3810.1427178884805, 3943.4084887266854, 3956.9802150989062, 3957.485526881516, 3959.722819402643, 5521.923224971132, 5528.198411230389, 5542.0, 5557.138643510262, 5558.6942718150485, 4069.4709687740997, 4082.632563069338, 4087.896268007621, 4136.6483848872585, 4160.750354978711, 4082.9591704082577, 4114.958850411457, 4140.660526802347, 4145.958540414557, 4198.916021679611, 4605.194091034055, 4618.930716039262, 4636.724900652348, 4649.95350046502, 4650.488446270908, 5362.0, 5386.5152136307925, 5395.514403703607, 5431.592630552725, 5443.401225865152, 1378.427952399743, 1390.8261467316586, 1424.3946322812762, 1440.7838824176458, 1444.2129039673403, 985.2315194148575, 990.3166814897697, 1020.2093377632394, 1020.4234607446768, 1021.7088129883097, 5140.717260550706, 5154.690718556899, 5168.9741551292, 5179.507946745053, 5187.092258854761, 5425.403205647375, 5446.373667028342, 5451.890962180813, 5463.945360546423, 5471.50756431915, 4977.477364876709, 5140.280360749498, 5150.381954165449, 5155.401825434127, 5236.92144617831, 2916.1105862712075, 2924.7715959297147, 2930.750886174699, 2936.6329208848892, 2939.8383088930314, 5697.601167918206, 5706.457886500859, 5716.657000579979, 5719.19931209631, 5733.598648094677, 5538.47384498472, 5566.860828479321, 5603.159526071122, 5631.929933312657, 5653.773849046074, 5674.240985294572, 5681.687507187062, 5718.199452076629, 5737.3975732548315, 5760.337561180434, 5313.442088580643, 5422.511973922208, 5462.91805622908, 5552.973164794902, 5581.5255703265675, 5397.163439666858, 5444.50999410055, 5449.400565937823, 5460.7542660579575, 5476.397596264328, 5683.2895888014, 5702.6863522506665, 5703.62926409782, 5760.913586296293, 5789.56578256624, 3887.436321733276, 3948.5459172194414, 3960.4851369321805, 3961.2869683457257, 3962.405639154035, 5265.3944796348915, 5376.220448035091, 5485.725713714219, 5488.17677348401, 5511.311086114236, 5374.7312634367345, 5380.192971054216, 5422.891542169214, 5451.809186678447, 5473.233747275305, 5439.5648348132845, 5444.455554444682, 5448.83653490396, 5462.180672899097, 5491.423400542885, 5149.56228720548, 5326.201069839555, 5345.679259244458, 5365.22204280385, 5366.838994830161, 5334.1732031535175, 5449.918251226314, 5453.672779633234, 5457.399686034453, 5461.754221059982, 5165.210786175573, 5302.1781623848365, 5306.628536002443, 5361.705106219196, 5369.892602148013], "value": 4165.73139801595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.9148610680611, 699.6991293743691, 712.5688958180302, 736.2269616902252, 738.3354980517533, 13784.310784460775, 14905.105693658388, 14974.101553906774, 14976.850231497681, 15016.324265408055, 13581.117227380213, 13713.931430342835, 13714.58856234312, 13728.45086196551, 14398.784018239709, 659.8812213801514, 779.4972242903324, 799.760071978407, 801.6312496251702, 802.0976401548259, 784.4822417204646, 809.9392545559107, 809.9635516401746, 813.7436707437168, 814.5845618734459, 822.7038266224155, 829.6432534010373, 829.7593697827623, 830.887830142932, 831.1024093978519, 686.7939618114546, 826.7809030606894, 830.1034882327102, 830.2818062376061, 830.4519017448486, 594.5065595555678, 605.0863196573163, 606.4148097086289, 606.5420607441354, 608.4189598933052, 13531.661708457268, 13554.59336219915, 14081.929590352085, 14093.2953352333, 14100.506482273071, 13348.532801351907, 13755.656108597264, 14024.789628155586, 14077.225752583603, 14316.21260830654, 11444.198906076577, 12297.631071067883, 12584.056195785353, 12811.87188128116, 13558.93220533891, 4470.575295346936, 4519.231730605805, 4554.931676024862, 4717.952820471785, 4784.425868895755, 66855.66572167157, 68453.0, 69661.30338696598, 79789.20210797933, 80131.0, 10809.297395669257, 11081.944590276997, 11083.833742493869, 11337.26307789991, 11489.712757181138, 21454.463638409165, 21755.564888702138, 21766.89116554407, 21768.78231217699, 21779.564408711736, 8704.42928459196, 8831.867521987175, 8872.911270887338, 8956.462612243286, 9301.209397201314, 4742.407199100113, 4829.227323628273, 4836.274558816135, 4856.708597484162, 5173.068847607392, 3532.717382609385, 3628.401313783249, 3633.8728144514816, 3634.436662317345, 3646.9452958205648, 608.6682757896868, 612.6569121292091, 612.8437248501604, 620.460199626319, 628.2398298059308, 604.3291945940003, 724.4457989637931, 768.8846672999094, 783.8001309665999, 785.0073532334349, 9130.954345228363, 9496.192823609932, 9690.512430238536, 9709.563069661883, 10010.599576017023, 565.4515120333352, 660.6564586415134, 675.7330854312519, 683.2040672616346, 731.8499707560044, 4738.123447162286, 4881.585065269421, 4905.3623029006, 4951.282064100757, 4986.650934434555, 123220.38389807993, 123310.0, 123698.38150809189, 126426.36786816007, 127180.0, 105353.0, 108770.45614771875, 108937.0, 111412.0, 111684.0, 93864.53067734755, 96739.0, 98720.50639746756, 98867.50566247123, 101586.0, 8999.37004409685, 9094.363394562317, 9312.860307095534, 9320.580573874056, 9338.112879276458, 38883.41674874823, 42201.78899105485, 51678.22482662688, 52773.0, 53728.0, 73138.0, 77466.6126669363, 83314.0, 83384.0, 86630.0, 11497.252678575866, 12391.0, 13025.934870325587, 13035.674108147372, 13441.596752097452, 14207.64480887986, 14265.57203283903, 14303.642408939444, 15289.923550382176, 15492.612684682974, 12492.937535312265, 12623.242605443702, 12775.105742597929, 12959.481620735442, 13367.331633418096, 12939.482420703067, 13342.733145337234, 13538.932305338803, 13780.173189608655, 13854.376553054935, 13805.17168969865, 13879.375428105961, 14011.0, 14121.717565648834, 14146.575602731935, 10730.624428144978, 10988.725281867697, 11150.442477876237, 11188.1608879336, 11535.538578456768, 11241.156913231704, 11462.541498339973, 11623.941880290544, 11729.178957472895, 11777.882221177679], "value": 7567.846260692244, "unit": "score"}], "name": "dromaeo_css", "value": 7172.240807180156, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 108.0, 117.0, 116.0, 109.0, 117.0, 111.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 145.0, 191.0, 120.0, 147.0, 146.0, 121.0, 177.0, 122.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 179.0, 77.0, 79.0, 84.0, 78.0, 162.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 148.0, 85.0, 86.0, 86.0, 145.0, 87.0, 86.0, 142.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 50.0, 50.0, 52.0, 53.0, 51.0, 50.0, 50.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 80.0, 78.0, 83.0, 79.0, 79.0, 78.0, 78.0, 77.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 140.0, 123.0, 123.0, 125.0, 131.0, 132.0, 146.0, 128.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 167.0, 164.0, 163.0, 164.0, 164.0, 161.0, 164.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 68.0, 66.0, 64.0, 73.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1528.0, "alertThreshold": 2.0}]} 13:47:04 INFO - Return code: 0 13:47:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:47:04 INFO - # TBPL SUCCESS # 13:47:04 INFO - Running post-action listener: _resource_record_post_action 13:47:04 INFO - [mozharness: 2016-08-22 20:47:04.428185Z] Finished run-tests step (success) 13:47:04 INFO - Running post-run listener: _resource_record_post_run 13:47:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 411471872; Read time: 0; Write time: 394340 13:47:04 INFO - TinderboxPrint: CPU usage
13.3% 13:47:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:47:04 INFO - TinderboxPrint: I/O write bytes / time
411,471,872 / 394,340 13:47:04 INFO - TinderboxPrint: CPU idle
8,273.3 (86.7%) 13:47:04 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 13:47:04 INFO - TinderboxPrint: Swap in / out
0 / 0 13:47:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 122978304; Read time: 0; Write time: 154200 13:47:04 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288493568; Read time: 0; Write time: 240140 13:47:05 INFO - Running post-run listener: _upload_blobber_files 13:47:05 INFO - Blob upload gear active. 13:47:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:47:05 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 13:47:05 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'] 13:47:05 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 13:47:05 INFO - (blobuploader) - INFO - Open directory for files ... 13:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:06 INFO - (blobuploader) - INFO - Done attempting. 13:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:08 INFO - (blobuploader) - INFO - Done attempting. 13:47:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:47:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:47:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:12 INFO - (blobuploader) - INFO - Done attempting. 13:47:12 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:12 INFO - Return code: 0 13:47:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cefc603bc476631b2248f1c3d4b8a851a2ec134287a91d52e012add3963a2610c309c9a9d69e35931b4e3708a7ead719cf07aeb3fb29b8fd244cf846266464e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e814b944d11a28bfebbcd090bab4a53057b21a13a5e11463232459f11307ca41f8b910d06b26bd9e1267a98b6900b1b8c88d3ea99f9c2a4e6417122418ad2406", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baeb722111a2962a11041cf5f860abe28ae277abe6320f032a715a480593664dc613a75bde1bcbfdd63d08fea6b6b06c009b4d9358a64e7770e93a106fc07181"} 13:47:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:12 INFO - Contents: 13:47:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cefc603bc476631b2248f1c3d4b8a851a2ec134287a91d52e012add3963a2610c309c9a9d69e35931b4e3708a7ead719cf07aeb3fb29b8fd244cf846266464e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e814b944d11a28bfebbcd090bab4a53057b21a13a5e11463232459f11307ca41f8b910d06b26bd9e1267a98b6900b1b8c88d3ea99f9c2a4e6417122418ad2406", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baeb722111a2962a11041cf5f860abe28ae277abe6320f032a715a480593664dc613a75bde1bcbfdd63d08fea6b6b06c009b4d9358a64e7770e93a106fc07181"} 13:47:12 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:12 INFO - Copying logs to upload dir... 13:47:12 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.280419 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-22 13:47:11.427979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 13:47:11.431032) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409 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/cefc603bc476631b2248f1c3d4b8a851a2ec134287a91d52e012add3963a2610c309c9a9d69e35931b4e3708a7ead719cf07aeb3fb29b8fd244cf846266464e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e814b944d11a28bfebbcd090bab4a53057b21a13a5e11463232459f11307ca41f8b910d06b26bd9e1267a98b6900b1b8c88d3ea99f9c2a4e6417122418ad2406", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baeb722111a2962a11041cf5f860abe28ae277abe6320f032a715a480593664dc613a75bde1bcbfdd63d08fea6b6b06c009b4d9358a64e7770e93a106fc07181"} build_url:https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/cE3ykUjqTXCG863gi5dxrw/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/cefc603bc476631b2248f1c3d4b8a851a2ec134287a91d52e012add3963a2610c309c9a9d69e35931b4e3708a7ead719cf07aeb3fb29b8fd244cf846266464e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e814b944d11a28bfebbcd090bab4a53057b21a13a5e11463232459f11307ca41f8b910d06b26bd9e1267a98b6900b1b8c88d3ea99f9c2a4e6417122418ad2406", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baeb722111a2962a11041cf5f860abe28ae277abe6320f032a715a480593664dc613a75bde1bcbfdd63d08fea6b6b06c009b4d9358a64e7770e93a106fc07181"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 13:47:11.455693) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:47:11.456001) ========= 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=17051fcd5208b27b50bedfeb000001dd-1471897588.15052-1083072409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:47:11.539143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 13:47:11.539692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 13:47:11.540201) ========= ========= Total master_lag: 0.17 =========