builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1470691851.54 results: success (0) buildid: 20160808131225 builduid: e08ccfd5812946e19b7f8d15b21ccb11 revision: fe048eedd71ab4551131d03ddfb13e1f3d876dd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.537054) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.537440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.537720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.587331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.587591) ========= 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=523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 14:30:51-- 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% 38.0M=0s 2016-08-08 14:30:51 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.696055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.696394) ========= 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=523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017948 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.746052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:51.746414) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fe048eedd71ab4551131d03ddfb13e1f3d876dd0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev fe048eedd71ab4551131d03ddfb13e1f3d876dd0 --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=523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 14:30:51,903 truncating revision to first 12 chars 2016-08-08 14:30:51,903 Setting DEBUG logging. 2016-08-08 14:30:51,903 attempt 1/10 2016-08-08 14:30:51,903 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fe048eedd71a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 14:30:52,257 unpacking tar archive at: autoland-fe048eedd71a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:52.460040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:52.460366) ========= script_repo_revision: fe048eedd71ab4551131d03ddfb13e1f3d876dd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:52.460775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:52.461036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:30:52.469955) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-08 14:30:52.470309) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:30:52 INFO - MultiFileLogger online at 20160808 14:30:52 in /builds/slave/test 14:30:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 14:30:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:52 INFO - {'append_to_log': False, 14:30:52 INFO - 'base_work_dir': '/builds/slave/test', 14:30:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:30:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:52 INFO - 'branch': 'Autoland-Non-PGO', 14:30:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:52 INFO - 'config_files': ('talos/linux_config.py',), 14:30:52 INFO - 'default_actions': ('clobber', 14:30:52 INFO - 'read-buildbot-config', 14:30:52 INFO - 'download-and-extract', 14:30:52 INFO - 'populate-webroot', 14:30:52 INFO - 'create-virtualenv', 14:30:52 INFO - 'install', 14:30:52 INFO - 'run-tests'), 14:30:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:52 INFO - 'download_minidump_stackwalk': True, 14:30:52 INFO - 'download_symbols': 'ondemand', 14:30:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:52 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:52 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:52 INFO - 'installer_path': 'installer.exe', 14:30:52 INFO - 'log_level': 'info', 14:30:52 INFO - 'log_name': 'talos', 14:30:52 INFO - 'log_to_console': True, 14:30:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:30:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:30:52 INFO - 'opt_config_files': (), 14:30:52 INFO - 'pip_index': False, 14:30:52 INFO - 'sps_profile': False, 14:30:52 INFO - 'sps_profile_interval': 0, 14:30:52 INFO - 'suite': 'dromaeojs-e10s', 14:30:52 INFO - 'system_bits': '32', 14:30:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:52 INFO - 'title': 'talos-linux64-ix-065', 14:30:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:52 INFO - 'use_talos_json': True, 14:30:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:52 INFO - 'work_dir': 'build'} 14:30:52 INFO - [mozharness: 2016-08-08 21:30:52.715662Z] Running clobber step. 14:30:52 INFO - Running pre-action listener: _resource_record_pre_action 14:30:52 INFO - Running main action method: clobber 14:30:52 INFO - rmtree: /builds/slave/test/build 14:30:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:53 INFO - Running post-action listener: _resource_record_post_action 14:30:53 INFO - [mozharness: 2016-08-08 21:30:53.687202Z] Finished clobber step (success) 14:30:53 INFO - [mozharness: 2016-08-08 21:30:53.687302Z] Running read-buildbot-config step. 14:30:53 INFO - Running pre-action listener: _resource_record_pre_action 14:30:53 INFO - Running main action method: read_buildbot_config 14:30:53 INFO - Using buildbot properties: 14:30:53 INFO - { 14:30:53 INFO - "project": "", 14:30:53 INFO - "product": "firefox", 14:30:53 INFO - "script_repo_revision": "production", 14:30:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 14:30:53 INFO - "repository": "", 14:30:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 14:30:53 INFO - "buildid": "20160808131225", 14:30:53 INFO - "pgo_build": "False", 14:30:53 INFO - "basedir": "/builds/slave/test", 14:30:53 INFO - "buildnumber": 250, 14:30:53 INFO - "slavename": "talos-linux64-ix-065", 14:30:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:30:53 INFO - "platform": "ubuntu64_hw", 14:30:53 INFO - "scheduler": "tests-autoland-linux64-talos", 14:30:53 INFO - "branch": "autoland", 14:30:53 INFO - "repo_path": "integration/autoland", 14:30:53 INFO - "revision": "fe048eedd71ab4551131d03ddfb13e1f3d876dd0", 14:30:53 INFO - "stage_platform": "linux64", 14:30:53 INFO - "builduid": "e08ccfd5812946e19b7f8d15b21ccb11", 14:30:53 INFO - "slavebuilddir": "test" 14:30:53 INFO - } 14:30:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:30:53 INFO - Running post-action listener: _resource_record_post_action 14:30:53 INFO - [mozharness: 2016-08-08 21:30:53.689762Z] Finished read-buildbot-config step (success) 14:30:53 INFO - [mozharness: 2016-08-08 21:30:53.689852Z] Running download-and-extract step. 14:30:53 INFO - Running pre-action listener: _resource_record_pre_action 14:30:53 INFO - Running main action method: download_and_extract 14:30:53 INFO - mkdir: /builds/slave/test/build/tests 14:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:53 INFO - trying https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:30:53 INFO - Downloading https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:30:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:30:54 INFO - Downloaded 1361 bytes. 14:30:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:30:54 INFO - Using the following test package requirements: 14:30:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:30:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:30:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'jsshell-linux-x86_64.zip'], 14:30:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:30:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:30:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:30:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:30:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:30:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:30: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')]} 14:30:54 INFO - trying https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:30:54 INFO - Downloading https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:31:02 INFO - Downloaded 20257866 bytes. 14:31:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:03 INFO - Return code: 0 14:31:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:03 INFO - trying https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:31:03 INFO - Downloading https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:31:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:31:04 INFO - Downloaded 20257866 bytes. 14:31:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:06 INFO - Return code: 0 14:31: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')]} 14:31:06 INFO - trying https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:06 INFO - Downloading https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:31:08 INFO - Downloaded 14413723 bytes. 14:31:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:31:09 INFO - Return code: 0 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:09 INFO - trying https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:31:09 INFO - Downloading https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/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 14:31:13 INFO - Downloaded 56136100 bytes. 14:31:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:31:13 INFO - mkdir: /builds/slave/test/properties 14:31:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:13 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:13 INFO - Contents: 14:31:13 INFO - build_url:https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:31:14 INFO - Running post-action listener: _resource_record_post_action 14:31:14 INFO - Running post-action listener: set_extra_try_arguments 14:31:14 INFO - [mozharness: 2016-08-08 21:31:14.468564Z] Finished download-and-extract step (success) 14:31:14 INFO - [mozharness: 2016-08-08 21:31:14.468796Z] Running populate-webroot step. 14:31:14 INFO - Running pre-action listener: _resource_record_pre_action 14:31:14 INFO - Running main action method: populate_webroot 14:31:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:14 INFO - '--tppagecycles', 14:31:14 INFO - '7'], 14:31:14 INFO - 'tests': ['tsvgm']}}, 14:31:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['damp', 'tps']}, 14:31:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'tests': ['damp', 'tps']}, 14:31:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['dromaeo_dom']}, 14:31:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['basic_compositor_video']}, 14:31:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:31:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['a11yr', 14:31:14 INFO - 'ts_paint', 14:31:14 INFO - 'tpaint', 14:31:14 INFO - 'sessionrestore', 14:31:14 INFO - 'sessionrestore_no_auto_restore', 14:31:14 INFO - 'tabpaint']}, 14:31:14 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:14 INFO - 'ts_paint', 14:31:14 INFO - 'tpaint', 14:31:14 INFO - 'sessionrestore', 14:31:14 INFO - 'sessionrestore_no_auto_restore', 14:31:14 INFO - 'tabpaint']}, 14:31:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:31:14 INFO - 'ts_paint', 14:31:14 INFO - 'tpaint', 14:31:14 INFO - 'sessionrestore', 14:31:14 INFO - 'sessionrestore_no_auto_restore', 14:31:14 INFO - 'tabpaint']}, 14:31:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:31:14 INFO - 'ts_paint', 14:31:14 INFO - 'tpaint', 14:31:14 INFO - 'sessionrestore', 14:31:14 INFO - 'sessionrestore_no_auto_restore', 14:31:14 INFO - 'tabpaint']}, 14:31:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['a11yr', 14:31:14 INFO - 'ts_paint', 14:31:14 INFO - 'tpaint', 14:31:14 INFO - 'sessionrestore', 14:31:14 INFO - 'sessionrestore_no_auto_restore', 14:31:14 INFO - 'tabpaint']}, 14:31:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['a11yr', 14:31:14 INFO - 'ts_paint', 14:31:14 INFO - 'tpaint', 14:31:14 INFO - 'sessionrestore', 14:31:14 INFO - 'sessionrestore_no_auto_restore', 14:31:14 INFO - 'tabpaint']}, 14:31:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['tsvgx', 14:31:14 INFO - 'tsvgr_opacity', 14:31:14 INFO - 'tart', 14:31:14 INFO - 'tscrollx', 14:31:14 INFO - 'cart']}, 14:31:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:14 INFO - 'tsvgr_opacity', 14:31:14 INFO - 'tart', 14:31:14 INFO - 'tscrollx', 14:31:14 INFO - 'cart']}, 14:31:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'talos_options': ['--disable-e10s'], 14:31:14 INFO - 'tests': ['tp5o']}, 14:31:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'tests': ['tp5o']}, 14:31:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'talos_options': ['--disable-e10s', 14:31:14 INFO - '--xperf_path', 14:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:14 INFO - 'tests': ['tp5n']}, 14:31:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:14 INFO - 'talos_options': ['--xperf_path', 14:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:14 INFO - 'tests': ['tp5n']}}, 14:31:14 INFO - 'talos.zip': {'path': '', 14:31:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:14 INFO - Running post-action listener: _resource_record_post_action 14:31:14 INFO - [mozharness: 2016-08-08 21:31:14.490116Z] Finished populate-webroot step (success) 14:31:14 INFO - [mozharness: 2016-08-08 21:31:14.490205Z] Running create-virtualenv step. 14:31:14 INFO - Running pre-action listener: _resource_record_pre_action 14:31:14 INFO - Running main action method: create_virtualenv 14:31:14 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:14 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 14:31:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:14 INFO - Using real prefix '/usr' 14:31:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:15 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:17 INFO - Installing pip.................done. 14:31:17 INFO - Return code: 0 14:31:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:17 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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:17 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 14:31:17 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 14:31:17 INFO - Using env: {'DISPLAY': ':0', 14:31:17 INFO - 'HOME': '/home/cltbld', 14:31:17 INFO - 'LANG': 'en_US.UTF-8', 14:31:17 INFO - 'LANGUAGE': 'en_US:en', 14:31:17 INFO - 'LOGNAME': 'cltbld', 14:31:17 INFO - 'MAIL': '/var/mail/cltbld', 14:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:17 INFO - 'MOZ_NO_REMOTE': '1', 14:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:17 INFO - 'NO_EM_RESTART': '1', 14:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:17 INFO - 'PWD': '/builds/slave/test', 14:31:17 INFO - 'SHELL': '/bin/bash', 14:31:17 INFO - 'SHLVL': '1', 14:31:17 INFO - 'TERM': 'linux', 14:31:17 INFO - 'TMOUT': '86400', 14:31:17 INFO - 'USER': 'cltbld', 14:31:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:17 INFO - '_': '/tools/buildbot/bin/python'} 14:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:17 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 14:31:17 INFO - Cleaning up... 14:31:17 INFO - Return code: 0 14:31:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:17 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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:17 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 14:31:17 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 14:31:17 INFO - Using env: {'DISPLAY': ':0', 14:31:17 INFO - 'HOME': '/home/cltbld', 14:31:17 INFO - 'LANG': 'en_US.UTF-8', 14:31:17 INFO - 'LANGUAGE': 'en_US:en', 14:31:17 INFO - 'LOGNAME': 'cltbld', 14:31:17 INFO - 'MAIL': '/var/mail/cltbld', 14:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:17 INFO - 'MOZ_NO_REMOTE': '1', 14:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:17 INFO - 'NO_EM_RESTART': '1', 14:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:17 INFO - 'PWD': '/builds/slave/test', 14:31:17 INFO - 'SHELL': '/bin/bash', 14:31:17 INFO - 'SHLVL': '1', 14:31:17 INFO - 'TERM': 'linux', 14:31:17 INFO - 'TMOUT': '86400', 14:31:17 INFO - 'USER': 'cltbld', 14:31:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:17 INFO - '_': '/tools/buildbot/bin/python'} 14:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:17 INFO - Downloading/unpacking psutil>=3.1.1 14:31:17 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 14:31:17 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 14:31:17 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 14:31:17 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 14:31:17 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 14:31:17 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 14:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:19 INFO - Installing collected packages: psutil 14:31:19 INFO - Running setup.py install for psutil 14:31:19 INFO - building 'psutil._psutil_linux' extension 14:31:19 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 14:31:19 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 14:31:19 INFO - building 'psutil._psutil_posix' extension 14:31:19 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 14:31:19 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 14:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:20 INFO - Successfully installed psutil 14:31:20 INFO - Cleaning up... 14:31:20 INFO - Return code: 0 14:31:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:31:20 INFO - Using env: {'DISPLAY': ':0', 14:31:20 INFO - 'HOME': '/home/cltbld', 14:31:20 INFO - 'LANG': 'en_US.UTF-8', 14:31:20 INFO - 'LANGUAGE': 'en_US:en', 14:31:20 INFO - 'LOGNAME': 'cltbld', 14:31:20 INFO - 'MAIL': '/var/mail/cltbld', 14:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:20 INFO - 'MOZ_NO_REMOTE': '1', 14:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:20 INFO - 'NO_EM_RESTART': '1', 14:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:20 INFO - 'PWD': '/builds/slave/test', 14:31:20 INFO - 'SHELL': '/bin/bash', 14:31:20 INFO - 'SHLVL': '1', 14:31:20 INFO - 'TERM': 'linux', 14:31:20 INFO - 'TMOUT': '86400', 14:31:20 INFO - 'USER': 'cltbld', 14:31:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:20 INFO - '_': '/tools/buildbot/bin/python'} 14:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:31:22 INFO - Installing collected packages: mozsystemmonitor 14:31:22 INFO - Running setup.py install for mozsystemmonitor 14:31:22 INFO - Successfully installed mozsystemmonitor 14:31:22 INFO - Cleaning up... 14:31:22 INFO - Return code: 0 14:31:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:31:22 INFO - Using env: {'DISPLAY': ':0', 14:31:22 INFO - 'HOME': '/home/cltbld', 14:31:22 INFO - 'LANG': 'en_US.UTF-8', 14:31:22 INFO - 'LANGUAGE': 'en_US:en', 14:31:22 INFO - 'LOGNAME': 'cltbld', 14:31:22 INFO - 'MAIL': '/var/mail/cltbld', 14:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:22 INFO - 'MOZ_NO_REMOTE': '1', 14:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:22 INFO - 'NO_EM_RESTART': '1', 14:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:22 INFO - 'PWD': '/builds/slave/test', 14:31:22 INFO - 'SHELL': '/bin/bash', 14:31:22 INFO - 'SHLVL': '1', 14:31:22 INFO - 'TERM': 'linux', 14:31:22 INFO - 'TMOUT': '86400', 14:31:22 INFO - 'USER': 'cltbld', 14:31:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:22 INFO - '_': '/tools/buildbot/bin/python'} 14:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:22 INFO - Downloading/unpacking jsonschema==2.5.1 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:31:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:31:24 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 14:31:24 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 14:31:24 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 14:31:24 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 14:31:24 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 14:31:24 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 14:31:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:31:24 INFO - warning: no files found matching '*.txt' 14:31:24 INFO - no previously-included directories found matching 'build' 14:31:24 INFO - no previously-included directories found matching 'dist' 14:31:24 INFO - no previously-included directories found matching '.git*' 14:31:24 INFO - Installing collected packages: jsonschema, functools32 14:31:24 INFO - Running setup.py install for functools32 14:31:24 INFO - warning: no files found matching '*.txt' 14:31:24 INFO - no previously-included directories found matching 'build' 14:31:24 INFO - no previously-included directories found matching 'dist' 14:31:24 INFO - no previously-included directories found matching '.git*' 14:31:24 INFO - Successfully installed jsonschema functools32 14:31:24 INFO - Cleaning up... 14:31:24 INFO - Return code: 0 14:31:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:31:24 INFO - Using env: {'DISPLAY': ':0', 14:31:24 INFO - 'HOME': '/home/cltbld', 14:31:24 INFO - 'LANG': 'en_US.UTF-8', 14:31:24 INFO - 'LANGUAGE': 'en_US:en', 14:31:24 INFO - 'LOGNAME': 'cltbld', 14:31:24 INFO - 'MAIL': '/var/mail/cltbld', 14:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:24 INFO - 'MOZ_NO_REMOTE': '1', 14:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:24 INFO - 'NO_EM_RESTART': '1', 14:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:24 INFO - 'PWD': '/builds/slave/test', 14:31:24 INFO - 'SHELL': '/bin/bash', 14:31:24 INFO - 'SHLVL': '1', 14:31:24 INFO - 'TERM': 'linux', 14:31:24 INFO - 'TMOUT': '86400', 14:31:24 INFO - 'USER': 'cltbld', 14:31:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:24 INFO - '_': '/tools/buildbot/bin/python'} 14:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:31:25 INFO - Cleaning up... 14:31:25 INFO - Return code: 0 14:31:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:25 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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:25 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 14:31:25 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 14:31:25 INFO - Using env: {'DISPLAY': ':0', 14:31:25 INFO - 'HOME': '/home/cltbld', 14:31:25 INFO - 'LANG': 'en_US.UTF-8', 14:31:25 INFO - 'LANGUAGE': 'en_US:en', 14:31:25 INFO - 'LOGNAME': 'cltbld', 14:31:25 INFO - 'MAIL': '/var/mail/cltbld', 14:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:25 INFO - 'MOZ_NO_REMOTE': '1', 14:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:25 INFO - 'NO_EM_RESTART': '1', 14:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:25 INFO - 'PWD': '/builds/slave/test', 14:31:25 INFO - 'SHELL': '/bin/bash', 14:31:25 INFO - 'SHLVL': '1', 14:31:25 INFO - 'TERM': 'linux', 14:31:25 INFO - 'TMOUT': '86400', 14:31:25 INFO - 'USER': 'cltbld', 14:31:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:25 INFO - '_': '/tools/buildbot/bin/python'} 14:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:25 INFO - Downloading/unpacking blobuploader==1.2.4 14:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31: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 14:31:27 INFO - Downloading docopt-0.6.1.tar.gz 14:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:27 INFO - Running setup.py install for blobuploader 14:31:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:28 INFO - Running setup.py install for requests 14:31:28 INFO - Running setup.py install for docopt 14:31:28 INFO - Successfully installed blobuploader requests docopt 14:31:28 INFO - Cleaning up... 14:31:28 INFO - Return code: 0 14:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:28 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')]} 14:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:28 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')]} 14:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:28 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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:28 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 14:31:28 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 14:31:28 INFO - Using env: {'DISPLAY': ':0', 14:31:28 INFO - 'HOME': '/home/cltbld', 14:31:28 INFO - 'LANG': 'en_US.UTF-8', 14:31:28 INFO - 'LANGUAGE': 'en_US:en', 14:31:28 INFO - 'LOGNAME': 'cltbld', 14:31:28 INFO - 'MAIL': '/var/mail/cltbld', 14:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:28 INFO - 'MOZ_NO_REMOTE': '1', 14:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:28 INFO - 'NO_EM_RESTART': '1', 14:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:28 INFO - 'PWD': '/builds/slave/test', 14:31:28 INFO - 'SHELL': '/bin/bash', 14:31:28 INFO - 'SHLVL': '1', 14:31:28 INFO - 'TERM': 'linux', 14:31:28 INFO - 'TMOUT': '86400', 14:31:28 INFO - 'USER': 'cltbld', 14:31:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:28 INFO - '_': '/tools/buildbot/bin/python'} 14:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:28 INFO - Running setup.py (path:/tmp/pip-1_KLsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:28 INFO - Running setup.py (path:/tmp/pip-vyHXus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:28 INFO - Running setup.py (path:/tmp/pip-SxkTRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:29 INFO - Running setup.py (path:/tmp/pip-WKNuGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:29 INFO - Running setup.py (path:/tmp/pip-KM9uww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:29 INFO - Running setup.py (path:/tmp/pip-Fdvr9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:29 INFO - Running setup.py (path:/tmp/pip-_ty1GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:29 INFO - Running setup.py (path:/tmp/pip-RcN6Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:29 INFO - Running setup.py (path:/tmp/pip-gqzoMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:29 INFO - Running setup.py (path:/tmp/pip-nE9K0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:29 INFO - Running setup.py (path:/tmp/pip-sODTE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:29 INFO - Running setup.py (path:/tmp/pip-IB0TiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:29 INFO - Running setup.py (path:/tmp/pip-nQjGyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:29 INFO - Running setup.py (path:/tmp/pip-G8wuZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:29 INFO - Running setup.py (path:/tmp/pip-eu57Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:29 INFO - Running setup.py (path:/tmp/pip-BntiBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:29 INFO - Running setup.py (path:/tmp/pip-7xgOJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:30 INFO - Running setup.py install for manifestparser 14:31:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Running setup.py install for mozcrash 14:31:30 INFO - Running setup.py install for mozdebug 14:31:30 INFO - Running setup.py install for mozdevice 14:31:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Running setup.py install for mozfile 14:31:30 INFO - Running setup.py install for mozhttpd 14:31:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Running setup.py install for mozinfo 14:31:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Running setup.py install for mozInstall 14:31:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:30 INFO - Running setup.py install for mozleak 14:31:30 INFO - Running setup.py install for mozlog 14:31:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:31 INFO - Running setup.py install for moznetwork 14:31:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:31 INFO - Running setup.py install for mozprocess 14:31:31 INFO - Running setup.py install for mozprofile 14:31:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:31 INFO - Running setup.py install for mozrunner 14:31:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:31 INFO - Running setup.py install for mozscreenshot 14:31:31 INFO - Running setup.py install for moztest 14:31:31 INFO - Running setup.py install for mozversion 14:31:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:31 INFO - Cleaning up... 14:31:31 INFO - Return code: 0 14:31:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:31 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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:31 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 14:31:31 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 14:31:31 INFO - Using env: {'DISPLAY': ':0', 14:31:31 INFO - 'HOME': '/home/cltbld', 14:31:31 INFO - 'LANG': 'en_US.UTF-8', 14:31:31 INFO - 'LANGUAGE': 'en_US:en', 14:31:31 INFO - 'LOGNAME': 'cltbld', 14:31:31 INFO - 'MAIL': '/var/mail/cltbld', 14:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:31 INFO - 'MOZ_NO_REMOTE': '1', 14:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:31 INFO - 'NO_EM_RESTART': '1', 14:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:31 INFO - 'PWD': '/builds/slave/test', 14:31:31 INFO - 'SHELL': '/bin/bash', 14:31:31 INFO - 'SHLVL': '1', 14:31:31 INFO - 'TERM': 'linux', 14:31:31 INFO - 'TMOUT': '86400', 14:31:31 INFO - 'USER': 'cltbld', 14:31:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:31 INFO - '_': '/tools/buildbot/bin/python'} 14:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:32 INFO - Running setup.py (path:/tmp/pip-siCkxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:32 INFO - Running setup.py (path:/tmp/pip-daUX4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:32 INFO - Running setup.py (path:/tmp/pip-_15eFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:32 INFO - Running setup.py (path:/tmp/pip-Qg5BCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:32 INFO - Running setup.py (path:/tmp/pip-Ffkk4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:32 INFO - Running setup.py (path:/tmp/pip-u9CuXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:32 INFO - Running setup.py (path:/tmp/pip-HTzf6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:32 INFO - Running setup.py (path:/tmp/pip-ZVO9cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:32 INFO - Running setup.py (path:/tmp/pip-c62OhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:32 INFO - Running setup.py (path:/tmp/pip-VaGjTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:32 INFO - Running setup.py (path:/tmp/pip-uSvGSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:32 INFO - Running setup.py (path:/tmp/pip-SixXGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:32 INFO - Running setup.py (path:/tmp/pip-Qcmmei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:32 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)) 14:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:32 INFO - Running setup.py (path:/tmp/pip-aT3vro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:33 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)) 14:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:33 INFO - Running setup.py (path:/tmp/pip-g6H1gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:33 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)) 14:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:33 INFO - Running setup.py (path:/tmp/pip-3MBzdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:33 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)) 14:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:33 INFO - Running setup.py (path:/tmp/pip-GylNBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:33 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)) 14:31:33 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)) 14:31:33 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)) 14:31:33 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)) 14:31:33 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)) 14:31:33 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)) 14:31:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:33 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 14:31:33 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 14:31:33 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 14:31:33 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 14:31:33 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 14:31:33 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 14:31:35 INFO - Downloading blessings-1.6.tar.gz 14:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:35 INFO - Installing collected packages: blessings 14:31:35 INFO - Running setup.py install for blessings 14:31:35 INFO - Successfully installed blessings 14:31:35 INFO - Cleaning up... 14:31:35 INFO - Return code: 0 14:31:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:35 INFO - Reading from file tmpfile_stdout 14:31:35 INFO - Current package versions: 14:31:35 INFO - argparse == 1.2.1 14:31:35 INFO - blessings == 1.6 14:31:35 INFO - blobuploader == 1.2.4 14:31:35 INFO - docopt == 0.6.1 14:31:35 INFO - functools32 == 3.2.3-2 14:31:35 INFO - jsonschema == 2.5.1 14:31:35 INFO - manifestparser == 1.1 14:31:35 INFO - mozInstall == 1.12 14:31:35 INFO - mozcrash == 0.17 14:31:35 INFO - mozdebug == 0.1 14:31:35 INFO - mozdevice == 0.48 14:31:35 INFO - mozfile == 1.2 14:31:35 INFO - mozhttpd == 0.7 14:31:35 INFO - mozinfo == 0.9 14:31:35 INFO - mozleak == 0.1 14:31:35 INFO - mozlog == 3.3 14:31:35 INFO - moznetwork == 0.27 14:31:35 INFO - mozprocess == 0.23 14:31:35 INFO - mozprofile == 0.28 14:31:35 INFO - mozrunner == 6.12 14:31:35 INFO - mozscreenshot == 0.1 14:31:35 INFO - mozsystemmonitor == 0.3 14:31:35 INFO - moztest == 0.7 14:31:35 INFO - mozversion == 1.4 14:31:35 INFO - psutil == 3.1.1 14:31:35 INFO - requests == 1.2.3 14:31:35 INFO - wsgiref == 0.1.2 14:31:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:35 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')]} 14:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:35 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')]} 14:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:35 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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:35 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 14:31:35 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 14:31:35 INFO - Using env: {'DISPLAY': ':0', 14:31:35 INFO - 'HOME': '/home/cltbld', 14:31:35 INFO - 'LANG': 'en_US.UTF-8', 14:31:35 INFO - 'LANGUAGE': 'en_US:en', 14:31:35 INFO - 'LOGNAME': 'cltbld', 14:31:35 INFO - 'MAIL': '/var/mail/cltbld', 14:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:35 INFO - 'MOZ_NO_REMOTE': '1', 14:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:35 INFO - 'NO_EM_RESTART': '1', 14:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:35 INFO - 'PWD': '/builds/slave/test', 14:31:35 INFO - 'SHELL': '/bin/bash', 14:31:35 INFO - 'SHLVL': '1', 14:31:35 INFO - 'TERM': 'linux', 14:31:35 INFO - 'TMOUT': '86400', 14:31:35 INFO - 'USER': 'cltbld', 14:31:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:35 INFO - '_': '/tools/buildbot/bin/python'} 14:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 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)) 14:31:35 INFO - Cleaning up... 14:31:35 INFO - Return code: 0 14:31:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31:35 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')]} 14:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:35 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')]} 14:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:35 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 0x25fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, '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': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', '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 14:31:35 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 14:31:35 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 14:31:35 INFO - Using env: {'DISPLAY': ':0', 14:31:35 INFO - 'HOME': '/home/cltbld', 14:31:35 INFO - 'LANG': 'en_US.UTF-8', 14:31:35 INFO - 'LANGUAGE': 'en_US:en', 14:31:35 INFO - 'LOGNAME': 'cltbld', 14:31:35 INFO - 'MAIL': '/var/mail/cltbld', 14:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:35 INFO - 'MOZ_NO_REMOTE': '1', 14:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:35 INFO - 'NO_EM_RESTART': '1', 14:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:35 INFO - 'PWD': '/builds/slave/test', 14:31:35 INFO - 'SHELL': '/bin/bash', 14:31:35 INFO - 'SHLVL': '1', 14:31:35 INFO - 'TERM': 'linux', 14:31:35 INFO - 'TMOUT': '86400', 14:31:35 INFO - 'USER': 'cltbld', 14:31:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:35 INFO - '_': '/tools/buildbot/bin/python'} 14:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:31:36 INFO - Cleaning up... 14:31:36 INFO - Return code: 0 14:31:36 INFO - Running post-action listener: _resource_record_post_action 14:31:36 INFO - Running post-action listener: _start_resource_monitoring 14:31:36 INFO - Starting resource monitoring. 14:31:36 INFO - [mozharness: 2016-08-08 21:31:36.094239Z] Finished create-virtualenv step (success) 14:31:36 INFO - [mozharness: 2016-08-08 21:31:36.094669Z] Running install step. 14:31:36 INFO - Running pre-action listener: _resource_record_pre_action 14:31:36 INFO - Running main action method: install 14:31:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:36 INFO - Reading from file tmpfile_stdout 14:31:36 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:36 INFO - Reading from file tmpfile_stdout 14:31:36 INFO - Output received: 14:31:36 INFO - Usage: mozinstall [options] installer 14:31:36 INFO - Options: 14:31:36 INFO - -h, --help show this help message and exit 14:31:36 INFO - -d DEST, --destination=DEST 14:31:36 INFO - Directory to install application into. [default: 14:31:36 INFO - "/builds/slave/test"] 14:31:36 INFO - --app=APP Application being installed. [default: firefox] 14:31:36 INFO - mkdir: /builds/slave/test/build/application 14:31:36 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'] 14:31:36 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 14:31:52 INFO - Reading from file tmpfile_stdout 14:31:52 INFO - Output received: 14:31:52 INFO - /builds/slave/test/build/application/firefox/firefox 14:31:52 INFO - Running post-action listener: _resource_record_post_action 14:31:52 INFO - [mozharness: 2016-08-08 21:31:52.616151Z] Finished install step (success) 14:31:52 INFO - [mozharness: 2016-08-08 21:31:52.616397Z] Running run-tests step. 14:31:52 INFO - Running pre-action listener: _resource_record_pre_action 14:31:52 INFO - Running main action method: run_tests 14:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:52 INFO - Python 2.7.3 14:31:52 INFO - Return code: 0 14:31:52 INFO - grabbing minidump binary from tooltool 14:31:52 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')]} 14:31:52 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 0x28bb570>, '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 0x28bc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bc900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:52 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 14:31:52 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 14:31:52 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 14:31:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:52 INFO - Return code: 0 14:31:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:31:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:31:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:31:52 INFO - Using env: {'DISPLAY': ':0', 14:31:52 INFO - 'HOME': '/home/cltbld', 14:31:52 INFO - 'LANG': 'en_US.UTF-8', 14:31:52 INFO - 'LANGUAGE': 'en_US:en', 14:31:52 INFO - 'LOGNAME': 'cltbld', 14:31:52 INFO - 'MAIL': '/var/mail/cltbld', 14:31:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:52 INFO - 'MOZ_NO_REMOTE': '1', 14:31:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:52 INFO - 'NO_EM_RESTART': '1', 14:31:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:52 INFO - 'PWD': '/builds/slave/test', 14:31:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:52 INFO - 'SHELL': '/bin/bash', 14:31:52 INFO - 'SHLVL': '1', 14:31:52 INFO - 'TERM': 'linux', 14:31:52 INFO - 'TMOUT': '86400', 14:31:52 INFO - 'USER': 'cltbld', 14:31:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803', 14:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:52 INFO - '_': '/tools/buildbot/bin/python'} 14:31:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:31:52 INFO - mozversion application_buildid: 20160808131225 14:31:52 INFO - mozversion application_changeset: fe048eedd71ab4551131d03ddfb13e1f3d876dd0 14:31:52 INFO - mozversion application_display_name: Nightly 14:31:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:52 INFO - mozversion application_name: Firefox 14:31:52 INFO - mozversion application_remotingname: firefox 14:31:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:31:52 INFO - mozversion application_vendor: Mozilla 14:31:52 INFO - mozversion application_version: 51.0a1 14:31:52 INFO - mozversion platform_buildid: 20160808131225 14:31:52 INFO - mozversion platform_changeset: fe048eedd71ab4551131d03ddfb13e1f3d876dd0 14:31:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:31:52 INFO - mozversion platform_version: 51.0a1 14:31:52 INFO - using testdate: 1470691912 14:31:52 INFO - actual date: 1470691912 14:31:52 INFO - starting webserver on 'localhost:46563' 14:31:52 INFO - SUITE-START | Running 2 tests 14:31:52 INFO - TEST-START | dromaeo_css 14:31:52 INFO - operating with platform_type : linux_ 14:31:52 INFO - Initialising browser for dromaeo_css test... 14:31:52 INFO - TEST-INFO | started process 7528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp67Iwou/profile http://localhost:46563/getInfo.html) 14:31:57 INFO - PROCESS | 7528 | __metrics Screen width/height:1600/1200 14:31:57 INFO - PROCESS | 7528 | colorDepth:24 14:31:57 INFO - PROCESS | 7528 | Browser inner width/height: 1024/697 14:31:57 INFO - PROCESS | 7528 | __metrics 14:31:58 ERROR - PROCESS | 7528 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:31:58 INFO - TEST-INFO | 7528: exit 0 14:31:58 INFO - Browser initialized. 14:31:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:58 INFO - TEST-INFO | started process 7650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp67Iwou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:10 INFO - PROCESS | 7650 | RSS: Main: 165212160 14:32:10 INFO - PROCESS | 7650 | 14:33:00 INFO - PROCESS | 7650 | 1470691980557 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] 14:35:13 INFO - PROCESS | 7650 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46563/tests/dromaeo/cssquery-ext.html) 14:35:14 INFO - PROCESS | 7650 | RSS: Main: 167395328 14:35:14 INFO - PROCESS | 7650 | 14:38:16 INFO - PROCESS | 7650 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-ext.html (next: http://localhost:46563/tests/dromaeo/cssquery-jquery.html) 14:38:17 INFO - PROCESS | 7650 | RSS: Main: 167235584 14:38:17 INFO - PROCESS | 7650 | 14:41:19 INFO - PROCESS | 7650 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46563/tests/dromaeo/cssquery-mootools.html) 14:41:19 INFO - PROCESS | 7650 | RSS: Main: 170487808 14:41:19 INFO - PROCESS | 7650 | 14:44:21 INFO - PROCESS | 7650 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46563/tests/dromaeo/cssquery-prototype.html) 14:44:22 INFO - PROCESS | 7650 | RSS: Main: 164777984 14:44:22 INFO - PROCESS | 7650 | 14:47:25 INFO - PROCESS | 7650 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46563/tests/dromaeo/cssquery-yui.html) 14:47:25 INFO - PROCESS | 7650 | RSS: Main: 167436288 14:47:25 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-yui.html (next: http://localhost:46563/tests/dromaeo/cssquery-dojo.html) 14:50:28 INFO - PROCESS | 7650 | RSS: Main: 170627072 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | __start_tp_report 14:50:28 INFO - PROCESS | 7650 | _x_x_mozilla_page_load 14:50:28 INFO - PROCESS | 7650 | _x_x_mozilla_page_load_details 14:50:28 INFO - PROCESS | 7650 | |i|pagename|runs| 14:50:28 INFO - PROCESS | 7650 | |0;dojo.html;2675.451532435851;2676.692180399254;2701.689305729841;2706.959395609066;2725.8500782456967;4739.31279964405;4881.145799485089;4899.142650036243;4929.309896614477;4941.752912354385;4801.615870730342;4839.685420447669;4844.61243100552;4916.0905232532;4938.901221975568;4373.693841431101;4462.12988467249;4479.820807167709;4480.417545719069;4547.8180872765215;4545.250033744444;4555.362249285103;4592.74739889306;4602.447706275251;4649.51180126087;4376.146651402978;4428.424304840382;4463.4866990296205;4527.501974782771;4539.046800171951;4522.751248681321;4527.320901864747;4542.682012259143;4566.634669226487;4578.404807375054;4469.307257375112;4480.260756975095;4500.324951257305;4516.751578663172;4541.0236799088025;4670.626349892001;4748.287756836502;4806.735629540374;4810.374651295309;4894.412670479565;5220.608454365938;5225.608079394061;5238.92141617876;5240.109181439127;5269.104252277084;5234.7644356004075;5248.763805628756;5251.501107394792;5266.104762190437;5297.311349524575;4660.627149828073;4750.12122757291;4824.6863953842885;4875.219964805614;4877.219644856841;5320.654157479751;5330.733463326896;5332.360116785933;5359.544438722753;5379.085555455582;5098.566621837112;5099.6685215460875;5103.489651034941;5103.540681338697;5163.870903227375;4981.128302547112;5172.663776854492;5172.715500647425;5186.247994040843;5187.170052791535;5185.403678577012;5194.194899790538;5198.9740051299505;5286.762095705702;5287.4448182941005;5151.381834179922;5194.246834209094;5203.531682148625;5210.218467229945;5259.658122222043;4292.849750258726;4389.4513185851765;4417.757023363746;4433.069055498317;4496.39298694672;3855.768653880776;3860.82626281818;3891.066144125446;3902.843886244575;3927.489426374553;4416.558344165558;4456.821727130879;4465.084657645175;4474.731516109044;4478.507364189936;5001.124803159432;5149.845504634867;5193.584513238932;5240.9213861792105;5295;4429.158459892675;4465.933011004838;4492.618127459137;4495.190865644216;4503.437070366204;4696.319033740157;4701.858944231679;4704.600108990706;4718.41019872516;4769.66612337133;4704.1062198182235;4774.7851346688785;4800.903981920412;4900.313956046157;4914.090893184701;5156.226566014978;5163.896722065613;5167.61242906791;5209.114450543492;5215.478452154754;4857.514248575114;4861.4895435980125;4869.707817530818;4889.413270407574;4926.310316555613;4920.31115643803;5068.315777370008;5094.847154585368;5114.488551144856;5139.563137133386;5210.713410762444;5211.166213405837;5227.555657769132;5239.89520209586;5270.183121616155;4968.478309777422;5064.139096353555;5080.49195080489;5090.338256026693;5127.589792816491;4809.374781278411;5029.1953287473825;5092.312537807348;5094.2867998479505;5103.3110530077965;5023.497650234947;5037.445880953019;5061.7469126544265;5102.923456148086;5112.79548818058;5164;5166.535011848951;5180.093483640272;5183.50756678115;5230.947690523046;4773.785179666993;4960.131976904099;5013.24801279811;5042.14283571801;5054.241863720325 14:50:28 INFO - PROCESS | 7650 | |1;ext.html;544.9182622606609;548.4296331814911;552.9695866727328;559.3315987395061;565.1297002615971;37150.25699486012;38718.83843484696;38724.41913371298;42355.78822105893;42546;40211.19577608446;40719.18561628766;40809;40874;40886.182276354455;7814.882776758367;7992.280694737473;7992.3606111510935;7993.200679932019;7996.720114795983;7748.341390981774;7803.687852485894;7822.256885595888;7827.804304892395;7835.059792824841;7823.413244006694;7842.254985776342;7855;7861.2531809478005;7872.5670088145125;7754.224577542257;7757.495762775458;7778.338841198505;7786.26030527099;7793.961030194841;7707.845843083107;7769.650365733555;7820.67048601739;7822.396408736252;7832.490888092313;38079.23841523182;38102.80948595267;38625.22749545021;38669.806650966566;38708;3106.51848963411;3132.4361614909308;3144.4340018796606;3389.49157626358;3719.553653561563;28553.714462855314;28843;29220.70779292201;30875.228119297197;31121.84439077813;3182.1726351148636;3187.2828613561996;3235.4823228283362;3246.756493263015;3339.8163101029436;267128;267338.6633066842;269021;269400;272690;52790.47209527856;52928;53400;53436.73281633567;53485.73257133767;56575;57004;57272.71363643155;57281;57296.42703572994;13021.283829389286;13799.655008624664;13829.30853457323;13891.097078689852;14023.439062437388;10564.418956957441;10802.567897284021;10830.133589312836;10835.620753273597;10864.130869530418;17721.911390442965;17801.1989460472;17922.91038544799;17951.640967180585;18035.909820450815;6544.3782840630065;6636.933630663728;6665.700043498055;6694.799156025327;6714.832129196711;779.6140910249463;847.8770578266117;906.4833045164193;950.5532399772096;953.9141477266941;27243.863780681368;28250;28552.71447285542;31295;31333.37333253322;917.1287277086794;959.1894848852709;961.8461046232569;985.7486340983004;1051.1223128687632;14034.789478157836;14806.481773137888;14818.703625927421;15107.697846043018;15126.621834454227;409370;416491;418129;418422;418802;48142.75928620405;48354.75822620864;48358.51641483611;48632.513674863505;48634;1157.1494951210852;1180.1384988957936;1204.7590481903653;1211.7818792617238;1223.4677915106956;26434.86782566075;27399;27781.305467363476;27974.44051119007;27992.86003569969;35274.11814704653;36190.63809361873;36234;37986.24027519379;42746.35880461733;375067;379309;379514;380361;380703;29457.55813662754;29576.556351655174;29589.556156657236;29823.70176298296;29832.70167298386;41940.16119677528;42010.78994605008;42019.57980420279;43494.56505434905;43515.56484435115;28206.576901346907;28240.71759282381;28247;28354.149375518766;28672.569911451763;36293.63706362902;36314;36652.81673591615;36712.63287367092;36969.81515092407;34897.82551087228;35048.824755877074;35200.471992919614;35703.28593428065;35981.64018359783;31705.20736981594;33473.65263473731;33714.83142584271;33791.15522111967;33941.66058339385;21764;21891.233806816686;21909.452263693536;22022.229221977155;22037.449063773533 14:50:28 INFO - PROCESS | 7650 | |2;jquery.html;348.9755717099803;360.75288427427205;362.23387535362707;372.05683592094044;377.7638975640225;15978.84021159788;16048.117353545551;16991.83008169918;17001.744973825404;17055.57361065974;14169.362378692958;15236.619084522865;15290.235488225571;15308.387664493435;15310.923445382785;4818.494058123899;4846.539578740023;4989.675671081386;5067.290579318898;5073.239014147889;5006.1990081586955;5018.623603229772;5018.7992480300745;5048.6465947383695;5076.390833100015;5023.874403139914;5044.697318160922;5239.13554263546;5310.07073762092;5370.758315875795;5293.364796224459;5337.279467271907;5373.6775793452325;6294.653794041325;6634.071230027752;6463.67681615922;6473.061406096137;6485.319041500669;6557.442617377528;6593.142891424084;23489.647655285185;23588.410289742722;24264.029438822425;24307.87846060776;24311.513769724683;1989.7413336266193;2012.30575451469;2192.1450634252656;2246.0791075659063;2502.973780749902;14478.203698796562;14556.417743290256;14729.337179826933;14927;15324.310406031755;1854.7774267088037;1864.60843222922;1933.2073849721687;1961.852861035428;1975.9802401976083;81902.59048704719;82483.9999999994;82910.17089829146;83713;84497.57751211266;14145.929270353583;15501;15768.684626307639;16238.837611623969;16565.361698724137;29104.41791164165;29331.560026599618;29505;29529;29536.852315738284;8703.95648021756;8797.648094076294;8866.77833054166;8897.28821694276;9086.591103400362;7199.424046076406;7219.8917016244795;7347.5224110432655;7399.704011839466;7447.218042105609;8202.548859812649;8226.917730822615;8391.328693704489;8466.619002144918;8556.229939305493;3298.175456135966;3331.9666803331656;3392.7946834557733;3515.789052656849;3550.804705741209;757.2957149850691;806.3267171911402;808.2321794295443;830.2112992657;851.8849955256085;16159.192040397933;16860.74708879368;16945;17391.826081739273;17703.38038168658;833.2917020532499;840.9537475438909;842.616609442702;847.5931552854664;850.6427300533791;9324.720258392259;9680.709578712649;9748.512574371252;9807.31348805591;9947.20422366209;392521;402536;407629;408252;408566;62568.74862502816;74829.6258518704;78611.21388786039;79105;80187.59906200432;873.3493547307297;893.1693525021792;908.3505293715026;909.940853844498;914.794171311463;14154;14269.64325891861;15200.087994720352;15311.38754449854;15519.612009699396;36304.27391452209;37296.6270337304;37541;38066.619333807415;38876.80561597174;51481;51783.48216517787;55693;57816;58940.11589826242;7657.540547567164;7710.7686769397005;7737.92262077372;8033.879491807745;8124.025116985763;9224.723258302261;11101.333919964827;11370.886291137314;11846.348450835287;12857.228566286052;9579.9042009579;9865;10284.331518451278;10371.740706482398;10458.69648251679;9839.557219924978;10425.843612345972;10462.843057353994;10663.146948244277;11114.499847507042;10407.58369665205;10518.631847885288;10748.677539673823;10887.945560272148;10973.725656858642;7780.105287891738;7806.453548251795;7905.169957154416;8086.110527841815;8176.7955801105445;8635.525046122524;9099.31755118382;10285.588576456857;10340;10378.221633377678 14:50:28 INFO - PROCESS | 7650 | |3;mootools.html;1291.9095663303567;1336.3652265174042;1344.5899000804757;1605.25355709595;1631.9347226110942;6393.168888044559;7170.1395832500175;7300.1604815446235;7841.803954901123;7872.881906771403;7331.230220826817;7610.733624323149;7616.466847320689;7623.695052197905;7630.771076867689;2108.3464126120875;2143.6570148776123;2155.3318471273956;2155.892205389732;2158.212252527832;2087.4572611121143;2114.693369461427;2144.281665642004;2145.495808485005;2167.0464995402053;2078.3453212238096;2135.850490465668;2144.6354119799594;2151.7202763640785;2170.1536400803698;2037.3887833649846;2062.123597471076;2063.319104695447;2063.4428704249844;2066.059942726056;2043.652579061563;2092.9790702092937;2121.543868068373;2123.203798575534;2127.287358734826;7765.339946104588;7785.026871641045;7797.6880924762945;7833.608319583998;7847.097583777824;4283.271843786564;4364.563543645641;4410.977945110286;4417.734935903856;4425.402570652953;2662.8934842606272;2740.287525243431;2841.7158284171624;2854.357769501866;2895.5367141257298;824.221111050058;848.5969164646805;853.5774791478258;864.0538610221797;865.8701194820765;10309;10337.069663730224;10341.689749307532;10372.63695770652;10406.531706073245;3809.238152369537;4046.736962097454;4057.39139129133;4121.216968775923;4140.213359461693;8784.121587841164;8785.297176225886;8824.911750882537;8841.292696584258;8841.55792210387;4384.101259241847;4384.605385515319;4397.912041759147;4399.076193999232;4403.603675669206;3291.2594666200393;3957.782321972319;4043.0903046814233;4051.493563304587;4055.53361363447;3446.6897979181495;3461.567304086989;3508.2808024354945;3518.296340731864;3541.698955588752;1095.4686976816238;1099.5766629847567;1102.6967583914327;1114.8662160540625;1124.3759713359163;574.9022666146765;688.3529482286634;695.3185877839745;699.8565294114694;712.184548691745;4859.562639362403;4961.330220420269;5026.371703537058;5035.974820125949;5111.897762044739;382.5256681714654;393.96454319111416;412.47409552819795;413.23551429855127;418.0218289203279;3381.847816848248;3404.2851001290005;3423.640517745601;3449.913752156216;3496.4580490024086;8745.737627871174;9175.816483670424;9191.356605037718;9206.26349892007;9220.90779092214;9134.406263592846;9151.267898568232;9157.084291570924;9161.862572061424;9167.633294668138;6759.479117198591;6880.862382752317;6895.310468953165;6897.034415181778;6910.689018994057;4800.183968725395;4844.346013288161;4879.289704708727;4924.187509060965;4979.278004689228;8252.752417427488;8366.539840308842;8471.61877715492;8511.319094472303;8618;8398.496090234605;8617.267532259828;8622.956885215533;8656.610452529525;8660.566971651519;5653.067243904709;6510.674466276572;6637.070810086495;6697.564658297195;6873.793786186422;6887.758928437481;7085.078939737801;7090.787276381717;7105.644717764195;7109.573425594481;6183.907241391473;6307.968460157854;6340.239171299289;6383.840403989751;6517;6025.698715064142;6170.382961703794;6305.117283580211;6328.9050664240995;6390.360963903572;5792.275965504312;5912.497437717842;5918.911216331672;5922.496587790086;5934.050551911673;4306.849260275875;4367.301231802896;4487.551244875486;4503.437070366204;4530.198009970058;4374.387585737935;4491.30384790358;4517.5030746617185;4531.320301954733;4538.546145385435 14:50:28 INFO - PROCESS | 7650 | |4;prototype.html;280.3146307278704;287.2030116426915;289.63361347894914;294.46995408265144;296.4530441335736;5031.723255220962;5104.515071068243;5106.489351064901;5122.180451127821;5129.358830146231;5009.574186194169;5020.497950204986;5032.773525191366;5037.471065538111;5053.469385714502;3707.610700876403;3797.126660868002;3884.3008258513455;3912.8826135215845;3936.7047471439755;3907.6678482329035;3924.823382947774;3931.253061918226;3933.331333673268;3940.251352243079;3896.1428485733236;3911.2373087247997;3916.7454115482547;3921.4117882317596;3922.117243825786;3819;3875.593062728401;3892.47451594034;3925.9607403926025;3932.9016774580577;3417.5646228584055;3425.3149370126075;3432.3650124727005;3438.381091403546;3440.4667276572172;4772.76136193189;4818.253170758538;4818.698951283169;4841.443234028096;4850.248211527219;4353.5428779977965;4445.755483448409;4476.574725401082;4495.842645507391;4507.188706032913;5185.844424667266;5192.1692529195525;5197.272381866542;5208.359366799446;5219.530242278213;3750.1749615084636;3750.362438385481;3753.7560058596105;3754.9436758448646;3784.1863999240295;5264.368275806889;5524.06090964533;5535.529479994206;5540.833774986757;5560.916586251209;3827.1580252344997;3853.7495062821386;3856.151646637735;3868.4390763339156;3872.4316651756085;3940.625640564142;3943.5464921533817;3943.783091929914;3944.7830369329963;3947.7236593438183;4475.216837053503;4482.013956929471;4497.100579884036;4501.659137248613;4502.594766471033;5194.194899790538;5223.5559977402345;5245;5284;5326.20374303486;1329.4947919790418;1351.6823546466574;1352.2495015266622;1353.7157196988742;1353.8646135386382;809.1988930958308;839.7480755773244;847.3814115695577;861.5950503263456;862.4307956748515;4301.78491075445;4436.689431739812;4615.592244365501;4626.398568186114;4638.768061596907;5438.15708565173;5453.727313634303;5461.426550212171;5477.3427188737605;5489.286392768994;4622.399088118523;4632.3977882875015;4642.9767851161205;4653.325267836212;4662.580367766917;2702.878370473294;2888.884444622234;2895.811772234798;2908.7347004053304;2915.6646985596503;5089.312942752681;5113.0285245803925;5139.948600513947;5142.922856157161;5150.948490515122;5393.191021346829;5560.916586251209;5578.721063946787;5587.245721827582;5595.720213989284;5061.898762024739;5066.316047333563;5068.619853511002;5075.5178258065425;5088.185890257541;5438.483344082306;5438.891222175614;5445.727713614383;5454.59090568201;5479.808206712746;5254.425331587571;5297.356281930521;5329.813456529003;5386.973065134649;5400.081986062457;5089.898202035864;5104.438511763628;5105.927755171456;5130.102232109441;5140.820071297487;3365.8485368158003;3437.724982001384;3439.7076248518156;3470.583529976419;3482.9129271767397;4726.15679884852;4760.595349395202;4777.593904518016;4832.371791667061;4869.269609558594;4576.313552966948;4579.893249105448;4586.678932474695;4674.579287864109;4689.765511724332;4577.1164166574845;4612.446506419251;4655.4180727409075;4658.510856360033;4677.76611169447;4324.589164029412;4587.334836448763;4606.79269432883;4622.953770462253;4624.1676498230645;4678;4680.859574212643;5101.20931255656;5102.749826292582;5296.814611488579;5159.896802064013;5166.3025491558155;5191.402988656353;5217.452167522356;5225.451327610546 14:50:28 INFO - PROCESS | 7650 | |5;yui.html;629.8079085878808;634.1280738983897;645.3546453546453;711.7935798618398;749.3592978003807;12662.24026558406;13992.720145597095;14001.369938352773;14027.789583156247;14031.649208769786;13211.735765284713;13394.464221431155;13459.1924484531;13459.259740714257;13495.797563036562;618.1593033474471;728.6320408193868;740.5630677900037;745.355267693444;760.0309605253318;751.9323260906517;754.6226886556722;755.7241606813501;755.7694903054567;758.1849511774836;799.9920000800005;803.2569872867604;804.3766081286991;805.7341077444429;805.9274665280124;798.1021350980147;799.6481548118809;801.791534201109;802.2699343597357;802.558592773972;584.7427132061879;584.8800995795851;585.6427579176699;587.7590188022933;589.5342679283361;12929.288889111094;12952.935235323763;12953.546625868144;12972.221666699934;12978.740425191538;13605.115667481581;13706.862931370659;13960.162390256617;13985.790213146709;14143.504977325847;10675.83986240207;10695.251332406735;10894.945525272402;10910.23628346016;10953.671389858317;3239.562659041023;3281.0648965044848;3311.2218628622254;3325.152086217999;3358.261182539837;68356.6582167086;68824.31175688229;69221;69392.30607693909;70314.64842675805;10246.795064098676;10568.89431105679;10615.31000484966;10632.255742098134;10645.520951557199;19163.233470661296;19209.423717288504;19222.327218547285;19308.517287067934;19414.514637134183;6491.67541622917;6495.220573531206;6524.836879077966;6549.279579246279;6571.408573228432;3730.6828919542145;3766.3785475396253;3767.7265263472486;3802.619738026175;3841.1741475582885;2862.6278583783974;2951.2031751426994;2962.570427288031;2963.4073185363013;2974.152366575559;475.96668233224034;487.8780304923769;497.52983430658406;502.26418297194783;505.4919805595353;441.023133758726;486.25117319327836;499.4206720204618;502.2616753372537;518.8702824293927;7787.649555770004;7806.414518911104;7824.804379890548;8144.511329320259;8487.533185674723;445.10533827007947;462.23269372840923;485.77654279032043;491.4397586751107;551.3907132618478;3587.1749497615697;3726.9440958385644;3793.412021136728;3821.6560509554274;3889.358255887747;56504;57075.714621426625;59435.70282148562;96380;99254.50372748234;79601.60199198966;93695;96304;96588.51705741427;97289.51355243179;77972;78254.60872695714;78326.21673783303;79117;80707.59646201732;7008.123984501937;7348.59582722934;7358.96320518394;7457;7498.700051997859;38692.22568721409;39473.40789888096;50112.248316274556;50169.49830501794;51546.71133221549;42832.78583607062;43065;61363.69318153559;62397.37602623916;62668.046535579044;10966.396848173108;10994.120470362512;11108.180076151477;11135.888641113484;11275;12485.188462749893;12594.118411711092;12805.359732013176;12971.351432428151;13073.346332683137;11365.48855301497;11844.644660660195;12226.449809758404;12252.877471225174;12501.56244531437;11139.554417823196;11509.251898626897;11608.419579021183;11686.532538698357;12466.5013399463;11310.321380717183;11572.884271157182;11597.362145082101;11655.125865560287;11871.347075910562;9921.702348929544;9937.20502359795;10019.699409017741;10229.693109206735;10314.484275786332;9801.950990245003;10261.9486902565;10263.846042309222;10336.896631033895;10365.222608304559 14:50:28 INFO - PROCESS | 7650 | __end_tp_report 14:50:28 INFO - PROCESS | 7650 | __start_cc_report 14:50:28 INFO - PROCESS | 7650 | _x_x_mozilla_cycle_collect,374 14:50:28 INFO - PROCESS | 7650 | __end_cc_report 14:50:28 INFO - PROCESS | 7650 | __startTimestamp1470693028746__endTimestamp 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | ------- Summary: start ------- 14:50:28 INFO - PROCESS | 7650 | Number of tests: 6 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | [#0] dojo.html Cycles:165 Average:4810.63 Median:4916.09 stddev:504.48 (10.3%) stddev-sans-first:477.41 14:50:28 INFO - PROCESS | 7650 | Values: 2675.5 2676.7 2701.7 2707.0 2725.9 4739.3 4881.1 4899.1 4929.3 4941.8 4801.6 4839.7 4844.6 4916.1 4938.9 4373.7 4462.1 4479.8 4480.4 4547.8 4545.3 4555.4 4592.7 4602.4 4649.5 4376.1 4428.4 4463.5 4527.5 4539.0 4522.8 4527.3 4542.7 4566.6 4578.4 4469.3 4480.3 4500.3 4516.8 4541.0 4670.6 4748.3 4806.7 4810.4 4894.4 5220.6 5225.6 5238.9 5240.1 5269.1 5234.8 5248.8 5251.5 5266.1 5297.3 4660.6 4750.1 4824.7 4875.2 4877.2 5320.7 5330.7 5332.4 5359.5 5379.1 5098.6 5099.7 5103.5 5103.5 5163.9 4981.1 5172.7 5172.7 5186.2 5187.2 5185.4 5194.2 5199.0 5286.8 5287.4 5151.4 5194.2 5203.5 5210.2 5259.7 4292.8 4389.5 4417.8 4433.1 4496.4 3855.8 3860.8 3891.1 3902.8 3927.5 4416.6 4456.8 4465.1 4474.7 4478.5 5001.1 5149.8 5193.6 5240.9 5295.0 4429.2 4465.9 4492.6 4495.2 4503.4 4696.3 4701.9 4704.6 4718.4 4769.7 4704.1 4774.8 4800.9 4900.3 4914.1 5156.2 5163.9 5167.6 5209.1 5215.5 4857.5 4861.5 4869.7 4889.4 4926.3 4920.3 5068.3 5094.8 5114.5 5139.6 5210.7 5211.2 5227.6 5239.9 5270.2 4968.5 5064.1 5080.5 5090.3 5127.6 4809.4 5029.2 5092.3 5094.3 5103.3 5023.5 5037.4 5061.7 5102.9 5112.8 5164.0 5166.5 5180.1 5183.5 5230.9 4773.8 4960.1 5013.2 5042.1 5054.2 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | [#1] ext.html Cycles:180 Average:50202.92 Median:377188.00 stddev:95221.16 (25.2%) stddev-sans-first:95415.28 14:50:28 INFO - PROCESS | 7650 | Values: 544.9 548.4 553.0 559.3 565.1 37150.3 38718.8 38724.4 42355.8 42546.0 40211.2 40719.2 40809.0 40874.0 40886.2 7814.9 7992.3 7992.4 7993.2 7996.7 7748.3 7803.7 7822.3 7827.8 7835.1 7823.4 7842.3 7855.0 7861.3 7872.6 7754.2 7757.5 7778.3 7786.3 7794.0 7707.8 7769.7 7820.7 7822.4 7832.5 38079.2 38102.8 38625.2 38669.8 38708.0 3106.5 3132.4 3144.4 3389.5 3719.6 28553.7 28843.0 29220.7 30875.2 31121.8 3182.2 3187.3 3235.5 3246.8 3339.8 267128.0 267338.7 269021.0 269400.0 272690.0 52790.5 52928.0 53400.0 53436.7 53485.7 56575.0 57004.0 57272.7 57281.0 57296.4 13021.3 13799.7 13829.3 13891.1 14023.4 10564.4 10802.6 10830.1 10835.6 10864.1 17721.9 17801.2 17922.9 17951.6 18035.9 6544.4 6636.9 6665.7 6694.8 6714.8 779.6 847.9 906.5 950.6 953.9 27243.9 28250.0 28552.7 31295.0 31333.4 917.1 959.2 961.8 985.7 1051.1 14034.8 14806.5 14818.7 15107.7 15126.6 409370.0 416491.0 418129.0 418422.0 418802.0 48142.8 48354.8 48358.5 48632.5 48634.0 1157.1 1180.1 1204.8 1211.8 1223.5 26434.9 27399.0 27781.3 27974.4 27992.9 35274.1 36190.6 36234.0 37986.2 42746.4 375067.0 379309.0 379514.0 380361.0 380703.0 29457.6 29576.6 29589.6 29823.7 29832.7 41940.2 42010.8 42019.6 43494.6 43515.6 28206.6 28240.7 28247.0 28354.1 28672.6 36293.6 36314.0 36652.8 36712.6 36969.8 34897.8 35048.8 35200.5 35703.3 35981.6 31705.2 33473.7 33714.8 33791.2 33941.7 21764.0 21891.2 21909.5 22022.2 22037.4 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | [#2] jquery.html Cycles:180 Average:26183.18 Median:4918.11 stddev:66771.26 (1357.7%) stddev-sans-first:66930.39 14:50:28 INFO - PROCESS | 7650 | Values: 349.0 360.8 362.2 372.1 377.8 15978.8 16048.1 16991.8 17001.7 17055.6 14169.4 15236.6 15290.2 15308.4 15310.9 4818.5 4846.5 4989.7 5067.3 5073.2 5006.2 5018.6 5018.8 5048.6 5076.4 5023.9 5044.7 5239.1 5310.1 5370.8 5293.4 5337.3 5373.7 6294.7 6634.1 6463.7 6473.1 6485.3 6557.4 6593.1 23489.6 23588.4 24264.0 24307.9 24311.5 1989.7 2012.3 2192.1 2246.1 2503.0 14478.2 14556.4 14729.3 14927.0 15324.3 1854.8 1864.6 1933.2 1961.9 1976.0 81902.6 82484.0 82910.2 83713.0 84497.6 14145.9 15501.0 15768.7 16238.8 16565.4 29104.4 29331.6 29505.0 29529.0 29536.9 8704.0 8797.6 8866.8 8897.3 9086.6 7199.4 7219.9 7347.5 7399.7 7447.2 8202.5 8226.9 8391.3 8466.6 8556.2 3298.2 3332.0 3392.8 3515.8 3550.8 757.3 806.3 808.2 830.2 851.9 16159.2 16860.7 16945.0 17391.8 17703.4 833.3 841.0 842.6 847.6 850.6 9324.7 9680.7 9748.5 9807.3 9947.2 392521.0 402536.0 407629.0 408252.0 408566.0 62568.7 74829.6 78611.2 79105.0 80187.6 873.3 893.2 908.4 909.9 914.8 14154.0 14269.6 15200.1 15311.4 15519.6 36304.3 37296.6 37541.0 38066.6 38876.8 51481.0 51783.5 55693.0 57816.0 58940.1 7657.5 7710.8 7737.9 8033.9 8124.0 9224.7 11101.3 11370.9 11846.3 12857.2 9579.9 9865.0 10284.3 10371.7 10458.7 9839.6 10425.8 10462.8 10663.1 11114.5 10407.6 10518.6 10748.7 10887.9 10973.7 7780.1 7806.5 7905.2 8086.1 8176.8 8635.5 9099.3 10285.6 10340.0 10378.2 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | [#3] mootools.html Cycles:180 Average:4897.67 Median:4822.26 stddev:2776.27 (57.6%) stddev-sans-first:2770.83 14:50:28 INFO - PROCESS | 7650 | Values: 1291.9 1336.4 1344.6 1605.3 1631.9 6393.2 7170.1 7300.2 7841.8 7872.9 7331.2 7610.7 7616.5 7623.7 7630.8 2108.3 2143.7 2155.3 2155.9 2158.2 2087.5 2114.7 2144.3 2145.5 2167.0 2078.3 2135.9 2144.6 2151.7 2170.2 2037.4 2062.1 2063.3 2063.4 2066.1 2043.7 2093.0 2121.5 2123.2 2127.3 7765.3 7785.0 7797.7 7833.6 7847.1 4283.3 4364.6 4411.0 4417.7 4425.4 2662.9 2740.3 2841.7 2854.4 2895.5 824.2 848.6 853.6 864.1 865.9 10309.0 10337.1 10341.7 10372.6 10406.5 3809.2 4046.7 4057.4 4121.2 4140.2 8784.1 8785.3 8824.9 8841.3 8841.6 4384.1 4384.6 4397.9 4399.1 4403.6 3291.3 3957.8 4043.1 4051.5 4055.5 3446.7 3461.6 3508.3 3518.3 3541.7 1095.5 1099.6 1102.7 1114.9 1124.4 574.9 688.4 695.3 699.9 712.2 4859.6 4961.3 5026.4 5036.0 5111.9 382.5 394.0 412.5 413.2 418.0 3381.8 3404.3 3423.6 3449.9 3496.5 8745.7 9175.8 9191.4 9206.3 9220.9 9134.4 9151.3 9157.1 9161.9 9167.6 6759.5 6880.9 6895.3 6897.0 6910.7 4800.2 4844.3 4879.3 4924.2 4979.3 8252.8 8366.5 8471.6 8511.3 8618.0 8398.5 8617.3 8623.0 8656.6 8660.6 5653.1 6510.7 6637.1 6697.6 6873.8 6887.8 7085.1 7090.8 7105.6 7109.6 6183.9 6308.0 6340.2 6383.8 6517.0 6025.7 6170.4 6305.1 6328.9 6390.4 5792.3 5912.5 5918.9 5922.5 5934.1 4306.8 4367.3 4487.6 4503.4 4530.2 4374.4 4491.3 4517.5 4531.3 4538.5 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | [#4] prototype.html Cycles:180 Average:4284.14 Median:4660.55 stddev:1245.43 (26.7%) stddev-sans-first:1212.12 14:50:28 INFO - PROCESS | 7650 | Values: 280.3 287.2 289.6 294.5 296.5 5031.7 5104.5 5106.5 5122.2 5129.4 5009.6 5020.5 5032.8 5037.5 5053.5 3707.6 3797.1 3884.3 3912.9 3936.7 3907.7 3924.8 3931.3 3933.3 3940.3 3896.1 3911.2 3916.7 3921.4 3922.1 3819.0 3875.6 3892.5 3926.0 3932.9 3417.6 3425.3 3432.4 3438.4 3440.5 4772.8 4818.3 4818.7 4841.4 4850.2 4353.5 4445.8 4476.6 4495.8 4507.2 5185.8 5192.2 5197.3 5208.4 5219.5 3750.2 3750.4 3753.8 3754.9 3784.2 5264.4 5524.1 5535.5 5540.8 5560.9 3827.2 3853.7 3856.2 3868.4 3872.4 3940.6 3943.5 3943.8 3944.8 3947.7 4475.2 4482.0 4497.1 4501.7 4502.6 5194.2 5223.6 5245.0 5284.0 5326.2 1329.5 1351.7 1352.2 1353.7 1353.9 809.2 839.7 847.4 861.6 862.4 4301.8 4436.7 4615.6 4626.4 4638.8 5438.2 5453.7 5461.4 5477.3 5489.3 4622.4 4632.4 4643.0 4653.3 4662.6 2702.9 2888.9 2895.8 2908.7 2915.7 5089.3 5113.0 5139.9 5142.9 5150.9 5393.2 5560.9 5578.7 5587.2 5595.7 5061.9 5066.3 5068.6 5075.5 5088.2 5438.5 5438.9 5445.7 5454.6 5479.8 5254.4 5297.4 5329.8 5387.0 5400.1 5089.9 5104.4 5105.9 5130.1 5140.8 3365.8 3437.7 3439.7 3470.6 3482.9 4726.2 4760.6 4777.6 4832.4 4869.3 4576.3 4579.9 4586.7 4674.6 4689.8 4577.1 4612.4 4655.4 4658.5 4677.8 4324.6 4587.3 4606.8 4623.0 4624.2 4678.0 4680.9 5101.2 5102.7 5296.8 5159.9 5166.3 5191.4 5217.5 5225.5 14:50:28 INFO - PROCESS | 7650 | 14:50:28 INFO - PROCESS | 7650 | [#5] yui.html Cycles:180 Average:17515.81 Median:21753.01 stddev:24837.27 (114.2%) stddev-sans-first:24874.59 14:50:28 INFO - PROCESS | 7650 | Values: 629.8 634.1 645.4 711.8 749.4 12662.2 13992.7 14001.4 14027.8 14031.6 13211.7 13394.5 13459.2 13459.3 13495.8 618.2 728.6 740.6 745.4 760.0 751.9 754.6 755.7 755.8 758.2 800.0 803.3 804.4 805.7 805.9 798.1 799.6 801.8 802.3 802.6 584.7 584.9 585.6 587.8 589.5 12929.3 12952.9 12953.5 12972.2 12978.7 13605.1 13706.9 13960.2 13985.8 14143.5 10675.8 10695.3 10894.9 10910.2 10953.7 3239.6 3281.1 3311.2 3325.2 3358.3 68356.7 68824.3 69221.0 69392.3 70314.6 10246.8 10568.9 10615.3 10632.3 10645.5 19163.2 19209.4 19222.3 19308.5 19414.5 6491.7 6495.2 6524.8 6549.3 6571.4 3730.7 3766.4 3767.7 3802.6 3841.2 2862.6 2951.2 2962.6 2963.4 2974.2 476.0 487.9 497.5 502.3 505.5 441.0 486.3 499.4 502.3 518.9 7787.6 7806.4 7824.8 8144.5 8487.5 445.1 462.2 485.8 491.4 551.4 3587.2 3726.9 3793.4 3821.7 3889.4 56504.0 57075.7 59435.7 96380.0 99254.5 79601.6 93695.0 96304.0 96588.5 97289.5 77972.0 78254.6 78326.2 79117.0 80707.6 7008.1 7348.6 7359.0 7457.0 7498.7 38692.2 39473.4 50112.2 50169.5 51546.7 42832.8 43065.0 61363.7 62397.4 62668.0 10966.4 10994.1 11108.2 11135.9 11275.0 12485.2 12594.1 12805.4 12971.4 13073.3 11365.5 11844.6 12226.4 12252.9 12501.6 11139.6 11509.3 11608.4 11686.5 12466.5 11310.3 11572.9 11597.4 11655.1 11871.3 9921.7 9937.2 10019.7 10229.7 10314.5 9802.0 10261.9 10263.8 10336.9 10365.2 14:50:28 INFO - PROCESS | 7650 | -------- Summary: end -------- 14:50:28 INFO - PROCESS | 7650 | 14:50:29 INFO - TEST-INFO | 7650: exit 0 14:50:29 INFO - TEST-OK | dromaeo_css | took 1116688ms 14:50:29 INFO - TEST-START | kraken 14:50:29 INFO - operating with platform_type : linux_ 14:50:29 INFO - Initialising browser for kraken test... 14:50:29 INFO - TEST-INFO | started process 7891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph4SGxo/profile http://localhost:46563/getInfo.html) 14:50:34 INFO - PROCESS | 7891 | __metrics Screen width/height:1600/1200 14:50:34 INFO - PROCESS | 7891 | colorDepth:24 14:50:34 INFO - PROCESS | 7891 | Browser inner width/height: 1024/697 14:50:34 INFO - PROCESS | 7891 | __metrics 14:50:34 ERROR - PROCESS | 7891 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:50:35 INFO - TEST-INFO | 7891: exit 0 14:50:35 INFO - Browser initialized. 14:50:35 INFO - Running cycle 1/1 for kraken test... 14:50:35 INFO - TEST-INFO | started process 8014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph4SGxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:47 INFO - PROCESS | 8014 | RSS: Main: 165507072 14:50:47 INFO - PROCESS | 8014 | 14:50:50 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:51 INFO - PROCESS | 8014 | RSS: Main: 170471424 14:50:51 INFO - PROCESS | 8014 | 14:50:53 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-dft) 14:50:54 INFO - PROCESS | 8014 | RSS: Main: 169127936 14:50:54 INFO - PROCESS | 8014 | 14:50:57 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-fft) 14:50:58 INFO - PROCESS | 8014 | RSS: Main: 165847040 14:50:58 INFO - PROCESS | 8014 | 14:51:00 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-oscillator) 14:51:00 INFO - PROCESS | 8014 | RSS: Main: 166457344 14:51:00 INFO - PROCESS | 8014 | 14:51:03 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:03 INFO - PROCESS | 8014 | RSS: Main: 166379520 14:51:03 INFO - PROCESS | 8014 | 14:51:07 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46563/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:07 INFO - PROCESS | 8014 | RSS: Main: 166891520 14:51:07 INFO - PROCESS | 8014 | 14:51:11 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46563/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:11 INFO - PROCESS | 8014 | RSS: Main: 163872768 14:51:11 INFO - PROCESS | 8014 | 14:51:14 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46563/tests/kraken/driver.html?testName=json-parse-financial) 14:51:15 INFO - PROCESS | 8014 | RSS: Main: 165699584 14:51:15 INFO - PROCESS | 8014 | 14:51:17 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:17 INFO - PROCESS | 8014 | RSS: Main: 165580800 14:51:17 INFO - PROCESS | 8014 | 14:51:19 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:20 INFO - PROCESS | 8014 | RSS: Main: 165978112 14:51:20 INFO - PROCESS | 8014 | 14:51:22 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:23 INFO - PROCESS | 8014 | RSS: Main: 166703104 14:51:23 INFO - PROCESS | 8014 | 14:51:26 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:26 INFO - PROCESS | 8014 | RSS: Main: 166969344 14:51:26 INFO - PROCESS | 8014 | 14:51:29 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:51:30 INFO - PROCESS | 8014 | RSS: Main: 166850560 14:51:30 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46563/tests/kraken/driver.html?testName=ai-astar) 14:51:32 INFO - PROCESS | 8014 | RSS: Main: 167571456 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | __start_tp_report 14:51:32 INFO - PROCESS | 8014 | _x_x_mozilla_page_load 14:51:32 INFO - PROCESS | 8014 | _x_x_mozilla_page_load_details 14:51:32 INFO - PROCESS | 8014 | |i|pagename|runs| 14:51:32 INFO - PROCESS | 8014 | |0;ai-astar;106;115;109;115;115;116;116;114;114;114 14:51:32 INFO - PROCESS | 8014 | |1;audio-beat-detection;153;126;151;182;123;148;149;128;184;124 14:51:32 INFO - PROCESS | 8014 | |2;audio-dft;164;164;165;174;165;163;162;163;165;164 14:51:32 INFO - PROCESS | 8014 | |3;audio-fft;77;76;76;188;77;77;77;76;153;80 14:51:32 INFO - PROCESS | 8014 | |4;audio-oscillator;86;85;153;87;85;84;133;86;85;148 14:51:32 INFO - PROCESS | 8014 | |5;imaging-gaussian-blur;117;119;118;117;118;118;119;118;121;117 14:51:32 INFO - PROCESS | 8014 | |6;imaging-darkroom;148;148;147;147;149;148;148;148;147;147 14:51:32 INFO - PROCESS | 8014 | |7;imaging-desaturate;96;96;96;96;96;97;96;95;95;95 14:51:32 INFO - PROCESS | 8014 | |8;json-parse-financial;66;65;65;65;65;64;63;64;63;63 14:51:32 INFO - PROCESS | 8014 | |9;json-stringify-tinderbox;65;65;64;65;67;66;66;65;66;66 14:51:32 INFO - PROCESS | 8014 | |10;stanford-crypto-aes;85;80;80;81;80;81;81;85;85;81 14:51:32 INFO - PROCESS | 8014 | |11;stanford-crypto-ccm;135;134;134;135;148;152;142;140;150;142 14:51:32 INFO - PROCESS | 8014 | |12;stanford-crypto-pbkdf2;167;167;167;166;170;167;170;175;168;164 14:51:32 INFO - PROCESS | 8014 | |13;stanford-crypto-sha256-iterative;68;68;69;67;68;68;67;71;67;67 14:51:32 INFO - PROCESS | 8014 | __end_tp_report 14:51:32 INFO - PROCESS | 8014 | __start_cc_report 14:51:32 INFO - PROCESS | 8014 | _x_x_mozilla_cycle_collect,977 14:51:32 INFO - PROCESS | 8014 | __end_cc_report 14:51:32 INFO - PROCESS | 8014 | __startTimestamp1470693092446__endTimestamp 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | ------- Summary: start ------- 14:51:32 INFO - PROCESS | 8014 | Number of tests: 14 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:3.27 (2.8%) stddev-sans-first:2.11 14:51:32 INFO - PROCESS | 8014 | Values: 106.0 115.0 109.0 115.0 115.0 116.0 116.0 114.0 114.0 114.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:150.00 stddev:22.50 (15.0%) stddev-sans-first:23.76 14:51:32 INFO - PROCESS | 8014 | Values: 153.0 126.0 151.0 182.0 123.0 148.0 149.0 128.0 184.0 124.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.35 (2.0%) stddev-sans-first:3.54 14:51:32 INFO - PROCESS | 8014 | Values: 164.0 164.0 165.0 174.0 165.0 163.0 162.0 163.0 165.0 164.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#3] audio-fft Cycles:10 Average:95.70 Median:77.00 stddev:40.29 (52.3%) stddev-sans-first:42.17 14:51:32 INFO - PROCESS | 8014 | Values: 77.0 76.0 76.0 188.0 77.0 77.0 77.0 76.0 153.0 80.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:29.04 (34.2%) stddev-sans-first:30.13 14:51:32 INFO - PROCESS | 8014 | Values: 86.0 85.0 153.0 87.0 85.0 84.0 133.0 86.0 85.0 148.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.22 14:51:32 INFO - PROCESS | 8014 | Values: 117.0 119.0 118.0 117.0 118.0 118.0 119.0 118.0 121.0 117.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:51:32 INFO - PROCESS | 8014 | Values: 148.0 148.0 147.0 147.0 149.0 148.0 148.0 148.0 147.0 147.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:51:32 INFO - PROCESS | 8014 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 95.0 95.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:0.93 14:51:32 INFO - PROCESS | 8014 | Values: 66.0 65.0 65.0 65.0 65.0 64.0 63.0 64.0 63.0 63.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 14:51:32 INFO - PROCESS | 8014 | Values: 65.0 65.0 64.0 65.0 67.0 66.0 66.0 65.0 66.0 66.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:2.18 (2.7%) stddev-sans-first:2.01 14:51:32 INFO - PROCESS | 8014 | Values: 85.0 80.0 80.0 81.0 80.0 81.0 81.0 85.0 85.0 81.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:142.00 stddev:6.86 (4.8%) stddev-sans-first:6.90 14:51:32 INFO - PROCESS | 8014 | Values: 135.0 134.0 134.0 135.0 148.0 152.0 142.0 140.0 150.0 142.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:167.50 stddev:3.00 (1.8%) stddev-sans-first:3.15 14:51:32 INFO - PROCESS | 8014 | Values: 167.0 167.0 167.0 166.0 170.0 167.0 170.0 175.0 168.0 164.0 14:51:32 INFO - PROCESS | 8014 | 14:51:32 INFO - PROCESS | 8014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 14:51:32 INFO - PROCESS | 8014 | Values: 68.0 68.0 69.0 67.0 68.0 68.0 67.0 71.0 67.0 67.0 14:51:32 INFO - PROCESS | 8014 | -------- Summary: end -------- 14:51:32 INFO - PROCESS | 8014 | 14:51:33 INFO - TEST-INFO | 8014: exit 0 14:51:33 INFO - TEST-OK | kraken | took 64077ms 14:51:33 INFO - SUITE-END | took 1180s 14:51:34 INFO - Completed test suite (00:19:41) 14:51:34 INFO - javascript benchmark 14:51:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6476.220836745422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2675.451532435851, 2676.692180399254, 2701.689305729841, 2706.959395609066, 2725.8500782456967, 4739.31279964405, 4881.145799485089, 4899.142650036243, 4929.309896614477, 4941.752912354385, 4801.615870730342, 4839.685420447669, 4844.61243100552, 4916.0905232532, 4938.901221975568, 4373.693841431101, 4462.12988467249, 4479.820807167709, 4480.417545719069, 4547.8180872765215, 4545.250033744444, 4555.362249285103, 4592.74739889306, 4602.447706275251, 4649.51180126087, 4376.146651402978, 4428.424304840382, 4463.4866990296205, 4527.501974782771, 4539.046800171951, 4522.751248681321, 4527.320901864747, 4542.682012259143, 4566.634669226487, 4578.404807375054, 4469.307257375112, 4480.260756975095, 4500.324951257305, 4516.751578663172, 4541.0236799088025, 4670.626349892001, 4748.287756836502, 4806.735629540374, 4810.374651295309, 4894.412670479565, 5220.608454365938, 5225.608079394061, 5238.92141617876, 5240.109181439127, 5269.104252277084, 5234.7644356004075, 5248.763805628756, 5251.501107394792, 5266.104762190437, 5297.311349524575, 4660.627149828073, 4750.12122757291, 4824.6863953842885, 4875.219964805614, 4877.219644856841, 5320.654157479751, 5330.733463326896, 5332.360116785933, 5359.544438722753, 5379.085555455582, 5098.566621837112, 5099.6685215460875, 5103.489651034941, 5103.540681338697, 5163.870903227375, 4981.128302547112, 5172.663776854492, 5172.715500647425, 5186.247994040843, 5187.170052791535, 5185.403678577012, 5194.194899790538, 5198.9740051299505, 5286.762095705702, 5287.4448182941005, 5151.381834179922, 5194.246834209094, 5203.531682148625, 5210.218467229945, 5259.658122222043, 4292.849750258726, 4389.4513185851765, 4417.757023363746, 4433.069055498317, 4496.39298694672, 3855.768653880776, 3860.82626281818, 3891.066144125446, 3902.843886244575, 3927.489426374553, 4416.558344165558, 4456.821727130879, 4465.084657645175, 4474.731516109044, 4478.507364189936, 5001.124803159432, 5149.845504634867, 5193.584513238932, 5240.9213861792105, 5295.0, 4429.158459892675, 4465.933011004838, 4492.618127459137, 4495.190865644216, 4503.437070366204, 4696.319033740157, 4701.858944231679, 4704.600108990706, 4718.41019872516, 4769.66612337133, 4704.1062198182235, 4774.7851346688785, 4800.903981920412, 4900.313956046157, 4914.090893184701, 5156.226566014978, 5163.896722065613, 5167.61242906791, 5209.114450543492, 5215.478452154754, 4857.514248575114, 4861.4895435980125, 4869.707817530818, 4889.413270407574, 4926.310316555613, 4920.31115643803, 5068.315777370008, 5094.847154585368, 5114.488551144856, 5139.563137133386, 5210.713410762444, 5211.166213405837, 5227.555657769132, 5239.89520209586, 5270.183121616155, 4968.478309777422, 5064.139096353555, 5080.49195080489, 5090.338256026693, 5127.589792816491, 4809.374781278411, 5029.1953287473825, 5092.312537807348, 5094.2867998479505, 5103.3110530077965, 5023.497650234947, 5037.445880953019, 5061.7469126544265, 5102.923456148086, 5112.79548818058, 5164.0, 5166.535011848951, 5180.093483640272, 5183.50756678115, 5230.947690523046, 4773.785179666993, 4960.131976904099, 5013.24801279811, 5042.14283571801, 5054.241863720325], "value": 4778.330763941543, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9182622606609, 548.4296331814911, 552.9695866727328, 559.3315987395061, 565.1297002615971, 37150.25699486012, 38718.83843484696, 38724.41913371298, 42355.78822105893, 42546.0, 40211.19577608446, 40719.18561628766, 40809.0, 40874.0, 40886.182276354455, 7814.882776758367, 7992.280694737473, 7992.3606111510935, 7993.200679932019, 7996.720114795983, 7748.341390981774, 7803.687852485894, 7822.256885595888, 7827.804304892395, 7835.059792824841, 7823.413244006694, 7842.254985776342, 7855.0, 7861.2531809478005, 7872.5670088145125, 7754.224577542257, 7757.495762775458, 7778.338841198505, 7786.26030527099, 7793.961030194841, 7707.845843083107, 7769.650365733555, 7820.67048601739, 7822.396408736252, 7832.490888092313, 38079.23841523182, 38102.80948595267, 38625.22749545021, 38669.806650966566, 38708.0, 3106.51848963411, 3132.4361614909308, 3144.4340018796606, 3389.49157626358, 3719.553653561563, 28553.714462855314, 28843.0, 29220.70779292201, 30875.228119297197, 31121.84439077813, 3182.1726351148636, 3187.2828613561996, 3235.4823228283362, 3246.756493263015, 3339.8163101029436, 267128.0, 267338.6633066842, 269021.0, 269400.0, 272690.0, 52790.47209527856, 52928.0, 53400.0, 53436.73281633567, 53485.73257133767, 56575.0, 57004.0, 57272.71363643155, 57281.0, 57296.42703572994, 13021.283829389286, 13799.655008624664, 13829.30853457323, 13891.097078689852, 14023.439062437388, 10564.418956957441, 10802.567897284021, 10830.133589312836, 10835.620753273597, 10864.130869530418, 17721.911390442965, 17801.1989460472, 17922.91038544799, 17951.640967180585, 18035.909820450815, 6544.3782840630065, 6636.933630663728, 6665.700043498055, 6694.799156025327, 6714.832129196711, 779.6140910249463, 847.8770578266117, 906.4833045164193, 950.5532399772096, 953.9141477266941, 27243.863780681368, 28250.0, 28552.71447285542, 31295.0, 31333.37333253322, 917.1287277086794, 959.1894848852709, 961.8461046232569, 985.7486340983004, 1051.1223128687632, 14034.789478157836, 14806.481773137888, 14818.703625927421, 15107.697846043018, 15126.621834454227, 409370.0, 416491.0, 418129.0, 418422.0, 418802.0, 48142.75928620405, 48354.75822620864, 48358.51641483611, 48632.513674863505, 48634.0, 1157.1494951210852, 1180.1384988957936, 1204.7590481903653, 1211.7818792617238, 1223.4677915106956, 26434.86782566075, 27399.0, 27781.305467363476, 27974.44051119007, 27992.86003569969, 35274.11814704653, 36190.63809361873, 36234.0, 37986.24027519379, 42746.35880461733, 375067.0, 379309.0, 379514.0, 380361.0, 380703.0, 29457.55813662754, 29576.556351655174, 29589.556156657236, 29823.70176298296, 29832.70167298386, 41940.16119677528, 42010.78994605008, 42019.57980420279, 43494.56505434905, 43515.56484435115, 28206.576901346907, 28240.71759282381, 28247.0, 28354.149375518766, 28672.569911451763, 36293.63706362902, 36314.0, 36652.81673591615, 36712.63287367092, 36969.81515092407, 34897.82551087228, 35048.824755877074, 35200.471992919614, 35703.28593428065, 35981.64018359783, 31705.20736981594, 33473.65263473731, 33714.83142584271, 33791.15522111967, 33941.66058339385, 21764.0, 21891.233806816686, 21909.452263693536, 22022.229221977155, 22037.449063773533], "value": 17501.928284199985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9755717099803, 360.75288427427205, 362.23387535362707, 372.05683592094044, 377.7638975640225, 15978.84021159788, 16048.117353545551, 16991.83008169918, 17001.744973825404, 17055.57361065974, 14169.362378692958, 15236.619084522865, 15290.235488225571, 15308.387664493435, 15310.923445382785, 4818.494058123899, 4846.539578740023, 4989.675671081386, 5067.290579318898, 5073.239014147889, 5006.1990081586955, 5018.623603229772, 5018.7992480300745, 5048.6465947383695, 5076.390833100015, 5023.874403139914, 5044.697318160922, 5239.13554263546, 5310.07073762092, 5370.758315875795, 5293.364796224459, 5337.279467271907, 5373.6775793452325, 6294.653794041325, 6634.071230027752, 6463.67681615922, 6473.061406096137, 6485.319041500669, 6557.442617377528, 6593.142891424084, 23489.647655285185, 23588.410289742722, 24264.029438822425, 24307.87846060776, 24311.513769724683, 1989.7413336266193, 2012.30575451469, 2192.1450634252656, 2246.0791075659063, 2502.973780749902, 14478.203698796562, 14556.417743290256, 14729.337179826933, 14927.0, 15324.310406031755, 1854.7774267088037, 1864.60843222922, 1933.2073849721687, 1961.852861035428, 1975.9802401976083, 81902.59048704719, 82483.9999999994, 82910.17089829146, 83713.0, 84497.57751211266, 14145.929270353583, 15501.0, 15768.684626307639, 16238.837611623969, 16565.361698724137, 29104.41791164165, 29331.560026599618, 29505.0, 29529.0, 29536.852315738284, 8703.95648021756, 8797.648094076294, 8866.77833054166, 8897.28821694276, 9086.591103400362, 7199.424046076406, 7219.8917016244795, 7347.5224110432655, 7399.704011839466, 7447.218042105609, 8202.548859812649, 8226.917730822615, 8391.328693704489, 8466.619002144918, 8556.229939305493, 3298.175456135966, 3331.9666803331656, 3392.7946834557733, 3515.789052656849, 3550.804705741209, 757.2957149850691, 806.3267171911402, 808.2321794295443, 830.2112992657, 851.8849955256085, 16159.192040397933, 16860.74708879368, 16945.0, 17391.826081739273, 17703.38038168658, 833.2917020532499, 840.9537475438909, 842.616609442702, 847.5931552854664, 850.6427300533791, 9324.720258392259, 9680.709578712649, 9748.512574371252, 9807.31348805591, 9947.20422366209, 392521.0, 402536.0, 407629.0, 408252.0, 408566.0, 62568.74862502816, 74829.6258518704, 78611.21388786039, 79105.0, 80187.59906200432, 873.3493547307297, 893.1693525021792, 908.3505293715026, 909.940853844498, 914.794171311463, 14154.0, 14269.64325891861, 15200.087994720352, 15311.38754449854, 15519.612009699396, 36304.27391452209, 37296.6270337304, 37541.0, 38066.619333807415, 38876.80561597174, 51481.0, 51783.48216517787, 55693.0, 57816.0, 58940.11589826242, 7657.540547567164, 7710.7686769397005, 7737.92262077372, 8033.879491807745, 8124.025116985763, 9224.723258302261, 11101.333919964827, 11370.886291137314, 11846.348450835287, 12857.228566286052, 9579.9042009579, 9865.0, 10284.331518451278, 10371.740706482398, 10458.69648251679, 9839.557219924978, 10425.843612345972, 10462.843057353994, 10663.146948244277, 11114.499847507042, 10407.58369665205, 10518.631847885288, 10748.677539673823, 10887.945560272148, 10973.725656858642, 7780.105287891738, 7806.453548251795, 7905.169957154416, 8086.110527841815, 8176.7955801105445, 8635.525046122524, 9099.31755118382, 10285.588576456857, 10340.0, 10378.221633377678], "value": 9112.729327506568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.9095663303567, 1336.3652265174042, 1344.5899000804757, 1605.25355709595, 1631.9347226110942, 6393.168888044559, 7170.1395832500175, 7300.1604815446235, 7841.803954901123, 7872.881906771403, 7331.230220826817, 7610.733624323149, 7616.466847320689, 7623.695052197905, 7630.771076867689, 2108.3464126120875, 2143.6570148776123, 2155.3318471273956, 2155.892205389732, 2158.212252527832, 2087.4572611121143, 2114.693369461427, 2144.281665642004, 2145.495808485005, 2167.0464995402053, 2078.3453212238096, 2135.850490465668, 2144.6354119799594, 2151.7202763640785, 2170.1536400803698, 2037.3887833649846, 2062.123597471076, 2063.319104695447, 2063.4428704249844, 2066.059942726056, 2043.652579061563, 2092.9790702092937, 2121.543868068373, 2123.203798575534, 2127.287358734826, 7765.339946104588, 7785.026871641045, 7797.6880924762945, 7833.608319583998, 7847.097583777824, 4283.271843786564, 4364.563543645641, 4410.977945110286, 4417.734935903856, 4425.402570652953, 2662.8934842606272, 2740.287525243431, 2841.7158284171624, 2854.357769501866, 2895.5367141257298, 824.221111050058, 848.5969164646805, 853.5774791478258, 864.0538610221797, 865.8701194820765, 10309.0, 10337.069663730224, 10341.689749307532, 10372.63695770652, 10406.531706073245, 3809.238152369537, 4046.736962097454, 4057.39139129133, 4121.216968775923, 4140.213359461693, 8784.121587841164, 8785.297176225886, 8824.911750882537, 8841.292696584258, 8841.55792210387, 4384.101259241847, 4384.605385515319, 4397.912041759147, 4399.076193999232, 4403.603675669206, 3291.2594666200393, 3957.782321972319, 4043.0903046814233, 4051.493563304587, 4055.53361363447, 3446.6897979181495, 3461.567304086989, 3508.2808024354945, 3518.296340731864, 3541.698955588752, 1095.4686976816238, 1099.5766629847567, 1102.6967583914327, 1114.8662160540625, 1124.3759713359163, 574.9022666146765, 688.3529482286634, 695.3185877839745, 699.8565294114694, 712.184548691745, 4859.562639362403, 4961.330220420269, 5026.371703537058, 5035.974820125949, 5111.897762044739, 382.5256681714654, 393.96454319111416, 412.47409552819795, 413.23551429855127, 418.0218289203279, 3381.847816848248, 3404.2851001290005, 3423.640517745601, 3449.913752156216, 3496.4580490024086, 8745.737627871174, 9175.816483670424, 9191.356605037718, 9206.26349892007, 9220.90779092214, 9134.406263592846, 9151.267898568232, 9157.084291570924, 9161.862572061424, 9167.633294668138, 6759.479117198591, 6880.862382752317, 6895.310468953165, 6897.034415181778, 6910.689018994057, 4800.183968725395, 4844.346013288161, 4879.289704708727, 4924.187509060965, 4979.278004689228, 8252.752417427488, 8366.539840308842, 8471.61877715492, 8511.319094472303, 8618.0, 8398.496090234605, 8617.267532259828, 8622.956885215533, 8656.610452529525, 8660.566971651519, 5653.067243904709, 6510.674466276572, 6637.070810086495, 6697.564658297195, 6873.793786186422, 6887.758928437481, 7085.078939737801, 7090.787276381717, 7105.644717764195, 7109.573425594481, 6183.907241391473, 6307.968460157854, 6340.239171299289, 6383.840403989751, 6517.0, 6025.698715064142, 6170.382961703794, 6305.117283580211, 6328.9050664240995, 6390.360963903572, 5792.275965504312, 5912.497437717842, 5918.911216331672, 5922.496587790086, 5934.050551911673, 4306.849260275875, 4367.301231802896, 4487.551244875486, 4503.437070366204, 4530.198009970058, 4374.387585737935, 4491.30384790358, 4517.5030746617185, 4531.320301954733, 4538.546145385435], "value": 3863.4437543924746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.3146307278704, 287.2030116426915, 289.63361347894914, 294.46995408265144, 296.4530441335736, 5031.723255220962, 5104.515071068243, 5106.489351064901, 5122.180451127821, 5129.358830146231, 5009.574186194169, 5020.497950204986, 5032.773525191366, 5037.471065538111, 5053.469385714502, 3707.610700876403, 3797.126660868002, 3884.3008258513455, 3912.8826135215845, 3936.7047471439755, 3907.6678482329035, 3924.823382947774, 3931.253061918226, 3933.331333673268, 3940.251352243079, 3896.1428485733236, 3911.2373087247997, 3916.7454115482547, 3921.4117882317596, 3922.117243825786, 3819.0, 3875.593062728401, 3892.47451594034, 3925.9607403926025, 3932.9016774580577, 3417.5646228584055, 3425.3149370126075, 3432.3650124727005, 3438.381091403546, 3440.4667276572172, 4772.76136193189, 4818.253170758538, 4818.698951283169, 4841.443234028096, 4850.248211527219, 4353.5428779977965, 4445.755483448409, 4476.574725401082, 4495.842645507391, 4507.188706032913, 5185.844424667266, 5192.1692529195525, 5197.272381866542, 5208.359366799446, 5219.530242278213, 3750.1749615084636, 3750.362438385481, 3753.7560058596105, 3754.9436758448646, 3784.1863999240295, 5264.368275806889, 5524.06090964533, 5535.529479994206, 5540.833774986757, 5560.916586251209, 3827.1580252344997, 3853.7495062821386, 3856.151646637735, 3868.4390763339156, 3872.4316651756085, 3940.625640564142, 3943.5464921533817, 3943.783091929914, 3944.7830369329963, 3947.7236593438183, 4475.216837053503, 4482.013956929471, 4497.100579884036, 4501.659137248613, 4502.594766471033, 5194.194899790538, 5223.5559977402345, 5245.0, 5284.0, 5326.20374303486, 1329.4947919790418, 1351.6823546466574, 1352.2495015266622, 1353.7157196988742, 1353.8646135386382, 809.1988930958308, 839.7480755773244, 847.3814115695577, 861.5950503263456, 862.4307956748515, 4301.78491075445, 4436.689431739812, 4615.592244365501, 4626.398568186114, 4638.768061596907, 5438.15708565173, 5453.727313634303, 5461.426550212171, 5477.3427188737605, 5489.286392768994, 4622.399088118523, 4632.3977882875015, 4642.9767851161205, 4653.325267836212, 4662.580367766917, 2702.878370473294, 2888.884444622234, 2895.811772234798, 2908.7347004053304, 2915.6646985596503, 5089.312942752681, 5113.0285245803925, 5139.948600513947, 5142.922856157161, 5150.948490515122, 5393.191021346829, 5560.916586251209, 5578.721063946787, 5587.245721827582, 5595.720213989284, 5061.898762024739, 5066.316047333563, 5068.619853511002, 5075.5178258065425, 5088.185890257541, 5438.483344082306, 5438.891222175614, 5445.727713614383, 5454.59090568201, 5479.808206712746, 5254.425331587571, 5297.356281930521, 5329.813456529003, 5386.973065134649, 5400.081986062457, 5089.898202035864, 5104.438511763628, 5105.927755171456, 5130.102232109441, 5140.820071297487, 3365.8485368158003, 3437.724982001384, 3439.7076248518156, 3470.583529976419, 3482.9129271767397, 4726.15679884852, 4760.595349395202, 4777.593904518016, 4832.371791667061, 4869.269609558594, 4576.313552966948, 4579.893249105448, 4586.678932474695, 4674.579287864109, 4689.765511724332, 4577.1164166574845, 4612.446506419251, 4655.4180727409075, 4658.510856360033, 4677.76611169447, 4324.589164029412, 4587.334836448763, 4606.79269432883, 4622.953770462253, 4624.1676498230645, 4678.0, 4680.859574212643, 5101.20931255656, 5102.749826292582, 5296.814611488579, 5159.896802064013, 5166.3025491558155, 5191.402988656353, 5217.452167522356, 5225.451327610546], "value": 3882.7150742486856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.8079085878808, 634.1280738983897, 645.3546453546453, 711.7935798618398, 749.3592978003807, 12662.24026558406, 13992.720145597095, 14001.369938352773, 14027.789583156247, 14031.649208769786, 13211.735765284713, 13394.464221431155, 13459.1924484531, 13459.259740714257, 13495.797563036562, 618.1593033474471, 728.6320408193868, 740.5630677900037, 745.355267693444, 760.0309605253318, 751.9323260906517, 754.6226886556722, 755.7241606813501, 755.7694903054567, 758.1849511774836, 799.9920000800005, 803.2569872867604, 804.3766081286991, 805.7341077444429, 805.9274665280124, 798.1021350980147, 799.6481548118809, 801.791534201109, 802.2699343597357, 802.558592773972, 584.7427132061879, 584.8800995795851, 585.6427579176699, 587.7590188022933, 589.5342679283361, 12929.288889111094, 12952.935235323763, 12953.546625868144, 12972.221666699934, 12978.740425191538, 13605.115667481581, 13706.862931370659, 13960.162390256617, 13985.790213146709, 14143.504977325847, 10675.83986240207, 10695.251332406735, 10894.945525272402, 10910.23628346016, 10953.671389858317, 3239.562659041023, 3281.0648965044848, 3311.2218628622254, 3325.152086217999, 3358.261182539837, 68356.6582167086, 68824.31175688229, 69221.0, 69392.30607693909, 70314.64842675805, 10246.795064098676, 10568.89431105679, 10615.31000484966, 10632.255742098134, 10645.520951557199, 19163.233470661296, 19209.423717288504, 19222.327218547285, 19308.517287067934, 19414.514637134183, 6491.67541622917, 6495.220573531206, 6524.836879077966, 6549.279579246279, 6571.408573228432, 3730.6828919542145, 3766.3785475396253, 3767.7265263472486, 3802.619738026175, 3841.1741475582885, 2862.6278583783974, 2951.2031751426994, 2962.570427288031, 2963.4073185363013, 2974.152366575559, 475.96668233224034, 487.8780304923769, 497.52983430658406, 502.26418297194783, 505.4919805595353, 441.023133758726, 486.25117319327836, 499.4206720204618, 502.2616753372537, 518.8702824293927, 7787.649555770004, 7806.414518911104, 7824.804379890548, 8144.511329320259, 8487.533185674723, 445.10533827007947, 462.23269372840923, 485.77654279032043, 491.4397586751107, 551.3907132618478, 3587.1749497615697, 3726.9440958385644, 3793.412021136728, 3821.6560509554274, 3889.358255887747, 56504.0, 57075.714621426625, 59435.70282148562, 96380.0, 99254.50372748234, 79601.60199198966, 93695.0, 96304.0, 96588.51705741427, 97289.51355243179, 77972.0, 78254.60872695714, 78326.21673783303, 79117.0, 80707.59646201732, 7008.123984501937, 7348.59582722934, 7358.96320518394, 7457.0, 7498.700051997859, 38692.22568721409, 39473.40789888096, 50112.248316274556, 50169.49830501794, 51546.71133221549, 42832.78583607062, 43065.0, 61363.69318153559, 62397.37602623916, 62668.046535579044, 10966.396848173108, 10994.120470362512, 11108.180076151477, 11135.888641113484, 11275.0, 12485.188462749893, 12594.118411711092, 12805.359732013176, 12971.351432428151, 13073.346332683137, 11365.48855301497, 11844.644660660195, 12226.449809758404, 12252.877471225174, 12501.56244531437, 11139.554417823196, 11509.251898626897, 11608.419579021183, 11686.532538698357, 12466.5013399463, 11310.321380717183, 11572.884271157182, 11597.362145082101, 11655.125865560287, 11871.347075910562, 9921.702348929544, 9937.20502359795, 10019.699409017741, 10229.693109206735, 10314.484275786332, 9801.950990245003, 10261.9486902565, 10263.846042309222, 10336.896631033895, 10365.222608304559], "value": 6452.925488163449, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 109.0, 115.0, 115.0, 116.0, 116.0, 114.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 151.0, 182.0, 123.0, 148.0, 149.0, 128.0, 184.0, 124.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 174.0, 165.0, 163.0, 162.0, 163.0, 165.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 188.0, 77.0, 77.0, 77.0, 76.0, 153.0, 80.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 153.0, 87.0, 85.0, 84.0, 133.0, 86.0, 85.0, 148.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 121.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 63.0, 64.0, 63.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 80.0, 81.0, 80.0, 81.0, 81.0, 85.0, 85.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 134.0, 135.0, 148.0, 152.0, 142.0, 140.0, 150.0, 142.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 167.0, 166.0, 170.0, 167.0, 170.0, 175.0, 168.0, 164.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 68.0, 68.0, 67.0, 71.0, 67.0, 67.0], "value": 68.0, "unit": "score"}]}]} 14:51:34 INFO - Return code: 0 14:51:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:51:34 ERROR - # TBPL SUCCESS # 14:51:34 INFO - Running post-action listener: _resource_record_post_action 14:51:34 INFO - [mozharness: 2016-08-08 21:51:34.260558Z] Finished run-tests step (success) 14:51:34 INFO - Running post-run listener: _resource_record_post_run 14:51:34 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537886720; Read time: 8; Write time: 358784 14:51:34 INFO - TinderboxPrint: CPU usage
13.4% 14:51:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:51:34 INFO - TinderboxPrint: I/O write bytes / time
537,886,720 / 358,784 14:51:34 INFO - TinderboxPrint: CPU idle
8,280.1 (86.6%) 14:51:34 INFO - TinderboxPrint: CPU user
1,222.1 (12.8%) 14:51:34 INFO - TinderboxPrint: Swap in / out
0 / 0 14:51:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 186494976; Read time: 0; Write time: 164300 14:51:34 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 299634688; Read time: 0; Write time: 172064 14:51:34 INFO - Running post-run listener: _upload_blobber_files 14:51:34 INFO - Blob upload gear active. 14:51:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:34 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 14:51:34 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:51:34 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:51:35 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:36 INFO - (blobuploader) - INFO - Done attempting. 14:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:37 INFO - (blobuploader) - INFO - Done attempting. 14:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:40 INFO - (blobuploader) - INFO - Done attempting. 14:51:40 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:40 INFO - Return code: 0 14:51:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/898e2bfb1cc496b9e68bacd5ff6f922cdb1a502a1ad65bda3cb926718ae6c1ac7e9eb98a343600fba28afd9510c01fde4481ce7036e62220842619c1976b0d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4038ffc60e157993410712f3758c9800f70562e2185bea3d40561901f0705ec8eb2563cb5c11a45a734bd880426226297543103341ac4eb46f96560ecb6e907b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a6955572cd330a46d97beaf35cc07a502d71741b29873f1ce06e90677255ec074110e8dffef7fcb0686ca9b460d8d8232ff294eeb8a07867f4d64046f542b69"} 14:51:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:40 INFO - Contents: 14:51:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/898e2bfb1cc496b9e68bacd5ff6f922cdb1a502a1ad65bda3cb926718ae6c1ac7e9eb98a343600fba28afd9510c01fde4481ce7036e62220842619c1976b0d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4038ffc60e157993410712f3758c9800f70562e2185bea3d40561901f0705ec8eb2563cb5c11a45a734bd880426226297543103341ac4eb46f96560ecb6e907b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a6955572cd330a46d97beaf35cc07a502d71741b29873f1ce06e90677255ec074110e8dffef7fcb0686ca9b460d8d8232ff294eeb8a07867f4d64046f542b69"} 14:51:40 INFO - Running post-run listener: copy_logs_to_upload_dir 14:51:40 INFO - Copying logs to upload dir... 14:51:40 INFO - mkdir: /builds/slave/test/build/upload/logs 14:51:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.407067 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-08 14:51:40.976913) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:51:40.980523) ========= 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=523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/898e2bfb1cc496b9e68bacd5ff6f922cdb1a502a1ad65bda3cb926718ae6c1ac7e9eb98a343600fba28afd9510c01fde4481ce7036e62220842619c1976b0d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4038ffc60e157993410712f3758c9800f70562e2185bea3d40561901f0705ec8eb2563cb5c11a45a734bd880426226297543103341ac4eb46f96560ecb6e907b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a6955572cd330a46d97beaf35cc07a502d71741b29873f1ce06e90677255ec074110e8dffef7fcb0686ca9b460d8d8232ff294eeb8a07867f4d64046f542b69"} build_url:https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/MPdscakaQju7Gq1TAwQQUQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/898e2bfb1cc496b9e68bacd5ff6f922cdb1a502a1ad65bda3cb926718ae6c1ac7e9eb98a343600fba28afd9510c01fde4481ce7036e62220842619c1976b0d50", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4038ffc60e157993410712f3758c9800f70562e2185bea3d40561901f0705ec8eb2563cb5c11a45a734bd880426226297543103341ac4eb46f96560ecb6e907b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8a6955572cd330a46d97beaf35cc07a502d71741b29873f1ce06e90677255ec074110e8dffef7fcb0686ca9b460d8d8232ff294eeb8a07867f4d64046f542b69"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:51:41.005204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:51:41.005509) ========= 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=523ca41ca1e0623de333ad52000001bf-1470691778.541054-1620459803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:51:41.054729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:51:41.055039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:51:41.055314) ========= ========= Total master_lag: 0.22 =========