builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1472177265.32 results: success (0) buildid: 20160825173002 builduid: 481c35be1c644d78bf0d37d17fc5cfaf revision: b76313e48f6b443b0f4701621f01510f06455c83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.319353) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.319814) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.320522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.341430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.341750) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 19:07:45-- 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% 88.9M=0s 2016-08-25 19:07:45 (88.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.438379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.438707) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017670 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.493489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:45.493860) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b76313e48f6b443b0f4701621f01510f06455c83 --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 b76313e48f6b443b0f4701621f01510f06455c83 --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=934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 19:07:45,788 truncating revision to first 12 chars 2016-08-25 19:07:45,788 Setting DEBUG logging. 2016-08-25 19:07:45,788 attempt 1/10 2016-08-25 19:07:45,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b76313e48f6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 19:07:46,067 unpacking tar archive at: fx-team-b76313e48f6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623678 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:46.131442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:46.131762) ========= script_repo_revision: b76313e48f6b443b0f4701621f01510f06455c83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:46.132160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:46.132456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 19:07:46.141374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-25 19:07:46.141697) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:46 INFO - MultiFileLogger online at 20160825 19:07:46 in /builds/slave/test 19:07:46 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 19:07:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:46 INFO - {'append_to_log': False, 19:07:46 INFO - 'base_work_dir': '/builds/slave/test', 19:07:46 INFO - 'blob_upload_branch': 'Fx-Team', 19:07:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:46 INFO - 'branch': 'Fx-Team', 19:07:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:46 INFO - 'config_files': ('talos/linux_config.py',), 19:07:46 INFO - 'default_actions': ('clobber', 19:07:46 INFO - 'read-buildbot-config', 19:07:46 INFO - 'download-and-extract', 19:07:46 INFO - 'populate-webroot', 19:07:46 INFO - 'create-virtualenv', 19:07:46 INFO - 'install', 19:07:46 INFO - 'run-tests'), 19:07:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:46 INFO - 'download_minidump_stackwalk': True, 19:07:46 INFO - 'download_symbols': 'ondemand', 19:07:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:46 INFO - 'installer_path': 'installer.exe', 19:07:46 INFO - 'log_level': 'info', 19:07:46 INFO - 'log_name': 'talos', 19:07:46 INFO - 'log_to_console': True, 19:07:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:46 INFO - 'opt_config_files': (), 19:07:46 INFO - 'pip_index': False, 19:07:46 INFO - 'sps_profile': False, 19:07:46 INFO - 'sps_profile_interval': 0, 19:07:46 INFO - 'suite': 'dromaeojs', 19:07:46 INFO - 'system_bits': '32', 19:07:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:46 INFO - 'title': 'talos-linux64-ix-057', 19:07:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:46 INFO - 'use_talos_json': True, 19:07:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:46 INFO - 'work_dir': 'build'} 19:07:46 INFO - [mozharness: 2016-08-26 02:07:46.536806Z] Running clobber step. 19:07:46 INFO - Running pre-action listener: _resource_record_pre_action 19:07:46 INFO - Running main action method: clobber 19:07:46 INFO - rmtree: /builds/slave/test/build 19:07:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:47 INFO - Running post-action listener: _resource_record_post_action 19:07:47 INFO - [mozharness: 2016-08-26 02:07:47.519212Z] Finished clobber step (success) 19:07:47 INFO - [mozharness: 2016-08-26 02:07:47.519311Z] Running read-buildbot-config step. 19:07:47 INFO - Running pre-action listener: _resource_record_pre_action 19:07:47 INFO - Running main action method: read_buildbot_config 19:07:47 INFO - Using buildbot properties: 19:07:47 INFO - { 19:07:47 INFO - "project": "", 19:07:47 INFO - "product": "firefox", 19:07:47 INFO - "script_repo_revision": "production", 19:07:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:07:47 INFO - "repository": "", 19:07:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:07:47 INFO - "buildid": "20160825173002", 19:07:47 INFO - "pgo_build": "True", 19:07:47 INFO - "basedir": "/builds/slave/test", 19:07:47 INFO - "buildnumber": 1494, 19:07:47 INFO - "slavename": "talos-linux64-ix-057", 19:07:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:07:47 INFO - "platform": "ubuntu64_hw", 19:07:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:07:47 INFO - "branch": "fx-team", 19:07:47 INFO - "repo_path": "integration/fx-team", 19:07:47 INFO - "revision": "b76313e48f6b443b0f4701621f01510f06455c83", 19:07:47 INFO - "stage_platform": "linux64-pgo", 19:07:47 INFO - "builduid": "481c35be1c644d78bf0d37d17fc5cfaf", 19:07:47 INFO - "slavebuilddir": "test" 19:07:47 INFO - } 19:07:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:07:47 INFO - Running post-action listener: _resource_record_post_action 19:07:47 INFO - [mozharness: 2016-08-26 02:07:47.521737Z] Finished read-buildbot-config step (success) 19:07:47 INFO - [mozharness: 2016-08-26 02:07:47.521836Z] Running download-and-extract step. 19:07:47 INFO - Running pre-action listener: _resource_record_pre_action 19:07:47 INFO - Running main action method: download_and_extract 19:07:47 INFO - mkdir: /builds/slave/test/build/tests 19:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:47 INFO - trying https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:07:47 INFO - Downloading https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:48 INFO - Downloaded 1361 bytes. 19:07:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:07:48 INFO - Using the following test package requirements: 19:07:48 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:48 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:48 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:07:48 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'jsshell-linux-x86_64.zip'], 19:07:48 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:48 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:48 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:07:48 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:07:48 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:48 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07: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')]} 19:07:48 INFO - trying https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:07:48 INFO - Downloading https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:48 INFO - Downloaded 21872636 bytes. 19:07:48 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 19:07:53 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 19:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:53 INFO - trying https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:07:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:54 INFO - Downloaded 21872636 bytes. 19:07:54 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 19:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:58 INFO - trying https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:59 INFO - Downloaded 14413981 bytes. 19:07:59 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 19:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:59 INFO - trying https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:07:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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 19:08:02 INFO - Downloaded 59827945 bytes. 19:08:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:08:02 INFO - mkdir: /builds/slave/test/properties 19:08:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:02 INFO - Contents: 19:08:02 INFO - build_url:https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:08:02 INFO - Running post-action listener: _resource_record_post_action 19:08:02 INFO - Running post-action listener: set_extra_try_arguments 19:08:02 INFO - [mozharness: 2016-08-26 02:08:02.844832Z] Finished download-and-extract step (success) 19:08:02 INFO - [mozharness: 2016-08-26 02:08:02.845058Z] Running populate-webroot step. 19:08:02 INFO - Running pre-action listener: _resource_record_pre_action 19:08:02 INFO - Running main action method: populate_webroot 19:08:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:02 INFO - '--tppagecycles', 19:08:02 INFO - '7'], 19:08:02 INFO - 'tests': ['tsvgm']}}, 19:08:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['damp', 'tps']}, 19:08:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'tests': ['damp', 'tps']}, 19:08:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['dromaeo_dom']}, 19:08:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['basic_compositor_video']}, 19:08:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:08:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['a11yr', 19:08:02 INFO - 'ts_paint', 19:08:02 INFO - 'tpaint', 19:08:02 INFO - 'sessionrestore', 19:08:02 INFO - 'sessionrestore_no_auto_restore', 19:08:02 INFO - 'tabpaint']}, 19:08:02 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:02 INFO - 'ts_paint', 19:08:02 INFO - 'tpaint', 19:08:02 INFO - 'sessionrestore', 19:08:02 INFO - 'sessionrestore_no_auto_restore', 19:08:02 INFO - 'tabpaint']}, 19:08:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:02 INFO - 'ts_paint', 19:08:02 INFO - 'tpaint', 19:08:02 INFO - 'sessionrestore', 19:08:02 INFO - 'sessionrestore_no_auto_restore', 19:08:02 INFO - 'tabpaint']}, 19:08:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:02 INFO - 'ts_paint', 19:08:02 INFO - 'tpaint', 19:08:02 INFO - 'sessionrestore', 19:08:02 INFO - 'sessionrestore_no_auto_restore', 19:08:02 INFO - 'tabpaint']}, 19:08:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['a11yr', 19:08:02 INFO - 'ts_paint', 19:08:02 INFO - 'tpaint', 19:08:02 INFO - 'sessionrestore', 19:08:02 INFO - 'sessionrestore_no_auto_restore', 19:08:02 INFO - 'tabpaint']}, 19:08:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['a11yr', 19:08:02 INFO - 'ts_paint', 19:08:02 INFO - 'tpaint', 19:08:02 INFO - 'sessionrestore', 19:08:02 INFO - 'sessionrestore_no_auto_restore', 19:08:02 INFO - 'tabpaint']}, 19:08:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['tsvgx', 19:08:02 INFO - 'tsvgr_opacity', 19:08:02 INFO - 'tart', 19:08:02 INFO - 'tscrollx', 19:08:02 INFO - 'cart']}, 19:08:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:02 INFO - 'tsvgr_opacity', 19:08:02 INFO - 'tart', 19:08:02 INFO - 'tscrollx', 19:08:02 INFO - 'cart']}, 19:08:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'talos_options': ['--disable-e10s'], 19:08:02 INFO - 'tests': ['tp5o']}, 19:08:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'tests': ['tp5o']}, 19:08:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'talos_options': ['--disable-e10s', 19:08:02 INFO - '--xperf_path', 19:08:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:02 INFO - 'tests': ['tp5n']}, 19:08:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:02 INFO - 'talos_options': ['--xperf_path', 19:08:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:02 INFO - 'tests': ['tp5n']}}, 19:08:02 INFO - 'talos.zip': {'path': '', 19:08:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:02 INFO - Running post-action listener: _resource_record_post_action 19:08:02 INFO - [mozharness: 2016-08-26 02:08:02.863899Z] Finished populate-webroot step (success) 19:08:02 INFO - [mozharness: 2016-08-26 02:08:02.863988Z] Running create-virtualenv step. 19:08:02 INFO - Running pre-action listener: _resource_record_pre_action 19:08:02 INFO - Running main action method: create_virtualenv 19:08:02 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:02 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 19:08:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:02 INFO - Using real prefix '/usr' 19:08:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:05 INFO - Installing pip.................done. 19:08:05 INFO - Return code: 0 19:08:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:05 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 19:08:05 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 19:08:05 INFO - Using env: {'DISPLAY': ':0', 19:08:05 INFO - 'HOME': '/home/cltbld', 19:08:05 INFO - 'LANG': 'en_US.UTF-8', 19:08:05 INFO - 'LANGUAGE': 'en_US:en', 19:08:05 INFO - 'LOGNAME': 'cltbld', 19:08:05 INFO - 'MAIL': '/var/mail/cltbld', 19:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:05 INFO - 'MOZ_NO_REMOTE': '1', 19:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:05 INFO - 'NO_EM_RESTART': '1', 19:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:05 INFO - 'PWD': '/builds/slave/test', 19:08:05 INFO - 'SHELL': '/bin/bash', 19:08:05 INFO - 'SHLVL': '1', 19:08:05 INFO - 'TERM': 'linux', 19:08:05 INFO - 'TMOUT': '86400', 19:08:05 INFO - 'USER': 'cltbld', 19:08:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:05 INFO - '_': '/tools/buildbot/bin/python'} 19:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:05 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 19:08:05 INFO - Cleaning up... 19:08:05 INFO - Return code: 0 19:08:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:05 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 19:08:05 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 19:08:05 INFO - Using env: {'DISPLAY': ':0', 19:08:05 INFO - 'HOME': '/home/cltbld', 19:08:05 INFO - 'LANG': 'en_US.UTF-8', 19:08:05 INFO - 'LANGUAGE': 'en_US:en', 19:08:05 INFO - 'LOGNAME': 'cltbld', 19:08:05 INFO - 'MAIL': '/var/mail/cltbld', 19:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:05 INFO - 'MOZ_NO_REMOTE': '1', 19:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:05 INFO - 'NO_EM_RESTART': '1', 19:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:05 INFO - 'PWD': '/builds/slave/test', 19:08:05 INFO - 'SHELL': '/bin/bash', 19:08:05 INFO - 'SHLVL': '1', 19:08:05 INFO - 'TERM': 'linux', 19:08:05 INFO - 'TMOUT': '86400', 19:08:05 INFO - 'USER': 'cltbld', 19:08:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:05 INFO - '_': '/tools/buildbot/bin/python'} 19:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:05 INFO - Downloading/unpacking psutil>=3.1.1 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:07 INFO - Installing collected packages: psutil 19:08:07 INFO - Running setup.py install for psutil 19:08:07 INFO - building 'psutil._psutil_linux' extension 19:08:07 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 19:08:08 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 19:08:08 INFO - building 'psutil._psutil_posix' extension 19:08:08 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 19:08:08 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 19:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:08 INFO - Successfully installed psutil 19:08:08 INFO - Cleaning up... 19:08:08 INFO - Return code: 0 19:08:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:08 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 19:08:08 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 19:08:08 INFO - Using env: {'DISPLAY': ':0', 19:08:08 INFO - 'HOME': '/home/cltbld', 19:08:08 INFO - 'LANG': 'en_US.UTF-8', 19:08:08 INFO - 'LANGUAGE': 'en_US:en', 19:08:08 INFO - 'LOGNAME': 'cltbld', 19:08:08 INFO - 'MAIL': '/var/mail/cltbld', 19:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:08 INFO - 'MOZ_NO_REMOTE': '1', 19:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:08 INFO - 'NO_EM_RESTART': '1', 19:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:08 INFO - 'PWD': '/builds/slave/test', 19:08:08 INFO - 'SHELL': '/bin/bash', 19:08:08 INFO - 'SHLVL': '1', 19:08:08 INFO - 'TERM': 'linux', 19:08:08 INFO - 'TMOUT': '86400', 19:08:08 INFO - 'USER': 'cltbld', 19:08:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:08 INFO - '_': '/tools/buildbot/bin/python'} 19:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:08 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 19:08:08 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 19:08:08 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 19:08:08 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 19:08:08 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 19:08:08 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 19:08:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:10 INFO - Installing collected packages: mozsystemmonitor 19:08:10 INFO - Running setup.py install for mozsystemmonitor 19:08:10 INFO - Successfully installed mozsystemmonitor 19:08:10 INFO - Cleaning up... 19:08:10 INFO - Return code: 0 19:08:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08:10 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')]} 19:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:10 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')]} 19:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:10 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:10 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 19:08:10 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 19:08:10 INFO - Using env: {'DISPLAY': ':0', 19:08:10 INFO - 'HOME': '/home/cltbld', 19:08:10 INFO - 'LANG': 'en_US.UTF-8', 19:08:10 INFO - 'LANGUAGE': 'en_US:en', 19:08:10 INFO - 'LOGNAME': 'cltbld', 19:08:10 INFO - 'MAIL': '/var/mail/cltbld', 19:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:10 INFO - 'MOZ_NO_REMOTE': '1', 19:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:10 INFO - 'NO_EM_RESTART': '1', 19:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:10 INFO - 'PWD': '/builds/slave/test', 19:08:10 INFO - 'SHELL': '/bin/bash', 19:08:10 INFO - 'SHLVL': '1', 19:08:10 INFO - 'TERM': 'linux', 19:08:10 INFO - 'TMOUT': '86400', 19:08:10 INFO - 'USER': 'cltbld', 19:08:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:10 INFO - '_': '/tools/buildbot/bin/python'} 19:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:11 INFO - Downloading/unpacking jsonschema==2.5.1 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:11 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 19:08:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:13 INFO - warning: no files found matching '*.txt' 19:08:13 INFO - no previously-included directories found matching 'build' 19:08:13 INFO - no previously-included directories found matching 'dist' 19:08:13 INFO - no previously-included directories found matching '.git*' 19:08:13 INFO - Installing collected packages: jsonschema, functools32 19:08:13 INFO - Running setup.py install for functools32 19:08:13 INFO - warning: no files found matching '*.txt' 19:08:13 INFO - no previously-included directories found matching 'build' 19:08:13 INFO - no previously-included directories found matching 'dist' 19:08:13 INFO - no previously-included directories found matching '.git*' 19:08:13 INFO - Successfully installed jsonschema functools32 19:08:13 INFO - Cleaning up... 19:08:13 INFO - Return code: 0 19:08:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:08:13 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')]} 19:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 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')]} 19:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:13 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 19:08:13 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 19:08:13 INFO - Using env: {'DISPLAY': ':0', 19:08:13 INFO - 'HOME': '/home/cltbld', 19:08:13 INFO - 'LANG': 'en_US.UTF-8', 19:08:13 INFO - 'LANGUAGE': 'en_US:en', 19:08:13 INFO - 'LOGNAME': 'cltbld', 19:08:13 INFO - 'MAIL': '/var/mail/cltbld', 19:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:13 INFO - 'MOZ_NO_REMOTE': '1', 19:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:13 INFO - 'NO_EM_RESTART': '1', 19:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:13 INFO - 'PWD': '/builds/slave/test', 19:08:13 INFO - 'SHELL': '/bin/bash', 19:08:13 INFO - 'SHLVL': '1', 19:08:13 INFO - 'TERM': 'linux', 19:08:13 INFO - 'TMOUT': '86400', 19:08:13 INFO - 'USER': 'cltbld', 19:08:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:13 INFO - '_': '/tools/buildbot/bin/python'} 19:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:08:13 INFO - Cleaning up... 19:08:13 INFO - Return code: 0 19:08:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:13 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')]} 19:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 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')]} 19:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:13 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 19:08:13 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 19:08:13 INFO - Using env: {'DISPLAY': ':0', 19:08:13 INFO - 'HOME': '/home/cltbld', 19:08:13 INFO - 'LANG': 'en_US.UTF-8', 19:08:13 INFO - 'LANGUAGE': 'en_US:en', 19:08:13 INFO - 'LOGNAME': 'cltbld', 19:08:13 INFO - 'MAIL': '/var/mail/cltbld', 19:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:13 INFO - 'MOZ_NO_REMOTE': '1', 19:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:13 INFO - 'NO_EM_RESTART': '1', 19:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:13 INFO - 'PWD': '/builds/slave/test', 19:08:13 INFO - 'SHELL': '/bin/bash', 19:08:13 INFO - 'SHLVL': '1', 19:08:13 INFO - 'TERM': 'linux', 19:08:13 INFO - 'TMOUT': '86400', 19:08:13 INFO - 'USER': 'cltbld', 19:08:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:13 INFO - '_': '/tools/buildbot/bin/python'} 19:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:16 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 19:08:16 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 19:08:16 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 19:08:16 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 19:08:16 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 19:08:16 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 19:08:16 INFO - Downloading docopt-0.6.1.tar.gz 19:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:16 INFO - Running setup.py install for blobuploader 19:08:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:16 INFO - Running setup.py install for requests 19:08:17 INFO - Running setup.py install for docopt 19:08:17 INFO - Successfully installed blobuploader requests docopt 19:08:17 INFO - Cleaning up... 19:08:17 INFO - Return code: 0 19:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:17 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:17 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 19:08:17 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 19:08:17 INFO - Using env: {'DISPLAY': ':0', 19:08:17 INFO - 'HOME': '/home/cltbld', 19:08:17 INFO - 'LANG': 'en_US.UTF-8', 19:08:17 INFO - 'LANGUAGE': 'en_US:en', 19:08:17 INFO - 'LOGNAME': 'cltbld', 19:08:17 INFO - 'MAIL': '/var/mail/cltbld', 19:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:17 INFO - 'MOZ_NO_REMOTE': '1', 19:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:17 INFO - 'NO_EM_RESTART': '1', 19:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:17 INFO - 'PWD': '/builds/slave/test', 19:08:17 INFO - 'SHELL': '/bin/bash', 19:08:17 INFO - 'SHLVL': '1', 19:08:17 INFO - 'TERM': 'linux', 19:08:17 INFO - 'TMOUT': '86400', 19:08:17 INFO - 'USER': 'cltbld', 19:08:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:17 INFO - '_': '/tools/buildbot/bin/python'} 19:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:17 INFO - Running setup.py (path:/tmp/pip-FPMG0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:17 INFO - Running setup.py (path:/tmp/pip-tcYaKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:17 INFO - Running setup.py (path:/tmp/pip-q9Q3tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:17 INFO - Running setup.py (path:/tmp/pip-sNi0cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:17 INFO - Running setup.py (path:/tmp/pip-JD62Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:17 INFO - Running setup.py (path:/tmp/pip-WQ3iHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:17 INFO - Running setup.py (path:/tmp/pip-09V7VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:17 INFO - Running setup.py (path:/tmp/pip-57fv4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:17 INFO - Running setup.py (path:/tmp/pip-tXdle7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:18 INFO - Running setup.py (path:/tmp/pip-CHqeoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:18 INFO - Running setup.py (path:/tmp/pip-RQiDDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:18 INFO - Running setup.py (path:/tmp/pip-1x9Rm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:18 INFO - Running setup.py (path:/tmp/pip-wEo6kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:18 INFO - Running setup.py (path:/tmp/pip-821Pdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:18 INFO - Running setup.py (path:/tmp/pip-UcRbVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:18 INFO - Running setup.py (path:/tmp/pip-SuxQs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:18 INFO - Running setup.py (path:/tmp/pip-eDBnLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:18 INFO - Running setup.py install for manifestparser 19:08:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:18 INFO - Running setup.py install for mozcrash 19:08:18 INFO - Running setup.py install for mozdebug 19:08:18 INFO - Running setup.py install for mozdevice 19:08:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Running setup.py install for mozfile 19:08:19 INFO - Running setup.py install for mozhttpd 19:08:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Running setup.py install for mozinfo 19:08:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Running setup.py install for mozInstall 19:08:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Running setup.py install for mozleak 19:08:19 INFO - Running setup.py install for mozlog 19:08:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Running setup.py install for moznetwork 19:08:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Running setup.py install for mozprocess 19:08:19 INFO - Running setup.py install for mozprofile 19:08:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Running setup.py install for mozrunner 19:08:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:20 INFO - Running setup.py install for mozscreenshot 19:08:20 INFO - Running setup.py install for moztest 19:08:20 INFO - Running setup.py install for mozversion 19:08:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:20 INFO - Cleaning up... 19:08:20 INFO - Return code: 0 19:08:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:20 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:20 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 19:08:20 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 19:08:20 INFO - Using env: {'DISPLAY': ':0', 19:08:20 INFO - 'HOME': '/home/cltbld', 19:08:20 INFO - 'LANG': 'en_US.UTF-8', 19:08:20 INFO - 'LANGUAGE': 'en_US:en', 19:08:20 INFO - 'LOGNAME': 'cltbld', 19:08:20 INFO - 'MAIL': '/var/mail/cltbld', 19:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:20 INFO - 'MOZ_NO_REMOTE': '1', 19:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:20 INFO - 'NO_EM_RESTART': '1', 19:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:20 INFO - 'PWD': '/builds/slave/test', 19:08:20 INFO - 'SHELL': '/bin/bash', 19:08:20 INFO - 'SHLVL': '1', 19:08:20 INFO - 'TERM': 'linux', 19:08:20 INFO - 'TMOUT': '86400', 19:08:20 INFO - 'USER': 'cltbld', 19:08:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:20 INFO - '_': '/tools/buildbot/bin/python'} 19:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:20 INFO - Running setup.py (path:/tmp/pip-QLOEHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:20 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)) 19:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:20 INFO - Running setup.py (path:/tmp/pip-hpO_ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:20 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)) 19:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:20 INFO - Running setup.py (path:/tmp/pip-03KCPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:20 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)) 19:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:20 INFO - Running setup.py (path:/tmp/pip-aZAxwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:20 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)) 19:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:20 INFO - Running setup.py (path:/tmp/pip-tPV_8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:20 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)) 19:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:20 INFO - Running setup.py (path:/tmp/pip-FBb6oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:21 INFO - Running setup.py (path:/tmp/pip-5BGT0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:21 INFO - Running setup.py (path:/tmp/pip-pv3fJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:21 INFO - Running setup.py (path:/tmp/pip-uxyHD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:21 INFO - Running setup.py (path:/tmp/pip-jiE_1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:21 INFO - Running setup.py (path:/tmp/pip-wFzeKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:21 INFO - Running setup.py (path:/tmp/pip-es5dJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:21 INFO - Running setup.py (path:/tmp/pip-mNh_yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:21 INFO - Running setup.py (path:/tmp/pip-3Rh13Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:21 INFO - Running setup.py (path:/tmp/pip-dHTf4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:21 INFO - Running setup.py (path:/tmp/pip-Bj6vuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:21 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)) 19:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:21 INFO - Running setup.py (path:/tmp/pip-qg9NGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:21 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)) 19:08:21 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)) 19:08:21 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)) 19:08:21 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)) 19:08:21 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)) 19:08:21 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)) 19:08:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:21 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 19:08:21 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 19:08:21 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 19:08:21 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 19:08:21 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 19:08:21 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 19:08:23 INFO - Downloading blessings-1.6.tar.gz 19:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:23 INFO - Installing collected packages: blessings 19:08:23 INFO - Running setup.py install for blessings 19:08:23 INFO - Successfully installed blessings 19:08:23 INFO - Cleaning up... 19:08:23 INFO - Return code: 0 19:08:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:24 INFO - Reading from file tmpfile_stdout 19:08:24 INFO - Current package versions: 19:08:24 INFO - argparse == 1.2.1 19:08:24 INFO - blessings == 1.6 19:08:24 INFO - blobuploader == 1.2.4 19:08:24 INFO - docopt == 0.6.1 19:08:24 INFO - functools32 == 3.2.3-2 19:08:24 INFO - jsonschema == 2.5.1 19:08:24 INFO - manifestparser == 1.1 19:08:24 INFO - mozInstall == 1.12 19:08:24 INFO - mozcrash == 0.17 19:08:24 INFO - mozdebug == 0.1 19:08:24 INFO - mozdevice == 0.48 19:08:24 INFO - mozfile == 1.2 19:08:24 INFO - mozhttpd == 0.7 19:08:24 INFO - mozinfo == 0.9 19:08:24 INFO - mozleak == 0.1 19:08:24 INFO - mozlog == 3.3 19:08:24 INFO - moznetwork == 0.27 19:08:24 INFO - mozprocess == 0.23 19:08:24 INFO - mozprofile == 0.28 19:08:24 INFO - mozrunner == 6.12 19:08:24 INFO - mozscreenshot == 0.1 19:08:24 INFO - mozsystemmonitor == 0.3 19:08:24 INFO - moztest == 0.7 19:08:24 INFO - mozversion == 1.4 19:08:24 INFO - psutil == 3.1.1 19:08:24 INFO - requests == 1.2.3 19:08:24 INFO - wsgiref == 0.1.2 19:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:24 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')]} 19:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 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')]} 19:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:24 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 19:08:24 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 19:08:24 INFO - Using env: {'DISPLAY': ':0', 19:08:24 INFO - 'HOME': '/home/cltbld', 19:08:24 INFO - 'LANG': 'en_US.UTF-8', 19:08:24 INFO - 'LANGUAGE': 'en_US:en', 19:08:24 INFO - 'LOGNAME': 'cltbld', 19:08:24 INFO - 'MAIL': '/var/mail/cltbld', 19:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:24 INFO - 'MOZ_NO_REMOTE': '1', 19:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:24 INFO - 'NO_EM_RESTART': '1', 19:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:24 INFO - 'PWD': '/builds/slave/test', 19:08:24 INFO - 'SHELL': '/bin/bash', 19:08:24 INFO - 'SHLVL': '1', 19:08:24 INFO - 'TERM': 'linux', 19:08:24 INFO - 'TMOUT': '86400', 19:08:24 INFO - 'USER': 'cltbld', 19:08:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:24 INFO - '_': '/tools/buildbot/bin/python'} 19:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 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)) 19:08:24 INFO - Cleaning up... 19:08:24 INFO - Return code: 0 19:08:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:24 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')]} 19:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 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')]} 19:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 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 0x7f2336a8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, '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': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', '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 19:08:24 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 19:08:24 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 19:08:24 INFO - Using env: {'DISPLAY': ':0', 19:08:24 INFO - 'HOME': '/home/cltbld', 19:08:24 INFO - 'LANG': 'en_US.UTF-8', 19:08:24 INFO - 'LANGUAGE': 'en_US:en', 19:08:24 INFO - 'LOGNAME': 'cltbld', 19:08:24 INFO - 'MAIL': '/var/mail/cltbld', 19:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:24 INFO - 'MOZ_NO_REMOTE': '1', 19:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:24 INFO - 'NO_EM_RESTART': '1', 19:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:24 INFO - 'PWD': '/builds/slave/test', 19:08:24 INFO - 'SHELL': '/bin/bash', 19:08:24 INFO - 'SHLVL': '1', 19:08:24 INFO - 'TERM': 'linux', 19:08:24 INFO - 'TMOUT': '86400', 19:08:24 INFO - 'USER': 'cltbld', 19:08:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:24 INFO - '_': '/tools/buildbot/bin/python'} 19:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:24 INFO - Cleaning up... 19:08:24 INFO - Return code: 0 19:08:24 INFO - Running post-action listener: _resource_record_post_action 19:08:24 INFO - Running post-action listener: _start_resource_monitoring 19:08:24 INFO - Starting resource monitoring. 19:08:24 INFO - [mozharness: 2016-08-26 02:08:24.670648Z] Finished create-virtualenv step (success) 19:08:24 INFO - [mozharness: 2016-08-26 02:08:24.671104Z] Running install step. 19:08:24 INFO - Running pre-action listener: _resource_record_pre_action 19:08:24 INFO - Running main action method: install 19:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:24 INFO - Reading from file tmpfile_stdout 19:08:24 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:24 INFO - Reading from file tmpfile_stdout 19:08:24 INFO - Output received: 19:08:24 INFO - Usage: mozinstall [options] installer 19:08:24 INFO - Options: 19:08:24 INFO - -h, --help show this help message and exit 19:08:24 INFO - -d DEST, --destination=DEST 19:08:24 INFO - Directory to install application into. [default: 19:08:24 INFO - "/builds/slave/test"] 19:08:24 INFO - --app=APP Application being installed. [default: firefox] 19:08:24 INFO - mkdir: /builds/slave/test/build/application 19:08:24 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'] 19:08:24 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 19:08:42 INFO - Reading from file tmpfile_stdout 19:08:42 INFO - Output received: 19:08:42 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:42 INFO - Running post-action listener: _resource_record_post_action 19:08:42 INFO - [mozharness: 2016-08-26 02:08:42.022922Z] Finished install step (success) 19:08:42 INFO - [mozharness: 2016-08-26 02:08:42.023260Z] Running run-tests step. 19:08:42 INFO - Running pre-action listener: _resource_record_pre_action 19:08:42 INFO - Running main action method: run_tests 19:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:42 INFO - Python 2.7.3 19:08:42 INFO - Return code: 0 19:08:42 INFO - grabbing minidump binary from tooltool 19:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:42 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 0x2774370>, '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 0x27778f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2777d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:42 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 19:08:42 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 19:08:42 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 19:08:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:42 INFO - Return code: 0 19:08:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:42 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/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 19:08:42 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/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 19:08:42 INFO - Using env: {'DISPLAY': ':0', 19:08:42 INFO - 'HOME': '/home/cltbld', 19:08:42 INFO - 'LANG': 'en_US.UTF-8', 19:08:42 INFO - 'LANGUAGE': 'en_US:en', 19:08:42 INFO - 'LOGNAME': 'cltbld', 19:08:42 INFO - 'MAIL': '/var/mail/cltbld', 19:08:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:42 INFO - 'MOZ_NO_REMOTE': '1', 19:08:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:42 INFO - 'NO_EM_RESTART': '1', 19:08:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:42 INFO - 'PWD': '/builds/slave/test', 19:08:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:42 INFO - 'SHELL': '/bin/bash', 19:08:42 INFO - 'SHLVL': '1', 19:08:42 INFO - 'TERM': 'linux', 19:08:42 INFO - 'TMOUT': '86400', 19:08:42 INFO - 'USER': 'cltbld', 19:08:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181', 19:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:42 INFO - '_': '/tools/buildbot/bin/python'} 19:08:42 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/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 19:08:42 INFO - mozversion application_buildid: 20160825173002 19:08:42 INFO - mozversion application_changeset: b76313e48f6b443b0f4701621f01510f06455c83 19:08:42 INFO - mozversion application_display_name: Nightly 19:08:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:42 INFO - mozversion application_name: Firefox 19:08:42 INFO - mozversion application_remotingname: firefox 19:08:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:08:42 INFO - mozversion application_vendor: Mozilla 19:08:42 INFO - mozversion application_version: 51.0a1 19:08:42 INFO - mozversion platform_buildid: 20160825173002 19:08:42 INFO - mozversion platform_changeset: b76313e48f6b443b0f4701621f01510f06455c83 19:08:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:08:42 INFO - mozversion platform_version: 51.0a1 19:08:42 INFO - using testdate: 1472177322 19:08:42 INFO - actual date: 1472177322 19:08:42 INFO - starting webserver on 'localhost:44133' 19:08:42 INFO - SUITE-START | Running 2 tests 19:08:42 INFO - TEST-START | dromaeo_css 19:08:42 INFO - operating with platform_type : linux_ 19:08:42 INFO - Initialising browser for dromaeo_css test... 19:08:42 INFO - TEST-INFO | started process 2720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7ZiXVc/profile http://localhost:44133/getInfo.html) 19:08:46 INFO - PROCESS | 2720 | __metrics Screen width/height:1600/1200 19:08:46 INFO - PROCESS | 2720 | colorDepth:24 19:08:46 INFO - PROCESS | 2720 | Browser inner width/height: 1024/697 19:08:46 INFO - PROCESS | 2720 | __metrics 19:08:47 INFO - PROCESS | 2720 | 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" 19:08:47 INFO - PROCESS | 2720 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:08:47 INFO - PROCESS | 2720 | console.error: PushService: 19:08:47 INFO - PROCESS | 2720 | stateChangeProcessEnqueue: Error transitioning state 19:08:47 INFO - PROCESS | 2720 | UnknownError 19:08:48 INFO - TEST-INFO | 2720: exit 0 19:08:48 INFO - Browser initialized. 19:08:48 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:48 INFO - TEST-INFO | started process 2882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7ZiXVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:00 INFO - PROCESS | 2882 | RSS: Main: 179630080 19:09:00 INFO - PROCESS | 2882 | 19:09:52 INFO - PROCESS | 2882 | 1472177392300 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] 19:12:01 INFO - PROCESS | 2882 | Cycle 1(1): loaded http://localhost:44133/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44133/tests/dromaeo/cssquery-ext.html) 19:12:02 INFO - PROCESS | 2882 | RSS: Main: 293904384 19:12:02 INFO - PROCESS | 2882 | 19:15:05 INFO - PROCESS | 2882 | Cycle 1(1): loaded http://localhost:44133/tests/dromaeo/cssquery-ext.html (next: http://localhost:44133/tests/dromaeo/cssquery-jquery.html) 19:15:05 INFO - PROCESS | 2882 | RSS: Main: 272478208 19:15:05 INFO - PROCESS | 2882 | 19:18:07 INFO - PROCESS | 2882 | Cycle 1(1): loaded http://localhost:44133/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44133/tests/dromaeo/cssquery-mootools.html) 19:18:08 INFO - PROCESS | 2882 | RSS: Main: 260464640 19:18:08 INFO - PROCESS | 2882 | 19:21:10 INFO - PROCESS | 2882 | Cycle 1(1): loaded http://localhost:44133/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44133/tests/dromaeo/cssquery-prototype.html) 19:21:11 INFO - PROCESS | 2882 | RSS: Main: 215633920 19:21:11 INFO - PROCESS | 2882 | 19:24:13 INFO - PROCESS | 2882 | Cycle 1(1): loaded http://localhost:44133/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44133/tests/dromaeo/cssquery-yui.html) 19:24:14 INFO - PROCESS | 2882 | RSS: Main: 214593536 19:24:14 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | Cycle 1(1): loaded http://localhost:44133/tests/dromaeo/cssquery-yui.html (next: http://localhost:44133/tests/dromaeo/cssquery-dojo.html) 19:27:17 INFO - PROCESS | 2882 | RSS: Main: 307953664 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | __start_tp_report 19:27:17 INFO - PROCESS | 2882 | _x_x_mozilla_page_load 19:27:17 INFO - PROCESS | 2882 | _x_x_mozilla_page_load_details 19:27:17 INFO - PROCESS | 2882 | |i|pagename|runs| 19:27:17 INFO - PROCESS | 2882 | |0;dojo.html;2986.372861699044;3011.23213580537;3022.048054862718;3055.3125546752;3070.9385812283754;5144.279800827887;5218.21726740989;5244.685318880865;5249.86875328117;5326.707031113292;5262.736863156846;5271.15661494161;5308.389535203452;5322.680639161653;5382.650127741694;4693.460252071004;4786.976065119669;4793.616510679138;4807.687500312469;4972.70163790172;4856.444261490161;4878.634102442331;4914.877128071791;4925.359703238574;4960.007998400316;4762.357081793948;4765.8570242892765;4812.542808433193;4838.274258861164;4865.708057516525;4736.59738922192;4743.1699452596;4744.7627618618935;4795.112904112751;4857.611391088704;4747.074320507502;4758.381410416659;4759.333693282943;4772.045590881838;4815.205491093965;5152.742362881841;5214.270002199695;5270.209468579744;5354.759035843396;5358.303420555303;5590;5635.746391412396;5641.52047075995;5643;5653.152027195953;5630.071038278679;5671.9716401418145;5673.574481913873;5674.4892959633835;5689.943100569024;5091.389033315989;5171.948280517185;5213.244079608436;5224.973875130638;5300.840974770763;5718.428157184331;5724.1413787931315;5726.312842458931;5729.8567535811935;5730.885382292331;5474.370447398521;5481.643693159932;5489.204065410493;5489.505944465017;5495.175723641486;5502.449755024546;5546.528545073633;5631.887362252814;5640.689762063043;5714.771409143587;5646.717664116778;5648.6893220872425;5650.180723795027;5652.0391533439415;5709.7716091356715;5606.943930560724;5646.520045796071;5650.26546548946;5663.377028526858;5665.12190610456;4198.3702444633545;4293.892652683708;4363.105563359503;4372.890677733082;4447.2217361962175;3889.5138107736534;3890.533136023695;3897;3942.2706799242233;3948.6446219840354;5367.5169234769055;5371.892562148735;5372.650777699437;5376.623636345418;5436;5509.146082357241;5619.578531610146;5633.57748168889;5670.659760414388;5702.258706368229;5389.568834493231;5403.189521571717;5426.104692725735;5452.04589196889;5464.453554644504;4878.390201224847;4905.779239934212;4908.460069392364;4919.606431485473;4966.553010229097;5664.915026274609;5668.121441176624;5727.2268243787385;5727.770889164387;5878.11828225761;5564.276644036249;5569.192467092168;5626.127950167731;5627.409122042291;5631.380548139619;5728.369879313355;5730.484256416942;5732.111522713986;5741.569382296428;5743.4543718346695;5359.892802144013;5425.620206585501;5479.7122676170275;5483.725813709379;5485.040117979417;5627.831165065055;5628.971855140698;5637.746301416364;5723.427657234243;5731.8853622928145;5436.130219164915;5474.178873169057;5494.945050549443;5499.670019798825;5511.779528818963;5335.253064570886;5455.263539422127;5457.645253058538;5466.91799623014;5524.8342549723575;5473.781048758165;5505.064139096443;5516.200150978166;5571.498565129158;5576.693281869536;5530.640508366943;5533.474319939599;5536.916946245729;5544.251526043932;5566.081596536526;5219.19102539107;5264.210368444611;5399.433059528693;5431.837044888502;5440.129579267298 19:27:17 INFO - PROCESS | 2882 | |1;ext.html;554.5425024354905;592.8103007037744;604.3050491934275;614.1095411653104;623.0280762011262;31799.68200317996;44058.55941440585;45038;45124.32313515296;45164.774176129155;45884.4115588441;46243.30635040469;46479.30281045787;46492.767536162355;46553.30170047452;8925.375223734358;9074.637014519445;9097.681581144661;9102.271818254523;9103.180713735763;8994.145556172152;9073.274138068971;9091.954540227289;9092.22716069135;9095.363324567283;9076.591553380114;9127.95436022819;9129.041450647686;9132.315076369267;9136.177744003038;9024.684136055239;9108.453492790453;9118.58966346516;9124.771880703001;9128.497932613704;8955.104489551059;9021.819563608757;9027.503487308195;9028.683996060172;9029;43147.568524314665;43462.565374346486;43488.130237395395;43530.564694352965;43561.128777424274;3224.5808044954006;3408.3694516514274;3419.743519236067;3425.2122011937145;3445.7415693823064;32597.83701081503;32602.6739732602;32727.345453090806;33094.6690533094;33248.66751332504;4065.7560546367313;4097.508299004109;4130.648894843942;4134.441850350225;4159.854405095837;368791;370658;371390;372210;372643;50602.240966385536;58725.41274587285;58776.70611646914;59061;59136;58123;59046.704766475894;59855.102173467436;64565.67717161384;64614.35385646083;17384.913075434793;17530.386436474662;17556.473305800846;17562.912185438992;17569.472915812545;11313.208075434804;13628.863711362957;13705;13723.245221512712;13723.794143087862;15943.44197953066;16422.75365869513;16456.20244558428;16559.25483353252;16697;5835.620684655484;5842.298924129132;5860.560457965669;5868.38381969887;5898.705064746746;965.2229954886244;1013.9188864890791;1034.6482196053378;1069.9786004280027;1106.5186643809807;33078.834605826814;33591.152486612984;33757.32485350328;36283.637163628555;36495.81752091223;1030.2479190191202;1115.7043383503378;1117.0895719988184;1159.5303901919735;1176.7881781279282;15815.102187737315;16835.326586936386;17048.14759262032;17160.22778974949;17372.47882563525;524604;524746;524867;525633;526845;58105.418945810845;58282.4171758277;58320.12519812206;58339.70830145907;58348;1236.2644226685109;1273.891719203878;1340.9664758380923;1386.0851837787013;1396.3646540823697;31434.52848207233;32801.179970500925;34048.48927266044;34481.482777757854;34543;50007;50636.64495358225;50649.240261396844;50710;50738.746306269706;390546;390858;392630;395543;398580;27509.44981100407;28376.716232837407;28441.28896777597;29188.27029324284;29201.85399072991;47626.76186619045;48368;48456;48635.27047094367;48678;40352;41127.58872411357;41766.80351203121;42063.78968105262;43481.78259108684;41910.16179676451;42286.1542769149;42487.5751242496;42542.36186457144;43473.782631086644;41631.37552936648;41648;41763.7911810439;42217;42310.57689423066;35264.82367588145;37027;37575.624243757215;38136.42795358016;38191;28604;28732.13803585896;28764.85617571899;28898.711012889602;28964 19:27:17 INFO - PROCESS | 2882 | |2;jquery.html;371.8271003983147;377.25303898281385;388.69487452349904;396.9603039696031;413.4604341334557;16796.66406671866;19144.808551914477;19266.90366548167;20046.799532004712;20228.494287642818;18982.715259271088;19157.137928793203;19703.704444433344;19724.605507889835;19874.503137421572;5588.189712491686;5691.857703557403;5791.826245212629;5904.291485021782;5904.61619994699;5726.7422965966425;5733.197352370671;5753.424657534255;5760;5763.5101016413655;5575.832725018256;5733.340665823421;5750.281214848144;5769.192313076152;5786.942130578704;5716.085426331788;5722.599418040739;5756.568257380693;5759.5968282220265;5759.68321742304;5090.33825602673;5197.116490196676;5354.651947623392;5387.299651045339;5396.973015134939;12471.438785254686;12633.368331583384;12878;13085.28030958297;13087.41106650203;2028.513156842362;2116.1429621003517;2297.184499502686;2355.1756885090253;2364.2810767617207;9583.616655333779;9586.952065239699;9618.086281803218;9829;9873.753156171082;1826.205600563759;1847.7228415737613;1880.8683392162554;1894.8578856585812;1898.6582415165265;79899.6005019977;85697.57151214266;86891.56554217188;88226;89658.5517072417;11191.2725672831;11393.829092563617;11404.657860264206;11490.253133546294;11544.422778861024;15753;15818.60453488672;15893.125878076817;15933.203339832962;15968.92015539938;8379.62291696875;8426.662933482592;8559.315254779603;8666.696665616673;8688.6524539019;8143.470674406145;8157.184281571914;8236.50580965144;8322.45904016237;8432.114627963976;4675.859724208279;4816.590589799906;4871.658983871095;4894.556105948754;5004.624653151028;1797.70337894246;1871.6163186546726;1985.4837742187135;1986.5133042404702;1989.592133612606;913.3469569258012;954.5704433005176;972.8394814855611;977.2572844637984;1033.7674023344687;18605.976671282937;19399.612007760046;19643.214271429268;19667.704984425243;19914.469207424612;1015.4770293298957;1024.6618615856748;1034.3690348887174;1053.5469748008277;1069.0699091790036;10109.747256318651;10921.563137474572;10925.603980576856;10978.346151731865;11067.446627668583;422724;438958;496290;498650;503917;68573.65713171502;73031.63484182545;96772.51613742027;97713;100087;997.4663554998041;1002.183220675162;1035.896410358958;1035.9689209323733;1045.310095337089;17707.73438398451;17952.486651868487;18568;18706.906465467586;19024.52438689044;40149.397759033054;44417.223311067195;44798.16032194418;45403.77298113621;45439.22888096702;51933;59942.700286498286;60559.39440605538;61807.690961544904;63140.68429657822;7958.243966823143;8220.491312162781;8443.493390396596;8478.618462169341;8759.299256059627;9360.953195234253;13037.217766934014;13554.322283885964;13749.312534373441;13919;5746.712664366682;8969.416987895765;9345.392549484262;11737.823932640846;11852.466639001437;11454.599089031844;11675.124365672438;11718;11731.88268117308;11826.822597661214;11961.342126183143;12085.456154472893;12274.202176858833;12363.258204507758;12668.493260269486;7970.641321140447;7993.400494963017;7996.920030799618;8301.169883011651;8491.95754021226;9209.355345125778;11588.536458541901;11932.105092117952;11963.461644226205;12345.753084938431 19:27:17 INFO - PROCESS | 2882 | |3;mootools.html;1467.9192644404561;1474.616599684082;1611.7179493588626;1744.4243399678107;1784.6430713857233;7460.477766556343;8111.269985701286;8237.299829514484;8745.256653184479;8753.16844899735;8276.958615206931;8476.067632560413;8579.78550536237;8592.226699597035;8602.139786021395;2314.421394651333;2346.3312955807596;2349.3774149850306;2358.0921345282018;2359.6106642403984;1996.4110587376758;2218.689383486313;2263.298377502971;2287.839851210416;2293.0369244917174;2291.6218823894037;2310.07596961216;2310.792028717415;2325.3140323604493;2326.7556906524824;2205.7463391709916;2234.0393630738777;2279.988600057006;2283.828712846543;2284.371797755614;2242.674812152245;2245.36007237938;2246.1913711064003;2246.674232236333;2263.2870645746702;8516.06323304436;8543.572821358906;8599.656013759504;8601.354898382646;8629.309655227567;4902.558769710708;5047.4447810740785;5052.545270925598;5053.343065401475;5057.064443078006;3172;3217.324361884007;3263.902082937516;3284.687954644305;3291.8189499577516;1065.4619417194344;1088.9618863339745;1101.4437708956925;1106.8505751723494;1130.4686797205381;11313.83029254562;11364.204505684605;11367.829482557769;11376.544938202462;11384.203105782599;4135.97932010338;4246.766427846436;4382.8904277392685;4385.640451460057;4404.867853964386;9636.084571965652;9656.034396560288;9658.90341096594;9662.420254784594;9672.75818104539;5008.649394542347;5009.44896061433;5018.824341148115;5029.195328747456;5029.497050295015;4590;4641.976790116096;4643.048175124091;4657.138429390574;4659.9767001165455;3895.5520115187114;3913.9804300978312;3993.5207775066597;4017.2568074906235;4019.31671615826;1155.6764106050318;1240.4665993622648;1259.9370031498388;1273.178799674205;1285.4344088600985;814.9837003259902;931.9487428191379;937.8780758501488;977.1010670183448;1003.8243307421172;5907.227831650488;5962.25471816023;5987.670678112659;6032.39676032402;6103.35914728956;993.6124911284605;1026.7227848480868;1028.5702873006526;1048.6749107776614;1068.9946550267198;4041.1513582148077;4125.463689720317;4164.208800327928;4190.497140343117;4199.811008504625;10095.394276343442;10308.484575771181;10356.741081473023;10661.253712240068;10662.73343166427;9957.103860652576;10133.695989120339;10163.898361016296;10166.186705063577;10173;7887.44787864844;7925.564093974772;7967.28294453502;8023.117457079717;8025.919740802634;5848.766049357978;5887.61730487517;5932.703364831655;6036.33600303975;6182.196314479089;9708.902910970799;9771.462569558742;9822.361546499455;9845.556949937127;9897.752556186153;9570.425774453555;9891.109800117736;10207.897921020694;10241.436720980417;10241.975802419996;7277.526960747535;7415.555066696015;7426.702931882664;7427.925720742724;7433.739819106306;8294.129116442688;8307.044689860744;8315.542645154575;8317.41778075529;8363.581820908808;7339.339459448462;7467.141278753013;7496;7542.698292068256;7622.8094297643;7261.491695581259;7338.376238019828;7386.519876208029;7587.089549254125;7606.847863042819;6771.966140169267;6877.793666190022;6881.518293719391;6883.414909732529;6888.7244510221035;5125.205593133071;5163.148080566814;5252.343457067866;5268.1834315681135;5384.138537833927;5165.974170129125;5340.465953404629;5430.294061771944;5433.864153396196;5450.863728406822 19:27:17 INFO - PROCESS | 2882 | |4;prototype.html;311.78331059913353;316.83682903304805;317.87443959635937;318.14577858450065;320.70014536408445;5292.894142117156;5308.389535203452;5319.335083114615;5320.068987927112;5340.385855626604;5227.3465816772905;5255.658382205154;5258.421573626898;5261.815836445725;5264.8157314494;3858.459815625815;3932.6067393260587;4042.6967977401664;4075.8777236682945;4078.1843631273714;4061.817218225187;4062.5531191568903;4067.9220006698247;4091.3862920562005;4109.363048727437;4029.4560234368278;4033.37482690182;4040.979795101035;4047.6761859051207;4060.4924384451942;3817.4273858921106;3952.901177470572;4051.513818341818;4054.16889537647;4068.9186216275507;3567.2865426914723;3573.231755172624;3575.497151993589;3575.910602234939;3595.9101022474388;5107.361579802525;5115.309433226504;5131.7434128293435;5145.562627176694;5157.613179011551;4473.261911784584;4605.792739326738;4607;4609.640156153942;4653.673702994631;5386.622936394454;5395.163749618815;5396.163594642837;5432.212329212242;5454.754536045887;3904.531456225243;3906.867008567512;3923.98038009811;3928;3929.7052721046034;5529.3364796224305;5627.324721033461;5636.4927156556105;5661.348944871352;5696.544276457874;3998.9200215996098;4004.619561141687;4006.017021574339;4010.27814993304;4012.237674841829;4046.3728122141115;4060.127072679388;4060.8578699745367;4061.5126184858004;4063.5326937401987;4346.8043938022865;4573.588377046081;4641.767911604406;4650.279206722963;4680.602148817321;5488.670679759227;5491.007400966483;5506.587005974568;5510.889782204334;5518.613697041249;1340.3164386163128;1344.4471635261289;1353.458616553367;1366.8086467894304;1367.3300082959477;820.4707963363597;870.7779516223322;874.3529787956993;884.4958373727043;889.0975659705405;5085.525197692702;5165.638405311592;5236.764345604381;5245.659032162897;5245.6852588844795;5540.390557038722;5586.860328491739;5593.021221286259;5598.608097433141;5611.859703507445;5145.511176438233;5264.894702105937;5296.576273898079;5303;5306.787728490895;2904.954216482107;2920.7225313595172;2941.2793865502663;2949.510497198901;2950.6754257031707;5732.914006289909;5751.482366587027;5758.452946970031;5797.36229014808;5813.5349172066135;5478.780848766005;5703.429657034347;5730.255066841367;5731.570132240098;5732.598718089694;5764.510016648548;5809.593328466966;5825.825225243249;5828.388019257917;5834.299884013945;5379.462053794589;5612.045952188219;5622.3815380307315;5654.06707893193;5659.434056594308;5606.813342796231;5640.971795140998;5644.604877658525;5646.971765141312;5659.434056594472;5852.736626851887;5874.970625146847;5886.323072846678;5887.586979124893;5888.17565540816;3768.1521657626813;3934.15415685629;3955.6044395560216;3971.4439978403625;4019.1760689058087;5620.072688006433;5640.364294354756;5647.124695672177;5650.180723795109;5665.150227465749;5493.258410114583;5495.845872366848;5503.834884953458;5524.33707955048;5531.446855314436;5213.374395072464;5488.259085023471;5501.807436739695;5537.501624853782;5537.889242215053;5483.204935284281;5489.258950041853;5502.944970550243;5506.752196151263;5529.087700529368;5322.494363035506;5423.891522169613;5519.420460851553;5554.055810512304;5582.8325150245555;5420.457954204548;5425.287356321839;5427.565794736491;5438.3413059017375;5440.972795136157 19:27:17 INFO - PROCESS | 2882 | |5;yui.html;766.4366690482494;775.9068911730592;782.808211988063;799.0291795468505;846.2214762418574;16172.433964811235;16955.491335259932;17072;17089.316427342907;17135.057571833546;15269.847301526981;15442.845571544281;15453;15457.45898893539;15461.845381546182;655.3642966322683;797.3979645367739;800.0998876264202;814.1939479914901;815.0667485728837;810.2100452059225;811.817341098254;812.8455593437258;813.1665043330574;813.8331642013374;867.9392442529025;869.8651708985118;870.412471581683;870.412471581683;870.8127752533204;696.6969368324795;833.6373677450298;844.0293662288417;856.1652388920814;866.9653213871469;616.7594638091103;620.10394979255;620.3548309757891;620.8168590265838;622.3651875087386;15138.772918406232;15338.233088345538;15366.231688415646;15384.846151538453;15391.61520961985;14292.642683932881;14478;14689.118652880861;14792.778108328384;15128.697426051418;13670.658233544142;13677.31613419325;13814.585562433043;13927.442902283998;13983.79024314636;3868.4390763339156;3872.3417019106537;3901.531816182048;3983.920321593581;4085.407615895708;75764;76664.23335766683;76862.61568692177;77317;77444.22555774427;10977.506012229469;11422.543098275975;11491.885081149248;11510.654680359603;11649.708757281136;20131.19475221004;20140.39578812638;20142.69785953212;20164.798352016587;20172.19311227564;8226.300764434971;8378.748637540884;8509.659613615386;8533.018702849127;8546.31629469641;4724.692894961817;4848.593015646411;4901.877453063702;4942.406911170682;4990.700557966461;3509.298140371936;3667.889963301105;3670.5778835433734;3671.100580357776;3672.9632703672623;586.6099044135602;588.9558283128697;597.116267923467;600.1717629671114;600.9729562169713;571.9227904232876;657.0899304463353;668.314977148417;688.2841844481783;689.0938415982966;9128.132827381389;9679.274054445945;10041.899581004243;10377.584896604052;10646.680599582025;575.2923903598597;609.3510411411833;666.4834753066316;681.2744427185032;696.9686364113627;4513.480949690827;4732.455767586772;4832.49258827818;4833.637477189154;4869.537393947569;66675.33324666788;71819;95746;110976;115812;98256.50871745739;101038;101495;104632;105407.47296263622;54196;75396.62301688457;79859.60070199727;85502.14497855066;88360.55819720861;8796.560171991503;8805.559722013746;8848.734537963872;9016.774580635536;9027.877872156465;47821.521784781704;48293.75853120712;49741;50136;50262.74868625634;68834.65582672054;69804.65097674479;73876;77461.61269193619;78972.60513697394;10902.509387077442;10996.670099897015;11132.472123878417;11339.659810205707;11345.319280843176;12864.163829351062;12898.67753306175;12900.161489503153;13059.542915997894;13529;12262.570810021607;12355.3822308886;12467;12728.299943503196;12744;12093.37198840362;12182.269063856196;12629.895284032542;12677.17598356104;12867.613971580868;11403.942980285046;11646.70883227926;11908.76182476363;12079.57721479744;12775.808362874379;10354.378737275787;10400.167986561208;10634.30876992993;10642.521086551278;10812.621558245424;9916.157126644028;10482.895171048192;10523.263371564224;10528.473576321;10553.577856885639 19:27:17 INFO - PROCESS | 2882 | __end_tp_report 19:27:17 INFO - PROCESS | 2882 | __start_cc_report 19:27:17 INFO - PROCESS | 2882 | _x_x_mozilla_cycle_collect,932 19:27:17 INFO - PROCESS | 2882 | __end_cc_report 19:27:17 INFO - PROCESS | 2882 | __startTimestamp1472178437384__endTimestamp 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | ------- Summary: start ------- 19:27:17 INFO - PROCESS | 2882 | Number of tests: 6 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | [#0] dojo.html Cycles:165 Average:5233.09 Median:5452.05 stddev:579.86 (10.6%) stddev-sans-first:554.20 19:27:17 INFO - PROCESS | 2882 | Values: 2986.4 3011.2 3022.0 3055.3 3070.9 5144.3 5218.2 5244.7 5249.9 5326.7 5262.7 5271.2 5308.4 5322.7 5382.7 4693.5 4787.0 4793.6 4807.7 4972.7 4856.4 4878.6 4914.9 4925.4 4960.0 4762.4 4765.9 4812.5 4838.3 4865.7 4736.6 4743.2 4744.8 4795.1 4857.6 4747.1 4758.4 4759.3 4772.0 4815.2 5152.7 5214.3 5270.2 5354.8 5358.3 5590.0 5635.7 5641.5 5643.0 5653.2 5630.1 5672.0 5673.6 5674.5 5689.9 5091.4 5171.9 5213.2 5225.0 5300.8 5718.4 5724.1 5726.3 5729.9 5730.9 5474.4 5481.6 5489.2 5489.5 5495.2 5502.4 5546.5 5631.9 5640.7 5714.8 5646.7 5648.7 5650.2 5652.0 5709.8 5606.9 5646.5 5650.3 5663.4 5665.1 4198.4 4293.9 4363.1 4372.9 4447.2 3889.5 3890.5 3897.0 3942.3 3948.6 5367.5 5371.9 5372.7 5376.6 5436.0 5509.1 5619.6 5633.6 5670.7 5702.3 5389.6 5403.2 5426.1 5452.0 5464.5 4878.4 4905.8 4908.5 4919.6 4966.6 5664.9 5668.1 5727.2 5727.8 5878.1 5564.3 5569.2 5626.1 5627.4 5631.4 5728.4 5730.5 5732.1 5741.6 5743.5 5359.9 5425.6 5479.7 5483.7 5485.0 5627.8 5629.0 5637.7 5723.4 5731.9 5436.1 5474.2 5494.9 5499.7 5511.8 5335.3 5455.3 5457.6 5466.9 5524.8 5473.8 5505.1 5516.2 5571.5 5576.7 5530.6 5533.5 5536.9 5544.3 5566.1 5219.2 5264.2 5399.4 5431.8 5440.1 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | [#1] ext.html Cycles:180 Average:59620.90 Median:41838.48 stddev:115206.76 (275.4%) stddev-sans-first:115444.59 19:27:17 INFO - PROCESS | 2882 | Values: 554.5 592.8 604.3 614.1 623.0 31799.7 44058.6 45038.0 45124.3 45164.8 45884.4 46243.3 46479.3 46492.8 46553.3 8925.4 9074.6 9097.7 9102.3 9103.2 8994.1 9073.3 9092.0 9092.2 9095.4 9076.6 9128.0 9129.0 9132.3 9136.2 9024.7 9108.5 9118.6 9124.8 9128.5 8955.1 9021.8 9027.5 9028.7 9029.0 43147.6 43462.6 43488.1 43530.6 43561.1 3224.6 3408.4 3419.7 3425.2 3445.7 32597.8 32602.7 32727.3 33094.7 33248.7 4065.8 4097.5 4130.6 4134.4 4159.9 368791.0 370658.0 371390.0 372210.0 372643.0 50602.2 58725.4 58776.7 59061.0 59136.0 58123.0 59046.7 59855.1 64565.7 64614.4 17384.9 17530.4 17556.5 17562.9 17569.5 11313.2 13628.9 13705.0 13723.2 13723.8 15943.4 16422.8 16456.2 16559.3 16697.0 5835.6 5842.3 5860.6 5868.4 5898.7 965.2 1013.9 1034.6 1070.0 1106.5 33078.8 33591.2 33757.3 36283.6 36495.8 1030.2 1115.7 1117.1 1159.5 1176.8 15815.1 16835.3 17048.1 17160.2 17372.5 524604.0 524746.0 524867.0 525633.0 526845.0 58105.4 58282.4 58320.1 58339.7 58348.0 1236.3 1273.9 1341.0 1386.1 1396.4 31434.5 32801.2 34048.5 34481.5 34543.0 50007.0 50636.6 50649.2 50710.0 50738.7 390546.0 390858.0 392630.0 395543.0 398580.0 27509.4 28376.7 28441.3 29188.3 29201.9 47626.8 48368.0 48456.0 48635.3 48678.0 40352.0 41127.6 41766.8 42063.8 43481.8 41910.2 42286.2 42487.6 42542.4 43473.8 41631.4 41648.0 41763.8 42217.0 42310.6 35264.8 37027.0 37575.6 38136.4 38191.0 28604.0 28732.1 28764.9 28898.7 28964.0 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | [#2] jquery.html Cycles:180 Average:28319.05 Median:20281.43 stddev:78261.34 (385.9%) stddev-sans-first:78452.75 19:27:17 INFO - PROCESS | 2882 | Values: 371.8 377.3 388.7 397.0 413.5 16796.7 19144.8 19266.9 20046.8 20228.5 18982.7 19157.1 19703.7 19724.6 19874.5 5588.2 5691.9 5791.8 5904.3 5904.6 5726.7 5733.2 5753.4 5760.0 5763.5 5575.8 5733.3 5750.3 5769.2 5786.9 5716.1 5722.6 5756.6 5759.6 5759.7 5090.3 5197.1 5354.7 5387.3 5397.0 12471.4 12633.4 12878.0 13085.3 13087.4 2028.5 2116.1 2297.2 2355.2 2364.3 9583.6 9587.0 9618.1 9829.0 9873.8 1826.2 1847.7 1880.9 1894.9 1898.7 79899.6 85697.6 86891.6 88226.0 89658.6 11191.3 11393.8 11404.7 11490.3 11544.4 15753.0 15818.6 15893.1 15933.2 15968.9 8379.6 8426.7 8559.3 8666.7 8688.7 8143.5 8157.2 8236.5 8322.5 8432.1 4675.9 4816.6 4871.7 4894.6 5004.6 1797.7 1871.6 1985.5 1986.5 1989.6 913.3 954.6 972.8 977.3 1033.8 18606.0 19399.6 19643.2 19667.7 19914.5 1015.5 1024.7 1034.4 1053.5 1069.1 10109.7 10921.6 10925.6 10978.3 11067.4 422724.0 438958.0 496290.0 498650.0 503917.0 68573.7 73031.6 96772.5 97713.0 100087.0 997.5 1002.2 1035.9 1036.0 1045.3 17707.7 17952.5 18568.0 18706.9 19024.5 40149.4 44417.2 44798.2 45403.8 45439.2 51933.0 59942.7 60559.4 61807.7 63140.7 7958.2 8220.5 8443.5 8478.6 8759.3 9361.0 13037.2 13554.3 13749.3 13919.0 5746.7 8969.4 9345.4 11737.8 11852.5 11454.6 11675.1 11718.0 11731.9 11826.8 11961.3 12085.5 12274.2 12363.3 12668.5 7970.6 7993.4 7996.9 8301.2 8492.0 9209.4 11588.5 11932.1 11963.5 12345.8 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | [#3] mootools.html Cycles:180 Average:5623.36 Median:5024.01 stddev:3114.97 (62.0%) stddev-sans-first:3108.05 19:27:17 INFO - PROCESS | 2882 | Values: 1467.9 1474.6 1611.7 1744.4 1784.6 7460.5 8111.3 8237.3 8745.3 8753.2 8277.0 8476.1 8579.8 8592.2 8602.1 2314.4 2346.3 2349.4 2358.1 2359.6 1996.4 2218.7 2263.3 2287.8 2293.0 2291.6 2310.1 2310.8 2325.3 2326.8 2205.7 2234.0 2280.0 2283.8 2284.4 2242.7 2245.4 2246.2 2246.7 2263.3 8516.1 8543.6 8599.7 8601.4 8629.3 4902.6 5047.4 5052.5 5053.3 5057.1 3172.0 3217.3 3263.9 3284.7 3291.8 1065.5 1089.0 1101.4 1106.9 1130.5 11313.8 11364.2 11367.8 11376.5 11384.2 4136.0 4246.8 4382.9 4385.6 4404.9 9636.1 9656.0 9658.9 9662.4 9672.8 5008.6 5009.4 5018.8 5029.2 5029.5 4590.0 4642.0 4643.0 4657.1 4660.0 3895.6 3914.0 3993.5 4017.3 4019.3 1155.7 1240.5 1259.9 1273.2 1285.4 815.0 931.9 937.9 977.1 1003.8 5907.2 5962.3 5987.7 6032.4 6103.4 993.6 1026.7 1028.6 1048.7 1069.0 4041.2 4125.5 4164.2 4190.5 4199.8 10095.4 10308.5 10356.7 10661.3 10662.7 9957.1 10133.7 10163.9 10166.2 10173.0 7887.4 7925.6 7967.3 8023.1 8025.9 5848.8 5887.6 5932.7 6036.3 6182.2 9708.9 9771.5 9822.4 9845.6 9897.8 9570.4 9891.1 10207.9 10241.4 10242.0 7277.5 7415.6 7426.7 7427.9 7433.7 8294.1 8307.0 8315.5 8317.4 8363.6 7339.3 7467.1 7496.0 7542.7 7622.8 7261.5 7338.4 7386.5 7587.1 7606.8 6772.0 6877.8 6881.5 6883.4 6888.7 5125.2 5163.1 5252.3 5268.2 5384.1 5166.0 5340.5 5430.3 5433.9 5450.9 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | [#4] prototype.html Cycles:180 Average:4608.83 Median:5304.89 stddev:1375.67 (25.9%) stddev-sans-first:1341.19 19:27:17 INFO - PROCESS | 2882 | Values: 311.8 316.8 317.9 318.1 320.7 5292.9 5308.4 5319.3 5320.1 5340.4 5227.3 5255.7 5258.4 5261.8 5264.8 3858.5 3932.6 4042.7 4075.9 4078.2 4061.8 4062.6 4067.9 4091.4 4109.4 4029.5 4033.4 4041.0 4047.7 4060.5 3817.4 3952.9 4051.5 4054.2 4068.9 3567.3 3573.2 3575.5 3575.9 3595.9 5107.4 5115.3 5131.7 5145.6 5157.6 4473.3 4605.8 4607.0 4609.6 4653.7 5386.6 5395.2 5396.2 5432.2 5454.8 3904.5 3906.9 3924.0 3928.0 3929.7 5529.3 5627.3 5636.5 5661.3 5696.5 3998.9 4004.6 4006.0 4010.3 4012.2 4046.4 4060.1 4060.9 4061.5 4063.5 4346.8 4573.6 4641.8 4650.3 4680.6 5488.7 5491.0 5506.6 5510.9 5518.6 1340.3 1344.4 1353.5 1366.8 1367.3 820.5 870.8 874.4 884.5 889.1 5085.5 5165.6 5236.8 5245.7 5245.7 5540.4 5586.9 5593.0 5598.6 5611.9 5145.5 5264.9 5296.6 5303.0 5306.8 2905.0 2920.7 2941.3 2949.5 2950.7 5732.9 5751.5 5758.5 5797.4 5813.5 5478.8 5703.4 5730.3 5731.6 5732.6 5764.5 5809.6 5825.8 5828.4 5834.3 5379.5 5612.0 5622.4 5654.1 5659.4 5606.8 5641.0 5644.6 5647.0 5659.4 5852.7 5875.0 5886.3 5887.6 5888.2 3768.2 3934.2 3955.6 3971.4 4019.2 5620.1 5640.4 5647.1 5650.2 5665.2 5493.3 5495.8 5503.8 5524.3 5531.4 5213.4 5488.3 5501.8 5537.5 5537.9 5483.2 5489.3 5502.9 5506.8 5529.1 5322.5 5423.9 5519.4 5554.1 5582.8 5420.5 5425.3 5427.6 5438.3 5441.0 19:27:17 INFO - PROCESS | 2882 | 19:27:17 INFO - PROCESS | 2882 | [#5] yui.html Cycles:180 Average:19772.51 Median:26276.99 stddev:28007.82 (106.6%) stddev-sans-first:28050.03 19:27:17 INFO - PROCESS | 2882 | Values: 766.4 775.9 782.8 799.0 846.2 16172.4 16955.5 17072.0 17089.3 17135.1 15269.8 15442.8 15453.0 15457.5 15461.8 655.4 797.4 800.1 814.2 815.1 810.2 811.8 812.8 813.2 813.8 867.9 869.9 870.4 870.4 870.8 696.7 833.6 844.0 856.2 867.0 616.8 620.1 620.4 620.8 622.4 15138.8 15338.2 15366.2 15384.8 15391.6 14292.6 14478.0 14689.1 14792.8 15128.7 13670.7 13677.3 13814.6 13927.4 13983.8 3868.4 3872.3 3901.5 3983.9 4085.4 75764.0 76664.2 76862.6 77317.0 77444.2 10977.5 11422.5 11491.9 11510.7 11649.7 20131.2 20140.4 20142.7 20164.8 20172.2 8226.3 8378.7 8509.7 8533.0 8546.3 4724.7 4848.6 4901.9 4942.4 4990.7 3509.3 3667.9 3670.6 3671.1 3673.0 586.6 589.0 597.1 600.2 601.0 571.9 657.1 668.3 688.3 689.1 9128.1 9679.3 10041.9 10377.6 10646.7 575.3 609.4 666.5 681.3 697.0 4513.5 4732.5 4832.5 4833.6 4869.5 66675.3 71819.0 95746.0 110976.0 115812.0 98256.5 101038.0 101495.0 104632.0 105407.5 54196.0 75396.6 79859.6 85502.1 88360.6 8796.6 8805.6 8848.7 9016.8 9027.9 47821.5 48293.8 49741.0 50136.0 50262.7 68834.7 69804.7 73876.0 77461.6 78972.6 10902.5 10996.7 11132.5 11339.7 11345.3 12864.2 12898.7 12900.2 13059.5 13529.0 12262.6 12355.4 12467.0 12728.3 12744.0 12093.4 12182.3 12629.9 12677.2 12867.6 11403.9 11646.7 11908.8 12079.6 12775.8 10354.4 10400.2 10634.3 10642.5 10812.6 9916.2 10482.9 10523.3 10528.5 10553.6 19:27:17 INFO - PROCESS | 2882 | -------- Summary: end -------- 19:27:17 INFO - PROCESS | 2882 | 19:27:18 INFO - TEST-INFO | 2882: exit 0 19:27:18 INFO - TEST-OK | dromaeo_css | took 1116040ms 19:27:18 INFO - TEST-START | kraken 19:27:18 INFO - operating with platform_type : linux_ 19:27:18 INFO - Initialising browser for kraken test... 19:27:18 INFO - TEST-INFO | started process 3213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw68g8x/profile http://localhost:44133/getInfo.html) 19:27:22 INFO - PROCESS | 3213 | __metrics Screen width/height:1600/1200 19:27:22 INFO - PROCESS | 3213 | colorDepth:24 19:27:22 INFO - PROCESS | 3213 | Browser inner width/height: 1024/697 19:27:22 INFO - PROCESS | 3213 | __metrics 19:27:23 INFO - PROCESS | 3213 | 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" 19:27:23 INFO - PROCESS | 3213 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:23 INFO - PROCESS | 3213 | console.error: PushService: 19:27:23 INFO - PROCESS | 3213 | stateChangeProcessEnqueue: Error transitioning state 19:27:23 INFO - PROCESS | 3213 | UnknownError 19:27:24 INFO - TEST-INFO | 3213: exit 0 19:27:24 INFO - Browser initialized. 19:27:24 INFO - Running cycle 1/1 for kraken test... 19:27:24 INFO - TEST-INFO | started process 3298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw68g8x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:36 INFO - PROCESS | 3298 | RSS: Main: 179249152 19:27:36 INFO - PROCESS | 3298 | 19:27:39 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44133/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:39 INFO - PROCESS | 3298 | RSS: Main: 233095168 19:27:39 INFO - PROCESS | 3298 | 19:27:42 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44133/tests/kraken/driver.html?testName=audio-dft) 19:27:43 INFO - PROCESS | 3298 | RSS: Main: 224014336 19:27:43 INFO - PROCESS | 3298 | 19:27:46 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44133/tests/kraken/driver.html?testName=audio-fft) 19:27:46 INFO - PROCESS | 3298 | RSS: Main: 301760512 19:27:46 INFO - PROCESS | 3298 | 19:27:48 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44133/tests/kraken/driver.html?testName=audio-oscillator) 19:27:49 INFO - PROCESS | 3298 | RSS: Main: 212582400 19:27:49 INFO - PROCESS | 3298 | 19:27:51 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44133/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:52 INFO - PROCESS | 3298 | RSS: Main: 214515712 19:27:52 INFO - PROCESS | 3298 | 19:27:55 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44133/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:55 INFO - PROCESS | 3298 | RSS: Main: 254406656 19:27:55 INFO - PROCESS | 3298 | 19:27:59 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44133/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:59 INFO - PROCESS | 3298 | RSS: Main: 253509632 19:27:59 INFO - PROCESS | 3298 | 19:28:02 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44133/tests/kraken/driver.html?testName=json-parse-financial) 19:28:03 INFO - PROCESS | 3298 | RSS: Main: 252948480 19:28:03 INFO - PROCESS | 3298 | 19:28:04 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44133/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:05 INFO - PROCESS | 3298 | RSS: Main: 215457792 19:28:05 INFO - PROCESS | 3298 | 19:28:07 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:07 INFO - PROCESS | 3298 | RSS: Main: 222711808 19:28:07 INFO - PROCESS | 3298 | 19:28:09 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:10 INFO - PROCESS | 3298 | RSS: Main: 222642176 19:28:10 INFO - PROCESS | 3298 | 19:28:12 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:13 INFO - PROCESS | 3298 | RSS: Main: 222953472 19:28:13 INFO - PROCESS | 3298 | 19:28:16 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:16 INFO - PROCESS | 3298 | RSS: Main: 220549120 19:28:16 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | Cycle 1(1): loaded http://localhost:44133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44133/tests/kraken/driver.html?testName=ai-astar) 19:28:18 INFO - PROCESS | 3298 | RSS: Main: 271335424 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | __start_tp_report 19:28:18 INFO - PROCESS | 3298 | _x_x_mozilla_page_load 19:28:18 INFO - PROCESS | 3298 | _x_x_mozilla_page_load_details 19:28:18 INFO - PROCESS | 3298 | |i|pagename|runs| 19:28:18 INFO - PROCESS | 3298 | |0;ai-astar;111;109;125;111;112;111;108;111;111;110 19:28:18 INFO - PROCESS | 3298 | |1;audio-beat-detection;146;121;150;176;121;155;145;118;182;121 19:28:18 INFO - PROCESS | 3298 | |2;audio-dft;160;161;160;160;162;161;160;161;160;163 19:28:18 INFO - PROCESS | 3298 | |3;audio-fft;75;74;75;184;78;75;75;75;163;75 19:28:18 INFO - PROCESS | 3298 | |4;audio-oscillator;82;83;141;82;82;83;149;81;82;141 19:28:18 INFO - PROCESS | 3298 | |5;imaging-gaussian-blur;118;118;117;117;117;118;117;117;118;117 19:28:18 INFO - PROCESS | 3298 | |6;imaging-darkroom;146;145;146;146;145;146;146;146;146;145 19:28:18 INFO - PROCESS | 3298 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;96;96 19:28:18 INFO - PROCESS | 3298 | |8;json-parse-financial;55;59;55;55;54;56;55;55;52;53 19:28:18 INFO - PROCESS | 3298 | |9;json-stringify-tinderbox;60;62;61;61;62;62;62;63;63;62 19:28:18 INFO - PROCESS | 3298 | |10;stanford-crypto-aes;80;78;78;84;86;78;78;84;78;78 19:28:18 INFO - PROCESS | 3298 | |11;stanford-crypto-ccm;123;125;131;125;124;130;132;121;167;141 19:28:18 INFO - PROCESS | 3298 | |12;stanford-crypto-pbkdf2;160;165;168;161;162;161;162;161;161;160 19:28:18 INFO - PROCESS | 3298 | |13;stanford-crypto-sha256-iterative;65;65;65;64;65;64;63;65;65;63 19:28:18 INFO - PROCESS | 3298 | __end_tp_report 19:28:18 INFO - PROCESS | 3298 | __start_cc_report 19:28:18 INFO - PROCESS | 3298 | _x_x_mozilla_cycle_collect,1719 19:28:18 INFO - PROCESS | 3298 | __end_cc_report 19:28:18 INFO - PROCESS | 3298 | __startTimestamp1472178498858__endTimestamp 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | ------- Summary: start ------- 19:28:18 INFO - PROCESS | 3298 | Number of tests: 14 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.75 (4.3%) stddev-sans-first:5.02 19:28:18 INFO - PROCESS | 3298 | Values: 111.0 109.0 125.0 111.0 112.0 111.0 108.0 111.0 111.0 110.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:148.00 stddev:23.31 (15.8%) stddev-sans-first:24.71 19:28:18 INFO - PROCESS | 3298 | Values: 146.0 121.0 150.0 176.0 121.0 155.0 145.0 118.0 182.0 121.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 19:28:18 INFO - PROCESS | 3298 | Values: 160.0 161.0 160.0 160.0 162.0 161.0 160.0 161.0 160.0 163.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.00 stddev:41.73 (55.6%) stddev-sans-first:43.64 19:28:18 INFO - PROCESS | 3298 | Values: 75.0 74.0 75.0 184.0 78.0 75.0 75.0 75.0 163.0 75.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:82.00 stddev:29.80 (36.3%) stddev-sans-first:30.84 19:28:18 INFO - PROCESS | 3298 | Values: 82.0 83.0 141.0 82.0 82.0 83.0 149.0 81.0 82.0 141.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:28:18 INFO - PROCESS | 3298 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 19:28:18 INFO - PROCESS | 3298 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:28:18 INFO - PROCESS | 3298 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.85 (3.4%) stddev-sans-first:1.96 19:28:18 INFO - PROCESS | 3298 | Values: 55.0 59.0 55.0 55.0 54.0 56.0 55.0 55.0 52.0 53.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.71 19:28:18 INFO - PROCESS | 3298 | Values: 60.0 62.0 61.0 61.0 62.0 62.0 62.0 63.0 63.0 62.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.00 stddev:3.19 (4.0%) stddev-sans-first:3.38 19:28:18 INFO - PROCESS | 3298 | Values: 80.0 78.0 78.0 84.0 86.0 78.0 78.0 84.0 78.0 78.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:130.50 stddev:13.64 (10.5%) stddev-sans-first:14.08 19:28:18 INFO - PROCESS | 3298 | Values: 123.0 125.0 131.0 125.0 124.0 130.0 132.0 121.0 167.0 141.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:161.50 stddev:2.51 (1.6%) stddev-sans-first:2.55 19:28:18 INFO - PROCESS | 3298 | Values: 160.0 165.0 168.0 161.0 162.0 161.0 162.0 161.0 161.0 160.0 19:28:18 INFO - PROCESS | 3298 | 19:28:18 INFO - PROCESS | 3298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 19:28:18 INFO - PROCESS | 3298 | Values: 65.0 65.0 65.0 64.0 65.0 64.0 63.0 65.0 65.0 63.0 19:28:18 INFO - PROCESS | 3298 | -------- Summary: end -------- 19:28:18 INFO - PROCESS | 3298 | 19:28:19 INFO - TEST-INFO | 3298: exit 0 19:28:20 INFO - TEST-OK | kraken | took 61677ms 19:28:20 INFO - SUITE-END | took 1177s 19:28:20 INFO - Completed test suite (00:19:38) 19:28:20 INFO - javascript benchmark 19:28:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2986.372861699044, 3011.23213580537, 3022.048054862718, 3055.3125546752, 3070.9385812283754, 5144.279800827887, 5218.21726740989, 5244.685318880865, 5249.86875328117, 5326.707031113292, 5262.736863156846, 5271.15661494161, 5308.389535203452, 5322.680639161653, 5382.650127741694, 4693.460252071004, 4786.976065119669, 4793.616510679138, 4807.687500312469, 4972.70163790172, 4856.444261490161, 4878.634102442331, 4914.877128071791, 4925.359703238574, 4960.007998400316, 4762.357081793948, 4765.8570242892765, 4812.542808433193, 4838.274258861164, 4865.708057516525, 4736.59738922192, 4743.1699452596, 4744.7627618618935, 4795.112904112751, 4857.611391088704, 4747.074320507502, 4758.381410416659, 4759.333693282943, 4772.045590881838, 4815.205491093965, 5152.742362881841, 5214.270002199695, 5270.209468579744, 5354.759035843396, 5358.303420555303, 5590.0, 5635.746391412396, 5641.52047075995, 5643.0, 5653.152027195953, 5630.071038278679, 5671.9716401418145, 5673.574481913873, 5674.4892959633835, 5689.943100569024, 5091.389033315989, 5171.948280517185, 5213.244079608436, 5224.973875130638, 5300.840974770763, 5718.428157184331, 5724.1413787931315, 5726.312842458931, 5729.8567535811935, 5730.885382292331, 5474.370447398521, 5481.643693159932, 5489.204065410493, 5489.505944465017, 5495.175723641486, 5502.449755024546, 5546.528545073633, 5631.887362252814, 5640.689762063043, 5714.771409143587, 5646.717664116778, 5648.6893220872425, 5650.180723795027, 5652.0391533439415, 5709.7716091356715, 5606.943930560724, 5646.520045796071, 5650.26546548946, 5663.377028526858, 5665.12190610456, 4198.3702444633545, 4293.892652683708, 4363.105563359503, 4372.890677733082, 4447.2217361962175, 3889.5138107736534, 3890.533136023695, 3897.0, 3942.2706799242233, 3948.6446219840354, 5367.5169234769055, 5371.892562148735, 5372.650777699437, 5376.623636345418, 5436.0, 5509.146082357241, 5619.578531610146, 5633.57748168889, 5670.659760414388, 5702.258706368229, 5389.568834493231, 5403.189521571717, 5426.104692725735, 5452.04589196889, 5464.453554644504, 4878.390201224847, 4905.779239934212, 4908.460069392364, 4919.606431485473, 4966.553010229097, 5664.915026274609, 5668.121441176624, 5727.2268243787385, 5727.770889164387, 5878.11828225761, 5564.276644036249, 5569.192467092168, 5626.127950167731, 5627.409122042291, 5631.380548139619, 5728.369879313355, 5730.484256416942, 5732.111522713986, 5741.569382296428, 5743.4543718346695, 5359.892802144013, 5425.620206585501, 5479.7122676170275, 5483.725813709379, 5485.040117979417, 5627.831165065055, 5628.971855140698, 5637.746301416364, 5723.427657234243, 5731.8853622928145, 5436.130219164915, 5474.178873169057, 5494.945050549443, 5499.670019798825, 5511.779528818963, 5335.253064570886, 5455.263539422127, 5457.645253058538, 5466.91799623014, 5524.8342549723575, 5473.781048758165, 5505.064139096443, 5516.200150978166, 5571.498565129158, 5576.693281869536, 5530.640508366943, 5533.474319939599, 5536.916946245729, 5544.251526043932, 5566.081596536526, 5219.19102539107, 5264.210368444611, 5399.433059528693, 5431.837044888502, 5440.129579267298], "value": 5194.538503254234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5425024354905, 592.8103007037744, 604.3050491934275, 614.1095411653104, 623.0280762011262, 31799.68200317996, 44058.55941440585, 45038.0, 45124.32313515296, 45164.774176129155, 45884.4115588441, 46243.30635040469, 46479.30281045787, 46492.767536162355, 46553.30170047452, 8925.375223734358, 9074.637014519445, 9097.681581144661, 9102.271818254523, 9103.180713735763, 8994.145556172152, 9073.274138068971, 9091.954540227289, 9092.22716069135, 9095.363324567283, 9076.591553380114, 9127.95436022819, 9129.041450647686, 9132.315076369267, 9136.177744003038, 9024.684136055239, 9108.453492790453, 9118.58966346516, 9124.771880703001, 9128.497932613704, 8955.104489551059, 9021.819563608757, 9027.503487308195, 9028.683996060172, 9029.0, 43147.568524314665, 43462.565374346486, 43488.130237395395, 43530.564694352965, 43561.128777424274, 3224.5808044954006, 3408.3694516514274, 3419.743519236067, 3425.2122011937145, 3445.7415693823064, 32597.83701081503, 32602.6739732602, 32727.345453090806, 33094.6690533094, 33248.66751332504, 4065.7560546367313, 4097.508299004109, 4130.648894843942, 4134.441850350225, 4159.854405095837, 368791.0, 370658.0, 371390.0, 372210.0, 372643.0, 50602.240966385536, 58725.41274587285, 58776.70611646914, 59061.0, 59136.0, 58123.0, 59046.704766475894, 59855.102173467436, 64565.67717161384, 64614.35385646083, 17384.913075434793, 17530.386436474662, 17556.473305800846, 17562.912185438992, 17569.472915812545, 11313.208075434804, 13628.863711362957, 13705.0, 13723.245221512712, 13723.794143087862, 15943.44197953066, 16422.75365869513, 16456.20244558428, 16559.25483353252, 16697.0, 5835.620684655484, 5842.298924129132, 5860.560457965669, 5868.38381969887, 5898.705064746746, 965.2229954886244, 1013.9188864890791, 1034.6482196053378, 1069.9786004280027, 1106.5186643809807, 33078.834605826814, 33591.152486612984, 33757.32485350328, 36283.637163628555, 36495.81752091223, 1030.2479190191202, 1115.7043383503378, 1117.0895719988184, 1159.5303901919735, 1176.7881781279282, 15815.102187737315, 16835.326586936386, 17048.14759262032, 17160.22778974949, 17372.47882563525, 524604.0, 524746.0, 524867.0, 525633.0, 526845.0, 58105.418945810845, 58282.4171758277, 58320.12519812206, 58339.70830145907, 58348.0, 1236.2644226685109, 1273.891719203878, 1340.9664758380923, 1386.0851837787013, 1396.3646540823697, 31434.52848207233, 32801.179970500925, 34048.48927266044, 34481.482777757854, 34543.0, 50007.0, 50636.64495358225, 50649.240261396844, 50710.0, 50738.746306269706, 390546.0, 390858.0, 392630.0, 395543.0, 398580.0, 27509.44981100407, 28376.716232837407, 28441.28896777597, 29188.27029324284, 29201.85399072991, 47626.76186619045, 48368.0, 48456.0, 48635.27047094367, 48678.0, 40352.0, 41127.58872411357, 41766.80351203121, 42063.78968105262, 43481.78259108684, 41910.16179676451, 42286.1542769149, 42487.5751242496, 42542.36186457144, 43473.782631086644, 41631.37552936648, 41648.0, 41763.7911810439, 42217.0, 42310.57689423066, 35264.82367588145, 37027.0, 37575.624243757215, 38136.42795358016, 38191.0, 28604.0, 28732.13803585896, 28764.85617571899, 28898.711012889602, 28964.0], "value": 20113.326749560772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.8271003983147, 377.25303898281385, 388.69487452349904, 396.9603039696031, 413.4604341334557, 16796.66406671866, 19144.808551914477, 19266.90366548167, 20046.799532004712, 20228.494287642818, 18982.715259271088, 19157.137928793203, 19703.704444433344, 19724.605507889835, 19874.503137421572, 5588.189712491686, 5691.857703557403, 5791.826245212629, 5904.291485021782, 5904.61619994699, 5726.7422965966425, 5733.197352370671, 5753.424657534255, 5760.0, 5763.5101016413655, 5575.832725018256, 5733.340665823421, 5750.281214848144, 5769.192313076152, 5786.942130578704, 5716.085426331788, 5722.599418040739, 5756.568257380693, 5759.5968282220265, 5759.68321742304, 5090.33825602673, 5197.116490196676, 5354.651947623392, 5387.299651045339, 5396.973015134939, 12471.438785254686, 12633.368331583384, 12878.0, 13085.28030958297, 13087.41106650203, 2028.513156842362, 2116.1429621003517, 2297.184499502686, 2355.1756885090253, 2364.2810767617207, 9583.616655333779, 9586.952065239699, 9618.086281803218, 9829.0, 9873.753156171082, 1826.205600563759, 1847.7228415737613, 1880.8683392162554, 1894.8578856585812, 1898.6582415165265, 79899.6005019977, 85697.57151214266, 86891.56554217188, 88226.0, 89658.5517072417, 11191.2725672831, 11393.829092563617, 11404.657860264206, 11490.253133546294, 11544.422778861024, 15753.0, 15818.60453488672, 15893.125878076817, 15933.203339832962, 15968.92015539938, 8379.62291696875, 8426.662933482592, 8559.315254779603, 8666.696665616673, 8688.6524539019, 8143.470674406145, 8157.184281571914, 8236.50580965144, 8322.45904016237, 8432.114627963976, 4675.859724208279, 4816.590589799906, 4871.658983871095, 4894.556105948754, 5004.624653151028, 1797.70337894246, 1871.6163186546726, 1985.4837742187135, 1986.5133042404702, 1989.592133612606, 913.3469569258012, 954.5704433005176, 972.8394814855611, 977.2572844637984, 1033.7674023344687, 18605.976671282937, 19399.612007760046, 19643.214271429268, 19667.704984425243, 19914.469207424612, 1015.4770293298957, 1024.6618615856748, 1034.3690348887174, 1053.5469748008277, 1069.0699091790036, 10109.747256318651, 10921.563137474572, 10925.603980576856, 10978.346151731865, 11067.446627668583, 422724.0, 438958.0, 496290.0, 498650.0, 503917.0, 68573.65713171502, 73031.63484182545, 96772.51613742027, 97713.0, 100087.0, 997.4663554998041, 1002.183220675162, 1035.896410358958, 1035.9689209323733, 1045.310095337089, 17707.73438398451, 17952.486651868487, 18568.0, 18706.906465467586, 19024.52438689044, 40149.397759033054, 44417.223311067195, 44798.16032194418, 45403.77298113621, 45439.22888096702, 51933.0, 59942.700286498286, 60559.39440605538, 61807.690961544904, 63140.68429657822, 7958.243966823143, 8220.491312162781, 8443.493390396596, 8478.618462169341, 8759.299256059627, 9360.953195234253, 13037.217766934014, 13554.322283885964, 13749.312534373441, 13919.0, 5746.712664366682, 8969.416987895765, 9345.392549484262, 11737.823932640846, 11852.466639001437, 11454.599089031844, 11675.124365672438, 11718.0, 11731.88268117308, 11826.822597661214, 11961.342126183143, 12085.456154472893, 12274.202176858833, 12363.258204507758, 12668.493260269486, 7970.641321140447, 7993.400494963017, 7996.920030799618, 8301.169883011651, 8491.95754021226, 9209.355345125778, 11588.536458541901, 11932.105092117952, 11963.461644226205, 12345.753084938431], "value": 9037.142331668787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.9192644404561, 1474.616599684082, 1611.7179493588626, 1744.4243399678107, 1784.6430713857233, 7460.477766556343, 8111.269985701286, 8237.299829514484, 8745.256653184479, 8753.16844899735, 8276.958615206931, 8476.067632560413, 8579.78550536237, 8592.226699597035, 8602.139786021395, 2314.421394651333, 2346.3312955807596, 2349.3774149850306, 2358.0921345282018, 2359.6106642403984, 1996.4110587376758, 2218.689383486313, 2263.298377502971, 2287.839851210416, 2293.0369244917174, 2291.6218823894037, 2310.07596961216, 2310.792028717415, 2325.3140323604493, 2326.7556906524824, 2205.7463391709916, 2234.0393630738777, 2279.988600057006, 2283.828712846543, 2284.371797755614, 2242.674812152245, 2245.36007237938, 2246.1913711064003, 2246.674232236333, 2263.2870645746702, 8516.06323304436, 8543.572821358906, 8599.656013759504, 8601.354898382646, 8629.309655227567, 4902.558769710708, 5047.4447810740785, 5052.545270925598, 5053.343065401475, 5057.064443078006, 3172.0, 3217.324361884007, 3263.902082937516, 3284.687954644305, 3291.8189499577516, 1065.4619417194344, 1088.9618863339745, 1101.4437708956925, 1106.8505751723494, 1130.4686797205381, 11313.83029254562, 11364.204505684605, 11367.829482557769, 11376.544938202462, 11384.203105782599, 4135.97932010338, 4246.766427846436, 4382.8904277392685, 4385.640451460057, 4404.867853964386, 9636.084571965652, 9656.034396560288, 9658.90341096594, 9662.420254784594, 9672.75818104539, 5008.649394542347, 5009.44896061433, 5018.824341148115, 5029.195328747456, 5029.497050295015, 4590.0, 4641.976790116096, 4643.048175124091, 4657.138429390574, 4659.9767001165455, 3895.5520115187114, 3913.9804300978312, 3993.5207775066597, 4017.2568074906235, 4019.31671615826, 1155.6764106050318, 1240.4665993622648, 1259.9370031498388, 1273.178799674205, 1285.4344088600985, 814.9837003259902, 931.9487428191379, 937.8780758501488, 977.1010670183448, 1003.8243307421172, 5907.227831650488, 5962.25471816023, 5987.670678112659, 6032.39676032402, 6103.35914728956, 993.6124911284605, 1026.7227848480868, 1028.5702873006526, 1048.6749107776614, 1068.9946550267198, 4041.1513582148077, 4125.463689720317, 4164.208800327928, 4190.497140343117, 4199.811008504625, 10095.394276343442, 10308.484575771181, 10356.741081473023, 10661.253712240068, 10662.73343166427, 9957.103860652576, 10133.695989120339, 10163.898361016296, 10166.186705063577, 10173.0, 7887.44787864844, 7925.564093974772, 7967.28294453502, 8023.117457079717, 8025.919740802634, 5848.766049357978, 5887.61730487517, 5932.703364831655, 6036.33600303975, 6182.196314479089, 9708.902910970799, 9771.462569558742, 9822.361546499455, 9845.556949937127, 9897.752556186153, 9570.425774453555, 9891.109800117736, 10207.897921020694, 10241.436720980417, 10241.975802419996, 7277.526960747535, 7415.555066696015, 7426.702931882664, 7427.925720742724, 7433.739819106306, 8294.129116442688, 8307.044689860744, 8315.542645154575, 8317.41778075529, 8363.581820908808, 7339.339459448462, 7467.141278753013, 7496.0, 7542.698292068256, 7622.8094297643, 7261.491695581259, 7338.376238019828, 7386.519876208029, 7587.089549254125, 7606.847863042819, 6771.966140169267, 6877.793666190022, 6881.518293719391, 6883.414909732529, 6888.7244510221035, 5125.205593133071, 5163.148080566814, 5252.343457067866, 5268.1834315681135, 5384.138537833927, 5165.974170129125, 5340.465953404629, 5430.294061771944, 5433.864153396196, 5450.863728406822], "value": 4540.645652653627, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.78331059913353, 316.83682903304805, 317.87443959635937, 318.14577858450065, 320.70014536408445, 5292.894142117156, 5308.389535203452, 5319.335083114615, 5320.068987927112, 5340.385855626604, 5227.3465816772905, 5255.658382205154, 5258.421573626898, 5261.815836445725, 5264.8157314494, 3858.459815625815, 3932.6067393260587, 4042.6967977401664, 4075.8777236682945, 4078.1843631273714, 4061.817218225187, 4062.5531191568903, 4067.9220006698247, 4091.3862920562005, 4109.363048727437, 4029.4560234368278, 4033.37482690182, 4040.979795101035, 4047.6761859051207, 4060.4924384451942, 3817.4273858921106, 3952.901177470572, 4051.513818341818, 4054.16889537647, 4068.9186216275507, 3567.2865426914723, 3573.231755172624, 3575.497151993589, 3575.910602234939, 3595.9101022474388, 5107.361579802525, 5115.309433226504, 5131.7434128293435, 5145.562627176694, 5157.613179011551, 4473.261911784584, 4605.792739326738, 4607.0, 4609.640156153942, 4653.673702994631, 5386.622936394454, 5395.163749618815, 5396.163594642837, 5432.212329212242, 5454.754536045887, 3904.531456225243, 3906.867008567512, 3923.98038009811, 3928.0, 3929.7052721046034, 5529.3364796224305, 5627.324721033461, 5636.4927156556105, 5661.348944871352, 5696.544276457874, 3998.9200215996098, 4004.619561141687, 4006.017021574339, 4010.27814993304, 4012.237674841829, 4046.3728122141115, 4060.127072679388, 4060.8578699745367, 4061.5126184858004, 4063.5326937401987, 4346.8043938022865, 4573.588377046081, 4641.767911604406, 4650.279206722963, 4680.602148817321, 5488.670679759227, 5491.007400966483, 5506.587005974568, 5510.889782204334, 5518.613697041249, 1340.3164386163128, 1344.4471635261289, 1353.458616553367, 1366.8086467894304, 1367.3300082959477, 820.4707963363597, 870.7779516223322, 874.3529787956993, 884.4958373727043, 889.0975659705405, 5085.525197692702, 5165.638405311592, 5236.764345604381, 5245.659032162897, 5245.6852588844795, 5540.390557038722, 5586.860328491739, 5593.021221286259, 5598.608097433141, 5611.859703507445, 5145.511176438233, 5264.894702105937, 5296.576273898079, 5303.0, 5306.787728490895, 2904.954216482107, 2920.7225313595172, 2941.2793865502663, 2949.510497198901, 2950.6754257031707, 5732.914006289909, 5751.482366587027, 5758.452946970031, 5797.36229014808, 5813.5349172066135, 5478.780848766005, 5703.429657034347, 5730.255066841367, 5731.570132240098, 5732.598718089694, 5764.510016648548, 5809.593328466966, 5825.825225243249, 5828.388019257917, 5834.299884013945, 5379.462053794589, 5612.045952188219, 5622.3815380307315, 5654.06707893193, 5659.434056594308, 5606.813342796231, 5640.971795140998, 5644.604877658525, 5646.971765141312, 5659.434056594472, 5852.736626851887, 5874.970625146847, 5886.323072846678, 5887.586979124893, 5888.17565540816, 3768.1521657626813, 3934.15415685629, 3955.6044395560216, 3971.4439978403625, 4019.1760689058087, 5620.072688006433, 5640.364294354756, 5647.124695672177, 5650.180723795109, 5665.150227465749, 5493.258410114583, 5495.845872366848, 5503.834884953458, 5524.33707955048, 5531.446855314436, 5213.374395072464, 5488.259085023471, 5501.807436739695, 5537.501624853782, 5537.889242215053, 5483.204935284281, 5489.258950041853, 5502.944970550243, 5506.752196151263, 5529.087700529368, 5322.494363035506, 5423.891522169613, 5519.420460851553, 5554.055810512304, 5582.8325150245555, 5420.457954204548, 5425.287356321839, 5427.565794736491, 5438.3413059017375, 5440.972795136157], "value": 4160.853354949142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.4366690482494, 775.9068911730592, 782.808211988063, 799.0291795468505, 846.2214762418574, 16172.433964811235, 16955.491335259932, 17072.0, 17089.316427342907, 17135.057571833546, 15269.847301526981, 15442.845571544281, 15453.0, 15457.45898893539, 15461.845381546182, 655.3642966322683, 797.3979645367739, 800.0998876264202, 814.1939479914901, 815.0667485728837, 810.2100452059225, 811.817341098254, 812.8455593437258, 813.1665043330574, 813.8331642013374, 867.9392442529025, 869.8651708985118, 870.412471581683, 870.412471581683, 870.8127752533204, 696.6969368324795, 833.6373677450298, 844.0293662288417, 856.1652388920814, 866.9653213871469, 616.7594638091103, 620.10394979255, 620.3548309757891, 620.8168590265838, 622.3651875087386, 15138.772918406232, 15338.233088345538, 15366.231688415646, 15384.846151538453, 15391.61520961985, 14292.642683932881, 14478.0, 14689.118652880861, 14792.778108328384, 15128.697426051418, 13670.658233544142, 13677.31613419325, 13814.585562433043, 13927.442902283998, 13983.79024314636, 3868.4390763339156, 3872.3417019106537, 3901.531816182048, 3983.920321593581, 4085.407615895708, 75764.0, 76664.23335766683, 76862.61568692177, 77317.0, 77444.22555774427, 10977.506012229469, 11422.543098275975, 11491.885081149248, 11510.654680359603, 11649.708757281136, 20131.19475221004, 20140.39578812638, 20142.69785953212, 20164.798352016587, 20172.19311227564, 8226.300764434971, 8378.748637540884, 8509.659613615386, 8533.018702849127, 8546.31629469641, 4724.692894961817, 4848.593015646411, 4901.877453063702, 4942.406911170682, 4990.700557966461, 3509.298140371936, 3667.889963301105, 3670.5778835433734, 3671.100580357776, 3672.9632703672623, 586.6099044135602, 588.9558283128697, 597.116267923467, 600.1717629671114, 600.9729562169713, 571.9227904232876, 657.0899304463353, 668.314977148417, 688.2841844481783, 689.0938415982966, 9128.132827381389, 9679.274054445945, 10041.899581004243, 10377.584896604052, 10646.680599582025, 575.2923903598597, 609.3510411411833, 666.4834753066316, 681.2744427185032, 696.9686364113627, 4513.480949690827, 4732.455767586772, 4832.49258827818, 4833.637477189154, 4869.537393947569, 66675.33324666788, 71819.0, 95746.0, 110976.0, 115812.0, 98256.50871745739, 101038.0, 101495.0, 104632.0, 105407.47296263622, 54196.0, 75396.62301688457, 79859.60070199727, 85502.14497855066, 88360.55819720861, 8796.560171991503, 8805.559722013746, 8848.734537963872, 9016.774580635536, 9027.877872156465, 47821.521784781704, 48293.75853120712, 49741.0, 50136.0, 50262.74868625634, 68834.65582672054, 69804.65097674479, 73876.0, 77461.61269193619, 78972.60513697394, 10902.509387077442, 10996.670099897015, 11132.472123878417, 11339.659810205707, 11345.319280843176, 12864.163829351062, 12898.67753306175, 12900.161489503153, 13059.542915997894, 13529.0, 12262.570810021607, 12355.3822308886, 12467.0, 12728.299943503196, 12744.0, 12093.37198840362, 12182.269063856196, 12629.895284032542, 12677.17598356104, 12867.613971580868, 11403.942980285046, 11646.70883227926, 11908.76182476363, 12079.57721479744, 12775.808362874379, 10354.378737275787, 10400.167986561208, 10634.30876992993, 10642.521086551278, 10812.621558245424, 9916.157126644028, 10482.895171048192, 10523.263371564224, 10528.473576321, 10553.577856885639], "value": 7354.819403970208, "unit": "score"}], "name": "dromaeo_css", "value": 7128.477791767135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 125.0, 111.0, 112.0, 111.0, 108.0, 111.0, 111.0, 110.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 150.0, 176.0, 121.0, 155.0, 145.0, 118.0, 182.0, 121.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 184.0, 78.0, 75.0, 75.0, 75.0, 163.0, 75.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 141.0, 82.0, 82.0, 83.0, 149.0, 81.0, 82.0, 141.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 55.0, 55.0, 54.0, 56.0, 55.0, 55.0, 52.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 84.0, 86.0, 78.0, 78.0, 84.0, 78.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 131.0, 125.0, 124.0, 130.0, 132.0, 121.0, 167.0, 141.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 168.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 63.0, 65.0, 65.0, 63.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1525.4, "alertThreshold": 2.0}]} 19:28:20 INFO - Return code: 0 19:28:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:20 INFO - # TBPL SUCCESS # 19:28:20 INFO - Running post-action listener: _resource_record_post_action 19:28:20 INFO - [mozharness: 2016-08-26 02:28:20.674487Z] Finished run-tests step (success) 19:28:20 INFO - Running post-run listener: _resource_record_post_run 19:28:20 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 424873984; Read time: 116; Write time: 252864 19:28:20 INFO - TinderboxPrint: CPU usage
13.0% 19:28:20 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 116 19:28:20 INFO - TinderboxPrint: I/O write bytes / time
424,873,984 / 252,864 19:28:20 INFO - TinderboxPrint: CPU idle
8,293.7 (87.0%) 19:28:20 INFO - TinderboxPrint: CPU user
1,188.9 (12.5%) 19:28:20 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 120102912; Read time: 88; Write time: 71812 19:28:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289280000; Read time: 12; Write time: 172360 19:28:21 INFO - Running post-run listener: _upload_blobber_files 19:28:21 INFO - Blob upload gear active. 19:28:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:21 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 19:28:21 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'] 19:28:21 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 19:28:21 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:22 INFO - (blobuploader) - INFO - Done attempting. 19:28:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:29 INFO - (blobuploader) - INFO - Done attempting. 19:28:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:30 INFO - (blobuploader) - INFO - Done attempting. 19:28:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:30 INFO - Return code: 0 19:28:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6529c8d61e62503801c449165920e7e283cb4f4d86f7ed7cbec577522a2ffc376657b4b341533a127d61bf4d2bbb639662c88973af7125585752cc46c940e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/178edef38b05f9388e854a8032def22f0db949174978925edfcf47c90df8cda2801f972d07a95c10feaacaa7ca29805ff5f752737f93bfa590dc3a93dbf86d05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f8d7827b775704f03df40be362d35baa74801af8dfae146d73e461952a08e9fb84d182808c990f6558fe4e1d111ed49b27c05e05fccf7920bc8c6daa92ee18"} 19:28:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:30 INFO - Contents: 19:28:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6529c8d61e62503801c449165920e7e283cb4f4d86f7ed7cbec577522a2ffc376657b4b341533a127d61bf4d2bbb639662c88973af7125585752cc46c940e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/178edef38b05f9388e854a8032def22f0db949174978925edfcf47c90df8cda2801f972d07a95c10feaacaa7ca29805ff5f752737f93bfa590dc3a93dbf86d05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f8d7827b775704f03df40be362d35baa74801af8dfae146d73e461952a08e9fb84d182808c990f6558fe4e1d111ed49b27c05e05fccf7920bc8c6daa92ee18"} 19:28:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:30 INFO - Copying logs to upload dir... 19:28:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.300845 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-25 19:28:30.452547) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 19:28:30.456156) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181 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/c6529c8d61e62503801c449165920e7e283cb4f4d86f7ed7cbec577522a2ffc376657b4b341533a127d61bf4d2bbb639662c88973af7125585752cc46c940e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/178edef38b05f9388e854a8032def22f0db949174978925edfcf47c90df8cda2801f972d07a95c10feaacaa7ca29805ff5f752737f93bfa590dc3a93dbf86d05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f8d7827b775704f03df40be362d35baa74801af8dfae146d73e461952a08e9fb84d182808c990f6558fe4e1d111ed49b27c05e05fccf7920bc8c6daa92ee18"} build_url:https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/cOK28yh5SlOOAYSsDoF1Nw/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/c6529c8d61e62503801c449165920e7e283cb4f4d86f7ed7cbec577522a2ffc376657b4b341533a127d61bf4d2bbb639662c88973af7125585752cc46c940e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/178edef38b05f9388e854a8032def22f0db949174978925edfcf47c90df8cda2801f972d07a95c10feaacaa7ca29805ff5f752737f93bfa590dc3a93dbf86d05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43f8d7827b775704f03df40be362d35baa74801af8dfae146d73e461952a08e9fb84d182808c990f6558fe4e1d111ed49b27c05e05fccf7920bc8c6daa92ee18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 19:28:30.481215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 19:28:30.481526) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1472174422.233104-1575183181 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-25 19:28:30.567241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 19:28:30.567542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 19:28:30.567839) ========= ========= Total master_lag: 0.17 =========