builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1471146504.47 results: success (0) buildid: 20160813191917 builduid: 64887afeba0c4d2b9b16c36471be4b99 revision: 4f30550d3edb5c60f07cea7259652722deccc094 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.474538) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.474981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.475338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.551751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.552057) ========= 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=745a4373a2a16df560f216e000000264-1471136438.88672-997877800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-13 20:48:25-- 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% 18.5M=0.001s 2016-08-13 20:48:25 (18.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128130 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.706523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.706876) ========= 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=745a4373a2a16df560f216e000000264-1471136438.88672-997877800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022104 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:24.760641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 20:48:24.761502) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4f30550d3edb5c60f07cea7259652722deccc094 --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 4f30550d3edb5c60f07cea7259652722deccc094 --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=745a4373a2a16df560f216e000000264-1471136438.88672-997877800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-13 20:48:25,695 truncating revision to first 12 chars 2016-08-13 20:48:25,695 Setting DEBUG logging. 2016-08-13 20:48:25,695 attempt 1/10 2016-08-13 20:48:25,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4f30550d3edb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 20:48:27,061 unpacking tar archive at: autoland-4f30550d3edb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.723170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 20:48:26.505624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:26.506455) ========= script_repo_revision: 4f30550d3edb5c60f07cea7259652722deccc094 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:26.507460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:26.507787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 20:48:26.520028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-13 20:48:26.520369) ========= /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=745a4373a2a16df560f216e000000264-1471136438.88672-997877800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:48:27 INFO - MultiFileLogger online at 20160813 20:48:27 in /builds/slave/test 20:48:27 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 20:48:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:48:27 INFO - {'append_to_log': False, 20:48:27 INFO - 'base_work_dir': '/builds/slave/test', 20:48:27 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:48:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:48:27 INFO - 'branch': 'Autoland-Non-PGO', 20:48:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:48:27 INFO - 'config_files': ('talos/linux_config.py',), 20:48:27 INFO - 'default_actions': ('clobber', 20:48:27 INFO - 'read-buildbot-config', 20:48:27 INFO - 'download-and-extract', 20:48:27 INFO - 'populate-webroot', 20:48:27 INFO - 'create-virtualenv', 20:48:27 INFO - 'install', 20:48:27 INFO - 'run-tests'), 20:48:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:48:27 INFO - 'download_minidump_stackwalk': True, 20:48:27 INFO - 'download_symbols': 'ondemand', 20:48:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:48:27 INFO - 'tooltool.py': '/tools/tooltool.py', 20:48:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:48:27 INFO - '/tools/misc-python/virtualenv.py')}, 20:48:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:48:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:48:27 INFO - 'installer_path': 'installer.exe', 20:48:27 INFO - 'log_level': 'info', 20:48:27 INFO - 'log_name': 'talos', 20:48:27 INFO - 'log_to_console': True, 20:48:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:48:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:48:27 INFO - 'opt_config_files': (), 20:48:27 INFO - 'pip_index': False, 20:48:27 INFO - 'sps_profile': False, 20:48:27 INFO - 'sps_profile_interval': 0, 20:48:27 INFO - 'suite': 'dromaeojs', 20:48:27 INFO - 'system_bits': '32', 20:48:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:48:27 INFO - 'title': 'talos-linux64-ix-032', 20:48:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:48:27 INFO - 'use_talos_json': True, 20:48:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:48:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:48:27 INFO - 'work_dir': 'build'} 20:48:27 INFO - [mozharness: 2016-08-14 03:48:27.545863Z] Running clobber step. 20:48:27 INFO - Running pre-action listener: _resource_record_pre_action 20:48:27 INFO - Running main action method: clobber 20:48:27 INFO - rmtree: /builds/slave/test/build 20:48:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:48:28 INFO - Running post-action listener: _resource_record_post_action 20:48:28 INFO - [mozharness: 2016-08-14 03:48:28.000747Z] Finished clobber step (success) 20:48:28 INFO - [mozharness: 2016-08-14 03:48:28.000849Z] Running read-buildbot-config step. 20:48:28 INFO - Running pre-action listener: _resource_record_pre_action 20:48:28 INFO - Running main action method: read_buildbot_config 20:48:28 INFO - Using buildbot properties: 20:48:28 INFO - { 20:48:28 INFO - "project": "", 20:48:28 INFO - "product": "firefox", 20:48:28 INFO - "script_repo_revision": "production", 20:48:28 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:48:28 INFO - "repository": "", 20:48:28 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 20:48:28 INFO - "buildid": "20160813191917", 20:48:28 INFO - "pgo_build": "False", 20:48:28 INFO - "basedir": "/builds/slave/test", 20:48:28 INFO - "buildnumber": 234, 20:48:28 INFO - "slavename": "talos-linux64-ix-032", 20:48:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:48:28 INFO - "platform": "ubuntu64_hw", 20:48:28 INFO - "scheduler": "tests-autoland-linux64-talos", 20:48:28 INFO - "branch": "autoland", 20:48:28 INFO - "repo_path": "integration/autoland", 20:48:28 INFO - "revision": "4f30550d3edb5c60f07cea7259652722deccc094", 20:48:28 INFO - "stage_platform": "linux64", 20:48:28 INFO - "builduid": "64887afeba0c4d2b9b16c36471be4b99", 20:48:28 INFO - "slavebuilddir": "test" 20:48:28 INFO - } 20:48:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:48:28 INFO - Running post-action listener: _resource_record_post_action 20:48:28 INFO - [mozharness: 2016-08-14 03:48:28.003254Z] Finished read-buildbot-config step (success) 20:48:28 INFO - [mozharness: 2016-08-14 03:48:28.003342Z] Running download-and-extract step. 20:48:28 INFO - Running pre-action listener: _resource_record_pre_action 20:48:28 INFO - Running main action method: download_and_extract 20:48:28 INFO - mkdir: /builds/slave/test/build/tests 20:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:28 INFO - trying https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:48:28 INFO - Downloading https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:28 INFO - Downloaded 1361 bytes. 20:48:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:48:28 INFO - Using the following test package requirements: 20:48:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:48:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:48:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:48:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'jsshell-linux-x86_64.zip'], 20:48:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:48:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:48:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:48:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:48:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:48:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:48:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:48:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:28 INFO - trying https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:48:28 INFO - Downloading https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:29 INFO - Downloaded 20265526 bytes. 20:48:29 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 20:48:33 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 20:48:33 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')]} 20:48:33 INFO - trying https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:48:33 INFO - Downloading https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:34 INFO - Downloaded 20265526 bytes. 20:48:34 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 20:48: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')]} 20:48:39 INFO - trying https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:48:39 INFO - Downloading https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:40 INFO - Downloaded 14413719 bytes. 20:48:40 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 20:48:40 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')]} 20:48:40 INFO - trying https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:48:40 INFO - Downloading https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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 20:48:41 INFO - Downloaded 55623587 bytes. 20:48:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:48:41 INFO - mkdir: /builds/slave/test/properties 20:48:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:48:41 INFO - Writing to file /builds/slave/test/properties/build_url 20:48:41 INFO - Contents: 20:48:41 INFO - build_url:https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:48:43 INFO - Running post-action listener: _resource_record_post_action 20:48:43 INFO - Running post-action listener: set_extra_try_arguments 20:48:43 INFO - [mozharness: 2016-08-14 03:48:43.205622Z] Finished download-and-extract step (success) 20:48:43 INFO - [mozharness: 2016-08-14 03:48:43.205846Z] Running populate-webroot step. 20:48:43 INFO - Running pre-action listener: _resource_record_pre_action 20:48:43 INFO - Running main action method: populate_webroot 20:48:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:48:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:48:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:48:43 INFO - '--tppagecycles', 20:48:43 INFO - '7'], 20:48:43 INFO - 'tests': ['tsvgm']}}, 20:48:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:48:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:48:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:48:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:48:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['damp', 'tps']}, 20:48:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'tests': ['damp', 'tps']}, 20:48:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['dromaeo_dom']}, 20:48:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:48:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['basic_compositor_video']}, 20:48:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:48:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['a11yr', 20:48:43 INFO - 'ts_paint', 20:48:43 INFO - 'tpaint', 20:48:43 INFO - 'sessionrestore', 20:48:43 INFO - 'sessionrestore_no_auto_restore', 20:48:43 INFO - 'tabpaint']}, 20:48:43 INFO - 'other-e10s': {'tests': ['a11yr', 20:48:43 INFO - 'ts_paint', 20:48:43 INFO - 'tpaint', 20:48:43 INFO - 'sessionrestore', 20:48:43 INFO - 'sessionrestore_no_auto_restore', 20:48:43 INFO - 'tabpaint']}, 20:48:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:48:43 INFO - 'ts_paint', 20:48:43 INFO - 'tpaint', 20:48:43 INFO - 'sessionrestore', 20:48:43 INFO - 'sessionrestore_no_auto_restore', 20:48:43 INFO - 'tabpaint']}, 20:48:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:48:43 INFO - 'ts_paint', 20:48:43 INFO - 'tpaint', 20:48:43 INFO - 'sessionrestore', 20:48:43 INFO - 'sessionrestore_no_auto_restore', 20:48:43 INFO - 'tabpaint']}, 20:48:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['a11yr', 20:48:43 INFO - 'ts_paint', 20:48:43 INFO - 'tpaint', 20:48:43 INFO - 'sessionrestore', 20:48:43 INFO - 'sessionrestore_no_auto_restore', 20:48:43 INFO - 'tabpaint']}, 20:48:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['a11yr', 20:48:43 INFO - 'ts_paint', 20:48:43 INFO - 'tpaint', 20:48:43 INFO - 'sessionrestore', 20:48:43 INFO - 'sessionrestore_no_auto_restore', 20:48:43 INFO - 'tabpaint']}, 20:48:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['tsvgx', 20:48:43 INFO - 'tsvgr_opacity', 20:48:43 INFO - 'tart', 20:48:43 INFO - 'tscrollx', 20:48:43 INFO - 'cart']}, 20:48:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:48:43 INFO - 'tsvgr_opacity', 20:48:43 INFO - 'tart', 20:48:43 INFO - 'tscrollx', 20:48:43 INFO - 'cart']}, 20:48:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'talos_options': ['--disable-e10s'], 20:48:43 INFO - 'tests': ['tp5o']}, 20:48:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'tests': ['tp5o']}, 20:48:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'talos_options': ['--disable-e10s', 20:48:43 INFO - '--xperf_path', 20:48:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:43 INFO - 'tests': ['tp5n']}, 20:48:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:43 INFO - 'talos_options': ['--xperf_path', 20:48:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:43 INFO - 'tests': ['tp5n']}}, 20:48:43 INFO - 'talos.zip': {'path': '', 20:48:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:48:43 INFO - Running post-action listener: _resource_record_post_action 20:48:43 INFO - [mozharness: 2016-08-14 03:48:43.225616Z] Finished populate-webroot step (success) 20:48:43 INFO - [mozharness: 2016-08-14 03:48:43.225703Z] Running create-virtualenv step. 20:48:43 INFO - Running pre-action listener: _resource_record_pre_action 20:48:43 INFO - Running main action method: create_virtualenv 20:48:43 INFO - Creating virtualenv /builds/slave/test/build/venv 20:48:43 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 20:48:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:48:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:48:43 INFO - Using real prefix '/usr' 20:48:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:48:43 INFO - Installing distribute.............................................................................................................................................................................................done. 20:48:45 INFO - Installing pip.................done. 20:48:45 INFO - Return code: 0 20:48:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:48:45 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')]} 20:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:45 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')]} 20:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:45 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:48:45 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 20:48:45 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 20:48:45 INFO - Using env: {'DISPLAY': ':0', 20:48:45 INFO - 'HOME': '/home/cltbld', 20:48:45 INFO - 'LANG': 'en_US.UTF-8', 20:48:45 INFO - 'LANGUAGE': 'en_US:en', 20:48:45 INFO - 'LOGNAME': 'cltbld', 20:48:45 INFO - 'MAIL': '/var/mail/cltbld', 20:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:45 INFO - 'MOZ_NO_REMOTE': '1', 20:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:45 INFO - 'NO_EM_RESTART': '1', 20:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:45 INFO - 'PWD': '/builds/slave/test', 20:48:45 INFO - 'SHELL': '/bin/bash', 20:48:45 INFO - 'SHLVL': '1', 20:48:45 INFO - 'TERM': 'linux', 20:48:45 INFO - 'TMOUT': '86400', 20:48:45 INFO - 'USER': 'cltbld', 20:48:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:45 INFO - '_': '/tools/buildbot/bin/python'} 20:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:46 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 20:48:46 INFO - Cleaning up... 20:48:46 INFO - Return code: 0 20:48:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:48:46 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')]} 20:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:46 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')]} 20:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:46 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:48:46 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 20:48:46 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 20:48:46 INFO - Using env: {'DISPLAY': ':0', 20:48:46 INFO - 'HOME': '/home/cltbld', 20:48:46 INFO - 'LANG': 'en_US.UTF-8', 20:48:46 INFO - 'LANGUAGE': 'en_US:en', 20:48:46 INFO - 'LOGNAME': 'cltbld', 20:48:46 INFO - 'MAIL': '/var/mail/cltbld', 20:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:46 INFO - 'MOZ_NO_REMOTE': '1', 20:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:46 INFO - 'NO_EM_RESTART': '1', 20:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:46 INFO - 'PWD': '/builds/slave/test', 20:48:46 INFO - 'SHELL': '/bin/bash', 20:48:46 INFO - 'SHLVL': '1', 20:48:46 INFO - 'TERM': 'linux', 20:48:46 INFO - 'TMOUT': '86400', 20:48:46 INFO - 'USER': 'cltbld', 20:48:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:46 INFO - '_': '/tools/buildbot/bin/python'} 20:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:46 INFO - Downloading/unpacking psutil>=3.1.1 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:48:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:48:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:48:48 INFO - Installing collected packages: psutil 20:48:48 INFO - Running setup.py install for psutil 20:48:48 INFO - building 'psutil._psutil_linux' extension 20:48:48 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 20:48:48 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 20:48:48 INFO - building 'psutil._psutil_posix' extension 20:48:48 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 20:48:48 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 20:48:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:48:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:48:48 INFO - Successfully installed psutil 20:48:48 INFO - Cleaning up... 20:48:48 INFO - Return code: 0 20:48:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:48: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')]} 20:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48: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')]} 20:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:48:48 INFO - Using env: {'DISPLAY': ':0', 20:48:48 INFO - 'HOME': '/home/cltbld', 20:48:48 INFO - 'LANG': 'en_US.UTF-8', 20:48:48 INFO - 'LANGUAGE': 'en_US:en', 20:48:48 INFO - 'LOGNAME': 'cltbld', 20:48:48 INFO - 'MAIL': '/var/mail/cltbld', 20:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:48 INFO - 'MOZ_NO_REMOTE': '1', 20:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:48 INFO - 'NO_EM_RESTART': '1', 20:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:48 INFO - 'PWD': '/builds/slave/test', 20:48:48 INFO - 'SHELL': '/bin/bash', 20:48:48 INFO - 'SHLVL': '1', 20:48:48 INFO - 'TERM': 'linux', 20:48:48 INFO - 'TMOUT': '86400', 20:48:48 INFO - 'USER': 'cltbld', 20:48:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:48 INFO - '_': '/tools/buildbot/bin/python'} 20:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:48:48 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 20:48:48 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 20:48:48 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 20:48:48 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 20:48:48 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 20:48:48 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 20:48:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:48:50 INFO - Installing collected packages: mozsystemmonitor 20:48:50 INFO - Running setup.py install for mozsystemmonitor 20:48:50 INFO - Successfully installed mozsystemmonitor 20:48:50 INFO - Cleaning up... 20:48:51 INFO - Return code: 0 20:48:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:48: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')]} 20:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48: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')]} 20:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:48:51 INFO - Using env: {'DISPLAY': ':0', 20:48:51 INFO - 'HOME': '/home/cltbld', 20:48:51 INFO - 'LANG': 'en_US.UTF-8', 20:48:51 INFO - 'LANGUAGE': 'en_US:en', 20:48:51 INFO - 'LOGNAME': 'cltbld', 20:48:51 INFO - 'MAIL': '/var/mail/cltbld', 20:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:51 INFO - 'MOZ_NO_REMOTE': '1', 20:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:51 INFO - 'NO_EM_RESTART': '1', 20:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:51 INFO - 'PWD': '/builds/slave/test', 20:48:51 INFO - 'SHELL': '/bin/bash', 20:48:51 INFO - 'SHLVL': '1', 20:48:51 INFO - 'TERM': 'linux', 20:48:51 INFO - 'TMOUT': '86400', 20:48:51 INFO - 'USER': 'cltbld', 20:48:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:51 INFO - '_': '/tools/buildbot/bin/python'} 20:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:51 INFO - Downloading/unpacking jsonschema==2.5.1 20:48:51 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 20:48:51 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 20:48:51 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 20:48:51 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 20:48:51 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 20:48:51 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 20:48:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:48:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:48:53 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 20:48:53 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 20:48:53 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 20:48:53 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 20:48:53 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 20:48:53 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 20:48:53 INFO - Downloading functools32-3.2.3-2.tar.gz 20:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:48:53 INFO - warning: no files found matching '*.txt' 20:48:53 INFO - no previously-included directories found matching 'build' 20:48:53 INFO - no previously-included directories found matching 'dist' 20:48:53 INFO - no previously-included directories found matching '.git*' 20:48:53 INFO - Installing collected packages: jsonschema, functools32 20:48:53 INFO - Running setup.py install for functools32 20:48:53 INFO - warning: no files found matching '*.txt' 20:48:53 INFO - no previously-included directories found matching 'build' 20:48:53 INFO - no previously-included directories found matching 'dist' 20:48:53 INFO - no previously-included directories found matching '.git*' 20:48:53 INFO - Successfully installed jsonschema functools32 20:48:53 INFO - Cleaning up... 20:48:53 INFO - Return code: 0 20:48:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:53 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:48:53 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 20:48:53 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 20:48:53 INFO - Using env: {'DISPLAY': ':0', 20:48:53 INFO - 'HOME': '/home/cltbld', 20:48:53 INFO - 'LANG': 'en_US.UTF-8', 20:48:53 INFO - 'LANGUAGE': 'en_US:en', 20:48:53 INFO - 'LOGNAME': 'cltbld', 20:48:53 INFO - 'MAIL': '/var/mail/cltbld', 20:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:53 INFO - 'MOZ_NO_REMOTE': '1', 20:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:53 INFO - 'NO_EM_RESTART': '1', 20:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:53 INFO - 'PWD': '/builds/slave/test', 20:48:53 INFO - 'SHELL': '/bin/bash', 20:48:53 INFO - 'SHLVL': '1', 20:48:53 INFO - 'TERM': 'linux', 20:48:53 INFO - 'TMOUT': '86400', 20:48:53 INFO - 'USER': 'cltbld', 20:48:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:53 INFO - '_': '/tools/buildbot/bin/python'} 20:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:48:53 INFO - Cleaning up... 20:48:53 INFO - Return code: 0 20:48:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:53 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:48:53 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 20:48:53 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 20:48:53 INFO - Using env: {'DISPLAY': ':0', 20:48:53 INFO - 'HOME': '/home/cltbld', 20:48:53 INFO - 'LANG': 'en_US.UTF-8', 20:48:53 INFO - 'LANGUAGE': 'en_US:en', 20:48:53 INFO - 'LOGNAME': 'cltbld', 20:48:53 INFO - 'MAIL': '/var/mail/cltbld', 20:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:53 INFO - 'MOZ_NO_REMOTE': '1', 20:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:53 INFO - 'NO_EM_RESTART': '1', 20:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:53 INFO - 'PWD': '/builds/slave/test', 20:48:53 INFO - 'SHELL': '/bin/bash', 20:48:53 INFO - 'SHLVL': '1', 20:48:53 INFO - 'TERM': 'linux', 20:48:53 INFO - 'TMOUT': '86400', 20:48:53 INFO - 'USER': 'cltbld', 20:48:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:53 INFO - '_': '/tools/buildbot/bin/python'} 20:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:54 INFO - Downloading/unpacking blobuploader==1.2.4 20:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:55 INFO - Downloading blobuploader-1.2.4.tar.gz 20:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:48:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:48:55 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 20:48:55 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 20:48:55 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 20:48:55 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 20:48:55 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 20:48:55 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 20:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:48:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:56 INFO - Downloading docopt-0.6.1.tar.gz 20:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:48:56 INFO - Installing collected packages: blobuploader, requests, docopt 20:48:56 INFO - Running setup.py install for blobuploader 20:48:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:48:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:48:56 INFO - Running setup.py install for requests 20:48:57 INFO - Running setup.py install for docopt 20:48:57 INFO - Successfully installed blobuploader requests docopt 20:48:57 INFO - Cleaning up... 20:48:57 INFO - Return code: 0 20:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:57 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')]} 20:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:57 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')]} 20:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:57 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:48:57 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 20:48:57 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 20:48:57 INFO - Using env: {'DISPLAY': ':0', 20:48:57 INFO - 'HOME': '/home/cltbld', 20:48:57 INFO - 'LANG': 'en_US.UTF-8', 20:48:57 INFO - 'LANGUAGE': 'en_US:en', 20:48:57 INFO - 'LOGNAME': 'cltbld', 20:48:57 INFO - 'MAIL': '/var/mail/cltbld', 20:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:57 INFO - 'MOZ_NO_REMOTE': '1', 20:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:57 INFO - 'NO_EM_RESTART': '1', 20:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:57 INFO - 'PWD': '/builds/slave/test', 20:48:57 INFO - 'SHELL': '/bin/bash', 20:48:57 INFO - 'SHLVL': '1', 20:48:57 INFO - 'TERM': 'linux', 20:48:57 INFO - 'TMOUT': '86400', 20:48:57 INFO - 'USER': 'cltbld', 20:48:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:57 INFO - '_': '/tools/buildbot/bin/python'} 20:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:48:57 INFO - Running setup.py (path:/tmp/pip-wWW863-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:48:57 INFO - Running setup.py (path:/tmp/pip-GPjob6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:48:57 INFO - Running setup.py (path:/tmp/pip-hltdUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:48:57 INFO - Running setup.py (path:/tmp/pip-onqkYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:48:57 INFO - Running setup.py (path:/tmp/pip-jSr6n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:48:57 INFO - Running setup.py (path:/tmp/pip-7xZB3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:48:57 INFO - Running setup.py (path:/tmp/pip-QR0byx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:48:58 INFO - Running setup.py (path:/tmp/pip-nOzjOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:48:58 INFO - Running setup.py (path:/tmp/pip-BKWsRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:48:58 INFO - Running setup.py (path:/tmp/pip-8tn_7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:48:58 INFO - Running setup.py (path:/tmp/pip-OU6OU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:48:58 INFO - Running setup.py (path:/tmp/pip-FDINj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:48:58 INFO - Running setup.py (path:/tmp/pip-6c7TFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:48:58 INFO - Running setup.py (path:/tmp/pip-xlZ7Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:58 INFO - Running setup.py (path:/tmp/pip-ceJ7ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:48:58 INFO - Running setup.py (path:/tmp/pip-WfHJFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:48:58 INFO - Running setup.py (path:/tmp/pip-CQXeEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:48:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:48:58 INFO - Running setup.py install for manifestparser 20:48:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:48:58 INFO - Running setup.py install for mozcrash 20:48:58 INFO - Running setup.py install for mozdebug 20:48:59 INFO - Running setup.py install for mozdevice 20:48:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Running setup.py install for mozfile 20:48:59 INFO - Running setup.py install for mozhttpd 20:48:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Running setup.py install for mozinfo 20:48:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Running setup.py install for mozInstall 20:48:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Running setup.py install for mozleak 20:48:59 INFO - Running setup.py install for mozlog 20:48:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Running setup.py install for moznetwork 20:48:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:48:59 INFO - Running setup.py install for mozprocess 20:49:00 INFO - Running setup.py install for mozprofile 20:49:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:49:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:49:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:49:00 INFO - Running setup.py install for mozrunner 20:49:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:49:00 INFO - Running setup.py install for mozscreenshot 20:49:00 INFO - Running setup.py install for moztest 20:49:00 INFO - Running setup.py install for mozversion 20:49:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:49:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:49:00 INFO - Cleaning up... 20:49:00 INFO - Return code: 0 20:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:00 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:49:00 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 20:49:00 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 20:49:00 INFO - Using env: {'DISPLAY': ':0', 20:49:00 INFO - 'HOME': '/home/cltbld', 20:49:00 INFO - 'LANG': 'en_US.UTF-8', 20:49:00 INFO - 'LANGUAGE': 'en_US:en', 20:49:00 INFO - 'LOGNAME': 'cltbld', 20:49:00 INFO - 'MAIL': '/var/mail/cltbld', 20:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:00 INFO - 'MOZ_NO_REMOTE': '1', 20:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:00 INFO - 'NO_EM_RESTART': '1', 20:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:00 INFO - 'PWD': '/builds/slave/test', 20:49:00 INFO - 'SHELL': '/bin/bash', 20:49:00 INFO - 'SHLVL': '1', 20:49:00 INFO - 'TERM': 'linux', 20:49:00 INFO - 'TMOUT': '86400', 20:49:00 INFO - 'USER': 'cltbld', 20:49:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:00 INFO - '_': '/tools/buildbot/bin/python'} 20:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:49:00 INFO - Running setup.py (path:/tmp/pip-vR20ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:49:00 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)) 20:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:49:00 INFO - Running setup.py (path:/tmp/pip-rldqin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:49:00 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)) 20:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:49:00 INFO - Running setup.py (path:/tmp/pip-FKcBL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:49:00 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)) 20:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:49:01 INFO - Running setup.py (path:/tmp/pip-0fCuyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:49:01 INFO - Running setup.py (path:/tmp/pip-wf1V8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:49:01 INFO - Running setup.py (path:/tmp/pip-3dKgGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:49:01 INFO - Running setup.py (path:/tmp/pip-LFaRXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:49:01 INFO - Running setup.py (path:/tmp/pip-gyvHUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:49:01 INFO - Running setup.py (path:/tmp/pip-ORXb1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:49:01 INFO - Running setup.py (path:/tmp/pip-y9t9T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:49:01 INFO - Running setup.py (path:/tmp/pip-skloua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:49:01 INFO - Running setup.py (path:/tmp/pip-ukLVOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:49:01 INFO - Running setup.py (path:/tmp/pip-EsDLOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:49:01 INFO - Running setup.py (path:/tmp/pip-UXc5yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:49:01 INFO - Running setup.py (path:/tmp/pip-SvDiJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:49:01 INFO - Running setup.py (path:/tmp/pip-gyOHlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:49:01 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)) 20:49:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:49:01 INFO - Running setup.py (path:/tmp/pip-hg2aQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:49:02 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)) 20:49:02 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)) 20:49:02 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)) 20:49:02 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)) 20:49:02 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)) 20:49:02 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)) 20:49:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:49:02 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 20:49:02 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 20:49:02 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 20:49:02 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 20:49:02 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 20:49:02 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 20:49:03 INFO - Downloading blessings-1.6.tar.gz 20:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:49:03 INFO - Installing collected packages: blessings 20:49:03 INFO - Running setup.py install for blessings 20:49:04 INFO - Successfully installed blessings 20:49:04 INFO - Cleaning up... 20:49:04 INFO - Return code: 0 20:49:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:49:04 INFO - Reading from file tmpfile_stdout 20:49:04 INFO - Current package versions: 20:49:04 INFO - argparse == 1.2.1 20:49:04 INFO - blessings == 1.6 20:49:04 INFO - blobuploader == 1.2.4 20:49:04 INFO - docopt == 0.6.1 20:49:04 INFO - functools32 == 3.2.3-2 20:49:04 INFO - jsonschema == 2.5.1 20:49:04 INFO - manifestparser == 1.1 20:49:04 INFO - mozInstall == 1.12 20:49:04 INFO - mozcrash == 0.17 20:49:04 INFO - mozdebug == 0.1 20:49:04 INFO - mozdevice == 0.48 20:49:04 INFO - mozfile == 1.2 20:49:04 INFO - mozhttpd == 0.7 20:49:04 INFO - mozinfo == 0.9 20:49:04 INFO - mozleak == 0.1 20:49:04 INFO - mozlog == 3.3 20:49:04 INFO - moznetwork == 0.27 20:49:04 INFO - mozprocess == 0.23 20:49:04 INFO - mozprofile == 0.28 20:49:04 INFO - mozrunner == 6.12 20:49:04 INFO - mozscreenshot == 0.1 20:49:04 INFO - mozsystemmonitor == 0.3 20:49:04 INFO - moztest == 0.7 20:49:04 INFO - mozversion == 1.4 20:49:04 INFO - psutil == 3.1.1 20:49:04 INFO - requests == 1.2.3 20:49:04 INFO - wsgiref == 0.1.2 20:49:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:49:04 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')]} 20:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:04 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')]} 20:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:04 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:49:04 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 20:49:04 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 20:49:04 INFO - Using env: {'DISPLAY': ':0', 20:49:04 INFO - 'HOME': '/home/cltbld', 20:49:04 INFO - 'LANG': 'en_US.UTF-8', 20:49:04 INFO - 'LANGUAGE': 'en_US:en', 20:49:04 INFO - 'LOGNAME': 'cltbld', 20:49:04 INFO - 'MAIL': '/var/mail/cltbld', 20:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:04 INFO - 'MOZ_NO_REMOTE': '1', 20:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:04 INFO - 'NO_EM_RESTART': '1', 20:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:04 INFO - 'PWD': '/builds/slave/test', 20:49:04 INFO - 'SHELL': '/bin/bash', 20:49:04 INFO - 'SHLVL': '1', 20:49:04 INFO - 'TERM': 'linux', 20:49:04 INFO - 'TMOUT': '86400', 20:49:04 INFO - 'USER': 'cltbld', 20:49:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:04 INFO - '_': '/tools/buildbot/bin/python'} 20:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 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)) 20:49:04 INFO - Cleaning up... 20:49:04 INFO - Return code: 0 20:49:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:49:04 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')]} 20:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:04 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')]} 20:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:04 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 0x7fa3c231ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, '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': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', '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 20:49:04 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 20:49:04 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 20:49:04 INFO - Using env: {'DISPLAY': ':0', 20:49:04 INFO - 'HOME': '/home/cltbld', 20:49:04 INFO - 'LANG': 'en_US.UTF-8', 20:49:04 INFO - 'LANGUAGE': 'en_US:en', 20:49:04 INFO - 'LOGNAME': 'cltbld', 20:49:04 INFO - 'MAIL': '/var/mail/cltbld', 20:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:04 INFO - 'MOZ_NO_REMOTE': '1', 20:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:04 INFO - 'NO_EM_RESTART': '1', 20:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:04 INFO - 'PWD': '/builds/slave/test', 20:49:04 INFO - 'SHELL': '/bin/bash', 20:49:04 INFO - 'SHLVL': '1', 20:49:04 INFO - 'TERM': 'linux', 20:49:04 INFO - 'TMOUT': '86400', 20:49:04 INFO - 'USER': 'cltbld', 20:49:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:04 INFO - '_': '/tools/buildbot/bin/python'} 20:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:49:04 INFO - Cleaning up... 20:49:04 INFO - Return code: 0 20:49:04 INFO - Running post-action listener: _resource_record_post_action 20:49:04 INFO - Running post-action listener: _start_resource_monitoring 20:49:04 INFO - Starting resource monitoring. 20:49:04 INFO - [mozharness: 2016-08-14 03:49:04.818932Z] Finished create-virtualenv step (success) 20:49:04 INFO - [mozharness: 2016-08-14 03:49:04.819377Z] Running install step. 20:49:04 INFO - Running pre-action listener: _resource_record_pre_action 20:49:04 INFO - Running main action method: install 20:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:49:05 INFO - Reading from file tmpfile_stdout 20:49:05 INFO - Detecting whether we're running mozinstall >=1.0... 20:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:49:05 INFO - Reading from file tmpfile_stdout 20:49:05 INFO - Output received: 20:49:05 INFO - Usage: mozinstall [options] installer 20:49:05 INFO - Options: 20:49:05 INFO - -h, --help show this help message and exit 20:49:05 INFO - -d DEST, --destination=DEST 20:49:05 INFO - Directory to install application into. [default: 20:49:05 INFO - "/builds/slave/test"] 20:49:05 INFO - --app=APP Application being installed. [default: firefox] 20:49:05 INFO - mkdir: /builds/slave/test/build/application 20:49:05 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'] 20:49:05 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 20:49:21 INFO - Reading from file tmpfile_stdout 20:49:21 INFO - Output received: 20:49:21 INFO - /builds/slave/test/build/application/firefox/firefox 20:49:21 INFO - Running post-action listener: _resource_record_post_action 20:49:21 INFO - [mozharness: 2016-08-14 03:49:21.144858Z] Finished install step (success) 20:49:21 INFO - [mozharness: 2016-08-14 03:49:21.145105Z] Running run-tests step. 20:49:21 INFO - Running pre-action listener: _resource_record_pre_action 20:49:21 INFO - Running main action method: run_tests 20:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:49:21 INFO - Python 2.7.3 20:49:21 INFO - Return code: 0 20:49:21 INFO - grabbing minidump binary from tooltool 20:49:21 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')]} 20:49:21 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 0x1b74090>, '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 0x1b779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:49:21 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 20:49:21 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 20:49:21 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 20:49:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:49:21 INFO - Return code: 0 20:49:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:49:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:49:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:49:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:49:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:49:21 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/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 20:49:21 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/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 20:49:21 INFO - Using env: {'DISPLAY': ':0', 20:49:21 INFO - 'HOME': '/home/cltbld', 20:49:21 INFO - 'LANG': 'en_US.UTF-8', 20:49:21 INFO - 'LANGUAGE': 'en_US:en', 20:49:21 INFO - 'LOGNAME': 'cltbld', 20:49:21 INFO - 'MAIL': '/var/mail/cltbld', 20:49:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:49:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:21 INFO - 'MOZ_NO_REMOTE': '1', 20:49:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:49:21 INFO - 'NO_EM_RESTART': '1', 20:49:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:21 INFO - 'PWD': '/builds/slave/test', 20:49:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:49:21 INFO - 'SHELL': '/bin/bash', 20:49:21 INFO - 'SHLVL': '1', 20:49:21 INFO - 'TERM': 'linux', 20:49:21 INFO - 'TMOUT': '86400', 20:49:21 INFO - 'USER': 'cltbld', 20:49:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1471136438.88672-997877800', 20:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:21 INFO - '_': '/tools/buildbot/bin/python'} 20:49:21 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/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 20:49:21 INFO - mozversion application_buildid: 20160813191917 20:49:21 INFO - mozversion application_changeset: 4f30550d3edb5c60f07cea7259652722deccc094 20:49:21 INFO - mozversion application_display_name: Nightly 20:49:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:49:21 INFO - mozversion application_name: Firefox 20:49:21 INFO - mozversion application_remotingname: firefox 20:49:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:49:21 INFO - mozversion application_vendor: Mozilla 20:49:21 INFO - mozversion application_version: 51.0a1 20:49:21 INFO - mozversion platform_buildid: 20160813191917 20:49:21 INFO - mozversion platform_changeset: 4f30550d3edb5c60f07cea7259652722deccc094 20:49:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:49:21 INFO - mozversion platform_version: 51.0a1 20:49:21 INFO - using testdate: 1471146561 20:49:21 INFO - actual date: 1471146561 20:49:21 INFO - starting webserver on 'localhost:49710' 20:49:21 INFO - SUITE-START | Running 2 tests 20:49:21 INFO - TEST-START | dromaeo_css 20:49:21 INFO - operating with platform_type : linux_ 20:49:21 INFO - Initialising browser for dromaeo_css test... 20:49:21 INFO - TEST-INFO | started process 28920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQk6_N9/profile http://localhost:49710/getInfo.html) 20:49:26 INFO - PROCESS | 28920 | __metrics Screen width/height:1600/1200 20:49:26 INFO - PROCESS | 28920 | colorDepth:24 20:49:26 INFO - PROCESS | 28920 | Browser inner width/height: 1024/697 20:49:26 INFO - PROCESS | 28920 | __metrics 20:49:27 INFO - PROCESS | 28920 | 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" 20:49:27 INFO - PROCESS | 28920 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:49:28 INFO - TEST-INFO | 28920: exit 0 20:49:28 INFO - Browser initialized. 20:49:28 INFO - Running cycle 1/1 for dromaeo_css test... 20:49:28 INFO - TEST-INFO | started process 29002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQk6_N9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:49:40 INFO - PROCESS | 29002 | RSS: Main: 157376512 20:49:40 INFO - PROCESS | 29002 | 20:50:31 INFO - PROCESS | 29002 | 1471146631563 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] 20:52:45 INFO - PROCESS | 29002 | Cycle 1(1): loaded http://localhost:49710/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49710/tests/dromaeo/cssquery-ext.html) 20:52:46 INFO - PROCESS | 29002 | RSS: Main: 229990400 20:52:46 INFO - PROCESS | 29002 | 20:55:49 INFO - PROCESS | 29002 | Cycle 1(1): loaded http://localhost:49710/tests/dromaeo/cssquery-ext.html (next: http://localhost:49710/tests/dromaeo/cssquery-jquery.html) 20:55:50 INFO - PROCESS | 29002 | RSS: Main: 243277824 20:55:50 INFO - PROCESS | 29002 | 20:58:52 INFO - PROCESS | 29002 | Cycle 1(1): loaded http://localhost:49710/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49710/tests/dromaeo/cssquery-mootools.html) 20:58:53 INFO - PROCESS | 29002 | RSS: Main: 186150912 20:58:53 INFO - PROCESS | 29002 | 21:01:55 INFO - PROCESS | 29002 | Cycle 1(1): loaded http://localhost:49710/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49710/tests/dromaeo/cssquery-prototype.html) 21:01:55 INFO - PROCESS | 29002 | RSS: Main: 188010496 21:01:55 INFO - PROCESS | 29002 | 21:04:59 INFO - PROCESS | 29002 | Cycle 1(1): loaded http://localhost:49710/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49710/tests/dromaeo/cssquery-yui.html) 21:04:59 INFO - PROCESS | 29002 | RSS: Main: 189382656 21:04:59 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | Cycle 1(1): loaded http://localhost:49710/tests/dromaeo/cssquery-yui.html (next: http://localhost:49710/tests/dromaeo/cssquery-dojo.html) 21:08:03 INFO - PROCESS | 29002 | RSS: Main: 278265856 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | __start_tp_report 21:08:03 INFO - PROCESS | 29002 | _x_x_mozilla_page_load 21:08:03 INFO - PROCESS | 29002 | _x_x_mozilla_page_load_details 21:08:03 INFO - PROCESS | 29002 | |i|pagename|runs| 21:08:03 INFO - PROCESS | 29002 | |0;dojo.html;2692.8653567321635;2707.5532537131376;2725.1688235088295;2741;2748.615193872858;4737.715737055779;4803.663743537953;4805.231163013918;4845.563899249067;4857.51424857514;4673.6027437667835;4742.573168414842;4766.523347665232;4783.473817880031;4836.371271734678;4377.321515165147;4399.472063352387;4443.977780111095;4494.325851122325;4572.062727140945;4446.399736035626;4535.274356103024;4540.910181556419;4556.111558246143;4590.242609969351;4345.565443455661;4376.627986621141;4378.759168245745;4387.122575484916;4393.494748103945;4382.978085109554;4387.903024243939;4392.34114882767;4422.292433210703;4442.244818380851;4323.65410767141;4354.825806967718;4361.6074553290355;4418.668599855024;4441.800118994653;4759.714417134983;4775.880602984918;4803.471618122004;4871;4883.3651625288485;5164.715940623264;5184.662996905189;5196.558292545138;5243.344581927259;5244.947550524484;4984.90030199394;5131.4098878629065;5230.34620672416;5238.1618940969265;5289.656172348785;4899.926501102486;4928.039032388721;4932.802687892516;4933.45731969483;4944.208926571803;5125.56432703217;5412.107002344648;5426.240326354314;5426.593005524523;5427.023135835509;5030.446650868402;5037.269595908646;5040.395152581714;5120.436751957282;5162.716050617177;5189.455107213764;5212.582993360522;5222.947770522323;5260.789568417221;5269.525742683177;4944.975275123601;5146.897062058738;5167.948320516822;5168.61235407346;5206.167013277857;5007.6494645375205;5011.348524691767;5061.31672224245;5111.948880511221;5164.1995490699;4396.702972623084;4402.119576084796;4406.140802543538;4412.448443944507;4445.288753799441;3803.030227292023;3844.231153769257;3877.9030524236555;3887.1642596841248;3904.648581627667;4364.345348197796;4402.9559704402545;4449.7997590108525;4465.553444655508;4518.932216016762;5220.504052115043;5252.553532949666;5255.500727430888;5259.737013149327;5268;4474.574915383034;4481.551844815493;4481.865544033684;4509.503954564995;4520.61574766142;4532.5694059064335;4650;4679.883002924954;4696.365990591226;4763.190257656207;4886.682365646222;4896.608271338356;4899.681520701143;4899.730514821576;4950.77721502526;5196.246544251138;5218.034663587248;5229.555487783581;5237.162054071483;5244.501772331622;4752.9287060694805;4823.614110871052;4831.830885918976;4864.659473836798;4925.187344088328;5125.154349532286;5143.048536020848;5148.9742551287;5149.433562308068;5203.713795741271;5195.870103247449;5204.245384419162;5218.165093585008;5219.399769026611;5221.973890130525;4919.7540122993;4961.280614310833;4973.602111831117;4997.275395067768;5066.82266120684;5033.974830125826;5036.194208926554;5038.319826823332;5044.1172794761505;5080.161773307363;4852.296417019583;4963.875903102451;5005.474425185449;5007.949920500894;5008;4997.075541024777;5018.749062546785;5028.1200789860895;5059.089363914531;5126.487351264844;4951;4955.727434990966;4961.603071754179;4979.477154898828;5006.224035274538 21:08:03 INFO - PROCESS | 29002 | |1;ext.html;552.1717423864204;561.278756797515;572.5905977226283;574.2592056247436;587.5270407322107;28141.85929070354;36938.44592331114;38397.61602383975;38454.23091538171;42079;39253.80373098131;39648.801755991255;39735.403968940416;39874.60125398752;39895;7504.51220670656;7549.698012079511;7612.581308028056;7639.923600764005;7642.5796581188015;7410.481266311361;9417.199538039275;9669.274804389664;9678.322517423783;10038.949805250964;9920.751981200492;10014.148797352234;10017.499125043754;10024.19806415485;10027.899721002806;9796.951015244913;9858.408495490221;9868.21054315653;9874.506274686237;9876.753081172992;9741.123298903132;9775.90224097757;9795.755106122404;9816.165625921734;9821.312508124434;37123.62876371229;37408.62591374078;37414.25171496582;37477.81261093677;37484.25031499382;2876.295307649639;2953.7784666150123;3004.549317602377;3136.758483551207;3307.057488615757;27924;28015.719842801514;28369.858150709322;28649.856750716113;30174.0947771565;3187.474066778979;3275.819829909354;3353.4634458486526;3362.1762668146216;3449.6377880322707;249035;249960;250256;250344;250831;52361.21458178131;52925;52929;53011.20483192755;53033.46966530285;31868.203294917814;32595.83702081522;32783.50824737631;34293.314133717184;34489;12831.871681283254;12946.352682365845;12996.155249908727;13020.47918083285;13031.869681303066;9223.76940576491;9542.90457095434;10014.198864091;10166.339187952759;10177.84733229002;16824.915875420545;17278.30886764515;17450.91274543619;17520.123993800258;17612.295508179785;6685.298043705438;6717.227518835299;6739.506382638455;6848.657567121723;6853.897191542131;788.3574886467511;819.3772732723054;912.2473958983733;938.394735395666;939.112538650982;27001;27019.1894243173;27235.86382068077;27563.173104806887;27921.30196745057;926.4117285523741;943.7404713703786;946.342292106979;973.9610415583297;1002.1932344462778;13487.865121348661;14283.92858035724;14591.270436478133;14677.706445871023;14776;377594;383107;384151;385594;385996;47378.76310618425;47804;47826;47891.76054119707;47943.52056479391;1000.2944978811255;1139.5954436175039;1164.2025212729307;1186.300082951063;1193.8089905615059;25673.743262567135;28322.602811347264;28789.712102878704;29144.336906094923;29226.41547169087;40393.192136156526;40809.387859181545;40835.79582102071;40880.59119408887;40919.181616366914;304484;306191;306838;308063;308150;24082.759172408052;24090.63864042076;25137.87431062833;25168.74831251664;26235.277650023178;38377.6162238374;38683.80658096691;38928;39088;39222.803885980386;33100.71086493559;33189.66810331962;33314.66685333115;33360.666393335756;33407;32558.67441325651;32654.34691306208;33362.33275334528;33689.494657580646;33771.83114084414;33314;33696.831515843245;33850.153746156546;33952.490712639825;34239.31521369509;28178.2955426116;30898.382032359677;30943.226419339695;30999;31275.530867036556;23794.643080354155;24108.638370424105;24197.395065123514;24426.75573244245;24483.265502034967 21:08:03 INFO - PROCESS | 29002 | |2;jquery.html;354.24015486780837;371.29639333463086;372.8266356144392;375.1072447574772;390.3013605645894;12837.743245135092;13138.934305328472;15150.393984240618;16407;16471.83528164721;14129.858701412983;17789.288428462878;18598.721019184723;18691.252349905986;18698.065096745144;5751.309842818868;5928;5933.673647949361;6051.2133422655;6066.908996365058;4125.257453658341;6828.590284582916;7106.360427561518;7204.171520275157;7307.086614173229;7023.543469674481;7188.9640551797165;7255.74604888829;7265.636718164097;7270.563766174047;6886;7171.211166771651;7227.060482137341;7249.057622509093;7258.709651613929;6959.6868140933775;6995.685194166274;7003.3346832050875;7007.124109486314;7015.298470152995;22237.666435003488;23099.76900230993;23265.76734232653;23422.414439638975;23597.528049439086;1897.943061708151;2078.210280093555;2117.4918019675165;2139.0374331550865;2191.386411804697;14440;14686.485972990895;14859.108453492825;14929.850701492955;15117.319720612599;1865.710814823691;1902.2105826082159;1904.1241029126618;1941.4078705994666;1963.9410817675493;53913.46086539124;76407.61796190984;77766;78184.60907695482;80370.59814700947;15527.922360388126;16634;16935.322587096623;16953.83046169547;16968.915155424143;28710;28800.855995720307;28832.423351532852;28876.85561572221;28972.710272897424;8528.658853645784;8543.487390756574;8607.225349718556;8824.382293239412;8887.955560222286;6896.862062758717;6899.413549848319;6939.861202775916;7140.036095127195;7161.713531458683;8268.958655206685;8343.916560834436;8562.571871406404;8643.438176518506;8723.258523025486;3047.6038115044903;3223.2908760072746;3336.849841757127;3454.0434476526266;3467.7225821934185;756.76162008967;783.0368646564757;872.4634349874781;941.9340646154841;947.2280091725222;16705.33178672864;16893.83106168947;17560.38538651141;17592.824071759376;18161.545961350806;823.7446391618618;851.5486792000249;856.7130011446111;889.3107841422819;903.1961554216753;8955.910440895508;9324.533773311307;10152.390856548483;10283.331583447052;10395.272330936914;271349;276388;276660;377847;379900;80764;84926.57536712277;85102;86194;86288;894.9149830766066;899.5547204133865;932.2588542109039;933.1788026536605;935.6631612619451;14761.261936903327;15905.204739763198;16002.919985399998;16097.839021609634;16982.74525882088;35676.64323356733;39073.609263907;39445;39933.80033099932;41369;50005.74997124991;50068;50248.24627630515;51389.7430512845;53364;7585.165631780389;7708.267714567107;7942.960285198537;8048.476849004796;8088.191180881865;9121.954390228006;11565.190436669352;11693.415329233674;11858.881411185777;12539.749205015665;10180.898191017995;10198.847017294598;10544.52549635253;10913.454327283764;11021.283616564897;5663.631863928831;9108.316876234441;10615.416152111708;10899.782004360028;11117.777644447227;9870.901290986998;10020.849687254551;10427.322224055411;10661.307015043998;10759.623413180501;7835.804104897423;7881.763547093597;8045.758627241192;8099.595020249082;8134.674613015413;8386.580670966548;9715.659951901649;9854.802903942025;10668.573257069631;10793.784124317626 21:08:03 INFO - PROCESS | 29002 | |3;mootools.html;1353.5803900790752;1393.8048673185754;1408.7534681430748;1617.6198593330557;1644.481988173726;7299.416046716263;7914.722984695537;7924.603769811508;7926.326262267707;7929.048514178292;6379.425851673349;7373.815654608624;7589.658465369058;7605.8478830423355;7845.450818442711;2152.924647637337;2183.759786423492;2184.0390228299575;2195.1877805212093;2195.6047911375945;1822.0798496759119;2174.847760656755;2201.2295696506253;2227;2230.431240033789;2097.6329142400095;2175.41263858758;2177.923772667957;2181.4764456530397;2182.508935489518;2162.5566758814407;2183.355910006544;2189.211883721859;2191.605511008026;2194.5281764420565;2157.8165855902266;2158.266189495563;2164.967525487119;2169.0456199272426;2169.511859831541;7659.234076592352;7827.9608601956625;7875.645595948196;7879.606019698992;7885.8028549286155;4250.744955302661;4360.41134446852;4367.934480982788;4369.169857727022;4373.978130109329;2831.5044867148167;2832.9150125496267;2963.3332500187503;2974.092901664991;2984.7015298470196;919.6137622198693;923.501309292981;939.9389039712397;958.0706714486937;975.7853272280158;10298.3820970742;10317.38095714252;10324.690259292232;10330.7417314567;10334.483275836179;3857.8071096445065;4081.20416518776;4217.641500472494;4220.85227017053;4234.216669916075;8826.45537031017;8908.242799361997;8913.197812196933;8920.73237802867;8929.955350223207;4404.537523560044;4416.933745993812;4424.13729322779;4428.180786554498;4429.689921705514;3969.206158768258;4044.4135600337786;4045.3325201342036;4050.331695270306;4050.3924411338535;3514.876979305712;3578.248567800739;3609.8556057757396;3654.250878569887;3668.137987572918;1070.3577853287966;1188.7979043562616;1210.0803389424102;1225.148521777374;1232.9321887296105;716.8817145171092;741.7700512841036;821.3142026407896;827.6399766101765;858.7976832434516;4972.345326185251;5018.447970723218;5032.169692000852;5116.951025039858;5119.104156772624;841.5750046226616;846.6867259114044;864.8789169516147;866.9176428239307;888.8044630181349;3534.0988048047584;3536.3457760314423;3552.786832790041;3591.6228795976567;3622.565292164957;9187.448753074837;9520.381175223589;9616.9038309616;9724.95137524308;9736.513174341397;9326.533673316442;9444.95277523608;9521.809563808685;9553.522323883779;9556.904430955601;7215.855682886313;7314.232005639544;7335.523190992569;7349.412047036224;7351.4853960223345;5030.522100400456;5160.251763494347;5189.065968125623;5206.114960456655;5411.134218525017;8450.535220562928;8637.309015278888;8718.607662655322;8798.516081615573;8881.866771998555;8621.396502244783;8645.351598630003;8697.739067827975;8726.956365218133;8781.824363512822;6644.767433139817;6735.360140786617;6808.455323574201;6809.080774095433;6810.114685091105;7433.628318584158;7487.064116985377;7490.101187857492;7491.812704682427;7502.812429689301;6748.561343512656;6809.421199198124;6810.727570897108;6816.761413350708;6978.755743549154;6604.207495100426;6616.801495955129;6633.568818026813;6675.365840245169;6679.465642748665;5878.853028674317;5912.645241285537;5936.970315148396;5958.40415958418;6048.758049678139;4174.2486352455635;4188.4136220928485;4213.074578094806;4246.256905041667;4434.312681534368;4305;4361.2367835628;4408.537103604075;4450.421445212101;4612.054528821516 21:08:03 INFO - PROCESS | 29002 | |4;prototype.html;289.095132236101;294.69793461701755;296.3835222736707;299.2996388451025;299.5058154045823;4673.135469938064;4788.419821458919;4811.783469743861;4826.251930950704;4863.343448634433;4712.882177945553;4784.952150478494;4791.520847915207;4806.735629540382;4812.133815913135;3625.1480901988143;3727.645873642013;3727.7390582659223;3807.733458657895;3824.560175579802;3464.3497724240974;3730.339998700579;3746.5316835395574;3749.8125093745202;3781.6596506314427;3750.6061863504347;3752.662260396564;3755.305268525318;3760.3043436964113;3767.077066118805;3752.6601324821067;3762.9623703762886;3764.209516001643;3764.3412402829395;3768.566614839301;3184.2357834119875;3214.9678503215137;3334.899953001414;3351.614564325085;3351.6815902489225;4646.001109761383;4647.279671650899;4685.929711054337;4688.859334219979;4690.460597031317;4295.603928723178;4301.010767523487;4308.78456077198;4309.310510318334;4326.6754993375625;4822.083804077214;4945;5029.748512574357;5032.144535428949;5062.265971434122;3647.7264205184715;3652.086978255436;3656.945145822815;3667.3582123128344;3667.523221981152;4997.675151115202;5047.772850221749;5207.3230480037355;5243.082460569423;5251.21685506682;3672.192117734094;3684.521012268388;3700.0379901225338;3704.592494825567;3712.1462063724953;3768.660820526166;3768.792716400624;3774.8678796241998;3777;3778.1499162688724;4260.339647354665;4264.296391095435;4280.422143010654;4282.785860707015;4293.141371725667;4809.470958194595;4998.275250088716;5029.471905449948;5054.721990290569;5074.3657042869645;1308.241220092344;1319.5645437005765;1319.9340032998505;1320.8216890719823;1327.8340207474066;818.4107442641289;847.9660813567389;860.1742327365799;861.875028120919;867.5922316511355;4001.3594426285085;4003.4195041718785;4009.8396064157105;4012.277789997828;4035.4753881995152;4544.977275113603;4570.337301091323;4592.448906131285;4600.309953506934;4627.236505976476;4003.7397569158493;4003.919921601552;4023.275810354106;4029.7582145071387;4035.3858456617586;2454.570450171213;2558.4883023395396;2751.9724802751716;2775.875085621152;2786.8885244590397;4918.754062296871;4929.309896614477;4938.4320803107385;4940.950590494049;4945.431275403303;5332.9733351333;5338.572914166857;5343.942582105839;5362.570994320445;5363.19552067193;4694.708955037392;4911.754412279443;4920.778564964585;4925.670069081256;4943.382077240345;5202.609804264771;5217.165253559412;5219.269302297757;5230.613887319787;5262.710550919736;4916.950830491793;5128.58971282304;5160.916207596297;5166.199239117943;5181;4725.952740472689;4797.760111994457;4878.0975519529;4939.97530012362;4950.084234416644;3615.6203598621764;3615.8011309378235;3619.873304434332;3631.4371272452813;3631.6368363163474;5187.610929180402;5222.451642577626;5231.848993221485;5234.764435600331;5235;4881;5042.647014708935;5043.319151914445;5045.772940217773;5100.38795344561;4985.177445721415;5019.548240658358;5028.924566131438;5044.344235249394;5044.646874718735;4970.080535101018;4980.203167493184;4984.626153038609;5023.824166154167;5026.547610715053;4802.351682522954;5035.144025515598;5039.84880453587;5052.797888084436;5059.848204553869;4967.329410529533;4975.507347795719;4977.900441991067;4980.601551875769;4982.850514484571 21:08:03 INFO - PROCESS | 29002 | |5;yui.html;626.7273735924873;629.6788637794725;632.3834261594949;697.1285892634207;738.3170567225316;12306.38468076596;13222.801657975138;13298.534551290695;13306.800397994039;13337.13308634938;13542.661433464144;13642.249676267802;13659.385327660255;13695.794563081561;13718.382672779724;612.8804883047808;726.9563826170447;752.6349720385622;759.4569882533987;770.118214644232;756.1342263108737;764.3884892086337;765.6478020110756;766.3486036868672;766.6741634805213;800.995995020027;801.3388954112851;801.7714951238898;802.1937952357872;802.6348011654683;649.4187702006677;787.4723934963588;794.880767884819;796.8884356190138;822.7655118291318;589.9233099697054;592.7895597063024;593.6289818863211;593.9220315128028;594.1088367448826;11460.426978651034;11541.942290288494;11612.129090318176;11633.709157271136;11637.243579167327;13242.404091815795;13932.303384830819;14247.501337453139;14270.785938210935;14322.856771432256;10951.507182176741;11095.167862410271;11151.721206969809;11257.268277561932;11501.769964600744;3328.517364982088;3358.932821343559;3430.3139372125424;3496.4790316212275;3500.912477188065;61547.6922615384;62527.68736156336;62914;63030.36969630291;67170.32829671739;10025.749356266151;10101.797964040825;10758.515866786014;10780.46097695112;10850.186236032328;18182.909085454754;18474.076296185405;18485;18506.722399164024;18511.90744046298;6180.412860778219;6620.66896655175;6783.762568310085;6815.659217039129;6835.863282734317;3541.6281290464644;3594.982025089858;3644.1071937375514;3657.5062366580173;3694.704423646102;2826.7314605112483;2932.0324292983264;2942.52919532878;2947.572601972702;2955.246412164884;473.7110362678763;488.64329039801146;489.8334566247493;492.48289296238806;493.2305603258928;503.6424138861376;524.6747016849502;528.5982653183531;537.4893850841638;539.4767075936336;6967.79096627102;7083.397911177504;7256.492045556761;7508.436867234979;7689.615519224017;513.6635503745053;518.932538769965;543.5081251467428;556.4268803132779;559.2841163310968;3373.6626337366065;3551.8756843510355;3577.731670124751;3649.0694872807794;3723.702103831687;55332.44667553354;56650;72306;103523.4823825891;103726;53507;65686;66050.33949660537;67180.32819671741;87538.12461875427;43529.34705979413;45372.77313613411;70279.2972070283;70439.29560704532;71092.64453677699;7882.369410447036;8947.776305592412;9060.592273347847;9088.454692718458;9190.816183676423;41126.79436602798;41699.55955020398;41734;42770.57229427666;43420.78289608658;56816.18205815329;57449.712751435974;60384;63677.681611591644;66695.66652166708;10946.288491248044;11171.553137874394;11257.831132533182;11276.267042642203;11645.184837061324;12021.218620789621;12337.198082124632;13373.598792036255;13381;13927.164370137823;11256.437178141225;11438.714032149262;11590.304581725124;12233.266004039786;12392.81410778821;10912.56349746033;10982.176336774613;10988;11718.824217636571;11729.061675066145;10755.247132700948;10990.670279891616;11073.114150868072;12341.753164936472;12375.75248495043;9395.530223488935;9440.95279523598;9504.714858554255;9620.95189524048;9982.550785214828;9981.650642227487;10203.591856325664;10212.948935255276;10284.485775711335;10416.895831041897 21:08:03 INFO - PROCESS | 29002 | __end_tp_report 21:08:03 INFO - PROCESS | 29002 | __start_cc_report 21:08:03 INFO - PROCESS | 29002 | _x_x_mozilla_cycle_collect,1113 21:08:03 INFO - PROCESS | 29002 | __end_cc_report 21:08:03 INFO - PROCESS | 29002 | __startTimestamp1471147683269__endTimestamp 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | ------- Summary: start ------- 21:08:03 INFO - PROCESS | 29002 | Number of tests: 6 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | [#0] dojo.html Cycles:165 Average:4785.56 Median:4928.04 stddev:504.56 (10.2%) stddev-sans-first:478.66 21:08:03 INFO - PROCESS | 29002 | Values: 2692.9 2707.6 2725.2 2741.0 2748.6 4737.7 4803.7 4805.2 4845.6 4857.5 4673.6 4742.6 4766.5 4783.5 4836.4 4377.3 4399.5 4444.0 4494.3 4572.1 4446.4 4535.3 4540.9 4556.1 4590.2 4345.6 4376.6 4378.8 4387.1 4393.5 4383.0 4387.9 4392.3 4422.3 4442.2 4323.7 4354.8 4361.6 4418.7 4441.8 4759.7 4775.9 4803.5 4871.0 4883.4 5164.7 5184.7 5196.6 5243.3 5244.9 4984.9 5131.4 5230.3 5238.2 5289.7 4899.9 4928.0 4932.8 4933.5 4944.2 5125.6 5412.1 5426.2 5426.6 5427.0 5030.4 5037.3 5040.4 5120.4 5162.7 5189.5 5212.6 5222.9 5260.8 5269.5 4945.0 5146.9 5167.9 5168.6 5206.2 5007.6 5011.3 5061.3 5111.9 5164.2 4396.7 4402.1 4406.1 4412.4 4445.3 3803.0 3844.2 3877.9 3887.2 3904.6 4364.3 4403.0 4449.8 4465.6 4518.9 5220.5 5252.6 5255.5 5259.7 5268.0 4474.6 4481.6 4481.9 4509.5 4520.6 4532.6 4650.0 4679.9 4696.4 4763.2 4886.7 4896.6 4899.7 4899.7 4950.8 5196.2 5218.0 5229.6 5237.2 5244.5 4752.9 4823.6 4831.8 4864.7 4925.2 5125.2 5143.0 5149.0 5149.4 5203.7 5195.9 5204.2 5218.2 5219.4 5222.0 4919.8 4961.3 4973.6 4997.3 5066.8 5034.0 5036.2 5038.3 5044.1 5080.2 4852.3 4963.9 5005.5 5007.9 5008.0 4997.1 5018.7 5028.1 5059.1 5126.5 4951.0 4955.7 4961.6 4979.5 5006.2 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | [#1] ext.html Cycles:180 Average:45811.27 Median:18525.84 stddev:83706.08 (451.8%) stddev-sans-first:83871.93 21:08:03 INFO - PROCESS | 29002 | Values: 552.2 561.3 572.6 574.3 587.5 28141.9 36938.4 38397.6 38454.2 42079.0 39253.8 39648.8 39735.4 39874.6 39895.0 7504.5 7549.7 7612.6 7639.9 7642.6 7410.5 9417.2 9669.3 9678.3 10038.9 9920.8 10014.1 10017.5 10024.2 10027.9 9797.0 9858.4 9868.2 9874.5 9876.8 9741.1 9775.9 9795.8 9816.2 9821.3 37123.6 37408.6 37414.3 37477.8 37484.3 2876.3 2953.8 3004.5 3136.8 3307.1 27924.0 28015.7 28369.9 28649.9 30174.1 3187.5 3275.8 3353.5 3362.2 3449.6 249035.0 249960.0 250256.0 250344.0 250831.0 52361.2 52925.0 52929.0 53011.2 53033.5 31868.2 32595.8 32783.5 34293.3 34489.0 12831.9 12946.4 12996.2 13020.5 13031.9 9223.8 9542.9 10014.2 10166.3 10177.8 16824.9 17278.3 17450.9 17520.1 17612.3 6685.3 6717.2 6739.5 6848.7 6853.9 788.4 819.4 912.2 938.4 939.1 27001.0 27019.2 27235.9 27563.2 27921.3 926.4 943.7 946.3 974.0 1002.2 13487.9 14283.9 14591.3 14677.7 14776.0 377594.0 383107.0 384151.0 385594.0 385996.0 47378.8 47804.0 47826.0 47891.8 47943.5 1000.3 1139.6 1164.2 1186.3 1193.8 25673.7 28322.6 28789.7 29144.3 29226.4 40393.2 40809.4 40835.8 40880.6 40919.2 304484.0 306191.0 306838.0 308063.0 308150.0 24082.8 24090.6 25137.9 25168.7 26235.3 38377.6 38683.8 38928.0 39088.0 39222.8 33100.7 33189.7 33314.7 33360.7 33407.0 32558.7 32654.3 33362.3 33689.5 33771.8 33314.0 33696.8 33850.2 33952.5 34239.3 28178.3 30898.4 30943.2 30999.0 31275.5 23794.6 24108.6 24197.4 24426.8 24483.3 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | [#2] jquery.html Cycles:180 Average:23869.07 Median:22747.13 stddev:53682.20 (236.0%) stddev-sans-first:53803.76 21:08:03 INFO - PROCESS | 29002 | Values: 354.2 371.3 372.8 375.1 390.3 12837.7 13138.9 15150.4 16407.0 16471.8 14129.9 17789.3 18598.7 18691.3 18698.1 5751.3 5928.0 5933.7 6051.2 6066.9 4125.3 6828.6 7106.4 7204.2 7307.1 7023.5 7189.0 7255.7 7265.6 7270.6 6886.0 7171.2 7227.1 7249.1 7258.7 6959.7 6995.7 7003.3 7007.1 7015.3 22237.7 23099.8 23265.8 23422.4 23597.5 1897.9 2078.2 2117.5 2139.0 2191.4 14440.0 14686.5 14859.1 14929.9 15117.3 1865.7 1902.2 1904.1 1941.4 1963.9 53913.5 76407.6 77766.0 78184.6 80370.6 15527.9 16634.0 16935.3 16953.8 16968.9 28710.0 28800.9 28832.4 28876.9 28972.7 8528.7 8543.5 8607.2 8824.4 8888.0 6896.9 6899.4 6939.9 7140.0 7161.7 8269.0 8343.9 8562.6 8643.4 8723.3 3047.6 3223.3 3336.8 3454.0 3467.7 756.8 783.0 872.5 941.9 947.2 16705.3 16893.8 17560.4 17592.8 18161.5 823.7 851.5 856.7 889.3 903.2 8955.9 9324.5 10152.4 10283.3 10395.3 271349.0 276388.0 276660.0 377847.0 379900.0 80764.0 84926.6 85102.0 86194.0 86288.0 894.9 899.6 932.3 933.2 935.7 14761.3 15905.2 16002.9 16097.8 16982.7 35676.6 39073.6 39445.0 39933.8 41369.0 50005.7 50068.0 50248.2 51389.7 53364.0 7585.2 7708.3 7943.0 8048.5 8088.2 9122.0 11565.2 11693.4 11858.9 12539.7 10180.9 10198.8 10544.5 10913.5 11021.3 5663.6 9108.3 10615.4 10899.8 11117.8 9870.9 10020.8 10427.3 10661.3 10759.6 7835.8 7881.8 8045.8 8099.6 8134.7 8386.6 9715.7 9854.8 10668.6 10793.8 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | [#3] mootools.html Cycles:180 Average:5045.65 Median:5139.68 stddev:2822.61 (54.9%) stddev-sans-first:2816.89 21:08:03 INFO - PROCESS | 29002 | Values: 1353.6 1393.8 1408.8 1617.6 1644.5 7299.4 7914.7 7924.6 7926.3 7929.0 6379.4 7373.8 7589.7 7605.8 7845.5 2152.9 2183.8 2184.0 2195.2 2195.6 1822.1 2174.8 2201.2 2227.0 2230.4 2097.6 2175.4 2177.9 2181.5 2182.5 2162.6 2183.4 2189.2 2191.6 2194.5 2157.8 2158.3 2165.0 2169.0 2169.5 7659.2 7828.0 7875.6 7879.6 7885.8 4250.7 4360.4 4367.9 4369.2 4374.0 2831.5 2832.9 2963.3 2974.1 2984.7 919.6 923.5 939.9 958.1 975.8 10298.4 10317.4 10324.7 10330.7 10334.5 3857.8 4081.2 4217.6 4220.9 4234.2 8826.5 8908.2 8913.2 8920.7 8930.0 4404.5 4416.9 4424.1 4428.2 4429.7 3969.2 4044.4 4045.3 4050.3 4050.4 3514.9 3578.2 3609.9 3654.3 3668.1 1070.4 1188.8 1210.1 1225.1 1232.9 716.9 741.8 821.3 827.6 858.8 4972.3 5018.4 5032.2 5117.0 5119.1 841.6 846.7 864.9 866.9 888.8 3534.1 3536.3 3552.8 3591.6 3622.6 9187.4 9520.4 9616.9 9725.0 9736.5 9326.5 9445.0 9521.8 9553.5 9556.9 7215.9 7314.2 7335.5 7349.4 7351.5 5030.5 5160.3 5189.1 5206.1 5411.1 8450.5 8637.3 8718.6 8798.5 8881.9 8621.4 8645.4 8697.7 8727.0 8781.8 6644.8 6735.4 6808.5 6809.1 6810.1 7433.6 7487.1 7490.1 7491.8 7502.8 6748.6 6809.4 6810.7 6816.8 6978.8 6604.2 6616.8 6633.6 6675.4 6679.5 5878.9 5912.6 5937.0 5958.4 6048.8 4174.2 4188.4 4213.1 4246.3 4434.3 4305.0 4361.2 4408.5 4450.4 4612.1 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | [#4] prototype.html Cycles:180 Average:4147.07 Median:4692.58 stddev:1206.08 (25.7%) stddev-sans-first:1174.18 21:08:03 INFO - PROCESS | 29002 | Values: 289.1 294.7 296.4 299.3 299.5 4673.1 4788.4 4811.8 4826.3 4863.3 4712.9 4785.0 4791.5 4806.7 4812.1 3625.1 3727.6 3727.7 3807.7 3824.6 3464.3 3730.3 3746.5 3749.8 3781.7 3750.6 3752.7 3755.3 3760.3 3767.1 3752.7 3763.0 3764.2 3764.3 3768.6 3184.2 3215.0 3334.9 3351.6 3351.7 4646.0 4647.3 4685.9 4688.9 4690.5 4295.6 4301.0 4308.8 4309.3 4326.7 4822.1 4945.0 5029.7 5032.1 5062.3 3647.7 3652.1 3656.9 3667.4 3667.5 4997.7 5047.8 5207.3 5243.1 5251.2 3672.2 3684.5 3700.0 3704.6 3712.1 3768.7 3768.8 3774.9 3777.0 3778.1 4260.3 4264.3 4280.4 4282.8 4293.1 4809.5 4998.3 5029.5 5054.7 5074.4 1308.2 1319.6 1319.9 1320.8 1327.8 818.4 848.0 860.2 861.9 867.6 4001.4 4003.4 4009.8 4012.3 4035.5 4545.0 4570.3 4592.4 4600.3 4627.2 4003.7 4003.9 4023.3 4029.8 4035.4 2454.6 2558.5 2752.0 2775.9 2786.9 4918.8 4929.3 4938.4 4941.0 4945.4 5333.0 5338.6 5343.9 5362.6 5363.2 4694.7 4911.8 4920.8 4925.7 4943.4 5202.6 5217.2 5219.3 5230.6 5262.7 4917.0 5128.6 5160.9 5166.2 5181.0 4726.0 4797.8 4878.1 4940.0 4950.1 3615.6 3615.8 3619.9 3631.4 3631.6 5187.6 5222.5 5231.8 5234.8 5235.0 4881.0 5042.6 5043.3 5045.8 5100.4 4985.2 5019.5 5028.9 5044.3 5044.6 4970.1 4980.2 4984.6 5023.8 5026.5 4802.4 5035.1 5039.8 5052.8 5059.8 4967.3 4975.5 4977.9 4980.6 4982.9 21:08:03 INFO - PROCESS | 29002 | 21:08:03 INFO - PROCESS | 29002 | [#5] yui.html Cycles:180 Average:16286.66 Median:43475.06 stddev:22105.47 (50.8%) stddev-sans-first:22136.21 21:08:03 INFO - PROCESS | 29002 | Values: 626.7 629.7 632.4 697.1 738.3 12306.4 13222.8 13298.5 13306.8 13337.1 13542.7 13642.2 13659.4 13695.8 13718.4 612.9 727.0 752.6 759.5 770.1 756.1 764.4 765.6 766.3 766.7 801.0 801.3 801.8 802.2 802.6 649.4 787.5 794.9 796.9 822.8 589.9 592.8 593.6 593.9 594.1 11460.4 11541.9 11612.1 11633.7 11637.2 13242.4 13932.3 14247.5 14270.8 14322.9 10951.5 11095.2 11151.7 11257.3 11501.8 3328.5 3358.9 3430.3 3496.5 3500.9 61547.7 62527.7 62914.0 63030.4 67170.3 10025.7 10101.8 10758.5 10780.5 10850.2 18182.9 18474.1 18485.0 18506.7 18511.9 6180.4 6620.7 6783.8 6815.7 6835.9 3541.6 3595.0 3644.1 3657.5 3694.7 2826.7 2932.0 2942.5 2947.6 2955.2 473.7 488.6 489.8 492.5 493.2 503.6 524.7 528.6 537.5 539.5 6967.8 7083.4 7256.5 7508.4 7689.6 513.7 518.9 543.5 556.4 559.3 3373.7 3551.9 3577.7 3649.1 3723.7 55332.4 56650.0 72306.0 103523.5 103726.0 53507.0 65686.0 66050.3 67180.3 87538.1 43529.3 45372.8 70279.3 70439.3 71092.6 7882.4 8947.8 9060.6 9088.5 9190.8 41126.8 41699.6 41734.0 42770.6 43420.8 56816.2 57449.7 60384.0 63677.7 66695.7 10946.3 11171.6 11257.8 11276.3 11645.2 12021.2 12337.2 13373.6 13381.0 13927.2 11256.4 11438.7 11590.3 12233.3 12392.8 10912.6 10982.2 10988.0 11718.8 11729.1 10755.2 10990.7 11073.1 12341.8 12375.8 9395.5 9441.0 9504.7 9621.0 9982.6 9981.7 10203.6 10212.9 10284.5 10416.9 21:08:03 INFO - PROCESS | 29002 | -------- Summary: end -------- 21:08:03 INFO - PROCESS | 29002 | 21:08:04 INFO - TEST-INFO | 29002: exit 0 21:08:04 INFO - TEST-OK | dromaeo_css | took 1122716ms 21:08:04 INFO - TEST-START | kraken 21:08:04 INFO - operating with platform_type : linux_ 21:08:04 INFO - Initialising browser for kraken test... 21:08:04 INFO - TEST-INFO | started process 29306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpantGex/profile http://localhost:49710/getInfo.html) 21:08:09 INFO - PROCESS | 29306 | __metrics Screen width/height:1600/1200 21:08:09 INFO - PROCESS | 29306 | colorDepth:24 21:08:09 INFO - PROCESS | 29306 | Browser inner width/height: 1024/697 21:08:09 INFO - PROCESS | 29306 | __metrics 21:08:10 INFO - PROCESS | 29306 | 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" 21:08:10 INFO - PROCESS | 29306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:08:11 INFO - TEST-INFO | 29306: exit 0 21:08:11 INFO - Browser initialized. 21:08:11 INFO - Running cycle 1/1 for kraken test... 21:08:11 INFO - TEST-INFO | started process 29389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpantGex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:08:23 INFO - PROCESS | 29389 | RSS: Main: 156876800 21:08:23 INFO - PROCESS | 29389 | 21:08:25 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49710/tests/kraken/driver.html?testName=audio-beat-detection) 21:08:26 INFO - PROCESS | 29389 | RSS: Main: 205029376 21:08:26 INFO - PROCESS | 29389 | 21:08:29 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49710/tests/kraken/driver.html?testName=audio-dft) 21:08:30 INFO - PROCESS | 29389 | RSS: Main: 195821568 21:08:30 INFO - PROCESS | 29389 | 21:08:33 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49710/tests/kraken/driver.html?testName=audio-fft) 21:08:34 INFO - PROCESS | 29389 | RSS: Main: 278003712 21:08:34 INFO - PROCESS | 29389 | 21:08:36 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49710/tests/kraken/driver.html?testName=audio-oscillator) 21:08:36 INFO - PROCESS | 29389 | RSS: Main: 187908096 21:08:36 INFO - PROCESS | 29389 | 21:08:39 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49710/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:08:39 INFO - PROCESS | 29389 | RSS: Main: 191737856 21:08:39 INFO - PROCESS | 29389 | 21:08:42 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49710/tests/kraken/driver.html?testName=imaging-darkroom) 21:08:43 INFO - PROCESS | 29389 | RSS: Main: 228683776 21:08:43 INFO - PROCESS | 29389 | 21:08:47 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49710/tests/kraken/driver.html?testName=imaging-desaturate) 21:08:47 INFO - PROCESS | 29389 | RSS: Main: 222273536 21:08:47 INFO - PROCESS | 29389 | 21:08:50 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49710/tests/kraken/driver.html?testName=json-parse-financial) 21:08:51 INFO - PROCESS | 29389 | RSS: Main: 225738752 21:08:51 INFO - PROCESS | 29389 | 21:08:52 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49710/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:08:53 INFO - PROCESS | 29389 | RSS: Main: 189034496 21:08:53 INFO - PROCESS | 29389 | 21:08:55 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:08:56 INFO - PROCESS | 29389 | RSS: Main: 196354048 21:08:56 INFO - PROCESS | 29389 | 21:08:58 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:08:58 INFO - PROCESS | 29389 | RSS: Main: 194011136 21:08:58 INFO - PROCESS | 29389 | 21:09:01 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:09:02 INFO - PROCESS | 29389 | RSS: Main: 188895232 21:09:02 INFO - PROCESS | 29389 | 21:09:05 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:09:05 INFO - PROCESS | 29389 | RSS: Main: 192106496 21:09:05 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | Cycle 1(1): loaded http://localhost:49710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49710/tests/kraken/driver.html?testName=ai-astar) 21:09:07 INFO - PROCESS | 29389 | RSS: Main: 243134464 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | __start_tp_report 21:09:07 INFO - PROCESS | 29389 | _x_x_mozilla_page_load 21:09:07 INFO - PROCESS | 29389 | _x_x_mozilla_page_load_details 21:09:07 INFO - PROCESS | 29389 | |i|pagename|runs| 21:09:07 INFO - PROCESS | 29389 | |0;ai-astar;108;114;115;114;109;114;114;115;115;116 21:09:07 INFO - PROCESS | 29389 | |1;audio-beat-detection;153;124;124;182;123;128;154;122;183;121 21:09:07 INFO - PROCESS | 29389 | |2;audio-dft;162;161;160;162;161;162;162;161;161;161 21:09:07 INFO - PROCESS | 29389 | |3;audio-fft;76;76;76;112;75;76;76;76;100;77 21:09:07 INFO - PROCESS | 29389 | |4;audio-oscillator;87;86;130;86;86;86;126;87;86;127 21:09:07 INFO - PROCESS | 29389 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;117 21:09:07 INFO - PROCESS | 29389 | |6;imaging-darkroom;146;148;145;146;147;147;147;146;146;146 21:09:07 INFO - PROCESS | 29389 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;94 21:09:07 INFO - PROCESS | 29389 | |8;json-parse-financial;64;71;63;62;62;65;63;63;64;63 21:09:07 INFO - PROCESS | 29389 | |9;json-stringify-tinderbox;67;67;66;67;66;67;66;66;65;67 21:09:07 INFO - PROCESS | 29389 | |10;stanford-crypto-aes;84;83;85;83;83;91;85;82;91;84 21:09:07 INFO - PROCESS | 29389 | |11;stanford-crypto-ccm;144;155;135;140;134;142;134;133;153;132 21:09:07 INFO - PROCESS | 29389 | |12;stanford-crypto-pbkdf2;175;176;181;172;171;171;172;171;171;171 21:09:07 INFO - PROCESS | 29389 | |13;stanford-crypto-sha256-iterative;68;75;68;68;67;67;67;68;69;68 21:09:07 INFO - PROCESS | 29389 | __end_tp_report 21:09:07 INFO - PROCESS | 29389 | __start_cc_report 21:09:07 INFO - PROCESS | 29389 | _x_x_mozilla_cycle_collect,1910 21:09:07 INFO - PROCESS | 29389 | __end_cc_report 21:09:07 INFO - PROCESS | 29389 | __startTimestamp1471147747932__endTimestamp 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | ------- Summary: start ------- 21:09:07 INFO - PROCESS | 29389 | Number of tests: 14 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:2.67 (2.3%) stddev-sans-first:2.00 21:09:07 INFO - PROCESS | 29389 | Values: 108.0 114.0 115.0 114.0 109.0 114.0 114.0 115.0 115.0 116.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:140.50 stddev:24.92 (17.7%) stddev-sans-first:26.07 21:09:07 INFO - PROCESS | 29389 | Values: 153.0 124.0 124.0 182.0 123.0 128.0 154.0 122.0 183.0 121.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 21:09:07 INFO - PROCESS | 29389 | Values: 162.0 161.0 160.0 162.0 161.0 162.0 162.0 161.0 161.0 161.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.97 (17.1%) stddev-sans-first:13.57 21:09:07 INFO - PROCESS | 29389 | Values: 76.0 76.0 76.0 112.0 75.0 76.0 76.0 76.0 100.0 77.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:86.00 stddev:20.02 (23.3%) stddev-sans-first:20.78 21:09:07 INFO - PROCESS | 29389 | Values: 87.0 86.0 130.0 86.0 86.0 86.0 126.0 87.0 86.0 127.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:09:07 INFO - PROCESS | 29389 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 21:09:07 INFO - PROCESS | 29389 | Values: 146.0 148.0 145.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:09:07 INFO - PROCESS | 29389 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.50 stddev:2.62 (4.1%) stddev-sans-first:2.78 21:09:07 INFO - PROCESS | 29389 | Values: 64.0 71.0 63.0 62.0 62.0 65.0 63.0 63.0 64.0 63.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 21:09:07 INFO - PROCESS | 29389 | Values: 67.0 67.0 66.0 67.0 66.0 67.0 66.0 66.0 65.0 67.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:3.25 (3.8%) stddev-sans-first:3.42 21:09:07 INFO - PROCESS | 29389 | Values: 84.0 83.0 85.0 83.0 83.0 91.0 85.0 82.0 91.0 84.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:141.00 stddev:8.32 (5.9%) stddev-sans-first:8.71 21:09:07 INFO - PROCESS | 29389 | Values: 144.0 155.0 135.0 140.0 134.0 142.0 134.0 133.0 153.0 132.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:172.00 stddev:3.31 (1.9%) stddev-sans-first:3.44 21:09:07 INFO - PROCESS | 29389 | Values: 175.0 176.0 181.0 172.0 171.0 171.0 172.0 171.0 171.0 171.0 21:09:07 INFO - PROCESS | 29389 | 21:09:07 INFO - PROCESS | 29389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:2.37 (3.5%) stddev-sans-first:2.51 21:09:07 INFO - PROCESS | 29389 | Values: 68.0 75.0 68.0 68.0 67.0 67.0 67.0 68.0 69.0 68.0 21:09:07 INFO - PROCESS | 29389 | -------- Summary: end -------- 21:09:07 INFO - PROCESS | 29389 | 21:09:09 INFO - TEST-INFO | 29389: exit 0 21:09:09 INFO - TEST-OK | kraken | took 64990ms 21:09:09 INFO - SUITE-END | took 1187s 21:09:09 INFO - Completed test suite (00:19:48) 21:09:09 INFO - javascript benchmark 21:09:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2692.8653567321635, 2707.5532537131376, 2725.1688235088295, 2741.0, 2748.615193872858, 4737.715737055779, 4803.663743537953, 4805.231163013918, 4845.563899249067, 4857.51424857514, 4673.6027437667835, 4742.573168414842, 4766.523347665232, 4783.473817880031, 4836.371271734678, 4377.321515165147, 4399.472063352387, 4443.977780111095, 4494.325851122325, 4572.062727140945, 4446.399736035626, 4535.274356103024, 4540.910181556419, 4556.111558246143, 4590.242609969351, 4345.565443455661, 4376.627986621141, 4378.759168245745, 4387.122575484916, 4393.494748103945, 4382.978085109554, 4387.903024243939, 4392.34114882767, 4422.292433210703, 4442.244818380851, 4323.65410767141, 4354.825806967718, 4361.6074553290355, 4418.668599855024, 4441.800118994653, 4759.714417134983, 4775.880602984918, 4803.471618122004, 4871.0, 4883.3651625288485, 5164.715940623264, 5184.662996905189, 5196.558292545138, 5243.344581927259, 5244.947550524484, 4984.90030199394, 5131.4098878629065, 5230.34620672416, 5238.1618940969265, 5289.656172348785, 4899.926501102486, 4928.039032388721, 4932.802687892516, 4933.45731969483, 4944.208926571803, 5125.56432703217, 5412.107002344648, 5426.240326354314, 5426.593005524523, 5427.023135835509, 5030.446650868402, 5037.269595908646, 5040.395152581714, 5120.436751957282, 5162.716050617177, 5189.455107213764, 5212.582993360522, 5222.947770522323, 5260.789568417221, 5269.525742683177, 4944.975275123601, 5146.897062058738, 5167.948320516822, 5168.61235407346, 5206.167013277857, 5007.6494645375205, 5011.348524691767, 5061.31672224245, 5111.948880511221, 5164.1995490699, 4396.702972623084, 4402.119576084796, 4406.140802543538, 4412.448443944507, 4445.288753799441, 3803.030227292023, 3844.231153769257, 3877.9030524236555, 3887.1642596841248, 3904.648581627667, 4364.345348197796, 4402.9559704402545, 4449.7997590108525, 4465.553444655508, 4518.932216016762, 5220.504052115043, 5252.553532949666, 5255.500727430888, 5259.737013149327, 5268.0, 4474.574915383034, 4481.551844815493, 4481.865544033684, 4509.503954564995, 4520.61574766142, 4532.5694059064335, 4650.0, 4679.883002924954, 4696.365990591226, 4763.190257656207, 4886.682365646222, 4896.608271338356, 4899.681520701143, 4899.730514821576, 4950.77721502526, 5196.246544251138, 5218.034663587248, 5229.555487783581, 5237.162054071483, 5244.501772331622, 4752.9287060694805, 4823.614110871052, 4831.830885918976, 4864.659473836798, 4925.187344088328, 5125.154349532286, 5143.048536020848, 5148.9742551287, 5149.433562308068, 5203.713795741271, 5195.870103247449, 5204.245384419162, 5218.165093585008, 5219.399769026611, 5221.973890130525, 4919.7540122993, 4961.280614310833, 4973.602111831117, 4997.275395067768, 5066.82266120684, 5033.974830125826, 5036.194208926554, 5038.319826823332, 5044.1172794761505, 5080.161773307363, 4852.296417019583, 4963.875903102451, 5005.474425185449, 5007.949920500894, 5008.0, 4997.075541024777, 5018.749062546785, 5028.1200789860895, 5059.089363914531, 5126.487351264844, 4951.0, 4955.727434990966, 4961.603071754179, 4979.477154898828, 5006.224035274538], "value": 4753.491022254249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.1717423864204, 561.278756797515, 572.5905977226283, 574.2592056247436, 587.5270407322107, 28141.85929070354, 36938.44592331114, 38397.61602383975, 38454.23091538171, 42079.0, 39253.80373098131, 39648.801755991255, 39735.403968940416, 39874.60125398752, 39895.0, 7504.51220670656, 7549.698012079511, 7612.581308028056, 7639.923600764005, 7642.5796581188015, 7410.481266311361, 9417.199538039275, 9669.274804389664, 9678.322517423783, 10038.949805250964, 9920.751981200492, 10014.148797352234, 10017.499125043754, 10024.19806415485, 10027.899721002806, 9796.951015244913, 9858.408495490221, 9868.21054315653, 9874.506274686237, 9876.753081172992, 9741.123298903132, 9775.90224097757, 9795.755106122404, 9816.165625921734, 9821.312508124434, 37123.62876371229, 37408.62591374078, 37414.25171496582, 37477.81261093677, 37484.25031499382, 2876.295307649639, 2953.7784666150123, 3004.549317602377, 3136.758483551207, 3307.057488615757, 27924.0, 28015.719842801514, 28369.858150709322, 28649.856750716113, 30174.0947771565, 3187.474066778979, 3275.819829909354, 3353.4634458486526, 3362.1762668146216, 3449.6377880322707, 249035.0, 249960.0, 250256.0, 250344.0, 250831.0, 52361.21458178131, 52925.0, 52929.0, 53011.20483192755, 53033.46966530285, 31868.203294917814, 32595.83702081522, 32783.50824737631, 34293.314133717184, 34489.0, 12831.871681283254, 12946.352682365845, 12996.155249908727, 13020.47918083285, 13031.869681303066, 9223.76940576491, 9542.90457095434, 10014.198864091, 10166.339187952759, 10177.84733229002, 16824.915875420545, 17278.30886764515, 17450.91274543619, 17520.123993800258, 17612.295508179785, 6685.298043705438, 6717.227518835299, 6739.506382638455, 6848.657567121723, 6853.897191542131, 788.3574886467511, 819.3772732723054, 912.2473958983733, 938.394735395666, 939.112538650982, 27001.0, 27019.1894243173, 27235.86382068077, 27563.173104806887, 27921.30196745057, 926.4117285523741, 943.7404713703786, 946.342292106979, 973.9610415583297, 1002.1932344462778, 13487.865121348661, 14283.92858035724, 14591.270436478133, 14677.706445871023, 14776.0, 377594.0, 383107.0, 384151.0, 385594.0, 385996.0, 47378.76310618425, 47804.0, 47826.0, 47891.76054119707, 47943.52056479391, 1000.2944978811255, 1139.5954436175039, 1164.2025212729307, 1186.300082951063, 1193.8089905615059, 25673.743262567135, 28322.602811347264, 28789.712102878704, 29144.336906094923, 29226.41547169087, 40393.192136156526, 40809.387859181545, 40835.79582102071, 40880.59119408887, 40919.181616366914, 304484.0, 306191.0, 306838.0, 308063.0, 308150.0, 24082.759172408052, 24090.63864042076, 25137.87431062833, 25168.74831251664, 26235.277650023178, 38377.6162238374, 38683.80658096691, 38928.0, 39088.0, 39222.803885980386, 33100.71086493559, 33189.66810331962, 33314.66685333115, 33360.666393335756, 33407.0, 32558.67441325651, 32654.34691306208, 33362.33275334528, 33689.494657580646, 33771.83114084414, 33314.0, 33696.831515843245, 33850.153746156546, 33952.490712639825, 34239.31521369509, 28178.2955426116, 30898.382032359677, 30943.226419339695, 30999.0, 31275.530867036556, 23794.643080354155, 24108.638370424105, 24197.395065123514, 24426.75573244245, 24483.265502034967], "value": 17133.74144196625, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.24015486780837, 371.29639333463086, 372.8266356144392, 375.1072447574772, 390.3013605645894, 12837.743245135092, 13138.934305328472, 15150.393984240618, 16407.0, 16471.83528164721, 14129.858701412983, 17789.288428462878, 18598.721019184723, 18691.252349905986, 18698.065096745144, 5751.309842818868, 5928.0, 5933.673647949361, 6051.2133422655, 6066.908996365058, 4125.257453658341, 6828.590284582916, 7106.360427561518, 7204.171520275157, 7307.086614173229, 7023.543469674481, 7188.9640551797165, 7255.74604888829, 7265.636718164097, 7270.563766174047, 6886.0, 7171.211166771651, 7227.060482137341, 7249.057622509093, 7258.709651613929, 6959.6868140933775, 6995.685194166274, 7003.3346832050875, 7007.124109486314, 7015.298470152995, 22237.666435003488, 23099.76900230993, 23265.76734232653, 23422.414439638975, 23597.528049439086, 1897.943061708151, 2078.210280093555, 2117.4918019675165, 2139.0374331550865, 2191.386411804697, 14440.0, 14686.485972990895, 14859.108453492825, 14929.850701492955, 15117.319720612599, 1865.710814823691, 1902.2105826082159, 1904.1241029126618, 1941.4078705994666, 1963.9410817675493, 53913.46086539124, 76407.61796190984, 77766.0, 78184.60907695482, 80370.59814700947, 15527.922360388126, 16634.0, 16935.322587096623, 16953.83046169547, 16968.915155424143, 28710.0, 28800.855995720307, 28832.423351532852, 28876.85561572221, 28972.710272897424, 8528.658853645784, 8543.487390756574, 8607.225349718556, 8824.382293239412, 8887.955560222286, 6896.862062758717, 6899.413549848319, 6939.861202775916, 7140.036095127195, 7161.713531458683, 8268.958655206685, 8343.916560834436, 8562.571871406404, 8643.438176518506, 8723.258523025486, 3047.6038115044903, 3223.2908760072746, 3336.849841757127, 3454.0434476526266, 3467.7225821934185, 756.76162008967, 783.0368646564757, 872.4634349874781, 941.9340646154841, 947.2280091725222, 16705.33178672864, 16893.83106168947, 17560.38538651141, 17592.824071759376, 18161.545961350806, 823.7446391618618, 851.5486792000249, 856.7130011446111, 889.3107841422819, 903.1961554216753, 8955.910440895508, 9324.533773311307, 10152.390856548483, 10283.331583447052, 10395.272330936914, 271349.0, 276388.0, 276660.0, 377847.0, 379900.0, 80764.0, 84926.57536712277, 85102.0, 86194.0, 86288.0, 894.9149830766066, 899.5547204133865, 932.2588542109039, 933.1788026536605, 935.6631612619451, 14761.261936903327, 15905.204739763198, 16002.919985399998, 16097.839021609634, 16982.74525882088, 35676.64323356733, 39073.609263907, 39445.0, 39933.80033099932, 41369.0, 50005.74997124991, 50068.0, 50248.24627630515, 51389.7430512845, 53364.0, 7585.165631780389, 7708.267714567107, 7942.960285198537, 8048.476849004796, 8088.191180881865, 9121.954390228006, 11565.190436669352, 11693.415329233674, 11858.881411185777, 12539.749205015665, 10180.898191017995, 10198.847017294598, 10544.52549635253, 10913.454327283764, 11021.283616564897, 5663.631863928831, 9108.316876234441, 10615.416152111708, 10899.782004360028, 11117.777644447227, 9870.901290986998, 10020.849687254551, 10427.322224055411, 10661.307015043998, 10759.623413180501, 7835.804104897423, 7881.763547093597, 8045.758627241192, 8099.595020249082, 8134.674613015413, 8386.580670966548, 9715.659951901649, 9854.802903942025, 10668.573257069631, 10793.784124317626], "value": 9327.891203692849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.5803900790752, 1393.8048673185754, 1408.7534681430748, 1617.6198593330557, 1644.481988173726, 7299.416046716263, 7914.722984695537, 7924.603769811508, 7926.326262267707, 7929.048514178292, 6379.425851673349, 7373.815654608624, 7589.658465369058, 7605.8478830423355, 7845.450818442711, 2152.924647637337, 2183.759786423492, 2184.0390228299575, 2195.1877805212093, 2195.6047911375945, 1822.0798496759119, 2174.847760656755, 2201.2295696506253, 2227.0, 2230.431240033789, 2097.6329142400095, 2175.41263858758, 2177.923772667957, 2181.4764456530397, 2182.508935489518, 2162.5566758814407, 2183.355910006544, 2189.211883721859, 2191.605511008026, 2194.5281764420565, 2157.8165855902266, 2158.266189495563, 2164.967525487119, 2169.0456199272426, 2169.511859831541, 7659.234076592352, 7827.9608601956625, 7875.645595948196, 7879.606019698992, 7885.8028549286155, 4250.744955302661, 4360.41134446852, 4367.934480982788, 4369.169857727022, 4373.978130109329, 2831.5044867148167, 2832.9150125496267, 2963.3332500187503, 2974.092901664991, 2984.7015298470196, 919.6137622198693, 923.501309292981, 939.9389039712397, 958.0706714486937, 975.7853272280158, 10298.3820970742, 10317.38095714252, 10324.690259292232, 10330.7417314567, 10334.483275836179, 3857.8071096445065, 4081.20416518776, 4217.641500472494, 4220.85227017053, 4234.216669916075, 8826.45537031017, 8908.242799361997, 8913.197812196933, 8920.73237802867, 8929.955350223207, 4404.537523560044, 4416.933745993812, 4424.13729322779, 4428.180786554498, 4429.689921705514, 3969.206158768258, 4044.4135600337786, 4045.3325201342036, 4050.331695270306, 4050.3924411338535, 3514.876979305712, 3578.248567800739, 3609.8556057757396, 3654.250878569887, 3668.137987572918, 1070.3577853287966, 1188.7979043562616, 1210.0803389424102, 1225.148521777374, 1232.9321887296105, 716.8817145171092, 741.7700512841036, 821.3142026407896, 827.6399766101765, 858.7976832434516, 4972.345326185251, 5018.447970723218, 5032.169692000852, 5116.951025039858, 5119.104156772624, 841.5750046226616, 846.6867259114044, 864.8789169516147, 866.9176428239307, 888.8044630181349, 3534.0988048047584, 3536.3457760314423, 3552.786832790041, 3591.6228795976567, 3622.565292164957, 9187.448753074837, 9520.381175223589, 9616.9038309616, 9724.95137524308, 9736.513174341397, 9326.533673316442, 9444.95277523608, 9521.809563808685, 9553.522323883779, 9556.904430955601, 7215.855682886313, 7314.232005639544, 7335.523190992569, 7349.412047036224, 7351.4853960223345, 5030.522100400456, 5160.251763494347, 5189.065968125623, 5206.114960456655, 5411.134218525017, 8450.535220562928, 8637.309015278888, 8718.607662655322, 8798.516081615573, 8881.866771998555, 8621.396502244783, 8645.351598630003, 8697.739067827975, 8726.956365218133, 8781.824363512822, 6644.767433139817, 6735.360140786617, 6808.455323574201, 6809.080774095433, 6810.114685091105, 7433.628318584158, 7487.064116985377, 7490.101187857492, 7491.812704682427, 7502.812429689301, 6748.561343512656, 6809.421199198124, 6810.727570897108, 6816.761413350708, 6978.755743549154, 6604.207495100426, 6616.801495955129, 6633.568818026813, 6675.365840245169, 6679.465642748665, 5878.853028674317, 5912.645241285537, 5936.970315148396, 5958.40415958418, 6048.758049678139, 4174.2486352455635, 4188.4136220928485, 4213.074578094806, 4246.256905041667, 4434.312681534368, 4305.0, 4361.2367835628, 4408.537103604075, 4450.421445212101, 4612.054528821516], "value": 4072.8143315425064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.095132236101, 294.69793461701755, 296.3835222736707, 299.2996388451025, 299.5058154045823, 4673.135469938064, 4788.419821458919, 4811.783469743861, 4826.251930950704, 4863.343448634433, 4712.882177945553, 4784.952150478494, 4791.520847915207, 4806.735629540382, 4812.133815913135, 3625.1480901988143, 3727.645873642013, 3727.7390582659223, 3807.733458657895, 3824.560175579802, 3464.3497724240974, 3730.339998700579, 3746.5316835395574, 3749.8125093745202, 3781.6596506314427, 3750.6061863504347, 3752.662260396564, 3755.305268525318, 3760.3043436964113, 3767.077066118805, 3752.6601324821067, 3762.9623703762886, 3764.209516001643, 3764.3412402829395, 3768.566614839301, 3184.2357834119875, 3214.9678503215137, 3334.899953001414, 3351.614564325085, 3351.6815902489225, 4646.001109761383, 4647.279671650899, 4685.929711054337, 4688.859334219979, 4690.460597031317, 4295.603928723178, 4301.010767523487, 4308.78456077198, 4309.310510318334, 4326.6754993375625, 4822.083804077214, 4945.0, 5029.748512574357, 5032.144535428949, 5062.265971434122, 3647.7264205184715, 3652.086978255436, 3656.945145822815, 3667.3582123128344, 3667.523221981152, 4997.675151115202, 5047.772850221749, 5207.3230480037355, 5243.082460569423, 5251.21685506682, 3672.192117734094, 3684.521012268388, 3700.0379901225338, 3704.592494825567, 3712.1462063724953, 3768.660820526166, 3768.792716400624, 3774.8678796241998, 3777.0, 3778.1499162688724, 4260.339647354665, 4264.296391095435, 4280.422143010654, 4282.785860707015, 4293.141371725667, 4809.470958194595, 4998.275250088716, 5029.471905449948, 5054.721990290569, 5074.3657042869645, 1308.241220092344, 1319.5645437005765, 1319.9340032998505, 1320.8216890719823, 1327.8340207474066, 818.4107442641289, 847.9660813567389, 860.1742327365799, 861.875028120919, 867.5922316511355, 4001.3594426285085, 4003.4195041718785, 4009.8396064157105, 4012.277789997828, 4035.4753881995152, 4544.977275113603, 4570.337301091323, 4592.448906131285, 4600.309953506934, 4627.236505976476, 4003.7397569158493, 4003.919921601552, 4023.275810354106, 4029.7582145071387, 4035.3858456617586, 2454.570450171213, 2558.4883023395396, 2751.9724802751716, 2775.875085621152, 2786.8885244590397, 4918.754062296871, 4929.309896614477, 4938.4320803107385, 4940.950590494049, 4945.431275403303, 5332.9733351333, 5338.572914166857, 5343.942582105839, 5362.570994320445, 5363.19552067193, 4694.708955037392, 4911.754412279443, 4920.778564964585, 4925.670069081256, 4943.382077240345, 5202.609804264771, 5217.165253559412, 5219.269302297757, 5230.613887319787, 5262.710550919736, 4916.950830491793, 5128.58971282304, 5160.916207596297, 5166.199239117943, 5181.0, 4725.952740472689, 4797.760111994457, 4878.0975519529, 4939.97530012362, 4950.084234416644, 3615.6203598621764, 3615.8011309378235, 3619.873304434332, 3631.4371272452813, 3631.6368363163474, 5187.610929180402, 5222.451642577626, 5231.848993221485, 5234.764435600331, 5235.0, 4881.0, 5042.647014708935, 5043.319151914445, 5045.772940217773, 5100.38795344561, 4985.177445721415, 5019.548240658358, 5028.924566131438, 5044.344235249394, 5044.646874718735, 4970.080535101018, 4980.203167493184, 4984.626153038609, 5023.824166154167, 5026.547610715053, 4802.351682522954, 5035.144025515598, 5039.84880453587, 5052.797888084436, 5059.848204553869, 4967.329410529533, 4975.507347795719, 4977.900441991067, 4980.601551875769, 4982.850514484571], "value": 3766.03945808533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.7273735924873, 629.6788637794725, 632.3834261594949, 697.1285892634207, 738.3170567225316, 12306.38468076596, 13222.801657975138, 13298.534551290695, 13306.800397994039, 13337.13308634938, 13542.661433464144, 13642.249676267802, 13659.385327660255, 13695.794563081561, 13718.382672779724, 612.8804883047808, 726.9563826170447, 752.6349720385622, 759.4569882533987, 770.118214644232, 756.1342263108737, 764.3884892086337, 765.6478020110756, 766.3486036868672, 766.6741634805213, 800.995995020027, 801.3388954112851, 801.7714951238898, 802.1937952357872, 802.6348011654683, 649.4187702006677, 787.4723934963588, 794.880767884819, 796.8884356190138, 822.7655118291318, 589.9233099697054, 592.7895597063024, 593.6289818863211, 593.9220315128028, 594.1088367448826, 11460.426978651034, 11541.942290288494, 11612.129090318176, 11633.709157271136, 11637.243579167327, 13242.404091815795, 13932.303384830819, 14247.501337453139, 14270.785938210935, 14322.856771432256, 10951.507182176741, 11095.167862410271, 11151.721206969809, 11257.268277561932, 11501.769964600744, 3328.517364982088, 3358.932821343559, 3430.3139372125424, 3496.4790316212275, 3500.912477188065, 61547.6922615384, 62527.68736156336, 62914.0, 63030.36969630291, 67170.32829671739, 10025.749356266151, 10101.797964040825, 10758.515866786014, 10780.46097695112, 10850.186236032328, 18182.909085454754, 18474.076296185405, 18485.0, 18506.722399164024, 18511.90744046298, 6180.412860778219, 6620.66896655175, 6783.762568310085, 6815.659217039129, 6835.863282734317, 3541.6281290464644, 3594.982025089858, 3644.1071937375514, 3657.5062366580173, 3694.704423646102, 2826.7314605112483, 2932.0324292983264, 2942.52919532878, 2947.572601972702, 2955.246412164884, 473.7110362678763, 488.64329039801146, 489.8334566247493, 492.48289296238806, 493.2305603258928, 503.6424138861376, 524.6747016849502, 528.5982653183531, 537.4893850841638, 539.4767075936336, 6967.79096627102, 7083.397911177504, 7256.492045556761, 7508.436867234979, 7689.615519224017, 513.6635503745053, 518.932538769965, 543.5081251467428, 556.4268803132779, 559.2841163310968, 3373.6626337366065, 3551.8756843510355, 3577.731670124751, 3649.0694872807794, 3723.702103831687, 55332.44667553354, 56650.0, 72306.0, 103523.4823825891, 103726.0, 53507.0, 65686.0, 66050.33949660537, 67180.32819671741, 87538.12461875427, 43529.34705979413, 45372.77313613411, 70279.2972070283, 70439.29560704532, 71092.64453677699, 7882.369410447036, 8947.776305592412, 9060.592273347847, 9088.454692718458, 9190.816183676423, 41126.79436602798, 41699.55955020398, 41734.0, 42770.57229427666, 43420.78289608658, 56816.18205815329, 57449.712751435974, 60384.0, 63677.681611591644, 66695.66652166708, 10946.288491248044, 11171.553137874394, 11257.831132533182, 11276.267042642203, 11645.184837061324, 12021.218620789621, 12337.198082124632, 13373.598792036255, 13381.0, 13927.164370137823, 11256.437178141225, 11438.714032149262, 11590.304581725124, 12233.266004039786, 12392.81410778821, 10912.56349746033, 10982.176336774613, 10988.0, 11718.824217636571, 11729.061675066145, 10755.247132700948, 10990.670279891616, 11073.114150868072, 12341.753164936472, 12375.75248495043, 9395.530223488935, 9440.95279523598, 9504.714858554255, 9620.95189524048, 9982.550785214828, 9981.650642227487, 10203.591856325664, 10212.948935255276, 10284.485775711335, 10416.895831041897], "value": 6340.62786263277, "unit": "score"}], "name": "dromaeo_css", "value": 6477.915189014951, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 115.0, 114.0, 109.0, 114.0, 114.0, 115.0, 115.0, 116.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 124.0, 182.0, 123.0, 128.0, 154.0, 122.0, 183.0, 121.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 112.0, 75.0, 76.0, 76.0, 76.0, 100.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 130.0, 86.0, 86.0, 86.0, 126.0, 87.0, 86.0, 127.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 145.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 63.0, 62.0, 62.0, 65.0, 63.0, 63.0, 64.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 65.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 83.0, 83.0, 91.0, 85.0, 82.0, 91.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 155.0, 135.0, 140.0, 134.0, 142.0, 134.0, 133.0, 153.0, 132.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 181.0, 172.0, 171.0, 171.0, 172.0, 171.0, 171.0, 171.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1552.7, "alertThreshold": 2.0}]} 21:09:09 INFO - Return code: 0 21:09:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:09:09 INFO - # TBPL SUCCESS # 21:09:09 INFO - Running post-action listener: _resource_record_post_action 21:09:09 INFO - [mozharness: 2016-08-14 04:09:09.734308Z] Finished run-tests step (success) 21:09:09 INFO - Running post-run listener: _resource_record_post_run 21:09:09 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 415576064; Read time: 12; Write time: 635464 21:09:09 INFO - TinderboxPrint: CPU usage
13.0% 21:09:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:09:09 INFO - TinderboxPrint: I/O write bytes / time
415,576,064 / 635,464 21:09:09 INFO - TinderboxPrint: CPU idle
8,357.3 (86.9%) 21:09:09 INFO - TinderboxPrint: CPU user
1,201.5 (12.5%) 21:09:09 INFO - TinderboxPrint: Swap in / out
0 / 0 21:09:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 113704960; Read time: 0; Write time: 230448 21:09:09 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290004992; Read time: 0; Write time: 403392 21:09:10 INFO - Running post-run listener: _upload_blobber_files 21:09:10 INFO - Blob upload gear active. 21:09:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:09:10 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 21:09:10 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'] 21:09:10 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 21:09:10 INFO - (blobuploader) - INFO - Open directory for files ... 21:09:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:09:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:09:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:15 INFO - (blobuploader) - INFO - Done attempting. 21:09:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:09:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:09:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:16 INFO - (blobuploader) - INFO - Done attempting. 21:09:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:09:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:09:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:16 INFO - (blobuploader) - INFO - Done attempting. 21:09:16 INFO - (blobuploader) - INFO - Iteration through files over. 21:09:16 INFO - Return code: 0 21:09:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:09:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:09:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e9c9f4492f7bfa138c9706982b1f7a7fcaca7b77fa1e0401641a24fa485197a46c576c1fe763ac12dcdf5df0fd0c586ae61a965b241d2df810baa6fc62c164d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cbe4be37b4b018e19513d6c6cddcedc33b9cde0102df3967765e9a3130633753428a6324621d567afca38f981fbbba0d16fc6ba09fde527120390a17998c8e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/782a4eeb072dfb1457e72893444397fc12a041e4c44a100969c2ba7fe17e4de9ac07288a667f7b23425278925e8b4fc8d7d4d67b637f9575e90e88c005f70433"} 21:09:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:09:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:09:16 INFO - Contents: 21:09:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e9c9f4492f7bfa138c9706982b1f7a7fcaca7b77fa1e0401641a24fa485197a46c576c1fe763ac12dcdf5df0fd0c586ae61a965b241d2df810baa6fc62c164d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cbe4be37b4b018e19513d6c6cddcedc33b9cde0102df3967765e9a3130633753428a6324621d567afca38f981fbbba0d16fc6ba09fde527120390a17998c8e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/782a4eeb072dfb1457e72893444397fc12a041e4c44a100969c2ba7fe17e4de9ac07288a667f7b23425278925e8b4fc8d7d4d67b637f9575e90e88c005f70433"} 21:09:16 INFO - Running post-run listener: copy_logs_to_upload_dir 21:09:16 INFO - Copying logs to upload dir... 21:09:16 INFO - mkdir: /builds/slave/test/build/upload/logs 21:09:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.285565 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-13 21:09:15.822769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 21:09:15.826712) ========= 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=745a4373a2a16df560f216e000000264-1471136438.88672-997877800 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/6e9c9f4492f7bfa138c9706982b1f7a7fcaca7b77fa1e0401641a24fa485197a46c576c1fe763ac12dcdf5df0fd0c586ae61a965b241d2df810baa6fc62c164d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cbe4be37b4b018e19513d6c6cddcedc33b9cde0102df3967765e9a3130633753428a6324621d567afca38f981fbbba0d16fc6ba09fde527120390a17998c8e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/782a4eeb072dfb1457e72893444397fc12a041e4c44a100969c2ba7fe17e4de9ac07288a667f7b23425278925e8b4fc8d7d4d67b637f9575e90e88c005f70433"} build_url:https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/CJrwMJsFTAyC6qv3kcOxGg/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/6e9c9f4492f7bfa138c9706982b1f7a7fcaca7b77fa1e0401641a24fa485197a46c576c1fe763ac12dcdf5df0fd0c586ae61a965b241d2df810baa6fc62c164d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cbe4be37b4b018e19513d6c6cddcedc33b9cde0102df3967765e9a3130633753428a6324621d567afca38f981fbbba0d16fc6ba09fde527120390a17998c8e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/782a4eeb072dfb1457e72893444397fc12a041e4c44a100969c2ba7fe17e4de9ac07288a667f7b23425278925e8b4fc8d7d4d67b637f9575e90e88c005f70433"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 21:09:15.852468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 21:09:15.852832) ========= 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=745a4373a2a16df560f216e000000264-1471136438.88672-997877800 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 21:09:15.934399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 21:09:15.934800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 21:09:15.935143) ========= ========= Total master_lag: 0.19 =========