builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1471975636.89 results: success (0) buildid: 20160823020448 builduid: a7e9c5855b34472d91f6aea3e4caeafa revision: a759a1704791bd3de6462d4153f02c7844e786b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:16.887257) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:16.887800) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:16.888137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:16.903324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:16.903638) ========= 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=920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 11:07:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.2M=0s 2016-08-23 11:07:17 (39.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090399 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:17.008434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:17.008822) ========= 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=920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020932 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:17.058926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 11:07:17.059341) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a759a1704791bd3de6462d4153f02c7844e786b6 --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 a759a1704791bd3de6462d4153f02c7844e786b6 --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=920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 11:07:17,476 truncating revision to first 12 chars 2016-08-23 11:07:17,476 Setting DEBUG logging. 2016-08-23 11:07:17,477 attempt 1/10 2016-08-23 11:07:17,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a759a1704791?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 11:07:18,139 unpacking tar archive at: autoland-a759a1704791/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 11:07:18.060045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:18.060698) ========= script_repo_revision: a759a1704791bd3de6462d4153f02c7844e786b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:18.061492) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:18.062139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:07:18.073818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-23 11:07:18.074205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:18 INFO - MultiFileLogger online at 20160823 11:07:18 in /builds/slave/test 11:07:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 11:07:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:07:18 INFO - {'append_to_log': False, 11:07:18 INFO - 'base_work_dir': '/builds/slave/test', 11:07:18 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:07:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:07:18 INFO - 'branch': 'Autoland-Non-PGO', 11:07:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:18 INFO - 'config_files': ('talos/linux_config.py',), 11:07:18 INFO - 'default_actions': ('clobber', 11:07:18 INFO - 'read-buildbot-config', 11:07:18 INFO - 'download-and-extract', 11:07:18 INFO - 'populate-webroot', 11:07:18 INFO - 'create-virtualenv', 11:07:18 INFO - 'install', 11:07:18 INFO - 'run-tests'), 11:07:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:18 INFO - 'download_minidump_stackwalk': True, 11:07:18 INFO - 'download_symbols': 'ondemand', 11:07:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:18 INFO - 'installer_path': 'installer.exe', 11:07:18 INFO - 'log_level': 'info', 11:07:18 INFO - 'log_name': 'talos', 11:07:18 INFO - 'log_to_console': True, 11:07:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:18 INFO - 'opt_config_files': (), 11:07:18 INFO - 'pip_index': False, 11:07:18 INFO - 'sps_profile': False, 11:07:18 INFO - 'sps_profile_interval': 0, 11:07:18 INFO - 'suite': 'dromaeojs', 11:07:18 INFO - 'system_bits': '32', 11:07:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:18 INFO - 'title': 'talos-linux64-ix-053', 11:07:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:18 INFO - 'use_talos_json': True, 11:07:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:07:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:18 INFO - 'work_dir': 'build'} 11:07:18 INFO - [mozharness: 2016-08-23 18:07:18.583692Z] Running clobber step. 11:07:18 INFO - Running pre-action listener: _resource_record_pre_action 11:07:18 INFO - Running main action method: clobber 11:07:18 INFO - rmtree: /builds/slave/test/build 11:07:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:19 INFO - Running post-action listener: _resource_record_post_action 11:07:19 INFO - [mozharness: 2016-08-23 18:07:19.040262Z] Finished clobber step (success) 11:07:19 INFO - [mozharness: 2016-08-23 18:07:19.040363Z] Running read-buildbot-config step. 11:07:19 INFO - Running pre-action listener: _resource_record_pre_action 11:07:19 INFO - Running main action method: read_buildbot_config 11:07:19 INFO - Using buildbot properties: 11:07:19 INFO - { 11:07:19 INFO - "project": "", 11:07:19 INFO - "product": "firefox", 11:07:19 INFO - "script_repo_revision": "production", 11:07:19 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:07:19 INFO - "repository": "", 11:07:19 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:07:19 INFO - "buildid": "20160823020448", 11:07:19 INFO - "pgo_build": "False", 11:07:19 INFO - "basedir": "/builds/slave/test", 11:07:19 INFO - "buildnumber": 343, 11:07:19 INFO - "slavename": "talos-linux64-ix-053", 11:07:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:07:19 INFO - "platform": "ubuntu64_hw", 11:07:19 INFO - "scheduler": "tests-autoland-linux64-talos", 11:07:19 INFO - "branch": "autoland", 11:07:19 INFO - "repo_path": "integration/autoland", 11:07:19 INFO - "revision": "a759a1704791bd3de6462d4153f02c7844e786b6", 11:07:19 INFO - "stage_platform": "linux64", 11:07:19 INFO - "builduid": "a7e9c5855b34472d91f6aea3e4caeafa", 11:07:19 INFO - "slavebuilddir": "test" 11:07:19 INFO - } 11:07:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:07:19 INFO - Running post-action listener: _resource_record_post_action 11:07:19 INFO - [mozharness: 2016-08-23 18:07:19.042794Z] Finished read-buildbot-config step (success) 11:07:19 INFO - [mozharness: 2016-08-23 18:07:19.042882Z] Running download-and-extract step. 11:07:19 INFO - Running pre-action listener: _resource_record_pre_action 11:07:19 INFO - Running main action method: download_and_extract 11:07:19 INFO - mkdir: /builds/slave/test/build/tests 11:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:19 INFO - trying https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:07:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:07:19 INFO - Downloaded 1361 bytes. 11:07:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:07:19 INFO - Using the following test package requirements: 11:07:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:07:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'jsshell-linux-x86_64.zip'], 11:07:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:07:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:07:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:19 INFO - trying https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:07:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:20 INFO - Downloaded 20332083 bytes. 11:07:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:07:24 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:07: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')]} 11:07:24 INFO - trying https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:07:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:25 INFO - Downloaded 20332083 bytes. 11:07:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:30 INFO - trying https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:07:31 INFO - Downloaded 14413981 bytes. 11:07:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:07: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')]} 11:07:31 INFO - trying https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:07:33 INFO - Downloaded 55756399 bytes. 11:07:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:33 INFO - mkdir: /builds/slave/test/properties 11:07:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:33 INFO - Contents: 11:07:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:07:34 INFO - Running post-action listener: _resource_record_post_action 11:07:34 INFO - Running post-action listener: set_extra_try_arguments 11:07:34 INFO - [mozharness: 2016-08-23 18:07:34.147492Z] Finished download-and-extract step (success) 11:07:34 INFO - [mozharness: 2016-08-23 18:07:34.147716Z] Running populate-webroot step. 11:07:34 INFO - Running pre-action listener: _resource_record_pre_action 11:07:34 INFO - Running main action method: populate_webroot 11:07:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:34 INFO - '--tppagecycles', 11:07:34 INFO - '7'], 11:07:34 INFO - 'tests': ['tsvgm']}}, 11:07:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['damp', 'tps']}, 11:07:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'tests': ['damp', 'tps']}, 11:07:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['dromaeo_dom']}, 11:07:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['basic_compositor_video']}, 11:07:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:07:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['a11yr', 11:07:34 INFO - 'ts_paint', 11:07:34 INFO - 'tpaint', 11:07:34 INFO - 'sessionrestore', 11:07:34 INFO - 'sessionrestore_no_auto_restore', 11:07:34 INFO - 'tabpaint']}, 11:07:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:34 INFO - 'ts_paint', 11:07:34 INFO - 'tpaint', 11:07:34 INFO - 'sessionrestore', 11:07:34 INFO - 'sessionrestore_no_auto_restore', 11:07:34 INFO - 'tabpaint']}, 11:07:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:34 INFO - 'ts_paint', 11:07:34 INFO - 'tpaint', 11:07:34 INFO - 'sessionrestore', 11:07:34 INFO - 'sessionrestore_no_auto_restore', 11:07:34 INFO - 'tabpaint']}, 11:07:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:34 INFO - 'ts_paint', 11:07:34 INFO - 'tpaint', 11:07:34 INFO - 'sessionrestore', 11:07:34 INFO - 'sessionrestore_no_auto_restore', 11:07:34 INFO - 'tabpaint']}, 11:07:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['a11yr', 11:07:34 INFO - 'ts_paint', 11:07:34 INFO - 'tpaint', 11:07:34 INFO - 'sessionrestore', 11:07:34 INFO - 'sessionrestore_no_auto_restore', 11:07:34 INFO - 'tabpaint']}, 11:07:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['a11yr', 11:07:34 INFO - 'ts_paint', 11:07:34 INFO - 'tpaint', 11:07:34 INFO - 'sessionrestore', 11:07:34 INFO - 'sessionrestore_no_auto_restore', 11:07:34 INFO - 'tabpaint']}, 11:07:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['tsvgx', 11:07:34 INFO - 'tsvgr_opacity', 11:07:34 INFO - 'tart', 11:07:34 INFO - 'tscrollx', 11:07:34 INFO - 'cart']}, 11:07:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:34 INFO - 'tsvgr_opacity', 11:07:34 INFO - 'tart', 11:07:34 INFO - 'tscrollx', 11:07:34 INFO - 'cart']}, 11:07:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'talos_options': ['--disable-e10s'], 11:07:34 INFO - 'tests': ['tp5o']}, 11:07:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'tests': ['tp5o']}, 11:07:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'talos_options': ['--disable-e10s', 11:07:34 INFO - '--xperf_path', 11:07:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:34 INFO - 'tests': ['tp5n']}, 11:07:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:34 INFO - 'talos_options': ['--xperf_path', 11:07:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:34 INFO - 'tests': ['tp5n']}}, 11:07:34 INFO - 'talos.zip': {'path': '', 11:07:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:34 INFO - Running post-action listener: _resource_record_post_action 11:07:34 INFO - [mozharness: 2016-08-23 18:07:34.167266Z] Finished populate-webroot step (success) 11:07:34 INFO - [mozharness: 2016-08-23 18:07:34.167353Z] Running create-virtualenv step. 11:07:34 INFO - Running pre-action listener: _resource_record_pre_action 11:07:34 INFO - Running main action method: create_virtualenv 11:07:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:07:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:34 INFO - Using real prefix '/usr' 11:07:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:34 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:36 INFO - Installing pip.................done. 11:07:36 INFO - Return code: 0 11:07:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:36 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:07:36 INFO - Using env: {'DISPLAY': ':0', 11:07:36 INFO - 'HOME': '/home/cltbld', 11:07:36 INFO - 'LANG': 'en_US.UTF-8', 11:07:36 INFO - 'LANGUAGE': 'en_US:en', 11:07:36 INFO - 'LOGNAME': 'cltbld', 11:07:36 INFO - 'MAIL': '/var/mail/cltbld', 11:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:36 INFO - 'MOZ_NO_REMOTE': '1', 11:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:36 INFO - 'NO_EM_RESTART': '1', 11:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:36 INFO - 'PWD': '/builds/slave/test', 11:07:36 INFO - 'SHELL': '/bin/bash', 11:07:36 INFO - 'SHLVL': '1', 11:07:36 INFO - 'TERM': 'linux', 11:07:36 INFO - 'TMOUT': '86400', 11:07:36 INFO - 'USER': 'cltbld', 11:07:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:36 INFO - '_': '/tools/buildbot/bin/python'} 11:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:07:36 INFO - Cleaning up... 11:07:36 INFO - Return code: 0 11:07:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:36 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:07:36 INFO - Using env: {'DISPLAY': ':0', 11:07:36 INFO - 'HOME': '/home/cltbld', 11:07:36 INFO - 'LANG': 'en_US.UTF-8', 11:07:36 INFO - 'LANGUAGE': 'en_US:en', 11:07:36 INFO - 'LOGNAME': 'cltbld', 11:07:36 INFO - 'MAIL': '/var/mail/cltbld', 11:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:36 INFO - 'MOZ_NO_REMOTE': '1', 11:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:36 INFO - 'NO_EM_RESTART': '1', 11:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:36 INFO - 'PWD': '/builds/slave/test', 11:07:36 INFO - 'SHELL': '/bin/bash', 11:07:36 INFO - 'SHLVL': '1', 11:07:36 INFO - 'TERM': 'linux', 11:07:36 INFO - 'TMOUT': '86400', 11:07:36 INFO - 'USER': 'cltbld', 11:07:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:36 INFO - '_': '/tools/buildbot/bin/python'} 11:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:37 INFO - Downloading/unpacking psutil>=3.1.1 11:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:39 INFO - Installing collected packages: psutil 11:07:39 INFO - Running setup.py install for psutil 11:07:39 INFO - building 'psutil._psutil_linux' extension 11:07:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:07:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:07:39 INFO - building 'psutil._psutil_posix' extension 11:07:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:07:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:07:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:39 INFO - Successfully installed psutil 11:07:39 INFO - Cleaning up... 11:07:39 INFO - Return code: 0 11:07:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:39 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:07:39 INFO - Using env: {'DISPLAY': ':0', 11:07:39 INFO - 'HOME': '/home/cltbld', 11:07:39 INFO - 'LANG': 'en_US.UTF-8', 11:07:39 INFO - 'LANGUAGE': 'en_US:en', 11:07:39 INFO - 'LOGNAME': 'cltbld', 11:07:39 INFO - 'MAIL': '/var/mail/cltbld', 11:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:39 INFO - 'MOZ_NO_REMOTE': '1', 11:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:39 INFO - 'NO_EM_RESTART': '1', 11:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:39 INFO - 'PWD': '/builds/slave/test', 11:07:39 INFO - 'SHELL': '/bin/bash', 11:07:39 INFO - 'SHLVL': '1', 11:07:39 INFO - 'TERM': 'linux', 11:07:39 INFO - 'TMOUT': '86400', 11:07:39 INFO - 'USER': 'cltbld', 11:07:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:39 INFO - '_': '/tools/buildbot/bin/python'} 11:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:07:41 INFO - Installing collected packages: mozsystemmonitor 11:07:41 INFO - Running setup.py install for mozsystemmonitor 11:07:41 INFO - Successfully installed mozsystemmonitor 11:07:41 INFO - Cleaning up... 11:07:42 INFO - Return code: 0 11:07:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:42 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:07:42 INFO - Using env: {'DISPLAY': ':0', 11:07:42 INFO - 'HOME': '/home/cltbld', 11:07:42 INFO - 'LANG': 'en_US.UTF-8', 11:07:42 INFO - 'LANGUAGE': 'en_US:en', 11:07:42 INFO - 'LOGNAME': 'cltbld', 11:07:42 INFO - 'MAIL': '/var/mail/cltbld', 11:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:42 INFO - 'MOZ_NO_REMOTE': '1', 11:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:42 INFO - 'NO_EM_RESTART': '1', 11:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:42 INFO - 'PWD': '/builds/slave/test', 11:07:42 INFO - 'SHELL': '/bin/bash', 11:07:42 INFO - 'SHLVL': '1', 11:07:42 INFO - 'TERM': 'linux', 11:07:42 INFO - 'TMOUT': '86400', 11:07:42 INFO - 'USER': 'cltbld', 11:07:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:42 INFO - '_': '/tools/buildbot/bin/python'} 11:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:42 INFO - Downloading/unpacking jsonschema==2.5.1 11:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:44 INFO - warning: no files found matching '*.txt' 11:07:44 INFO - no previously-included directories found matching 'build' 11:07:44 INFO - no previously-included directories found matching 'dist' 11:07:44 INFO - no previously-included directories found matching '.git*' 11:07:44 INFO - Installing collected packages: jsonschema, functools32 11:07:44 INFO - Running setup.py install for functools32 11:07:44 INFO - warning: no files found matching '*.txt' 11:07:44 INFO - no previously-included directories found matching 'build' 11:07:44 INFO - no previously-included directories found matching 'dist' 11:07:44 INFO - no previously-included directories found matching '.git*' 11:07:44 INFO - Successfully installed jsonschema functools32 11:07:44 INFO - Cleaning up... 11:07:44 INFO - Return code: 0 11:07:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:44 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:07:44 INFO - Using env: {'DISPLAY': ':0', 11:07:44 INFO - 'HOME': '/home/cltbld', 11:07:44 INFO - 'LANG': 'en_US.UTF-8', 11:07:44 INFO - 'LANGUAGE': 'en_US:en', 11:07:44 INFO - 'LOGNAME': 'cltbld', 11:07:44 INFO - 'MAIL': '/var/mail/cltbld', 11:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:44 INFO - 'MOZ_NO_REMOTE': '1', 11:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:44 INFO - 'NO_EM_RESTART': '1', 11:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:44 INFO - 'PWD': '/builds/slave/test', 11:07:44 INFO - 'SHELL': '/bin/bash', 11:07:44 INFO - 'SHLVL': '1', 11:07:44 INFO - 'TERM': 'linux', 11:07:44 INFO - 'TMOUT': '86400', 11:07:44 INFO - 'USER': 'cltbld', 11:07:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:44 INFO - '_': '/tools/buildbot/bin/python'} 11:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:07:44 INFO - Cleaning up... 11:07:44 INFO - Return code: 0 11:07:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:44 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:07:44 INFO - Using env: {'DISPLAY': ':0', 11:07:44 INFO - 'HOME': '/home/cltbld', 11:07:44 INFO - 'LANG': 'en_US.UTF-8', 11:07:44 INFO - 'LANGUAGE': 'en_US:en', 11:07:44 INFO - 'LOGNAME': 'cltbld', 11:07:44 INFO - 'MAIL': '/var/mail/cltbld', 11:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:44 INFO - 'MOZ_NO_REMOTE': '1', 11:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:44 INFO - 'NO_EM_RESTART': '1', 11:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:44 INFO - 'PWD': '/builds/slave/test', 11:07:44 INFO - 'SHELL': '/bin/bash', 11:07:44 INFO - 'SHLVL': '1', 11:07:44 INFO - 'TERM': 'linux', 11:07:44 INFO - 'TMOUT': '86400', 11:07:44 INFO - 'USER': 'cltbld', 11:07:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:44 INFO - '_': '/tools/buildbot/bin/python'} 11:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:47 INFO - Downloading docopt-0.6.1.tar.gz 11:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:47 INFO - Running setup.py install for blobuploader 11:07:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:47 INFO - Running setup.py install for requests 11:07:48 INFO - Running setup.py install for docopt 11:07:48 INFO - Successfully installed blobuploader requests docopt 11:07:48 INFO - Cleaning up... 11:07:48 INFO - Return code: 0 11:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:48 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:07:48 INFO - Using env: {'DISPLAY': ':0', 11:07:48 INFO - 'HOME': '/home/cltbld', 11:07:48 INFO - 'LANG': 'en_US.UTF-8', 11:07:48 INFO - 'LANGUAGE': 'en_US:en', 11:07:48 INFO - 'LOGNAME': 'cltbld', 11:07:48 INFO - 'MAIL': '/var/mail/cltbld', 11:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:48 INFO - 'MOZ_NO_REMOTE': '1', 11:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:48 INFO - 'NO_EM_RESTART': '1', 11:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:48 INFO - 'PWD': '/builds/slave/test', 11:07:48 INFO - 'SHELL': '/bin/bash', 11:07:48 INFO - 'SHLVL': '1', 11:07:48 INFO - 'TERM': 'linux', 11:07:48 INFO - 'TMOUT': '86400', 11:07:48 INFO - 'USER': 'cltbld', 11:07:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:48 INFO - '_': '/tools/buildbot/bin/python'} 11:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:48 INFO - Running setup.py (path:/tmp/pip-G6h2Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:48 INFO - Running setup.py (path:/tmp/pip-3MZift-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:48 INFO - Running setup.py (path:/tmp/pip-NYkSE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:48 INFO - Running setup.py (path:/tmp/pip-iFBvPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:48 INFO - Running setup.py (path:/tmp/pip-VVUHvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:48 INFO - Running setup.py (path:/tmp/pip-RYvKIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:48 INFO - Running setup.py (path:/tmp/pip-f1edqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:48 INFO - Running setup.py (path:/tmp/pip-Us90R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:49 INFO - Running setup.py (path:/tmp/pip-1m0s4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:49 INFO - Running setup.py (path:/tmp/pip-UYNj2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:49 INFO - Running setup.py (path:/tmp/pip-I3xiqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:49 INFO - Running setup.py (path:/tmp/pip-bj7h5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:49 INFO - Running setup.py (path:/tmp/pip-O2ADOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:49 INFO - Running setup.py (path:/tmp/pip-oKY6dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:49 INFO - Running setup.py (path:/tmp/pip-Dzn_tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:49 INFO - Running setup.py (path:/tmp/pip-cY0hSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:49 INFO - Running setup.py (path:/tmp/pip-nfn2Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:49 INFO - Running setup.py install for manifestparser 11:07:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:49 INFO - Running setup.py install for mozcrash 11:07:49 INFO - Running setup.py install for mozdebug 11:07:49 INFO - Running setup.py install for mozdevice 11:07:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Running setup.py install for mozfile 11:07:50 INFO - Running setup.py install for mozhttpd 11:07:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Running setup.py install for mozinfo 11:07:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Running setup.py install for mozInstall 11:07:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Running setup.py install for mozleak 11:07:50 INFO - Running setup.py install for mozlog 11:07:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Running setup.py install for moznetwork 11:07:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:50 INFO - Running setup.py install for mozprocess 11:07:50 INFO - Running setup.py install for mozprofile 11:07:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:51 INFO - Running setup.py install for mozrunner 11:07:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:51 INFO - Running setup.py install for mozscreenshot 11:07:51 INFO - Running setup.py install for moztest 11:07:51 INFO - Running setup.py install for mozversion 11:07:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:51 INFO - Cleaning up... 11:07:51 INFO - Return code: 0 11:07:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:51 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:07:51 INFO - Using env: {'DISPLAY': ':0', 11:07:51 INFO - 'HOME': '/home/cltbld', 11:07:51 INFO - 'LANG': 'en_US.UTF-8', 11:07:51 INFO - 'LANGUAGE': 'en_US:en', 11:07:51 INFO - 'LOGNAME': 'cltbld', 11:07:51 INFO - 'MAIL': '/var/mail/cltbld', 11:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:51 INFO - 'MOZ_NO_REMOTE': '1', 11:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:51 INFO - 'NO_EM_RESTART': '1', 11:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:51 INFO - 'PWD': '/builds/slave/test', 11:07:51 INFO - 'SHELL': '/bin/bash', 11:07:51 INFO - 'SHLVL': '1', 11:07:51 INFO - 'TERM': 'linux', 11:07:51 INFO - 'TMOUT': '86400', 11:07:51 INFO - 'USER': 'cltbld', 11:07:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:51 INFO - '_': '/tools/buildbot/bin/python'} 11:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:51 INFO - Running setup.py (path:/tmp/pip-f7bYwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:51 INFO - Running setup.py (path:/tmp/pip-lxXqs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:51 INFO - Running setup.py (path:/tmp/pip-9v05IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:51 INFO - Running setup.py (path:/tmp/pip-XaS5MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:51 INFO - Running setup.py (path:/tmp/pip-_H2W8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:52 INFO - Running setup.py (path:/tmp/pip-LmJkPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:52 INFO - Running setup.py (path:/tmp/pip-oeV0ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:52 INFO - Running setup.py (path:/tmp/pip-RuMCLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:52 INFO - Running setup.py (path:/tmp/pip-WKyxcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:52 INFO - Running setup.py (path:/tmp/pip-Xc6yJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:52 INFO - Running setup.py (path:/tmp/pip-AaKo1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:52 INFO - Running setup.py (path:/tmp/pip-9qGU3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:52 INFO - Running setup.py (path:/tmp/pip-4wInw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:52 INFO - Running setup.py (path:/tmp/pip-nsSN5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:52 INFO - Running setup.py (path:/tmp/pip-Qa_NSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:52 INFO - Running setup.py (path:/tmp/pip-hqrF6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:52 INFO - Running setup.py (path:/tmp/pip-oNCdhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:07:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:54 INFO - Downloading blessings-1.6.tar.gz 11:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:54 INFO - Installing collected packages: blessings 11:07:54 INFO - Running setup.py install for blessings 11:07:54 INFO - Successfully installed blessings 11:07:54 INFO - Cleaning up... 11:07:55 INFO - Return code: 0 11:07:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:55 INFO - Reading from file tmpfile_stdout 11:07:55 INFO - Current package versions: 11:07:55 INFO - argparse == 1.2.1 11:07:55 INFO - blessings == 1.6 11:07:55 INFO - blobuploader == 1.2.4 11:07:55 INFO - docopt == 0.6.1 11:07:55 INFO - functools32 == 3.2.3-2 11:07:55 INFO - jsonschema == 2.5.1 11:07:55 INFO - manifestparser == 1.1 11:07:55 INFO - mozInstall == 1.12 11:07:55 INFO - mozcrash == 0.17 11:07:55 INFO - mozdebug == 0.1 11:07:55 INFO - mozdevice == 0.48 11:07:55 INFO - mozfile == 1.2 11:07:55 INFO - mozhttpd == 0.7 11:07:55 INFO - mozinfo == 0.9 11:07:55 INFO - mozleak == 0.1 11:07:55 INFO - mozlog == 3.3 11:07:55 INFO - moznetwork == 0.27 11:07:55 INFO - mozprocess == 0.23 11:07:55 INFO - mozprofile == 0.28 11:07:55 INFO - mozrunner == 6.12 11:07:55 INFO - mozscreenshot == 0.1 11:07:55 INFO - mozsystemmonitor == 0.3 11:07:55 INFO - moztest == 0.7 11:07:55 INFO - mozversion == 1.4 11:07:55 INFO - psutil == 3.1.1 11:07:55 INFO - requests == 1.2.3 11:07:55 INFO - wsgiref == 0.1.2 11:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:55 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:07:55 INFO - Using env: {'DISPLAY': ':0', 11:07:55 INFO - 'HOME': '/home/cltbld', 11:07:55 INFO - 'LANG': 'en_US.UTF-8', 11:07:55 INFO - 'LANGUAGE': 'en_US:en', 11:07:55 INFO - 'LOGNAME': 'cltbld', 11:07:55 INFO - 'MAIL': '/var/mail/cltbld', 11:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:55 INFO - 'MOZ_NO_REMOTE': '1', 11:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:55 INFO - 'NO_EM_RESTART': '1', 11:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:55 INFO - 'PWD': '/builds/slave/test', 11:07:55 INFO - 'SHELL': '/bin/bash', 11:07:55 INFO - 'SHLVL': '1', 11:07:55 INFO - 'TERM': 'linux', 11:07:55 INFO - 'TMOUT': '86400', 11:07:55 INFO - 'USER': 'cltbld', 11:07:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:55 INFO - '_': '/tools/buildbot/bin/python'} 11:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:07:55 INFO - Cleaning up... 11:07:55 INFO - Return code: 0 11:07:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:55 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 0x7ff5600ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, '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': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:07:55 INFO - Using env: {'DISPLAY': ':0', 11:07:55 INFO - 'HOME': '/home/cltbld', 11:07:55 INFO - 'LANG': 'en_US.UTF-8', 11:07:55 INFO - 'LANGUAGE': 'en_US:en', 11:07:55 INFO - 'LOGNAME': 'cltbld', 11:07:55 INFO - 'MAIL': '/var/mail/cltbld', 11:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:55 INFO - 'MOZ_NO_REMOTE': '1', 11:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:55 INFO - 'NO_EM_RESTART': '1', 11:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:55 INFO - 'PWD': '/builds/slave/test', 11:07:55 INFO - 'SHELL': '/bin/bash', 11:07:55 INFO - 'SHLVL': '1', 11:07:55 INFO - 'TERM': 'linux', 11:07:55 INFO - 'TMOUT': '86400', 11:07:55 INFO - 'USER': 'cltbld', 11:07:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:55 INFO - '_': '/tools/buildbot/bin/python'} 11:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:07:55 INFO - Cleaning up... 11:07:55 INFO - Return code: 0 11:07:55 INFO - Running post-action listener: _resource_record_post_action 11:07:55 INFO - Running post-action listener: _start_resource_monitoring 11:07:55 INFO - Starting resource monitoring. 11:07:55 INFO - [mozharness: 2016-08-23 18:07:55.715790Z] Finished create-virtualenv step (success) 11:07:55 INFO - [mozharness: 2016-08-23 18:07:55.716243Z] Running install step. 11:07:55 INFO - Running pre-action listener: _resource_record_pre_action 11:07:55 INFO - Running main action method: install 11:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:55 INFO - Reading from file tmpfile_stdout 11:07:55 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:56 INFO - Reading from file tmpfile_stdout 11:07:56 INFO - Output received: 11:07:56 INFO - Usage: mozinstall [options] installer 11:07:56 INFO - Options: 11:07:56 INFO - -h, --help show this help message and exit 11:07:56 INFO - -d DEST, --destination=DEST 11:07:56 INFO - Directory to install application into. [default: 11:07:56 INFO - "/builds/slave/test"] 11:07:56 INFO - --app=APP Application being installed. [default: firefox] 11:07:56 INFO - mkdir: /builds/slave/test/build/application 11:07:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:08:12 INFO - Reading from file tmpfile_stdout 11:08:12 INFO - Output received: 11:08:12 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:12 INFO - Running post-action listener: _resource_record_post_action 11:08:12 INFO - [mozharness: 2016-08-23 18:08:12.543244Z] Finished install step (success) 11:08:12 INFO - [mozharness: 2016-08-23 18:08:12.543492Z] Running run-tests step. 11:08:12 INFO - Running pre-action listener: _resource_record_pre_action 11:08:12 INFO - Running main action method: run_tests 11:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:12 INFO - Python 2.7.3 11:08:12 INFO - Return code: 0 11:08:12 INFO - grabbing minidump binary from tooltool 11:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:12 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 0x1d35090>, '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 0x1d389b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d38e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:08:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:08:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:08:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:12 INFO - Return code: 0 11:08:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:12 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:08:12 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:08:12 INFO - Using env: {'DISPLAY': ':0', 11:08:12 INFO - 'HOME': '/home/cltbld', 11:08:12 INFO - 'LANG': 'en_US.UTF-8', 11:08:12 INFO - 'LANGUAGE': 'en_US:en', 11:08:12 INFO - 'LOGNAME': 'cltbld', 11:08:12 INFO - 'MAIL': '/var/mail/cltbld', 11:08:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:12 INFO - 'MOZ_NO_REMOTE': '1', 11:08:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:12 INFO - 'NO_EM_RESTART': '1', 11:08:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:12 INFO - 'PWD': '/builds/slave/test', 11:08:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:12 INFO - 'SHELL': '/bin/bash', 11:08:12 INFO - 'SHLVL': '1', 11:08:12 INFO - 'TERM': 'linux', 11:08:12 INFO - 'TMOUT': '86400', 11:08:12 INFO - 'USER': 'cltbld', 11:08:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814', 11:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:12 INFO - '_': '/tools/buildbot/bin/python'} 11:08:12 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:08:12 INFO - mozversion application_buildid: 20160823020448 11:08:12 INFO - mozversion application_changeset: a759a1704791bd3de6462d4153f02c7844e786b6 11:08:12 INFO - mozversion application_display_name: Nightly 11:08:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:12 INFO - mozversion application_name: Firefox 11:08:12 INFO - mozversion application_remotingname: firefox 11:08:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:08:12 INFO - mozversion application_vendor: Mozilla 11:08:12 INFO - mozversion application_version: 51.0a1 11:08:12 INFO - mozversion platform_buildid: 20160823020448 11:08:12 INFO - mozversion platform_changeset: a759a1704791bd3de6462d4153f02c7844e786b6 11:08:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:08:12 INFO - mozversion platform_version: 51.0a1 11:08:12 INFO - using testdate: 1471975692 11:08:12 INFO - actual date: 1471975692 11:08:12 INFO - starting webserver on 'localhost:42812' 11:08:12 INFO - SUITE-START | Running 2 tests 11:08:12 INFO - TEST-START | dromaeo_css 11:08:12 INFO - operating with platform_type : linux_ 11:08:12 INFO - Initialising browser for dromaeo_css test... 11:08:12 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpli_bQ5/profile http://localhost:42812/getInfo.html) 11:08:17 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 11:08:17 INFO - PROCESS | 1958 | colorDepth:24 11:08:17 INFO - PROCESS | 1958 | Browser inner width/height: 1024/697 11:08:17 INFO - PROCESS | 1958 | __metrics 11:08:18 INFO - PROCESS | 1958 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:08:18 INFO - PROCESS | 1958 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:08:19 INFO - PROCESS | 1958 | console.error: PushService: 11:08:19 INFO - PROCESS | 1958 | stateChangeProcessEnqueue: Error transitioning state 11:08:19 INFO - PROCESS | 1958 | UnknownError 11:08:19 INFO - TEST-INFO | 1958: exit 0 11:08:19 INFO - Browser initialized. 11:08:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:19 INFO - TEST-INFO | started process 2035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpli_bQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:31 INFO - PROCESS | 2035 | RSS: Main: 175992832 11:08:31 INFO - PROCESS | 2035 | 11:09:23 INFO - PROCESS | 2035 | 1471975763950 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:11:36 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:42812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42812/tests/dromaeo/cssquery-ext.html) 11:11:37 INFO - PROCESS | 2035 | RSS: Main: 271069184 11:11:37 INFO - PROCESS | 2035 | 11:14:40 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:42812/tests/dromaeo/cssquery-ext.html (next: http://localhost:42812/tests/dromaeo/cssquery-jquery.html) 11:14:40 INFO - PROCESS | 2035 | RSS: Main: 277835776 11:14:40 INFO - PROCESS | 2035 | 11:17:42 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:42812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42812/tests/dromaeo/cssquery-mootools.html) 11:17:43 INFO - PROCESS | 2035 | RSS: Main: 217391104 11:17:43 INFO - PROCESS | 2035 | 11:20:45 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:42812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42812/tests/dromaeo/cssquery-prototype.html) 11:20:46 INFO - PROCESS | 2035 | RSS: Main: 219279360 11:20:46 INFO - PROCESS | 2035 | 11:23:49 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:42812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42812/tests/dromaeo/cssquery-yui.html) 11:23:50 INFO - PROCESS | 2035 | RSS: Main: 218939392 11:23:50 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | Cycle 1(1): loaded http://localhost:42812/tests/dromaeo/cssquery-yui.html (next: http://localhost:42812/tests/dromaeo/cssquery-dojo.html) 11:26:53 INFO - PROCESS | 2035 | RSS: Main: 285798400 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | __start_tp_report 11:26:53 INFO - PROCESS | 2035 | _x_x_mozilla_page_load 11:26:53 INFO - PROCESS | 2035 | _x_x_mozilla_page_load_details 11:26:53 INFO - PROCESS | 2035 | |i|pagename|runs| 11:26:53 INFO - PROCESS | 2035 | |0;dojo.html;2596;2664.9733502664967;2669.4794515069557;2673.705892351841;2688.2741659751855;4665.4168228971375;4762.8094876205;4808.855734327972;4909.116359055373;4910.6071514278865;4728.550787675165;4760.500147484516;4776.235802271637;4800.087983283173;4898.583620392271;4368.213721530124;4394.736315821045;4447.888802779924;4489.25927222008;4533.569310915458;4491.056878055612;4509.210888094587;4524.366588677588;4524.389207457;4525.027119169378;4303.74177549348;4333.090051089275;4348.760818155;4439.977800111011;4462.776861156929;4343.2399330117105;4389.758563279019;4395.494518130424;4415.8233670653135;4519.41247637805;4358.259095953696;4403.867883963486;4417.359482874966;4417.933730994037;4422.513523512411;4792.353032340624;4824.879378015543;4825.686330388514;4834.178189707758;4835;4959.330490383788;5084.898302033976;5132.230165475208;5163.63854530183;5232.189010703347;5227.634065615409;5235.816746413895;5237.9476205238225;5238.554722848562;5246.186841039645;4713.34013238147;4878.463369029404;4880.536349046835;4887.633427492952;4888.437829649564;5067.822626208065;5084.669496482791;5113.821016264487;5184.818531351385;5205.167173252262;4993.1262029144755;5003.449620541737;5005.174146265898;5005.399352077774;5007.524285192901;4985.376827896513;5083.059633967654;5091.210862316347;5091.694498330112;5094.5669618082875;4901.142300097468;4961.528654777862;4966.03162383339;5029.949700502948;5039.44566097729;5005.524475174852;5009.599232061426;5014.52362025607;5016.147254966664;5025.4974502550185;4276.337167738943;4308.3968244445805;4325.15659446405;4326.149726743201;4326.394304797331;3779.962200377961;3814.446905198786;3846.615338466131;3847.2305538892333;3907.882763517099;4454.354118652777;4475.955240447619;4480.484744254452;4485.1702435048965;4486.416765820422;4995.975020124876;5249.081410753103;5252.868678283074;5257.5005374489365;5265.368155821326;4368.825246990148;4376.737395756265;4394.428724265889;4456.019675671347;4464.419625448671;4644.535546445396;4682.2508398656055;4684.063187362541;4691.038337140878;4691.390119284471;4659.44086709597;4893.388326459192;4896.4124305083615;4905.018996200845;4908.312836203006;5047.4700156484505;5153.845384638467;5158.148905430562;5192.506711862367;5232;4859.392575928009;4880.097182021337;4883.145449546386;4885.560299573055;4887.144749668865;5009.123403404463;5096.413912399973;5111.642185047011;5124.30821839047;5127.512886275797;4995.300657907823;5062.696238225718;5068;5126.846194614168;5152.613553983391;4990.051890140861;4992.80028798844;4995.050940321327;5001.749912504433;5004.324416203766;4813.374261346003;4987.476314986874;4998.775055122455;4999.975005123868;5002.2496625506465;4837.7097374157665;4891.682040667345;4898.608111351155;4964.4539100698175;4980.377452818398;5088.0587091388215;5093.083245015784;5093.439721630692;5093.745312734274;5094.745262736922;4805.567498925114;4977;4988.027334669705;4990.201567749143;4996.175631020987 11:26:53 INFO - PROCESS | 2035 | |1;ext.html;550.1994597860114;565.2510423688614;566.6062086849641;573.6328749600257;579.8869220502004;40127.19745605086;41725;41740.37389439157;44393.55606443935;44840.10319793611;40757.38863917044;41169.17661646765;41189.38215926763;41587.79206103973;41723.37414938771;7355.77932662021;7371.557706537598;7495.2879476449925;7499.062617172854;9923.553440095213;9545.377285861421;9868.358556693793;9882.604695812159;9958.253131015166;9980.50097495126;9928.10647041766;9970.401775893433;9974.401535907833;9977.600895964153;9981.75045623858;9960.103590676837;10006.79986400268;10009.449480278581;10010.349327293703;10017.799644007078;9934.45360505172;10010.799784004279;10011;10014.799704005953;10015.549300281506;38921.22157556861;38991.41512877309;39070.21859562821;39135.41296880549;39281.41077883834;2698.649175607178;3034;3386.1196089016785;3414.6926776589976;3416.4875268709643;28811.423771524453;29052;29058.564121538195;29279;29529.114126576238;3007.5187969924928;3062.5865508156335;3064.249258931554;3144.339688665383;3192.201949512622;245223;246915;246978;247509;247784.9999999982;53453.73273133687;53880.995470588576;53885.34203908533;53900.46099538954;53949;33003.66996330006;33767.662323376455;33798.324033519195;35866.64133358685;35887.82056089703;13006.349682515836;13226.470941162246;13234.470621175045;13241.271730054747;13245.139065960682;9076.455412675261;9602.135807777333;9745.31782775199;9803.313768036312;9829.852552211723;18105.275788968556;18137.546561335806;18161.545961351072;18164.63670726578;18266.711991841596;6728.461723062143;6939.375456208965;6958.373746362851;6971.895421568681;7073.575585464889;767.8157242261817;933.6265493802533;980.2745967983641;1002.1031177096457;1029.3720830293514;27715.584266236023;28262.43475130527;29065.564016539767;29250.268743281587;29307.41385172327;934.9252059835197;1000.8440251509518;1004.4927311707687;1038.6832016234969;1038.9116925061455;14204.360803763855;15021.399144034334;15200.543983680507;15219.162946038074;15352.769708454382;382893;383098.94362148154;385026;385140;386526;33269.83365083207;33464.49409776566;33566;33589;33608.49587256193;1023.6007956896816;1111.522045520434;1161.91285653578;1162.442027826648;1170.0639488409238;27013.59479607847;28564.714352856205;29209;29554.408911821214;29742.405151896408;47537.28694069522;49041.509584903695;49208.507914920396;52810;52876.735616321675;364634;367213;367618;368204.58977050503;368427;24463;25459.32677068881;25499.362515936507;26408.20775376742;26651.33371665724;38666.226675466896;42252.78873605735;43027;43718.344224836015;46957.765211175094;36658.26683466262;36731;37069.25861482701;37402.8129859349;38138.618613814615;36752;37411.43882841705;37482.250354993295;37774;38492.80753596214;35547.28905421929;35657.46513802243;35771.82114089413;35781.28437431289;35834.64165358313;32447.188820279684;33603.66396336005;33812;34155.82922085473;34326.48510272298;25805.225843224733;25859.612105818804;26101.608475872497;26135.477290454466;26389 11:26:53 INFO - PROCESS | 2035 | |2;jquery.html;338.533781402483;361.67087949965537;362.32607350328385;365.5868868178958;377.19555107773704;12728.236305821645;16060.839391606096;16094.195290235486;16469.83530164698;17481.300747970065;14435.63910902228;15185.316660750264;15292.388304467808;15774.684506309866;15912.443064492745;4688;4904.681195722284;5121.769520371574;5185.740712964355;5193.558547523465;5020.824271150511;5110.207917772751;5115.386153661566;5116.232565115225;5116.462771409004;4885.413750349963;5031.27046578246;5074.670146440488;5082.313887625179;5085.66943148696;5101.311322971388;5155;5157.767900444489;5162.5095615916425;5165.457626949173;4370.409994650713;4544.272916333371;4588.151192029485;4616.330632058366;4633.536646335373;21183.576328473497;21214.469638259012;21290.25484108049;21453.46366340854;21471.463213419633;1898.3166060218311;1988.2643421933833;2125.7130287411155;2141.7001619773246;2281.5094754627835;12851.485940562367;13392.86607133926;13631.710106422828;13680.726385472335;13968.93015534926;1646.8517833394933;1710.8887922285012;1711.1786342555642;1712.5119340987883;1712.691715491211;69436.30563694349;69549;70421.29578704199;70768.2923170772;71128.28871711268;9269.44383337002;9325.393849399767;9468.479233642216;9646.276529260334;9883.555240014217;13148.802767958488;13149.21104733719;13179.538716144889;13192;13200.603981880367;6492.935070649328;6936.549124306904;7108.751193708299;7151.60666163366;7157;6518.804435866931;6619.2056953164965;6639.982810399735;6746.291639377893;6786.355296246848;5861.3552509223955;6028.969855150784;6075.726592303357;6098.146259523582;6173;1686.0778712268025;1690.6280618263963;1703.7359209322574;1740.3299729604194;1779.4839496545856;826.5949684654476;892.9285657147412;964.7925695975258;967.8548217767391;977.4770497783652;17053.31786728542;17194.1402929853;17831.197596108206;17850.732239016426;18118.45644630663;850.7192626433385;855.8373908957278;877.3025444771422;887.3034667785757;904.8326059678981;9336.673216437392;10136.341137826017;10283.9485802572;10319.638812641522;10327.173826093895;305039;308083;308196;383328;422891;56957.715211424504;57916;73670.63164684143;81126.18873811305;84861.15138848656;404.4782230922136;422.5359130612443;425.14333617760235;425.41293015638223;427.5468003915859;9628.75928101803;9727.367721098106;9924.75188120274;10091.344062635904;10603.840942386025;36288;37815;37952.810235948644;38207.617923820406;42672.359914601926;33477.66522334745;33906.83046584751;34735.652643473244;39936;42159;7557.773266802004;7604.80987975305;7645.273698998586;7683.961580192064;8141.8778718320455;8510.872336915076;11705.122115841516;12095.092868034757;12417.565385211474;12444.75110497767;9905.018996200644;10043.648472303434;10381.9480902595;10555.63055293061;10909.345439273351;10458.63394781179;10689.358638481715;10719.892801072201;10841.07850832688;10967.232293739362;10472.266941314036;10830.51262693165;10889.346639201673;11200.271982321123;11214.102871770401;7420.703171873281;7446.329830315298;7553.848923021399;7620.466567340233;7935.365170786438;9542;9985.251106166921;10044;10345;11065.446727663746 11:26:53 INFO - PROCESS | 2035 | |3;mootools.html;1347.2118810495856;1388.944442222311;1427.8786303164231;1631.9510414687563;1641.4008886756337;6747.966260168704;7005.719771209158;7414.480986330959;7968.760937171887;7983.441159118856;7397.741079062234;7609.961950190255;7679;7813.6874525019075;7860.135385107634;2101.9264325748563;2115.9471013224716;2120.628889944261;2124.4370241885913;2136.444524423653;1827.0499340343013;2072.057213967641;2086.9582608347823;2131.3712454825863;2140.069069954567;2118.0998075817793;2129.1483406637312;2136.3377353020537;2138.957220855582;2143.7534683511362;2059.938201853939;2076.8546201765885;2128.755193152792;2130.243763463979;2130.6164890319737;2089.3209706845337;2095.1514636572215;2103.0115845552564;2105.620988222119;2135.7330333708287;7883.172266912006;7889.2110788920645;7891.6054197289905;7894.526328420256;7898.091719452222;4261.74429534229;4294.527601963781;4392.407025051641;4394.78026098697;4396.406485124499;2773.88904443822;2901.1151598762367;2928.0191135969476;2943.484890144216;2945.5434407666844;890.3767362845969;929.9674511392136;941.0260380506144;948.3835506920487;949.6059135458777;10650.25448218625;10650.307729997525;10655.84016239757;10662;10668.093212076983;3713.3687273163628;3989.940150897739;4091.8158682859344;4139.110091330378;4165.333546632585;9046.231070358961;9154.89437429395;9192.448453092837;9198.264138868875;9199.402038867453;4343.3484977253665;4362.847300344472;4363.781810909441;4365.4761428628135;4382.342648602671;4023.471080989264;4038.656714179269;4043.9191216175514;4044.6359827615065;4052.1490486997473;3313.403587354251;3432.1419645088727;3457.3085382923514;3501.457274122515;3526.2771131917893;953.2516974175239;1005.0552480668149;1017.7964407118606;1022.3865680591734;1032.390889375257;670.3999920071509;708.9361957423856;717.6340066566089;785.8939043229091;792.5442870349572;4821.7589120543835;5063;5101.770420331094;5280.392754833243;5393.352797664305;816.9673213071411;835.3327131175564;864.2351518905688;878.0604752914448;907.7186072317603;3559.341521818472;3612.8735494257576;3709.8330575124182;3753.5683396409217;3776.3202623528027;9429.198518125899;9632.75918102053;9740.123388894892;9741.12329890299;9772.609095636237;9371.344005919656;9583.856242156373;9658.130768230892;9658.227341812639;9660.661876834278;7103.183133939663;7106.964465177744;7308.6345682715655;7310.561366317932;7312.464382479632;5239.161734122522;5291.682499050069;5302.469753024667;5419.3225846769155;5439.238506609157;8493.830123397374;8612.913870861212;8710.12898710124;8843.734687959372;8920.55397230123;8780.648774048967;9064.728058158265;9122.042185570419;9142.771430714285;9166.954165229132;6463.353664633499;6597.307282735435;6601.174853143357;6604.471642268703;6613.636250006296;7319.63401829917;7368.631568421664;7376.926230737624;7454;7462.179160292472;4849.515048495122;6444.613323200623;6489;6685.565438246498;6773.966130169318;6584.9230233540275;6588.209414870054;6741.022551729873;6752.122224110834;6787.4230690389895;5980.5215582754145;6015.39846015395;6058.182145410313;6060.060690592789;6066.332703402711;4289.742615443083;4351.543087975717;4430.512643609136;4484.05834774701;4511.729296242236;4401.779911004501;4448.1770872388715;4462.085272519191;4475.9552404475535;4564.050370193011 11:26:53 INFO - PROCESS | 2035 | |4;prototype.html;295.5596161719039;298.28263027419064;301.88981021926975;306.70556265984646;306.8941215280729;4886.169351210294;4891.461939186691;4911.165101932671;4916.95083049169;4927.088488629606;4785.5214478552125;4795.976020119894;4836.951630483694;4848.878778030542;4849.612031037517;3582.26563554472;3691.53855768029;3700.2987818892225;3746.868859589915;3818.0073180972868;3756.3614185588517;3766.4538641896906;3766.5480142382953;3793.4499497572833;3798.3922572388424;3727.9627203728023;3734.9457798210874;3753.686209826566;3763.284975854579;3779.9433008504893;3618.860059081394;3710.2023065041144;3772;3787.5644300905474;3789.3747531657245;3341.8830340937952;3357.244619960489;3362.0586235854;3362.663733626642;3376.3584918865336;4710.552497512731;4714.693544919569;4728.810847566093;4749.430068391781;4760.666753327268;4162.793719328761;4330.242207613655;4379.4525684289465;4381.605655491021;4386.6929314947965;5027.748612569393;5030.496950304977;5037.722925239111;5043.218301163325;5056.84829455117;3662.3957047087197;3662.468942003421;3669.6146904574903;3670.46778217157;3673.761205521659;5110.207917772751;5261.710605916673;5318.867028324285;5325.520703136736;5340.332458442695;3728.7949162795762;3728.925421491609;3745.419459983707;3747.2505498900327;3761.1349389640536;3815.618438156162;3827.2919509890758;3827.5789663137034;3834.4631751554803;3837.501124853751;4331.263685173528;4344.761038142932;4352.630026447724;4353.7591786340745;4357.673174511924;4843.830465933675;5071.721055341918;5089.6691715038405;5097.745112744422;5130.615203859726;1317.5059352742721;1333.2067419885152;1333.4399552188104;1339.8459177194552;1346.158650843223;825.6738588257605;853.2917678326974;854.6068808348106;865.8181582140334;869.8564736818481;4330.39374487572;4459.4169069980335;4475.440569928759;4477.619402350771;4478.731276123443;5196.246544251138;5225.033368826703;5226.686398816008;5234.18870075139;5234.633575649668;4470.150671372428;4472.597466228055;4474.32885067236;4480.775961201927;4488.640908727294;2628.8422694638384;2756.5589505678995;2792.4694308081807;2795.720427957229;2800.523910935146;4928.162212423825;4938.234573641092;4939.90120197594;4941.703497790144;4944.1100601891285;5218.243354713545;5293.3647962244;5352.598555108382;5367.865803354869;5371.884307101872;4892.902141957141;4900.656954013256;4909.5090490950615;4909.680870743319;4922.803087876445;5220.843374698765;5236.502532259429;5241.292425522505;5259.316288882574;5277.920831187458;4840.370751802243;5070.340855688737;5119.334486516729;5130.48695130484;5141.794328226829;4895.4859739728245;4899.142650036159;4914.729689867092;4920.483349248278;4940.752962351796;3636.454531820142;3643.9635603643624;3685.5577330720484;3707.2029513654693;3716.442533619979;5139.794408223779;5343.9198412024625;5344.931013797178;5351.03681337363;5358.892822143457;5013.949860501494;5039.53853382515;5105.821296254613;5154.458781827854;5175.249588809676;5010.920468005736;5084.7966081356335;5108.9782043590685;5161.922571161361;5195.272661827423;4784.588546378896;5025.924611130909;5029;5036.773345199402;5044.167712327425;4920.327088789829;4929.1866841972105;5097.16502059251;5162.122439185272;5172.663776854492;4973.910957397974;4976.5521103099445;4980.153373926369;4982.352294201875;5001.42483614389 11:26:53 INFO - PROCESS | 2035 | |5;yui.html;582.9096490044042;589.6956872928013;607.1136141233799;648.186525909983;684.2712511175598;11846.881531184696;12094.455749491271;12299.446524906378;12305.876941230585;12955.611331660066;12696.936515317433;12893.161944473602;12903.225806451595;12918.612441626743;12925.612231633042;622.6046460497594;751.3763576231714;761.1665226576889;763.0118995900294;763.3397111498541;759.3014426727397;778.1168373895613;787.3976408047848;788.9526628402285;790.1584812175043;825.8926339575846;828.2380210206625;828.2752591482453;828.3000864269712;828.6064119543229;648.0667838312814;813.5606772342928;818.6193420059672;818.6520728690313;818.8034871630825;571.7484306904948;587.6297932302622;587.7854583077188;590.9556783241231;591.4794980417205;12711.110222284444;12744.553940612126;12761.489540418372;12766.234025958473;12776.680582985407;12497;12740;12891.484340626457;13100.47598096075;13150.389347025783;11777.882221177764;12005.339706316148;12027.27836329823;12081.033517318594;12688.175268607603;4052.250333688277;4095.5290141633795;4198.664106871473;4329.7618630975285;4330.047389574289;52158.739206304104;54505.727471362785;54927.450725492636;60934.695326523084;61797;9068.274538036942;9268.536573171314;9505.144536991565;9522.90477095234;9813.607455701693;18293.451196464128;18337.633247335245;18352.082395880152;18358.357457488924;18365.90817045906;6902.758403455855;7018.75434359795;7024.789256322319;7047.612381319077;7176.96411517939;3752.5309336332957;3770.5286839145106;3811.676007539335;3861.710371722132;3944.3886197639413;2810.409813939096;2969.213158512996;2977.7320041195962;2981.0609657957675;2981.3739114785703;511.86947328431756;537.6102325813832;557.2310211907622;561.6040691312614;571.8341680912572;522.7647558598646;553.532265235875;561.4862400903128;562.2381672833252;563.9605227634108;7649.196834332426;7779.572123533147;7841.333486653584;7904.604769761604;8089.150639182919;478.0009779560735;479.2595440045139;532.4063669009028;536.3295880149813;572.3160822816777;3567.1438854674693;3697.2975134724315;3714.795686237283;3742.143545351516;3829.942550861739;98161.50919245358;100503.42700308414;101161.49419253004;104373.75547590661;105933;84001;87979;90803;90833;92171.07828921625;75037;75044;75680.62159689056;75880.62059689667;76019.23980760122;6970.825729356807;6981.5543875776975;7069.752558660422;7167.749128780468;7242.420606351374;44920.55079449164;45603.54396455993;46740.53259467498;47703;48016;63304.68347658416;67915.3208467909;68639.65680171567;69524;70022;8288.419810613199;8383.413161078666;8600.13998600135;9657.22742180638;9930.404175749478;10625.9468702656;10639.14886809069;10786.838197427202;11233.101351891992;11236.775264494829;8882.644694212158;9135.543222838698;9154.862677059717;9533.809323813624;9548.856767148638;9431.386959847589;9432.19826314771;9672.274579406432;9723.85414218773;9978.052085051908;9380.530973451163;9440.575174117044;9867.06262905023;9870.851937220803;9902.950485247527;7528.774136775905;7931.405144614292;7944.205579442009;8614.526201059001;8625.39622226438;7587.810304742205;7651.311381975426;7799.337056350047;7832.921670783219;7900.446968712365 11:26:53 INFO - PROCESS | 2035 | __end_tp_report 11:26:53 INFO - PROCESS | 2035 | __start_cc_report 11:26:53 INFO - PROCESS | 2035 | _x_x_mozilla_cycle_collect,988 11:26:53 INFO - PROCESS | 2035 | __end_cc_report 11:26:53 INFO - PROCESS | 2035 | __startTimestamp1471976813957__endTimestamp 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | ------- Summary: start ------- 11:26:53 INFO - PROCESS | 2035 | Number of tests: 6 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | [#0] dojo.html Cycles:165 Average:4743.69 Median:4893.39 stddev:492.05 (10.1%) stddev-sans-first:463.82 11:26:53 INFO - PROCESS | 2035 | Values: 2596.0 2665.0 2669.5 2673.7 2688.3 4665.4 4762.8 4808.9 4909.1 4910.6 4728.6 4760.5 4776.2 4800.1 4898.6 4368.2 4394.7 4447.9 4489.3 4533.6 4491.1 4509.2 4524.4 4524.4 4525.0 4303.7 4333.1 4348.8 4440.0 4462.8 4343.2 4389.8 4395.5 4415.8 4519.4 4358.3 4403.9 4417.4 4417.9 4422.5 4792.4 4824.9 4825.7 4834.2 4835.0 4959.3 5084.9 5132.2 5163.6 5232.2 5227.6 5235.8 5237.9 5238.6 5246.2 4713.3 4878.5 4880.5 4887.6 4888.4 5067.8 5084.7 5113.8 5184.8 5205.2 4993.1 5003.4 5005.2 5005.4 5007.5 4985.4 5083.1 5091.2 5091.7 5094.6 4901.1 4961.5 4966.0 5029.9 5039.4 5005.5 5009.6 5014.5 5016.1 5025.5 4276.3 4308.4 4325.2 4326.1 4326.4 3780.0 3814.4 3846.6 3847.2 3907.9 4454.4 4476.0 4480.5 4485.2 4486.4 4996.0 5249.1 5252.9 5257.5 5265.4 4368.8 4376.7 4394.4 4456.0 4464.4 4644.5 4682.3 4684.1 4691.0 4691.4 4659.4 4893.4 4896.4 4905.0 4908.3 5047.5 5153.8 5158.1 5192.5 5232.0 4859.4 4880.1 4883.1 4885.6 4887.1 5009.1 5096.4 5111.6 5124.3 5127.5 4995.3 5062.7 5068.0 5126.8 5152.6 4990.1 4992.8 4995.1 5001.7 5004.3 4813.4 4987.5 4998.8 5000.0 5002.2 4837.7 4891.7 4898.6 4964.5 4980.4 5088.1 5093.1 5093.4 5093.7 5094.7 4805.6 4977.0 4988.0 4990.2 4996.2 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | [#1] ext.html Cycles:180 Average:48326.14 Median:35807.96 stddev:89167.96 (249.0%) stddev-sans-first:89345.94 11:26:53 INFO - PROCESS | 2035 | Values: 550.2 565.3 566.6 573.6 579.9 40127.2 41725.0 41740.4 44393.6 44840.1 40757.4 41169.2 41189.4 41587.8 41723.4 7355.8 7371.6 7495.3 7499.1 9923.6 9545.4 9868.4 9882.6 9958.3 9980.5 9928.1 9970.4 9974.4 9977.6 9981.8 9960.1 10006.8 10009.4 10010.3 10017.8 9934.5 10010.8 10011.0 10014.8 10015.5 38921.2 38991.4 39070.2 39135.4 39281.4 2698.6 3034.0 3386.1 3414.7 3416.5 28811.4 29052.0 29058.6 29279.0 29529.1 3007.5 3062.6 3064.2 3144.3 3192.2 245223.0 246915.0 246978.0 247509.0 247785.0 53453.7 53881.0 53885.3 53900.5 53949.0 33003.7 33767.7 33798.3 35866.6 35887.8 13006.3 13226.5 13234.5 13241.3 13245.1 9076.5 9602.1 9745.3 9803.3 9829.9 18105.3 18137.5 18161.5 18164.6 18266.7 6728.5 6939.4 6958.4 6971.9 7073.6 767.8 933.6 980.3 1002.1 1029.4 27715.6 28262.4 29065.6 29250.3 29307.4 934.9 1000.8 1004.5 1038.7 1038.9 14204.4 15021.4 15200.5 15219.2 15352.8 382893.0 383098.9 385026.0 385140.0 386526.0 33269.8 33464.5 33566.0 33589.0 33608.5 1023.6 1111.5 1161.9 1162.4 1170.1 27013.6 28564.7 29209.0 29554.4 29742.4 47537.3 49041.5 49208.5 52810.0 52876.7 364634.0 367213.0 367618.0 368204.6 368427.0 24463.0 25459.3 25499.4 26408.2 26651.3 38666.2 42252.8 43027.0 43718.3 46957.8 36658.3 36731.0 37069.3 37402.8 38138.6 36752.0 37411.4 37482.3 37774.0 38492.8 35547.3 35657.5 35771.8 35781.3 35834.6 32447.2 33603.7 33812.0 34155.8 34326.5 25805.2 25859.6 26101.6 26135.5 26389.0 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | [#2] jquery.html Cycles:180 Average:22499.44 Median:21290.77 stddev:57737.87 (271.2%) stddev-sans-first:57875.87 11:26:53 INFO - PROCESS | 2035 | Values: 338.5 361.7 362.3 365.6 377.2 12728.2 16060.8 16094.2 16469.8 17481.3 14435.6 15185.3 15292.4 15774.7 15912.4 4688.0 4904.7 5121.8 5185.7 5193.6 5020.8 5110.2 5115.4 5116.2 5116.5 4885.4 5031.3 5074.7 5082.3 5085.7 5101.3 5155.0 5157.8 5162.5 5165.5 4370.4 4544.3 4588.2 4616.3 4633.5 21183.6 21214.5 21290.3 21453.5 21471.5 1898.3 1988.3 2125.7 2141.7 2281.5 12851.5 13392.9 13631.7 13680.7 13968.9 1646.9 1710.9 1711.2 1712.5 1712.7 69436.3 69549.0 70421.3 70768.3 71128.3 9269.4 9325.4 9468.5 9646.3 9883.6 13148.8 13149.2 13179.5 13192.0 13200.6 6492.9 6936.5 7108.8 7151.6 7157.0 6518.8 6619.2 6640.0 6746.3 6786.4 5861.4 6029.0 6075.7 6098.1 6173.0 1686.1 1690.6 1703.7 1740.3 1779.5 826.6 892.9 964.8 967.9 977.5 17053.3 17194.1 17831.2 17850.7 18118.5 850.7 855.8 877.3 887.3 904.8 9336.7 10136.3 10283.9 10319.6 10327.2 305039.0 308083.0 308196.0 383328.0 422891.0 56957.7 57916.0 73670.6 81126.2 84861.2 404.5 422.5 425.1 425.4 427.5 9628.8 9727.4 9924.8 10091.3 10603.8 36288.0 37815.0 37952.8 38207.6 42672.4 33477.7 33906.8 34735.7 39936.0 42159.0 7557.8 7604.8 7645.3 7684.0 8141.9 8510.9 11705.1 12095.1 12417.6 12444.8 9905.0 10043.6 10381.9 10555.6 10909.3 10458.6 10689.4 10719.9 10841.1 10967.2 10472.3 10830.5 10889.3 11200.3 11214.1 7420.7 7446.3 7553.8 7620.5 7935.4 9542.0 9985.3 10044.0 10345.0 11065.4 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | [#3] mootools.html Cycles:180 Average:5046.95 Median:5297.08 stddev:2882.67 (54.4%) stddev-sans-first:2877.35 11:26:53 INFO - PROCESS | 2035 | Values: 1347.2 1388.9 1427.9 1632.0 1641.4 6748.0 7005.7 7414.5 7968.8 7983.4 7397.7 7610.0 7679.0 7813.7 7860.1 2101.9 2115.9 2120.6 2124.4 2136.4 1827.0 2072.1 2087.0 2131.4 2140.1 2118.1 2129.1 2136.3 2139.0 2143.8 2059.9 2076.9 2128.8 2130.2 2130.6 2089.3 2095.2 2103.0 2105.6 2135.7 7883.2 7889.2 7891.6 7894.5 7898.1 4261.7 4294.5 4392.4 4394.8 4396.4 2773.9 2901.1 2928.0 2943.5 2945.5 890.4 930.0 941.0 948.4 949.6 10650.3 10650.3 10655.8 10662.0 10668.1 3713.4 3989.9 4091.8 4139.1 4165.3 9046.2 9154.9 9192.4 9198.3 9199.4 4343.3 4362.8 4363.8 4365.5 4382.3 4023.5 4038.7 4043.9 4044.6 4052.1 3313.4 3432.1 3457.3 3501.5 3526.3 953.3 1005.1 1017.8 1022.4 1032.4 670.4 708.9 717.6 785.9 792.5 4821.8 5063.0 5101.8 5280.4 5393.4 817.0 835.3 864.2 878.1 907.7 3559.3 3612.9 3709.8 3753.6 3776.3 9429.2 9632.8 9740.1 9741.1 9772.6 9371.3 9583.9 9658.1 9658.2 9660.7 7103.2 7107.0 7308.6 7310.6 7312.5 5239.2 5291.7 5302.5 5419.3 5439.2 8493.8 8612.9 8710.1 8843.7 8920.6 8780.6 9064.7 9122.0 9142.8 9167.0 6463.4 6597.3 6601.2 6604.5 6613.6 7319.6 7368.6 7376.9 7454.0 7462.2 4849.5 6444.6 6489.0 6685.6 6774.0 6584.9 6588.2 6741.0 6752.1 6787.4 5980.5 6015.4 6058.2 6060.1 6066.3 4289.7 4351.5 4430.5 4484.1 4511.7 4401.8 4448.2 4462.1 4476.0 4564.1 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | [#4] prototype.html Cycles:180 Average:4223.98 Median:4846.35 stddev:1224.29 (25.3%) stddev-sans-first:1191.69 11:26:53 INFO - PROCESS | 2035 | Values: 295.6 298.3 301.9 306.7 306.9 4886.2 4891.5 4911.2 4917.0 4927.1 4785.5 4796.0 4837.0 4848.9 4849.6 3582.3 3691.5 3700.3 3746.9 3818.0 3756.4 3766.5 3766.5 3793.4 3798.4 3728.0 3734.9 3753.7 3763.3 3779.9 3618.9 3710.2 3772.0 3787.6 3789.4 3341.9 3357.2 3362.1 3362.7 3376.4 4710.6 4714.7 4728.8 4749.4 4760.7 4162.8 4330.2 4379.5 4381.6 4386.7 5027.7 5030.5 5037.7 5043.2 5056.8 3662.4 3662.5 3669.6 3670.5 3673.8 5110.2 5261.7 5318.9 5325.5 5340.3 3728.8 3728.9 3745.4 3747.3 3761.1 3815.6 3827.3 3827.6 3834.5 3837.5 4331.3 4344.8 4352.6 4353.8 4357.7 4843.8 5071.7 5089.7 5097.7 5130.6 1317.5 1333.2 1333.4 1339.8 1346.2 825.7 853.3 854.6 865.8 869.9 4330.4 4459.4 4475.4 4477.6 4478.7 5196.2 5225.0 5226.7 5234.2 5234.6 4470.2 4472.6 4474.3 4480.8 4488.6 2628.8 2756.6 2792.5 2795.7 2800.5 4928.2 4938.2 4939.9 4941.7 4944.1 5218.2 5293.4 5352.6 5367.9 5371.9 4892.9 4900.7 4909.5 4909.7 4922.8 5220.8 5236.5 5241.3 5259.3 5277.9 4840.4 5070.3 5119.3 5130.5 5141.8 4895.5 4899.1 4914.7 4920.5 4940.8 3636.5 3644.0 3685.6 3707.2 3716.4 5139.8 5343.9 5344.9 5351.0 5358.9 5013.9 5039.5 5105.8 5154.5 5175.2 5010.9 5084.8 5109.0 5161.9 5195.3 4784.6 5025.9 5029.0 5036.8 5044.2 4920.3 4929.2 5097.2 5162.1 5172.7 4973.9 4976.6 4980.2 4982.4 5001.4 11:26:53 INFO - PROCESS | 2035 | 11:26:53 INFO - PROCESS | 2035 | [#5] yui.html Cycles:180 Average:17658.58 Median:61365.85 stddev:26386.63 (43.0%) stddev-sans-first:26429.50 11:26:53 INFO - PROCESS | 2035 | Values: 582.9 589.7 607.1 648.2 684.3 11846.9 12094.5 12299.4 12305.9 12955.6 12696.9 12893.2 12903.2 12918.6 12925.6 622.6 751.4 761.2 763.0 763.3 759.3 778.1 787.4 789.0 790.2 825.9 828.2 828.3 828.3 828.6 648.1 813.6 818.6 818.7 818.8 571.7 587.6 587.8 591.0 591.5 12711.1 12744.6 12761.5 12766.2 12776.7 12497.0 12740.0 12891.5 13100.5 13150.4 11777.9 12005.3 12027.3 12081.0 12688.2 4052.3 4095.5 4198.7 4329.8 4330.0 52158.7 54505.7 54927.5 60934.7 61797.0 9068.3 9268.5 9505.1 9522.9 9813.6 18293.5 18337.6 18352.1 18358.4 18365.9 6902.8 7018.8 7024.8 7047.6 7177.0 3752.5 3770.5 3811.7 3861.7 3944.4 2810.4 2969.2 2977.7 2981.1 2981.4 511.9 537.6 557.2 561.6 571.8 522.8 553.5 561.5 562.2 564.0 7649.2 7779.6 7841.3 7904.6 8089.2 478.0 479.3 532.4 536.3 572.3 3567.1 3697.3 3714.8 3742.1 3829.9 98161.5 100503.4 101161.5 104373.8 105933.0 84001.0 87979.0 90803.0 90833.0 92171.1 75037.0 75044.0 75680.6 75880.6 76019.2 6970.8 6981.6 7069.8 7167.7 7242.4 44920.6 45603.5 46740.5 47703.0 48016.0 63304.7 67915.3 68639.7 69524.0 70022.0 8288.4 8383.4 8600.1 9657.2 9930.4 10625.9 10639.1 10786.8 11233.1 11236.8 8882.6 9135.5 9154.9 9533.8 9548.9 9431.4 9432.2 9672.3 9723.9 9978.1 9380.5 9440.6 9867.1 9870.9 9903.0 7528.8 7931.4 7944.2 8614.5 8625.4 7587.8 7651.3 7799.3 7832.9 7900.4 11:26:53 INFO - PROCESS | 2035 | -------- Summary: end -------- 11:26:53 INFO - PROCESS | 2035 | 11:26:54 INFO - TEST-INFO | 2035: exit 0 11:26:54 INFO - TEST-OK | dromaeo_css | took 1122112ms 11:26:54 INFO - TEST-START | kraken 11:26:54 INFO - operating with platform_type : linux_ 11:26:54 INFO - Initialising browser for kraken test... 11:26:54 INFO - TEST-INFO | started process 2345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYCSxVP/profile http://localhost:42812/getInfo.html) 11:26:59 INFO - PROCESS | 2345 | __metrics Screen width/height:1600/1200 11:26:59 INFO - PROCESS | 2345 | colorDepth:24 11:26:59 INFO - PROCESS | 2345 | Browser inner width/height: 1024/697 11:26:59 INFO - PROCESS | 2345 | __metrics 11:27:00 INFO - PROCESS | 2345 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:27:00 INFO - PROCESS | 2345 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:01 INFO - TEST-INFO | 2345: exit 0 11:27:01 INFO - Browser initialized. 11:27:01 INFO - Running cycle 1/1 for kraken test... 11:27:01 INFO - TEST-INFO | started process 2500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYCSxVP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:13 INFO - PROCESS | 2500 | RSS: Main: 176013312 11:27:13 INFO - PROCESS | 2500 | 11:27:16 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42812/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:17 INFO - PROCESS | 2500 | RSS: Main: 245297152 11:27:17 INFO - PROCESS | 2500 | 11:27:20 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42812/tests/kraken/driver.html?testName=audio-dft) 11:27:20 INFO - PROCESS | 2500 | RSS: Main: 227450880 11:27:20 INFO - PROCESS | 2500 | 11:27:23 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42812/tests/kraken/driver.html?testName=audio-fft) 11:27:24 INFO - PROCESS | 2500 | RSS: Main: 303370240 11:27:24 INFO - PROCESS | 2500 | 11:27:26 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42812/tests/kraken/driver.html?testName=audio-oscillator) 11:27:27 INFO - PROCESS | 2500 | RSS: Main: 210870272 11:27:27 INFO - PROCESS | 2500 | 11:27:29 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:30 INFO - PROCESS | 2500 | RSS: Main: 215662592 11:27:30 INFO - PROCESS | 2500 | 11:27:33 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42812/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:34 INFO - PROCESS | 2500 | RSS: Main: 251281408 11:27:34 INFO - PROCESS | 2500 | 11:27:37 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42812/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:38 INFO - PROCESS | 2500 | RSS: Main: 245207040 11:27:38 INFO - PROCESS | 2500 | 11:27:41 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42812/tests/kraken/driver.html?testName=json-parse-financial) 11:27:41 INFO - PROCESS | 2500 | RSS: Main: 248418304 11:27:41 INFO - PROCESS | 2500 | 11:27:43 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:44 INFO - PROCESS | 2500 | RSS: Main: 211886080 11:27:44 INFO - PROCESS | 2500 | 11:27:46 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:46 INFO - PROCESS | 2500 | RSS: Main: 219189248 11:27:46 INFO - PROCESS | 2500 | 11:27:48 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:49 INFO - PROCESS | 2500 | RSS: Main: 223965184 11:27:49 INFO - PROCESS | 2500 | 11:27:52 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:53 INFO - PROCESS | 2500 | RSS: Main: 219885568 11:27:53 INFO - PROCESS | 2500 | 11:27:56 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:56 INFO - PROCESS | 2500 | RSS: Main: 221913088 11:27:56 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:42812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42812/tests/kraken/driver.html?testName=ai-astar) 11:27:58 INFO - PROCESS | 2500 | RSS: Main: 272957440 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | __start_tp_report 11:27:58 INFO - PROCESS | 2500 | _x_x_mozilla_page_load 11:27:58 INFO - PROCESS | 2500 | _x_x_mozilla_page_load_details 11:27:58 INFO - PROCESS | 2500 | |i|pagename|runs| 11:27:58 INFO - PROCESS | 2500 | |0;ai-astar;102;113;111;113;114;113;126;112;113;113 11:27:58 INFO - PROCESS | 2500 | |1;audio-beat-detection;155;125;153;198;122;151;149;125;180;122 11:27:58 INFO - PROCESS | 2500 | |2;audio-dft;163;160;160;162;160;162;162;161;162;161 11:27:58 INFO - PROCESS | 2500 | |3;audio-fft;75;76;75;168;76;77;75;123;109;75 11:27:58 INFO - PROCESS | 2500 | |4;audio-oscillator;87;85;153;87;88;87;137;86;86;155 11:27:58 INFO - PROCESS | 2500 | |5;imaging-gaussian-blur;118;118;118;118;117;118;117;118;117;117 11:27:58 INFO - PROCESS | 2500 | |6;imaging-darkroom;146;147;147;147;146;146;147;147;146;146 11:27:58 INFO - PROCESS | 2500 | |7;imaging-desaturate;95;95;95;94;96;95;94;95;95;96 11:27:58 INFO - PROCESS | 2500 | |8;json-parse-financial;63;63;64;65;64;64;67;71;65;65 11:27:58 INFO - PROCESS | 2500 | |9;json-stringify-tinderbox;66;67;65;75;66;65;65;65;66;67 11:27:58 INFO - PROCESS | 2500 | |10;stanford-crypto-aes;84;87;83;82;86;83;84;82;82;82 11:27:58 INFO - PROCESS | 2500 | |11;stanford-crypto-ccm;140;144;142;142;142;136;134;133;147;146 11:27:58 INFO - PROCESS | 2500 | |12;stanford-crypto-pbkdf2;174;172;174;175;172;176;181;168;169;169 11:27:58 INFO - PROCESS | 2500 | |13;stanford-crypto-sha256-iterative;68;73;68;73;71;68;69;73;66;66 11:27:58 INFO - PROCESS | 2500 | __end_tp_report 11:27:58 INFO - PROCESS | 2500 | __start_cc_report 11:27:58 INFO - PROCESS | 2500 | _x_x_mozilla_cycle_collect,2010 11:27:58 INFO - PROCESS | 2500 | __end_cc_report 11:27:58 INFO - PROCESS | 2500 | __startTimestamp1471976878723__endTimestamp 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | ------- Summary: start ------- 11:27:58 INFO - PROCESS | 2500 | Number of tests: 14 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:5.73 (5.1%) stddev-sans-first:4.49 11:27:58 INFO - PROCESS | 2500 | Values: 102.0 113.0 111.0 113.0 114.0 113.0 126.0 112.0 113.0 113.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:152.00 stddev:25.86 (17.0%) stddev-sans-first:27.30 11:27:58 INFO - PROCESS | 2500 | Values: 155.0 125.0 153.0 198.0 122.0 151.0 149.0 125.0 180.0 122.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 11:27:58 INFO - PROCESS | 2500 | Values: 163.0 160.0 160.0 162.0 160.0 162.0 162.0 161.0 162.0 161.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:31.47 (42.0%) stddev-sans-first:32.70 11:27:58 INFO - PROCESS | 2500 | Values: 75.0 76.0 75.0 168.0 76.0 77.0 75.0 123.0 109.0 75.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:86.50 stddev:30.20 (34.9%) stddev-sans-first:31.32 11:27:58 INFO - PROCESS | 2500 | Values: 87.0 85.0 153.0 87.0 88.0 87.0 137.0 86.0 86.0 155.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:27:58 INFO - PROCESS | 2500 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:27:58 INFO - PROCESS | 2500 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:27:58 INFO - PROCESS | 2500 | Values: 95.0 95.0 95.0 94.0 96.0 95.0 94.0 95.0 95.0 96.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:2.38 (3.7%) stddev-sans-first:2.40 11:27:58 INFO - PROCESS | 2500 | Values: 63.0 63.0 64.0 65.0 64.0 64.0 67.0 71.0 65.0 65.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:3.02 (4.6%) stddev-sans-first:3.19 11:27:58 INFO - PROCESS | 2500 | Values: 66.0 67.0 65.0 75.0 66.0 65.0 65.0 65.0 66.0 67.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.78 (2.1%) stddev-sans-first:1.88 11:27:58 INFO - PROCESS | 2500 | Values: 84.0 87.0 83.0 82.0 86.0 83.0 84.0 82.0 82.0 82.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:142.00 stddev:4.84 (3.4%) stddev-sans-first:5.12 11:27:58 INFO - PROCESS | 2500 | Values: 140.0 144.0 142.0 142.0 142.0 136.0 134.0 133.0 147.0 146.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.00 stddev:3.92 (2.3%) stddev-sans-first:4.14 11:27:58 INFO - PROCESS | 2500 | Values: 174.0 172.0 174.0 175.0 172.0 176.0 181.0 168.0 169.0 169.0 11:27:58 INFO - PROCESS | 2500 | 11:27:58 INFO - PROCESS | 2500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:2.80 (4.0%) stddev-sans-first:2.92 11:27:58 INFO - PROCESS | 2500 | Values: 68.0 73.0 68.0 73.0 71.0 68.0 69.0 73.0 66.0 66.0 11:27:58 INFO - PROCESS | 2500 | -------- Summary: end -------- 11:27:58 INFO - PROCESS | 2500 | 11:27:59 INFO - TEST-INFO | 2500: exit 0 11:27:59 INFO - TEST-OK | kraken | took 65027ms 11:27:59 INFO - SUITE-END | took 1187s 11:28:00 INFO - Completed test suite (00:19:47) 11:28:00 INFO - javascript benchmark 11:28:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.0, 2664.9733502664967, 2669.4794515069557, 2673.705892351841, 2688.2741659751855, 4665.4168228971375, 4762.8094876205, 4808.855734327972, 4909.116359055373, 4910.6071514278865, 4728.550787675165, 4760.500147484516, 4776.235802271637, 4800.087983283173, 4898.583620392271, 4368.213721530124, 4394.736315821045, 4447.888802779924, 4489.25927222008, 4533.569310915458, 4491.056878055612, 4509.210888094587, 4524.366588677588, 4524.389207457, 4525.027119169378, 4303.74177549348, 4333.090051089275, 4348.760818155, 4439.977800111011, 4462.776861156929, 4343.2399330117105, 4389.758563279019, 4395.494518130424, 4415.8233670653135, 4519.41247637805, 4358.259095953696, 4403.867883963486, 4417.359482874966, 4417.933730994037, 4422.513523512411, 4792.353032340624, 4824.879378015543, 4825.686330388514, 4834.178189707758, 4835.0, 4959.330490383788, 5084.898302033976, 5132.230165475208, 5163.63854530183, 5232.189010703347, 5227.634065615409, 5235.816746413895, 5237.9476205238225, 5238.554722848562, 5246.186841039645, 4713.34013238147, 4878.463369029404, 4880.536349046835, 4887.633427492952, 4888.437829649564, 5067.822626208065, 5084.669496482791, 5113.821016264487, 5184.818531351385, 5205.167173252262, 4993.1262029144755, 5003.449620541737, 5005.174146265898, 5005.399352077774, 5007.524285192901, 4985.376827896513, 5083.059633967654, 5091.210862316347, 5091.694498330112, 5094.5669618082875, 4901.142300097468, 4961.528654777862, 4966.03162383339, 5029.949700502948, 5039.44566097729, 5005.524475174852, 5009.599232061426, 5014.52362025607, 5016.147254966664, 5025.4974502550185, 4276.337167738943, 4308.3968244445805, 4325.15659446405, 4326.149726743201, 4326.394304797331, 3779.962200377961, 3814.446905198786, 3846.615338466131, 3847.2305538892333, 3907.882763517099, 4454.354118652777, 4475.955240447619, 4480.484744254452, 4485.1702435048965, 4486.416765820422, 4995.975020124876, 5249.081410753103, 5252.868678283074, 5257.5005374489365, 5265.368155821326, 4368.825246990148, 4376.737395756265, 4394.428724265889, 4456.019675671347, 4464.419625448671, 4644.535546445396, 4682.2508398656055, 4684.063187362541, 4691.038337140878, 4691.390119284471, 4659.44086709597, 4893.388326459192, 4896.4124305083615, 4905.018996200845, 4908.312836203006, 5047.4700156484505, 5153.845384638467, 5158.148905430562, 5192.506711862367, 5232.0, 4859.392575928009, 4880.097182021337, 4883.145449546386, 4885.560299573055, 4887.144749668865, 5009.123403404463, 5096.413912399973, 5111.642185047011, 5124.30821839047, 5127.512886275797, 4995.300657907823, 5062.696238225718, 5068.0, 5126.846194614168, 5152.613553983391, 4990.051890140861, 4992.80028798844, 4995.050940321327, 5001.749912504433, 5004.324416203766, 4813.374261346003, 4987.476314986874, 4998.775055122455, 4999.975005123868, 5002.2496625506465, 4837.7097374157665, 4891.682040667345, 4898.608111351155, 4964.4539100698175, 4980.377452818398, 5088.0587091388215, 5093.083245015784, 5093.439721630692, 5093.745312734274, 5094.745262736922, 4805.567498925114, 4977.0, 4988.027334669705, 4990.201567749143, 4996.175631020987], "value": 4712.314119038721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.1994597860114, 565.2510423688614, 566.6062086849641, 573.6328749600257, 579.8869220502004, 40127.19745605086, 41725.0, 41740.37389439157, 44393.55606443935, 44840.10319793611, 40757.38863917044, 41169.17661646765, 41189.38215926763, 41587.79206103973, 41723.37414938771, 7355.77932662021, 7371.557706537598, 7495.2879476449925, 7499.062617172854, 9923.553440095213, 9545.377285861421, 9868.358556693793, 9882.604695812159, 9958.253131015166, 9980.50097495126, 9928.10647041766, 9970.401775893433, 9974.401535907833, 9977.600895964153, 9981.75045623858, 9960.103590676837, 10006.79986400268, 10009.449480278581, 10010.349327293703, 10017.799644007078, 9934.45360505172, 10010.799784004279, 10011.0, 10014.799704005953, 10015.549300281506, 38921.22157556861, 38991.41512877309, 39070.21859562821, 39135.41296880549, 39281.41077883834, 2698.649175607178, 3034.0, 3386.1196089016785, 3414.6926776589976, 3416.4875268709643, 28811.423771524453, 29052.0, 29058.564121538195, 29279.0, 29529.114126576238, 3007.5187969924928, 3062.5865508156335, 3064.249258931554, 3144.339688665383, 3192.201949512622, 245223.0, 246915.0, 246978.0, 247509.0, 247784.9999999982, 53453.73273133687, 53880.995470588576, 53885.34203908533, 53900.46099538954, 53949.0, 33003.66996330006, 33767.662323376455, 33798.324033519195, 35866.64133358685, 35887.82056089703, 13006.349682515836, 13226.470941162246, 13234.470621175045, 13241.271730054747, 13245.139065960682, 9076.455412675261, 9602.135807777333, 9745.31782775199, 9803.313768036312, 9829.852552211723, 18105.275788968556, 18137.546561335806, 18161.545961351072, 18164.63670726578, 18266.711991841596, 6728.461723062143, 6939.375456208965, 6958.373746362851, 6971.895421568681, 7073.575585464889, 767.8157242261817, 933.6265493802533, 980.2745967983641, 1002.1031177096457, 1029.3720830293514, 27715.584266236023, 28262.43475130527, 29065.564016539767, 29250.268743281587, 29307.41385172327, 934.9252059835197, 1000.8440251509518, 1004.4927311707687, 1038.6832016234969, 1038.9116925061455, 14204.360803763855, 15021.399144034334, 15200.543983680507, 15219.162946038074, 15352.769708454382, 382893.0, 383098.94362148154, 385026.0, 385140.0, 386526.0, 33269.83365083207, 33464.49409776566, 33566.0, 33589.0, 33608.49587256193, 1023.6007956896816, 1111.522045520434, 1161.91285653578, 1162.442027826648, 1170.0639488409238, 27013.59479607847, 28564.714352856205, 29209.0, 29554.408911821214, 29742.405151896408, 47537.28694069522, 49041.509584903695, 49208.507914920396, 52810.0, 52876.735616321675, 364634.0, 367213.0, 367618.0, 368204.58977050503, 368427.0, 24463.0, 25459.32677068881, 25499.362515936507, 26408.20775376742, 26651.33371665724, 38666.226675466896, 42252.78873605735, 43027.0, 43718.344224836015, 46957.765211175094, 36658.26683466262, 36731.0, 37069.25861482701, 37402.8129859349, 38138.618613814615, 36752.0, 37411.43882841705, 37482.250354993295, 37774.0, 38492.80753596214, 35547.28905421929, 35657.46513802243, 35771.82114089413, 35781.28437431289, 35834.64165358313, 32447.188820279684, 33603.66396336005, 33812.0, 34155.82922085473, 34326.48510272298, 25805.225843224733, 25859.612105818804, 26101.608475872497, 26135.477290454466, 26389.0], "value": 17769.69047556179, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.533781402483, 361.67087949965537, 362.32607350328385, 365.5868868178958, 377.19555107773704, 12728.236305821645, 16060.839391606096, 16094.195290235486, 16469.83530164698, 17481.300747970065, 14435.63910902228, 15185.316660750264, 15292.388304467808, 15774.684506309866, 15912.443064492745, 4688.0, 4904.681195722284, 5121.769520371574, 5185.740712964355, 5193.558547523465, 5020.824271150511, 5110.207917772751, 5115.386153661566, 5116.232565115225, 5116.462771409004, 4885.413750349963, 5031.27046578246, 5074.670146440488, 5082.313887625179, 5085.66943148696, 5101.311322971388, 5155.0, 5157.767900444489, 5162.5095615916425, 5165.457626949173, 4370.409994650713, 4544.272916333371, 4588.151192029485, 4616.330632058366, 4633.536646335373, 21183.576328473497, 21214.469638259012, 21290.25484108049, 21453.46366340854, 21471.463213419633, 1898.3166060218311, 1988.2643421933833, 2125.7130287411155, 2141.7001619773246, 2281.5094754627835, 12851.485940562367, 13392.86607133926, 13631.710106422828, 13680.726385472335, 13968.93015534926, 1646.8517833394933, 1710.8887922285012, 1711.1786342555642, 1712.5119340987883, 1712.691715491211, 69436.30563694349, 69549.0, 70421.29578704199, 70768.2923170772, 71128.28871711268, 9269.44383337002, 9325.393849399767, 9468.479233642216, 9646.276529260334, 9883.555240014217, 13148.802767958488, 13149.21104733719, 13179.538716144889, 13192.0, 13200.603981880367, 6492.935070649328, 6936.549124306904, 7108.751193708299, 7151.60666163366, 7157.0, 6518.804435866931, 6619.2056953164965, 6639.982810399735, 6746.291639377893, 6786.355296246848, 5861.3552509223955, 6028.969855150784, 6075.726592303357, 6098.146259523582, 6173.0, 1686.0778712268025, 1690.6280618263963, 1703.7359209322574, 1740.3299729604194, 1779.4839496545856, 826.5949684654476, 892.9285657147412, 964.7925695975258, 967.8548217767391, 977.4770497783652, 17053.31786728542, 17194.1402929853, 17831.197596108206, 17850.732239016426, 18118.45644630663, 850.7192626433385, 855.8373908957278, 877.3025444771422, 887.3034667785757, 904.8326059678981, 9336.673216437392, 10136.341137826017, 10283.9485802572, 10319.638812641522, 10327.173826093895, 305039.0, 308083.0, 308196.0, 383328.0, 422891.0, 56957.715211424504, 57916.0, 73670.63164684143, 81126.18873811305, 84861.15138848656, 404.4782230922136, 422.5359130612443, 425.14333617760235, 425.41293015638223, 427.5468003915859, 9628.75928101803, 9727.367721098106, 9924.75188120274, 10091.344062635904, 10603.840942386025, 36288.0, 37815.0, 37952.810235948644, 38207.617923820406, 42672.359914601926, 33477.66522334745, 33906.83046584751, 34735.652643473244, 39936.0, 42159.0, 7557.773266802004, 7604.80987975305, 7645.273698998586, 7683.961580192064, 8141.8778718320455, 8510.872336915076, 11705.122115841516, 12095.092868034757, 12417.565385211474, 12444.75110497767, 9905.018996200644, 10043.648472303434, 10381.9480902595, 10555.63055293061, 10909.345439273351, 10458.63394781179, 10689.358638481715, 10719.892801072201, 10841.07850832688, 10967.232293739362, 10472.266941314036, 10830.51262693165, 10889.346639201673, 11200.271982321123, 11214.102871770401, 7420.703171873281, 7446.329830315298, 7553.848923021399, 7620.466567340233, 7935.365170786438, 9542.0, 9985.251106166921, 10044.0, 10345.0, 11065.446727663746], "value": 7894.975296655957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.2118810495856, 1388.944442222311, 1427.8786303164231, 1631.9510414687563, 1641.4008886756337, 6747.966260168704, 7005.719771209158, 7414.480986330959, 7968.760937171887, 7983.441159118856, 7397.741079062234, 7609.961950190255, 7679.0, 7813.6874525019075, 7860.135385107634, 2101.9264325748563, 2115.9471013224716, 2120.628889944261, 2124.4370241885913, 2136.444524423653, 1827.0499340343013, 2072.057213967641, 2086.9582608347823, 2131.3712454825863, 2140.069069954567, 2118.0998075817793, 2129.1483406637312, 2136.3377353020537, 2138.957220855582, 2143.7534683511362, 2059.938201853939, 2076.8546201765885, 2128.755193152792, 2130.243763463979, 2130.6164890319737, 2089.3209706845337, 2095.1514636572215, 2103.0115845552564, 2105.620988222119, 2135.7330333708287, 7883.172266912006, 7889.2110788920645, 7891.6054197289905, 7894.526328420256, 7898.091719452222, 4261.74429534229, 4294.527601963781, 4392.407025051641, 4394.78026098697, 4396.406485124499, 2773.88904443822, 2901.1151598762367, 2928.0191135969476, 2943.484890144216, 2945.5434407666844, 890.3767362845969, 929.9674511392136, 941.0260380506144, 948.3835506920487, 949.6059135458777, 10650.25448218625, 10650.307729997525, 10655.84016239757, 10662.0, 10668.093212076983, 3713.3687273163628, 3989.940150897739, 4091.8158682859344, 4139.110091330378, 4165.333546632585, 9046.231070358961, 9154.89437429395, 9192.448453092837, 9198.264138868875, 9199.402038867453, 4343.3484977253665, 4362.847300344472, 4363.781810909441, 4365.4761428628135, 4382.342648602671, 4023.471080989264, 4038.656714179269, 4043.9191216175514, 4044.6359827615065, 4052.1490486997473, 3313.403587354251, 3432.1419645088727, 3457.3085382923514, 3501.457274122515, 3526.2771131917893, 953.2516974175239, 1005.0552480668149, 1017.7964407118606, 1022.3865680591734, 1032.390889375257, 670.3999920071509, 708.9361957423856, 717.6340066566089, 785.8939043229091, 792.5442870349572, 4821.7589120543835, 5063.0, 5101.770420331094, 5280.392754833243, 5393.352797664305, 816.9673213071411, 835.3327131175564, 864.2351518905688, 878.0604752914448, 907.7186072317603, 3559.341521818472, 3612.8735494257576, 3709.8330575124182, 3753.5683396409217, 3776.3202623528027, 9429.198518125899, 9632.75918102053, 9740.123388894892, 9741.12329890299, 9772.609095636237, 9371.344005919656, 9583.856242156373, 9658.130768230892, 9658.227341812639, 9660.661876834278, 7103.183133939663, 7106.964465177744, 7308.6345682715655, 7310.561366317932, 7312.464382479632, 5239.161734122522, 5291.682499050069, 5302.469753024667, 5419.3225846769155, 5439.238506609157, 8493.830123397374, 8612.913870861212, 8710.12898710124, 8843.734687959372, 8920.55397230123, 8780.648774048967, 9064.728058158265, 9122.042185570419, 9142.771430714285, 9166.954165229132, 6463.353664633499, 6597.307282735435, 6601.174853143357, 6604.471642268703, 6613.636250006296, 7319.63401829917, 7368.631568421664, 7376.926230737624, 7454.0, 7462.179160292472, 4849.515048495122, 6444.613323200623, 6489.0, 6685.565438246498, 6773.966130169318, 6584.9230233540275, 6588.209414870054, 6741.022551729873, 6752.122224110834, 6787.4230690389895, 5980.5215582754145, 6015.39846015395, 6058.182145410313, 6060.060690592789, 6066.332703402711, 4289.742615443083, 4351.543087975717, 4430.512643609136, 4484.05834774701, 4511.729296242236, 4401.779911004501, 4448.1770872388715, 4462.085272519191, 4475.9552404475535, 4564.050370193011], "value": 4032.9919235623393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5596161719039, 298.28263027419064, 301.88981021926975, 306.70556265984646, 306.8941215280729, 4886.169351210294, 4891.461939186691, 4911.165101932671, 4916.95083049169, 4927.088488629606, 4785.5214478552125, 4795.976020119894, 4836.951630483694, 4848.878778030542, 4849.612031037517, 3582.26563554472, 3691.53855768029, 3700.2987818892225, 3746.868859589915, 3818.0073180972868, 3756.3614185588517, 3766.4538641896906, 3766.5480142382953, 3793.4499497572833, 3798.3922572388424, 3727.9627203728023, 3734.9457798210874, 3753.686209826566, 3763.284975854579, 3779.9433008504893, 3618.860059081394, 3710.2023065041144, 3772.0, 3787.5644300905474, 3789.3747531657245, 3341.8830340937952, 3357.244619960489, 3362.0586235854, 3362.663733626642, 3376.3584918865336, 4710.552497512731, 4714.693544919569, 4728.810847566093, 4749.430068391781, 4760.666753327268, 4162.793719328761, 4330.242207613655, 4379.4525684289465, 4381.605655491021, 4386.6929314947965, 5027.748612569393, 5030.496950304977, 5037.722925239111, 5043.218301163325, 5056.84829455117, 3662.3957047087197, 3662.468942003421, 3669.6146904574903, 3670.46778217157, 3673.761205521659, 5110.207917772751, 5261.710605916673, 5318.867028324285, 5325.520703136736, 5340.332458442695, 3728.7949162795762, 3728.925421491609, 3745.419459983707, 3747.2505498900327, 3761.1349389640536, 3815.618438156162, 3827.2919509890758, 3827.5789663137034, 3834.4631751554803, 3837.501124853751, 4331.263685173528, 4344.761038142932, 4352.630026447724, 4353.7591786340745, 4357.673174511924, 4843.830465933675, 5071.721055341918, 5089.6691715038405, 5097.745112744422, 5130.615203859726, 1317.5059352742721, 1333.2067419885152, 1333.4399552188104, 1339.8459177194552, 1346.158650843223, 825.6738588257605, 853.2917678326974, 854.6068808348106, 865.8181582140334, 869.8564736818481, 4330.39374487572, 4459.4169069980335, 4475.440569928759, 4477.619402350771, 4478.731276123443, 5196.246544251138, 5225.033368826703, 5226.686398816008, 5234.18870075139, 5234.633575649668, 4470.150671372428, 4472.597466228055, 4474.32885067236, 4480.775961201927, 4488.640908727294, 2628.8422694638384, 2756.5589505678995, 2792.4694308081807, 2795.720427957229, 2800.523910935146, 4928.162212423825, 4938.234573641092, 4939.90120197594, 4941.703497790144, 4944.1100601891285, 5218.243354713545, 5293.3647962244, 5352.598555108382, 5367.865803354869, 5371.884307101872, 4892.902141957141, 4900.656954013256, 4909.5090490950615, 4909.680870743319, 4922.803087876445, 5220.843374698765, 5236.502532259429, 5241.292425522505, 5259.316288882574, 5277.920831187458, 4840.370751802243, 5070.340855688737, 5119.334486516729, 5130.48695130484, 5141.794328226829, 4895.4859739728245, 4899.142650036159, 4914.729689867092, 4920.483349248278, 4940.752962351796, 3636.454531820142, 3643.9635603643624, 3685.5577330720484, 3707.2029513654693, 3716.442533619979, 5139.794408223779, 5343.9198412024625, 5344.931013797178, 5351.03681337363, 5358.892822143457, 5013.949860501494, 5039.53853382515, 5105.821296254613, 5154.458781827854, 5175.249588809676, 5010.920468005736, 5084.7966081356335, 5108.9782043590685, 5161.922571161361, 5195.272661827423, 4784.588546378896, 5025.924611130909, 5029.0, 5036.773345199402, 5044.167712327425, 4920.327088789829, 4929.1866841972105, 5097.16502059251, 5162.122439185272, 5172.663776854492, 4973.910957397974, 4976.5521103099445, 4980.153373926369, 4982.352294201875, 5001.42483614389], "value": 3835.3244844016613, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.9096490044042, 589.6956872928013, 607.1136141233799, 648.186525909983, 684.2712511175598, 11846.881531184696, 12094.455749491271, 12299.446524906378, 12305.876941230585, 12955.611331660066, 12696.936515317433, 12893.161944473602, 12903.225806451595, 12918.612441626743, 12925.612231633042, 622.6046460497594, 751.3763576231714, 761.1665226576889, 763.0118995900294, 763.3397111498541, 759.3014426727397, 778.1168373895613, 787.3976408047848, 788.9526628402285, 790.1584812175043, 825.8926339575846, 828.2380210206625, 828.2752591482453, 828.3000864269712, 828.6064119543229, 648.0667838312814, 813.5606772342928, 818.6193420059672, 818.6520728690313, 818.8034871630825, 571.7484306904948, 587.6297932302622, 587.7854583077188, 590.9556783241231, 591.4794980417205, 12711.110222284444, 12744.553940612126, 12761.489540418372, 12766.234025958473, 12776.680582985407, 12497.0, 12740.0, 12891.484340626457, 13100.47598096075, 13150.389347025783, 11777.882221177764, 12005.339706316148, 12027.27836329823, 12081.033517318594, 12688.175268607603, 4052.250333688277, 4095.5290141633795, 4198.664106871473, 4329.7618630975285, 4330.047389574289, 52158.739206304104, 54505.727471362785, 54927.450725492636, 60934.695326523084, 61797.0, 9068.274538036942, 9268.536573171314, 9505.144536991565, 9522.90477095234, 9813.607455701693, 18293.451196464128, 18337.633247335245, 18352.082395880152, 18358.357457488924, 18365.90817045906, 6902.758403455855, 7018.75434359795, 7024.789256322319, 7047.612381319077, 7176.96411517939, 3752.5309336332957, 3770.5286839145106, 3811.676007539335, 3861.710371722132, 3944.3886197639413, 2810.409813939096, 2969.213158512996, 2977.7320041195962, 2981.0609657957675, 2981.3739114785703, 511.86947328431756, 537.6102325813832, 557.2310211907622, 561.6040691312614, 571.8341680912572, 522.7647558598646, 553.532265235875, 561.4862400903128, 562.2381672833252, 563.9605227634108, 7649.196834332426, 7779.572123533147, 7841.333486653584, 7904.604769761604, 8089.150639182919, 478.0009779560735, 479.2595440045139, 532.4063669009028, 536.3295880149813, 572.3160822816777, 3567.1438854674693, 3697.2975134724315, 3714.795686237283, 3742.143545351516, 3829.942550861739, 98161.50919245358, 100503.42700308414, 101161.49419253004, 104373.75547590661, 105933.0, 84001.0, 87979.0, 90803.0, 90833.0, 92171.07828921625, 75037.0, 75044.0, 75680.62159689056, 75880.62059689667, 76019.23980760122, 6970.825729356807, 6981.5543875776975, 7069.752558660422, 7167.749128780468, 7242.420606351374, 44920.55079449164, 45603.54396455993, 46740.53259467498, 47703.0, 48016.0, 63304.68347658416, 67915.3208467909, 68639.65680171567, 69524.0, 70022.0, 8288.419810613199, 8383.413161078666, 8600.13998600135, 9657.22742180638, 9930.404175749478, 10625.9468702656, 10639.14886809069, 10786.838197427202, 11233.101351891992, 11236.775264494829, 8882.644694212158, 9135.543222838698, 9154.862677059717, 9533.809323813624, 9548.856767148638, 9431.386959847589, 9432.19826314771, 9672.274579406432, 9723.85414218773, 9978.052085051908, 9380.530973451163, 9440.575174117044, 9867.06262905023, 9870.851937220803, 9902.950485247527, 7528.774136775905, 7931.405144614292, 7944.205579442009, 8614.526201059001, 8625.39622226438, 7587.810304742205, 7651.311381975426, 7799.337056350047, 7832.921670783219, 7900.446968712365], "value": 6279.735710961941, "unit": "score"}], "name": "dromaeo_css", "value": 6328.210755871395, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 113.0, 114.0, 113.0, 126.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 153.0, 198.0, 122.0, 151.0, 149.0, 125.0, 180.0, 122.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 162.0, 160.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 168.0, 76.0, 77.0, 75.0, 123.0, 109.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 153.0, 87.0, 88.0, 87.0, 137.0, 86.0, 86.0, 155.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 65.0, 64.0, 64.0, 67.0, 71.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 75.0, 66.0, 65.0, 65.0, 65.0, 66.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 83.0, 82.0, 86.0, 83.0, 84.0, 82.0, 82.0, 82.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 142.0, 142.0, 142.0, 136.0, 134.0, 133.0, 147.0, 146.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 174.0, 175.0, 172.0, 176.0, 181.0, 168.0, 169.0, 169.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 68.0, 73.0, 71.0, 68.0, 69.0, 73.0, 66.0, 66.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1577.8, "alertThreshold": 2.0}]} 11:28:00 INFO - Return code: 0 11:28:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:28:00 INFO - # TBPL SUCCESS # 11:28:00 INFO - Running post-action listener: _resource_record_post_action 11:28:00 INFO - [mozharness: 2016-08-23 18:28:00.521649Z] Finished run-tests step (success) 11:28:00 INFO - Running post-run listener: _resource_record_post_run 11:28:00 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408231936; Read time: 8; Write time: 420588 11:28:00 INFO - TinderboxPrint: CPU usage
13.3% 11:28:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:28:00 INFO - TinderboxPrint: I/O write bytes / time
408,231,936 / 420,588 11:28:00 INFO - TinderboxPrint: CPU idle
8,333.2 (86.7%) 11:28:00 INFO - TinderboxPrint: CPU user
1,206.8 (12.6%) 11:28:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:28:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117186560; Read time: 0; Write time: 120452 11:28:00 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291045376; Read time: 8; Write time: 300136 11:28:01 INFO - Running post-run listener: _upload_blobber_files 11:28:01 INFO - Blob upload gear active. 11:28:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:28:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:28:01 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'] 11:28:01 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 11:28:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:02 INFO - (blobuploader) - INFO - Done attempting. 11:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:06 INFO - (blobuploader) - INFO - Done attempting. 11:28:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:28:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:06 INFO - (blobuploader) - INFO - Done attempting. 11:28:06 INFO - (blobuploader) - INFO - Iteration through files over. 11:28:06 INFO - Return code: 0 11:28:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:28:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:28:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3868ca0f59e69044e065c9f1c86e743ce0b0dbac7c80ca5cdfd344dddf1c6a1d07d4d08a3831bca91b3f7cddf69d28c1f5d383ef0fe71b3271b5a98b906b0f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fd2669bd29a51336d4c80ddde277398a364d288cec88dc33bd7fe617a6016daa7756280ee80d6747e2377c4628394175cdc5d8f53bf851890846852c527fce79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f86b4d7edaf9392a8a53b53d64bd23f3f10bd3be121b710f5ed51c583a6feca8b9325da8cc37ef6d9eb1eccc50c1c8c9b1fae733489ede2a70af5a7ad56121e"} 11:28:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:28:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:28:06 INFO - Contents: 11:28:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3868ca0f59e69044e065c9f1c86e743ce0b0dbac7c80ca5cdfd344dddf1c6a1d07d4d08a3831bca91b3f7cddf69d28c1f5d383ef0fe71b3271b5a98b906b0f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fd2669bd29a51336d4c80ddde277398a364d288cec88dc33bd7fe617a6016daa7756280ee80d6747e2377c4628394175cdc5d8f53bf851890846852c527fce79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f86b4d7edaf9392a8a53b53d64bd23f3f10bd3be121b710f5ed51c583a6feca8b9325da8cc37ef6d9eb1eccc50c1c8c9b1fae733489ede2a70af5a7ad56121e"} 11:28:06 INFO - Running post-run listener: copy_logs_to_upload_dir 11:28:06 INFO - Copying logs to upload dir... 11:28:06 INFO - mkdir: /builds/slave/test/build/upload/logs 11:28:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.481641 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-23 11:28:06.562767) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:28:06.566089) ========= 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=920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3868ca0f59e69044e065c9f1c86e743ce0b0dbac7c80ca5cdfd344dddf1c6a1d07d4d08a3831bca91b3f7cddf69d28c1f5d383ef0fe71b3271b5a98b906b0f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fd2669bd29a51336d4c80ddde277398a364d288cec88dc33bd7fe617a6016daa7756280ee80d6747e2377c4628394175cdc5d8f53bf851890846852c527fce79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f86b4d7edaf9392a8a53b53d64bd23f3f10bd3be121b710f5ed51c583a6feca8b9325da8cc37ef6d9eb1eccc50c1c8c9b1fae733489ede2a70af5a7ad56121e"} build_url:https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/Q2MmjJ_pQQCnLS2lVObJZg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3868ca0f59e69044e065c9f1c86e743ce0b0dbac7c80ca5cdfd344dddf1c6a1d07d4d08a3831bca91b3f7cddf69d28c1f5d383ef0fe71b3271b5a98b906b0f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fd2669bd29a51336d4c80ddde277398a364d288cec88dc33bd7fe617a6016daa7756280ee80d6747e2377c4628394175cdc5d8f53bf851890846852c527fce79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f86b4d7edaf9392a8a53b53d64bd23f3f10bd3be121b710f5ed51c583a6feca8b9325da8cc37ef6d9eb1eccc50c1c8c9b1fae733489ede2a70af5a7ad56121e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:28:06.591151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:28:06.591507) ========= 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=920470bf432669ad7e3a5387000001ca-1471975630.23121-1556735814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:28:06.675425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:28:06.675755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:28:06.676036) ========= ========= Total master_lag: 0.16 =========