builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1474492389.41 results: success (0) buildid: 20160921130600 builduid: 0cb6c6a5d5924431a6f43d9b9448690a revision: 6957fdb6a7128810bc9a8ba1f871eede183dd9f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.411108) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.411830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.412305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.444843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.445175) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 14:13:09-- 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% 227M=0s 2016-09-21 14:13:09 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.582617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.583363) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016486 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:09.637333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 14:13:09.638139) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6957fdb6a7128810bc9a8ba1f871eede183dd9f2 --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 6957fdb6a7128810bc9a8ba1f871eede183dd9f2 --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=e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 14:13:10,121 truncating revision to first 12 chars 2016-09-21 14:13:10,121 Setting DEBUG logging. 2016-09-21 14:13:10,121 attempt 1/10 2016-09-21 14:13:10,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6957fdb6a712?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 14:13:10,803 unpacking tar archive at: autoland-6957fdb6a712/testing/mozharness/ program finished with exit code 0 elapsedTime=1.037268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 14:13:10.694612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:10.695271) ========= script_repo_revision: 6957fdb6a7128810bc9a8ba1f871eede183dd9f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:10.696309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:10.697053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 14:13:10.707878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-21 14:13:10.708533) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:13:11 INFO - MultiFileLogger online at 20160921 14:13:11 in /builds/slave/test 14:13:11 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 14:13:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:13:11 INFO - {'append_to_log': False, 14:13:11 INFO - 'base_work_dir': '/builds/slave/test', 14:13:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:13:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:13:11 INFO - 'branch': 'Autoland-Non-PGO', 14:13:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:13:11 INFO - 'config_files': ('talos/linux_config.py',), 14:13:11 INFO - 'default_actions': ('clobber', 14:13:11 INFO - 'read-buildbot-config', 14:13:11 INFO - 'download-and-extract', 14:13:11 INFO - 'populate-webroot', 14:13:11 INFO - 'create-virtualenv', 14:13:11 INFO - 'install', 14:13:11 INFO - 'run-tests'), 14:13:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:13:11 INFO - 'download_minidump_stackwalk': True, 14:13:11 INFO - 'download_symbols': 'ondemand', 14:13:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:13:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:13:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:13:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:13:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:13:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:13:11 INFO - 'installer_path': 'installer.exe', 14:13:11 INFO - 'log_level': 'info', 14:13:11 INFO - 'log_name': 'talos', 14:13:11 INFO - 'log_to_console': True, 14:13:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:13:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:13:11 INFO - 'opt_config_files': (), 14:13:11 INFO - 'pip_index': False, 14:13:11 INFO - 'sps_profile': False, 14:13:11 INFO - 'sps_profile_interval': 0, 14:13:11 INFO - 'suite': 'dromaeojs', 14:13:11 INFO - 'system_bits': '32', 14:13:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:13:11 INFO - 'title': 'talos-linux64-ix-067', 14:13:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:13:11 INFO - 'use_talos_json': True, 14:13:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:13:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:13:11 INFO - 'work_dir': 'build'} 14:13:11 INFO - [mozharness: 2016-09-21 21:13:11.290259Z] Running clobber step. 14:13:11 INFO - Running pre-action listener: _resource_record_pre_action 14:13:11 INFO - Running main action method: clobber 14:13:11 INFO - rmtree: /builds/slave/test/build 14:13:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:13:12 INFO - Running post-action listener: _resource_record_post_action 14:13:12 INFO - [mozharness: 2016-09-21 21:13:12.252729Z] Finished clobber step (success) 14:13:12 INFO - [mozharness: 2016-09-21 21:13:12.252828Z] Running read-buildbot-config step. 14:13:12 INFO - Running pre-action listener: _resource_record_pre_action 14:13:12 INFO - Running main action method: read_buildbot_config 14:13:12 INFO - Using buildbot properties: 14:13:12 INFO - { 14:13:12 INFO - "project": "", 14:13:12 INFO - "product": "firefox", 14:13:12 INFO - "script_repo_revision": "production", 14:13:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 14:13:12 INFO - "repository": "", 14:13:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 14:13:12 INFO - "buildid": "20160921130600", 14:13:12 INFO - "pgo_build": "False", 14:13:12 INFO - "basedir": "/builds/slave/test", 14:13:12 INFO - "buildnumber": 608, 14:13:12 INFO - "slavename": "talos-linux64-ix-067", 14:13:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:13:12 INFO - "platform": "ubuntu64_hw", 14:13:12 INFO - "scheduler": "tests-autoland-linux64-talos", 14:13:12 INFO - "branch": "autoland", 14:13:12 INFO - "repo_path": "integration/autoland", 14:13:12 INFO - "revision": "6957fdb6a7128810bc9a8ba1f871eede183dd9f2", 14:13:12 INFO - "stage_platform": "linux64", 14:13:12 INFO - "builduid": "0cb6c6a5d5924431a6f43d9b9448690a", 14:13:12 INFO - "slavebuilddir": "test" 14:13:12 INFO - } 14:13:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:13:12 INFO - Running post-action listener: _resource_record_post_action 14:13:12 INFO - [mozharness: 2016-09-21 21:13:12.255460Z] Finished read-buildbot-config step (success) 14:13:12 INFO - [mozharness: 2016-09-21 21:13:12.255550Z] Running download-and-extract step. 14:13:12 INFO - Running pre-action listener: _resource_record_pre_action 14:13:12 INFO - Running main action method: download_and_extract 14:13:12 INFO - mkdir: /builds/slave/test/build/tests 14:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:12 INFO - trying https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:13:12 INFO - Downloading https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:13:12 INFO - Downloaded 1361 bytes. 14:13:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:13:12 INFO - Using the following test package requirements: 14:13:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:13:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:13:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:13:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'jsshell-linux-x86_64.zip'], 14:13:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:13:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:13:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:13:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:13:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:13:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:13:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:13:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:13:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:13:12 INFO - Fetch https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:13:13 INFO - Expected file size: 20373798 14:13:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:13:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:13:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:13:18 INFO - Fetch https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:13:18 INFO - Expected file size: 20373798 14:13:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:13:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:13:23 INFO - Fetch https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:13:24 INFO - Expected file size: 14414059 14:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:25 INFO - trying https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:13:26 INFO - Downloaded 55601151 bytes. 14:13:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:13:26 INFO - mkdir: /builds/slave/test/properties 14:13:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:13:26 INFO - Writing to file /builds/slave/test/properties/build_url 14:13:26 INFO - Contents: 14:13:26 INFO - build_url:https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:13:27 INFO - Running post-action listener: _resource_record_post_action 14:13:27 INFO - Running post-action listener: set_extra_try_arguments 14:13:27 INFO - [mozharness: 2016-09-21 21:13:27.753979Z] Finished download-and-extract step (success) 14:13:27 INFO - [mozharness: 2016-09-21 21:13:27.754209Z] Running populate-webroot step. 14:13:27 INFO - Running pre-action listener: _resource_record_pre_action 14:13:27 INFO - Running main action method: populate_webroot 14:13:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:13:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:13:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:13:27 INFO - '--tppagecycles', 14:13:27 INFO - '7'], 14:13:27 INFO - 'tests': ['tsvgm']}}, 14:13:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:13:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:13:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:13:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:13:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['damp', 'tps']}, 14:13:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'tests': ['damp', 'tps']}, 14:13:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['dromaeo_dom']}, 14:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:13:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['basic_compositor_video']}, 14:13:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:13:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['a11yr', 14:13:27 INFO - 'ts_paint', 14:13:27 INFO - 'tpaint', 14:13:27 INFO - 'sessionrestore', 14:13:27 INFO - 'sessionrestore_no_auto_restore', 14:13:27 INFO - 'tabpaint']}, 14:13:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:13:27 INFO - 'ts_paint', 14:13:27 INFO - 'tpaint', 14:13:27 INFO - 'sessionrestore', 14:13:27 INFO - 'sessionrestore_no_auto_restore', 14:13:27 INFO - 'tabpaint']}, 14:13:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:13:27 INFO - 'ts_paint', 14:13:27 INFO - 'tpaint', 14:13:27 INFO - 'sessionrestore', 14:13:27 INFO - 'sessionrestore_no_auto_restore', 14:13:27 INFO - 'tabpaint']}, 14:13:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:13:27 INFO - 'ts_paint', 14:13:27 INFO - 'tpaint', 14:13:27 INFO - 'sessionrestore', 14:13:27 INFO - 'sessionrestore_no_auto_restore', 14:13:27 INFO - 'tabpaint']}, 14:13:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['a11yr', 14:13:27 INFO - 'ts_paint', 14:13:27 INFO - 'tpaint', 14:13:27 INFO - 'sessionrestore', 14:13:27 INFO - 'sessionrestore_no_auto_restore', 14:13:27 INFO - 'tabpaint']}, 14:13:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['a11yr', 14:13:27 INFO - 'ts_paint', 14:13:27 INFO - 'tpaint', 14:13:27 INFO - 'sessionrestore', 14:13:27 INFO - 'sessionrestore_no_auto_restore', 14:13:27 INFO - 'tabpaint']}, 14:13:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['tsvgx', 14:13:27 INFO - 'tsvgr_opacity', 14:13:27 INFO - 'tart', 14:13:27 INFO - 'tscrollx', 14:13:27 INFO - 'cart']}, 14:13:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:13:27 INFO - 'tsvgr_opacity', 14:13:27 INFO - 'tart', 14:13:27 INFO - 'tscrollx', 14:13:27 INFO - 'cart']}, 14:13:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'talos_options': ['--disable-e10s'], 14:13:27 INFO - 'tests': ['tp5o']}, 14:13:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'tests': ['tp5o']}, 14:13:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'talos_options': ['--disable-e10s', 14:13:27 INFO - '--xperf_path', 14:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:27 INFO - 'tests': ['tp5n']}, 14:13:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:13:27 INFO - 'talos_options': ['--xperf_path', 14:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:27 INFO - 'tests': ['tp5n']}}, 14:13:27 INFO - 'talos.zip': {'path': '', 14:13:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:13:27 INFO - Running post-action listener: _resource_record_post_action 14:13:27 INFO - [mozharness: 2016-09-21 21:13:27.772427Z] Finished populate-webroot step (success) 14:13:27 INFO - [mozharness: 2016-09-21 21:13:27.772516Z] Running create-virtualenv step. 14:13:27 INFO - Running pre-action listener: _resource_record_pre_action 14:13:27 INFO - Running main action method: create_virtualenv 14:13:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:13:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:13:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:13:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:13:27 INFO - Using real prefix '/usr' 14:13:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:13:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:13:30 INFO - Installing pip.................done. 14:13:30 INFO - Return code: 0 14:13:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:13:30 INFO - Using env: {'DISPLAY': ':0', 14:13:30 INFO - 'HOME': '/home/cltbld', 14:13:30 INFO - 'LANG': 'en_US.UTF-8', 14:13:30 INFO - 'LANGUAGE': 'en_US:en', 14:13:30 INFO - 'LOGNAME': 'cltbld', 14:13:30 INFO - 'MAIL': '/var/mail/cltbld', 14:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:30 INFO - 'MOZ_NO_REMOTE': '1', 14:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:30 INFO - 'NO_EM_RESTART': '1', 14:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:30 INFO - 'PWD': '/builds/slave/test', 14:13:30 INFO - 'SHELL': '/bin/bash', 14:13:30 INFO - 'SHLVL': '1', 14:13:30 INFO - 'TERM': 'linux', 14:13:30 INFO - 'TMOUT': '86400', 14:13:30 INFO - 'USER': 'cltbld', 14:13:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:30 INFO - '_': '/tools/buildbot/bin/python'} 14:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:13:30 INFO - Cleaning up... 14:13:30 INFO - Return code: 0 14:13:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:13:30 INFO - Using env: {'DISPLAY': ':0', 14:13:30 INFO - 'HOME': '/home/cltbld', 14:13:30 INFO - 'LANG': 'en_US.UTF-8', 14:13:30 INFO - 'LANGUAGE': 'en_US:en', 14:13:30 INFO - 'LOGNAME': 'cltbld', 14:13:30 INFO - 'MAIL': '/var/mail/cltbld', 14:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:30 INFO - 'MOZ_NO_REMOTE': '1', 14:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:30 INFO - 'NO_EM_RESTART': '1', 14:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:30 INFO - 'PWD': '/builds/slave/test', 14:13:30 INFO - 'SHELL': '/bin/bash', 14:13:30 INFO - 'SHLVL': '1', 14:13:30 INFO - 'TERM': 'linux', 14:13:30 INFO - 'TMOUT': '86400', 14:13:30 INFO - 'USER': 'cltbld', 14:13:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:30 INFO - '_': '/tools/buildbot/bin/python'} 14:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:30 INFO - Downloading/unpacking psutil>=3.1.1 14:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:13:32 INFO - Installing collected packages: psutil 14:13:32 INFO - Running setup.py install for psutil 14:13:32 INFO - building 'psutil._psutil_linux' extension 14:13:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:13:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:13:33 INFO - building 'psutil._psutil_posix' extension 14:13:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:13:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:13:33 INFO - Successfully installed psutil 14:13:33 INFO - Cleaning up... 14:13:33 INFO - Return code: 0 14:13:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:33 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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:13:33 INFO - Using env: {'DISPLAY': ':0', 14:13:33 INFO - 'HOME': '/home/cltbld', 14:13:33 INFO - 'LANG': 'en_US.UTF-8', 14:13:33 INFO - 'LANGUAGE': 'en_US:en', 14:13:33 INFO - 'LOGNAME': 'cltbld', 14:13:33 INFO - 'MAIL': '/var/mail/cltbld', 14:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:33 INFO - 'MOZ_NO_REMOTE': '1', 14:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:33 INFO - 'NO_EM_RESTART': '1', 14:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:33 INFO - 'PWD': '/builds/slave/test', 14:13:33 INFO - 'SHELL': '/bin/bash', 14:13:33 INFO - 'SHLVL': '1', 14:13:33 INFO - 'TERM': 'linux', 14:13:33 INFO - 'TMOUT': '86400', 14:13:33 INFO - 'USER': 'cltbld', 14:13:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:33 INFO - '_': '/tools/buildbot/bin/python'} 14:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:13:35 INFO - Installing collected packages: mozsystemmonitor 14:13:35 INFO - Running setup.py install for mozsystemmonitor 14:13:35 INFO - Successfully installed mozsystemmonitor 14:13:35 INFO - Cleaning up... 14:13:35 INFO - Return code: 0 14:13:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:13:35 INFO - Using env: {'DISPLAY': ':0', 14:13:35 INFO - 'HOME': '/home/cltbld', 14:13:35 INFO - 'LANG': 'en_US.UTF-8', 14:13:35 INFO - 'LANGUAGE': 'en_US:en', 14:13:35 INFO - 'LOGNAME': 'cltbld', 14:13:35 INFO - 'MAIL': '/var/mail/cltbld', 14:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:35 INFO - 'MOZ_NO_REMOTE': '1', 14:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:35 INFO - 'NO_EM_RESTART': '1', 14:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:35 INFO - 'PWD': '/builds/slave/test', 14:13:35 INFO - 'SHELL': '/bin/bash', 14:13:35 INFO - 'SHLVL': '1', 14:13:35 INFO - 'TERM': 'linux', 14:13:35 INFO - 'TMOUT': '86400', 14:13:35 INFO - 'USER': 'cltbld', 14:13:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:35 INFO - '_': '/tools/buildbot/bin/python'} 14:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:35 INFO - Downloading/unpacking jsonschema==2.5.1 14:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:13:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:13:37 INFO - warning: no files found matching '*.txt' 14:13:37 INFO - no previously-included directories found matching 'build' 14:13:37 INFO - no previously-included directories found matching 'dist' 14:13:37 INFO - no previously-included directories found matching '.git*' 14:13:38 INFO - Installing collected packages: jsonschema, functools32 14:13:38 INFO - Running setup.py install for functools32 14:13:38 INFO - warning: no files found matching '*.txt' 14:13:38 INFO - no previously-included directories found matching 'build' 14:13:38 INFO - no previously-included directories found matching 'dist' 14:13:38 INFO - no previously-included directories found matching '.git*' 14:13:38 INFO - Successfully installed jsonschema functools32 14:13:38 INFO - Cleaning up... 14:13:38 INFO - Return code: 0 14:13:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:38 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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:13:38 INFO - Using env: {'DISPLAY': ':0', 14:13:38 INFO - 'HOME': '/home/cltbld', 14:13:38 INFO - 'LANG': 'en_US.UTF-8', 14:13:38 INFO - 'LANGUAGE': 'en_US:en', 14:13:38 INFO - 'LOGNAME': 'cltbld', 14:13:38 INFO - 'MAIL': '/var/mail/cltbld', 14:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:38 INFO - 'MOZ_NO_REMOTE': '1', 14:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:38 INFO - 'NO_EM_RESTART': '1', 14:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:38 INFO - 'PWD': '/builds/slave/test', 14:13:38 INFO - 'SHELL': '/bin/bash', 14:13:38 INFO - 'SHLVL': '1', 14:13:38 INFO - 'TERM': 'linux', 14:13:38 INFO - 'TMOUT': '86400', 14:13:38 INFO - 'USER': 'cltbld', 14:13:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:38 INFO - '_': '/tools/buildbot/bin/python'} 14:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:13:38 INFO - Cleaning up... 14:13:38 INFO - Return code: 0 14:13:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:38 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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:13:38 INFO - Using env: {'DISPLAY': ':0', 14:13:38 INFO - 'HOME': '/home/cltbld', 14:13:38 INFO - 'LANG': 'en_US.UTF-8', 14:13:38 INFO - 'LANGUAGE': 'en_US:en', 14:13:38 INFO - 'LOGNAME': 'cltbld', 14:13:38 INFO - 'MAIL': '/var/mail/cltbld', 14:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:38 INFO - 'MOZ_NO_REMOTE': '1', 14:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:38 INFO - 'NO_EM_RESTART': '1', 14:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:38 INFO - 'PWD': '/builds/slave/test', 14:13:38 INFO - 'SHELL': '/bin/bash', 14:13:38 INFO - 'SHLVL': '1', 14:13:38 INFO - 'TERM': 'linux', 14:13:38 INFO - 'TMOUT': '86400', 14:13:38 INFO - 'USER': 'cltbld', 14:13:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:38 INFO - '_': '/tools/buildbot/bin/python'} 14:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:40 INFO - Downloading blobuploader-1.2.4.tar.gz 14:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:13:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:13:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:41 INFO - Downloading docopt-0.6.1.tar.gz 14:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:13:41 INFO - Installing collected packages: blobuploader, requests, docopt 14:13:41 INFO - Running setup.py install for blobuploader 14:13:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:13:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:13:41 INFO - Running setup.py install for requests 14:13:41 INFO - Running setup.py install for docopt 14:13:41 INFO - Successfully installed blobuploader requests docopt 14:13:41 INFO - Cleaning up... 14:13:41 INFO - Return code: 0 14:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:41 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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:13:41 INFO - Using env: {'DISPLAY': ':0', 14:13:41 INFO - 'HOME': '/home/cltbld', 14:13:41 INFO - 'LANG': 'en_US.UTF-8', 14:13:41 INFO - 'LANGUAGE': 'en_US:en', 14:13:41 INFO - 'LOGNAME': 'cltbld', 14:13:41 INFO - 'MAIL': '/var/mail/cltbld', 14:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:41 INFO - 'MOZ_NO_REMOTE': '1', 14:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:41 INFO - 'NO_EM_RESTART': '1', 14:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:41 INFO - 'PWD': '/builds/slave/test', 14:13:41 INFO - 'SHELL': '/bin/bash', 14:13:41 INFO - 'SHLVL': '1', 14:13:41 INFO - 'TERM': 'linux', 14:13:41 INFO - 'TMOUT': '86400', 14:13:41 INFO - 'USER': 'cltbld', 14:13:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:41 INFO - '_': '/tools/buildbot/bin/python'} 14:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:13:42 INFO - Running setup.py (path:/tmp/pip-jlwtED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:13:42 INFO - Running setup.py (path:/tmp/pip-9Gkoi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:13:42 INFO - Running setup.py (path:/tmp/pip-0U0fmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:13:42 INFO - Running setup.py (path:/tmp/pip-_uUJoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:13:42 INFO - Running setup.py (path:/tmp/pip-uWgYy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:13:42 INFO - Running setup.py (path:/tmp/pip-_4c5TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:13:42 INFO - Running setup.py (path:/tmp/pip-Q9N_qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:13:42 INFO - Running setup.py (path:/tmp/pip-cRYDNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:13:42 INFO - Running setup.py (path:/tmp/pip-hUISyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:13:42 INFO - Running setup.py (path:/tmp/pip-5jOF6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:13:42 INFO - Running setup.py (path:/tmp/pip-lcFlti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:13:42 INFO - Running setup.py (path:/tmp/pip-875beW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:13:42 INFO - Running setup.py (path:/tmp/pip-i6c0o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:13:43 INFO - Running setup.py (path:/tmp/pip-iXe_IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:43 INFO - Running setup.py (path:/tmp/pip-pvrv9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:13:43 INFO - Running setup.py (path:/tmp/pip-8ezm2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:13:43 INFO - Running setup.py (path:/tmp/pip-iGoDcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:13:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:13:43 INFO - Running setup.py install for manifestparser 14:13:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:13:43 INFO - Running setup.py install for mozcrash 14:13:43 INFO - Running setup.py install for mozdebug 14:13:43 INFO - Running setup.py install for mozdevice 14:13:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:13:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:13:43 INFO - Running setup.py install for mozfile 14:13:43 INFO - Running setup.py install for mozhttpd 14:13:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:13:43 INFO - Running setup.py install for mozinfo 14:13:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Running setup.py install for mozInstall 14:13:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Running setup.py install for mozleak 14:13:44 INFO - Running setup.py install for mozlog 14:13:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Running setup.py install for moznetwork 14:13:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Running setup.py install for mozprocess 14:13:44 INFO - Running setup.py install for mozprofile 14:13:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Running setup.py install for mozrunner 14:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:13:44 INFO - Running setup.py install for mozscreenshot 14:13:44 INFO - Running setup.py install for moztest 14:13:44 INFO - Running setup.py install for mozversion 14:13:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:13:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:13:45 INFO - Cleaning up... 14:13:45 INFO - Return code: 0 14:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:45 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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:13:45 INFO - Using env: {'DISPLAY': ':0', 14:13:45 INFO - 'HOME': '/home/cltbld', 14:13:45 INFO - 'LANG': 'en_US.UTF-8', 14:13:45 INFO - 'LANGUAGE': 'en_US:en', 14:13:45 INFO - 'LOGNAME': 'cltbld', 14:13:45 INFO - 'MAIL': '/var/mail/cltbld', 14:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:45 INFO - 'MOZ_NO_REMOTE': '1', 14:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:45 INFO - 'NO_EM_RESTART': '1', 14:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:45 INFO - 'PWD': '/builds/slave/test', 14:13:45 INFO - 'SHELL': '/bin/bash', 14:13:45 INFO - 'SHLVL': '1', 14:13:45 INFO - 'TERM': 'linux', 14:13:45 INFO - 'TMOUT': '86400', 14:13:45 INFO - 'USER': 'cltbld', 14:13:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:45 INFO - '_': '/tools/buildbot/bin/python'} 14:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:13:45 INFO - Running setup.py (path:/tmp/pip-WacO7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:13:45 INFO - Running setup.py (path:/tmp/pip-W6ZtUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:13:45 INFO - Running setup.py (path:/tmp/pip-1S5hyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:13:45 INFO - Running setup.py (path:/tmp/pip-3oUFb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:13:45 INFO - Running setup.py (path:/tmp/pip-uRugQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:13:45 INFO - Running setup.py (path:/tmp/pip-7cKaX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:13:45 INFO - Running setup.py (path:/tmp/pip-TKs08v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:13:45 INFO - Running setup.py (path:/tmp/pip-qJM39I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:13:45 INFO - Running setup.py (path:/tmp/pip-gpfr3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:13:45 INFO - Running setup.py (path:/tmp/pip-J88Qxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:13:46 INFO - Running setup.py (path:/tmp/pip-CS8v6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:13:46 INFO - Running setup.py (path:/tmp/pip-wqIHuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:13:46 INFO - Running setup.py (path:/tmp/pip-qponc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:13:46 INFO - Running setup.py (path:/tmp/pip-8ODzyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:46 INFO - Running setup.py (path:/tmp/pip-ZOK2jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:13:46 INFO - Running setup.py (path:/tmp/pip-kD_H2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:13:46 INFO - Running setup.py (path:/tmp/pip-Jmai8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:13:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13:48 INFO - Downloading blessings-1.6.tar.gz 14:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:13:48 INFO - Installing collected packages: blessings 14:13:48 INFO - Running setup.py install for blessings 14:13:48 INFO - Successfully installed blessings 14:13:48 INFO - Cleaning up... 14:13:48 INFO - Return code: 0 14:13:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:48 INFO - Reading from file tmpfile_stdout 14:13:48 INFO - Current package versions: 14:13:48 INFO - argparse == 1.2.1 14:13:48 INFO - blessings == 1.6 14:13:48 INFO - blobuploader == 1.2.4 14:13:48 INFO - docopt == 0.6.1 14:13:48 INFO - functools32 == 3.2.3-2 14:13:48 INFO - jsonschema == 2.5.1 14:13:48 INFO - manifestparser == 1.1 14:13:48 INFO - mozInstall == 1.12 14:13:48 INFO - mozcrash == 0.17 14:13:48 INFO - mozdebug == 0.1 14:13:48 INFO - mozdevice == 0.48 14:13:48 INFO - mozfile == 1.2 14:13:48 INFO - mozhttpd == 0.7 14:13:48 INFO - mozinfo == 0.9 14:13:48 INFO - mozleak == 0.1 14:13:48 INFO - mozlog == 3.4 14:13:48 INFO - moznetwork == 0.27 14:13:48 INFO - mozprocess == 0.23 14:13:48 INFO - mozprofile == 0.28 14:13:48 INFO - mozrunner == 6.12 14:13:48 INFO - mozscreenshot == 0.1 14:13:48 INFO - mozsystemmonitor == 0.3 14:13:48 INFO - moztest == 0.7 14:13:48 INFO - mozversion == 1.4 14:13:48 INFO - psutil == 3.1.1 14:13:48 INFO - requests == 1.2.3 14:13:48 INFO - wsgiref == 0.1.2 14:13:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:48 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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:13:48 INFO - Using env: {'DISPLAY': ':0', 14:13:48 INFO - 'HOME': '/home/cltbld', 14:13:48 INFO - 'LANG': 'en_US.UTF-8', 14:13:48 INFO - 'LANGUAGE': 'en_US:en', 14:13:48 INFO - 'LOGNAME': 'cltbld', 14:13:48 INFO - 'MAIL': '/var/mail/cltbld', 14:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:48 INFO - 'MOZ_NO_REMOTE': '1', 14:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:48 INFO - 'NO_EM_RESTART': '1', 14:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:48 INFO - 'PWD': '/builds/slave/test', 14:13:48 INFO - 'SHELL': '/bin/bash', 14:13:48 INFO - 'SHLVL': '1', 14:13:48 INFO - 'TERM': 'linux', 14:13:48 INFO - 'TMOUT': '86400', 14:13:48 INFO - 'USER': 'cltbld', 14:13:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:48 INFO - '_': '/tools/buildbot/bin/python'} 14:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:13:49 INFO - Cleaning up... 14:13:49 INFO - Return code: 0 14:13:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:49 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 0x7f56f02f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a45ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:13:49 INFO - Using env: {'DISPLAY': ':0', 14:13:49 INFO - 'HOME': '/home/cltbld', 14:13:49 INFO - 'LANG': 'en_US.UTF-8', 14:13:49 INFO - 'LANGUAGE': 'en_US:en', 14:13:49 INFO - 'LOGNAME': 'cltbld', 14:13:49 INFO - 'MAIL': '/var/mail/cltbld', 14:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:49 INFO - 'MOZ_NO_REMOTE': '1', 14:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:49 INFO - 'NO_EM_RESTART': '1', 14:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:49 INFO - 'PWD': '/builds/slave/test', 14:13:49 INFO - 'SHELL': '/bin/bash', 14:13:49 INFO - 'SHLVL': '1', 14:13:49 INFO - 'TERM': 'linux', 14:13:49 INFO - 'TMOUT': '86400', 14:13:49 INFO - 'USER': 'cltbld', 14:13:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:49 INFO - '_': '/tools/buildbot/bin/python'} 14:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:13:49 INFO - Cleaning up... 14:13:49 INFO - Return code: 0 14:13:49 INFO - Running post-action listener: _resource_record_post_action 14:13:49 INFO - Running post-action listener: _start_resource_monitoring 14:13:49 INFO - Starting resource monitoring. 14:13:49 INFO - [mozharness: 2016-09-21 21:13:49.401010Z] Finished create-virtualenv step (success) 14:13:49 INFO - [mozharness: 2016-09-21 21:13:49.401459Z] Running install step. 14:13:49 INFO - Running pre-action listener: _resource_record_pre_action 14:13:49 INFO - Running main action method: install 14:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:49 INFO - Reading from file tmpfile_stdout 14:13:49 INFO - Detecting whether we're running mozinstall >=1.0... 14:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:13:49 INFO - Reading from file tmpfile_stdout 14:13:49 INFO - Output received: 14:13:49 INFO - Usage: mozinstall [options] installer 14:13:49 INFO - Options: 14:13:49 INFO - -h, --help show this help message and exit 14:13:49 INFO - -d DEST, --destination=DEST 14:13:49 INFO - Directory to install application into. [default: 14:13:49 INFO - "/builds/slave/test"] 14:13:49 INFO - --app=APP Application being installed. [default: firefox] 14:13:49 INFO - mkdir: /builds/slave/test/build/application 14:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:14:05 INFO - Reading from file tmpfile_stdout 14:14:05 INFO - Output received: 14:14:05 INFO - /builds/slave/test/build/application/firefox/firefox 14:14:05 INFO - Running post-action listener: _resource_record_post_action 14:14:05 INFO - [mozharness: 2016-09-21 21:14:05.764353Z] Finished install step (success) 14:14:05 INFO - [mozharness: 2016-09-21 21:14:05.764599Z] Running run-tests step. 14:14:05 INFO - Running pre-action listener: _resource_record_pre_action 14:14:05 INFO - Running main action method: run_tests 14:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:14:05 INFO - Python 2.7.3 14:14:05 INFO - Return code: 0 14:14:05 INFO - grabbing minidump binary from tooltool 14:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:05 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 0x1a42f60>, '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 0x1a43d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a441d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:14:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:14:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:14:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:14:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:14:05 INFO - Return code: 0 14:14:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:14:05 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/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 14:14:05 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/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 14:14:05 INFO - Using env: {'DISPLAY': ':0', 14:14:05 INFO - 'HOME': '/home/cltbld', 14:14:05 INFO - 'LANG': 'en_US.UTF-8', 14:14:05 INFO - 'LANGUAGE': 'en_US:en', 14:14:05 INFO - 'LOGNAME': 'cltbld', 14:14:05 INFO - 'MAIL': '/var/mail/cltbld', 14:14:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:14:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:05 INFO - 'MOZ_NO_REMOTE': '1', 14:14:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:05 INFO - 'NO_EM_RESTART': '1', 14:14:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:05 INFO - 'PWD': '/builds/slave/test', 14:14:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:14:05 INFO - 'SHELL': '/bin/bash', 14:14:05 INFO - 'SHLVL': '1', 14:14:05 INFO - 'TERM': 'linux', 14:14:05 INFO - 'TMOUT': '86400', 14:14:05 INFO - 'USER': 'cltbld', 14:14:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248', 14:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:05 INFO - '_': '/tools/buildbot/bin/python'} 14:14:05 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/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 14:14:06 INFO - mozversion application_buildid: 20160921130600 14:14:06 INFO - mozversion application_changeset: 6957fdb6a7128810bc9a8ba1f871eede183dd9f2 14:14:06 INFO - mozversion application_display_name: Nightly 14:14:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:14:06 INFO - mozversion application_name: Firefox 14:14:06 INFO - mozversion application_remotingname: firefox 14:14:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:14:06 INFO - mozversion application_vendor: Mozilla 14:14:06 INFO - mozversion application_version: 52.0a1 14:14:06 INFO - mozversion platform_buildid: 20160921130600 14:14:06 INFO - mozversion platform_changeset: 6957fdb6a7128810bc9a8ba1f871eede183dd9f2 14:14:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:14:06 INFO - mozversion platform_version: 52.0a1 14:14:06 INFO - using testdate: 1474492446 14:14:06 INFO - actual date: 1474492446 14:14:06 INFO - starting webserver on 'localhost:53884' 14:14:06 INFO - SUITE-START | Running 2 tests 14:14:06 INFO - TEST-START | dromaeo_css 14:14:06 INFO - operating with platform_type : linux_ 14:14:06 INFO - Initialising browser for dromaeo_css test... 14:14:06 INFO - TEST-INFO | started process 30497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph2utsZ/profile http://localhost:53884/getInfo.html) 14:14:10 INFO - PROCESS | 30497 | __metrics Screen width/height:1600/1200 14:14:10 INFO - PROCESS | 30497 | colorDepth:24 14:14:10 INFO - PROCESS | 30497 | Browser inner width/height: 1024/697 14:14:10 INFO - PROCESS | 30497 | __metrics 14:14:10 INFO - PROCESS | 30497 | 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" 14:14:10 INFO - PROCESS | 30497 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:14:11 INFO - PROCESS | 30497 | console.error: PushService: 14:14:11 INFO - PROCESS | 30497 | stateChangeProcessEnqueue: Error transitioning state 14:14:11 INFO - PROCESS | 30497 | UnknownError 14:14:11 INFO - TEST-INFO | 30497: exit 0 14:14:11 INFO - Browser initialized. 14:14:11 INFO - Running cycle 1/1 for dromaeo_css test... 14:14:11 INFO - TEST-INFO | started process 30579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph2utsZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:14:24 INFO - PROCESS | 30579 | RSS: Main: 175140864 14:14:24 INFO - PROCESS | 30579 | 14:15:15 INFO - PROCESS | 30579 | 1474492515915 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:17:27 INFO - PROCESS | 30579 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53884/tests/dromaeo/cssquery-ext.html) 14:17:28 INFO - PROCESS | 30579 | RSS: Main: 300302336 14:17:28 INFO - PROCESS | 30579 | 14:20:31 INFO - PROCESS | 30579 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-ext.html (next: http://localhost:53884/tests/dromaeo/cssquery-jquery.html) 14:20:32 INFO - PROCESS | 30579 | RSS: Main: 273747968 14:20:32 INFO - PROCESS | 30579 | 14:23:34 INFO - PROCESS | 30579 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53884/tests/dromaeo/cssquery-mootools.html) 14:23:35 INFO - PROCESS | 30579 | RSS: Main: 219926528 14:23:35 INFO - PROCESS | 30579 | 14:26:37 INFO - PROCESS | 30579 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53884/tests/dromaeo/cssquery-prototype.html) 14:26:38 INFO - PROCESS | 30579 | RSS: Main: 219275264 14:26:38 INFO - PROCESS | 30579 | 14:29:41 INFO - PROCESS | 30579 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53884/tests/dromaeo/cssquery-yui.html) 14:29:42 INFO - PROCESS | 30579 | RSS: Main: 219602944 14:29:42 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | Cycle 1(1): loaded http://localhost:53884/tests/dromaeo/cssquery-yui.html (next: http://localhost:53884/tests/dromaeo/cssquery-dojo.html) 14:32:45 INFO - PROCESS | 30579 | RSS: Main: 310001664 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | __start_tp_report 14:32:45 INFO - PROCESS | 30579 | _x_x_mozilla_page_load 14:32:45 INFO - PROCESS | 30579 | _x_x_mozilla_page_load_details 14:32:45 INFO - PROCESS | 30579 | |i|pagename|runs| 14:32:45 INFO - PROCESS | 30579 | |0;dojo.html;2558.846469211847;2572.09976508222;2601.9982306811876;2614.7908167346613;2628.973710262898;4515.503294637587;4603.7928293226805;4656.092062047902;4698.27176787598;4699.412573428322;4640.907181856361;4659.603933665642;4659.998100408411;4705.106029854325;4725.243960966246;4271.188474189894;4291.549387314334;4309.944063704381;4327;4397.890052748675;4377.7592232427205;4418.248897687385;4420.182266280733;4422.292433210687;4441.178381999341;4227.661787057028;4277.850275240383;4389.122175564899;4427.756473393962;4453.087117140978;4309.030468144674;4311.611954924072;4319.805608747614;4358.0412309291905;4434.201843668138;4310.4396428464415;4323.113761678848;4325.026868954492;4331.5018772840895;4372.40972468719;4681.297805329194;4702.3181638662545;4706.599939005188;4707.6233901287815;4734.83428080019;4828.830990915336;4884.755762211911;4994.225894986283;5024.572911302544;5028.019536190444;5044.243363495469;5075.746212689388;5076.720780357079;5085.872853178663;5120.436751957282;4683.391159149289;4707.082118986833;4724.149653062447;4750.168720473903;4769.499202583748;4991.126552853236;5042.647014708935;5090.440051594322;5124.948750512522;5142.460041695568;4948.035133149001;4950.727709975986;5005.724685142352;5008.649394542347;5012.899742005139;5013.498650134958;5016.749162541858;5019.447860735316;5025.447200807908;5084.847454576368;4857.149998750205;4910.877228069256;4963.6525443218625;4980.900381992412;5038.370203724535;4891.902161956741;4922.212446008693;4923.187674033816;4954.405471343462;4978.751062446863;4090.5091389033505;4093.201825643971;4094.8566800161852;4136.98643832257;4142.378643203544;3596.047047532406;3602.3875941089555;3609.3683605368956;3640.2173532690067;3676.6323367663554;4297.484301883794;4326.048269380732;4359.520452750195;4368.366586844953;4376.431063961664;4956.578690811321;4999.125153098194;4999.800007999712;5003.524665156804;5032.396112466454;4353.956460435355;4354.825806967686;4359.258925982591;4395.252807022814;4403.757793321334;4429.158459892675;4440.777961101932;4441.622462090694;4463.598276155097;4491.101779644085;4787.473377928494;4837.443693975097;4837.56461918415;4845.515448455127;4846.29728689331;5049.166887463527;5056.165732654071;5059.19052951526;5060.2156665716875;5120.692758434357;4668.463126740468;4762.357081794052;4769.2130798417875;4775.044991001744;4831.782569784298;4865.343178670834;4884.0476107158765;4923.359963204761;4939.901201976012;5005.7997680092385;4984.302197692398;5005.274235235943;5020.322256495472;5027.27104569828;5091.261767043684;4867.172580661225;4880.072786170616;4897.9020419592125;4899.853004409873;4950.2079667253065;4718.433787945469;4812.085703716282;4887.486813884491;4932.087563800708;4951.77717002743;4861.683990540603;4865.805367785249;4867.569828392678;4881.121398148367;4927.359443272351;4978.103941290602;4980.128477516348;4981.476944920876;4982.800687972585;5023.6985780853265;4740.525947405232;4790.8323208687525;4793.376861008047;4858.6356023297685;4911.852644420673 14:32:45 INFO - PROCESS | 30579 | |1;ext.html;551.7544692611787;559.8376470823462;568.8407245971127;571.9561799715517;574.224796524692;28216.43567128659;30816.691833081662;31088;37293.254134917355;38537.614623853755;40201.39697904534;40495.545489996075;40572.79713601435;40625;40671.38992915109;7322.450816188793;7451.7019319227165;7457.5152615080115;7460.1420836603675;7461.850762984737;6980.336867997532;7145.928540714578;7158.246229673738;7310.2689731027;7682.423818213629;9761.804763904718;10010.199184065257;10013.599456021786;10392.584296628125;10426.165906727443;9870;9919.256055795844;9932.155766759763;9953.30326877119;9955.80088398228;9674;9917.454540000297;9921.107100361001;9922.751931201705;9957.651482198089;37393;37444.81277593622;37678;37687.81156094202;37806.81096594499;3030.6060212172497;3077.261457250266;3235.48232282836;3290.3583801158784;3584.3727347714307;27634;28173;28380.290492737848;28402.85798570994;28502.71497285021;3465.7747246429153;3522.8590856365713;3658.762180458262;3699.72252081095;3707.9814600926825;246450;248359;248501.9999999982;248563;248656;30960.845195774327;31831.52252716211;43507.12985740267;43556;43563.346549801776;32737.18157046093;32849.17877053045;32876.67123328784;32909.83545082259;33097.338053238804;12047.096467764954;12176.086793490524;12181.634550963485;12211;12227.816582751266;10251.38491690501;10255.9487202565;10322.638707645196;10393.06462418386;10402.115820155372;7133.89299160513;7331.963340183265;7334.779956601311;7694.499857509244;7795.727149549739;2845.928851778681;2887.797854150231;2970.1089673097986;3045.086474057818;3048.2531779714113;854.3293514591016;855.6149732620346;876.3296078499952;876.5836227791875;908.4458480326995;26871.462570748867;27894.581581276296;28074.71925280762;28300.85849570739;28331.858340708164;927.5733162745213;937.1565590968047;945.1965829045394;950.2065775077749;955.6464108279841;14208.64478388028;14546.199959002144;14721;15021.624459388602;15081.849181508045;364991;371508;372064;372452;372470;47979;48453.27320090202;48521.272180917316;48552;48568.7571562147;972.7616733900239;1100.5432745410565;1108.872479664849;1130.519529200103;1191.065013964034;27566.310842229104;28870.71129288764;29135.708642913298;29267;29683.851580741957;35088.29823403569;35312.47031294584;35395.29209415849;35396;35451.64548354483;301224;302255;302838;303367.9442891898;303439;24227.51544969126;24684.629730554414;24821;26126;26277.474450511265;41333.37999929943;41653.375199371425;41918.58081419147;42543.7872810634;45320.32019519776;34997.82501087478;35067.298654026265;35429.46855797217;35696;35937.82031089828;35145;35332.47001295034;35578.28843423169;35747;35882.64117358898;35216.29567408689;35272.647273526934;35278.82360588181;35313.47029794606;36386.09034774152;30693.53959690562;32726.34547309088;32794;33183.502247465825;33218.83390583032;24692.506149877263;24898.751012490367;24988.62517062209;25473.0402970356;25720.871395642902 14:32:45 INFO - PROCESS | 30579 | |2;jquery.html;339.3874057326526;347.94606835940436;365.48284177888286;366.66999700269764;390.16310015017785;12243.449044792984;15658.765118523217;15964.521064368073;17270.56823579411;17495.650086998252;16710.415135470263;16971.15144242789;17007.404740834074;17130.486085417426;17253.741193882102;4905.337779399771;5026.195808670614;5139.794408223666;5172.353455818023;5182.870428239286;3689.317476266886;3880.7865567393783;5099.337086178792;5184.196449550307;5185.662931909414;3841.3661745811905;3904.2386734586767;3908.2965066288057;3955.545112312078;5789;5863.149843272744;5868.501177399926;5885.293764748215;5887.8528036799;5888.882222355529;5057.772400241998;5123.564497017758;5268.341457317835;5287.735613219362;5298.337707786527;20653.070611822503;20682.58634827295;20802.375928722162;20834.895825520925;20867.060982255683;1754.4911975527082;1784.696601577735;1805.0974512743628;1844.2622950819646;1950.288144827142;8730.476171429735;8738.169873861973;8937.419067760575;9115;9360.251179905592;1680.0927499150444;1705.744138379253;1707.4974022859928;1735.0977491704368;1784.4825000749768;62465.37534624687;68634;68872;70433.29566704319;72266.91599626062;10066.69799906004;10098.192144628412;10234.897651023542;10296.279260451845;10338.793224135625;13671.521496747766;13706.862931370759;13774.104683195761;13796.310184490936;13814.861851381558;7263.237360077116;7300.160481544584;7431.182569917305;7465.888011679829;7501.062367204099;6983.650817459208;7076.504644674823;7212.459065570103;7251.238619944936;7279.67241474135;4216.2832318505925;4289.378040184156;4376.824927002948;4406.669499787528;4472.8210871565425;1611.5971007248188;1841.9815801842078;1851.1577232359514;1861.3950466098572;1896.5069082038494;722.9927700723031;769.9114601820751;795.308081968691;824.4929368438487;865.1564724393792;15669.373225071098;16014.359425623077;16278.43025494102;16452.670946581;16781.077040762877;819.9754007379788;827.4414770030205;828.5774255129927;845.2223953962247;901.6258252825136;8254.504729716236;9413.435193888388;9616.855747163798;9664.293997680661;9776.51117444125;337952;385192;389632;390240;390690;72400.27599723935;75252.62373688097;77805;77858;78004.60997694975;869.5695630662863;886.3751055505853;886.5434301334818;888.4891187567175;889.8620713789373;14454.27728613586;14821.25893705332;14831;14939.103653780809;15357.155356455502;34092.488612671325;35395.64604353924;36773.26453470969;38686;39321.60678393179;46942.29586556136;47715.76142119267;48868.5113148864;52934.73532632312;55141.44858551524;7077.68150433242;7120.323569260912;7326.523775954759;7519.661615227437;7813.531188128731;11375.488103035548;11383.829242561535;11946.522139114339;12147.696307592381;12269.877301226874;9894.901050989398;9907.900920990698;10324.48377581133;10698.73253168677;10809.945950270197;9454.101860323259;9737.561809718722;9825.115739583473;9964.50177491137;10222.591096356062;10335.844962325722;10339.431331276852;10376.273660843668;10387.584496620353;10597.788044239227;7259.745908893164;7357.374623157091;7384.815379615553;7506.774796755888;7639.388848891964;8932.687355942511;10276.383416995004;10511.737206569896;10515.15878729715;11075.169362298022 14:32:45 INFO - PROCESS | 30579 | |3;mootools.html;1245.545375937782;1345.1055048392818;1368.8083668286442;1379.6275005748441;1709.0009378055347;6505.447037001854;7535.547867127969;7803.258690424408;7807.531548107103;8072.990876140482;7854;7906.051273847132;7914.366850651934;7922.247386498273;7928.5242885426915;2159.7516285627157;2177.2706143441965;2178.9128434862664;2185.7704940981125;2186.1036974840317;2118.54451292972;2151.7955794199606;2155.795199456049;2156.6764985252257;2164.9242276520326;2093.822025127866;2132.5841460915126;2137.8824164670937;2144.9785502145014;2176.1186719378675;2129.5102126510833;2132.1791110422446;2133.5626196629655;2135.3060255417054;2141.2719675310314;2026.7770545240012;2110.4934815644133;2112.039022244875;2112.8732276063483;2116.1958455786857;7741.380689544823;7884.881726774103;7935.801604959865;8045.678172873078;8052.43632945694;4395.099004704028;4538.931916021263;4579.816807327703;4582.427196600425;4590.196715574794;2870.669872964594;2995.3110784519463;3044.101989912981;3048.8628011739524;3062.3569050499423;920.8756817829641;924.4684306523709;942.472215559289;943.7168849345238;944.4097439100562;10487.213458990529;10621.41582212978;10646.787064258671;10657.946710266477;10664.946675266652;3927.3912543555225;4045.7167998239843;4050.432939388488;4067.1458993611673;4286.678499112579;7990.4406691532195;8132;8134.877976830352;8137.308328792119;8202.671893124209;4463.709858859163;4469.843555475608;4472.552744725502;4474.731516109044;4483.2602620567895;3625.3836847735947;3768.4724138620613;3921.450996860442;4161.791910404468;4162.771047592351;3350.497425386163;3352.949705754416;3435.347284016029;3455.1707590178175;3471.2016236265295;1011.9696409107738;1033.788073444942;1038.7974345002651;1039.3867618105203;1046;579.7593998490579;707.8938159276047;751.3838652305058;798.7284323330096;817.2032268538246;4932.778024988884;5077.771500282496;5228.9477105229225;5341.198820176927;5482.342118945672;818.1818181818181;829.6764261937849;874.1826392323071;889.355217467331;897.3718397122041;3308.4375656138513;3367.1582104473882;3496.3531746626445;3503.404421248394;3595.6404359563835;9482.668106616235;9660.903390966001;9772.609095636237;9775.31572789912;9796.314258002014;9710.660126895666;9720.854187187198;9722.902770972341;9725.0761177688;9729.61081556744;7344.081989751281;7372.373348265458;7415.925840741524;7498.475106742476;7510.812229694301;5091.949080509147;5092.8472145835685;5112.36095488064;5158.123119069692;5189.558887494605;8792;8980.506072165832;9004.774880627774;9043.377420547968;9122.817543649222;9122.543872806466;9220.907790922005;9222.354435189472;9274.118958698913;9285.953570232106;5597.552195824405;5872.060470324898;6109.602875813058;6216.378362163748;6229;6972.58164510131;7261;7285.963570182115;7460.776176714708;7461.179270280156;6459.483241340776;6509.967450162909;6610.537262391586;6675.766348177791;6712.9664351679885;6260.68696565179;6456.289808121197;6473.093766872736;6598.571092878948;6609.272979972296;6044.486218671462;6124.6325220486915;6125.9693701531205;6142.815715528542;6145.938540614537;4466.5086840448175;4482.125985432809;4496.37050812893;4544.863654090383;4580.725156490621;4499.640028797754;4585.426821647294;4608.400907881954;4641.582257596698;4667.043256132417 14:32:45 INFO - PROCESS | 30579 | |4;prototype.html;295.74418128318996;295.75747886732887;297.3072740514601;299.5357196345664;307.68462326115736;4822.421309442868;4840.782164802584;4841.201201801708;4851.078295123924;4881.585065269447;4485.564619321818;4769.8807529811775;4788.832390866321;4820.83127090551;4833.468318484964;3686.6037075900613;3707.2214834884708;3767.4537192107127;3800.9429858552144;3844.4233364995334;3812.2756676231566;3816.503854498911;3822.8661996830115;3826;3827.3302172119766;3578.159132603836;3791.5829258781514;3801.277757226132;3806.5812760596314;3812.3519001769764;3645.5260816094005;3672.265546890633;3744.588095309514;3750.9309846693563;3775.8300876460626;3349.598048234203;3350.96649033509;3360.143163493318;3363.3441478911623;3383.8646454141804;4694.929576056362;4701.224297990828;4703.988642441891;4706.952930470686;4713.764311784432;4223.007593215591;4347.739135651871;4350.390945267665;4352.542982986773;4357.41174941382;4952.529509696573;5033.672811267256;5040.16837221858;5040.949590504085;5042.495750424928;3721.864831226475;3724.6461586149544;3740.3267411865854;3749.2501499699897;3756.3614185588517;5039.168537191359;5308.336457942757;5329.800794821173;5389.9191512127345;5396.514313711785;3623.3477973964414;3636.7272454566014;3646.234290798962;3648.4527320902075;3650.233450975272;3700.259948010355;3719.962800372016;3723.478712980185;3733.701303895682;3744.3260213161893;4263.8081286342185;4283.336082907154;4295.548967358445;4306.418633484503;4306.633936115402;4805.255185446262;5025;5076.822311219164;5101.846944591668;5111.361079865017;1330.7405056014177;1335.7177109974534;1335.9532416365576;1339.6717804137854;1346.8585798491213;843.8059246373368;849.5582297205418;850.4047166983013;858.4076986879033;882.6292956958093;4414.602685758297;4494.910101797946;4511.390962220058;4519.751413672214;4546.74992875395;5208.958208358267;5218.191180367049;5222.321098257202;5231.9476805232225;5245.291885595472;4295.4415925929425;4504.864854054384;4512.2554778461845;4534.251848445036;4554.476235232991;2732.7429382483883;2749.4913441013477;2766.349907771672;2769.2661444717164;2779.652543432071;4906.852794416173;4908.460069392436;4919.508049195052;4926.3989203509;4949.193544356284;5070.898582028339;5255.264263003182;5315.3621565412395;5331.960267747752;5356.276902618175;4922.261660750844;4924.823488849744;4953.3065370848835;4969.27945447908;4975.950240497548;5197.7141257231215;5221.347331583552;5249.501297376743;5249.527542521191;5261.131913234273;4934.827281045146;5099.6685215460875;5105.361829771278;5111.974440127924;5123.23151527259;4948.579370753526;4949.7030178189425;4951.331570237971;4952.801887924443;4953.399465280757;3804.6385593368586;3810.2760475509563;3813.9618603813606;3828.73198876076;3832.3293423651307;4980.526849949249;5155.252488389237;5271.71005594696;5274.156135018532;5283.762230699551;5043.798248070036;5051.166557518115;5058.077930386429;5061;5075.695458272516;5043.87390315245;5050.873728156826;5062.2406639002975;5072.9746351268;5092.567131793691;4823.324734537097;4912.214045752662;4932.827351042696;4975.850724478127;4992.975035124801;4839.274108883696;4927.236278376858;4984.875378115431;5073.949260507347;5077.263796749525;4936.950630493793;4965.45380008206;4965.900681986413;4993.076280888047;4998.875028124326 14:32:45 INFO - PROCESS | 30579 | |5;yui.html;631.3875540725496;692.165940042249;703.4723957032222;732.3226015935262;739.9963000184998;12397.752044959107;13403.932980335108;13444.52944146955;13607.931960340196;13620.591382258523;13060.477580896777;13189.142705724145;13194.34028298586;13196.60410187696;13483.46066157355;731.4185222747901;755.1202848681307;755.3730403764862;758.1395116542709;761.1057008015559;610.6244659534376;627.9780207692709;762.4662736084736;764.464874587788;765.5406755946416;656.4846595422595;658.6443320606867;658.6673729766485;765.5559775330323;784.380339531772;785.5129819511939;788.8422315536886;789.6841263494591;790.9011373578331;794.06697130871;572.8510587247346;572.862512996882;573.0144152058452;578.3291381996905;578.8813293274868;10275.743106422324;10719.62481313158;11167.888321116767;11174.720631984266;12724.427400766896;12139.696507587292;12854.742905141939;13301.268430236332;13320.800187997187;13943.023988320821;10670.253082284244;10695.411752353617;10723.14214862809;10780.083692886114;10949.83575246372;3334.2664613785173;3405.4551271796395;3413.3343997920415;3422.469517224834;3511.227529943408;64730.676346618435;65088.34911650918;65520.48233729585;65936.67031664858;65967.67016164889;9306.290944987793;9767.267454940908;9925.305228633926;9934.950325248328;9977.846964435299;19196;19281.325153619837;19348;19383.612327753366;19387.709184362247;6916.135483064617;7030.718771249195;7118.216996130422;7224.602646854473;7237.131544214728;3751.8311675974646;3849.576546579874;3888;3913.9804300978312;3930;2980.225141463235;3065.5095184770776;3081.8613162407296;3087.21276074604;3088.258817883692;510.4436164580625;512.7154429291779;515.4201523286303;521.0750917122062;527.8759491519489;568.0659394228844;593.9079442686391;594.4590422715395;616.1712496691943;621.1397214857365;7716.72991445308;7752.5348479091435;7820.960895195602;7843.450958432855;8194.975628046494;515.9963870272285;538.4991957479582;543.2638774460628;555.2809112199711;564.9858753531195;3657.7256705747177;3785.5078839750654;3792.791396473165;3800.809959502014;3908.7263891527887;59093.40906590965;100465;100666.49666751765;105953.47023264988;106743.46628266809;48979.26531102036;51373.74313128485;51783.48216517787;84475.5776221115;88786.55606722055;80167.59916200499;81746.59126704329;82158.17841821506;83265;83360.99502089682;7373.543577752532;7551.73568925085;7694.2571344806465;7806.609669516388;7841.803954901173;36382.454263186606;38118.61881381151;47803.52196477991;48818.5118148814;51063.74468127636;37595.2480950374;39253.60746392499;52977;58436;61196;10579.89420105789;10806.567737290421;11470.197086203885;11710.1217408693;12085.456154473246;12170.57402990891;12857.678558036125;13143.802842957171;13403.530876419278;13612.319384030561;10759.408232547285;11018.338899666045;11120.165987550805;11242.775144497227;11484.712882178012;11422;11935.52257909674;12610.936945315214;12784.808227876403;12798.936005319914;11589.304641721523;11594.94202528982;11762.294262344287;12255.632331030083;12532.483108783565;10423.322484038514;10467.528961196916;10537.157027437634;10935.890641093805;11400.651465798217;9954.55204515813;10547.314424562379;10784.946075269574;10869;10895.509702063584 14:32:45 INFO - PROCESS | 30579 | __end_tp_report 14:32:45 INFO - PROCESS | 30579 | __start_cc_report 14:32:45 INFO - PROCESS | 30579 | _x_x_mozilla_cycle_collect,1150 14:32:45 INFO - PROCESS | 30579 | __end_cc_report 14:32:45 INFO - PROCESS | 30579 | __startTimestamp1474493565567__endTimestamp 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | ------- Summary: start ------- 14:32:45 INFO - PROCESS | 30579 | Number of tests: 6 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | [#0] dojo.html Cycles:165 Average:4639.08 Median:4790.83 stddev:494.84 (10.3%) stddev-sans-first:468.68 14:32:45 INFO - PROCESS | 30579 | Values: 2558.8 2572.1 2602.0 2614.8 2629.0 4515.5 4603.8 4656.1 4698.3 4699.4 4640.9 4659.6 4660.0 4705.1 4725.2 4271.2 4291.5 4309.9 4327.0 4397.9 4377.8 4418.2 4420.2 4422.3 4441.2 4227.7 4277.9 4389.1 4427.8 4453.1 4309.0 4311.6 4319.8 4358.0 4434.2 4310.4 4323.1 4325.0 4331.5 4372.4 4681.3 4702.3 4706.6 4707.6 4734.8 4828.8 4884.8 4994.2 5024.6 5028.0 5044.2 5075.7 5076.7 5085.9 5120.4 4683.4 4707.1 4724.1 4750.2 4769.5 4991.1 5042.6 5090.4 5124.9 5142.5 4948.0 4950.7 5005.7 5008.6 5012.9 5013.5 5016.7 5019.4 5025.4 5084.8 4857.1 4910.9 4963.7 4980.9 5038.4 4891.9 4922.2 4923.2 4954.4 4978.8 4090.5 4093.2 4094.9 4137.0 4142.4 3596.0 3602.4 3609.4 3640.2 3676.6 4297.5 4326.0 4359.5 4368.4 4376.4 4956.6 4999.1 4999.8 5003.5 5032.4 4354.0 4354.8 4359.3 4395.3 4403.8 4429.2 4440.8 4441.6 4463.6 4491.1 4787.5 4837.4 4837.6 4845.5 4846.3 5049.2 5056.2 5059.2 5060.2 5120.7 4668.5 4762.4 4769.2 4775.0 4831.8 4865.3 4884.0 4923.4 4939.9 5005.8 4984.3 5005.3 5020.3 5027.3 5091.3 4867.2 4880.1 4897.9 4899.9 4950.2 4718.4 4812.1 4887.5 4932.1 4951.8 4861.7 4865.8 4867.6 4881.1 4927.4 4978.1 4980.1 4981.5 4982.8 5023.7 4740.5 4790.8 4793.4 4858.6 4911.9 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | [#1] ext.html Cycles:180 Average:44654.60 Median:35295.65 stddev:81955.44 (232.2%) stddev-sans-first:82118.45 14:32:45 INFO - PROCESS | 30579 | Values: 551.8 559.8 568.8 572.0 574.2 28216.4 30816.7 31088.0 37293.3 38537.6 40201.4 40495.5 40572.8 40625.0 40671.4 7322.5 7451.7 7457.5 7460.1 7461.9 6980.3 7145.9 7158.2 7310.3 7682.4 9761.8 10010.2 10013.6 10392.6 10426.2 9870.0 9919.3 9932.2 9953.3 9955.8 9674.0 9917.5 9921.1 9922.8 9957.7 37393.0 37444.8 37678.0 37687.8 37806.8 3030.6 3077.3 3235.5 3290.4 3584.4 27634.0 28173.0 28380.3 28402.9 28502.7 3465.8 3522.9 3658.8 3699.7 3708.0 246450.0 248359.0 248502.0 248563.0 248656.0 30960.8 31831.5 43507.1 43556.0 43563.3 32737.2 32849.2 32876.7 32909.8 33097.3 12047.1 12176.1 12181.6 12211.0 12227.8 10251.4 10255.9 10322.6 10393.1 10402.1 7133.9 7332.0 7334.8 7694.5 7795.7 2845.9 2887.8 2970.1 3045.1 3048.3 854.3 855.6 876.3 876.6 908.4 26871.5 27894.6 28074.7 28300.9 28331.9 927.6 937.2 945.2 950.2 955.6 14208.6 14546.2 14721.0 15021.6 15081.8 364991.0 371508.0 372064.0 372452.0 372470.0 47979.0 48453.3 48521.3 48552.0 48568.8 972.8 1100.5 1108.9 1130.5 1191.1 27566.3 28870.7 29135.7 29267.0 29683.9 35088.3 35312.5 35395.3 35396.0 35451.6 301224.0 302255.0 302838.0 303367.9 303439.0 24227.5 24684.6 24821.0 26126.0 26277.5 41333.4 41653.4 41918.6 42543.8 45320.3 34997.8 35067.3 35429.5 35696.0 35937.8 35145.0 35332.5 35578.3 35747.0 35882.6 35216.3 35272.6 35278.8 35313.5 36386.1 30693.5 32726.3 32794.0 33183.5 33218.8 24692.5 24898.8 24988.6 25473.0 25720.9 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | [#2] jquery.html Cycles:180 Average:23813.91 Median:4333.10 stddev:62698.44 (1447.0%) stddev-sans-first:62849.55 14:32:45 INFO - PROCESS | 30579 | Values: 339.4 347.9 365.5 366.7 390.2 12243.4 15658.8 15964.5 17270.6 17495.7 16710.4 16971.2 17007.4 17130.5 17253.7 4905.3 5026.2 5139.8 5172.4 5182.9 3689.3 3880.8 5099.3 5184.2 5185.7 3841.4 3904.2 3908.3 3955.5 5789.0 5863.1 5868.5 5885.3 5887.9 5888.9 5057.8 5123.6 5268.3 5287.7 5298.3 20653.1 20682.6 20802.4 20834.9 20867.1 1754.5 1784.7 1805.1 1844.3 1950.3 8730.5 8738.2 8937.4 9115.0 9360.3 1680.1 1705.7 1707.5 1735.1 1784.5 62465.4 68634.0 68872.0 70433.3 72266.9 10066.7 10098.2 10234.9 10296.3 10338.8 13671.5 13706.9 13774.1 13796.3 13814.9 7263.2 7300.2 7431.2 7465.9 7501.1 6983.7 7076.5 7212.5 7251.2 7279.7 4216.3 4289.4 4376.8 4406.7 4472.8 1611.6 1842.0 1851.2 1861.4 1896.5 723.0 769.9 795.3 824.5 865.2 15669.4 16014.4 16278.4 16452.7 16781.1 820.0 827.4 828.6 845.2 901.6 8254.5 9413.4 9616.9 9664.3 9776.5 337952.0 385192.0 389632.0 390240.0 390690.0 72400.3 75252.6 77805.0 77858.0 78004.6 869.6 886.4 886.5 888.5 889.9 14454.3 14821.3 14831.0 14939.1 15357.2 34092.5 35395.6 36773.3 38686.0 39321.6 46942.3 47715.8 48868.5 52934.7 55141.4 7077.7 7120.3 7326.5 7519.7 7813.5 11375.5 11383.8 11946.5 12147.7 12269.9 9894.9 9907.9 10324.5 10698.7 10809.9 9454.1 9737.6 9825.1 9964.5 10222.6 10335.8 10339.4 10376.3 10387.6 10597.8 7259.7 7357.4 7384.8 7506.8 7639.4 8932.7 10276.4 10511.7 10515.2 11075.2 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | [#3] mootools.html Cycles:180 Average:5046.36 Median:5173.84 stddev:2869.86 (55.5%) stddev-sans-first:2863.69 14:32:45 INFO - PROCESS | 30579 | Values: 1245.5 1345.1 1368.8 1379.6 1709.0 6505.4 7535.5 7803.3 7807.5 8073.0 7854.0 7906.1 7914.4 7922.2 7928.5 2159.8 2177.3 2178.9 2185.8 2186.1 2118.5 2151.8 2155.8 2156.7 2164.9 2093.8 2132.6 2137.9 2145.0 2176.1 2129.5 2132.2 2133.6 2135.3 2141.3 2026.8 2110.5 2112.0 2112.9 2116.2 7741.4 7884.9 7935.8 8045.7 8052.4 4395.1 4538.9 4579.8 4582.4 4590.2 2870.7 2995.3 3044.1 3048.9 3062.4 920.9 924.5 942.5 943.7 944.4 10487.2 10621.4 10646.8 10657.9 10664.9 3927.4 4045.7 4050.4 4067.1 4286.7 7990.4 8132.0 8134.9 8137.3 8202.7 4463.7 4469.8 4472.6 4474.7 4483.3 3625.4 3768.5 3921.5 4161.8 4162.8 3350.5 3352.9 3435.3 3455.2 3471.2 1012.0 1033.8 1038.8 1039.4 1046.0 579.8 707.9 751.4 798.7 817.2 4932.8 5077.8 5228.9 5341.2 5482.3 818.2 829.7 874.2 889.4 897.4 3308.4 3367.2 3496.4 3503.4 3595.6 9482.7 9660.9 9772.6 9775.3 9796.3 9710.7 9720.9 9722.9 9725.1 9729.6 7344.1 7372.4 7415.9 7498.5 7510.8 5091.9 5092.8 5112.4 5158.1 5189.6 8792.0 8980.5 9004.8 9043.4 9122.8 9122.5 9220.9 9222.4 9274.1 9286.0 5597.6 5872.1 6109.6 6216.4 6229.0 6972.6 7261.0 7286.0 7460.8 7461.2 6459.5 6510.0 6610.5 6675.8 6713.0 6260.7 6456.3 6473.1 6598.6 6609.3 6044.5 6124.6 6126.0 6142.8 6145.9 4466.5 4482.1 4496.4 4544.9 4580.7 4499.6 4585.4 4608.4 4641.6 4667.0 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | [#4] prototype.html Cycles:180 Average:4212.23 Median:4822.87 stddev:1213.53 (25.2%) stddev-sans-first:1180.79 14:32:45 INFO - PROCESS | 30579 | Values: 295.7 295.8 297.3 299.5 307.7 4822.4 4840.8 4841.2 4851.1 4881.6 4485.6 4769.9 4788.8 4820.8 4833.5 3686.6 3707.2 3767.5 3800.9 3844.4 3812.3 3816.5 3822.9 3826.0 3827.3 3578.2 3791.6 3801.3 3806.6 3812.4 3645.5 3672.3 3744.6 3750.9 3775.8 3349.6 3351.0 3360.1 3363.3 3383.9 4694.9 4701.2 4704.0 4707.0 4713.8 4223.0 4347.7 4350.4 4352.5 4357.4 4952.5 5033.7 5040.2 5040.9 5042.5 3721.9 3724.6 3740.3 3749.3 3756.4 5039.2 5308.3 5329.8 5389.9 5396.5 3623.3 3636.7 3646.2 3648.5 3650.2 3700.3 3720.0 3723.5 3733.7 3744.3 4263.8 4283.3 4295.5 4306.4 4306.6 4805.3 5025.0 5076.8 5101.8 5111.4 1330.7 1335.7 1336.0 1339.7 1346.9 843.8 849.6 850.4 858.4 882.6 4414.6 4494.9 4511.4 4519.8 4546.7 5209.0 5218.2 5222.3 5231.9 5245.3 4295.4 4504.9 4512.3 4534.3 4554.5 2732.7 2749.5 2766.3 2769.3 2779.7 4906.9 4908.5 4919.5 4926.4 4949.2 5070.9 5255.3 5315.4 5332.0 5356.3 4922.3 4924.8 4953.3 4969.3 4976.0 5197.7 5221.3 5249.5 5249.5 5261.1 4934.8 5099.7 5105.4 5112.0 5123.2 4948.6 4949.7 4951.3 4952.8 4953.4 3804.6 3810.3 3814.0 3828.7 3832.3 4980.5 5155.3 5271.7 5274.2 5283.8 5043.8 5051.2 5058.1 5061.0 5075.7 5043.9 5050.9 5062.2 5073.0 5092.6 4823.3 4912.2 4932.8 4975.9 4993.0 4839.3 4927.2 4984.9 5073.9 5077.3 4937.0 4965.5 4965.9 4993.1 4998.9 14:32:45 INFO - PROCESS | 30579 | 14:32:45 INFO - PROCESS | 30579 | [#5] yui.html Cycles:180 Average:17112.53 Median:21591.80 stddev:24395.95 (113.0%) stddev-sans-first:24433.00 14:32:45 INFO - PROCESS | 30579 | Values: 631.4 692.2 703.5 732.3 740.0 12397.8 13403.9 13444.5 13607.9 13620.6 13060.5 13189.1 13194.3 13196.6 13483.5 731.4 755.1 755.4 758.1 761.1 610.6 628.0 762.5 764.5 765.5 656.5 658.6 658.7 765.6 784.4 785.5 788.8 789.7 790.9 794.1 572.9 572.9 573.0 578.3 578.9 10275.7 10719.6 11167.9 11174.7 12724.4 12139.7 12854.7 13301.3 13320.8 13943.0 10670.3 10695.4 10723.1 10780.1 10949.8 3334.3 3405.5 3413.3 3422.5 3511.2 64730.7 65088.3 65520.5 65936.7 65967.7 9306.3 9767.3 9925.3 9935.0 9977.8 19196.0 19281.3 19348.0 19383.6 19387.7 6916.1 7030.7 7118.2 7224.6 7237.1 3751.8 3849.6 3888.0 3914.0 3930.0 2980.2 3065.5 3081.9 3087.2 3088.3 510.4 512.7 515.4 521.1 527.9 568.1 593.9 594.5 616.2 621.1 7716.7 7752.5 7821.0 7843.5 8195.0 516.0 538.5 543.3 555.3 565.0 3657.7 3785.5 3792.8 3800.8 3908.7 59093.4 100465.0 100666.5 105953.5 106743.5 48979.3 51373.7 51783.5 84475.6 88786.6 80167.6 81746.6 82158.2 83265.0 83361.0 7373.5 7551.7 7694.3 7806.6 7841.8 36382.5 38118.6 47803.5 48818.5 51063.7 37595.2 39253.6 52977.0 58436.0 61196.0 10579.9 10806.6 11470.2 11710.1 12085.5 12170.6 12857.7 13143.8 13403.5 13612.3 10759.4 11018.3 11120.2 11242.8 11484.7 11422.0 11935.5 12610.9 12784.8 12798.9 11589.3 11594.9 11762.3 12255.6 12532.5 10423.3 10467.5 10537.2 10935.9 11400.7 9954.6 10547.3 10784.9 10869.0 10895.5 14:32:45 INFO - PROCESS | 30579 | -------- Summary: end -------- 14:32:45 INFO - PROCESS | 30579 | 14:32:46 INFO - TEST-INFO | 30579: exit 0 14:32:46 INFO - TEST-OK | dromaeo_css | took 1120516ms 14:32:46 INFO - TEST-START | kraken 14:32:46 INFO - operating with platform_type : linux_ 14:32:46 INFO - Initialising browser for kraken test... 14:32:46 INFO - TEST-INFO | started process 30891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNiBsjP/profile http://localhost:53884/getInfo.html) 14:32:50 INFO - PROCESS | 30891 | __metrics Screen width/height:1600/1200 14:32:50 INFO - PROCESS | 30891 | colorDepth:24 14:32:50 INFO - PROCESS | 30891 | Browser inner width/height: 1024/697 14:32:50 INFO - PROCESS | 30891 | __metrics 14:32:51 INFO - PROCESS | 30891 | 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" 14:32:51 INFO - PROCESS | 30891 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:32:51 INFO - PROCESS | 30891 | console.error: PushService: 14:32:51 INFO - PROCESS | 30891 | stateChangeProcessEnqueue: Error transitioning state 14:32:51 INFO - PROCESS | 30891 | UnknownError 14:32:52 INFO - TEST-INFO | 30891: exit 0 14:32:52 INFO - Browser initialized. 14:32:52 INFO - Running cycle 1/1 for kraken test... 14:32:52 INFO - TEST-INFO | started process 30974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNiBsjP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:04 INFO - PROCESS | 30974 | RSS: Main: 175046656 14:33:04 INFO - PROCESS | 30974 | 14:33:07 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-beat-detection) 14:33:08 INFO - PROCESS | 30974 | RSS: Main: 237985792 14:33:08 INFO - PROCESS | 30974 | 14:33:11 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-dft) 14:33:11 INFO - PROCESS | 30974 | RSS: Main: 218501120 14:33:11 INFO - PROCESS | 30974 | 14:33:14 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-fft) 14:33:15 INFO - PROCESS | 30974 | RSS: Main: 300679168 14:33:15 INFO - PROCESS | 30974 | 14:33:17 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53884/tests/kraken/driver.html?testName=audio-oscillator) 14:33:18 INFO - PROCESS | 30974 | RSS: Main: 210501632 14:33:18 INFO - PROCESS | 30974 | 14:33:20 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:33:21 INFO - PROCESS | 30974 | RSS: Main: 213655552 14:33:21 INFO - PROCESS | 30974 | 14:33:24 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53884/tests/kraken/driver.html?testName=imaging-darkroom) 14:33:25 INFO - PROCESS | 30974 | RSS: Main: 250253312 14:33:25 INFO - PROCESS | 30974 | 14:33:28 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53884/tests/kraken/driver.html?testName=imaging-desaturate) 14:33:29 INFO - PROCESS | 30974 | RSS: Main: 250068992 14:33:29 INFO - PROCESS | 30974 | 14:33:31 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53884/tests/kraken/driver.html?testName=json-parse-financial) 14:33:32 INFO - PROCESS | 30974 | RSS: Main: 249442304 14:33:32 INFO - PROCESS | 30974 | 14:33:34 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:33:34 INFO - PROCESS | 30974 | RSS: Main: 212639744 14:33:34 INFO - PROCESS | 30974 | 14:33:36 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:33:37 INFO - PROCESS | 30974 | RSS: Main: 219308032 14:33:37 INFO - PROCESS | 30974 | 14:33:39 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:33:40 INFO - PROCESS | 30974 | RSS: Main: 223657984 14:33:40 INFO - PROCESS | 30974 | 14:33:43 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:33:43 INFO - PROCESS | 30974 | RSS: Main: 224616448 14:33:43 INFO - PROCESS | 30974 | 14:33:46 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:33:47 INFO - PROCESS | 30974 | RSS: Main: 222629888 14:33:47 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | Cycle 1(1): loaded http://localhost:53884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53884/tests/kraken/driver.html?testName=ai-astar) 14:33:49 INFO - PROCESS | 30974 | RSS: Main: 273788928 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | __start_tp_report 14:33:49 INFO - PROCESS | 30974 | _x_x_mozilla_page_load 14:33:49 INFO - PROCESS | 30974 | _x_x_mozilla_page_load_details 14:33:49 INFO - PROCESS | 30974 | |i|pagename|runs| 14:33:49 INFO - PROCESS | 30974 | |0;ai-astar;111;114;115;115;114;117;114;114;114;114 14:33:49 INFO - PROCESS | 30974 | |1;audio-beat-detection;153;124;125;155;125;126;128;138;163;130 14:33:49 INFO - PROCESS | 30974 | |2;audio-dft;162;160;161;161;161;160;161;162;162;162 14:33:49 INFO - PROCESS | 30974 | |3;audio-fft;75;77;76;101;79;76;76;76;105;76 14:33:49 INFO - PROCESS | 30974 | |4;audio-oscillator;84;83;123;83;84;84;112;82;83;115 14:33:49 INFO - PROCESS | 30974 | |5;imaging-gaussian-blur;117;119;118;118;118;118;118;120;118;117 14:33:49 INFO - PROCESS | 30974 | |6;imaging-darkroom;146;147;146;146;146;146;145;146;146;146 14:33:49 INFO - PROCESS | 30974 | |7;imaging-desaturate;96;94;95;95;95;95;95;96;95;95 14:33:49 INFO - PROCESS | 30974 | |8;json-parse-financial;64;64;63;64;64;65;65;65;63;64 14:33:49 INFO - PROCESS | 30974 | |9;json-stringify-tinderbox;65;65;66;66;66;66;66;72;67;67 14:33:49 INFO - PROCESS | 30974 | |10;stanford-crypto-aes;82;82;82;82;82;82;82;82;81;82 14:33:49 INFO - PROCESS | 30974 | |11;stanford-crypto-ccm;147;142;136;134;143;151;142;134;179;135 14:33:49 INFO - PROCESS | 30974 | |12;stanford-crypto-pbkdf2;175;179;179;176;173;171;172;172;172;170 14:33:49 INFO - PROCESS | 30974 | |13;stanford-crypto-sha256-iterative;70;69;69;68;69;68;67;68;67;67 14:33:49 INFO - PROCESS | 30974 | __end_tp_report 14:33:49 INFO - PROCESS | 30974 | __start_cc_report 14:33:49 INFO - PROCESS | 30974 | _x_x_mozilla_cycle_collect,1916 14:33:49 INFO - PROCESS | 30974 | __end_cc_report 14:33:49 INFO - PROCESS | 30974 | __startTimestamp1474493629364__endTimestamp 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | ------- Summary: start ------- 14:33:49 INFO - PROCESS | 30974 | Number of tests: 14 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:1.48 (1.3%) stddev-sans-first:1.01 14:33:49 INFO - PROCESS | 30974 | Values: 111.0 114.0 115.0 115.0 114.0 117.0 114.0 114.0 114.0 114.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:134.00 stddev:14.77 (11.0%) stddev-sans-first:14.44 14:33:49 INFO - PROCESS | 30974 | Values: 153.0 124.0 125.0 155.0 125.0 126.0 128.0 138.0 163.0 130.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 14:33:49 INFO - PROCESS | 30974 | Values: 162.0 160.0 161.0 161.0 161.0 160.0 161.0 162.0 162.0 162.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.31 (14.9%) stddev-sans-first:11.74 14:33:49 INFO - PROCESS | 30974 | Values: 75.0 77.0 76.0 101.0 79.0 76.0 76.0 76.0 105.0 76.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:16.36 (19.7%) stddev-sans-first:17.00 14:33:49 INFO - PROCESS | 30974 | Values: 84.0 83.0 123.0 83.0 84.0 84.0 112.0 82.0 83.0 115.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 14:33:49 INFO - PROCESS | 30974 | Values: 117.0 119.0 118.0 118.0 118.0 118.0 118.0 120.0 118.0 117.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 14:33:49 INFO - PROCESS | 30974 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 14:33:49 INFO - PROCESS | 30974 | Values: 96.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 14:33:49 INFO - PROCESS | 30974 | Values: 64.0 64.0 63.0 64.0 64.0 65.0 65.0 65.0 63.0 64.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.00 stddev:2.01 (3.0%) stddev-sans-first:2.05 14:33:49 INFO - PROCESS | 30974 | Values: 65.0 65.0 66.0 66.0 66.0 66.0 66.0 72.0 67.0 67.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 14:33:49 INFO - PROCESS | 30974 | Values: 82.0 82.0 82.0 82.0 82.0 82.0 82.0 82.0 81.0 82.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:142.50 stddev:13.48 (9.5%) stddev-sans-first:14.27 14:33:49 INFO - PROCESS | 30974 | Values: 147.0 142.0 136.0 134.0 143.0 151.0 142.0 134.0 179.0 135.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:3.21 (1.8%) stddev-sans-first:3.38 14:33:49 INFO - PROCESS | 30974 | Values: 175.0 179.0 179.0 176.0 173.0 171.0 172.0 172.0 172.0 170.0 14:33:49 INFO - PROCESS | 30974 | 14:33:49 INFO - PROCESS | 30974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.03 (1.5%) stddev-sans-first:0.87 14:33:49 INFO - PROCESS | 30974 | Values: 70.0 69.0 69.0 68.0 69.0 68.0 67.0 68.0 67.0 67.0 14:33:49 INFO - PROCESS | 30974 | -------- Summary: end -------- 14:33:49 INFO - PROCESS | 30974 | 14:33:50 INFO - TEST-INFO | 30974: exit 0 14:33:50 INFO - TEST-OK | kraken | took 64099ms 14:33:50 INFO - SUITE-END | took 1184s 14:33:51 INFO - Completed test suite (00:19:44) 14:33:51 INFO - javascript benchmark 14:33:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.846469211847, 2572.09976508222, 2601.9982306811876, 2614.7908167346613, 2628.973710262898, 4515.503294637587, 4603.7928293226805, 4656.092062047902, 4698.27176787598, 4699.412573428322, 4640.907181856361, 4659.603933665642, 4659.998100408411, 4705.106029854325, 4725.243960966246, 4271.188474189894, 4291.549387314334, 4309.944063704381, 4327.0, 4397.890052748675, 4377.7592232427205, 4418.248897687385, 4420.182266280733, 4422.292433210687, 4441.178381999341, 4227.661787057028, 4277.850275240383, 4389.122175564899, 4427.756473393962, 4453.087117140978, 4309.030468144674, 4311.611954924072, 4319.805608747614, 4358.0412309291905, 4434.201843668138, 4310.4396428464415, 4323.113761678848, 4325.026868954492, 4331.5018772840895, 4372.40972468719, 4681.297805329194, 4702.3181638662545, 4706.599939005188, 4707.6233901287815, 4734.83428080019, 4828.830990915336, 4884.755762211911, 4994.225894986283, 5024.572911302544, 5028.019536190444, 5044.243363495469, 5075.746212689388, 5076.720780357079, 5085.872853178663, 5120.436751957282, 4683.391159149289, 4707.082118986833, 4724.149653062447, 4750.168720473903, 4769.499202583748, 4991.126552853236, 5042.647014708935, 5090.440051594322, 5124.948750512522, 5142.460041695568, 4948.035133149001, 4950.727709975986, 5005.724685142352, 5008.649394542347, 5012.899742005139, 5013.498650134958, 5016.749162541858, 5019.447860735316, 5025.447200807908, 5084.847454576368, 4857.149998750205, 4910.877228069256, 4963.6525443218625, 4980.900381992412, 5038.370203724535, 4891.902161956741, 4922.212446008693, 4923.187674033816, 4954.405471343462, 4978.751062446863, 4090.5091389033505, 4093.201825643971, 4094.8566800161852, 4136.98643832257, 4142.378643203544, 3596.047047532406, 3602.3875941089555, 3609.3683605368956, 3640.2173532690067, 3676.6323367663554, 4297.484301883794, 4326.048269380732, 4359.520452750195, 4368.366586844953, 4376.431063961664, 4956.578690811321, 4999.125153098194, 4999.800007999712, 5003.524665156804, 5032.396112466454, 4353.956460435355, 4354.825806967686, 4359.258925982591, 4395.252807022814, 4403.757793321334, 4429.158459892675, 4440.777961101932, 4441.622462090694, 4463.598276155097, 4491.101779644085, 4787.473377928494, 4837.443693975097, 4837.56461918415, 4845.515448455127, 4846.29728689331, 5049.166887463527, 5056.165732654071, 5059.19052951526, 5060.2156665716875, 5120.692758434357, 4668.463126740468, 4762.357081794052, 4769.2130798417875, 4775.044991001744, 4831.782569784298, 4865.343178670834, 4884.0476107158765, 4923.359963204761, 4939.901201976012, 5005.7997680092385, 4984.302197692398, 5005.274235235943, 5020.322256495472, 5027.27104569828, 5091.261767043684, 4867.172580661225, 4880.072786170616, 4897.9020419592125, 4899.853004409873, 4950.2079667253065, 4718.433787945469, 4812.085703716282, 4887.486813884491, 4932.087563800708, 4951.77717002743, 4861.683990540603, 4865.805367785249, 4867.569828392678, 4881.121398148367, 4927.359443272351, 4978.103941290602, 4980.128477516348, 4981.476944920876, 4982.800687972585, 5023.6985780853265, 4740.525947405232, 4790.8323208687525, 4793.376861008047, 4858.6356023297685, 4911.852644420673], "value": 4606.647847746126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.7544692611787, 559.8376470823462, 568.8407245971127, 571.9561799715517, 574.224796524692, 28216.43567128659, 30816.691833081662, 31088.0, 37293.254134917355, 38537.614623853755, 40201.39697904534, 40495.545489996075, 40572.79713601435, 40625.0, 40671.38992915109, 7322.450816188793, 7451.7019319227165, 7457.5152615080115, 7460.1420836603675, 7461.850762984737, 6980.336867997532, 7145.928540714578, 7158.246229673738, 7310.2689731027, 7682.423818213629, 9761.804763904718, 10010.199184065257, 10013.599456021786, 10392.584296628125, 10426.165906727443, 9870.0, 9919.256055795844, 9932.155766759763, 9953.30326877119, 9955.80088398228, 9674.0, 9917.454540000297, 9921.107100361001, 9922.751931201705, 9957.651482198089, 37393.0, 37444.81277593622, 37678.0, 37687.81156094202, 37806.81096594499, 3030.6060212172497, 3077.261457250266, 3235.48232282836, 3290.3583801158784, 3584.3727347714307, 27634.0, 28173.0, 28380.290492737848, 28402.85798570994, 28502.71497285021, 3465.7747246429153, 3522.8590856365713, 3658.762180458262, 3699.72252081095, 3707.9814600926825, 246450.0, 248359.0, 248501.9999999982, 248563.0, 248656.0, 30960.845195774327, 31831.52252716211, 43507.12985740267, 43556.0, 43563.346549801776, 32737.18157046093, 32849.17877053045, 32876.67123328784, 32909.83545082259, 33097.338053238804, 12047.096467764954, 12176.086793490524, 12181.634550963485, 12211.0, 12227.816582751266, 10251.38491690501, 10255.9487202565, 10322.638707645196, 10393.06462418386, 10402.115820155372, 7133.89299160513, 7331.963340183265, 7334.779956601311, 7694.499857509244, 7795.727149549739, 2845.928851778681, 2887.797854150231, 2970.1089673097986, 3045.086474057818, 3048.2531779714113, 854.3293514591016, 855.6149732620346, 876.3296078499952, 876.5836227791875, 908.4458480326995, 26871.462570748867, 27894.581581276296, 28074.71925280762, 28300.85849570739, 28331.858340708164, 927.5733162745213, 937.1565590968047, 945.1965829045394, 950.2065775077749, 955.6464108279841, 14208.64478388028, 14546.199959002144, 14721.0, 15021.624459388602, 15081.849181508045, 364991.0, 371508.0, 372064.0, 372452.0, 372470.0, 47979.0, 48453.27320090202, 48521.272180917316, 48552.0, 48568.7571562147, 972.7616733900239, 1100.5432745410565, 1108.872479664849, 1130.519529200103, 1191.065013964034, 27566.310842229104, 28870.71129288764, 29135.708642913298, 29267.0, 29683.851580741957, 35088.29823403569, 35312.47031294584, 35395.29209415849, 35396.0, 35451.64548354483, 301224.0, 302255.0, 302838.0, 303367.9442891898, 303439.0, 24227.51544969126, 24684.629730554414, 24821.0, 26126.0, 26277.474450511265, 41333.37999929943, 41653.375199371425, 41918.58081419147, 42543.7872810634, 45320.32019519776, 34997.82501087478, 35067.298654026265, 35429.46855797217, 35696.0, 35937.82031089828, 35145.0, 35332.47001295034, 35578.28843423169, 35747.0, 35882.64117358898, 35216.29567408689, 35272.647273526934, 35278.82360588181, 35313.47029794606, 36386.09034774152, 30693.53959690562, 32726.34547309088, 32794.0, 33183.502247465825, 33218.83390583032, 24692.506149877263, 24898.751012490367, 24988.62517062209, 25473.0402970356, 25720.871395642902], "value": 16215.1444127954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.3874057326526, 347.94606835940436, 365.48284177888286, 366.66999700269764, 390.16310015017785, 12243.449044792984, 15658.765118523217, 15964.521064368073, 17270.56823579411, 17495.650086998252, 16710.415135470263, 16971.15144242789, 17007.404740834074, 17130.486085417426, 17253.741193882102, 4905.337779399771, 5026.195808670614, 5139.794408223666, 5172.353455818023, 5182.870428239286, 3689.317476266886, 3880.7865567393783, 5099.337086178792, 5184.196449550307, 5185.662931909414, 3841.3661745811905, 3904.2386734586767, 3908.2965066288057, 3955.545112312078, 5789.0, 5863.149843272744, 5868.501177399926, 5885.293764748215, 5887.8528036799, 5888.882222355529, 5057.772400241998, 5123.564497017758, 5268.341457317835, 5287.735613219362, 5298.337707786527, 20653.070611822503, 20682.58634827295, 20802.375928722162, 20834.895825520925, 20867.060982255683, 1754.4911975527082, 1784.696601577735, 1805.0974512743628, 1844.2622950819646, 1950.288144827142, 8730.476171429735, 8738.169873861973, 8937.419067760575, 9115.0, 9360.251179905592, 1680.0927499150444, 1705.744138379253, 1707.4974022859928, 1735.0977491704368, 1784.4825000749768, 62465.37534624687, 68634.0, 68872.0, 70433.29566704319, 72266.91599626062, 10066.69799906004, 10098.192144628412, 10234.897651023542, 10296.279260451845, 10338.793224135625, 13671.521496747766, 13706.862931370759, 13774.104683195761, 13796.310184490936, 13814.861851381558, 7263.237360077116, 7300.160481544584, 7431.182569917305, 7465.888011679829, 7501.062367204099, 6983.650817459208, 7076.504644674823, 7212.459065570103, 7251.238619944936, 7279.67241474135, 4216.2832318505925, 4289.378040184156, 4376.824927002948, 4406.669499787528, 4472.8210871565425, 1611.5971007248188, 1841.9815801842078, 1851.1577232359514, 1861.3950466098572, 1896.5069082038494, 722.9927700723031, 769.9114601820751, 795.308081968691, 824.4929368438487, 865.1564724393792, 15669.373225071098, 16014.359425623077, 16278.43025494102, 16452.670946581, 16781.077040762877, 819.9754007379788, 827.4414770030205, 828.5774255129927, 845.2223953962247, 901.6258252825136, 8254.504729716236, 9413.435193888388, 9616.855747163798, 9664.293997680661, 9776.51117444125, 337952.0, 385192.0, 389632.0, 390240.0, 390690.0, 72400.27599723935, 75252.62373688097, 77805.0, 77858.0, 78004.60997694975, 869.5695630662863, 886.3751055505853, 886.5434301334818, 888.4891187567175, 889.8620713789373, 14454.27728613586, 14821.25893705332, 14831.0, 14939.103653780809, 15357.155356455502, 34092.488612671325, 35395.64604353924, 36773.26453470969, 38686.0, 39321.60678393179, 46942.29586556136, 47715.76142119267, 48868.5113148864, 52934.73532632312, 55141.44858551524, 7077.68150433242, 7120.323569260912, 7326.523775954759, 7519.661615227437, 7813.531188128731, 11375.488103035548, 11383.829242561535, 11946.522139114339, 12147.696307592381, 12269.877301226874, 9894.901050989398, 9907.900920990698, 10324.48377581133, 10698.73253168677, 10809.945950270197, 9454.101860323259, 9737.561809718722, 9825.115739583473, 9964.50177491137, 10222.591096356062, 10335.844962325722, 10339.431331276852, 10376.273660843668, 10387.584496620353, 10597.788044239227, 7259.745908893164, 7357.374623157091, 7384.815379615553, 7506.774796755888, 7639.388848891964, 8932.687355942511, 10276.383416995004, 10511.737206569896, 10515.15878729715, 11075.169362298022], "value": 8020.878193895078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.545375937782, 1345.1055048392818, 1368.8083668286442, 1379.6275005748441, 1709.0009378055347, 6505.447037001854, 7535.547867127969, 7803.258690424408, 7807.531548107103, 8072.990876140482, 7854.0, 7906.051273847132, 7914.366850651934, 7922.247386498273, 7928.5242885426915, 2159.7516285627157, 2177.2706143441965, 2178.9128434862664, 2185.7704940981125, 2186.1036974840317, 2118.54451292972, 2151.7955794199606, 2155.795199456049, 2156.6764985252257, 2164.9242276520326, 2093.822025127866, 2132.5841460915126, 2137.8824164670937, 2144.9785502145014, 2176.1186719378675, 2129.5102126510833, 2132.1791110422446, 2133.5626196629655, 2135.3060255417054, 2141.2719675310314, 2026.7770545240012, 2110.4934815644133, 2112.039022244875, 2112.8732276063483, 2116.1958455786857, 7741.380689544823, 7884.881726774103, 7935.801604959865, 8045.678172873078, 8052.43632945694, 4395.099004704028, 4538.931916021263, 4579.816807327703, 4582.427196600425, 4590.196715574794, 2870.669872964594, 2995.3110784519463, 3044.101989912981, 3048.8628011739524, 3062.3569050499423, 920.8756817829641, 924.4684306523709, 942.472215559289, 943.7168849345238, 944.4097439100562, 10487.213458990529, 10621.41582212978, 10646.787064258671, 10657.946710266477, 10664.946675266652, 3927.3912543555225, 4045.7167998239843, 4050.432939388488, 4067.1458993611673, 4286.678499112579, 7990.4406691532195, 8132.0, 8134.877976830352, 8137.308328792119, 8202.671893124209, 4463.709858859163, 4469.843555475608, 4472.552744725502, 4474.731516109044, 4483.2602620567895, 3625.3836847735947, 3768.4724138620613, 3921.450996860442, 4161.791910404468, 4162.771047592351, 3350.497425386163, 3352.949705754416, 3435.347284016029, 3455.1707590178175, 3471.2016236265295, 1011.9696409107738, 1033.788073444942, 1038.7974345002651, 1039.3867618105203, 1046.0, 579.7593998490579, 707.8938159276047, 751.3838652305058, 798.7284323330096, 817.2032268538246, 4932.778024988884, 5077.771500282496, 5228.9477105229225, 5341.198820176927, 5482.342118945672, 818.1818181818181, 829.6764261937849, 874.1826392323071, 889.355217467331, 897.3718397122041, 3308.4375656138513, 3367.1582104473882, 3496.3531746626445, 3503.404421248394, 3595.6404359563835, 9482.668106616235, 9660.903390966001, 9772.609095636237, 9775.31572789912, 9796.314258002014, 9710.660126895666, 9720.854187187198, 9722.902770972341, 9725.0761177688, 9729.61081556744, 7344.081989751281, 7372.373348265458, 7415.925840741524, 7498.475106742476, 7510.812229694301, 5091.949080509147, 5092.8472145835685, 5112.36095488064, 5158.123119069692, 5189.558887494605, 8792.0, 8980.506072165832, 9004.774880627774, 9043.377420547968, 9122.817543649222, 9122.543872806466, 9220.907790922005, 9222.354435189472, 9274.118958698913, 9285.953570232106, 5597.552195824405, 5872.060470324898, 6109.602875813058, 6216.378362163748, 6229.0, 6972.58164510131, 7261.0, 7285.963570182115, 7460.776176714708, 7461.179270280156, 6459.483241340776, 6509.967450162909, 6610.537262391586, 6675.766348177791, 6712.9664351679885, 6260.68696565179, 6456.289808121197, 6473.093766872736, 6598.571092878948, 6609.272979972296, 6044.486218671462, 6124.6325220486915, 6125.9693701531205, 6142.815715528542, 6145.938540614537, 4466.5086840448175, 4482.125985432809, 4496.37050812893, 4544.863654090383, 4580.725156490621, 4499.640028797754, 4585.426821647294, 4608.400907881954, 4641.582257596698, 4667.043256132417], "value": 4038.5499698294357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.74418128318996, 295.75747886732887, 297.3072740514601, 299.5357196345664, 307.68462326115736, 4822.421309442868, 4840.782164802584, 4841.201201801708, 4851.078295123924, 4881.585065269447, 4485.564619321818, 4769.8807529811775, 4788.832390866321, 4820.83127090551, 4833.468318484964, 3686.6037075900613, 3707.2214834884708, 3767.4537192107127, 3800.9429858552144, 3844.4233364995334, 3812.2756676231566, 3816.503854498911, 3822.8661996830115, 3826.0, 3827.3302172119766, 3578.159132603836, 3791.5829258781514, 3801.277757226132, 3806.5812760596314, 3812.3519001769764, 3645.5260816094005, 3672.265546890633, 3744.588095309514, 3750.9309846693563, 3775.8300876460626, 3349.598048234203, 3350.96649033509, 3360.143163493318, 3363.3441478911623, 3383.8646454141804, 4694.929576056362, 4701.224297990828, 4703.988642441891, 4706.952930470686, 4713.764311784432, 4223.007593215591, 4347.739135651871, 4350.390945267665, 4352.542982986773, 4357.41174941382, 4952.529509696573, 5033.672811267256, 5040.16837221858, 5040.949590504085, 5042.495750424928, 3721.864831226475, 3724.6461586149544, 3740.3267411865854, 3749.2501499699897, 3756.3614185588517, 5039.168537191359, 5308.336457942757, 5329.800794821173, 5389.9191512127345, 5396.514313711785, 3623.3477973964414, 3636.7272454566014, 3646.234290798962, 3648.4527320902075, 3650.233450975272, 3700.259948010355, 3719.962800372016, 3723.478712980185, 3733.701303895682, 3744.3260213161893, 4263.8081286342185, 4283.336082907154, 4295.548967358445, 4306.418633484503, 4306.633936115402, 4805.255185446262, 5025.0, 5076.822311219164, 5101.846944591668, 5111.361079865017, 1330.7405056014177, 1335.7177109974534, 1335.9532416365576, 1339.6717804137854, 1346.8585798491213, 843.8059246373368, 849.5582297205418, 850.4047166983013, 858.4076986879033, 882.6292956958093, 4414.602685758297, 4494.910101797946, 4511.390962220058, 4519.751413672214, 4546.74992875395, 5208.958208358267, 5218.191180367049, 5222.321098257202, 5231.9476805232225, 5245.291885595472, 4295.4415925929425, 4504.864854054384, 4512.2554778461845, 4534.251848445036, 4554.476235232991, 2732.7429382483883, 2749.4913441013477, 2766.349907771672, 2769.2661444717164, 2779.652543432071, 4906.852794416173, 4908.460069392436, 4919.508049195052, 4926.3989203509, 4949.193544356284, 5070.898582028339, 5255.264263003182, 5315.3621565412395, 5331.960267747752, 5356.276902618175, 4922.261660750844, 4924.823488849744, 4953.3065370848835, 4969.27945447908, 4975.950240497548, 5197.7141257231215, 5221.347331583552, 5249.501297376743, 5249.527542521191, 5261.131913234273, 4934.827281045146, 5099.6685215460875, 5105.361829771278, 5111.974440127924, 5123.23151527259, 4948.579370753526, 4949.7030178189425, 4951.331570237971, 4952.801887924443, 4953.399465280757, 3804.6385593368586, 3810.2760475509563, 3813.9618603813606, 3828.73198876076, 3832.3293423651307, 4980.526849949249, 5155.252488389237, 5271.71005594696, 5274.156135018532, 5283.762230699551, 5043.798248070036, 5051.166557518115, 5058.077930386429, 5061.0, 5075.695458272516, 5043.87390315245, 5050.873728156826, 5062.2406639002975, 5072.9746351268, 5092.567131793691, 4823.324734537097, 4912.214045752662, 4932.827351042696, 4975.850724478127, 4992.975035124801, 4839.274108883696, 4927.236278376858, 4984.875378115431, 5073.949260507347, 5077.263796749525, 4936.950630493793, 4965.45380008206, 4965.900681986413, 4993.076280888047, 4998.875028124326], "value": 3826.7252733450955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.3875540725496, 692.165940042249, 703.4723957032222, 732.3226015935262, 739.9963000184998, 12397.752044959107, 13403.932980335108, 13444.52944146955, 13607.931960340196, 13620.591382258523, 13060.477580896777, 13189.142705724145, 13194.34028298586, 13196.60410187696, 13483.46066157355, 731.4185222747901, 755.1202848681307, 755.3730403764862, 758.1395116542709, 761.1057008015559, 610.6244659534376, 627.9780207692709, 762.4662736084736, 764.464874587788, 765.5406755946416, 656.4846595422595, 658.6443320606867, 658.6673729766485, 765.5559775330323, 784.380339531772, 785.5129819511939, 788.8422315536886, 789.6841263494591, 790.9011373578331, 794.06697130871, 572.8510587247346, 572.862512996882, 573.0144152058452, 578.3291381996905, 578.8813293274868, 10275.743106422324, 10719.62481313158, 11167.888321116767, 11174.720631984266, 12724.427400766896, 12139.696507587292, 12854.742905141939, 13301.268430236332, 13320.800187997187, 13943.023988320821, 10670.253082284244, 10695.411752353617, 10723.14214862809, 10780.083692886114, 10949.83575246372, 3334.2664613785173, 3405.4551271796395, 3413.3343997920415, 3422.469517224834, 3511.227529943408, 64730.676346618435, 65088.34911650918, 65520.48233729585, 65936.67031664858, 65967.67016164889, 9306.290944987793, 9767.267454940908, 9925.305228633926, 9934.950325248328, 9977.846964435299, 19196.0, 19281.325153619837, 19348.0, 19383.612327753366, 19387.709184362247, 6916.135483064617, 7030.718771249195, 7118.216996130422, 7224.602646854473, 7237.131544214728, 3751.8311675974646, 3849.576546579874, 3888.0, 3913.9804300978312, 3930.0, 2980.225141463235, 3065.5095184770776, 3081.8613162407296, 3087.21276074604, 3088.258817883692, 510.4436164580625, 512.7154429291779, 515.4201523286303, 521.0750917122062, 527.8759491519489, 568.0659394228844, 593.9079442686391, 594.4590422715395, 616.1712496691943, 621.1397214857365, 7716.72991445308, 7752.5348479091435, 7820.960895195602, 7843.450958432855, 8194.975628046494, 515.9963870272285, 538.4991957479582, 543.2638774460628, 555.2809112199711, 564.9858753531195, 3657.7256705747177, 3785.5078839750654, 3792.791396473165, 3800.809959502014, 3908.7263891527887, 59093.40906590965, 100465.0, 100666.49666751765, 105953.47023264988, 106743.46628266809, 48979.26531102036, 51373.74313128485, 51783.48216517787, 84475.5776221115, 88786.55606722055, 80167.59916200499, 81746.59126704329, 82158.17841821506, 83265.0, 83360.99502089682, 7373.543577752532, 7551.73568925085, 7694.2571344806465, 7806.609669516388, 7841.803954901173, 36382.454263186606, 38118.61881381151, 47803.52196477991, 48818.5118148814, 51063.74468127636, 37595.2480950374, 39253.60746392499, 52977.0, 58436.0, 61196.0, 10579.89420105789, 10806.567737290421, 11470.197086203885, 11710.1217408693, 12085.456154473246, 12170.57402990891, 12857.678558036125, 13143.802842957171, 13403.530876419278, 13612.319384030561, 10759.408232547285, 11018.338899666045, 11120.165987550805, 11242.775144497227, 11484.712882178012, 11422.0, 11935.52257909674, 12610.936945315214, 12784.808227876403, 12798.936005319914, 11589.304641721523, 11594.94202528982, 11762.294262344287, 12255.632331030083, 12532.483108783565, 10423.322484038514, 10467.528961196916, 10537.157027437634, 10935.890641093805, 11400.651465798217, 9954.55204515813, 10547.314424562379, 10784.946075269574, 10869.0, 10895.509702063584], "value": 6452.590398738954, "unit": "score"}], "name": "dromaeo_css", "value": 6252.59398749471, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 115.0, 115.0, 114.0, 117.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 125.0, 155.0, 125.0, 126.0, 128.0, 138.0, 163.0, 130.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 101.0, 79.0, 76.0, 76.0, 76.0, 105.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 123.0, 83.0, 84.0, 84.0, 112.0, 82.0, 83.0, 115.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 120.0, 118.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 65.0, 65.0, 63.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 72.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 81.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 142.0, 136.0, 134.0, 143.0, 151.0, 142.0, 134.0, 179.0, 135.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 179.0, 176.0, 173.0, 171.0, 172.0, 172.0, 172.0, 170.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 69.0, 68.0, 67.0, 68.0, 67.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1545.3000000000002, "alertThreshold": 2.0}]} 14:33:51 INFO - Return code: 0 14:33:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:33:51 INFO - # TBPL SUCCESS # 14:33:51 INFO - Running post-action listener: _resource_record_post_action 14:33:51 INFO - [mozharness: 2016-09-21 21:33:51.165306Z] Finished run-tests step (success) 14:33:51 INFO - Running post-run listener: _resource_record_post_run 14:33:51 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 409268224; Read time: 0; Write time: 266548 14:33:51 INFO - TinderboxPrint: CPU usage
13.0% 14:33:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:33:51 INFO - TinderboxPrint: I/O write bytes / time
409,268,224 / 266,548 14:33:51 INFO - TinderboxPrint: CPU idle
8,332.3 (86.9%) 14:33:51 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 14:33:51 INFO - TinderboxPrint: Swap in / out
0 / 0 14:33:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99786752; Read time: 0; Write time: 100288 14:33:51 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 292679680; Read time: 0; Write time: 160688 14:33:51 INFO - Running post-run listener: _upload_blobber_files 14:33:51 INFO - Blob upload gear active. 14:33:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:33:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:33:52 INFO - (blobuploader) - INFO - Open directory for files ... 14:33:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:33:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:33:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:57 INFO - (blobuploader) - INFO - Done attempting. 14:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:33:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:58 INFO - (blobuploader) - INFO - Done attempting. 14:33:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:33:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:59 INFO - (blobuploader) - INFO - Done attempting. 14:33:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:33:59 INFO - Return code: 0 14:33:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:33:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:33:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b8221e8e31ba8f9a48a36e8510d25b6ed873a733641d4f2893ba8ae4975387a910b82231ddf4985ff14cf04868a25d92379c283a298e8c63643e6b7fa79bcc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b34573f401a8540c6423c4a181bf5607d06e1888d98524799b673a37c35ff4b493b46d186b088a433f742427761a46f606af93895f589c08a1a2a0c990d8d35a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63b3936a10365c9c242d01be12d7aef54347cd55915437fa67ef93be7011fe77c60fd2438436fb0ee36e26c1d5683625a64458fd60d4370f6fd7bebfa7ad3404"} 14:33:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:33:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:33:59 INFO - Contents: 14:33:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b8221e8e31ba8f9a48a36e8510d25b6ed873a733641d4f2893ba8ae4975387a910b82231ddf4985ff14cf04868a25d92379c283a298e8c63643e6b7fa79bcc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b34573f401a8540c6423c4a181bf5607d06e1888d98524799b673a37c35ff4b493b46d186b088a433f742427761a46f606af93895f589c08a1a2a0c990d8d35a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63b3936a10365c9c242d01be12d7aef54347cd55915437fa67ef93be7011fe77c60fd2438436fb0ee36e26c1d5683625a64458fd60d4370f6fd7bebfa7ad3404"} 14:33:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:33:59 INFO - Copying logs to upload dir... 14:33:59 INFO - mkdir: /builds/slave/test/build/upload/logs 14:33:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.197842 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-21 14:33:58.914015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 14:33:58.918155) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248 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/7b8221e8e31ba8f9a48a36e8510d25b6ed873a733641d4f2893ba8ae4975387a910b82231ddf4985ff14cf04868a25d92379c283a298e8c63643e6b7fa79bcc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b34573f401a8540c6423c4a181bf5607d06e1888d98524799b673a37c35ff4b493b46d186b088a433f742427761a46f606af93895f589c08a1a2a0c990d8d35a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63b3936a10365c9c242d01be12d7aef54347cd55915437fa67ef93be7011fe77c60fd2438436fb0ee36e26c1d5683625a64458fd60d4370f6fd7bebfa7ad3404"} build_url:https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/UInqj8f4RWCgVhiJhT_ZDw/artifacts/public/build/firefox-52.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/7b8221e8e31ba8f9a48a36e8510d25b6ed873a733641d4f2893ba8ae4975387a910b82231ddf4985ff14cf04868a25d92379c283a298e8c63643e6b7fa79bcc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b34573f401a8540c6423c4a181bf5607d06e1888d98524799b673a37c35ff4b493b46d186b088a433f742427761a46f606af93895f589c08a1a2a0c990d8d35a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/63b3936a10365c9c242d01be12d7aef54347cd55915437fa67ef93be7011fe77c60fd2438436fb0ee36e26c1d5683625a64458fd60d4370f6fd7bebfa7ad3404"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 14:33:58.949153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 14:33:58.950045) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474491983.957094-1393749248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 14:33:59.033487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 14:33:59.033871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 14:33:59.034213) ========= ========= Total master_lag: 0.18 =========