builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1472666452.17 results: success (0) buildid: 20160831102122 builduid: ce6ed98c50d34542990a0b025866d864 revision: 286a80b932232b2d9c90446c59214a028b5edec9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.171448) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.171940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.172319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.187381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.187718) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 11:00:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-08-31 11:00:52 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.275818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.477806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.478181) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013917 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.528584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:52.528934) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 286a80b932232b2d9c90446c59214a028b5edec9 --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 286a80b932232b2d9c90446c59214a028b5edec9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 11:00:52,791 truncating revision to first 12 chars 2016-08-31 11:00:52,791 Setting DEBUG logging. 2016-08-31 11:00:52,791 attempt 1/10 2016-08-31 11:00:52,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/286a80b93223?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 11:00:53,350 unpacking tar archive at: fx-team-286a80b93223/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835446 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:53.452112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:53.452503) ========= script_repo_revision: 286a80b932232b2d9c90446c59214a028b5edec9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:53.452886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:53.453185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:00:53.464096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-31 11:00:53.464474) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:53 INFO - MultiFileLogger online at 20160831 11:00:53 in /builds/slave/test 11:00:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:00:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:00:53 INFO - {'append_to_log': False, 11:00:53 INFO - 'base_work_dir': '/builds/slave/test', 11:00:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:00:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:00:53 INFO - 'branch': 'Fx-Team-Non-PGO', 11:00:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:53 INFO - 'config_files': ('talos/linux_config.py',), 11:00:53 INFO - 'default_actions': ('clobber', 11:00:53 INFO - 'read-buildbot-config', 11:00:53 INFO - 'download-and-extract', 11:00:53 INFO - 'populate-webroot', 11:00:53 INFO - 'create-virtualenv', 11:00:53 INFO - 'install', 11:00:53 INFO - 'run-tests'), 11:00:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:53 INFO - 'download_minidump_stackwalk': True, 11:00:53 INFO - 'download_symbols': 'ondemand', 11:00:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:53 INFO - 'installer_path': 'installer.exe', 11:00:53 INFO - 'log_level': 'info', 11:00:53 INFO - 'log_name': 'talos', 11:00:53 INFO - 'log_to_console': True, 11:00:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:53 INFO - 'opt_config_files': (), 11:00:53 INFO - 'pip_index': False, 11:00:53 INFO - 'sps_profile': False, 11:00:53 INFO - 'sps_profile_interval': 0, 11:00:53 INFO - 'suite': 'dromaeojs', 11:00:53 INFO - 'system_bits': '32', 11:00:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:53 INFO - 'title': 'talos-linux64-ix-026', 11:00:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:53 INFO - 'use_talos_json': True, 11:00:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:00:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:53 INFO - 'work_dir': 'build'} 11:00:53 INFO - [mozharness: 2016-08-31 18:00:53.817360Z] Running clobber step. 11:00:53 INFO - Running pre-action listener: _resource_record_pre_action 11:00:53 INFO - Running main action method: clobber 11:00:53 INFO - rmtree: /builds/slave/test/build 11:00:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:00:54 INFO - Running post-action listener: _resource_record_post_action 11:00:54 INFO - [mozharness: 2016-08-31 18:00:54.280105Z] Finished clobber step (success) 11:00:54 INFO - [mozharness: 2016-08-31 18:00:54.280208Z] Running read-buildbot-config step. 11:00:54 INFO - Running pre-action listener: _resource_record_pre_action 11:00:54 INFO - Running main action method: read_buildbot_config 11:00:54 INFO - Using buildbot properties: 11:00:54 INFO - { 11:00:54 INFO - "project": "", 11:00:54 INFO - "product": "firefox", 11:00:54 INFO - "script_repo_revision": "production", 11:00:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:00:54 INFO - "repository": "", 11:00:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:00:54 INFO - "buildid": "20160831102122", 11:00:54 INFO - "pgo_build": "False", 11:00:54 INFO - "basedir": "/builds/slave/test", 11:00:54 INFO - "buildnumber": 1909, 11:00:54 INFO - "slavename": "talos-linux64-ix-026", 11:00:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:00:54 INFO - "platform": "ubuntu64_hw", 11:00:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:00:54 INFO - "branch": "fx-team", 11:00:54 INFO - "repo_path": "integration/fx-team", 11:00:54 INFO - "revision": "286a80b932232b2d9c90446c59214a028b5edec9", 11:00:54 INFO - "stage_platform": "linux64", 11:00:54 INFO - "builduid": "ce6ed98c50d34542990a0b025866d864", 11:00:54 INFO - "slavebuilddir": "test" 11:00:54 INFO - } 11:00:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:00:54 INFO - Running post-action listener: _resource_record_post_action 11:00:54 INFO - [mozharness: 2016-08-31 18:00:54.283344Z] Finished read-buildbot-config step (success) 11:00:54 INFO - [mozharness: 2016-08-31 18:00:54.283434Z] Running download-and-extract step. 11:00:54 INFO - Running pre-action listener: _resource_record_pre_action 11:00:54 INFO - Running main action method: download_and_extract 11:00:54 INFO - mkdir: /builds/slave/test/build/tests 11:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:54 INFO - trying https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:00:54 INFO - Downloaded 1361 bytes. 11:00:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:00:54 INFO - Using the following test package requirements: 11:00:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:00:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:00:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'jsshell-linux-x86_64.zip'], 11:00:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:00:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:00:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:00:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:00:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:00:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:00:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:00:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:54 INFO - trying https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:55 INFO - Downloaded 20332181 bytes. 11:00:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:00:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:00: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')]} 11:00:59 INFO - trying https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:59 INFO - Downloading https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:00:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:01:00 INFO - Downloaded 20332181 bytes. 11:01:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:01: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')]} 11:01:05 INFO - trying https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:05 INFO - Downloading https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:01:06 INFO - Downloaded 14413998 bytes. 11:01:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:06 INFO - trying https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:06 INFO - Downloading https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:01:08 INFO - Downloaded 55861825 bytes. 11:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:08 INFO - mkdir: /builds/slave/test/properties 11:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:01:08 INFO - Writing to file /builds/slave/test/properties/build_url 11:01:08 INFO - Contents: 11:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:01:08 INFO - Running post-action listener: _resource_record_post_action 11:01:08 INFO - Running post-action listener: set_extra_try_arguments 11:01:08 INFO - [mozharness: 2016-08-31 18:01:08.717561Z] Finished download-and-extract step (success) 11:01:08 INFO - [mozharness: 2016-08-31 18:01:08.717864Z] Running populate-webroot step. 11:01:08 INFO - Running pre-action listener: _resource_record_pre_action 11:01:08 INFO - Running main action method: populate_webroot 11:01:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:08 INFO - '--tppagecycles', 11:01:08 INFO - '7'], 11:01:08 INFO - 'tests': ['tsvgm']}}, 11:01:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:01:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:01:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:01:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['damp', 'tps']}, 11:01:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'tests': ['damp', 'tps']}, 11:01:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['dromaeo_dom']}, 11:01:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['basic_compositor_video']}, 11:01:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:01:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore', 11:01:08 INFO - 'tabpaint']}, 11:01:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore', 11:01:08 INFO - 'tabpaint']}, 11:01:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore', 11:01:08 INFO - 'tabpaint']}, 11:01:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore', 11:01:08 INFO - 'tabpaint']}, 11:01:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore', 11:01:08 INFO - 'tabpaint']}, 11:01:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['a11yr', 11:01:08 INFO - 'ts_paint', 11:01:08 INFO - 'tpaint', 11:01:08 INFO - 'sessionrestore', 11:01:08 INFO - 'sessionrestore_no_auto_restore', 11:01:08 INFO - 'tabpaint']}, 11:01:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['tsvgx', 11:01:08 INFO - 'tsvgr_opacity', 11:01:08 INFO - 'tart', 11:01:08 INFO - 'tscrollx', 11:01:08 INFO - 'cart']}, 11:01:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:01:08 INFO - 'tsvgr_opacity', 11:01:08 INFO - 'tart', 11:01:08 INFO - 'tscrollx', 11:01:08 INFO - 'cart']}, 11:01:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--disable-e10s'], 11:01:08 INFO - 'tests': ['tp5o']}, 11:01:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'tests': ['tp5o']}, 11:01:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--disable-e10s', 11:01:08 INFO - '--xperf_path', 11:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:08 INFO - 'tests': ['tp5n']}, 11:01:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:08 INFO - 'talos_options': ['--xperf_path', 11:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:08 INFO - 'tests': ['tp5n']}}, 11:01:08 INFO - 'talos.zip': {'path': '', 11:01:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:08 INFO - Running post-action listener: _resource_record_post_action 11:01:08 INFO - [mozharness: 2016-08-31 18:01:08.734422Z] Finished populate-webroot step (success) 11:01:08 INFO - [mozharness: 2016-08-31 18:01:08.734516Z] Running create-virtualenv step. 11:01:08 INFO - Running pre-action listener: _resource_record_pre_action 11:01:08 INFO - Running main action method: create_virtualenv 11:01:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:01:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:01:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:01:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:08 INFO - Using real prefix '/usr' 11:01:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:01:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:11 INFO - Installing pip.................done. 11:01:11 INFO - Return code: 0 11:01:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:11 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:01:11 INFO - Using env: {'DISPLAY': ':0', 11:01:11 INFO - 'HOME': '/home/cltbld', 11:01:11 INFO - 'LANG': 'en_US.UTF-8', 11:01:11 INFO - 'LANGUAGE': 'en_US:en', 11:01:11 INFO - 'LOGNAME': 'cltbld', 11:01:11 INFO - 'MAIL': '/var/mail/cltbld', 11:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:11 INFO - 'MOZ_NO_REMOTE': '1', 11:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:11 INFO - 'NO_EM_RESTART': '1', 11:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:11 INFO - 'PWD': '/builds/slave/test', 11:01:11 INFO - 'SHELL': '/bin/bash', 11:01:11 INFO - 'SHLVL': '1', 11:01:11 INFO - 'TERM': 'linux', 11:01:11 INFO - 'TMOUT': '86400', 11:01:11 INFO - 'USER': 'cltbld', 11:01:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:11 INFO - '_': '/tools/buildbot/bin/python'} 11:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:01:11 INFO - Cleaning up... 11:01:11 INFO - Return code: 0 11:01:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:11 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:01:11 INFO - Using env: {'DISPLAY': ':0', 11:01:11 INFO - 'HOME': '/home/cltbld', 11:01:11 INFO - 'LANG': 'en_US.UTF-8', 11:01:11 INFO - 'LANGUAGE': 'en_US:en', 11:01:11 INFO - 'LOGNAME': 'cltbld', 11:01:11 INFO - 'MAIL': '/var/mail/cltbld', 11:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:11 INFO - 'MOZ_NO_REMOTE': '1', 11:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:11 INFO - 'NO_EM_RESTART': '1', 11:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:11 INFO - 'PWD': '/builds/slave/test', 11:01:11 INFO - 'SHELL': '/bin/bash', 11:01:11 INFO - 'SHLVL': '1', 11:01:11 INFO - 'TERM': 'linux', 11:01:11 INFO - 'TMOUT': '86400', 11:01:11 INFO - 'USER': 'cltbld', 11:01:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:11 INFO - '_': '/tools/buildbot/bin/python'} 11:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:11 INFO - Downloading/unpacking psutil>=3.1.1 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:13 INFO - Installing collected packages: psutil 11:01:13 INFO - Running setup.py install for psutil 11:01:13 INFO - building 'psutil._psutil_linux' extension 11:01:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:01:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:01:14 INFO - building 'psutil._psutil_posix' extension 11:01:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:01:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:01:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:14 INFO - Successfully installed psutil 11:01:14 INFO - Cleaning up... 11:01:14 INFO - Return code: 0 11:01:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:14 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:01:14 INFO - Using env: {'DISPLAY': ':0', 11:01:14 INFO - 'HOME': '/home/cltbld', 11:01:14 INFO - 'LANG': 'en_US.UTF-8', 11:01:14 INFO - 'LANGUAGE': 'en_US:en', 11:01:14 INFO - 'LOGNAME': 'cltbld', 11:01:14 INFO - 'MAIL': '/var/mail/cltbld', 11:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:14 INFO - 'MOZ_NO_REMOTE': '1', 11:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:14 INFO - 'NO_EM_RESTART': '1', 11:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:14 INFO - 'PWD': '/builds/slave/test', 11:01:14 INFO - 'SHELL': '/bin/bash', 11:01:14 INFO - 'SHLVL': '1', 11:01:14 INFO - 'TERM': 'linux', 11:01:14 INFO - 'TMOUT': '86400', 11:01:14 INFO - 'USER': 'cltbld', 11:01:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:14 INFO - '_': '/tools/buildbot/bin/python'} 11:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:01:16 INFO - Installing collected packages: mozsystemmonitor 11:01:16 INFO - Running setup.py install for mozsystemmonitor 11:01:16 INFO - Successfully installed mozsystemmonitor 11:01:16 INFO - Cleaning up... 11:01:16 INFO - Return code: 0 11:01:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:16 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:01:16 INFO - Using env: {'DISPLAY': ':0', 11:01:16 INFO - 'HOME': '/home/cltbld', 11:01:16 INFO - 'LANG': 'en_US.UTF-8', 11:01:16 INFO - 'LANGUAGE': 'en_US:en', 11:01:16 INFO - 'LOGNAME': 'cltbld', 11:01:16 INFO - 'MAIL': '/var/mail/cltbld', 11:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:16 INFO - 'MOZ_NO_REMOTE': '1', 11:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:16 INFO - 'NO_EM_RESTART': '1', 11:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:16 INFO - 'PWD': '/builds/slave/test', 11:01:16 INFO - 'SHELL': '/bin/bash', 11:01:16 INFO - 'SHLVL': '1', 11:01:16 INFO - 'TERM': 'linux', 11:01:16 INFO - 'TMOUT': '86400', 11:01:16 INFO - 'USER': 'cltbld', 11:01:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:16 INFO - '_': '/tools/buildbot/bin/python'} 11:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:01:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:01:19 INFO - warning: no files found matching '*.txt' 11:01:19 INFO - no previously-included directories found matching 'build' 11:01:19 INFO - no previously-included directories found matching 'dist' 11:01:19 INFO - no previously-included directories found matching '.git*' 11:01:19 INFO - Installing collected packages: jsonschema, functools32 11:01:19 INFO - Running setup.py install for functools32 11:01:19 INFO - warning: no files found matching '*.txt' 11:01:19 INFO - no previously-included directories found matching 'build' 11:01:19 INFO - no previously-included directories found matching 'dist' 11:01:19 INFO - no previously-included directories found matching '.git*' 11:01:19 INFO - Successfully installed jsonschema functools32 11:01:19 INFO - Cleaning up... 11:01:19 INFO - Return code: 0 11:01:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:19 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:01:19 INFO - Using env: {'DISPLAY': ':0', 11:01:19 INFO - 'HOME': '/home/cltbld', 11:01:19 INFO - 'LANG': 'en_US.UTF-8', 11:01:19 INFO - 'LANGUAGE': 'en_US:en', 11:01:19 INFO - 'LOGNAME': 'cltbld', 11:01:19 INFO - 'MAIL': '/var/mail/cltbld', 11:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:19 INFO - 'MOZ_NO_REMOTE': '1', 11:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:19 INFO - 'NO_EM_RESTART': '1', 11:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:19 INFO - 'PWD': '/builds/slave/test', 11:01:19 INFO - 'SHELL': '/bin/bash', 11:01:19 INFO - 'SHLVL': '1', 11:01:19 INFO - 'TERM': 'linux', 11:01:19 INFO - 'TMOUT': '86400', 11:01:19 INFO - 'USER': 'cltbld', 11:01:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:19 INFO - '_': '/tools/buildbot/bin/python'} 11:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:01:19 INFO - Cleaning up... 11:01:19 INFO - Return code: 0 11:01:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:19 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:01:19 INFO - Using env: {'DISPLAY': ':0', 11:01:19 INFO - 'HOME': '/home/cltbld', 11:01:19 INFO - 'LANG': 'en_US.UTF-8', 11:01:19 INFO - 'LANGUAGE': 'en_US:en', 11:01:19 INFO - 'LOGNAME': 'cltbld', 11:01:19 INFO - 'MAIL': '/var/mail/cltbld', 11:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:19 INFO - 'MOZ_NO_REMOTE': '1', 11:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:19 INFO - 'NO_EM_RESTART': '1', 11:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:19 INFO - 'PWD': '/builds/slave/test', 11:01:19 INFO - 'SHELL': '/bin/bash', 11:01:19 INFO - 'SHLVL': '1', 11:01:19 INFO - 'TERM': 'linux', 11:01:19 INFO - 'TMOUT': '86400', 11:01:19 INFO - 'USER': 'cltbld', 11:01:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:19 INFO - '_': '/tools/buildbot/bin/python'} 11:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:01:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:22 INFO - Downloading docopt-0.6.1.tar.gz 11:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:22 INFO - Running setup.py install for blobuploader 11:01:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:01:22 INFO - Running setup.py install for requests 11:01:22 INFO - Running setup.py install for docopt 11:01:22 INFO - Successfully installed blobuploader requests docopt 11:01:22 INFO - Cleaning up... 11:01:22 INFO - Return code: 0 11:01:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:22 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:01:22 INFO - Using env: {'DISPLAY': ':0', 11:01:22 INFO - 'HOME': '/home/cltbld', 11:01:22 INFO - 'LANG': 'en_US.UTF-8', 11:01:22 INFO - 'LANGUAGE': 'en_US:en', 11:01:22 INFO - 'LOGNAME': 'cltbld', 11:01:22 INFO - 'MAIL': '/var/mail/cltbld', 11:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:22 INFO - 'MOZ_NO_REMOTE': '1', 11:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:22 INFO - 'NO_EM_RESTART': '1', 11:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:22 INFO - 'PWD': '/builds/slave/test', 11:01:22 INFO - 'SHELL': '/bin/bash', 11:01:22 INFO - 'SHLVL': '1', 11:01:22 INFO - 'TERM': 'linux', 11:01:22 INFO - 'TMOUT': '86400', 11:01:22 INFO - 'USER': 'cltbld', 11:01:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:22 INFO - '_': '/tools/buildbot/bin/python'} 11:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:23 INFO - Running setup.py (path:/tmp/pip-rszU6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:01:23 INFO - Running setup.py (path:/tmp/pip-p__1_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:01:23 INFO - Running setup.py (path:/tmp/pip-rGJ8z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:01:23 INFO - Running setup.py (path:/tmp/pip-tD7sW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:01:23 INFO - Running setup.py (path:/tmp/pip-l2BUKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:01:23 INFO - Running setup.py (path:/tmp/pip-ThnoeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:23 INFO - Running setup.py (path:/tmp/pip-cIUOpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:23 INFO - Running setup.py (path:/tmp/pip-ogsT3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:23 INFO - Running setup.py (path:/tmp/pip-xp8Vle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:23 INFO - Running setup.py (path:/tmp/pip-wfbL0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:23 INFO - Running setup.py (path:/tmp/pip-KLcBZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:23 INFO - Running setup.py (path:/tmp/pip-HWNhGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:23 INFO - Running setup.py (path:/tmp/pip-RCS_nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:24 INFO - Running setup.py (path:/tmp/pip-uOQKRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:24 INFO - Running setup.py (path:/tmp/pip-YKaHRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:24 INFO - Running setup.py (path:/tmp/pip-JKWLZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:24 INFO - Running setup.py (path:/tmp/pip-mJLgXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:01:24 INFO - Running setup.py install for manifestparser 11:01:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:01:24 INFO - Running setup.py install for mozcrash 11:01:24 INFO - Running setup.py install for mozdebug 11:01:24 INFO - Running setup.py install for mozdevice 11:01:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:01:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:01:24 INFO - Running setup.py install for mozfile 11:01:24 INFO - Running setup.py install for mozhttpd 11:01:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:01:24 INFO - Running setup.py install for mozinfo 11:01:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Running setup.py install for mozInstall 11:01:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Running setup.py install for mozleak 11:01:25 INFO - Running setup.py install for mozlog 11:01:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Running setup.py install for moznetwork 11:01:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Running setup.py install for mozprocess 11:01:25 INFO - Running setup.py install for mozprofile 11:01:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Running setup.py install for mozrunner 11:01:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:01:25 INFO - Running setup.py install for mozscreenshot 11:01:25 INFO - Running setup.py install for moztest 11:01:26 INFO - Running setup.py install for mozversion 11:01:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:01:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:01:26 INFO - Cleaning up... 11:01:26 INFO - Return code: 0 11:01:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:26 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:01:26 INFO - Using env: {'DISPLAY': ':0', 11:01:26 INFO - 'HOME': '/home/cltbld', 11:01:26 INFO - 'LANG': 'en_US.UTF-8', 11:01:26 INFO - 'LANGUAGE': 'en_US:en', 11:01:26 INFO - 'LOGNAME': 'cltbld', 11:01:26 INFO - 'MAIL': '/var/mail/cltbld', 11:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:26 INFO - 'MOZ_NO_REMOTE': '1', 11:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:26 INFO - 'NO_EM_RESTART': '1', 11:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:26 INFO - 'PWD': '/builds/slave/test', 11:01:26 INFO - 'SHELL': '/bin/bash', 11:01:26 INFO - 'SHLVL': '1', 11:01:26 INFO - 'TERM': 'linux', 11:01:26 INFO - 'TMOUT': '86400', 11:01:26 INFO - 'USER': 'cltbld', 11:01:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:26 INFO - '_': '/tools/buildbot/bin/python'} 11:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:26 INFO - Running setup.py (path:/tmp/pip-v4BHNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:01:26 INFO - Running setup.py (path:/tmp/pip-DDN9Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:01:26 INFO - Running setup.py (path:/tmp/pip-JW5zUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:01:26 INFO - Running setup.py (path:/tmp/pip-xe_VE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:01:26 INFO - Running setup.py (path:/tmp/pip-kmYNg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:01:26 INFO - Running setup.py (path:/tmp/pip-zCOlAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:26 INFO - Running setup.py (path:/tmp/pip-4WFjkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:26 INFO - Running setup.py (path:/tmp/pip-aNfLKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:27 INFO - Running setup.py (path:/tmp/pip-OfRg8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:27 INFO - Running setup.py (path:/tmp/pip-KhAhtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:27 INFO - Running setup.py (path:/tmp/pip-xkhVnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:27 INFO - Running setup.py (path:/tmp/pip-ECSNTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:27 INFO - Running setup.py (path:/tmp/pip-_xPRhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:27 INFO - Running setup.py (path:/tmp/pip-TPP_SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:27 INFO - Running setup.py (path:/tmp/pip-5Xe9v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:27 INFO - Running setup.py (path:/tmp/pip-JvXkj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:27 INFO - Running setup.py (path:/tmp/pip-Gf7L_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:01:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:29 INFO - Downloading blessings-1.6.tar.gz 11:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:01:29 INFO - Installing collected packages: blessings 11:01:29 INFO - Running setup.py install for blessings 11:01:29 INFO - Successfully installed blessings 11:01:29 INFO - Cleaning up... 11:01:29 INFO - Return code: 0 11:01:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:29 INFO - Reading from file tmpfile_stdout 11:01:29 INFO - Current package versions: 11:01:29 INFO - argparse == 1.2.1 11:01:29 INFO - blessings == 1.6 11:01:29 INFO - blobuploader == 1.2.4 11:01:29 INFO - docopt == 0.6.1 11:01:29 INFO - functools32 == 3.2.3-2 11:01:29 INFO - jsonschema == 2.5.1 11:01:29 INFO - manifestparser == 1.1 11:01:29 INFO - mozInstall == 1.12 11:01:29 INFO - mozcrash == 0.17 11:01:29 INFO - mozdebug == 0.1 11:01:29 INFO - mozdevice == 0.48 11:01:29 INFO - mozfile == 1.2 11:01:29 INFO - mozhttpd == 0.7 11:01:29 INFO - mozinfo == 0.9 11:01:29 INFO - mozleak == 0.1 11:01:29 INFO - mozlog == 3.3 11:01:29 INFO - moznetwork == 0.27 11:01:29 INFO - mozprocess == 0.23 11:01:29 INFO - mozprofile == 0.28 11:01:29 INFO - mozrunner == 6.12 11:01:29 INFO - mozscreenshot == 0.1 11:01:29 INFO - mozsystemmonitor == 0.3 11:01:29 INFO - moztest == 0.7 11:01:29 INFO - mozversion == 1.4 11:01:29 INFO - psutil == 3.1.1 11:01:29 INFO - requests == 1.2.3 11:01:29 INFO - wsgiref == 0.1.2 11:01:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:29 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:01:29 INFO - Using env: {'DISPLAY': ':0', 11:01:29 INFO - 'HOME': '/home/cltbld', 11:01:29 INFO - 'LANG': 'en_US.UTF-8', 11:01:29 INFO - 'LANGUAGE': 'en_US:en', 11:01:29 INFO - 'LOGNAME': 'cltbld', 11:01:29 INFO - 'MAIL': '/var/mail/cltbld', 11:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:29 INFO - 'MOZ_NO_REMOTE': '1', 11:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:29 INFO - 'NO_EM_RESTART': '1', 11:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:29 INFO - 'PWD': '/builds/slave/test', 11:01:29 INFO - 'SHELL': '/bin/bash', 11:01:29 INFO - 'SHLVL': '1', 11:01:29 INFO - 'TERM': 'linux', 11:01:29 INFO - 'TMOUT': '86400', 11:01:29 INFO - 'USER': 'cltbld', 11:01:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:29 INFO - '_': '/tools/buildbot/bin/python'} 11:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:01:30 INFO - Cleaning up... 11:01:30 INFO - Return code: 0 11:01:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:30 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 0x7fd38d5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2889230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:01:30 INFO - Using env: {'DISPLAY': ':0', 11:01:30 INFO - 'HOME': '/home/cltbld', 11:01:30 INFO - 'LANG': 'en_US.UTF-8', 11:01:30 INFO - 'LANGUAGE': 'en_US:en', 11:01:30 INFO - 'LOGNAME': 'cltbld', 11:01:30 INFO - 'MAIL': '/var/mail/cltbld', 11:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:30 INFO - 'MOZ_NO_REMOTE': '1', 11:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:30 INFO - 'NO_EM_RESTART': '1', 11:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:30 INFO - 'PWD': '/builds/slave/test', 11:01:30 INFO - 'SHELL': '/bin/bash', 11:01:30 INFO - 'SHLVL': '1', 11:01:30 INFO - 'TERM': 'linux', 11:01:30 INFO - 'TMOUT': '86400', 11:01:30 INFO - 'USER': 'cltbld', 11:01:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:30 INFO - '_': '/tools/buildbot/bin/python'} 11:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:01:30 INFO - Cleaning up... 11:01:30 INFO - Return code: 0 11:01:30 INFO - Running post-action listener: _resource_record_post_action 11:01:30 INFO - Running post-action listener: _start_resource_monitoring 11:01:30 INFO - Starting resource monitoring. 11:01:30 INFO - [mozharness: 2016-08-31 18:01:30.467735Z] Finished create-virtualenv step (success) 11:01:30 INFO - [mozharness: 2016-08-31 18:01:30.468233Z] Running install step. 11:01:30 INFO - Running pre-action listener: _resource_record_pre_action 11:01:30 INFO - Running main action method: install 11:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:30 INFO - Reading from file tmpfile_stdout 11:01:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:01:30 INFO - Reading from file tmpfile_stdout 11:01:30 INFO - Output received: 11:01:30 INFO - Usage: mozinstall [options] installer 11:01:30 INFO - Options: 11:01:30 INFO - -h, --help show this help message and exit 11:01:30 INFO - -d DEST, --destination=DEST 11:01:30 INFO - Directory to install application into. [default: 11:01:30 INFO - "/builds/slave/test"] 11:01:30 INFO - --app=APP Application being installed. [default: firefox] 11:01:30 INFO - mkdir: /builds/slave/test/build/application 11:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:01:47 INFO - Reading from file tmpfile_stdout 11:01:47 INFO - Output received: 11:01:47 INFO - /builds/slave/test/build/application/firefox/firefox 11:01:47 INFO - Running post-action listener: _resource_record_post_action 11:01:47 INFO - [mozharness: 2016-08-31 18:01:47.466534Z] Finished install step (success) 11:01:47 INFO - [mozharness: 2016-08-31 18:01:47.466813Z] Running run-tests step. 11:01:47 INFO - Running pre-action listener: _resource_record_pre_action 11:01:47 INFO - Running main action method: run_tests 11:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:01:47 INFO - Python 2.7.3 11:01:47 INFO - Return code: 0 11:01:47 INFO - grabbing minidump binary from tooltool 11:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:01:47 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 0x2883090>, '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 0x28869b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2886e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:01:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:01:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:01:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:01:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:47 INFO - Return code: 0 11:01:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:01:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:01:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:01:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:01:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:01:47 INFO - Using env: {'DISPLAY': ':0', 11:01:47 INFO - 'HOME': '/home/cltbld', 11:01:47 INFO - 'LANG': 'en_US.UTF-8', 11:01:47 INFO - 'LANGUAGE': 'en_US:en', 11:01:47 INFO - 'LOGNAME': 'cltbld', 11:01:47 INFO - 'MAIL': '/var/mail/cltbld', 11:01:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:01:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:47 INFO - 'MOZ_NO_REMOTE': '1', 11:01:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:47 INFO - 'NO_EM_RESTART': '1', 11:01:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:47 INFO - 'PWD': '/builds/slave/test', 11:01:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:01:47 INFO - 'SHELL': '/bin/bash', 11:01:47 INFO - 'SHLVL': '1', 11:01:47 INFO - 'TERM': 'linux', 11:01:47 INFO - 'TMOUT': '86400', 11:01:47 INFO - 'USER': 'cltbld', 11:01:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468', 11:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:47 INFO - '_': '/tools/buildbot/bin/python'} 11:01:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:01:47 INFO - mozversion application_buildid: 20160831102122 11:01:47 INFO - mozversion application_changeset: 286a80b932232b2d9c90446c59214a028b5edec9 11:01:47 INFO - mozversion application_display_name: Nightly 11:01:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:47 INFO - mozversion application_name: Firefox 11:01:47 INFO - mozversion application_remotingname: firefox 11:01:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:01:47 INFO - mozversion application_vendor: Mozilla 11:01:47 INFO - mozversion application_version: 51.0a1 11:01:47 INFO - mozversion platform_buildid: 20160831102122 11:01:47 INFO - mozversion platform_changeset: 286a80b932232b2d9c90446c59214a028b5edec9 11:01:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:01:47 INFO - mozversion platform_version: 51.0a1 11:01:47 INFO - using testdate: 1472666507 11:01:47 INFO - actual date: 1472666507 11:01:47 INFO - starting webserver on 'localhost:41165' 11:01:47 INFO - SUITE-START | Running 2 tests 11:01:47 INFO - TEST-START | dromaeo_css 11:01:47 INFO - operating with platform_type : linux_ 11:01:47 INFO - Initialising browser for dromaeo_css test... 11:01:47 INFO - TEST-INFO | started process 4678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeYjq0V/profile http://localhost:41165/getInfo.html) 11:01:52 INFO - PROCESS | 4678 | __metrics Screen width/height:1600/1200 11:01:52 INFO - PROCESS | 4678 | colorDepth:24 11:01:52 INFO - PROCESS | 4678 | Browser inner width/height: 1024/697 11:01:52 INFO - PROCESS | 4678 | __metrics 11:01:52 INFO - PROCESS | 4678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:01:52 INFO - PROCESS | 4678 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:53 INFO - PROCESS | 4678 | console.error: PushService: 11:01:53 INFO - PROCESS | 4678 | stateChangeProcessEnqueue: Error transitioning state 11:01:53 INFO - PROCESS | 4678 | UnknownError 11:01:53 INFO - TEST-INFO | 4678: exit 0 11:01:53 INFO - Browser initialized. 11:01:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:53 INFO - TEST-INFO | started process 4757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeYjq0V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:06 INFO - PROCESS | 4757 | RSS: Main: 182140928 11:02:06 INFO - PROCESS | 4757 | 11:02:57 INFO - PROCESS | 4757 | 1472666577077 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:05:10 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41165/tests/dromaeo/cssquery-ext.html) 11:05:11 INFO - PROCESS | 4757 | RSS: Main: 315305984 11:05:11 INFO - PROCESS | 4757 | 11:08:14 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-ext.html (next: http://localhost:41165/tests/dromaeo/cssquery-jquery.html) 11:08:14 INFO - PROCESS | 4757 | RSS: Main: 283967488 11:08:14 INFO - PROCESS | 4757 | 11:11:17 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41165/tests/dromaeo/cssquery-mootools.html) 11:11:17 INFO - PROCESS | 4757 | RSS: Main: 218066944 11:11:17 INFO - PROCESS | 4757 | 11:14:20 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41165/tests/dromaeo/cssquery-prototype.html) 11:14:20 INFO - PROCESS | 4757 | RSS: Main: 222240768 11:14:20 INFO - PROCESS | 4757 | 11:17:23 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41165/tests/dromaeo/cssquery-yui.html) 11:17:24 INFO - PROCESS | 4757 | RSS: Main: 219439104 11:17:24 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:41165/tests/dromaeo/cssquery-yui.html (next: http://localhost:41165/tests/dromaeo/cssquery-dojo.html) 11:20:27 INFO - PROCESS | 4757 | RSS: Main: 311414784 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | __start_tp_report 11:20:27 INFO - PROCESS | 4757 | _x_x_mozilla_page_load 11:20:27 INFO - PROCESS | 4757 | _x_x_mozilla_page_load_details 11:20:27 INFO - PROCESS | 4757 | |i|pagename|runs| 11:20:27 INFO - PROCESS | 4757 | |0;dojo.html;2578.7245368202634;2582.6513420688207;2596.610508423735;2635.8418494890298;2650.4831557846214;4600.97699511502;4649.9070018599605;4674.368960190373;4757.9524204757945;4833.105875413046;4634.467036290827;4663.300504924263;4677.672562920597;4692.202325604647;4726.692764970283;4279.165562715256;4338.609525142737;4349.499807522144;4350.3474478828275;4358.3462480628;4327.653787696977;4406.317020861771;4460.665450091256;4477.731336119827;4496.123255965072;4449.288113901776;4469.463664360282;4496.55034496551;4525.0949810037955;4530.048689775152;4204.201201771684;4225.809838557272;4284.807183676711;4295.269804133273;4297.35539669049;4205.768682722449;4211.263028969948;4239.915201695949;4324.567543245682;4425.402570652985;4622.468416132154;4628.09752098341;4638.976805115953;4645.837395691168;4659.277811939155;4880.194767863299;4985.35190425246;4992.900141997176;4998.12532806761;5039.143345631252;5115.744212789383;5120.257562653432;5127.2052831811125;5135.101357262502;5192.7403629818355;4714.622830173578;4748.620110391195;4752.857414277577;4781.9043619128115;4821.4696383397795;5036.974815125975;5137.51193636604;5201.557867581298;5224.895502089937;5231.293775340357;4962.851114466572;4986.202207646759;4990.201567749143;5036.244563315532;5053.2420136979745;5074.746262686851;5082.288479612857;5086.618503612244;5088.185890257615;5150.150225212873;4893.632977526629;4903.436104847917;4981.701097934136;5015.924761128586;5030.220315850976;5004.3494345734825;5004.474530174352;5042.924356134661;5066.265391518209;5068.391792984866;4227.598378154071;4230.280852255124;4235.7670328131635;4279.807408666617;4285.978570107191;3630.854765809338;3633.927321453556;3713.053171441319;3738.4953031340965;3790.8104594770152;4350.129974005212;4350.195213885441;4419.513853476115;4428.092241090569;4430.62339701129;5077.416097148875;5083.262926875583;5092.0579692756955;5097.133487307166;5157.922631160535;4414.977925110354;4424.336349547593;4427.40230068943;4434.0245146068455;4480.619147372445;4435.157320109169;4480.9103817924115;4515.751633660115;4533.77331133442;4591.9081618367445;4795.496472870298;4806;4816.373871396696;4817.421909370758;4872.3909511311085;5088;5096.388433388017;5098.719570423662;5107.336046313955;5108.412532558803;4645.86062418128;4791.401074865642;4805.471398146271;4812.085703716282;4816.603185076288;4982.8754281143265;5008.273800299009;5009.899802004013;5018.04657115147;5068.163752980717;5079.11115554769;5091.338126043739;5094.414142373675;5095.974520127524;5097.745112744422;4767.284907263938;4819.204831202953;4871.732054737024;4907.509249075064;4915.090708218991;4954.479779623088;4958.826441074545;4959.355283813081;4960.8759781005765;5007.924881126859;4881.29221262922;4881.780319885685;4882.853514394574;4897.094037603055;4940.901181976412;4813.566778989908;4918.262260660929;4948.282499037691;4971.751412429437;5036.622253331088;4879.780409881493;4879.853604391874;4881.121398148367;4927.063857866994;4933.260010998379 11:20:27 INFO - PROCESS | 4757 | |1;ext.html;572.4132763916986;579.6811753535557;581.1254062635734;581.6451964301775;583.0641819879097;28012.57981130282;30711.385772284542;30776.69223307766;30866.84566577164;30934.53598196029;30245.3950920982;40381;41417.792911035474;41494.58505414945;45035.77482112593;7632.427567932414;7747.767566973;7752.689892404297;7762.9611851940945;7764.650590723431;7614.8477030459635;7620.9237907621045;7666.00341955545;7699.345555627779;7701.22987701231;7687.154413014564;7707.6916923323;7719.536827790323;7720;7728.7681369559;7671.309582137606;7724.6137693115115;7724.922750772476;7726.304632583066;7730.149683534807;7706.38348932084;7757.301842834116;7762.184970578121;7769.067711874554;7769.184235655288;38598.22803543913;38891.22217555633;38918;38937.41593876094;38961.610383896084;2854.728800763924;2960.767599072218;2991.1624745071413;3020.2600362911007;3038.756899448061;28954.27614309638;28998.565021524693;29042.564361534594;29187.124386268446;30663.233419164477;3342;3365.848536815849;3366.7271280512787;3378.1048022274117;3417.5557177566757;242838;243836;244691;244820;245262;31541.369172616418;32380.142978553406;51559.226611600854;51865.48134518607;52036.47963520392;33146.3370732584;33308.500372493945;33343.832650877615;33355.16612084669;33372.165695857795;11617.6514704559;11665.533378664759;11673.241239319417;11679.88320116805;11697.2981621103;11385.886141138482;11681.941590292165;11687.357195354338;11696.356700381391;11701.180917335874;7724.6523906424345;7746.883796743054;7770.844583108306;7839.412044096715;7846.8430631387055;3033.605631267921;3039.7416219621136;3041.2700951771417;3052.8931487397836;3075.1235897769475;809.3606051219589;853.1425916953422;858.296197118357;944.15026476172;951.8905325887612;26711.732882671313;27514.44971100567;28013.299667508476;28164;28402.573961390597;754.6302311867146;899.5951821680139;924.339097545245;938.3585207640471;1015.2690063154517;13756.931215343859;14625.78061329081;14639.92680036593;14683.55949321522;14908.403663853542;361455;364727;364933;365298;365309;46871.76564117226;47319.29021064687;47348.28977565339;47361.763191183825;47429;1076.359566058194;1160.14729174057;1179.5281887245171;1183.8224266360114;1189.74420499593;27762.861185693942;29090.27274318159;29178.56232156562;29923.55114673238;29938.70061299359;41046.58953410547;41639.7918010408;41682;41721.58278417177;41756;293716;294734;295263;295542;514337;37768.43347349737;38095.42856857094;38173.80913095417;38512.61487385202;38987.41518877276;42160;42386;42663.36004959866;42693.35959960665;43380.56619433891;36216;36429.81785091058;36479;36483.635163648025;36904.09534474471;35011.82494087513;35229.64770352366;35483.64516354803;35525.82237088798;35701.82149089238;35383.11542211465;35629.28741425209;35682;35779.28441431105;35956.64043359533;31014.22464438317;32260.19349516281;32773.67226327706;33359;36299.63700362963;25093.623595645713;25745;25771;25776.61335080013;26228.475430491664 11:20:27 INFO - PROCESS | 4757 | |2;jquery.html;344.35949134609604;361.8661095394704;365.88108864619005;368.4822823932375;387.4981898441518;12427.316497592628;16108.838911610881;16459.588510287234;17777.37779177729;18000.909995450038;15230.162341071236;15360.539183824503;15388.538343849674;16119.435819746312;17363.913180434112;5023.648344615869;5194.298769666085;5240.187770895517;5427.348718153827;5463.7814487420455;3481.6692414220734;3645.9270814583692;5515.862103447405;5551.833444996657;5553.666779993213;3693.5013773140686;3698.722595805312;5236.31927849379;5487.780488780444;5494.340679118512;5554.9722251388885;5564.554835613141;5566.443355664422;5705.5435565154685;6041.214642096544;5385.703786291752;5386.084365657847;5388.218708287276;5395.78416863325;5398.433164517708;10912.345259284468;11389.943050284779;20623.896880515502;20774.272900448414;20809.687854682194;1956.814102660245;2142.882141482218;2299.2297580310615;2316.968948817777;2381;8834.69078582253;8931.419457735226;9168.495732734697;9711.465869377182;12337.93831030848;1690.1802625726514;1723.2934496856353;1746.685596592613;1749.8512626426768;1782.8841125326812;68138.65930670315;72879.63560182218;73396.63301683511;75032.62483687601;75730.24269757287;8415.789605259917;8926.330525210635;9072.228860546795;10013.499325033865;10210.642627508001;11921.403929803475;12037;12079.335636540074;12087.697807554705;12098.213616114925;5810.82567522975;5931.25028116698;5940.61386009908;6426.74293028283;7468.887966680504;7258.927410725931;7292.562446253241;7337.449691273069;7527.096748390229;7572;3746.2132952079824;3819.4461803038403;4001.1797581495725;4186.602272784081;4229.851955181553;1741.1729428521605;1744.345870298638;1795.353672677835;1810.4387639831432;1815.3283285184302;836.3768992100923;861.7716305179133;874.4185116897319;908.0601577367393;940.4310392212612;15594.610134746723;16802.83197168037;17021.48935531936;17093.401730939608;17815.376461823773;785.7249962513189;829.1749709039544;844.5861527851308;849.6049337058298;864.2783275964514;8769.342299327576;8995.505247211335;9574.090461406155;9661.323707340418;9792.706218813448;389513;399510;399525;399714;401420;83802;84509;84874.5756271227;86337.56831215929;87174.56412717896;957.6408846682494;970.5001924009;973.2992245583168;977.2768151567789;979.1383582447543;14653.267336633338;14927.179005154387;14985.475508357154;15052;15646.374145034071;38360;38912;39308.6069139305;39333.606663932995;39539.40690889581;53943;54824.177637336266;55132;58300;59226.70386648039;6524.184476940382;7204.89192662121;7661.885071723817;7740.612969351622;7890.210978902064;9025.729228123168;11935.462904169159;12002.21985570935;12150.57472988441;12747.043971702346;7841;10124.34191777532;10393.740156496147;10447.216458765472;10503.579856805642;10183.541740621542;10298.691039268833;10660.46697665129;10913;11242.83135752948;10358.585656573954;10546.525406356579;10689.30519516229;10943.343399396063;11013.394263315595;7818.569978651229;7828.138904720362;7999.920000799918;8054.83890322202;8054.8791768122355;8023.237792409712;10126.44304563256;10184.694459166238;10280.383177009404;11056.613018544313 11:20:27 INFO - PROCESS | 4757 | |3;mootools.html;1371.143035602748;1409.09113621714;1514.8257950335715;1670.8304187069054;1736.6439879824636;7435.367993720533;7986.880196797053;7988.081370642363;7992.92007079929;8006.879896801545;6781.389674929255;7553.773386798405;7815.101263354716;7822.8044298892555;7828.882566761489;2173.641349177388;2199.3951663292564;2208.1277895231374;2209.7569267380577;2210.3258506155616;2152.709384233124;2172.913083476659;2249.4826189976316;2252.234240358278;2253.740819805727;2183.0394626364427;2187.6062308784412;2201.273579718689;2202.8017478426937;2211.8562293450955;2149.935501934937;2155.482684155807;2158.0396723458066;2158.7733288004692;2159.9892000539976;2097.171617211193;2112.461322362803;2112.6091673040537;2112.852100352976;2115.862468939514;7981.042274926988;8034.236747508978;8097.392695547857;8099.55452450115;8103.149169337253;4645.419322584677;4752.405949256343;4762.357081793948;4762.9523704763205;4763.071201115784;2907.6220091387986;3024.8185108893535;3040.407120611482;3057.877684892602;3085.9074227773203;990.8365119755232;1055.941923194224;1057.2123767792966;1792.9820701793076;1846.8891866488054;10698.144148468104;10737.141028717684;10754.354738715623;10808.459577021118;10819.134469242363;4008.2985477541315;4096.979515102465;4224.809883555247;4257.914841703148;4261.722988005769;8483.787905302417;8483.95758021206;8484.53335066565;8487.321014318839;8490.448120872246;4552.157850797613;4569.748663823521;4572.108438854458;4581.5647513486165;4582.793774280165;3730.9440358394104;4105.507339119265;4190.916181676411;4249.87250382489;4257.552956939477;3389.8983030509125;3497.9125521862156;3514.384982628081;3609.6209897960334;3614.2229420674157;1069.8341757027517;1071.164491696478;1084.9963783500389;1091.1325496230515;1092.847001419802;794.3367288314207;809.7246936041774;825.4469505431375;825.8307047055339;830.1366578758024;5046.44489106198;5086.338775959176;5089.414717307557;5157.355330583677;5279.260903473517;406.7478163538625;409.1224323825378;411.2330503610804;424.4609346130397;425.79561810330597;3543.9291214175573;3549.769264997767;3641.5630124385243;3648.343298206348;3674.632536746304;9537.523123843781;9980.650677226262;9980.850287245697;9981.60073597048;10004.749881253027;9808.95095524532;9887.258455615858;9963.551640176209;9964.25268104895;9975.650852220137;7371.967924490576;7415.369693576106;7448.031755871702;7457.664405101784;7468.103827540621;4820.566149046603;4922.483139270468;4926.310316555613;5014.247862820606;5165.793368265227;8859.666202365399;8977.865332020156;9058.456492610465;9152.084791520794;9232;9140.63437462494;9258.675946341846;9266.629334826532;9287.86068208991;9334.113259240361;6194.81415557534;6201.968990155201;6234.096056071935;6268.874622507433;6300.338464461349;7557.735479258419;7623.352015078781;7625.771226863203;7627.694892204249;7629;6443.67781610927;6513.413792758485;6542.182227221598;6602.349412646839;6705.0612914193025;6768.695408706521;6803.285655006351;6811.2167100784045;6821.1814582250445;6865.828354291183;6243.250809902841;6252.187215661935;6314.652694101685;6316.210473690789;6318.336574659595;4356.346548017823;4388.385626012297;4393.868183954486;4415;4481.641468682433;4256.7445953242905;4361.214981303396;4362.890927726832;4383.777529524427;4518.186726389282 11:20:27 INFO - PROCESS | 4757 | |4;prototype.html;301.89282804604363;302.101248784865;307.72304925566993;310.48304572886144;313.80230454813466;4860.951390486099;4876.829310974116;4887.511248875111;4889.633277504193;4898.975505122474;4801.399825021872;4824.27635854622;4826.1554228010045;4832.516748325165;4838.75806209689;3603.8738644147393;3711.5917249102577;3711.851525938959;3718.721095917817;3742.906427339311;3688.7602305850032;3795.867144649938;3804.5054142961376;3828.9808550957205;3835.712321575879;3757.7745335279833;3761.4357846323132;3762.7177961652988;3766.7193154327524;3769.8303576338994;3587.318409502186;3751.1559899022773;3754.9812250938708;3780.7920564368947;3787.16682329887;3298.653641367646;3302.9504557431655;3304.9008529744146;3308.7022168004996;3326.6839650233187;4639.188142075123;4701.153792317382;4716.127516409441;4722.95277047232;4725.834595789165;4294.959894050332;4297.419848320499;4302.849400271007;4305.375720520538;4308.763018034007;4933.506649335038;5029.170186919154;5036.143855544567;5039.647224694273;5055.8988820223385;3593.3111437624534;3605.152789094561;3609.1157666371646;3610.783352998802;3616.2044350242904;5244.737763111829;5276.9446110778;5277.656952298088;5289.233061206142;5324.440933701983;3453.547980933515;3597.31650986317;3636.781793092423;3708.9814550927613;3716.572594151707;3660.108514273747;3664.9083772905356;3681.3005528949416;3684.7236457265813;3691.9446208306895;4186.874393768192;4200.2617670273485;4206.26390381682;4211.494620645542;4217.641500472433;4866.853994380174;4991.101601711727;5008.974955125201;5012.949870501248;5028.195488721787;1273.8535068467245;1277.6231011851526;1277.9552715654906;1279.4945996331396;1279.5649479177125;792.2711105782694;813.4712436915934;827.7309874290879;829.3199576347337;834.8747687846871;4300.591443812833;4403.603675669206;4415.977920110379;4459.710118842265;4465.9058530660195;5177.488917874828;5225.790968361299;5239.925815207873;5246.921296180561;5254.789808407697;4558.020025694492;4559.908801823945;4560.543945605479;4562.608404436613;4566.771661416916;2632.420867409167;2744.2727677165567;2761.3293957156034;2764.557670772667;2764.903228386997;4891.755412229374;4903.828366007244;4915.090708218991;4926.1379258629595;4926.531979461945;5070.898582028339;5298.496642818926;5332;5336.519713225828;5340.893182136336;4895.755212239374;4926.852194434173;4927.655064145619;4927.9507204927495;4944.950550494521;5145.202493613496;5156.7421628917655;5194.909069095533;5204.791808327776;5258.973705131603;4874.8050077997905;4979.502049794992;5063.7468126592785;5116.2069879168785;5123.205903084879;4869.829555965524;4906.681065730716;4924.458309585871;4925.408950925912;4926.48271931442;3681.8152298262344;3694.3719567673024;3697.685696715809;3703.7037037036434;3720.572134204493;4961.950380496149;5194.714290714047;5215.55667768244;5219.2693022976055;5227.320448341691;4960.759810047488;4964.528369804862;4999.400311837751;5016.297718319511;5028.748562571784;4971.850844474671;4976.253561965734;4978.5270399312;4982.060584255307;4983.9003219934675;4726.929096063631;4913.754312284443;4918.393251576527;4958.7024778513405;4968.478309777422;4787.569118779326;4908.7545622719435;5001.799928002984;5063;5070.746462676925;4961.7271050092595;4966.379202599675;4968.577670898014;4969.1800852860315;4993.725345106054 11:20:27 INFO - PROCESS | 4757 | |5;yui.html;638.0365647871712;638.8243233110896;640.9455196308313;660.818274974382;661.7386132477671;13370.331483425827;13456.93271533641;13563.932180339098;13574.932125339385;13607.387667554958;13571.52499662512;13818.723625527484;13829.308534573256;13837.817302020541;13855.307234638252;619.3775255867846;733.9633018349087;769.1270408086834;782.5148407987056;782.788647065292;625.7872323410039;637.5250438423382;637.8022812928007;749.1721647579428;776.1850057439694;810.5947026486757;815.0708192660372;819.7458787775779;821.2731732416825;821.5686764448652;814.1044850664251;814.5235037503068;814.7352110564091;814.8859159717645;815.0748899998545;477.15305333033797;577.5062321714958;589.3840936221659;600.0069884341378;600.726669365442;13391.464341426332;13457.663558411117;13463.798043029363;13470.461181552726;13564.864351356557;12634.557790477289;13009.414576343992;13300.467981280737;13359.666008349772;13814.68760467754;9974.850377244347;10066.496675166212;10075.848862267072;10324.43806886623;12031.09766767496;4073.1293785394796;4088.4071809587444;4117.094239267386;4123.793810309502;4324.416203812477;59806.40193598052;60119;60749.088763669024;61234.69382653058;62043.68978155126;10115.848262276071;10237.385756854612;10362.637307694195;10420.32267902584;10478.00917825626;18074.18666160026;18097.728534072;18099.185536650883;18143.63712725738;18196.90901545484;6816.659167041628;6843.863122737617;6867.381935625817;6978.267281935425;7119.89320160198;3779.6220377961986;3788.8105594720155;3799.962000380016;3801.239752049601;3857.7685338879755;2899.3476467795;3008.8044277121917;3010.1421094987822;3010.864511097006;3011.5482677598534;511.6904272914907;514.3596222702758;522.7281813456981;528.9418164001956;567.9914801277985;529.9152135658276;601.3955974245855;603.2067830802481;604.1330690459205;617.1483352972868;7548.886766698504;7703.807404814925;7731.652075656497;7922.36621070313;7932.5637089959455;496.65730645854245;502.3344069108446;575.2981362737454;579.2614416618844;582.9621074630136;3371.494275858641;3649.5073165122367;3665.633436656313;3697.3344797936093;3806.657400833938;103112.48443757734;105319;107461.4030877528;107723;107888.46055769672;91526.54236728908;93573;93715;94090;94248;80468;80471;80933.59533202296;81374.18625813785;81602.5919870385;6808.421284190701;7060.54106483077;7196.640167991475;7258.818529536804;7358.595277259802;46391;47733.76133119312;48096.27855582239;49707;50352;60251.39748602458;70914;70919.29080709333;71508.64245678738;71843.64078179575;9476.384035037701;9943.751406214902;10029;10200.795984080425;10572.735681608021;10915.345079295268;11021.83467248008;11079.371251663773;11247.606333778278;12458.439370228543;9855.11303982645;9998.900010999796;10157.085862272432;10398.428086455318;10691.465426728788;9734.853977190489;9841.45871977048;9851.310408271353;9885.505724713592;9887.851682224917;9441.858372124561;9898.505074746377;9945.552450139905;10070.791505019444;10441.895581044093;8086.959565202136;8141.8778718320455;8431;8444.535550544779;8719.221604448127;8207.917920820715;8390.874136887829;8592.527410992456;8665.2634526066;8701.521416322163 11:20:27 INFO - PROCESS | 4757 | __end_tp_report 11:20:27 INFO - PROCESS | 4757 | __start_cc_report 11:20:27 INFO - PROCESS | 4757 | _x_x_mozilla_cycle_collect,1195 11:20:27 INFO - PROCESS | 4757 | __end_cc_report 11:20:27 INFO - PROCESS | 4757 | __startTimestamp1472667627449__endTimestamp 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | ------- Summary: start ------- 11:20:27 INFO - PROCESS | 4757 | Number of tests: 6 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | [#0] dojo.html Cycles:165 Average:4677.28 Median:4816.60 stddev:499.62 (10.4%) stddev-sans-first:473.25 11:20:27 INFO - PROCESS | 4757 | Values: 2578.7 2582.7 2596.6 2635.8 2650.5 4601.0 4649.9 4674.4 4758.0 4833.1 4634.5 4663.3 4677.7 4692.2 4726.7 4279.2 4338.6 4349.5 4350.3 4358.3 4327.7 4406.3 4460.7 4477.7 4496.1 4449.3 4469.5 4496.6 4525.1 4530.0 4204.2 4225.8 4284.8 4295.3 4297.4 4205.8 4211.3 4239.9 4324.6 4425.4 4622.5 4628.1 4639.0 4645.8 4659.3 4880.2 4985.4 4992.9 4998.1 5039.1 5115.7 5120.3 5127.2 5135.1 5192.7 4714.6 4748.6 4752.9 4781.9 4821.5 5037.0 5137.5 5201.6 5224.9 5231.3 4962.9 4986.2 4990.2 5036.2 5053.2 5074.7 5082.3 5086.6 5088.2 5150.2 4893.6 4903.4 4981.7 5015.9 5030.2 5004.3 5004.5 5042.9 5066.3 5068.4 4227.6 4230.3 4235.8 4279.8 4286.0 3630.9 3633.9 3713.1 3738.5 3790.8 4350.1 4350.2 4419.5 4428.1 4430.6 5077.4 5083.3 5092.1 5097.1 5157.9 4415.0 4424.3 4427.4 4434.0 4480.6 4435.2 4480.9 4515.8 4533.8 4591.9 4795.5 4806.0 4816.4 4817.4 4872.4 5088.0 5096.4 5098.7 5107.3 5108.4 4645.9 4791.4 4805.5 4812.1 4816.6 4982.9 5008.3 5009.9 5018.0 5068.2 5079.1 5091.3 5094.4 5096.0 5097.7 4767.3 4819.2 4871.7 4907.5 4915.1 4954.5 4958.8 4959.4 4960.9 5007.9 4881.3 4881.8 4882.9 4897.1 4940.9 4813.6 4918.3 4948.3 4971.8 5036.6 4879.8 4879.9 4881.1 4927.1 4933.3 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | [#1] ext.html Cycles:180 Average:45917.36 Median:35867.96 stddev:85605.78 (238.7%) stddev-sans-first:85778.23 11:20:27 INFO - PROCESS | 4757 | Values: 572.4 579.7 581.1 581.6 583.1 28012.6 30711.4 30776.7 30866.8 30934.5 30245.4 40381.0 41417.8 41494.6 45035.8 7632.4 7747.8 7752.7 7763.0 7764.7 7614.8 7620.9 7666.0 7699.3 7701.2 7687.2 7707.7 7719.5 7720.0 7728.8 7671.3 7724.6 7724.9 7726.3 7730.1 7706.4 7757.3 7762.2 7769.1 7769.2 38598.2 38891.2 38918.0 38937.4 38961.6 2854.7 2960.8 2991.2 3020.3 3038.8 28954.3 28998.6 29042.6 29187.1 30663.2 3342.0 3365.8 3366.7 3378.1 3417.6 242838.0 243836.0 244691.0 244820.0 245262.0 31541.4 32380.1 51559.2 51865.5 52036.5 33146.3 33308.5 33343.8 33355.2 33372.2 11617.7 11665.5 11673.2 11679.9 11697.3 11385.9 11681.9 11687.4 11696.4 11701.2 7724.7 7746.9 7770.8 7839.4 7846.8 3033.6 3039.7 3041.3 3052.9 3075.1 809.4 853.1 858.3 944.2 951.9 26711.7 27514.4 28013.3 28164.0 28402.6 754.6 899.6 924.3 938.4 1015.3 13756.9 14625.8 14639.9 14683.6 14908.4 361455.0 364727.0 364933.0 365298.0 365309.0 46871.8 47319.3 47348.3 47361.8 47429.0 1076.4 1160.1 1179.5 1183.8 1189.7 27762.9 29090.3 29178.6 29923.6 29938.7 41046.6 41639.8 41682.0 41721.6 41756.0 293716.0 294734.0 295263.0 295542.0 514337.0 37768.4 38095.4 38173.8 38512.6 38987.4 42160.0 42386.0 42663.4 42693.4 43380.6 36216.0 36429.8 36479.0 36483.6 36904.1 35011.8 35229.6 35483.6 35525.8 35701.8 35383.1 35629.3 35682.0 35779.3 35956.6 31014.2 32260.2 32773.7 33359.0 36299.6 25093.6 25745.0 25771.0 25776.6 26228.5 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | [#2] jquery.html Cycles:180 Average:24819.48 Median:202710.59 stddev:66057.82 (32.6%) stddev-sans-first:66217.57 11:20:27 INFO - PROCESS | 4757 | Values: 344.4 361.9 365.9 368.5 387.5 12427.3 16108.8 16459.6 17777.4 18000.9 15230.2 15360.5 15388.5 16119.4 17363.9 5023.6 5194.3 5240.2 5427.3 5463.8 3481.7 3645.9 5515.9 5551.8 5553.7 3693.5 3698.7 5236.3 5487.8 5494.3 5555.0 5564.6 5566.4 5705.5 6041.2 5385.7 5386.1 5388.2 5395.8 5398.4 10912.3 11389.9 20623.9 20774.3 20809.7 1956.8 2142.9 2299.2 2317.0 2381.0 8834.7 8931.4 9168.5 9711.5 12337.9 1690.2 1723.3 1746.7 1749.9 1782.9 68138.7 72879.6 73396.6 75032.6 75730.2 8415.8 8926.3 9072.2 10013.5 10210.6 11921.4 12037.0 12079.3 12087.7 12098.2 5810.8 5931.3 5940.6 6426.7 7468.9 7258.9 7292.6 7337.4 7527.1 7572.0 3746.2 3819.4 4001.2 4186.6 4229.9 1741.2 1744.3 1795.4 1810.4 1815.3 836.4 861.8 874.4 908.1 940.4 15594.6 16802.8 17021.5 17093.4 17815.4 785.7 829.2 844.6 849.6 864.3 8769.3 8995.5 9574.1 9661.3 9792.7 389513.0 399510.0 399525.0 399714.0 401420.0 83802.0 84509.0 84874.6 86337.6 87174.6 957.6 970.5 973.3 977.3 979.1 14653.3 14927.2 14985.5 15052.0 15646.4 38360.0 38912.0 39308.6 39333.6 39539.4 53943.0 54824.2 55132.0 58300.0 59226.7 6524.2 7204.9 7661.9 7740.6 7890.2 9025.7 11935.5 12002.2 12150.6 12747.0 7841.0 10124.3 10393.7 10447.2 10503.6 10183.5 10298.7 10660.5 10913.0 11242.8 10358.6 10546.5 10689.3 10943.3 11013.4 7818.6 7828.1 7999.9 8054.8 8054.9 8023.2 10126.4 10184.7 10280.4 11056.6 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | [#3] mootools.html Cycles:180 Average:5126.40 Median:4698.91 stddev:2912.02 (62.0%) stddev-sans-first:2906.51 11:20:27 INFO - PROCESS | 4757 | Values: 1371.1 1409.1 1514.8 1670.8 1736.6 7435.4 7986.9 7988.1 7992.9 8006.9 6781.4 7553.8 7815.1 7822.8 7828.9 2173.6 2199.4 2208.1 2209.8 2210.3 2152.7 2172.9 2249.5 2252.2 2253.7 2183.0 2187.6 2201.3 2202.8 2211.9 2149.9 2155.5 2158.0 2158.8 2160.0 2097.2 2112.5 2112.6 2112.9 2115.9 7981.0 8034.2 8097.4 8099.6 8103.1 4645.4 4752.4 4762.4 4763.0 4763.1 2907.6 3024.8 3040.4 3057.9 3085.9 990.8 1055.9 1057.2 1793.0 1846.9 10698.1 10737.1 10754.4 10808.5 10819.1 4008.3 4097.0 4224.8 4257.9 4261.7 8483.8 8484.0 8484.5 8487.3 8490.4 4552.2 4569.7 4572.1 4581.6 4582.8 3730.9 4105.5 4190.9 4249.9 4257.6 3389.9 3497.9 3514.4 3609.6 3614.2 1069.8 1071.2 1085.0 1091.1 1092.8 794.3 809.7 825.4 825.8 830.1 5046.4 5086.3 5089.4 5157.4 5279.3 406.7 409.1 411.2 424.5 425.8 3543.9 3549.8 3641.6 3648.3 3674.6 9537.5 9980.7 9980.9 9981.6 10004.7 9809.0 9887.3 9963.6 9964.3 9975.7 7372.0 7415.4 7448.0 7457.7 7468.1 4820.6 4922.5 4926.3 5014.2 5165.8 8859.7 8977.9 9058.5 9152.1 9232.0 9140.6 9258.7 9266.6 9287.9 9334.1 6194.8 6202.0 6234.1 6268.9 6300.3 7557.7 7623.4 7625.8 7627.7 7629.0 6443.7 6513.4 6542.2 6602.3 6705.1 6768.7 6803.3 6811.2 6821.2 6865.8 6243.3 6252.2 6314.7 6316.2 6318.3 4356.3 4388.4 4393.9 4415.0 4481.6 4256.7 4361.2 4362.9 4383.8 4518.2 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | [#4] prototype.html Cycles:180 Average:4184.81 Median:4835.64 stddev:1218.96 (25.2%) stddev-sans-first:1187.03 11:20:27 INFO - PROCESS | 4757 | Values: 301.9 302.1 307.7 310.5 313.8 4861.0 4876.8 4887.5 4889.6 4899.0 4801.4 4824.3 4826.2 4832.5 4838.8 3603.9 3711.6 3711.9 3718.7 3742.9 3688.8 3795.9 3804.5 3829.0 3835.7 3757.8 3761.4 3762.7 3766.7 3769.8 3587.3 3751.2 3755.0 3780.8 3787.2 3298.7 3303.0 3304.9 3308.7 3326.7 4639.2 4701.2 4716.1 4723.0 4725.8 4295.0 4297.4 4302.8 4305.4 4308.8 4933.5 5029.2 5036.1 5039.6 5055.9 3593.3 3605.2 3609.1 3610.8 3616.2 5244.7 5276.9 5277.7 5289.2 5324.4 3453.5 3597.3 3636.8 3709.0 3716.6 3660.1 3664.9 3681.3 3684.7 3691.9 4186.9 4200.3 4206.3 4211.5 4217.6 4866.9 4991.1 5009.0 5012.9 5028.2 1273.9 1277.6 1278.0 1279.5 1279.6 792.3 813.5 827.7 829.3 834.9 4300.6 4403.6 4416.0 4459.7 4465.9 5177.5 5225.8 5239.9 5246.9 5254.8 4558.0 4559.9 4560.5 4562.6 4566.8 2632.4 2744.3 2761.3 2764.6 2764.9 4891.8 4903.8 4915.1 4926.1 4926.5 5070.9 5298.5 5332.0 5336.5 5340.9 4895.8 4926.9 4927.7 4928.0 4945.0 5145.2 5156.7 5194.9 5204.8 5259.0 4874.8 4979.5 5063.7 5116.2 5123.2 4869.8 4906.7 4924.5 4925.4 4926.5 3681.8 3694.4 3697.7 3703.7 3720.6 4962.0 5194.7 5215.6 5219.3 5227.3 4960.8 4964.5 4999.4 5016.3 5028.7 4971.9 4976.3 4978.5 4982.1 4983.9 4726.9 4913.8 4918.4 4958.7 4968.5 4787.6 4908.8 5001.8 5063.0 5070.7 4961.7 4966.4 4968.6 4969.2 4993.7 11:20:27 INFO - PROCESS | 4757 | 11:20:27 INFO - PROCESS | 4757 | [#5] yui.html Cycles:180 Average:18405.49 Median:30197.89 stddev:27664.43 (91.6%) stddev-sans-first:27709.87 11:20:27 INFO - PROCESS | 4757 | Values: 638.0 638.8 640.9 660.8 661.7 13370.3 13456.9 13563.9 13574.9 13607.4 13571.5 13818.7 13829.3 13837.8 13855.3 619.4 734.0 769.1 782.5 782.8 625.8 637.5 637.8 749.2 776.2 810.6 815.1 819.7 821.3 821.6 814.1 814.5 814.7 814.9 815.1 477.2 577.5 589.4 600.0 600.7 13391.5 13457.7 13463.8 13470.5 13564.9 12634.6 13009.4 13300.5 13359.7 13814.7 9974.9 10066.5 10075.8 10324.4 12031.1 4073.1 4088.4 4117.1 4123.8 4324.4 59806.4 60119.0 60749.1 61234.7 62043.7 10115.8 10237.4 10362.6 10420.3 10478.0 18074.2 18097.7 18099.2 18143.6 18196.9 6816.7 6843.9 6867.4 6978.3 7119.9 3779.6 3788.8 3800.0 3801.2 3857.8 2899.3 3008.8 3010.1 3010.9 3011.5 511.7 514.4 522.7 528.9 568.0 529.9 601.4 603.2 604.1 617.1 7548.9 7703.8 7731.7 7922.4 7932.6 496.7 502.3 575.3 579.3 583.0 3371.5 3649.5 3665.6 3697.3 3806.7 103112.5 105319.0 107461.4 107723.0 107888.5 91526.5 93573.0 93715.0 94090.0 94248.0 80468.0 80471.0 80933.6 81374.2 81602.6 6808.4 7060.5 7196.6 7258.8 7358.6 46391.0 47733.8 48096.3 49707.0 50352.0 60251.4 70914.0 70919.3 71508.6 71843.6 9476.4 9943.8 10029.0 10200.8 10572.7 10915.3 11021.8 11079.4 11247.6 12458.4 9855.1 9998.9 10157.1 10398.4 10691.5 9734.9 9841.5 9851.3 9885.5 9887.9 9441.9 9898.5 9945.6 10070.8 10441.9 8087.0 8141.9 8431.0 8444.5 8719.2 8207.9 8390.9 8592.5 8665.3 8701.5 11:20:27 INFO - PROCESS | 4757 | -------- Summary: end -------- 11:20:27 INFO - PROCESS | 4757 | 11:20:28 INFO - TEST-INFO | 4757: exit 0 11:20:28 INFO - TEST-OK | dromaeo_css | took 1120692ms 11:20:28 INFO - TEST-START | kraken 11:20:28 INFO - operating with platform_type : linux_ 11:20:28 INFO - Initialising browser for kraken test... 11:20:28 INFO - TEST-INFO | started process 5066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkHTSA4/profile http://localhost:41165/getInfo.html) 11:20:32 INFO - PROCESS | 5066 | __metrics Screen width/height:1600/1200 11:20:32 INFO - PROCESS | 5066 | colorDepth:24 11:20:32 INFO - PROCESS | 5066 | Browser inner width/height: 1024/697 11:20:32 INFO - PROCESS | 5066 | __metrics 11:20:33 INFO - PROCESS | 5066 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:20:33 INFO - PROCESS | 5066 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:34 INFO - TEST-INFO | 5066: exit 0 11:20:34 INFO - Browser initialized. 11:20:34 INFO - Running cycle 1/1 for kraken test... 11:20:34 INFO - TEST-INFO | started process 5147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkHTSA4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:46 INFO - PROCESS | 5147 | RSS: Main: 181682176 11:20:46 INFO - PROCESS | 5147 | 11:20:49 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:50 INFO - PROCESS | 5147 | RSS: Main: 243531776 11:20:50 INFO - PROCESS | 5147 | 11:20:53 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-dft) 11:20:53 INFO - PROCESS | 5147 | RSS: Main: 225947648 11:20:53 INFO - PROCESS | 5147 | 11:20:57 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-fft) 11:20:57 INFO - PROCESS | 5147 | RSS: Main: 303415296 11:20:57 INFO - PROCESS | 5147 | 11:20:59 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41165/tests/kraken/driver.html?testName=audio-oscillator) 11:21:00 INFO - PROCESS | 5147 | RSS: Main: 213921792 11:21:00 INFO - PROCESS | 5147 | 11:21:02 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:03 INFO - PROCESS | 5147 | RSS: Main: 215552000 11:21:03 INFO - PROCESS | 5147 | 11:21:06 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41165/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:07 INFO - PROCESS | 5147 | RSS: Main: 253497344 11:21:07 INFO - PROCESS | 5147 | 11:21:10 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41165/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:11 INFO - PROCESS | 5147 | RSS: Main: 247734272 11:21:11 INFO - PROCESS | 5147 | 11:21:14 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41165/tests/kraken/driver.html?testName=json-parse-financial) 11:21:14 INFO - PROCESS | 5147 | RSS: Main: 251252736 11:21:14 INFO - PROCESS | 5147 | 11:21:16 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:17 INFO - PROCESS | 5147 | RSS: Main: 214675456 11:21:17 INFO - PROCESS | 5147 | 11:21:18 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:19 INFO - PROCESS | 5147 | RSS: Main: 222269440 11:21:19 INFO - PROCESS | 5147 | 11:21:21 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:22 INFO - PROCESS | 5147 | RSS: Main: 222986240 11:21:22 INFO - PROCESS | 5147 | 11:21:25 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:25 INFO - PROCESS | 5147 | RSS: Main: 223940608 11:21:25 INFO - PROCESS | 5147 | 11:21:28 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:21:29 INFO - PROCESS | 5147 | RSS: Main: 221478912 11:21:29 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | Cycle 1(1): loaded http://localhost:41165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41165/tests/kraken/driver.html?testName=ai-astar) 11:21:31 INFO - PROCESS | 5147 | RSS: Main: 272732160 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | __start_tp_report 11:21:31 INFO - PROCESS | 5147 | _x_x_mozilla_page_load 11:21:31 INFO - PROCESS | 5147 | _x_x_mozilla_page_load_details 11:21:31 INFO - PROCESS | 5147 | |i|pagename|runs| 11:21:31 INFO - PROCESS | 5147 | |0;ai-astar;113;115;132;114;114;114;114;114;113;116 11:21:31 INFO - PROCESS | 5147 | |1;audio-beat-detection;163;126;150;193;125;150;149;132;186;123 11:21:31 INFO - PROCESS | 5147 | |2;audio-dft;163;161;161;163;161;163;163;161;162;165 11:21:31 INFO - PROCESS | 5147 | |3;audio-fft;76;76;76;178;78;76;76;76;162;81 11:21:31 INFO - PROCESS | 5147 | |4;audio-oscillator;83;86;145;84;83;90;141;84;84;137 11:21:31 INFO - PROCESS | 5147 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;118;117 11:21:31 INFO - PROCESS | 5147 | |6;imaging-darkroom;146;147;146;148;146;146;147;148;145;145 11:21:31 INFO - PROCESS | 5147 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;95 11:21:31 INFO - PROCESS | 5147 | |8;json-parse-financial;63;63;63;64;64;74;65;65;64;65 11:21:31 INFO - PROCESS | 5147 | |9;json-stringify-tinderbox;66;66;66;67;67;66;66;67;66;66 11:21:31 INFO - PROCESS | 5147 | |10;stanford-crypto-aes;82;83;88;82;82;89;82;91;95;83 11:21:31 INFO - PROCESS | 5147 | |11;stanford-crypto-ccm;148;133;132;135;133;140;131;132;175;141 11:21:31 INFO - PROCESS | 5147 | |12;stanford-crypto-pbkdf2;175;171;177;173;175;174;180;174;174;173 11:21:31 INFO - PROCESS | 5147 | |13;stanford-crypto-sha256-iterative;69;71;69;69;70;69;70;70;67;70 11:21:31 INFO - PROCESS | 5147 | __end_tp_report 11:21:31 INFO - PROCESS | 5147 | __start_cc_report 11:21:31 INFO - PROCESS | 5147 | _x_x_mozilla_cycle_collect,2033 11:21:31 INFO - PROCESS | 5147 | __end_cc_report 11:21:31 INFO - PROCESS | 5147 | __startTimestamp1472667691523__endTimestamp 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | ------- Summary: start ------- 11:21:31 INFO - PROCESS | 5147 | Number of tests: 14 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#0] ai-astar Cycles:10 Average:115.90 Median:114.00 stddev:5.72 (5.0%) stddev-sans-first:5.97 11:21:31 INFO - PROCESS | 5147 | Values: 113.0 115.0 132.0 114.0 114.0 114.0 114.0 114.0 113.0 116.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:150.00 stddev:24.87 (16.6%) stddev-sans-first:25.91 11:21:31 INFO - PROCESS | 5147 | Values: 163.0 126.0 150.0 193.0 125.0 150.0 149.0 132.0 186.0 123.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 11:21:31 INFO - PROCESS | 5147 | Values: 163.0 161.0 161.0 163.0 161.0 163.0 163.0 161.0 162.0 165.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:39.48 (51.9%) stddev-sans-first:41.24 11:21:31 INFO - PROCESS | 5147 | Values: 76.0 76.0 76.0 178.0 78.0 76.0 76.0 76.0 162.0 81.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:84.00 stddev:27.26 (32.5%) stddev-sans-first:28.06 11:21:31 INFO - PROCESS | 5147 | Values: 83.0 86.0 145.0 84.0 83.0 90.0 141.0 84.0 84.0 137.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:21:31 INFO - PROCESS | 5147 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 118.0 117.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 11:21:31 INFO - PROCESS | 5147 | Values: 146.0 147.0 146.0 148.0 146.0 146.0 147.0 148.0 145.0 145.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:21:31 INFO - PROCESS | 5147 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.50 stddev:3.27 (5.1%) stddev-sans-first:3.38 11:21:31 INFO - PROCESS | 5147 | Values: 63.0 63.0 63.0 64.0 64.0 74.0 65.0 65.0 64.0 65.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:21:31 INFO - PROCESS | 5147 | Values: 66.0 66.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 66.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:4.72 (5.5%) stddev-sans-first:4.81 11:21:31 INFO - PROCESS | 5147 | Values: 82.0 83.0 88.0 82.0 82.0 89.0 82.0 91.0 95.0 83.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:137.50 stddev:13.42 (9.8%) stddev-sans-first:13.92 11:21:31 INFO - PROCESS | 5147 | Values: 148.0 133.0 132.0 135.0 133.0 140.0 131.0 132.0 175.0 141.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:174.50 stddev:2.46 (1.4%) stddev-sans-first:2.60 11:21:31 INFO - PROCESS | 5147 | Values: 175.0 171.0 177.0 173.0 175.0 174.0 180.0 174.0 174.0 173.0 11:21:31 INFO - PROCESS | 5147 | 11:21:31 INFO - PROCESS | 5147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.07 (1.5%) stddev-sans-first:1.13 11:21:31 INFO - PROCESS | 5147 | Values: 69.0 71.0 69.0 69.0 70.0 69.0 70.0 70.0 67.0 70.0 11:21:31 INFO - PROCESS | 5147 | -------- Summary: end -------- 11:21:31 INFO - PROCESS | 5147 | 11:21:32 INFO - TEST-INFO | 5147: exit 0 11:21:32 INFO - TEST-OK | kraken | took 64344ms 11:21:32 INFO - SUITE-END | took 1185s 11:21:33 INFO - Completed test suite (00:19:45) 11:21:33 INFO - javascript benchmark 11:21:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.7245368202634, 2582.6513420688207, 2596.610508423735, 2635.8418494890298, 2650.4831557846214, 4600.97699511502, 4649.9070018599605, 4674.368960190373, 4757.9524204757945, 4833.105875413046, 4634.467036290827, 4663.300504924263, 4677.672562920597, 4692.202325604647, 4726.692764970283, 4279.165562715256, 4338.609525142737, 4349.499807522144, 4350.3474478828275, 4358.3462480628, 4327.653787696977, 4406.317020861771, 4460.665450091256, 4477.731336119827, 4496.123255965072, 4449.288113901776, 4469.463664360282, 4496.55034496551, 4525.0949810037955, 4530.048689775152, 4204.201201771684, 4225.809838557272, 4284.807183676711, 4295.269804133273, 4297.35539669049, 4205.768682722449, 4211.263028969948, 4239.915201695949, 4324.567543245682, 4425.402570652985, 4622.468416132154, 4628.09752098341, 4638.976805115953, 4645.837395691168, 4659.277811939155, 4880.194767863299, 4985.35190425246, 4992.900141997176, 4998.12532806761, 5039.143345631252, 5115.744212789383, 5120.257562653432, 5127.2052831811125, 5135.101357262502, 5192.7403629818355, 4714.622830173578, 4748.620110391195, 4752.857414277577, 4781.9043619128115, 4821.4696383397795, 5036.974815125975, 5137.51193636604, 5201.557867581298, 5224.895502089937, 5231.293775340357, 4962.851114466572, 4986.202207646759, 4990.201567749143, 5036.244563315532, 5053.2420136979745, 5074.746262686851, 5082.288479612857, 5086.618503612244, 5088.185890257615, 5150.150225212873, 4893.632977526629, 4903.436104847917, 4981.701097934136, 5015.924761128586, 5030.220315850976, 5004.3494345734825, 5004.474530174352, 5042.924356134661, 5066.265391518209, 5068.391792984866, 4227.598378154071, 4230.280852255124, 4235.7670328131635, 4279.807408666617, 4285.978570107191, 3630.854765809338, 3633.927321453556, 3713.053171441319, 3738.4953031340965, 3790.8104594770152, 4350.129974005212, 4350.195213885441, 4419.513853476115, 4428.092241090569, 4430.62339701129, 5077.416097148875, 5083.262926875583, 5092.0579692756955, 5097.133487307166, 5157.922631160535, 4414.977925110354, 4424.336349547593, 4427.40230068943, 4434.0245146068455, 4480.619147372445, 4435.157320109169, 4480.9103817924115, 4515.751633660115, 4533.77331133442, 4591.9081618367445, 4795.496472870298, 4806.0, 4816.373871396696, 4817.421909370758, 4872.3909511311085, 5088.0, 5096.388433388017, 5098.719570423662, 5107.336046313955, 5108.412532558803, 4645.86062418128, 4791.401074865642, 4805.471398146271, 4812.085703716282, 4816.603185076288, 4982.8754281143265, 5008.273800299009, 5009.899802004013, 5018.04657115147, 5068.163752980717, 5079.11115554769, 5091.338126043739, 5094.414142373675, 5095.974520127524, 5097.745112744422, 4767.284907263938, 4819.204831202953, 4871.732054737024, 4907.509249075064, 4915.090708218991, 4954.479779623088, 4958.826441074545, 4959.355283813081, 4960.8759781005765, 5007.924881126859, 4881.29221262922, 4881.780319885685, 4882.853514394574, 4897.094037603055, 4940.901181976412, 4813.566778989908, 4918.262260660929, 4948.282499037691, 4971.751412429437, 5036.622253331088, 4879.780409881493, 4879.853604391874, 4881.121398148367, 4927.063857866994, 4933.260010998379], "value": 4644.5469697472245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.4132763916986, 579.6811753535557, 581.1254062635734, 581.6451964301775, 583.0641819879097, 28012.57981130282, 30711.385772284542, 30776.69223307766, 30866.84566577164, 30934.53598196029, 30245.3950920982, 40381.0, 41417.792911035474, 41494.58505414945, 45035.77482112593, 7632.427567932414, 7747.767566973, 7752.689892404297, 7762.9611851940945, 7764.650590723431, 7614.8477030459635, 7620.9237907621045, 7666.00341955545, 7699.345555627779, 7701.22987701231, 7687.154413014564, 7707.6916923323, 7719.536827790323, 7720.0, 7728.7681369559, 7671.309582137606, 7724.6137693115115, 7724.922750772476, 7726.304632583066, 7730.149683534807, 7706.38348932084, 7757.301842834116, 7762.184970578121, 7769.067711874554, 7769.184235655288, 38598.22803543913, 38891.22217555633, 38918.0, 38937.41593876094, 38961.610383896084, 2854.728800763924, 2960.767599072218, 2991.1624745071413, 3020.2600362911007, 3038.756899448061, 28954.27614309638, 28998.565021524693, 29042.564361534594, 29187.124386268446, 30663.233419164477, 3342.0, 3365.848536815849, 3366.7271280512787, 3378.1048022274117, 3417.5557177566757, 242838.0, 243836.0, 244691.0, 244820.0, 245262.0, 31541.369172616418, 32380.142978553406, 51559.226611600854, 51865.48134518607, 52036.47963520392, 33146.3370732584, 33308.500372493945, 33343.832650877615, 33355.16612084669, 33372.165695857795, 11617.6514704559, 11665.533378664759, 11673.241239319417, 11679.88320116805, 11697.2981621103, 11385.886141138482, 11681.941590292165, 11687.357195354338, 11696.356700381391, 11701.180917335874, 7724.6523906424345, 7746.883796743054, 7770.844583108306, 7839.412044096715, 7846.8430631387055, 3033.605631267921, 3039.7416219621136, 3041.2700951771417, 3052.8931487397836, 3075.1235897769475, 809.3606051219589, 853.1425916953422, 858.296197118357, 944.15026476172, 951.8905325887612, 26711.732882671313, 27514.44971100567, 28013.299667508476, 28164.0, 28402.573961390597, 754.6302311867146, 899.5951821680139, 924.339097545245, 938.3585207640471, 1015.2690063154517, 13756.931215343859, 14625.78061329081, 14639.92680036593, 14683.55949321522, 14908.403663853542, 361455.0, 364727.0, 364933.0, 365298.0, 365309.0, 46871.76564117226, 47319.29021064687, 47348.28977565339, 47361.763191183825, 47429.0, 1076.359566058194, 1160.14729174057, 1179.5281887245171, 1183.8224266360114, 1189.74420499593, 27762.861185693942, 29090.27274318159, 29178.56232156562, 29923.55114673238, 29938.70061299359, 41046.58953410547, 41639.7918010408, 41682.0, 41721.58278417177, 41756.0, 293716.0, 294734.0, 295263.0, 295542.0, 514337.0, 37768.43347349737, 38095.42856857094, 38173.80913095417, 38512.61487385202, 38987.41518877276, 42160.0, 42386.0, 42663.36004959866, 42693.35959960665, 43380.56619433891, 36216.0, 36429.81785091058, 36479.0, 36483.635163648025, 36904.09534474471, 35011.82494087513, 35229.64770352366, 35483.64516354803, 35525.82237088798, 35701.82149089238, 35383.11542211465, 35629.28741425209, 35682.0, 35779.28441431105, 35956.64043359533, 31014.22464438317, 32260.19349516281, 32773.67226327706, 33359.0, 36299.63700362963, 25093.623595645713, 25745.0, 25771.0, 25776.61335080013, 26228.475430491664], "value": 16292.079586624683, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.35949134609604, 361.8661095394704, 365.88108864619005, 368.4822823932375, 387.4981898441518, 12427.316497592628, 16108.838911610881, 16459.588510287234, 17777.37779177729, 18000.909995450038, 15230.162341071236, 15360.539183824503, 15388.538343849674, 16119.435819746312, 17363.913180434112, 5023.648344615869, 5194.298769666085, 5240.187770895517, 5427.348718153827, 5463.7814487420455, 3481.6692414220734, 3645.9270814583692, 5515.862103447405, 5551.833444996657, 5553.666779993213, 3693.5013773140686, 3698.722595805312, 5236.31927849379, 5487.780488780444, 5494.340679118512, 5554.9722251388885, 5564.554835613141, 5566.443355664422, 5705.5435565154685, 6041.214642096544, 5385.703786291752, 5386.084365657847, 5388.218708287276, 5395.78416863325, 5398.433164517708, 10912.345259284468, 11389.943050284779, 20623.896880515502, 20774.272900448414, 20809.687854682194, 1956.814102660245, 2142.882141482218, 2299.2297580310615, 2316.968948817777, 2381.0, 8834.69078582253, 8931.419457735226, 9168.495732734697, 9711.465869377182, 12337.93831030848, 1690.1802625726514, 1723.2934496856353, 1746.685596592613, 1749.8512626426768, 1782.8841125326812, 68138.65930670315, 72879.63560182218, 73396.63301683511, 75032.62483687601, 75730.24269757287, 8415.789605259917, 8926.330525210635, 9072.228860546795, 10013.499325033865, 10210.642627508001, 11921.403929803475, 12037.0, 12079.335636540074, 12087.697807554705, 12098.213616114925, 5810.82567522975, 5931.25028116698, 5940.61386009908, 6426.74293028283, 7468.887966680504, 7258.927410725931, 7292.562446253241, 7337.449691273069, 7527.096748390229, 7572.0, 3746.2132952079824, 3819.4461803038403, 4001.1797581495725, 4186.602272784081, 4229.851955181553, 1741.1729428521605, 1744.345870298638, 1795.353672677835, 1810.4387639831432, 1815.3283285184302, 836.3768992100923, 861.7716305179133, 874.4185116897319, 908.0601577367393, 940.4310392212612, 15594.610134746723, 16802.83197168037, 17021.48935531936, 17093.401730939608, 17815.376461823773, 785.7249962513189, 829.1749709039544, 844.5861527851308, 849.6049337058298, 864.2783275964514, 8769.342299327576, 8995.505247211335, 9574.090461406155, 9661.323707340418, 9792.706218813448, 389513.0, 399510.0, 399525.0, 399714.0, 401420.0, 83802.0, 84509.0, 84874.5756271227, 86337.56831215929, 87174.56412717896, 957.6408846682494, 970.5001924009, 973.2992245583168, 977.2768151567789, 979.1383582447543, 14653.267336633338, 14927.179005154387, 14985.475508357154, 15052.0, 15646.374145034071, 38360.0, 38912.0, 39308.6069139305, 39333.606663932995, 39539.40690889581, 53943.0, 54824.177637336266, 55132.0, 58300.0, 59226.70386648039, 6524.184476940382, 7204.89192662121, 7661.885071723817, 7740.612969351622, 7890.210978902064, 9025.729228123168, 11935.462904169159, 12002.21985570935, 12150.57472988441, 12747.043971702346, 7841.0, 10124.34191777532, 10393.740156496147, 10447.216458765472, 10503.579856805642, 10183.541740621542, 10298.691039268833, 10660.46697665129, 10913.0, 11242.83135752948, 10358.585656573954, 10546.525406356579, 10689.30519516229, 10943.343399396063, 11013.394263315595, 7818.569978651229, 7828.138904720362, 7999.920000799918, 8054.83890322202, 8054.8791768122355, 8023.237792409712, 10126.44304563256, 10184.694459166238, 10280.383177009404, 11056.613018544313], "value": 8129.690784819534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.143035602748, 1409.09113621714, 1514.8257950335715, 1670.8304187069054, 1736.6439879824636, 7435.367993720533, 7986.880196797053, 7988.081370642363, 7992.92007079929, 8006.879896801545, 6781.389674929255, 7553.773386798405, 7815.101263354716, 7822.8044298892555, 7828.882566761489, 2173.641349177388, 2199.3951663292564, 2208.1277895231374, 2209.7569267380577, 2210.3258506155616, 2152.709384233124, 2172.913083476659, 2249.4826189976316, 2252.234240358278, 2253.740819805727, 2183.0394626364427, 2187.6062308784412, 2201.273579718689, 2202.8017478426937, 2211.8562293450955, 2149.935501934937, 2155.482684155807, 2158.0396723458066, 2158.7733288004692, 2159.9892000539976, 2097.171617211193, 2112.461322362803, 2112.6091673040537, 2112.852100352976, 2115.862468939514, 7981.042274926988, 8034.236747508978, 8097.392695547857, 8099.55452450115, 8103.149169337253, 4645.419322584677, 4752.405949256343, 4762.357081793948, 4762.9523704763205, 4763.071201115784, 2907.6220091387986, 3024.8185108893535, 3040.407120611482, 3057.877684892602, 3085.9074227773203, 990.8365119755232, 1055.941923194224, 1057.2123767792966, 1792.9820701793076, 1846.8891866488054, 10698.144148468104, 10737.141028717684, 10754.354738715623, 10808.459577021118, 10819.134469242363, 4008.2985477541315, 4096.979515102465, 4224.809883555247, 4257.914841703148, 4261.722988005769, 8483.787905302417, 8483.95758021206, 8484.53335066565, 8487.321014318839, 8490.448120872246, 4552.157850797613, 4569.748663823521, 4572.108438854458, 4581.5647513486165, 4582.793774280165, 3730.9440358394104, 4105.507339119265, 4190.916181676411, 4249.87250382489, 4257.552956939477, 3389.8983030509125, 3497.9125521862156, 3514.384982628081, 3609.6209897960334, 3614.2229420674157, 1069.8341757027517, 1071.164491696478, 1084.9963783500389, 1091.1325496230515, 1092.847001419802, 794.3367288314207, 809.7246936041774, 825.4469505431375, 825.8307047055339, 830.1366578758024, 5046.44489106198, 5086.338775959176, 5089.414717307557, 5157.355330583677, 5279.260903473517, 406.7478163538625, 409.1224323825378, 411.2330503610804, 424.4609346130397, 425.79561810330597, 3543.9291214175573, 3549.769264997767, 3641.5630124385243, 3648.343298206348, 3674.632536746304, 9537.523123843781, 9980.650677226262, 9980.850287245697, 9981.60073597048, 10004.749881253027, 9808.95095524532, 9887.258455615858, 9963.551640176209, 9964.25268104895, 9975.650852220137, 7371.967924490576, 7415.369693576106, 7448.031755871702, 7457.664405101784, 7468.103827540621, 4820.566149046603, 4922.483139270468, 4926.310316555613, 5014.247862820606, 5165.793368265227, 8859.666202365399, 8977.865332020156, 9058.456492610465, 9152.084791520794, 9232.0, 9140.63437462494, 9258.675946341846, 9266.629334826532, 9287.86068208991, 9334.113259240361, 6194.81415557534, 6201.968990155201, 6234.096056071935, 6268.874622507433, 6300.338464461349, 7557.735479258419, 7623.352015078781, 7625.771226863203, 7627.694892204249, 7629.0, 6443.67781610927, 6513.413792758485, 6542.182227221598, 6602.349412646839, 6705.0612914193025, 6768.695408706521, 6803.285655006351, 6811.2167100784045, 6821.1814582250445, 6865.828354291183, 6243.250809902841, 6252.187215661935, 6314.652694101685, 6316.210473690789, 6318.336574659595, 4356.346548017823, 4388.385626012297, 4393.868183954486, 4415.0, 4481.641468682433, 4256.7445953242905, 4361.214981303396, 4362.890927726832, 4383.777529524427, 4518.186726389282], "value": 4077.3287287916883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.89282804604363, 302.101248784865, 307.72304925566993, 310.48304572886144, 313.80230454813466, 4860.951390486099, 4876.829310974116, 4887.511248875111, 4889.633277504193, 4898.975505122474, 4801.399825021872, 4824.27635854622, 4826.1554228010045, 4832.516748325165, 4838.75806209689, 3603.8738644147393, 3711.5917249102577, 3711.851525938959, 3718.721095917817, 3742.906427339311, 3688.7602305850032, 3795.867144649938, 3804.5054142961376, 3828.9808550957205, 3835.712321575879, 3757.7745335279833, 3761.4357846323132, 3762.7177961652988, 3766.7193154327524, 3769.8303576338994, 3587.318409502186, 3751.1559899022773, 3754.9812250938708, 3780.7920564368947, 3787.16682329887, 3298.653641367646, 3302.9504557431655, 3304.9008529744146, 3308.7022168004996, 3326.6839650233187, 4639.188142075123, 4701.153792317382, 4716.127516409441, 4722.95277047232, 4725.834595789165, 4294.959894050332, 4297.419848320499, 4302.849400271007, 4305.375720520538, 4308.763018034007, 4933.506649335038, 5029.170186919154, 5036.143855544567, 5039.647224694273, 5055.8988820223385, 3593.3111437624534, 3605.152789094561, 3609.1157666371646, 3610.783352998802, 3616.2044350242904, 5244.737763111829, 5276.9446110778, 5277.656952298088, 5289.233061206142, 5324.440933701983, 3453.547980933515, 3597.31650986317, 3636.781793092423, 3708.9814550927613, 3716.572594151707, 3660.108514273747, 3664.9083772905356, 3681.3005528949416, 3684.7236457265813, 3691.9446208306895, 4186.874393768192, 4200.2617670273485, 4206.26390381682, 4211.494620645542, 4217.641500472433, 4866.853994380174, 4991.101601711727, 5008.974955125201, 5012.949870501248, 5028.195488721787, 1273.8535068467245, 1277.6231011851526, 1277.9552715654906, 1279.4945996331396, 1279.5649479177125, 792.2711105782694, 813.4712436915934, 827.7309874290879, 829.3199576347337, 834.8747687846871, 4300.591443812833, 4403.603675669206, 4415.977920110379, 4459.710118842265, 4465.9058530660195, 5177.488917874828, 5225.790968361299, 5239.925815207873, 5246.921296180561, 5254.789808407697, 4558.020025694492, 4559.908801823945, 4560.543945605479, 4562.608404436613, 4566.771661416916, 2632.420867409167, 2744.2727677165567, 2761.3293957156034, 2764.557670772667, 2764.903228386997, 4891.755412229374, 4903.828366007244, 4915.090708218991, 4926.1379258629595, 4926.531979461945, 5070.898582028339, 5298.496642818926, 5332.0, 5336.519713225828, 5340.893182136336, 4895.755212239374, 4926.852194434173, 4927.655064145619, 4927.9507204927495, 4944.950550494521, 5145.202493613496, 5156.7421628917655, 5194.909069095533, 5204.791808327776, 5258.973705131603, 4874.8050077997905, 4979.502049794992, 5063.7468126592785, 5116.2069879168785, 5123.205903084879, 4869.829555965524, 4906.681065730716, 4924.458309585871, 4925.408950925912, 4926.48271931442, 3681.8152298262344, 3694.3719567673024, 3697.685696715809, 3703.7037037036434, 3720.572134204493, 4961.950380496149, 5194.714290714047, 5215.55667768244, 5219.2693022976055, 5227.320448341691, 4960.759810047488, 4964.528369804862, 4999.400311837751, 5016.297718319511, 5028.748562571784, 4971.850844474671, 4976.253561965734, 4978.5270399312, 4982.060584255307, 4983.9003219934675, 4726.929096063631, 4913.754312284443, 4918.393251576527, 4958.7024778513405, 4968.478309777422, 4787.569118779326, 4908.7545622719435, 5001.799928002984, 5063.0, 5070.746462676925, 4961.7271050092595, 4966.379202599675, 4968.577670898014, 4969.1800852860315, 4993.725345106054], "value": 3796.742342742679, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.0365647871712, 638.8243233110896, 640.9455196308313, 660.818274974382, 661.7386132477671, 13370.331483425827, 13456.93271533641, 13563.932180339098, 13574.932125339385, 13607.387667554958, 13571.52499662512, 13818.723625527484, 13829.308534573256, 13837.817302020541, 13855.307234638252, 619.3775255867846, 733.9633018349087, 769.1270408086834, 782.5148407987056, 782.788647065292, 625.7872323410039, 637.5250438423382, 637.8022812928007, 749.1721647579428, 776.1850057439694, 810.5947026486757, 815.0708192660372, 819.7458787775779, 821.2731732416825, 821.5686764448652, 814.1044850664251, 814.5235037503068, 814.7352110564091, 814.8859159717645, 815.0748899998545, 477.15305333033797, 577.5062321714958, 589.3840936221659, 600.0069884341378, 600.726669365442, 13391.464341426332, 13457.663558411117, 13463.798043029363, 13470.461181552726, 13564.864351356557, 12634.557790477289, 13009.414576343992, 13300.467981280737, 13359.666008349772, 13814.68760467754, 9974.850377244347, 10066.496675166212, 10075.848862267072, 10324.43806886623, 12031.09766767496, 4073.1293785394796, 4088.4071809587444, 4117.094239267386, 4123.793810309502, 4324.416203812477, 59806.40193598052, 60119.0, 60749.088763669024, 61234.69382653058, 62043.68978155126, 10115.848262276071, 10237.385756854612, 10362.637307694195, 10420.32267902584, 10478.00917825626, 18074.18666160026, 18097.728534072, 18099.185536650883, 18143.63712725738, 18196.90901545484, 6816.659167041628, 6843.863122737617, 6867.381935625817, 6978.267281935425, 7119.89320160198, 3779.6220377961986, 3788.8105594720155, 3799.962000380016, 3801.239752049601, 3857.7685338879755, 2899.3476467795, 3008.8044277121917, 3010.1421094987822, 3010.864511097006, 3011.5482677598534, 511.6904272914907, 514.3596222702758, 522.7281813456981, 528.9418164001956, 567.9914801277985, 529.9152135658276, 601.3955974245855, 603.2067830802481, 604.1330690459205, 617.1483352972868, 7548.886766698504, 7703.807404814925, 7731.652075656497, 7922.36621070313, 7932.5637089959455, 496.65730645854245, 502.3344069108446, 575.2981362737454, 579.2614416618844, 582.9621074630136, 3371.494275858641, 3649.5073165122367, 3665.633436656313, 3697.3344797936093, 3806.657400833938, 103112.48443757734, 105319.0, 107461.4030877528, 107723.0, 107888.46055769672, 91526.54236728908, 93573.0, 93715.0, 94090.0, 94248.0, 80468.0, 80471.0, 80933.59533202296, 81374.18625813785, 81602.5919870385, 6808.421284190701, 7060.54106483077, 7196.640167991475, 7258.818529536804, 7358.595277259802, 46391.0, 47733.76133119312, 48096.27855582239, 49707.0, 50352.0, 60251.39748602458, 70914.0, 70919.29080709333, 71508.64245678738, 71843.64078179575, 9476.384035037701, 9943.751406214902, 10029.0, 10200.795984080425, 10572.735681608021, 10915.345079295268, 11021.83467248008, 11079.371251663773, 11247.606333778278, 12458.439370228543, 9855.11303982645, 9998.900010999796, 10157.085862272432, 10398.428086455318, 10691.465426728788, 9734.853977190489, 9841.45871977048, 9851.310408271353, 9885.505724713592, 9887.851682224917, 9441.858372124561, 9898.505074746377, 9945.552450139905, 10070.791505019444, 10441.895581044093, 8086.959565202136, 8141.8778718320455, 8431.0, 8444.535550544779, 8719.221604448127, 8207.917920820715, 8390.874136887829, 8592.527410992456, 8665.2634526066, 8701.521416322163], "value": 6427.05370867464, "unit": "score"}], "name": "dromaeo_css", "value": 6277.787479460411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 132.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 150.0, 193.0, 125.0, 150.0, 149.0, 132.0, 186.0, 123.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 161.0, 163.0, 163.0, 161.0, 162.0, 165.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 178.0, 78.0, 76.0, 76.0, 76.0, 162.0, 81.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 145.0, 84.0, 83.0, 90.0, 141.0, 84.0, 84.0, 137.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 148.0, 145.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 74.0, 65.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 88.0, 82.0, 82.0, 89.0, 82.0, 91.0, 95.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 133.0, 132.0, 135.0, 133.0, 140.0, 131.0, 132.0, 175.0, 141.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 177.0, 173.0, 175.0, 174.0, 180.0, 174.0, 174.0, 173.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 69.0, 70.0, 69.0, 70.0, 70.0, 67.0, 70.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1584.2, "alertThreshold": 2.0}]} 11:21:33 INFO - Return code: 0 11:21:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:21:33 INFO - # TBPL SUCCESS # 11:21:33 INFO - Running post-action listener: _resource_record_post_action 11:21:33 INFO - [mozharness: 2016-08-31 18:21:33.311682Z] Finished run-tests step (success) 11:21:33 INFO - Running post-run listener: _resource_record_post_run 11:21:33 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407597056; Read time: 24; Write time: 287940 11:21:33 INFO - TinderboxPrint: CPU usage
13.0% 11:21:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 11:21:33 INFO - TinderboxPrint: I/O write bytes / time
407,597,056 / 287,940 11:21:33 INFO - TinderboxPrint: CPU idle
8,340.1 (87.0%) 11:21:33 INFO - TinderboxPrint: CPU user
1,202.1 (12.5%) 11:21:33 INFO - TinderboxPrint: Swap in / out
0 / 0 11:21:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113610752; Read time: 0; Write time: 102636 11:21:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293081088; Read time: 24; Write time: 185288 11:21:33 INFO - Running post-run listener: _upload_blobber_files 11:21:33 INFO - Blob upload gear active. 11:21:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:21:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:21:33 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:21:33 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:21:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:21:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:35 INFO - (blobuploader) - INFO - Done attempting. 11:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:36 INFO - (blobuploader) - INFO - Done attempting. 11:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:39 INFO - (blobuploader) - INFO - Done attempting. 11:21:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:39 INFO - Return code: 0 11:21:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:21:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22fab3fc85622c862638ec15fc9b6175f5d4923c6c966e50480d2d16512c22f1d9c36b7ad388d7cf3cd86f2173180f8331c9c176d5af1cd139bc8d9981de6fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5139458ca78884d66003b4bc767597ba97c74d4906fdcd89f3c2a04a7a62b287477d7f6e7e165f56ff977c2dad0ca2b1faa27427c89e221e736e0fd95034b40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98b188bc336ecd00d50b6a0bb86ba360a7e86113eda88b43853d032ad6304128fb3285a3fd89b0d21f7a0b2eadee077b9ddafe6d39f862e872b25117af6930a7"} 11:21:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:21:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:21:39 INFO - Contents: 11:21:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22fab3fc85622c862638ec15fc9b6175f5d4923c6c966e50480d2d16512c22f1d9c36b7ad388d7cf3cd86f2173180f8331c9c176d5af1cd139bc8d9981de6fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5139458ca78884d66003b4bc767597ba97c74d4906fdcd89f3c2a04a7a62b287477d7f6e7e165f56ff977c2dad0ca2b1faa27427c89e221e736e0fd95034b40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98b188bc336ecd00d50b6a0bb86ba360a7e86113eda88b43853d032ad6304128fb3285a3fd89b0d21f7a0b2eadee077b9ddafe6d39f862e872b25117af6930a7"} 11:21:39 INFO - Running post-run listener: copy_logs_to_upload_dir 11:21:39 INFO - Copying logs to upload dir... 11:21:39 INFO - mkdir: /builds/slave/test/build/upload/logs 11:21:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.546626 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-31 11:21:39.025223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:39.028402) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468 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-Non-PGO/sha512/22fab3fc85622c862638ec15fc9b6175f5d4923c6c966e50480d2d16512c22f1d9c36b7ad388d7cf3cd86f2173180f8331c9c176d5af1cd139bc8d9981de6fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5139458ca78884d66003b4bc767597ba97c74d4906fdcd89f3c2a04a7a62b287477d7f6e7e165f56ff977c2dad0ca2b1faa27427c89e221e736e0fd95034b40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98b188bc336ecd00d50b6a0bb86ba360a7e86113eda88b43853d032ad6304128fb3285a3fd89b0d21f7a0b2eadee077b9ddafe6d39f862e872b25117af6930a7"} build_url:https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/a2EYCNk9SnOErhSFJPATOw/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-Non-PGO/sha512/22fab3fc85622c862638ec15fc9b6175f5d4923c6c966e50480d2d16512c22f1d9c36b7ad388d7cf3cd86f2173180f8331c9c176d5af1cd139bc8d9981de6fd1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5139458ca78884d66003b4bc767597ba97c74d4906fdcd89f3c2a04a7a62b287477d7f6e7e165f56ff977c2dad0ca2b1faa27427c89e221e736e0fd95034b40e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98b188bc336ecd00d50b6a0bb86ba360a7e86113eda88b43853d032ad6304128fb3285a3fd89b0d21f7a0b2eadee077b9ddafe6d39f862e872b25117af6930a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:39.053674) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:39.054001) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472666451.642241-295809468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:21:39.136829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:21:39.137150) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:21:39.137430) ========= ========= Total master_lag: 0.24 =========