builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1474985939.12 results: success (0) buildid: 20160927043004 builduid: f212cac4337241cd8500e18dd1ed7042 revision: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.122157) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.122749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.123106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.162907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.163228) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 07:18:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.5M=0s 2016-09-27 07:18:59 (38.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.310515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.310848) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013857 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.372984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:18:59.373351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd --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=5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 07:18:59,754 truncating revision to first 12 chars 2016-09-27 07:18:59,755 Setting DEBUG logging. 2016-09-27 07:18:59,755 attempt 1/10 2016-09-27 07:18:59,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66a77b9bfe5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 07:19:00,054 unpacking tar archive at: mozilla-central-66a77b9bfe5d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:19:00.039078) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 07:19:00.039430) ========= script_repo_revision: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 07:19:00.039964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 07:19:00.040548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 07:19:00.054799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-27 07:19:00.055102) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:19:00 INFO - MultiFileLogger online at 20160927 07:19:00 in /builds/slave/test 07:19:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:19:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:19:00 INFO - {'append_to_log': False, 07:19:00 INFO - 'base_work_dir': '/builds/slave/test', 07:19:00 INFO - 'blob_upload_branch': 'Firefox', 07:19:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:19:00 INFO - 'branch': 'Firefox', 07:19:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:19:00 INFO - 'config_files': ('talos/linux_config.py',), 07:19:00 INFO - 'default_actions': ('clobber', 07:19:00 INFO - 'read-buildbot-config', 07:19:00 INFO - 'download-and-extract', 07:19:00 INFO - 'populate-webroot', 07:19:00 INFO - 'create-virtualenv', 07:19:00 INFO - 'install', 07:19:00 INFO - 'run-tests'), 07:19:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:19:00 INFO - 'download_minidump_stackwalk': True, 07:19:00 INFO - 'download_symbols': 'ondemand', 07:19:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:19:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:19:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:19:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:19:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:19:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:19:00 INFO - 'installer_path': 'installer.exe', 07:19:00 INFO - 'log_level': 'info', 07:19:00 INFO - 'log_name': 'talos', 07:19:00 INFO - 'log_to_console': True, 07:19:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:19:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:19:00 INFO - 'opt_config_files': (), 07:19:00 INFO - 'pip_index': False, 07:19:00 INFO - 'sps_profile': False, 07:19:00 INFO - 'sps_profile_interval': 0, 07:19:00 INFO - 'suite': 'dromaeojs', 07:19:00 INFO - 'system_bits': '32', 07:19:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:19:00 INFO - 'title': 'talos-linux64-ix-039', 07:19:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:19:00 INFO - 'use_talos_json': True, 07:19:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:19:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:19:00 INFO - 'work_dir': 'build'} 07:19:00 INFO - [mozharness: 2016-09-27 14:19:00.528263Z] Running clobber step. 07:19:00 INFO - Running pre-action listener: _resource_record_pre_action 07:19:00 INFO - Running main action method: clobber 07:19:00 INFO - rmtree: /builds/slave/test/build 07:19:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:19:00 INFO - Running post-action listener: _resource_record_post_action 07:19:00 INFO - [mozharness: 2016-09-27 14:19:00.989499Z] Finished clobber step (success) 07:19:00 INFO - [mozharness: 2016-09-27 14:19:00.989600Z] Running read-buildbot-config step. 07:19:00 INFO - Running pre-action listener: _resource_record_pre_action 07:19:00 INFO - Running main action method: read_buildbot_config 07:19:00 INFO - Using buildbot properties: 07:19:00 INFO - { 07:19:00 INFO - "project": "", 07:19:00 INFO - "product": "firefox", 07:19:00 INFO - "script_repo_revision": "production", 07:19:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:19:00 INFO - "repository": "", 07:19:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:19:00 INFO - "buildid": "20160927043004", 07:19:00 INFO - "pgo_build": "True", 07:19:00 INFO - "basedir": "/builds/slave/test", 07:19:00 INFO - "buildnumber": 4, 07:19:00 INFO - "slavename": "talos-linux64-ix-039", 07:19:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:19:00 INFO - "platform": "ubuntu64_hw", 07:19:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:19:00 INFO - "branch": "mozilla-central", 07:19:00 INFO - "repo_path": "mozilla-central", 07:19:00 INFO - "revision": "66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd", 07:19:00 INFO - "stage_platform": "linux64-pgo", 07:19:00 INFO - "builduid": "f212cac4337241cd8500e18dd1ed7042", 07:19:00 INFO - "slavebuilddir": "test" 07:19:00 INFO - } 07:19:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:19:00 INFO - Running post-action listener: _resource_record_post_action 07:19:00 INFO - [mozharness: 2016-09-27 14:19:00.992032Z] Finished read-buildbot-config step (success) 07:19:00 INFO - [mozharness: 2016-09-27 14:19:00.992139Z] Running download-and-extract step. 07:19:00 INFO - Running pre-action listener: _resource_record_pre_action 07:19:00 INFO - Running main action method: download_and_extract 07:19:00 INFO - mkdir: /builds/slave/test/build/tests 07:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:00 INFO - trying https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:19:00 INFO - Downloading https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/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 07:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/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 07:19:01 INFO - Downloaded 1361 bytes. 07:19:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:19:01 INFO - Using the following test package requirements: 07:19:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:19:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:19:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:19:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'jsshell-linux-x86_64.zip'], 07:19:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:19:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:19:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:19:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:19:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:19:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:19:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:19:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:19:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:19:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:01 INFO - Fetch https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:19:02 INFO - Expected file size: 21984007 07:19:06 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 07:19:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:19:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:06 INFO - Fetch https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:19:06 INFO - Expected file size: 21984007 07:19:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:19:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:19:11 INFO - Fetch https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:19:12 INFO - Expected file size: 14414057 07:19:13 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')]} 07:19:13 INFO - trying https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:19:13 INFO - Downloading https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/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 07:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/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 07:19:15 INFO - Downloaded 59711999 bytes. 07:19:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:19:15 INFO - mkdir: /builds/slave/test/properties 07:19:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:19:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:19:15 INFO - Contents: 07:19:15 INFO - build_url:https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:19:16 INFO - Running post-action listener: _resource_record_post_action 07:19:16 INFO - Running post-action listener: set_extra_try_arguments 07:19:16 INFO - [mozharness: 2016-09-27 14:19:16.175068Z] Finished download-and-extract step (success) 07:19:16 INFO - [mozharness: 2016-09-27 14:19:16.175295Z] Running populate-webroot step. 07:19:16 INFO - Running pre-action listener: _resource_record_pre_action 07:19:16 INFO - Running main action method: populate_webroot 07:19:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:19:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:19:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:19:16 INFO - '--tppagecycles', 07:19:16 INFO - '7'], 07:19:16 INFO - 'tests': ['tsvgm']}}, 07:19:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:19:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:19:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:19:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:19:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['damp', 'tps']}, 07:19:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'tests': ['damp', 'tps']}, 07:19:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['dromaeo_dom']}, 07:19:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:19:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['basic_compositor_video']}, 07:19:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:19:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['a11yr', 07:19:16 INFO - 'ts_paint', 07:19:16 INFO - 'tpaint', 07:19:16 INFO - 'sessionrestore', 07:19:16 INFO - 'sessionrestore_no_auto_restore', 07:19:16 INFO - 'tabpaint']}, 07:19:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:19:16 INFO - 'ts_paint', 07:19:16 INFO - 'tpaint', 07:19:16 INFO - 'sessionrestore', 07:19:16 INFO - 'sessionrestore_no_auto_restore', 07:19:16 INFO - 'tabpaint']}, 07:19:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:19:16 INFO - 'ts_paint', 07:19:16 INFO - 'tpaint', 07:19:16 INFO - 'sessionrestore', 07:19:16 INFO - 'sessionrestore_no_auto_restore', 07:19:16 INFO - 'tabpaint']}, 07:19:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:19:16 INFO - 'ts_paint', 07:19:16 INFO - 'tpaint', 07:19:16 INFO - 'sessionrestore', 07:19:16 INFO - 'sessionrestore_no_auto_restore', 07:19:16 INFO - 'tabpaint']}, 07:19:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['a11yr', 07:19:16 INFO - 'ts_paint', 07:19:16 INFO - 'tpaint', 07:19:16 INFO - 'sessionrestore', 07:19:16 INFO - 'sessionrestore_no_auto_restore', 07:19:16 INFO - 'tabpaint']}, 07:19:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['a11yr', 07:19:16 INFO - 'ts_paint', 07:19:16 INFO - 'tpaint', 07:19:16 INFO - 'sessionrestore', 07:19:16 INFO - 'sessionrestore_no_auto_restore', 07:19:16 INFO - 'tabpaint']}, 07:19:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['tsvgx', 07:19:16 INFO - 'tsvgr_opacity', 07:19:16 INFO - 'tart', 07:19:16 INFO - 'tscrollx', 07:19:16 INFO - 'cart']}, 07:19:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:19:16 INFO - 'tsvgr_opacity', 07:19:16 INFO - 'tart', 07:19:16 INFO - 'tscrollx', 07:19:16 INFO - 'cart']}, 07:19:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'talos_options': ['--disable-e10s'], 07:19:16 INFO - 'tests': ['tp5o']}, 07:19:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'tests': ['tp5o']}, 07:19:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'talos_options': ['--disable-e10s', 07:19:16 INFO - '--xperf_path', 07:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:16 INFO - 'tests': ['tp5n']}, 07:19:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:16 INFO - 'talos_options': ['--xperf_path', 07:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:16 INFO - 'tests': ['tp5n']}}, 07:19:16 INFO - 'talos.zip': {'path': '', 07:19:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:19:16 INFO - Running post-action listener: _resource_record_post_action 07:19:16 INFO - [mozharness: 2016-09-27 14:19:16.194210Z] Finished populate-webroot step (success) 07:19:16 INFO - [mozharness: 2016-09-27 14:19:16.194299Z] Running create-virtualenv step. 07:19:16 INFO - Running pre-action listener: _resource_record_pre_action 07:19:16 INFO - Running main action method: create_virtualenv 07:19:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:19:16 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 07:19:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:19:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:19:16 INFO - Using real prefix '/usr' 07:19:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:19:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:19:18 INFO - Installing pip.................done. 07:19:18 INFO - Return code: 0 07:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:19:18 INFO - Reading from file tmpfile_stdout 07:19:18 INFO - Output received: 07:19:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:19:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:19:18 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')]} 07:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:18 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')]} 07:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:18 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:18 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 07:19:18 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 07:19:18 INFO - Using env: {'DISPLAY': ':0', 07:19:18 INFO - 'HOME': '/home/cltbld', 07:19:18 INFO - 'LANG': 'en_US.UTF-8', 07:19:18 INFO - 'LANGUAGE': 'en_US:en', 07:19:18 INFO - 'LOGNAME': 'cltbld', 07:19:18 INFO - 'MAIL': '/var/mail/cltbld', 07:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:18 INFO - 'MOZ_NO_REMOTE': '1', 07:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:18 INFO - 'NO_EM_RESTART': '1', 07:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:18 INFO - 'PWD': '/builds/slave/test', 07:19:18 INFO - 'SHELL': '/bin/bash', 07:19:18 INFO - 'SHLVL': '1', 07:19:18 INFO - 'TERM': 'linux', 07:19:18 INFO - 'TMOUT': '86400', 07:19:18 INFO - 'USER': 'cltbld', 07:19:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:18 INFO - '_': '/tools/buildbot/bin/python'} 07:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:19 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 07:19:19 INFO - Cleaning up... 07:19:19 INFO - Return code: 0 07:19:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:19:19 INFO - Using env: {'DISPLAY': ':0', 07:19:19 INFO - 'HOME': '/home/cltbld', 07:19:19 INFO - 'LANG': 'en_US.UTF-8', 07:19:19 INFO - 'LANGUAGE': 'en_US:en', 07:19:19 INFO - 'LOGNAME': 'cltbld', 07:19:19 INFO - 'MAIL': '/var/mail/cltbld', 07:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:19 INFO - 'MOZ_NO_REMOTE': '1', 07:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:19 INFO - 'NO_EM_RESTART': '1', 07:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:19 INFO - 'PWD': '/builds/slave/test', 07:19:19 INFO - 'SHELL': '/bin/bash', 07:19:19 INFO - 'SHLVL': '1', 07:19:19 INFO - 'TERM': 'linux', 07:19:19 INFO - 'TMOUT': '86400', 07:19:19 INFO - 'USER': 'cltbld', 07:19:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:19 INFO - '_': '/tools/buildbot/bin/python'} 07:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:19 INFO - Downloading/unpacking psutil>=3.1.1 07:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:21 INFO - Installing collected packages: psutil 07:19:21 INFO - Running setup.py install for psutil 07:19:21 INFO - building 'psutil._psutil_linux' extension 07:19:21 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 07:19:21 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 07:19:21 INFO - building 'psutil._psutil_posix' extension 07:19:21 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 07:19:21 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 07:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:21 INFO - Successfully installed psutil 07:19:21 INFO - Cleaning up... 07:19:21 INFO - Return code: 0 07:19:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:21 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:21 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 07:19:21 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 07:19:21 INFO - Using env: {'DISPLAY': ':0', 07:19:21 INFO - 'HOME': '/home/cltbld', 07:19:21 INFO - 'LANG': 'en_US.UTF-8', 07:19:21 INFO - 'LANGUAGE': 'en_US:en', 07:19:21 INFO - 'LOGNAME': 'cltbld', 07:19:21 INFO - 'MAIL': '/var/mail/cltbld', 07:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:21 INFO - 'MOZ_NO_REMOTE': '1', 07:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:21 INFO - 'NO_EM_RESTART': '1', 07:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:21 INFO - 'PWD': '/builds/slave/test', 07:19:21 INFO - 'SHELL': '/bin/bash', 07:19:21 INFO - 'SHLVL': '1', 07:19:21 INFO - 'TERM': 'linux', 07:19:21 INFO - 'TMOUT': '86400', 07:19:21 INFO - 'USER': 'cltbld', 07:19:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:21 INFO - '_': '/tools/buildbot/bin/python'} 07:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:19:24 INFO - Installing collected packages: mozsystemmonitor 07:19:24 INFO - Running setup.py install for mozsystemmonitor 07:19:24 INFO - Successfully installed mozsystemmonitor 07:19:24 INFO - Cleaning up... 07:19:24 INFO - Return code: 0 07:19:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:19:24 INFO - Using env: {'DISPLAY': ':0', 07:19:24 INFO - 'HOME': '/home/cltbld', 07:19:24 INFO - 'LANG': 'en_US.UTF-8', 07:19:24 INFO - 'LANGUAGE': 'en_US:en', 07:19:24 INFO - 'LOGNAME': 'cltbld', 07:19:24 INFO - 'MAIL': '/var/mail/cltbld', 07:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:24 INFO - 'MOZ_NO_REMOTE': '1', 07:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:24 INFO - 'NO_EM_RESTART': '1', 07:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:24 INFO - 'PWD': '/builds/slave/test', 07:19:24 INFO - 'SHELL': '/bin/bash', 07:19:24 INFO - 'SHLVL': '1', 07:19:24 INFO - 'TERM': 'linux', 07:19:24 INFO - 'TMOUT': '86400', 07:19:24 INFO - 'USER': 'cltbld', 07:19:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:24 INFO - '_': '/tools/buildbot/bin/python'} 07:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:24 INFO - Downloading/unpacking jsonschema==2.5.1 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:19:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:19:26 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 07:19:26 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 07:19:26 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 07:19:26 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 07:19:26 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 07:19:26 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 07:19:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:19:26 INFO - warning: no files found matching '*.txt' 07:19:26 INFO - no previously-included directories found matching 'build' 07:19:26 INFO - no previously-included directories found matching 'dist' 07:19:26 INFO - no previously-included directories found matching '.git*' 07:19:26 INFO - Installing collected packages: jsonschema, functools32 07:19:26 INFO - Running setup.py install for functools32 07:19:26 INFO - warning: no files found matching '*.txt' 07:19:26 INFO - no previously-included directories found matching 'build' 07:19:26 INFO - no previously-included directories found matching 'dist' 07:19:26 INFO - no previously-included directories found matching '.git*' 07:19:26 INFO - Successfully installed jsonschema functools32 07:19:26 INFO - Cleaning up... 07:19:26 INFO - Return code: 0 07:19:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:26 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:26 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 07:19:26 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 07:19:26 INFO - Using env: {'DISPLAY': ':0', 07:19:26 INFO - 'HOME': '/home/cltbld', 07:19:26 INFO - 'LANG': 'en_US.UTF-8', 07:19:26 INFO - 'LANGUAGE': 'en_US:en', 07:19:26 INFO - 'LOGNAME': 'cltbld', 07:19:26 INFO - 'MAIL': '/var/mail/cltbld', 07:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:26 INFO - 'MOZ_NO_REMOTE': '1', 07:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:26 INFO - 'NO_EM_RESTART': '1', 07:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:26 INFO - 'PWD': '/builds/slave/test', 07:19:26 INFO - 'SHELL': '/bin/bash', 07:19:26 INFO - 'SHLVL': '1', 07:19:26 INFO - 'TERM': 'linux', 07:19:26 INFO - 'TMOUT': '86400', 07:19:26 INFO - 'USER': 'cltbld', 07:19:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:26 INFO - '_': '/tools/buildbot/bin/python'} 07:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:19:27 INFO - Cleaning up... 07:19:27 INFO - Return code: 0 07:19:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:19:27 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')]} 07:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:27 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')]} 07:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:27 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:27 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 07:19:27 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 07:19:27 INFO - Using env: {'DISPLAY': ':0', 07:19:27 INFO - 'HOME': '/home/cltbld', 07:19:27 INFO - 'LANG': 'en_US.UTF-8', 07:19:27 INFO - 'LANGUAGE': 'en_US:en', 07:19:27 INFO - 'LOGNAME': 'cltbld', 07:19:27 INFO - 'MAIL': '/var/mail/cltbld', 07:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:27 INFO - 'MOZ_NO_REMOTE': '1', 07:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:27 INFO - 'NO_EM_RESTART': '1', 07:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:27 INFO - 'PWD': '/builds/slave/test', 07:19:27 INFO - 'SHELL': '/bin/bash', 07:19:27 INFO - 'SHLVL': '1', 07:19:27 INFO - 'TERM': 'linux', 07:19:27 INFO - 'TMOUT': '86400', 07:19:27 INFO - 'USER': 'cltbld', 07:19:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:27 INFO - '_': '/tools/buildbot/bin/python'} 07:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 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 07:19:29 INFO - Downloading docopt-0.6.1.tar.gz 07:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:29 INFO - Running setup.py install for blobuploader 07:19:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:30 INFO - Running setup.py install for requests 07:19:30 INFO - Running setup.py install for docopt 07:19:30 INFO - Successfully installed blobuploader requests docopt 07:19:30 INFO - Cleaning up... 07:19:30 INFO - Return code: 0 07:19:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19: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')]} 07:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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')]} 07:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:30 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:30 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 07:19:30 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 07:19:30 INFO - Using env: {'DISPLAY': ':0', 07:19:30 INFO - 'HOME': '/home/cltbld', 07:19:30 INFO - 'LANG': 'en_US.UTF-8', 07:19:30 INFO - 'LANGUAGE': 'en_US:en', 07:19:30 INFO - 'LOGNAME': 'cltbld', 07:19:30 INFO - 'MAIL': '/var/mail/cltbld', 07:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:30 INFO - 'MOZ_NO_REMOTE': '1', 07:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:30 INFO - 'NO_EM_RESTART': '1', 07:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:30 INFO - 'PWD': '/builds/slave/test', 07:19:30 INFO - 'SHELL': '/bin/bash', 07:19:30 INFO - 'SHLVL': '1', 07:19:30 INFO - 'TERM': 'linux', 07:19:30 INFO - 'TMOUT': '86400', 07:19:30 INFO - 'USER': 'cltbld', 07:19:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:30 INFO - '_': '/tools/buildbot/bin/python'} 07:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:30 INFO - Running setup.py (path:/tmp/pip-v05PFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:30 INFO - Running setup.py (path:/tmp/pip-UW8yRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:30 INFO - Running setup.py (path:/tmp/pip-zM4i87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:31 INFO - Running setup.py (path:/tmp/pip-ZbpVGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:31 INFO - Running setup.py (path:/tmp/pip-OvZqIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:31 INFO - Running setup.py (path:/tmp/pip-tyH4Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:31 INFO - Running setup.py (path:/tmp/pip-c_xcRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:31 INFO - Running setup.py (path:/tmp/pip-rTBWbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:31 INFO - Running setup.py (path:/tmp/pip-g3heyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:31 INFO - Running setup.py (path:/tmp/pip-YdNdMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:31 INFO - Running setup.py (path:/tmp/pip-PTgVFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:31 INFO - Running setup.py (path:/tmp/pip-iKw3nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:31 INFO - Running setup.py (path:/tmp/pip-AhUs6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:31 INFO - Running setup.py (path:/tmp/pip-VKKNHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:31 INFO - Running setup.py (path:/tmp/pip-gxi47K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:31 INFO - Running setup.py (path:/tmp/pip-fA0b2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:31 INFO - Running setup.py (path:/tmp/pip-7o1HW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:31 INFO - Running setup.py install for manifestparser 07:19:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Running setup.py install for mozcrash 07:19:32 INFO - Running setup.py install for mozdebug 07:19:32 INFO - Running setup.py install for mozdevice 07:19:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Running setup.py install for mozfile 07:19:32 INFO - Running setup.py install for mozhttpd 07:19:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Running setup.py install for mozinfo 07:19:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Running setup.py install for mozInstall 07:19:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:32 INFO - Running setup.py install for mozleak 07:19:32 INFO - Running setup.py install for mozlog 07:19:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:33 INFO - Running setup.py install for moznetwork 07:19:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:33 INFO - Running setup.py install for mozprocess 07:19:33 INFO - Running setup.py install for mozprofile 07:19:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:33 INFO - Running setup.py install for mozrunner 07:19:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:33 INFO - Running setup.py install for mozscreenshot 07:19:33 INFO - Running setup.py install for moztest 07:19:33 INFO - Running setup.py install for mozversion 07:19:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:33 INFO - Cleaning up... 07:19:33 INFO - Return code: 0 07:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19: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')]} 07:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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')]} 07:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:33 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:33 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 07:19:33 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 07:19:33 INFO - Using env: {'DISPLAY': ':0', 07:19:33 INFO - 'HOME': '/home/cltbld', 07:19:33 INFO - 'LANG': 'en_US.UTF-8', 07:19:33 INFO - 'LANGUAGE': 'en_US:en', 07:19:33 INFO - 'LOGNAME': 'cltbld', 07:19:33 INFO - 'MAIL': '/var/mail/cltbld', 07:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:33 INFO - 'MOZ_NO_REMOTE': '1', 07:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:33 INFO - 'NO_EM_RESTART': '1', 07:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:33 INFO - 'PWD': '/builds/slave/test', 07:19:33 INFO - 'SHELL': '/bin/bash', 07:19:33 INFO - 'SHLVL': '1', 07:19:33 INFO - 'TERM': 'linux', 07:19:33 INFO - 'TMOUT': '86400', 07:19:33 INFO - 'USER': 'cltbld', 07:19:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:33 INFO - '_': '/tools/buildbot/bin/python'} 07:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:34 INFO - Running setup.py (path:/tmp/pip-rkHGdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:34 INFO - Running setup.py (path:/tmp/pip-hs2q8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:34 INFO - Running setup.py (path:/tmp/pip-9Qq5YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:34 INFO - Running setup.py (path:/tmp/pip-ubpzXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:34 INFO - Running setup.py (path:/tmp/pip-oZDQjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:34 INFO - Running setup.py (path:/tmp/pip-qlO1yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:34 INFO - Running setup.py (path:/tmp/pip-k24unT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:34 INFO - Running setup.py (path:/tmp/pip-bGnd3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:34 INFO - Running setup.py (path:/tmp/pip-svLl3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:34 INFO - Running setup.py (path:/tmp/pip-wwPVKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:34 INFO - Running setup.py (path:/tmp/pip-Iu_akz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:34 INFO - Running setup.py (path:/tmp/pip-M22KiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:34 INFO - Running setup.py (path:/tmp/pip-NHXg_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:34 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)) 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:34 INFO - Running setup.py (path:/tmp/pip-CI0CIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:35 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)) 07:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:35 INFO - Running setup.py (path:/tmp/pip-zbC3kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:35 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)) 07:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:35 INFO - Running setup.py (path:/tmp/pip-0jKr1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:35 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)) 07:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:35 INFO - Running setup.py (path:/tmp/pip-sSj5Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:35 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)) 07:19:35 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)) 07:19:35 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)) 07:19:35 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)) 07:19:35 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)) 07:19:35 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)) 07:19:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:37 INFO - Downloading blessings-1.6.tar.gz 07:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:37 INFO - Installing collected packages: blessings 07:19:37 INFO - Running setup.py install for blessings 07:19:37 INFO - Successfully installed blessings 07:19:37 INFO - Cleaning up... 07:19:37 INFO - Return code: 0 07:19:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:37 INFO - Reading from file tmpfile_stdout 07:19:37 INFO - Current package versions: 07:19:37 INFO - argparse == 1.2.1 07:19:37 INFO - blessings == 1.6 07:19:37 INFO - blobuploader == 1.2.4 07:19:37 INFO - docopt == 0.6.1 07:19:37 INFO - functools32 == 3.2.3-2 07:19:37 INFO - jsonschema == 2.5.1 07:19:37 INFO - manifestparser == 1.1 07:19:37 INFO - mozInstall == 1.12 07:19:37 INFO - mozcrash == 0.17 07:19:37 INFO - mozdebug == 0.1 07:19:37 INFO - mozdevice == 0.48 07:19:37 INFO - mozfile == 1.2 07:19:37 INFO - mozhttpd == 0.7 07:19:37 INFO - mozinfo == 0.9 07:19:37 INFO - mozleak == 0.1 07:19:37 INFO - mozlog == 3.4 07:19:37 INFO - moznetwork == 0.27 07:19:37 INFO - mozprocess == 0.23 07:19:37 INFO - mozprofile == 0.28 07:19:37 INFO - mozrunner == 6.12 07:19:37 INFO - mozscreenshot == 0.1 07:19:37 INFO - mozsystemmonitor == 0.3 07:19:37 INFO - moztest == 0.7 07:19:37 INFO - mozversion == 1.4 07:19:37 INFO - psutil == 3.1.1 07:19:37 INFO - requests == 1.2.3 07:19:37 INFO - wsgiref == 0.1.2 07:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:37 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')]} 07:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:37 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')]} 07:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:37 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:37 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 07:19:37 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 07:19:37 INFO - Using env: {'DISPLAY': ':0', 07:19:37 INFO - 'HOME': '/home/cltbld', 07:19:37 INFO - 'LANG': 'en_US.UTF-8', 07:19:37 INFO - 'LANGUAGE': 'en_US:en', 07:19:37 INFO - 'LOGNAME': 'cltbld', 07:19:37 INFO - 'MAIL': '/var/mail/cltbld', 07:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:37 INFO - 'MOZ_NO_REMOTE': '1', 07:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:37 INFO - 'NO_EM_RESTART': '1', 07:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:37 INFO - 'PWD': '/builds/slave/test', 07:19:37 INFO - 'SHELL': '/bin/bash', 07:19:37 INFO - 'SHLVL': '1', 07:19:37 INFO - 'TERM': 'linux', 07:19:37 INFO - 'TMOUT': '86400', 07:19:37 INFO - 'USER': 'cltbld', 07:19:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:37 INFO - '_': '/tools/buildbot/bin/python'} 07:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 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)) 07:19:37 INFO - Cleaning up... 07:19:37 INFO - Return code: 0 07:19:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:37 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')]} 07:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:37 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')]} 07:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:37 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 0x7f3ea3e27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, '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': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', '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 07:19:37 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 07:19:37 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 07:19:37 INFO - Using env: {'DISPLAY': ':0', 07:19:37 INFO - 'HOME': '/home/cltbld', 07:19:37 INFO - 'LANG': 'en_US.UTF-8', 07:19:37 INFO - 'LANGUAGE': 'en_US:en', 07:19:37 INFO - 'LOGNAME': 'cltbld', 07:19:37 INFO - 'MAIL': '/var/mail/cltbld', 07:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:37 INFO - 'MOZ_NO_REMOTE': '1', 07:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:37 INFO - 'NO_EM_RESTART': '1', 07:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:37 INFO - 'PWD': '/builds/slave/test', 07:19:37 INFO - 'SHELL': '/bin/bash', 07:19:37 INFO - 'SHLVL': '1', 07:19:37 INFO - 'TERM': 'linux', 07:19:37 INFO - 'TMOUT': '86400', 07:19:37 INFO - 'USER': 'cltbld', 07:19:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:37 INFO - '_': '/tools/buildbot/bin/python'} 07:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:38 INFO - Cleaning up... 07:19:38 INFO - Return code: 0 07:19:38 INFO - Running post-action listener: _resource_record_post_action 07:19:38 INFO - Running post-action listener: _start_resource_monitoring 07:19:38 INFO - Starting resource monitoring. 07:19:38 INFO - [mozharness: 2016-09-27 14:19:38.101945Z] Finished create-virtualenv step (success) 07:19:38 INFO - [mozharness: 2016-09-27 14:19:38.102411Z] Running install step. 07:19:38 INFO - Running pre-action listener: _resource_record_pre_action 07:19:38 INFO - Running main action method: install 07:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:38 INFO - Reading from file tmpfile_stdout 07:19:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:38 INFO - Reading from file tmpfile_stdout 07:19:38 INFO - Output received: 07:19:38 INFO - Usage: mozinstall [options] installer 07:19:38 INFO - Options: 07:19:38 INFO - -h, --help show this help message and exit 07:19:38 INFO - -d DEST, --destination=DEST 07:19:38 INFO - Directory to install application into. [default: 07:19:38 INFO - "/builds/slave/test"] 07:19:38 INFO - --app=APP Application being installed. [default: firefox] 07:19:38 INFO - mkdir: /builds/slave/test/build/application 07:19:38 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'] 07:19:38 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 07:19:55 INFO - Reading from file tmpfile_stdout 07:19:55 INFO - Output received: 07:19:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:55 INFO - Running post-action listener: _resource_record_post_action 07:19:55 INFO - [mozharness: 2016-09-27 14:19:55.564373Z] Finished install step (success) 07:19:55 INFO - [mozharness: 2016-09-27 14:19:55.564620Z] Running run-tests step. 07:19:55 INFO - Running pre-action listener: _resource_record_pre_action 07:19:55 INFO - Running main action method: run_tests 07:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:55 INFO - Python 2.7.3 07:19:55 INFO - Return code: 0 07:19:55 INFO - grabbing minidump binary from tooltool 07:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:55 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 0x27fe790>, '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 0x27ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:55 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 07:19:55 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 07:19:55 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 07:19:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:55 INFO - Return code: 0 07:19:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 07:19:55 INFO - Using env: {'DISPLAY': ':0', 07:19:55 INFO - 'HOME': '/home/cltbld', 07:19:55 INFO - 'LANG': 'en_US.UTF-8', 07:19:55 INFO - 'LANGUAGE': 'en_US:en', 07:19:55 INFO - 'LOGNAME': 'cltbld', 07:19:55 INFO - 'MAIL': '/var/mail/cltbld', 07:19:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:55 INFO - 'MOZ_NO_REMOTE': '1', 07:19:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:55 INFO - 'NO_EM_RESTART': '1', 07:19:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:55 INFO - 'PWD': '/builds/slave/test', 07:19:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:55 INFO - 'SHELL': '/bin/bash', 07:19:55 INFO - 'SHLVL': '1', 07:19:55 INFO - 'TERM': 'linux', 07:19:55 INFO - 'TMOUT': '86400', 07:19:55 INFO - 'USER': 'cltbld', 07:19:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453', 07:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:55 INFO - '_': '/tools/buildbot/bin/python'} 07:19:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:19:55 INFO - mozversion application_buildid: 20160927043004 07:19:55 INFO - mozversion application_changeset: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd 07:19:55 INFO - mozversion application_display_name: Nightly 07:19:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:55 INFO - mozversion application_name: Firefox 07:19:55 INFO - mozversion application_remotingname: firefox 07:19:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:19:55 INFO - mozversion application_vendor: Mozilla 07:19:55 INFO - mozversion application_version: 52.0a1 07:19:55 INFO - mozversion platform_buildid: 20160927043004 07:19:55 INFO - mozversion platform_changeset: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd 07:19:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:19:55 INFO - mozversion platform_version: 52.0a1 07:19:55 INFO - using testdate: 1474985995 07:19:55 INFO - actual date: 1474985995 07:19:55 INFO - starting webserver on 'localhost:53464' 07:19:55 INFO - SUITE-START | Running 2 tests 07:19:55 INFO - TEST-START | dromaeo_css 07:19:55 INFO - operating with platform_type : linux_ 07:19:55 INFO - Initialising browser for dromaeo_css test... 07:19:55 INFO - TEST-INFO | started process 16929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBPfFLU/profile http://localhost:53464/getInfo.html) 07:20:00 INFO - PROCESS | 16929 | __metrics Screen width/height:1600/1200 07:20:00 INFO - PROCESS | 16929 | colorDepth:24 07:20:00 INFO - PROCESS | 16929 | Browser inner width/height: 1024/697 07:20:00 INFO - PROCESS | 16929 | __metrics 07:20:00 INFO - PROCESS | 16929 | 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" 07:20:00 INFO - PROCESS | 16929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:20:01 INFO - PROCESS | 16929 | console.error: PushService: 07:20:01 INFO - PROCESS | 16929 | stateChangeProcessEnqueue: Error transitioning state 07:20:01 INFO - PROCESS | 16929 | UnknownError 07:20:01 INFO - TEST-INFO | 16929: exit 0 07:20:01 INFO - Browser initialized. 07:20:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:20:01 INFO - TEST-INFO | started process 17012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBPfFLU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:13 INFO - PROCESS | 17012 | RSS: Main: 173821952 07:20:13 INFO - PROCESS | 17012 | 07:21:05 INFO - PROCESS | 17012 | 1474986065237 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] 07:23:14 INFO - PROCESS | 17012 | Cycle 1(1): loaded http://localhost:53464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53464/tests/dromaeo/cssquery-ext.html) 07:23:15 INFO - PROCESS | 17012 | RSS: Main: 296210432 07:23:15 INFO - PROCESS | 17012 | 07:26:18 INFO - PROCESS | 17012 | Cycle 1(1): loaded http://localhost:53464/tests/dromaeo/cssquery-ext.html (next: http://localhost:53464/tests/dromaeo/cssquery-jquery.html) 07:26:18 INFO - PROCESS | 17012 | RSS: Main: 280137728 07:26:18 INFO - PROCESS | 17012 | 07:29:20 INFO - PROCESS | 17012 | Cycle 1(1): loaded http://localhost:53464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53464/tests/dromaeo/cssquery-mootools.html) 07:29:21 INFO - PROCESS | 17012 | RSS: Main: 277622784 07:29:21 INFO - PROCESS | 17012 | 07:32:23 INFO - PROCESS | 17012 | Cycle 1(1): loaded http://localhost:53464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53464/tests/dromaeo/cssquery-prototype.html) 07:32:23 INFO - PROCESS | 17012 | RSS: Main: 214003712 07:32:23 INFO - PROCESS | 17012 | 07:35:26 INFO - PROCESS | 17012 | Cycle 1(1): loaded http://localhost:53464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53464/tests/dromaeo/cssquery-yui.html) 07:35:27 INFO - PROCESS | 17012 | RSS: Main: 215646208 07:35:27 INFO - PROCESS | 17012 | 07:38:29 INFO - PROCESS | 17012 | Cycle 1(1): loaded http://localhost:53464/tests/dromaeo/cssquery-yui.html (next: http://localhost:53464/tests/dromaeo/cssquery-dojo.html) 07:38:30 INFO - PROCESS | 17012 | RSS: Main: 313155584 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | __start_tp_report 07:38:30 INFO - PROCESS | 17012 | _x_x_mozilla_page_load 07:38:30 INFO - PROCESS | 17012 | _x_x_mozilla_page_load_details 07:38:30 INFO - PROCESS | 17012 | |i|pagename|runs| 07:38:30 INFO - PROCESS | 17012 | |0;dojo.html;2942.764578833693;2975.7619390448754;2989.3274013347;3015.8039727417704;3022.939541209176;5218.817341393052;5249;5330.38700549436;5347.866303342414;5383.084875571152;5285.127953887604;5297.549708274792;5303.893922121555;5373.032854086273;5436.864078398042;4839.927401088987;4841.588464980481;4857.344258525107;4872.561469467747;4997;4879.829205977791;4909.165441874889;4910.6317026223;4939.777710003059;4945.480724523927;4792.281157826319;4815;4842.055799119174;4869.245266983623;4966.553010229079;4817.614590832725;4843.2735089736825;4855.830045948375;4913.385826771653;4929.7781599828095;4789.712617242942;4797.136515427222;4820.180569303192;4877.902441951177;4905.2642103684375;5331.120365139747;5335.786568537293;5338.039152952506;5346.705931173784;5351.678899266057;5557.694326812024;5582.804601838916;5598.636088654265;5676.687782171979;5680.034394153004;5692.288463942007;5707.771689132472;5730.828075157752;5791.362950075489;5797.942020579782;5267.841074963502;5272.182811664198;5272.736363181864;5276.7361631917865;5281.102212623863;5509.972450137724;5603.019471592455;5676.262085928803;5773.6824474654295;5829.708514574254;5431.755570999315;5462.590305727086;5477.507024367826;5533.253010843565;5604.3835178130375;5596.972015139898;5600.551955843604;5601.327840659147;5606.271184746039;5609.4390560943575;5554.583406244547;5587.38538760736;5589.441055894459;5592.412796656374;5656.038473459522;5553.916691249635;5560.582956278296;5615.157726341082;5615.8876822464135;5628.268325117709;4364.018095928391;4374.21264172452;4380.474343078851;4416.315471101984;4420.80106395213;3883.165119499321;3893.824777885002;3913.0608653923423;3954.130091379949;3958.524977002778;5353.732313384316;5357.732113394315;5362.410134885159;5363.061464243741;5389.052558611656;5602.719864006784;5650.943490565124;5653.095504719307;5702.6293290935955;5720.08478643415;5373.9731301343245;5383.67697938125;5386.13821788512;5388.0570900092325;5427.9185812212845;4909.656324057353;4911.361523001987;4922.950770492321;4931.778069986859;4984.476629953875;5798.652080875161;5806.187133801272;5859.062549992066;5884;5889.705514724333;5699.23060386859;5739.081746920473;5743.3395159557185;5800.564957628279;5815.505682016907;5877.059670452707;5949.25634295713;5954.940450595439;5965.880682386415;5967.4629283362965;5415.83752487426;5500.257465242141;5511.063119269654;5620.662760234399;5625.381208067028;5536.4186760389575;5555.250041244381;5555.50000499957;5622.85942851432;5623.156526521055;5456.20884971669;5459.863503412446;5461.863453413696;5465.152901300305;5468;5424.864378390572;5435.266239057677;5450.454954504517;5484.753186106555;5504.422035686195;5503.20203570472;5537.086380747131;5545.805896793593;5572.108462645957;5626.127950167731;5568.638038527482;5614.887702246014;5629.774809007594;5632.605717599728;5632.690202038927;5504.504594586507;5510.338759348904;5512.240065782228;5517.420670829505;5520.36515800672 07:38:30 INFO - PROCESS | 17012 | |1;ext.html;564.9124385720212;582.0715958046915;604.88204800064;606.3178923710828;625.8404106952727;26523.07169249077;27050.458990820196;28767.424651506957;28800.71199288009;36485.45271820925;41413;45382.915537601606;45405;45419.545804541944;45457;8591.35564832637;8730.126987301282;8736.126387361244;8741.694040708577;8760.561971901412;8881.555922203896;8986.910130898705;8987.730368088967;9026.23277021454;9054.547272636375;9081;9120.771980700469;9129.452232866017;9133.086691330847;9135.36052476327;9034.638614455414;9053.954730226373;9070.63717451301;9079.137481939206;9081.091890810865;8935.374523783337;8977.6857809977;8993.14565116313;9003.639854405881;9005.189532942066;36066.27867442663;36185.27629447423;36369.63630363689;36407.453888191696;36411.08972275688;3287.539744435781;3319.9170020749434;3443.6900678938764;3788.8295026723863;3849.7305188636806;30974.380512389853;31991.84004079965;32077.839610801795;32157.356852862813;32355.676443235738;4267.807948642288;4338.891527711801;4379.4525684289465;4384.21084204843;4393.714408563433;329155;333357;333403;333437;335440;56895;57013;57186.7140664294;57191;57283.71358143266;59014.70492647509;59566.702166489755;59596.40403595995;59648.70175649094;59678.40321596815;16377.91811040961;16549.25528351227;16598.917005414896;16610.66778664444;16611.335546578244;11648.41757912118;11680.649580512598;11787.88212117885;11788.764224715458;11817.763644727058;14837;15748.795168676394;15799.289031993589;15803.604909877346;15804.525864224091;6298.9530051151405;6305.306416294204;6463.806085817433;6498.772542961068;6626.304238055031;969.2343048991218;1005.7887843552936;1019.9031092046243;1042.1766804224728;1100.3178029621686;32333.35333293321;32382.676173238437;32452.83773581117;32742.345153096805;32815.343693126;1103.508938522366;1126.2735535579668;1158.2760774515928;1170.2510393348264;1180.392098069495;16674.499765006825;17014.914925425295;17140.40008599693;17262.309507619804;17326.480205593853;517238;519973;520329;520723;520796;55869.441305587236;55905.44094559084;56017.15974260389;56140.43859561434;56305.71847140738;1198.604460528041;1254.1095821966323;1261.8611952685014;1319.2414361742037;1356.7286542691304;29839.552406714352;33177;33257.83371083129;33412.498812518315;33432;39522.2095558093;39921.60274390382;39971.200575987736;39973.60026399699;39978.60021399865;379934;380892;381491;381547;382292;34090.14774630654;35339;38232.80883595564;39483.802580986914;39591.40612890867;45510.772446137555;45703.314450283935;45876.541234587225;46449.53550464587;46979;38851.41722874215;39958.800205998785;41275;41923.7903810479;42074.57925420706;40071.39892901667;41577.168456631305;42515.36226956536;43593;44748.77625611851;35240.471392928615;36522.15645496708;36915.446268306536;36923.446148308336;36988.075298117765;40823;42161.36757948695;43350.92321964742;43878.78060609676;44736.32895506505;26889.462210755282;29275.85362073176;29869;30028.849855751454;30044 07:38:30 INFO - PROCESS | 17012 | |2;jquery.html;362.5848403577905;376.9302679004384;377.95842457329707;384.172109104879;400.24753463488656;18024.81975180248;18907.338243161492;19338.613227735437;19385;19529;16726.41457548986;17247.82752172478;17284.740728889046;17919.193636286367;18980.715289270636;5655.57583181262;5721.3694097182315;5867.031939729939;5872.236609240793;5873.383294754053;5632.943670563303;5768.740406681688;5817.418258174191;5818.272715910512;5820.301563812349;5597.916031259534;5794.971025144869;5798.768049278024;5802.12968054791;5804.013317735974;5735.483806457418;5821.446962538552;5823.388544202861;5824.912626310609;5826.455989162875;5120.718360490171;5210.140326846066;5216.634835561512;5218.373795144569;5382.650127741724;13667;13864.098833575785;13866.653333666638;13904.652383690387;22037.559248814934;2127.7340332458443;2179.716636837217;2216.9113235470563;2381.6784734060852;2823.9833659882424;10339.431331276777;10360.119389851872;10488.475576221159;10791.622293219778;10795.406252656101;1768.6639538487645;1775.6359946210996;1846.18767742193;1857.414914302004;1877.0333278361654;78158.21841781623;82498.58750706268;83214;83673;84585.61657533691;10427.739306517398;10476.947615262028;10566.101881340019;10842.728931776768;10940.617078402218;14929.776053359208;14980.325885335185;14987.625309367135;14995.250237488082;15013.324400402009;7478.887816682754;7670.846583068307;7723.266289702469;7918.089419716806;7959.761207163794;7376.815579610446;7389.778306650702;7423.183449820515;7555.055618047744;7679.155292917774;4513.842015529441;4631.768411579407;4632.62938964882;4721.1265915805;4739.976300118477;1925.8748181368167;1931.5364312564884;1968.9212431502579;2007.9196832126552;2034.481207292131;919.7424721078108;939.9295052871062;966.6809952715587;1012.9594816207269;1035.1511760356436;18962;19425.22299108048;19501.12244948981;19507.707384389247;19863.205471780966;934.2619330728648;971.9076687714655;995.865558149655;1050.2963014780116;1063.3407287481657;10551.314164579278;10929.344239345664;11042.155378052148;11087.72280692973;11121.888781112248;426447;426564;439395;440377;449970;88067.55966220128;89219;89823;90965.54517227504;91572;902.5757893789909;909.068205089775;936.1293996583242;936.9718908432758;943.1935694980692;16665.91667041657;16936.068516231724;17471.301147954448;17668.558286042953;17796.733049004535;32295.838520807247;40854;41638.791806040776;41871.37192942047;42121.36817947795;56397;57359.713201433726;57502.7124864373;58129;58615.12077318929;8211.95894020526;8360.122187170502;8369.832603347777;8474.533900635524;8551.57242137903;9288.535573221447;12568.183068100545;12776.6805829855;13210.735785284432;13286.402111904794;11601.361925093863;11610.303381797119;11786;11898.22661526998;12364.44360003784;11246.66260012201;11363.204575679954;11508.769824603294;11537.942310288396;11929.403529823301;11687.357195353998;11693.88306116962;11965.341906195243;11968.521259149884;12317.507299707911;7661;8007.399445041761;8269.875951860848;8530.829383412172;8742.781430464034;11248.26886252391;11278.323300601991;11288.717782055513;11426.942865285953;12169.574064907685 07:38:30 INFO - PROCESS | 17012 | |3;mootools.html;1284.6531436512148;1286.95495657652;1288.5618889577543;1366.8974826887984;1510.9320080596372;7481;8376.078631350547;8483.618237179326;8564.272036876873;8776.956115219431;8605.741827745178;8660.696875609356;8680.782980425492;8683.261922736576;8689.087645797179;2288.7024686790737;2325.93022209334;2331.6036273833406;2339.181286549711;2340.1224540797202;2249.3364457485;2317.06159005603;2326.1044497868356;2327.9185228517003;2339.7075365579303;2313.548857972696;2334.26470661741;2339.6841426407473;2350.529894021194;2372.8457650252763;2242.5627002734473;2269.3986093685185;2281.0533628544135;2283.2693538067824;2297.425643589111;2272.784085511874;2308.953820923589;2317.1774020222747;2323.5352929414184;2328.93013209604;8576.828463430758;8683.348748843862;8685.305175585938;8687.261582765472;8699.869501957475;5110.207917772751;5114.693118412907;5243.056249875021;5246.9768395162955;5293.655912365684;3304.669533046676;3387.762856600039;3486.9128271793406;3504.859805607798;3557.94663080054;1151.7811615792973;1207.6558180918485;1208.788462019143;1222.0468034932678;1224.6081253998725;12122.696932576668;12172.634820955385;12210.32843193624;12247.571335003233;12284.078694097978;4303.849365272201;4430.246858034142;4592.954070459253;4602.792874320597;4619.607333376701;9656.662016829378;9667;9670.613175473043;9672.75818104553;9677.564509597085;5300.867478312995;5338.172583249602;5338.332708411449;5344.038073146871;5347.545458635982;4205.137946720914;4273.1026484438;4330.588594083557;4687.250039993584;4900.09348270564;3641.198936234024;3745.232227393378;3822.598627144165;3902.687784977195;3923.7841918694744;1131.3494740524231;1137.4597066393396;1155.3934184553177;1173.0674114079327;1180.710725872167;918.7519369770125;942.9815798937132;947.7251597036782;975.2250903355824;992.7915137820994;5644.717764111778;5725.1698503716725;5751.194832723339;5988.101784732325;6001.699915004232;425.8743670617175;437.18901437833;438.3599944081613;448.40362318116826;455.52625269719783;4083.387491876242;4143.461350024478;4152.4601801765575;4154.086101057763;4155.771432571238;10771.730706732238;10966.451677416097;11049.060829829394;11057.225994180491;11061.170412219115;10977.615783447542;11032.724181895357;11059.557617695364;11074.944625276983;11082.279651822606;8157.265846073882;8183;8234.094249632535;8243.587820608825;8247.463914845515;5929.762809487572;5987.072003839412;6020.247469066367;6073.210482637229;6128.693565321805;9536.33245672824;9978.351407158512;10038;10067.84898226542;10111.39331640104;10015.1987840974;10307.381557106597;10309.123724483203;10310;10319.226058045526;6726.529142959946;7071.116110486189;7754.728584499516;7908;7908.604569771604;8132.186781322057;8402.201790829862;8478.533680647624;8487.193716596914;8494;7709.768706938801;7713.2286771322415;7744.535327880345;7899.960500197462;8053;7355.963220183865;7489.176190618919;7577.583232922242;7587.772366829004;7710.421718371257;7024.438044956493;7154.928450715426;7160.534565253241;7161.928380716335;7165.605891676008;5122.359705036871;5174.844754657366;5214.322138122172;5230.869228269324;5431.37539182999;5338.3060202173465;5364.839054828361;5414;5423.132298832168;5479.013777520085 07:38:30 INFO - PROCESS | 17012 | |4;prototype.html;332.7753865773952;335.0818756606898;342.8919890234576;346.6949084805371;347.0456245325354;5149.716765577901;5190.480951904808;5202.193659982704;5205.553389906747;5225.230627767285;5111.677409683707;5115.155999260118;5118.846434606959;5120.615953803461;5155.7422128893595;3901.648851603355;3967.642912137907;4014.518257809067;4046.312126938413;4105.4252404663375;4114.917701645965;4115.259253334399;4121.1757648470275;4124.731397731251;4124.773137477438;4080.571539988303;4087.5912408759036;4089.161721847029;4097.282975479294;4109.794510274489;3898.2203559288114;3969.563348031714;4016.879493615196;4034;4052.331365324718;3603.4414665726854;3610.4185507362363;3622.6558476944647;3624.7643903146213;3626.12972886508;5010.774515146791;5019.924701129486;5033.748312584356;5037.29477873098;5040.697558146523;4476.283794592882;4623.83816566422;4632.745199014053;4642.210824159867;4643.489216186217;5352.036633405985;5352.518273355417;5372.355317361941;5374.220737992969;5403.837884863421;3990.8004599769897;3994.460747799068;3996.660283875874;3999.3601023836045;4025.1144748155652;5428.484293992104;5571.749271282802;5609.4390560943575;5622.943770562283;5635.408282130358;4070.5115386153852;4072.6945479089186;4078.163976384834;4079.816408261576;4081.0409553754844;4122.2786012447705;4135.31767258405;4138.813753381105;4139.77231252278;4141.378793181047;4389.956100439019;4566.520515345907;4627.282771170474;4669.2762621793;4678.69588476748;5359.866003349869;5383.623146379716;5387.982729671397;5397.271368365299;5400.945990540123;1381.7720076187518;1403.5683602725162;1406.4725727852056;1406.8874490040773;1415.5328741515275;855.8887344645157;908.7410088124852;914.1270087066836;927.3909766555022;927.7866090799154;5033.924491132636;5069.822556210589;5199.452268388538;5233.973830130825;5241.371035475768;5454.754536045887;5514.889702205934;5524.364698059774;5539.7784088636;5554.972225138929;4985.700857948535;5184.455632158569;5214.582833373321;5219.869503262373;5223;2927.6779554249015;2932.8122110545264;2937.75029122527;2953.18787333485;2957;5712.571557133148;5721.799737009184;5743.339515955635;5770.740316685759;5772.422757724278;5418.6748795071635;5675.687837168995;5716;5719.656820590778;5733.483986441241;5738.942610573841;5743.368229494836;5745.195672605839;5796.623219490804;5815.970920145457;5458.208559758892;5591.329040515164;5598.384177740527;5602.52378547828;5607.308491923981;5518.357883796675;5523;5539.8892022160135;5548.167774833646;5553.6390134641115;5849.94150058494;5849.970750146222;5852.473277405054;5853.531717462678;5864.706764661664;3870.5291989043985;4051.3517837145914;4051.959480405158;4068.2270368629866;4095.365218391035;5553.416891226525;5560.471755183251;5573.414791446839;5578.358488773681;5581.6930068846605;5349.545288650508;5429.158480435539;5436.836894893159;5448.45515448452;5475.808346707846;5199.92200116991;5466.426025267289;5471.179323101407;5488.655279456559;5489.698066606215;5451.236826844324;5451.56387488992;5458.781648734006;5460.525658072219;5479.561635069264;5244.7902083916215;5305.787768489217;5411.2153737708595;5459.672419654833;5485.561155107502;5351.518363347317;5379.892402152013;5380.085385484555;5387.249144028128;5389.434109418455 07:38:30 INFO - PROCESS | 17012 | |5;yui.html;684.722687311639;714.3963350968431;735.9300866417692;775.4726785785667;828.8466633672771;16016.919915400422;17587.5603109922;17603.383881564132;17606.823931760693;17654.117294135274;13949.58151255464;14001.509947151852;14017.15897046178;14085.647858803535;14114.505992290271;788.1724189600925;806.2743530822248;808.7937575918132;810.9391795615323;810.9391795615323;807.0638059850575;809.3323008517967;809.7004108479871;809.8785182222684;810.2140923304386;834.3575446905879;835.1773503099442;836.3267569606464;836.3351135847016;838.4340570115178;835.8620827563444;836.7322456813822;837.1962915601031;837.7403005068418;837.8533756592602;614.7633161232912;618.1654766065775;618.2086928731231;618.4681174190193;618.6906546726636;14297.928510357486;14313.28433578317;14338.068025578408;14342.85657143436;14355.71288574233;11884.346360950145;11890.405479726065;12185.69535761613;12214.083943704258;13041.934790326082;10978.615748448767;11129.888701112966;11136.387498687569;11206.495707693091;11879.584214552535;3775.4336849472525;3779.9055023624355;3799.3351163546267;3946.2304850554156;3950.7827069511163;73614;74815.25184748192;77324.61337693332;79334.603326983;79338.20661793424;9191.770205744777;9232.122948319899;9245.861312080324;9372.578233979488;9401.811963760687;16146.838531614769;16345.673086538203;16393.180340982904;16412.75380869288;16448.83551164497;8373.162683731578;8457.830843383097;8570.663599222542;8619.310455163572;8790.164934331227;4820.590249828804;4926.926096108561;4934.333864928189;5013.974930125326;5226.555742761831;3417.162795115163;3538.628444013393;3544.362014837354;3544.7164226861787;3561.7506774526055;557.4759725857681;567.6877717255493;568.7383803450376;570.2814453788257;572.567711377907;554.6810583914265;590.5806877117209;729.0813574895564;739.9049406877743;750.4071783291139;9563.521823908777;10072.244581656405;10114.949425252827;10137.847932281022;10202.132818710345;670.4602794750273;694.6804469943781;703.4624003799315;717.9533330333512;725.684327317608;4783.56947874686;5017.243964612357;5078.13671675816;5202.609804264695;5214.45248248936;120661.39669301597;122024.38987805005;123982;124366;126659;101625;101909.49045254727;103256;104876;105233.47383263188;93124.53437732768;94966.5251673751;97222;98497.50751246055;99000.50499747455;9471.905280947103;9770;9776.413415195111;9836.262280329147;9853.655122070693;55832.72083639556;56458.76234686379;56685.433145668016;57239.42760572341;57859;81173.18826811893;81682;84294.7355789676;85146;86330;12441.253524788543;12533.623991280276;12561.497540098293;12692.17500862441;13159.934200328937;13114.868851311747;13397.598072057854;13904.165750055028;13953.860461395256;14158.221297828719;12092.576759813364;12186.390680466118;12345.38273086324;13001.869981300066;13239.20564766117;12177.817332740193;12209.206401583868;12324.938375308424;12370.381480926098;12915.289659068842;12563.811542827048;12629.93685031569;12635.115541911979;12651.177673451197;13331.400086996302;10276.948615256875;10371.58513659445;10453;10477.37135771856;10738.355698658106;10830.51262693165;11014.614488492864;11071.833922491009;11193.776124477628;11327.830082548604 07:38:30 INFO - PROCESS | 17012 | __end_tp_report 07:38:30 INFO - PROCESS | 17012 | __start_cc_report 07:38:30 INFO - PROCESS | 17012 | _x_x_mozilla_cycle_collect,1014 07:38:30 INFO - PROCESS | 17012 | __end_cc_report 07:38:30 INFO - PROCESS | 17012 | __startTimestamp1474987110189__endTimestamp 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | ------- Summary: start ------- 07:38:30 INFO - PROCESS | 17012 | Number of tests: 6 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | [#0] dojo.html Cycles:165 Average:5269.39 Median:5461.86 stddev:588.76 (10.8%) stddev-sans-first:561.56 07:38:30 INFO - PROCESS | 17012 | Values: 2942.8 2975.8 2989.3 3015.8 3022.9 5218.8 5249.0 5330.4 5347.9 5383.1 5285.1 5297.5 5303.9 5373.0 5436.9 4839.9 4841.6 4857.3 4872.6 4997.0 4879.8 4909.2 4910.6 4939.8 4945.5 4792.3 4815.0 4842.1 4869.2 4966.6 4817.6 4843.3 4855.8 4913.4 4929.8 4789.7 4797.1 4820.2 4877.9 4905.3 5331.1 5335.8 5338.0 5346.7 5351.7 5557.7 5582.8 5598.6 5676.7 5680.0 5692.3 5707.8 5730.8 5791.4 5797.9 5267.8 5272.2 5272.7 5276.7 5281.1 5510.0 5603.0 5676.3 5773.7 5829.7 5431.8 5462.6 5477.5 5533.3 5604.4 5597.0 5600.6 5601.3 5606.3 5609.4 5554.6 5587.4 5589.4 5592.4 5656.0 5553.9 5560.6 5615.2 5615.9 5628.3 4364.0 4374.2 4380.5 4416.3 4420.8 3883.2 3893.8 3913.1 3954.1 3958.5 5353.7 5357.7 5362.4 5363.1 5389.1 5602.7 5650.9 5653.1 5702.6 5720.1 5374.0 5383.7 5386.1 5388.1 5427.9 4909.7 4911.4 4923.0 4931.8 4984.5 5798.7 5806.2 5859.1 5884.0 5889.7 5699.2 5739.1 5743.3 5800.6 5815.5 5877.1 5949.3 5954.9 5965.9 5967.5 5415.8 5500.3 5511.1 5620.7 5625.4 5536.4 5555.3 5555.5 5622.9 5623.2 5456.2 5459.9 5461.9 5465.2 5468.0 5424.9 5435.3 5450.5 5484.8 5504.4 5503.2 5537.1 5545.8 5572.1 5626.1 5568.6 5614.9 5629.8 5632.6 5632.7 5504.5 5510.3 5512.2 5517.4 5520.4 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | [#1] ext.html Cycles:180 Average:57049.10 Median:39756.50 stddev:110936.22 (279.0%) stddev-sans-first:111166.36 07:38:30 INFO - PROCESS | 17012 | Values: 564.9 582.1 604.9 606.3 625.8 26523.1 27050.5 28767.4 28800.7 36485.5 41413.0 45382.9 45405.0 45419.5 45457.0 8591.4 8730.1 8736.1 8741.7 8760.6 8881.6 8986.9 8987.7 9026.2 9054.5 9081.0 9120.8 9129.5 9133.1 9135.4 9034.6 9054.0 9070.6 9079.1 9081.1 8935.4 8977.7 8993.1 9003.6 9005.2 36066.3 36185.3 36369.6 36407.5 36411.1 3287.5 3319.9 3443.7 3788.8 3849.7 30974.4 31991.8 32077.8 32157.4 32355.7 4267.8 4338.9 4379.5 4384.2 4393.7 329155.0 333357.0 333403.0 333437.0 335440.0 56895.0 57013.0 57186.7 57191.0 57283.7 59014.7 59566.7 59596.4 59648.7 59678.4 16377.9 16549.3 16598.9 16610.7 16611.3 11648.4 11680.6 11787.9 11788.8 11817.8 14837.0 15748.8 15799.3 15803.6 15804.5 6299.0 6305.3 6463.8 6498.8 6626.3 969.2 1005.8 1019.9 1042.2 1100.3 32333.4 32382.7 32452.8 32742.3 32815.3 1103.5 1126.3 1158.3 1170.3 1180.4 16674.5 17014.9 17140.4 17262.3 17326.5 517238.0 519973.0 520329.0 520723.0 520796.0 55869.4 55905.4 56017.2 56140.4 56305.7 1198.6 1254.1 1261.9 1319.2 1356.7 29839.6 33177.0 33257.8 33412.5 33432.0 39522.2 39921.6 39971.2 39973.6 39978.6 379934.0 380892.0 381491.0 381547.0 382292.0 34090.1 35339.0 38232.8 39483.8 39591.4 45510.8 45703.3 45876.5 46449.5 46979.0 38851.4 39958.8 41275.0 41923.8 42074.6 40071.4 41577.2 42515.4 43593.0 44748.8 35240.5 36522.2 36915.4 36923.4 36988.1 40823.0 42161.4 43350.9 43878.8 44736.3 26889.5 29275.9 29869.0 30028.8 30044.0 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | [#2] jquery.html Cycles:180 Average:27100.27 Median:377.44 stddev:72339.82 (19165.7%) stddev-sans-first:72514.89 07:38:30 INFO - PROCESS | 17012 | Values: 362.6 376.9 378.0 384.2 400.2 18024.8 18907.3 19338.6 19385.0 19529.0 16726.4 17247.8 17284.7 17919.2 18980.7 5655.6 5721.4 5867.0 5872.2 5873.4 5632.9 5768.7 5817.4 5818.3 5820.3 5597.9 5795.0 5798.8 5802.1 5804.0 5735.5 5821.4 5823.4 5824.9 5826.5 5120.7 5210.1 5216.6 5218.4 5382.7 13667.0 13864.1 13866.7 13904.7 22037.6 2127.7 2179.7 2216.9 2381.7 2824.0 10339.4 10360.1 10488.5 10791.6 10795.4 1768.7 1775.6 1846.2 1857.4 1877.0 78158.2 82498.6 83214.0 83673.0 84585.6 10427.7 10476.9 10566.1 10842.7 10940.6 14929.8 14980.3 14987.6 14995.3 15013.3 7478.9 7670.8 7723.3 7918.1 7959.8 7376.8 7389.8 7423.2 7555.1 7679.2 4513.8 4631.8 4632.6 4721.1 4740.0 1925.9 1931.5 1968.9 2007.9 2034.5 919.7 939.9 966.7 1013.0 1035.2 18962.0 19425.2 19501.1 19507.7 19863.2 934.3 971.9 995.9 1050.3 1063.3 10551.3 10929.3 11042.2 11087.7 11121.9 426447.0 426564.0 439395.0 440377.0 449970.0 88067.6 89219.0 89823.0 90965.5 91572.0 902.6 909.1 936.1 937.0 943.2 16665.9 16936.1 17471.3 17668.6 17796.7 32295.8 40854.0 41638.8 41871.4 42121.4 56397.0 57359.7 57502.7 58129.0 58615.1 8212.0 8360.1 8369.8 8474.5 8551.6 9288.5 12568.2 12776.7 13210.7 13286.4 11601.4 11610.3 11786.0 11898.2 12364.4 11246.7 11363.2 11508.8 11537.9 11929.4 11687.4 11693.9 11965.3 11968.5 12317.5 7661.0 8007.4 8269.9 8530.8 8742.8 11248.3 11278.3 11288.7 11426.9 12169.6 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | [#3] mootools.html Cycles:180 Average:5734.15 Median:4653.43 stddev:3289.63 (70.7%) stddev-sans-first:3281.86 07:38:30 INFO - PROCESS | 17012 | Values: 1284.7 1287.0 1288.6 1366.9 1510.9 7481.0 8376.1 8483.6 8564.3 8777.0 8605.7 8660.7 8680.8 8683.3 8689.1 2288.7 2325.9 2331.6 2339.2 2340.1 2249.3 2317.1 2326.1 2327.9 2339.7 2313.5 2334.3 2339.7 2350.5 2372.8 2242.6 2269.4 2281.1 2283.3 2297.4 2272.8 2309.0 2317.2 2323.5 2328.9 8576.8 8683.3 8685.3 8687.3 8699.9 5110.2 5114.7 5243.1 5247.0 5293.7 3304.7 3387.8 3486.9 3504.9 3557.9 1151.8 1207.7 1208.8 1222.0 1224.6 12122.7 12172.6 12210.3 12247.6 12284.1 4303.8 4430.2 4593.0 4602.8 4619.6 9656.7 9667.0 9670.6 9672.8 9677.6 5300.9 5338.2 5338.3 5344.0 5347.5 4205.1 4273.1 4330.6 4687.3 4900.1 3641.2 3745.2 3822.6 3902.7 3923.8 1131.3 1137.5 1155.4 1173.1 1180.7 918.8 943.0 947.7 975.2 992.8 5644.7 5725.2 5751.2 5988.1 6001.7 425.9 437.2 438.4 448.4 455.5 4083.4 4143.5 4152.5 4154.1 4155.8 10771.7 10966.5 11049.1 11057.2 11061.2 10977.6 11032.7 11059.6 11074.9 11082.3 8157.3 8183.0 8234.1 8243.6 8247.5 5929.8 5987.1 6020.2 6073.2 6128.7 9536.3 9978.4 10038.0 10067.8 10111.4 10015.2 10307.4 10309.1 10310.0 10319.2 6726.5 7071.1 7754.7 7908.0 7908.6 8132.2 8402.2 8478.5 8487.2 8494.0 7709.8 7713.2 7744.5 7900.0 8053.0 7356.0 7489.2 7577.6 7587.8 7710.4 7024.4 7154.9 7160.5 7161.9 7165.6 5122.4 5174.8 5214.3 5230.9 5431.4 5338.3 5364.8 5414.0 5423.1 5479.0 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | [#4] prototype.html Cycles:180 Average:4587.20 Median:5217.23 stddev:1337.76 (25.6%) stddev-sans-first:1302.85 07:38:30 INFO - PROCESS | 17012 | Values: 332.8 335.1 342.9 346.7 347.0 5149.7 5190.5 5202.2 5205.6 5225.2 5111.7 5115.2 5118.8 5120.6 5155.7 3901.6 3967.6 4014.5 4046.3 4105.4 4114.9 4115.3 4121.2 4124.7 4124.8 4080.6 4087.6 4089.2 4097.3 4109.8 3898.2 3969.6 4016.9 4034.0 4052.3 3603.4 3610.4 3622.7 3624.8 3626.1 5010.8 5019.9 5033.7 5037.3 5040.7 4476.3 4623.8 4632.7 4642.2 4643.5 5352.0 5352.5 5372.4 5374.2 5403.8 3990.8 3994.5 3996.7 3999.4 4025.1 5428.5 5571.7 5609.4 5622.9 5635.4 4070.5 4072.7 4078.2 4079.8 4081.0 4122.3 4135.3 4138.8 4139.8 4141.4 4390.0 4566.5 4627.3 4669.3 4678.7 5359.9 5383.6 5388.0 5397.3 5400.9 1381.8 1403.6 1406.5 1406.9 1415.5 855.9 908.7 914.1 927.4 927.8 5033.9 5069.8 5199.5 5234.0 5241.4 5454.8 5514.9 5524.4 5539.8 5555.0 4985.7 5184.5 5214.6 5219.9 5223.0 2927.7 2932.8 2937.8 2953.2 2957.0 5712.6 5721.8 5743.3 5770.7 5772.4 5418.7 5675.7 5716.0 5719.7 5733.5 5738.9 5743.4 5745.2 5796.6 5816.0 5458.2 5591.3 5598.4 5602.5 5607.3 5518.4 5523.0 5539.9 5548.2 5553.6 5849.9 5850.0 5852.5 5853.5 5864.7 3870.5 4051.4 4052.0 4068.2 4095.4 5553.4 5560.5 5573.4 5578.4 5581.7 5349.5 5429.2 5436.8 5448.5 5475.8 5199.9 5466.4 5471.2 5488.7 5489.7 5451.2 5451.6 5458.8 5460.5 5479.6 5244.8 5305.8 5411.2 5459.7 5485.6 5351.5 5379.9 5380.1 5387.2 5389.4 07:38:30 INFO - PROCESS | 17012 | 07:38:30 INFO - PROCESS | 17012 | [#5] yui.html Cycles:180 Average:21492.05 Median:4873.76 stddev:32388.74 (664.6%) stddev-sans-first:32441.92 07:38:30 INFO - PROCESS | 17012 | Values: 684.7 714.4 735.9 775.5 828.8 16016.9 17587.6 17603.4 17606.8 17654.1 13949.6 14001.5 14017.2 14085.6 14114.5 788.2 806.3 808.8 810.9 810.9 807.1 809.3 809.7 809.9 810.2 834.4 835.2 836.3 836.3 838.4 835.9 836.7 837.2 837.7 837.9 614.8 618.2 618.2 618.5 618.7 14297.9 14313.3 14338.1 14342.9 14355.7 11884.3 11890.4 12185.7 12214.1 13041.9 10978.6 11129.9 11136.4 11206.5 11879.6 3775.4 3779.9 3799.3 3946.2 3950.8 73614.0 74815.3 77324.6 79334.6 79338.2 9191.8 9232.1 9245.9 9372.6 9401.8 16146.8 16345.7 16393.2 16412.8 16448.8 8373.2 8457.8 8570.7 8619.3 8790.2 4820.6 4926.9 4934.3 5014.0 5226.6 3417.2 3538.6 3544.4 3544.7 3561.8 557.5 567.7 568.7 570.3 572.6 554.7 590.6 729.1 739.9 750.4 9563.5 10072.2 10114.9 10137.8 10202.1 670.5 694.7 703.5 718.0 725.7 4783.6 5017.2 5078.1 5202.6 5214.5 120661.4 122024.4 123982.0 124366.0 126659.0 101625.0 101909.5 103256.0 104876.0 105233.5 93124.5 94966.5 97222.0 98497.5 99000.5 9471.9 9770.0 9776.4 9836.3 9853.7 55832.7 56458.8 56685.4 57239.4 57859.0 81173.2 81682.0 84294.7 85146.0 86330.0 12441.3 12533.6 12561.5 12692.2 13159.9 13114.9 13397.6 13904.2 13953.9 14158.2 12092.6 12186.4 12345.4 13001.9 13239.2 12177.8 12209.2 12324.9 12370.4 12915.3 12563.8 12629.9 12635.1 12651.2 13331.4 10276.9 10371.6 10453.0 10477.4 10738.4 10830.5 11014.6 11071.8 11193.8 11327.8 07:38:30 INFO - PROCESS | 17012 | -------- Summary: end -------- 07:38:30 INFO - PROCESS | 17012 | 07:38:31 INFO - TEST-INFO | 17012: exit 0 07:38:31 INFO - TEST-OK | dromaeo_css | took 1115356ms 07:38:31 INFO - TEST-START | kraken 07:38:31 INFO - operating with platform_type : linux_ 07:38:31 INFO - Initialising browser for kraken test... 07:38:31 INFO - TEST-INFO | started process 17324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8HfklL/profile http://localhost:53464/getInfo.html) 07:38:35 INFO - PROCESS | 17324 | __metrics Screen width/height:1600/1200 07:38:35 INFO - PROCESS | 17324 | colorDepth:24 07:38:35 INFO - PROCESS | 17324 | Browser inner width/height: 1024/697 07:38:35 INFO - PROCESS | 17324 | __metrics 07:38:35 INFO - PROCESS | 17324 | 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" 07:38:35 INFO - PROCESS | 17324 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:36 INFO - PROCESS | 17324 | console.error: PushService: 07:38:36 INFO - PROCESS | 17324 | stateChangeProcessEnqueue: Error transitioning state 07:38:36 INFO - PROCESS | 17324 | UnknownError 07:38:37 INFO - TEST-INFO | 17324: exit 0 07:38:37 INFO - Browser initialized. 07:38:37 INFO - Running cycle 1/1 for kraken test... 07:38:37 INFO - TEST-INFO | started process 17409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8HfklL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:49 INFO - PROCESS | 17409 | RSS: Main: 173789184 07:38:49 INFO - PROCESS | 17409 | 07:38:51 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53464/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:52 INFO - PROCESS | 17409 | RSS: Main: 233005056 07:38:52 INFO - PROCESS | 17409 | 07:38:55 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53464/tests/kraken/driver.html?testName=audio-dft) 07:38:55 INFO - PROCESS | 17409 | RSS: Main: 217944064 07:38:55 INFO - PROCESS | 17409 | 07:38:59 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53464/tests/kraken/driver.html?testName=audio-fft) 07:38:59 INFO - PROCESS | 17409 | RSS: Main: 298393600 07:38:59 INFO - PROCESS | 17409 | 07:39:01 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53464/tests/kraken/driver.html?testName=audio-oscillator) 07:39:02 INFO - PROCESS | 17409 | RSS: Main: 208891904 07:39:02 INFO - PROCESS | 17409 | 07:39:04 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:39:05 INFO - PROCESS | 17409 | RSS: Main: 213159936 07:39:05 INFO - PROCESS | 17409 | 07:39:08 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53464/tests/kraken/driver.html?testName=imaging-darkroom) 07:39:08 INFO - PROCESS | 17409 | RSS: Main: 250032128 07:39:08 INFO - PROCESS | 17409 | 07:39:11 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53464/tests/kraken/driver.html?testName=imaging-desaturate) 07:39:12 INFO - PROCESS | 17409 | RSS: Main: 248537088 07:39:12 INFO - PROCESS | 17409 | 07:39:15 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53464/tests/kraken/driver.html?testName=json-parse-financial) 07:39:15 INFO - PROCESS | 17409 | RSS: Main: 248356864 07:39:15 INFO - PROCESS | 17409 | 07:39:17 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:39:18 INFO - PROCESS | 17409 | RSS: Main: 210563072 07:39:18 INFO - PROCESS | 17409 | 07:39:19 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:39:20 INFO - PROCESS | 17409 | RSS: Main: 218841088 07:39:20 INFO - PROCESS | 17409 | 07:39:22 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:39:23 INFO - PROCESS | 17409 | RSS: Main: 222916608 07:39:23 INFO - PROCESS | 17409 | 07:39:25 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:26 INFO - PROCESS | 17409 | RSS: Main: 224215040 07:39:26 INFO - PROCESS | 17409 | 07:39:29 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:29 INFO - PROCESS | 17409 | RSS: Main: 221892608 07:39:29 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | Cycle 1(1): loaded http://localhost:53464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53464/tests/kraken/driver.html?testName=ai-astar) 07:39:31 INFO - PROCESS | 17409 | RSS: Main: 272924672 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | __start_tp_report 07:39:31 INFO - PROCESS | 17409 | _x_x_mozilla_page_load 07:39:31 INFO - PROCESS | 17409 | _x_x_mozilla_page_load_details 07:39:31 INFO - PROCESS | 17409 | |i|pagename|runs| 07:39:31 INFO - PROCESS | 17409 | |0;ai-astar;110;113;111;111;113;112;110;112;112;111 07:39:31 INFO - PROCESS | 17409 | |1;audio-beat-detection;144;119;118;164;120;119;118;123;163;119 07:39:31 INFO - PROCESS | 17409 | |2;audio-dft;162;162;164;163;164;163;163;164;164;165 07:39:31 INFO - PROCESS | 17409 | |3;audio-fft;75;74;79;111;76;77;75;76;103;75 07:39:31 INFO - PROCESS | 17409 | |4;audio-oscillator;83;81;119;83;83;82;112;81;82;117 07:39:31 INFO - PROCESS | 17409 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;116;117 07:39:31 INFO - PROCESS | 17409 | |6;imaging-darkroom;146;146;146;145;146;145;146;145;147;145 07:39:31 INFO - PROCESS | 17409 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;96;95 07:39:31 INFO - PROCESS | 17409 | |8;json-parse-financial;52;50;50;51;51;52;53;51;52;52 07:39:31 INFO - PROCESS | 17409 | |9;json-stringify-tinderbox;60;60;60;60;60;59;60;61;61;60 07:39:31 INFO - PROCESS | 17409 | |10;stanford-crypto-aes;82;85;78;81;87;79;79;86;77;78 07:39:31 INFO - PROCESS | 17409 | |11;stanford-crypto-ccm;133;129;122;127;125;122;120;121;178;124 07:39:31 INFO - PROCESS | 17409 | |12;stanford-crypto-pbkdf2;166;174;166;160;164;162;164;164;163;173 07:39:31 INFO - PROCESS | 17409 | |13;stanford-crypto-sha256-iterative;64;65;65;64;64;64;65;65;63;65 07:39:31 INFO - PROCESS | 17409 | __end_tp_report 07:39:31 INFO - PROCESS | 17409 | __start_cc_report 07:39:31 INFO - PROCESS | 17409 | _x_x_mozilla_cycle_collect,1642 07:39:31 INFO - PROCESS | 17409 | __end_cc_report 07:39:31 INFO - PROCESS | 17409 | __startTimestamp1474987171536__endTimestamp 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | ------- Summary: start ------- 07:39:31 INFO - PROCESS | 17409 | Number of tests: 14 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.08 (1.0%) stddev-sans-first:1.00 07:39:31 INFO - PROCESS | 17409 | Values: 110.0 113.0 111.0 111.0 113.0 112.0 110.0 112.0 112.0 111.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:121.50 stddev:18.96 (15.6%) stddev-sans-first:19.49 07:39:31 INFO - PROCESS | 17409 | Values: 144.0 119.0 118.0 164.0 120.0 119.0 118.0 123.0 163.0 119.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 07:39:31 INFO - PROCESS | 17409 | Values: 162.0 162.0 164.0 163.0 164.0 163.0 163.0 164.0 164.0 165.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.33 (17.7%) stddev-sans-first:13.89 07:39:31 INFO - PROCESS | 17409 | Values: 75.0 74.0 79.0 111.0 76.0 77.0 75.0 76.0 103.0 75.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:82.00 stddev:16.46 (20.1%) stddev-sans-first:17.11 07:39:31 INFO - PROCESS | 17409 | Values: 83.0 81.0 119.0 83.0 83.0 82.0 112.0 81.0 82.0 117.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:39:31 INFO - PROCESS | 17409 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:39:31 INFO - PROCESS | 17409 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 147.0 145.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:39:31 INFO - PROCESS | 17409 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 96.0 95.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.00 07:39:31 INFO - PROCESS | 17409 | Values: 52.0 50.0 50.0 51.0 51.0 52.0 53.0 51.0 52.0 52.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:39:31 INFO - PROCESS | 17409 | Values: 60.0 60.0 60.0 60.0 60.0 59.0 60.0 61.0 61.0 60.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:3.65 (4.5%) stddev-sans-first:3.86 07:39:31 INFO - PROCESS | 17409 | Values: 82.0 85.0 78.0 81.0 87.0 79.0 79.0 86.0 77.0 78.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:126.00 stddev:17.30 (13.7%) stddev-sans-first:18.32 07:39:31 INFO - PROCESS | 17409 | Values: 133.0 129.0 122.0 127.0 125.0 122.0 120.0 121.0 178.0 124.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:4.53 (2.7%) stddev-sans-first:4.80 07:39:31 INFO - PROCESS | 17409 | Values: 166.0 174.0 166.0 160.0 164.0 162.0 164.0 164.0 163.0 173.0 07:39:31 INFO - PROCESS | 17409 | 07:39:31 INFO - PROCESS | 17409 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 07:39:31 INFO - PROCESS | 17409 | Values: 64.0 65.0 65.0 64.0 64.0 64.0 65.0 65.0 63.0 65.0 07:39:31 INFO - PROCESS | 17409 | -------- Summary: end -------- 07:39:31 INFO - PROCESS | 17409 | 07:39:32 INFO - TEST-INFO | 17409: exit 0 07:39:32 INFO - TEST-OK | kraken | took 61550ms 07:39:32 INFO - SUITE-END | took 1176s 07:39:33 INFO - Completed test suite (00:19:37) 07:39:33 INFO - javascript benchmark 07:39:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2942.764578833693, 2975.7619390448754, 2989.3274013347, 3015.8039727417704, 3022.939541209176, 5218.817341393052, 5249.0, 5330.38700549436, 5347.866303342414, 5383.084875571152, 5285.127953887604, 5297.549708274792, 5303.893922121555, 5373.032854086273, 5436.864078398042, 4839.927401088987, 4841.588464980481, 4857.344258525107, 4872.561469467747, 4997.0, 4879.829205977791, 4909.165441874889, 4910.6317026223, 4939.777710003059, 4945.480724523927, 4792.281157826319, 4815.0, 4842.055799119174, 4869.245266983623, 4966.553010229079, 4817.614590832725, 4843.2735089736825, 4855.830045948375, 4913.385826771653, 4929.7781599828095, 4789.712617242942, 4797.136515427222, 4820.180569303192, 4877.902441951177, 4905.2642103684375, 5331.120365139747, 5335.786568537293, 5338.039152952506, 5346.705931173784, 5351.678899266057, 5557.694326812024, 5582.804601838916, 5598.636088654265, 5676.687782171979, 5680.034394153004, 5692.288463942007, 5707.771689132472, 5730.828075157752, 5791.362950075489, 5797.942020579782, 5267.841074963502, 5272.182811664198, 5272.736363181864, 5276.7361631917865, 5281.102212623863, 5509.972450137724, 5603.019471592455, 5676.262085928803, 5773.6824474654295, 5829.708514574254, 5431.755570999315, 5462.590305727086, 5477.507024367826, 5533.253010843565, 5604.3835178130375, 5596.972015139898, 5600.551955843604, 5601.327840659147, 5606.271184746039, 5609.4390560943575, 5554.583406244547, 5587.38538760736, 5589.441055894459, 5592.412796656374, 5656.038473459522, 5553.916691249635, 5560.582956278296, 5615.157726341082, 5615.8876822464135, 5628.268325117709, 4364.018095928391, 4374.21264172452, 4380.474343078851, 4416.315471101984, 4420.80106395213, 3883.165119499321, 3893.824777885002, 3913.0608653923423, 3954.130091379949, 3958.524977002778, 5353.732313384316, 5357.732113394315, 5362.410134885159, 5363.061464243741, 5389.052558611656, 5602.719864006784, 5650.943490565124, 5653.095504719307, 5702.6293290935955, 5720.08478643415, 5373.9731301343245, 5383.67697938125, 5386.13821788512, 5388.0570900092325, 5427.9185812212845, 4909.656324057353, 4911.361523001987, 4922.950770492321, 4931.778069986859, 4984.476629953875, 5798.652080875161, 5806.187133801272, 5859.062549992066, 5884.0, 5889.705514724333, 5699.23060386859, 5739.081746920473, 5743.3395159557185, 5800.564957628279, 5815.505682016907, 5877.059670452707, 5949.25634295713, 5954.940450595439, 5965.880682386415, 5967.4629283362965, 5415.83752487426, 5500.257465242141, 5511.063119269654, 5620.662760234399, 5625.381208067028, 5536.4186760389575, 5555.250041244381, 5555.50000499957, 5622.85942851432, 5623.156526521055, 5456.20884971669, 5459.863503412446, 5461.863453413696, 5465.152901300305, 5468.0, 5424.864378390572, 5435.266239057677, 5450.454954504517, 5484.753186106555, 5504.422035686195, 5503.20203570472, 5537.086380747131, 5545.805896793593, 5572.108462645957, 5626.127950167731, 5568.638038527482, 5614.887702246014, 5629.774809007594, 5632.605717599728, 5632.690202038927, 5504.504594586507, 5510.338759348904, 5512.240065782228, 5517.420670829505, 5520.36515800672], "value": 5229.437027749295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.9124385720212, 582.0715958046915, 604.88204800064, 606.3178923710828, 625.8404106952727, 26523.07169249077, 27050.458990820196, 28767.424651506957, 28800.71199288009, 36485.45271820925, 41413.0, 45382.915537601606, 45405.0, 45419.545804541944, 45457.0, 8591.35564832637, 8730.126987301282, 8736.126387361244, 8741.694040708577, 8760.561971901412, 8881.555922203896, 8986.910130898705, 8987.730368088967, 9026.23277021454, 9054.547272636375, 9081.0, 9120.771980700469, 9129.452232866017, 9133.086691330847, 9135.36052476327, 9034.638614455414, 9053.954730226373, 9070.63717451301, 9079.137481939206, 9081.091890810865, 8935.374523783337, 8977.6857809977, 8993.14565116313, 9003.639854405881, 9005.189532942066, 36066.27867442663, 36185.27629447423, 36369.63630363689, 36407.453888191696, 36411.08972275688, 3287.539744435781, 3319.9170020749434, 3443.6900678938764, 3788.8295026723863, 3849.7305188636806, 30974.380512389853, 31991.84004079965, 32077.839610801795, 32157.356852862813, 32355.676443235738, 4267.807948642288, 4338.891527711801, 4379.4525684289465, 4384.21084204843, 4393.714408563433, 329155.0, 333357.0, 333403.0, 333437.0, 335440.0, 56895.0, 57013.0, 57186.7140664294, 57191.0, 57283.71358143266, 59014.70492647509, 59566.702166489755, 59596.40403595995, 59648.70175649094, 59678.40321596815, 16377.91811040961, 16549.25528351227, 16598.917005414896, 16610.66778664444, 16611.335546578244, 11648.41757912118, 11680.649580512598, 11787.88212117885, 11788.764224715458, 11817.763644727058, 14837.0, 15748.795168676394, 15799.289031993589, 15803.604909877346, 15804.525864224091, 6298.9530051151405, 6305.306416294204, 6463.806085817433, 6498.772542961068, 6626.304238055031, 969.2343048991218, 1005.7887843552936, 1019.9031092046243, 1042.1766804224728, 1100.3178029621686, 32333.35333293321, 32382.676173238437, 32452.83773581117, 32742.345153096805, 32815.343693126, 1103.508938522366, 1126.2735535579668, 1158.2760774515928, 1170.2510393348264, 1180.392098069495, 16674.499765006825, 17014.914925425295, 17140.40008599693, 17262.309507619804, 17326.480205593853, 517238.0, 519973.0, 520329.0, 520723.0, 520796.0, 55869.441305587236, 55905.44094559084, 56017.15974260389, 56140.43859561434, 56305.71847140738, 1198.604460528041, 1254.1095821966323, 1261.8611952685014, 1319.2414361742037, 1356.7286542691304, 29839.552406714352, 33177.0, 33257.83371083129, 33412.498812518315, 33432.0, 39522.2095558093, 39921.60274390382, 39971.200575987736, 39973.60026399699, 39978.60021399865, 379934.0, 380892.0, 381491.0, 381547.0, 382292.0, 34090.14774630654, 35339.0, 38232.80883595564, 39483.802580986914, 39591.40612890867, 45510.772446137555, 45703.314450283935, 45876.541234587225, 46449.53550464587, 46979.0, 38851.41722874215, 39958.800205998785, 41275.0, 41923.7903810479, 42074.57925420706, 40071.39892901667, 41577.168456631305, 42515.36226956536, 43593.0, 44748.77625611851, 35240.471392928615, 36522.15645496708, 36915.446268306536, 36923.446148308336, 36988.075298117765, 40823.0, 42161.36757948695, 43350.92321964742, 43878.78060609676, 44736.32895506505, 26889.462210755282, 29275.85362073176, 29869.0, 30028.849855751454, 30044.0], "value": 19544.864437306154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.5848403577905, 376.9302679004384, 377.95842457329707, 384.172109104879, 400.24753463488656, 18024.81975180248, 18907.338243161492, 19338.613227735437, 19385.0, 19529.0, 16726.41457548986, 17247.82752172478, 17284.740728889046, 17919.193636286367, 18980.715289270636, 5655.57583181262, 5721.3694097182315, 5867.031939729939, 5872.236609240793, 5873.383294754053, 5632.943670563303, 5768.740406681688, 5817.418258174191, 5818.272715910512, 5820.301563812349, 5597.916031259534, 5794.971025144869, 5798.768049278024, 5802.12968054791, 5804.013317735974, 5735.483806457418, 5821.446962538552, 5823.388544202861, 5824.912626310609, 5826.455989162875, 5120.718360490171, 5210.140326846066, 5216.634835561512, 5218.373795144569, 5382.650127741724, 13667.0, 13864.098833575785, 13866.653333666638, 13904.652383690387, 22037.559248814934, 2127.7340332458443, 2179.716636837217, 2216.9113235470563, 2381.6784734060852, 2823.9833659882424, 10339.431331276777, 10360.119389851872, 10488.475576221159, 10791.622293219778, 10795.406252656101, 1768.6639538487645, 1775.6359946210996, 1846.18767742193, 1857.414914302004, 1877.0333278361654, 78158.21841781623, 82498.58750706268, 83214.0, 83673.0, 84585.61657533691, 10427.739306517398, 10476.947615262028, 10566.101881340019, 10842.728931776768, 10940.617078402218, 14929.776053359208, 14980.325885335185, 14987.625309367135, 14995.250237488082, 15013.324400402009, 7478.887816682754, 7670.846583068307, 7723.266289702469, 7918.089419716806, 7959.761207163794, 7376.815579610446, 7389.778306650702, 7423.183449820515, 7555.055618047744, 7679.155292917774, 4513.842015529441, 4631.768411579407, 4632.62938964882, 4721.1265915805, 4739.976300118477, 1925.8748181368167, 1931.5364312564884, 1968.9212431502579, 2007.9196832126552, 2034.481207292131, 919.7424721078108, 939.9295052871062, 966.6809952715587, 1012.9594816207269, 1035.1511760356436, 18962.0, 19425.22299108048, 19501.12244948981, 19507.707384389247, 19863.205471780966, 934.2619330728648, 971.9076687714655, 995.865558149655, 1050.2963014780116, 1063.3407287481657, 10551.314164579278, 10929.344239345664, 11042.155378052148, 11087.72280692973, 11121.888781112248, 426447.0, 426564.0, 439395.0, 440377.0, 449970.0, 88067.55966220128, 89219.0, 89823.0, 90965.54517227504, 91572.0, 902.5757893789909, 909.068205089775, 936.1293996583242, 936.9718908432758, 943.1935694980692, 16665.91667041657, 16936.068516231724, 17471.301147954448, 17668.558286042953, 17796.733049004535, 32295.838520807247, 40854.0, 41638.791806040776, 41871.37192942047, 42121.36817947795, 56397.0, 57359.713201433726, 57502.7124864373, 58129.0, 58615.12077318929, 8211.95894020526, 8360.122187170502, 8369.832603347777, 8474.533900635524, 8551.57242137903, 9288.535573221447, 12568.183068100545, 12776.6805829855, 13210.735785284432, 13286.402111904794, 11601.361925093863, 11610.303381797119, 11786.0, 11898.22661526998, 12364.44360003784, 11246.66260012201, 11363.204575679954, 11508.769824603294, 11537.942310288396, 11929.403529823301, 11687.357195353998, 11693.88306116962, 11965.341906195243, 11968.521259149884, 12317.507299707911, 7661.0, 8007.399445041761, 8269.875951860848, 8530.829383412172, 8742.781430464034, 11248.26886252391, 11278.323300601991, 11288.717782055513, 11426.942865285953, 12169.574064907685], "value": 8936.182039405146, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.6531436512148, 1286.95495657652, 1288.5618889577543, 1366.8974826887984, 1510.9320080596372, 7481.0, 8376.078631350547, 8483.618237179326, 8564.272036876873, 8776.956115219431, 8605.741827745178, 8660.696875609356, 8680.782980425492, 8683.261922736576, 8689.087645797179, 2288.7024686790737, 2325.93022209334, 2331.6036273833406, 2339.181286549711, 2340.1224540797202, 2249.3364457485, 2317.06159005603, 2326.1044497868356, 2327.9185228517003, 2339.7075365579303, 2313.548857972696, 2334.26470661741, 2339.6841426407473, 2350.529894021194, 2372.8457650252763, 2242.5627002734473, 2269.3986093685185, 2281.0533628544135, 2283.2693538067824, 2297.425643589111, 2272.784085511874, 2308.953820923589, 2317.1774020222747, 2323.5352929414184, 2328.93013209604, 8576.828463430758, 8683.348748843862, 8685.305175585938, 8687.261582765472, 8699.869501957475, 5110.207917772751, 5114.693118412907, 5243.056249875021, 5246.9768395162955, 5293.655912365684, 3304.669533046676, 3387.762856600039, 3486.9128271793406, 3504.859805607798, 3557.94663080054, 1151.7811615792973, 1207.6558180918485, 1208.788462019143, 1222.0468034932678, 1224.6081253998725, 12122.696932576668, 12172.634820955385, 12210.32843193624, 12247.571335003233, 12284.078694097978, 4303.849365272201, 4430.246858034142, 4592.954070459253, 4602.792874320597, 4619.607333376701, 9656.662016829378, 9667.0, 9670.613175473043, 9672.75818104553, 9677.564509597085, 5300.867478312995, 5338.172583249602, 5338.332708411449, 5344.038073146871, 5347.545458635982, 4205.137946720914, 4273.1026484438, 4330.588594083557, 4687.250039993584, 4900.09348270564, 3641.198936234024, 3745.232227393378, 3822.598627144165, 3902.687784977195, 3923.7841918694744, 1131.3494740524231, 1137.4597066393396, 1155.3934184553177, 1173.0674114079327, 1180.710725872167, 918.7519369770125, 942.9815798937132, 947.7251597036782, 975.2250903355824, 992.7915137820994, 5644.717764111778, 5725.1698503716725, 5751.194832723339, 5988.101784732325, 6001.699915004232, 425.8743670617175, 437.18901437833, 438.3599944081613, 448.40362318116826, 455.52625269719783, 4083.387491876242, 4143.461350024478, 4152.4601801765575, 4154.086101057763, 4155.771432571238, 10771.730706732238, 10966.451677416097, 11049.060829829394, 11057.225994180491, 11061.170412219115, 10977.615783447542, 11032.724181895357, 11059.557617695364, 11074.944625276983, 11082.279651822606, 8157.265846073882, 8183.0, 8234.094249632535, 8243.587820608825, 8247.463914845515, 5929.762809487572, 5987.072003839412, 6020.247469066367, 6073.210482637229, 6128.693565321805, 9536.33245672824, 9978.351407158512, 10038.0, 10067.84898226542, 10111.39331640104, 10015.1987840974, 10307.381557106597, 10309.123724483203, 10310.0, 10319.226058045526, 6726.529142959946, 7071.116110486189, 7754.728584499516, 7908.0, 7908.604569771604, 8132.186781322057, 8402.201790829862, 8478.533680647624, 8487.193716596914, 8494.0, 7709.768706938801, 7713.2286771322415, 7744.535327880345, 7899.960500197462, 8053.0, 7355.963220183865, 7489.176190618919, 7577.583232922242, 7587.772366829004, 7710.421718371257, 7024.438044956493, 7154.928450715426, 7160.534565253241, 7161.928380716335, 7165.605891676008, 5122.359705036871, 5174.844754657366, 5214.322138122172, 5230.869228269324, 5431.37539182999, 5338.3060202173465, 5364.839054828361, 5414.0, 5423.132298832168, 5479.013777520085], "value": 4494.798290014318, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.7753865773952, 335.0818756606898, 342.8919890234576, 346.6949084805371, 347.0456245325354, 5149.716765577901, 5190.480951904808, 5202.193659982704, 5205.553389906747, 5225.230627767285, 5111.677409683707, 5115.155999260118, 5118.846434606959, 5120.615953803461, 5155.7422128893595, 3901.648851603355, 3967.642912137907, 4014.518257809067, 4046.312126938413, 4105.4252404663375, 4114.917701645965, 4115.259253334399, 4121.1757648470275, 4124.731397731251, 4124.773137477438, 4080.571539988303, 4087.5912408759036, 4089.161721847029, 4097.282975479294, 4109.794510274489, 3898.2203559288114, 3969.563348031714, 4016.879493615196, 4034.0, 4052.331365324718, 3603.4414665726854, 3610.4185507362363, 3622.6558476944647, 3624.7643903146213, 3626.12972886508, 5010.774515146791, 5019.924701129486, 5033.748312584356, 5037.29477873098, 5040.697558146523, 4476.283794592882, 4623.83816566422, 4632.745199014053, 4642.210824159867, 4643.489216186217, 5352.036633405985, 5352.518273355417, 5372.355317361941, 5374.220737992969, 5403.837884863421, 3990.8004599769897, 3994.460747799068, 3996.660283875874, 3999.3601023836045, 4025.1144748155652, 5428.484293992104, 5571.749271282802, 5609.4390560943575, 5622.943770562283, 5635.408282130358, 4070.5115386153852, 4072.6945479089186, 4078.163976384834, 4079.816408261576, 4081.0409553754844, 4122.2786012447705, 4135.31767258405, 4138.813753381105, 4139.77231252278, 4141.378793181047, 4389.956100439019, 4566.520515345907, 4627.282771170474, 4669.2762621793, 4678.69588476748, 5359.866003349869, 5383.623146379716, 5387.982729671397, 5397.271368365299, 5400.945990540123, 1381.7720076187518, 1403.5683602725162, 1406.4725727852056, 1406.8874490040773, 1415.5328741515275, 855.8887344645157, 908.7410088124852, 914.1270087066836, 927.3909766555022, 927.7866090799154, 5033.924491132636, 5069.822556210589, 5199.452268388538, 5233.973830130825, 5241.371035475768, 5454.754536045887, 5514.889702205934, 5524.364698059774, 5539.7784088636, 5554.972225138929, 4985.700857948535, 5184.455632158569, 5214.582833373321, 5219.869503262373, 5223.0, 2927.6779554249015, 2932.8122110545264, 2937.75029122527, 2953.18787333485, 2957.0, 5712.571557133148, 5721.799737009184, 5743.339515955635, 5770.740316685759, 5772.422757724278, 5418.6748795071635, 5675.687837168995, 5716.0, 5719.656820590778, 5733.483986441241, 5738.942610573841, 5743.368229494836, 5745.195672605839, 5796.623219490804, 5815.970920145457, 5458.208559758892, 5591.329040515164, 5598.384177740527, 5602.52378547828, 5607.308491923981, 5518.357883796675, 5523.0, 5539.8892022160135, 5548.167774833646, 5553.6390134641115, 5849.94150058494, 5849.970750146222, 5852.473277405054, 5853.531717462678, 5864.706764661664, 3870.5291989043985, 4051.3517837145914, 4051.959480405158, 4068.2270368629866, 4095.365218391035, 5553.416891226525, 5560.471755183251, 5573.414791446839, 5578.358488773681, 5581.6930068846605, 5349.545288650508, 5429.158480435539, 5436.836894893159, 5448.45515448452, 5475.808346707846, 5199.92200116991, 5466.426025267289, 5471.179323101407, 5488.655279456559, 5489.698066606215, 5451.236826844324, 5451.56387488992, 5458.781648734006, 5460.525658072219, 5479.561635069264, 5244.7902083916215, 5305.787768489217, 5411.2153737708595, 5459.672419654833, 5485.561155107502, 5351.518363347317, 5379.892402152013, 5380.085385484555, 5387.249144028128, 5389.434109418455], "value": 4163.130156424913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.722687311639, 714.3963350968431, 735.9300866417692, 775.4726785785667, 828.8466633672771, 16016.919915400422, 17587.5603109922, 17603.383881564132, 17606.823931760693, 17654.117294135274, 13949.58151255464, 14001.509947151852, 14017.15897046178, 14085.647858803535, 14114.505992290271, 788.1724189600925, 806.2743530822248, 808.7937575918132, 810.9391795615323, 810.9391795615323, 807.0638059850575, 809.3323008517967, 809.7004108479871, 809.8785182222684, 810.2140923304386, 834.3575446905879, 835.1773503099442, 836.3267569606464, 836.3351135847016, 838.4340570115178, 835.8620827563444, 836.7322456813822, 837.1962915601031, 837.7403005068418, 837.8533756592602, 614.7633161232912, 618.1654766065775, 618.2086928731231, 618.4681174190193, 618.6906546726636, 14297.928510357486, 14313.28433578317, 14338.068025578408, 14342.85657143436, 14355.71288574233, 11884.346360950145, 11890.405479726065, 12185.69535761613, 12214.083943704258, 13041.934790326082, 10978.615748448767, 11129.888701112966, 11136.387498687569, 11206.495707693091, 11879.584214552535, 3775.4336849472525, 3779.9055023624355, 3799.3351163546267, 3946.2304850554156, 3950.7827069511163, 73614.0, 74815.25184748192, 77324.61337693332, 79334.603326983, 79338.20661793424, 9191.770205744777, 9232.122948319899, 9245.861312080324, 9372.578233979488, 9401.811963760687, 16146.838531614769, 16345.673086538203, 16393.180340982904, 16412.75380869288, 16448.83551164497, 8373.162683731578, 8457.830843383097, 8570.663599222542, 8619.310455163572, 8790.164934331227, 4820.590249828804, 4926.926096108561, 4934.333864928189, 5013.974930125326, 5226.555742761831, 3417.162795115163, 3538.628444013393, 3544.362014837354, 3544.7164226861787, 3561.7506774526055, 557.4759725857681, 567.6877717255493, 568.7383803450376, 570.2814453788257, 572.567711377907, 554.6810583914265, 590.5806877117209, 729.0813574895564, 739.9049406877743, 750.4071783291139, 9563.521823908777, 10072.244581656405, 10114.949425252827, 10137.847932281022, 10202.132818710345, 670.4602794750273, 694.6804469943781, 703.4624003799315, 717.9533330333512, 725.684327317608, 4783.56947874686, 5017.243964612357, 5078.13671675816, 5202.609804264695, 5214.45248248936, 120661.39669301597, 122024.38987805005, 123982.0, 124366.0, 126659.0, 101625.0, 101909.49045254727, 103256.0, 104876.0, 105233.47383263188, 93124.53437732768, 94966.5251673751, 97222.0, 98497.50751246055, 99000.50499747455, 9471.905280947103, 9770.0, 9776.413415195111, 9836.262280329147, 9853.655122070693, 55832.72083639556, 56458.76234686379, 56685.433145668016, 57239.42760572341, 57859.0, 81173.18826811893, 81682.0, 84294.7355789676, 85146.0, 86330.0, 12441.253524788543, 12533.623991280276, 12561.497540098293, 12692.17500862441, 13159.934200328937, 13114.868851311747, 13397.598072057854, 13904.165750055028, 13953.860461395256, 14158.221297828719, 12092.576759813364, 12186.390680466118, 12345.38273086324, 13001.869981300066, 13239.20564766117, 12177.817332740193, 12209.206401583868, 12324.938375308424, 12370.381480926098, 12915.289659068842, 12563.811542827048, 12629.93685031569, 12635.115541911979, 12651.177673451197, 13331.400086996302, 10276.948615256875, 10371.58513659445, 10453.0, 10477.37135771856, 10738.355698658106, 10830.51262693165, 11014.614488492864, 11071.833922491009, 11193.776124477628, 11327.830082548604], "value": 7418.844299378801, "unit": "score"}], "name": "dromaeo_css", "value": 7088.025875936859, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 111.0, 111.0, 113.0, 112.0, 110.0, 112.0, 112.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 118.0, 164.0, 120.0, 119.0, 118.0, 123.0, 163.0, 119.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 164.0, 163.0, 163.0, 164.0, 164.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 79.0, 111.0, 76.0, 77.0, 75.0, 76.0, 103.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 119.0, 83.0, 83.0, 82.0, 112.0, 81.0, 82.0, 117.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 51.0, 51.0, 52.0, 53.0, 51.0, 52.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 61.0, 61.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 78.0, 81.0, 87.0, 79.0, 79.0, 86.0, 77.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 122.0, 127.0, 125.0, 122.0, 120.0, 121.0, 178.0, 124.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 174.0, 166.0, 160.0, 164.0, 162.0, 164.0, 164.0, 163.0, 173.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 65.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1490.1999999999998, "alertThreshold": 2.0}]} 07:39:33 INFO - Return code: 0 07:39:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:33 INFO - # TBPL SUCCESS # 07:39:33 INFO - Running post-action listener: _resource_record_post_action 07:39:33 INFO - [mozharness: 2016-09-27 14:39:33.362634Z] Finished run-tests step (success) 07:39:33 INFO - Running post-run listener: _resource_record_post_run 07:39:33 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403660800; Read time: 20; Write time: 368784 07:39:33 INFO - TinderboxPrint: CPU usage
13.0% 07:39:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 07:39:33 INFO - TinderboxPrint: I/O write bytes / time
403,660,800 / 368,784 07:39:33 INFO - TinderboxPrint: CPU idle
8,292.7 (87.0%) 07:39:33 INFO - TinderboxPrint: CPU user
1,192.7 (12.5%) 07:39:33 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115322880; Read time: 0; Write time: 87496 07:39:33 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288337920; Read time: 0; Write time: 281288 07:39:33 INFO - Running post-run listener: _upload_blobber_files 07:39:33 INFO - Blob upload gear active. 07:39:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:38 INFO - (blobuploader) - INFO - Done attempting. 07:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:39 INFO - (blobuploader) - INFO - Done attempting. 07:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:40 INFO - (blobuploader) - INFO - Done attempting. 07:39:40 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:40 INFO - Return code: 0 07:39:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12319805a643e00646f269e0b8191e2f864db0ecefd1e52e93b8ba814dd4a7e8d4bbdb6522df23e0280e4ce87618784724949493cf191e75b3d139ae59bdd5e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0e287735d29c14db3e37597a8cec095396fc7c0cbf90a76c4b3ab2ab21b972bb0cac5cdcde9f24ccbb3bf3db195e7b038fa25adf3d67a7105c7be5acdf6c3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976470f2d97ccd5b1c4c31734402a99e3a013c8806bf30b19d641257e73168547d14f86279975ca23c6c97b4660ac8f060a9d102cb041ef8f15a9430e006cc2c"} 07:39:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:40 INFO - Contents: 07:39:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12319805a643e00646f269e0b8191e2f864db0ecefd1e52e93b8ba814dd4a7e8d4bbdb6522df23e0280e4ce87618784724949493cf191e75b3d139ae59bdd5e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0e287735d29c14db3e37597a8cec095396fc7c0cbf90a76c4b3ab2ab21b972bb0cac5cdcde9f24ccbb3bf3db195e7b038fa25adf3d67a7105c7be5acdf6c3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976470f2d97ccd5b1c4c31734402a99e3a013c8806bf30b19d641257e73168547d14f86279975ca23c6c97b4660ac8f060a9d102cb041ef8f15a9430e006cc2c"} 07:39:40 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:40 INFO - Copying logs to upload dir... 07:39:40 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.714627 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-27 07:39:39.785170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 07:39:39.788685) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12319805a643e00646f269e0b8191e2f864db0ecefd1e52e93b8ba814dd4a7e8d4bbdb6522df23e0280e4ce87618784724949493cf191e75b3d139ae59bdd5e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0e287735d29c14db3e37597a8cec095396fc7c0cbf90a76c4b3ab2ab21b972bb0cac5cdcde9f24ccbb3bf3db195e7b038fa25adf3d67a7105c7be5acdf6c3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976470f2d97ccd5b1c4c31734402a99e3a013c8806bf30b19d641257e73168547d14f86279975ca23c6c97b4660ac8f060a9d102cb041ef8f15a9430e006cc2c"} build_url:https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/cl-q3a66RTGTsaQEyN4VYw/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/Firefox/sha512/12319805a643e00646f269e0b8191e2f864db0ecefd1e52e93b8ba814dd4a7e8d4bbdb6522df23e0280e4ce87618784724949493cf191e75b3d139ae59bdd5e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0e287735d29c14db3e37597a8cec095396fc7c0cbf90a76c4b3ab2ab21b972bb0cac5cdcde9f24ccbb3bf3db195e7b038fa25adf3d67a7105c7be5acdf6c3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976470f2d97ccd5b1c4c31734402a99e3a013c8806bf30b19d641257e73168547d14f86279975ca23c6c97b4660ac8f060a9d102cb041ef8f15a9430e006cc2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 07:39:39.814647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:39:39.815002) ========= 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=5bd038846534b2fdfa68eeae000001e2-1474984818.874162-1778540453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 07:39:39.899975) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 07:39:39.900772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 07:39:39.901544) ========= ========= Total master_lag: 0.20 =========