builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1479136737.1 results: success (0) buildid: 20161114015620 builduid: 7575ab475a3f4481a1ee0dc2e232252d revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.097272) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.097684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.097955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.109235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.109489) ========= 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=52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 07:19:00-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-11-14 07:19:00 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.223020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.223677) ========= 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=52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016076 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:57.277780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 07:18:57.280211) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f867a8846778f927cfb3871e58cc61f6193ad5d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f867a8846778f927cfb3871e58cc61f6193ad5d --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=52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 07:19:00,576 truncating revision to first 12 chars 2016-11-14 07:19:00,576 Setting DEBUG logging. 2016-11-14 07:19:00,576 attempt 1/10 2016-11-14 07:19:00,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f867a884677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 07:19:01,756 unpacking tar archive at: mozilla-aurora-0f867a884677/testing/mozharness/ program finished with exit code 0 elapsedTime=1.495167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 07:18:58.788557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:58.788868) ========= script_repo_revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:58.789268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:58.789533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:58.798835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-14 07:18:58.799130) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:19:02 INFO - MultiFileLogger online at 20161114 07:19:02 in /builds/slave/test 07:19:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:19:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:19:02 INFO - {'append_to_log': False, 07:19:02 INFO - 'base_work_dir': '/builds/slave/test', 07:19:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:19:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:19:02 INFO - 'branch': 'Mozilla-Aurora', 07:19:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:19:02 INFO - 'config_files': ('talos/linux_config.py',), 07:19:02 INFO - 'default_actions': ('clobber', 07:19:02 INFO - 'read-buildbot-config', 07:19:02 INFO - 'download-and-extract', 07:19:02 INFO - 'populate-webroot', 07:19:02 INFO - 'create-virtualenv', 07:19:02 INFO - 'install', 07:19:02 INFO - 'run-tests'), 07:19:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:19:02 INFO - 'download_minidump_stackwalk': True, 07:19:02 INFO - 'download_symbols': 'ondemand', 07:19:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:19:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:19:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:19:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:19:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:19:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:19:02 INFO - 'installer_path': 'installer.exe', 07:19:02 INFO - 'log_level': 'info', 07:19:02 INFO - 'log_name': 'talos', 07:19:02 INFO - 'log_to_console': True, 07:19:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:19:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:19:02 INFO - 'opt_config_files': (), 07:19:02 INFO - 'pip_index': False, 07:19:02 INFO - 'sps_profile': False, 07:19:02 INFO - 'sps_profile_interval': 0, 07:19:02 INFO - 'suite': 'dromaeojs', 07:19:02 INFO - 'system_bits': '32', 07:19:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:19:02 INFO - 'title': 'talos-linux64-ix-056', 07:19:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:19:02 INFO - 'use_talos_json': True, 07:19:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:19:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:19:02 INFO - 'work_dir': 'build'} 07:19:02 INFO - [mozharness: 2016-11-14 15:19:02.186495Z] Running clobber step. 07:19:02 INFO - Running pre-action listener: _resource_record_pre_action 07:19:02 INFO - Running main action method: clobber 07:19:02 INFO - rmtree: /builds/slave/test/build 07:19:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:19:02 INFO - Running post-action listener: _resource_record_post_action 07:19:02 INFO - [mozharness: 2016-11-14 15:19:02.654192Z] Finished clobber step (success) 07:19:02 INFO - [mozharness: 2016-11-14 15:19:02.654293Z] Running read-buildbot-config step. 07:19:02 INFO - Running pre-action listener: _resource_record_pre_action 07:19:02 INFO - Running main action method: read_buildbot_config 07:19:02 INFO - Using buildbot properties: 07:19:02 INFO - { 07:19:02 INFO - "project": "", 07:19:02 INFO - "product": "firefox", 07:19:02 INFO - "script_repo_revision": "production", 07:19:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:19:02 INFO - "repository": "", 07:19:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:19:02 INFO - "buildid": "20161114015620", 07:19:02 INFO - "pgo_build": "True", 07:19:02 INFO - "basedir": "/builds/slave/test", 07:19:02 INFO - "buildnumber": 622, 07:19:02 INFO - "slavename": "talos-linux64-ix-056", 07:19:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:19:02 INFO - "platform": "ubuntu64_hw", 07:19:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:19:02 INFO - "branch": "mozilla-aurora", 07:19:02 INFO - "repo_path": "releases/mozilla-aurora", 07:19:02 INFO - "revision": "0f867a8846778f927cfb3871e58cc61f6193ad5d", 07:19:02 INFO - "stage_platform": "linux64-pgo", 07:19:02 INFO - "builduid": "7575ab475a3f4481a1ee0dc2e232252d", 07:19:02 INFO - "slavebuilddir": "test" 07:19:02 INFO - } 07:19:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 07:19:02 INFO - Running post-action listener: _resource_record_post_action 07:19:02 INFO - [mozharness: 2016-11-14 15:19:02.656821Z] Finished read-buildbot-config step (success) 07:19:02 INFO - [mozharness: 2016-11-14 15:19:02.656911Z] Running download-and-extract step. 07:19:02 INFO - Running pre-action listener: _resource_record_pre_action 07:19:02 INFO - Running main action method: download_and_extract 07:19:02 INFO - mkdir: /builds/slave/test/build/tests 07:19:02 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:02 INFO - trying https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:19:02 INFO - Downloading https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:19:03 INFO - Downloaded 1361 bytes. 07:19:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:19:03 INFO - Using the following test package requirements: 07:19:03 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:19:03 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:19:03 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:19:03 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'jsshell-linux-x86_64.zip'], 07:19:03 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:19:03 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:19:03 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:19:03 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:19:03 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:19:03 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:19:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:19:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:19:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:19:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:03 INFO - Fetch https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:19:03 INFO - Expected file size: 21962623 07:19:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:19:08 INFO - Expected file size: 21962623 07:19:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 07:19:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:19:13 INFO - Fetch https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:19:13 INFO - Expected file size: 14414089 07:19:14 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:14 INFO - trying https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:19:14 INFO - Downloading https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:19:15 INFO - Downloaded 64070902 bytes. 07:19:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.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/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.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-11-14 15:19:16.311262Z] Finished download-and-extract step (success) 07:19:16 INFO - [mozharness: 2016-11-14 15:19:16.311492Z] 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-11-14 15:19:16.327333Z] Finished populate-webroot step (success) 07:19:16 INFO - [mozharness: 2016-11-14 15:19:16.327422Z] 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 - 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:30 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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-ACJIzA-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-kmuI4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:31 INFO - Running setup.py (path:/tmp/pip-2qWuMM-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-du4VY9-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-mDa6c4-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-ZYlYvx-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-CQusDb-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-cArxAP-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-aNvoU1-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-lbooqM-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-zhsYnu-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-DZBU4l-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-U7SHmJ-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-gXENMb-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-Se991n-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:32 INFO - Running setup.py (path:/tmp/pip-PPKU1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:32 INFO - Running setup.py (path:/tmp/pip-QRAffP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:32 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:33 INFO - Running setup.py install for mozleak 07:19:33 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:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:34 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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 07:19:34 INFO - 'HOME': '/home/cltbld', 07:19:34 INFO - 'LANG': 'en_US.UTF-8', 07:19:34 INFO - 'LANGUAGE': 'en_US:en', 07:19:34 INFO - 'LOGNAME': 'cltbld', 07:19:34 INFO - 'MAIL': '/var/mail/cltbld', 07:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:34 INFO - 'MOZ_NO_REMOTE': '1', 07:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:34 INFO - 'NO_EM_RESTART': '1', 07:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:34 INFO - 'PWD': '/builds/slave/test', 07:19:34 INFO - 'SHELL': '/bin/bash', 07:19:34 INFO - 'SHLVL': '1', 07:19:34 INFO - 'TERM': 'linux', 07:19:34 INFO - 'TMOUT': '86400', 07:19:34 INFO - 'USER': 'cltbld', 07:19:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 07:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:34 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-SBslWI-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-vyP0PY-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-oFjI7D-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-F8Y9_4-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-PkAKnH-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-4QHYkJ-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-ASAjv3-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-NoEG3Q-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-JI8DyQ-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-QkCZhy-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-0mpnkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:35 INFO - Running setup.py (path:/tmp/pip-cHcd4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:35 INFO - Running setup.py (path:/tmp/pip-CnQSvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:35 INFO - Running setup.py (path:/tmp/pip-6iC_i2-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-Juz9cO-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-IsXvQK-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-4cX27J-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 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 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): 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:38 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:38 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:38 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:38 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:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Cleaning up... 07:19:38 INFO - Return code: 0 07:19:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa276760f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, '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': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', '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:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:19:38 INFO - Using env: {'DISPLAY': ':0', 07:19:38 INFO - 'HOME': '/home/cltbld', 07:19:38 INFO - 'LANG': 'en_US.UTF-8', 07:19:38 INFO - 'LANGUAGE': 'en_US:en', 07:19:38 INFO - 'LOGNAME': 'cltbld', 07:19:38 INFO - 'MAIL': '/var/mail/cltbld', 07:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:38 INFO - 'MOZ_NO_REMOTE': '1', 07:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:38 INFO - 'NO_EM_RESTART': '1', 07:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:38 INFO - 'PWD': '/builds/slave/test', 07:19:38 INFO - 'SHELL': '/bin/bash', 07:19:38 INFO - 'SHLVL': '1', 07:19:38 INFO - 'TERM': 'linux', 07:19:38 INFO - 'TMOUT': '86400', 07:19:38 INFO - 'USER': 'cltbld', 07:19:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 07:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:38 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-11-14 15:19:38.301350Z] Finished create-virtualenv step (success) 07:19:38 INFO - [mozharness: 2016-11-14 15:19:38.301927Z] 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-51.0a2.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-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:19:54 INFO - Reading from file tmpfile_stdout 07:19:54 INFO - Output received: 07:19:54 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:54 INFO - Running post-action listener: _resource_record_post_action 07:19:54 INFO - [mozharness: 2016-11-14 15:19:54.601301Z] Finished install step (success) 07:19:54 INFO - [mozharness: 2016-11-14 15:19:54.601547Z] Running run-tests step. 07:19:54 INFO - Running pre-action listener: _resource_record_pre_action 07:19:54 INFO - Running main action method: run_tests 07:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:54 INFO - Python 2.7.3 07:19:54 INFO - Return code: 0 07:19:54 INFO - grabbing minidump binary from tooltool 07:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:54 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 0x1789f60>, '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 0x178ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:54 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:54 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:54 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:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:54 INFO - Return code: 0 07:19:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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:54 INFO - Using env: {'DISPLAY': ':0', 07:19:54 INFO - 'HOME': '/home/cltbld', 07:19:54 INFO - 'LANG': 'en_US.UTF-8', 07:19:54 INFO - 'LANGUAGE': 'en_US:en', 07:19:54 INFO - 'LOGNAME': 'cltbld', 07:19:54 INFO - 'MAIL': '/var/mail/cltbld', 07:19:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:54 INFO - 'MOZ_NO_REMOTE': '1', 07:19:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:54 INFO - 'NO_EM_RESTART': '1', 07:19:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:54 INFO - 'PWD': '/builds/slave/test', 07:19:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:54 INFO - 'SHELL': '/bin/bash', 07:19:54 INFO - 'SHLVL': '1', 07:19:54 INFO - 'TERM': 'linux', 07:19:54 INFO - 'TMOUT': '86400', 07:19:54 INFO - 'USER': 'cltbld', 07:19:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229', 07:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:54 INFO - '_': '/tools/buildbot/bin/python'} 07:19:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:54 INFO - mozversion application_buildid: 20161114015620 07:19:54 INFO - mozversion application_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 07:19:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:19:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:54 INFO - mozversion application_name: Firefox 07:19:54 INFO - mozversion application_remotingname: firefox-dev 07:19:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:54 INFO - mozversion application_vendor: Mozilla 07:19:54 INFO - mozversion application_version: 51.0a2 07:19:54 INFO - mozversion platform_buildid: 20161114015620 07:19:54 INFO - mozversion platform_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 07:19:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:54 INFO - mozversion platform_version: 51.0a2 07:19:54 INFO - using testdate: 1479136794 07:19:54 INFO - actual date: 1479136794 07:19:54 INFO - starting webserver on 'localhost:59364' 07:19:54 INFO - SUITE-START | Running 2 tests 07:19:54 INFO - TEST-START | dromaeo_css 07:19:54 INFO - operating with platform_type : linux_ 07:19:54 INFO - Initialising browser for dromaeo_css test... 07:19:54 INFO - TEST-INFO | started process 15743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLjXPsJ/profile http://localhost:59364/getInfo.html) 07:19:58 INFO - PROCESS | 15743 | __metrics Screen width/height:1600/1200 07:19:58 INFO - PROCESS | 15743 | colorDepth:24 07:19:58 INFO - PROCESS | 15743 | Browser inner width/height: 1024/697 07:19:58 INFO - PROCESS | 15743 | __metrics 07:19:59 INFO - PROCESS | 15743 | 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:19:59 INFO - PROCESS | 15743 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:20:00 INFO - PROCESS | 15743 | console.error: PushService: 07:20:00 INFO - PROCESS | 15743 | stateChangeProcessEnqueue: Error transitioning state 07:20:00 INFO - PROCESS | 15743 | UnknownError 07:20:00 INFO - TEST-INFO | 15743: exit 0 07:20:00 INFO - Browser initialized. 07:20:00 INFO - Running cycle 1/1 for dromaeo_css test... 07:20:00 INFO - TEST-INFO | started process 15833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLjXPsJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:12 INFO - PROCESS | 15833 | RSS: Main: 145240064 07:20:12 INFO - PROCESS | 15833 | 07:21:03 INFO - PROCESS | 15833 | 1479136863388 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:12 INFO - PROCESS | 15833 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59364/tests/dromaeo/cssquery-ext.html) 07:23:13 INFO - PROCESS | 15833 | RSS: Main: 237039616 07:23:13 INFO - PROCESS | 15833 | 07:26:15 INFO - PROCESS | 15833 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-ext.html (next: http://localhost:59364/tests/dromaeo/cssquery-jquery.html) 07:26:16 INFO - PROCESS | 15833 | RSS: Main: 239493120 07:26:16 INFO - PROCESS | 15833 | 07:29:18 INFO - PROCESS | 15833 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59364/tests/dromaeo/cssquery-mootools.html) 07:29:19 INFO - PROCESS | 15833 | RSS: Main: 174280704 07:29:19 INFO - PROCESS | 15833 | 07:32:21 INFO - PROCESS | 15833 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59364/tests/dromaeo/cssquery-prototype.html) 07:32:21 INFO - PROCESS | 15833 | RSS: Main: 176500736 07:32:21 INFO - PROCESS | 15833 | 07:35:24 INFO - PROCESS | 15833 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59364/tests/dromaeo/cssquery-yui.html) 07:35:25 INFO - PROCESS | 15833 | RSS: Main: 176123904 07:35:25 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | Cycle 1(1): loaded http://localhost:59364/tests/dromaeo/cssquery-yui.html (next: http://localhost:59364/tests/dromaeo/cssquery-dojo.html) 07:38:27 INFO - PROCESS | 15833 | RSS: Main: 262352896 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | __start_tp_report 07:38:27 INFO - PROCESS | 15833 | _x_x_mozilla_page_load 07:38:27 INFO - PROCESS | 15833 | _x_x_mozilla_page_load_details 07:38:27 INFO - PROCESS | 15833 | |i|pagename|runs| 07:38:27 INFO - PROCESS | 15833 | |0;dojo.html;3106.1458099022766;3142.7485801135904;3151.3539724356497;3170.714635682788;3190.58522392089;5428.4028756836715;5505.229267902497;5511.972440137799;5544.972275138629;5560.58295627828;5492.890142197154;5517.172424136382;5524.502794748471;5528.530074943625;5530.557555395569;4932.062908047459;4974.12952733273;4991.525805048533;5015.7492125393765;5086.949130508685;4952.87617809554;5018.422881368635;5078.898422031557;5083.542481176693;5100.107481190796;4932.260160975864;4951.727654978975;4987.900241995158;5018.372703412074;5038.345015148044;4993.051320249159;5019.899602007976;5024.547790698854;5086.491350864921;5122.026814905156;4952.807869505666;4980.950190498085;5029.170186919154;5047.4952504749235;5058.671186372874;5291.894162116774;5314.92027619586;5386.73066346685;5410.3507579090365;5411.053065713524;5816.127580862904;5835.883282334372;5847.386024467412;5910.704464776744;5913.763449462016;5954.196183515213;5985.1022346647915;6000.609960352606;6000.939990600082;6018.789342372996;5315.760790764425;5353.143497040455;5433.565314774809;5459.5359394451125;5469.15228139639;6007.639541627516;6030.48740857032;6056.3338032816355;6061.787837425757;6063.878722425527;5793.8841223175305;5794.913076303858;5799.594028418054;5803.738831752581;5807.970960145172;5685.545156387479;5756.625819321731;5840.269966254218;5882.970585147133;5901.409859014064;5901.291844978544;5923.466887980103;5932.19915311436;5941.22764040672;5959.344472108065;5882.088276317178;5924.822255332347;5939.376365481562;5942.762289508458;5968.283805943314;4353.869383918487;4393.253146965024;4450.310201918708;4510.616597589242;4555.658325625525;4021.8592349267633;4075.0219947212454;4077.959220407817;4081.8774836919492;4100.897477563025;5577.776888924398;5584.357798853184;5587.189857470644;5587.69267690281;5590.888182236414;5810;5868.530517558585;5889.293284805765;5953.553483488756;5964.671943043088;5568.44315568448;5627.549796016309;5627.662340259598;5652.519535839418;5652.9152062719095;5170.1469257572835;5176.9741151294;5177.611679124006;5182.067227899014;5212.739363031909;5902.291724992942;6009.909851352146;6198.907016394758;6198.969005154945;6209.565330426917;5839.532837373085;5868.677222752619;5870.882582348415;5948.958932186936;5985.491233245223;6057.636541807506;6061.454469097626;6077.361877002851;6077.665728384981;6116.113163591343;5629.155626656035;5842.853928651818;5846.41535846412;5850.414958504286;5860.179574859438;5689.829305120853;5910.586258962004;5928.822135335947;5953.136795164591;6058.90911636317;5849.239598852292;5887.941120588739;5888.411158884077;5889.587728858939;5896.17453556511;5867.589268751147;5882.117682347682;5882.23530940975;5887.470127688529;5896.970515147397;5459.863503412446;5567.4432556744005;5636.549076073986;5679.119736440858;5828.533717302521;5783;5795.94204057954;5799.82600521985;5829.621074630305;5852.94147058524;5488.1767734838495;5666.546676265972;5670.121131224667;5671.744771485211;5674.347450043133 07:38:27 INFO - PROCESS | 15833 | |1;ext.html;583.3845293215655;650.2814390098938;654.6399480285843;659.2155335151173;661.1570247933885;34725.65274347259;37665;37725.245495090116;46018.53981460184;47350;49473.75263123679;49718.751406243005;49858.75070624642;49866.25200621993;50002;9344.672936447225;9480.952595237015;9499;9499.33504654671;9502.952485237563;8523.914760852374;8691.826163476726;8699.869501957475;8743.650253989832;9245.260379169684;10921.508532116035;11198.944005279962;11210.383428911407;11593.6521904343;11596.188266821326;11219.439028048564;11302.321860688386;11303;11305.547778088907;11316.717082073013;11062;11086.944565277123;11129.332240065542;11188.160887933438;11193.776124477465;45611.315830262574;45801;45952.77023614894;45979.31031034537;45988.54011459876;3355.7147642450423;3361.058903507022;3458.723302135823;3462.4633181856852;3508.2281897982402;34401;34565.481517777254;34603.4809477858;34626.6537334626;34718.30563388743;4613.284940834176;4647.3958385410015;4675.602573781199;4681.5530314323205;4739.336492890998;352409;353370;355672;355977;356864.21567892254;64269.678651606446;64616.67691661511;64670;64753;64773.352266477676;39705;40364.59635403608;40539.18921621551;42810.78594607007;42844.143117138105;19726.506837329183;19887;19920.800791992184;19949;19963.700544491843;13593.932030339984;13616.795748063787;13617.455301788015;13622.250776207205;13630.727385452434;19079.427617171506;19205.519862003563;20119.497012574804;20439.284625038053;20656.896715516326;7537.585432801248;7595.392368610498;7644.541327520366;7646.59726421737;7743.341815945595;845.7420486751599;853.5689476814293;950.6150009246267;958.6069711418285;975.2490582251627;30065;30344.84827575848;30379;30532.389352213275;30549.541756873663;984.601236499219;986.9358491698017;994.4282037828277;997.7405874472689;1063.6489958313894;15444.45944391941;15863.206839658202;15889.364425422853;16102.19489025544;19010.42968710941;436806;586605;587420;588903;591161;45006.09987800291;45272.54727452749;45383;45535.08929821385;45618.08763824705;1233.8581063177849;1349.7975303704523;1390.8261467316586;1423.252792284059;1428.764253898116;32977;36016.4597531032;36041.279174416886;36944.26111477809;36975.63024369722;53826;54433.18350224829;54505.454945451624;54520.72739636277;54528;434142;437979;438553;439368;439945;30985.845070774503;32024.35951281008;32069.67930320667;33555;33557.83221083879;52312;52445.21332179944;52449.47550524599;52484.737576311876;52671.20993185029;43093.569064308955;43940.56059439493;44058.15864163746;44913;44935.77532112318;44151.33772993343;44476.777616111714;45182.54817451783;45278.54721452743;45527.317090243014;44571.10857782891;45850.312245317014;45888;45908.540914591766;45937.31094033525;35562.46656300106;38703;39245.6075439242;39382.60617393789;39716.2056758869;29991.400171996873;30063.17428317676;30105;30189.698103018687;30390.696093038787 07:38:27 INFO - PROCESS | 15833 | |2;jquery.html;394.42020230261505;420.625643177572;422.4107370218545;430.46622188486276;437.7373575854486;14278.14331140131;15500.689986200268;19936.102875370623;20945;21585.352439426802;20063;20298.391048268575;20390.69413958792;20598.897005514988;21019.159233630675;5811.651300921937;5850.648961062328;5974.253218347707;5989.251343582052;6027.9752442084955;4345.717528360647;4535.478419981695;5854.121881717755;5988.550858685594;5994.250718660168;6259.87480250397;6506.674666266691;6529.51028672849;6639.900401493981;6642.4353929916015;6473.967630161843;6628.536002479828;6675.33246675331;6706.161729783777;6720.66396680169;5734.254546908917;5945.375735547748;5945.554083443759;5946.167536544887;5947;24027.51944961091;24302;24347.14784982517;24559.508809823703;24609.63085553718;2445.8287919845616;2459.840110392837;2493.962590561143;2716.3209197700576;2818.802683812134;10595;10938.398388088652;10979.83530247047;11142.610008649659;14988.700225995419;1956.5597740508415;2055.393658870622;2087.759907610614;2101.8843963582;2136.7970042845905;68347.31652683509;70598.64700676464;70607.64696176538;77723.61138194273;88966.5551672244;10985.395803230898;11673.35796531182;11727.589534366256;11849.585264515874;11919.642410727693;16873.57816054584;16884.831151688573;16912;16953;16970.490885273462;8197.096536979936;8870.600822962982;8958.835351404276;9005.234555062762;9178.908210917805;8778.385513014155;8819.85341905561;8827;8976.102389761103;9074.773130671787;4968.254761785761;5046.899062018739;5074.416442109131;5111.080005599028;5174.534291913746;1996.2681925612637;2069.8344132469365;2071.5292142578937;2082.958340833175;2109.567538654572;993.0417147452742;997.9301448898652;1016.9644062457926;1025.8717660292464;1072.3405105859997;20794.896025519774;20819.1672333108;20963.26628567993;21442.356729298146;21629.351119466442;987.2299606307092;988.3526290279879;1014.6905193915926;1028.1928685981468;1057.2704833664748;10532.315399499008;10891.455427228608;11180.720481988015;11288.54845806175;11375.089992800557;546028;559319;563230;566054;567981;58650.12024819631;59520.7023964886;62465.687671561354;100216;102958;987.2200961240683;999.8554545952937;1044.921630877672;1052.0636633396284;1057.7725788955258;14328.785068223777;17775;18001.909990449964;19073.809261907205;19102.713459297844;31403.528947065355;45126;46019;46424.53575464337;46652.300215497475;56297.43702562922;56345.43654563402;58467.61492887965;59628;60054.39945600488;7807.726729564438;8283.461574997606;8772.210501054935;9172.12864777845;9183.862242066241;7854.960725196566;11185.776284474428;13670;13898.742018964267;13959.302034898417;11571.19001669875;11775.823362649397;11787.410629468664;12006.039516838806;12150.331731754484;12065.638030859089;12071.094667900119;12260.693482663004;12330.568430104904;12595.496180152692;12530.686732831387;12631.494740210288;12718.618441446772;12855.678608034874;12926.612201633967;8237.588120593826;8275.089740128702;8555.657773688983;8734.563271836256;8740.34447416459;12201.450934707782;12430.813537797121;12483.500659973499;12504.124711270124;12763.170393924365 07:38:27 INFO - PROCESS | 15833 | |3;mootools.html;1551.05385714714;1552.107538165555;1743.572824657958;1834.944951651451;1858.637565674694;8582.87125693115;9208.447493150406;9228.16946474817;9243.584038718249;9260.120288572592;7584.658690358933;7824.256695613922;7837.725679601215;8699.434536755107;8978.057303983085;2389.1160270699866;2423.8182136339756;2424.0788500369836;2430.4774473488196;2432.2581612608146;2410.95178096438;2464.2607217834666;2473.5671257529953;2475.938101547458;2489.7012358517004;2426.8543887366727;2444.1445494077107;2483.726790053093;2502.7997760179233;2507.661465702125;2346.436855154759;2353.341064501942;2360.8229382796358;2407.518496300747;2452.766987136219;2381.761823817622;2395.9760402395927;2401.8438801478023;2404.579198640231;2406.5307265083316;9105;9200.493972831491;9241;9270.258379329638;9296.628134874596;5266.499682530153;5399.082156033483;5403.2705584745945;5408.891822163535;5411.053065713484;3367.107716455141;3432.9656703432897;3522.4716292556063;3524.4184709522897;3527.894163175109;1230.6246594788586;1260.9747805043849;1261.0983147049903;1293.353323338331;1294.8575656677758;11988.400579970967;12006.399680015964;12029.578964736193;12035.759284814254;12043.156979011474;4558.566936141061;4654.185517534418;4815.831445899376;4816.8554943351755;4829.106615276185;10260.179185665129;10300.433476158883;10317.226208034428;10322.535485903003;10335;5460.645058071292;5469.671819690831;5474.206240095164;5488.396276409591;5489.231507588941;4467.865964021084;4609.124266389375;4776.068666609977;4869.561739443467;5016.523430274191;4243.069403421436;4325.653947684178;4401.977990110029;4441.4892287387365;4453.265211240174;1407.1627381707867;1431.8115963750063;1433.8637829406189;1446.067286600158;1455.316001479303;854.2269246331955;982.1602529836887;1028.280203857303;1036.9740756481149;1042.3276986343917;6035.094735789667;6283.277423096311;6308.3060863305;6342.619442833445;6386.361363863576;994.7910938702953;998.2413365842012;1034.632705389576;1036.4662198967537;1051.0277992856577;4247.617714405656;4332.090261045153;4350.129974005212;4466.486354069259;4553.772311384484;11144.498497567629;11509.827352589718;11565.421728913521;11570.363630000262;11580.36308003068;11089.27919685218;11121.165912556591;11457.369844658624;11497;11499.885001150049;8285.751427457186;8449.619767110495;8454.32365410778;8458.238758511641;8461.153884611489;5935.465808077293;6050.152978582913;6084.269887613515;6086.756529738761;6144.38556144382;9952.701418957442;10267.7433064174;10275.84586231222;10299.845502317321;10426.478676066015;10447.94776026115;10770.299930504492;10773.353598784099;10849.511771970438;10879.129669626569;7031.191412987368;7507.924920750723;7787.922120778946;8001.679932802623;8195.057568379474;8788.956055219684;8966.86549701742;8972.955135224282;8976.955115224382;8981.595828187877;7606.429517786078;7712.650286200005;8013.118556958613;8047.919520804951;8249.373726910177;7539.623018849145;7681.078270607562;7793.571353575381;7902;8127.83744325122;7028.50800443964;7105.538140020882;7111.324424179695;7116.679749411185;7118.60847653384;5400.648957817729;5440.211169380497;5511.5315198207;5534.750936207961;5626.971865140648;5460.34475862899;5480.890382192413;5496.835094947158;5614.101743720985;5658.349289831722 07:38:27 INFO - PROCESS | 15833 | |4;prototype.html;337.55779928293936;348.258210012673;348.48250348232875;351.57611672725454;355.49342187382956;5525.806596769114;5560.944390556093;5586.469285417889;5613.4386561343945;5623.578231632629;5484.177373393983;5517.475839795223;5588.636738611997;5594.776208951647;5601.775928962837;4031.778252196128;4086.795660216992;4303.935440968388;4320.287152619814;4363.476382834048;4268.274393353122;4285.250081235771;4312.590303921138;4318.438602981623;4328.199283132615;4254.808533615995;4260.957390426087;4262.509811371686;4283.207606592775;4329.653627709776;4022.577629348935;4029.858954936578;4267.957320426787;4290.334998075304;4308.74147551148;3803.980980095082;3804.5434547854434;3816.694664426839;3819.178876541529;3830.3296923038356;5322.7072511011875;5331.680099194061;5355.758990845382;5357;5386.946130538684;4792.353032340624;4869.342638743759;4881.585065269456;4910.656254062182;4937.185364414867;5623.493885550321;5653.1520271959125;5657.43425657431;5658.991058174372;5661.971690141564;4030.6775457963295;4182.330827067685;4184.163167366539;4184.518780340239;4230.7038507304505;5942.762289508414;5958.672273024982;5960.850978725523;5961.701914904281;5979.531871514511;4226.154769046203;4242.957570424256;4253.914921701548;4267.146570685875;4269.779714548417;4029.9597004029583;4315.741055536678;4340.60934515895;4357.8256869724855;4371.846985355497;4788.545088216614;4821.397325334333;4827.975860120747;4848.393950756155;4879.878003049952;5711.143328500758;5760.567957403212;5776.364599894008;5786.88426231473;5799.797007104816;1454.2946670864621;1477.9113253204841;1485.8365579786214;1505.736496113176;1507.2915729607066;917.7292698653913;922.34513495419;934.9485778282124;935.8830146231721;949.3164921256684;5370.92581483697;5441.28599491159;5520.779168833282;5534.347330761678;5555.722213889289;5876.471117599436;5900.1739756434135;5909.3204281507315;5913.309444202878;5914.2311499504785;5350.5987050971335;5470.753816078286;5491.835244942658;5522.171674248895;5542.168674698827;3053.4656435123766;3095.2880837407074;3097.535369694519;3107.6270847497995;3113.6886311369135;5846.795362162304;6054.212952316171;6073.908891366633;6097.2683278006925;6113.969430152821;5969.224000879858;5976.342602313742;5996.730147143389;6006.606267458872;6012.158297838306;6023.427774361428;6027.402738274361;6050.6369617823075;6054.215061071956;6095.3904609538695;5712.600117991867;5873.4126587342635;5904.940950590611;5919.6152250103605;5948.226730525004;5765.711714414347;5812.73842677089;5857.121431785266;5861.6189947653265;5871.1486834407915;5912.250803376451;6110.358412366638;6110.541709371726;6134.06776865286;6159.168512250789;4143.627073563393;4241;4269.2742233820945;4283.935740963951;4290.699651024398;5980.910286345796;5986.850328741816;5993.6403815769445;6021.885951099061;6030.442039196895;5537.7784888604;5747.5689323300085;5752.424757524214;5781.884362312814;5877.441643043904;5756.222909907109;5764.855878603068;5772.200482765771;5781.103928891029;5781.82654520365;5455.699936503531;5691.971540142438;5723.542116630576;5752.63470869546;5760;5295.7087360195555;5752.913706294493;5800.767969281182;5823.563232757476;5835.387284335084;5646.943530564806;5665.886682266414;5681.488666020078;5694.092479019575;5703.429657034263 07:38:27 INFO - PROCESS | 15833 | |5;yui.html;781.9139894611592;835.6768184447235;876.2508055612451;889.9021107678154;898.1691934960161;15084.924575377121;15477;15684.451044213454;15752.448664296751;15778.921105394471;15183.620409489768;15225.771613425808;15716;15853.20733963303;15853.841461585409;845.3406343052429;861.530465896085;864.1315477944688;864.3517361978517;864.5893200729635;707.6426404665636;722.8373615936398;820.4502983001404;851.3019324154196;857.4126723194631;891.0510306523564;893.0221407558713;894.0835643465467;897.33148804141;897.3359713811765;889.3863234368298;890.185480285538;890.2788741119681;891.2513488669549;891.6789955615973;539.9892002159974;554.3209568278867;554.5840619535348;555.7165845418865;641.8170821315903;14878.925605372013;15093.169875656835;15126.168060756654;15198.848011519854;15237.466688665954;14051.64870878226;14266.3580138894;14483.275836208148;14486.348114334774;14600.196989165592;12763.617091487271;12820.487180512862;12955.740885182244;13009.414576344087;13109;4505.211587972091;4525.366448697185;4548.158590660705;4590.150822097922;4656.278276867091;82846.17153828444;82894;84227.57886210529;84234.57882710609;84627.15372846254;11485.827712584318;11535.76928461426;11603.187776855708;11899;11939;23439.765602344098;23503.17738879131;23529.1764788235;23709.288721338387;23718.525629487314;8748.562571871382;8864.822703546022;9018.323625728097;9331.486768227813;9331.580078896466;4900.705957642553;4910.165271903785;5141.53726164647;5227.032998895216;5291.920621190685;3592.4611308303442;3717.4423836424753;3722.8324725387424;3723.832427540767;3734.6078661740125;626.5175814622716;628.5443053785968;635.5360586771683;635.7679447001811;649.6102338596804;660.359451332207;675.7837492002512;680.9489288303397;686.3513979289523;715.1239731329081;8755.474671519729;9464.716058518256;9792.951035244778;9822.867947059465;10031.270040914636;518.8495336352491;594.6016169166669;679.4564348521262;710.499098135813;731.4696844787486;4513.435820522434;4592.3800286961505;4629.328747331618;4653.441587009581;4658.051689860835;117903;130395.69604304025;132203.74573779744;132596;138656;117061.79091978572;118881;119439;122003;123810;96426;103051;103748;105066.47466762617;105100.47449762856;8728.69449569262;9171.724848254564;9182.449053056838;9198.926411565459;9224.40041397307;48128.796780080775;49108.75445622749;57182.14226786518;57479;59703.402965969784;68740.6562967182;78134.609326953;78286;80733.19266807492;80979;12377.566785162477;13135.408906599418;13320.333983300603;13353.66615834612;14094.577162685136;13818.723625527635;14631.341589628706;14885.25573721288;14922.552323430315;14992.175430351435;13380.866191337962;13439.932800336326;13644.65888352799;13996.16023038621;14054.086484378482;11735.589254376056;13186;13357.731015553507;13492.920566354864;13844;12322.75354492923;12738.745225095632;12894.67763305925;12995.415206315549;13385.19688818674;10531.473426328806;10798.244122911321;10999.840567579442;11127;11501.539938402704;11074.501647425725;11167.290389362197;11350.205485615928;11470.598529051444;11567.652970410902 07:38:27 INFO - PROCESS | 15833 | __end_tp_report 07:38:27 INFO - PROCESS | 15833 | __start_cc_report 07:38:27 INFO - PROCESS | 15833 | _x_x_mozilla_cycle_collect,886 07:38:27 INFO - PROCESS | 15833 | __end_cc_report 07:38:27 INFO - PROCESS | 15833 | __startTimestamp1479137907884__endTimestamp 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | ------- Summary: start ------- 07:38:27 INFO - PROCESS | 15833 | Number of tests: 6 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | [#0] dojo.html Cycles:165 Average:5481.36 Median:5671.74 stddev:629.30 (11.1%) stddev-sans-first:603.01 07:38:27 INFO - PROCESS | 15833 | Values: 3106.1 3142.7 3151.4 3170.7 3190.6 5428.4 5505.2 5512.0 5545.0 5560.6 5492.9 5517.2 5524.5 5528.5 5530.6 4932.1 4974.1 4991.5 5015.7 5086.9 4952.9 5018.4 5078.9 5083.5 5100.1 4932.3 4951.7 4987.9 5018.4 5038.3 4993.1 5019.9 5024.5 5086.5 5122.0 4952.8 4981.0 5029.2 5047.5 5058.7 5291.9 5314.9 5386.7 5410.4 5411.1 5816.1 5835.9 5847.4 5910.7 5913.8 5954.2 5985.1 6000.6 6000.9 6018.8 5315.8 5353.1 5433.6 5459.5 5469.2 6007.6 6030.5 6056.3 6061.8 6063.9 5793.9 5794.9 5799.6 5803.7 5808.0 5685.5 5756.6 5840.3 5883.0 5901.4 5901.3 5923.5 5932.2 5941.2 5959.3 5882.1 5924.8 5939.4 5942.8 5968.3 4353.9 4393.3 4450.3 4510.6 4555.7 4021.9 4075.0 4078.0 4081.9 4100.9 5577.8 5584.4 5587.2 5587.7 5590.9 5810.0 5868.5 5889.3 5953.6 5964.7 5568.4 5627.5 5627.7 5652.5 5652.9 5170.1 5177.0 5177.6 5182.1 5212.7 5902.3 6009.9 6198.9 6199.0 6209.6 5839.5 5868.7 5870.9 5949.0 5985.5 6057.6 6061.5 6077.4 6077.7 6116.1 5629.2 5842.9 5846.4 5850.4 5860.2 5689.8 5910.6 5928.8 5953.1 6058.9 5849.2 5887.9 5888.4 5889.6 5896.2 5867.6 5882.1 5882.2 5887.5 5897.0 5459.9 5567.4 5636.5 5679.1 5828.5 5783.0 5795.9 5799.8 5829.6 5852.9 5488.2 5666.5 5670.1 5671.7 5674.3 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | [#1] ext.html Cycles:180 Average:61765.33 Median:435474.00 stddev:121718.28 (28.0%) stddev-sans-first:121973.06 07:38:27 INFO - PROCESS | 15833 | Values: 583.4 650.3 654.6 659.2 661.2 34725.7 37665.0 37725.2 46018.5 47350.0 49473.8 49718.8 49858.8 49866.3 50002.0 9344.7 9481.0 9499.0 9499.3 9503.0 8523.9 8691.8 8699.9 8743.7 9245.3 10921.5 11198.9 11210.4 11593.7 11596.2 11219.4 11302.3 11303.0 11305.5 11316.7 11062.0 11086.9 11129.3 11188.2 11193.8 45611.3 45801.0 45952.8 45979.3 45988.5 3355.7 3361.1 3458.7 3462.5 3508.2 34401.0 34565.5 34603.5 34626.7 34718.3 4613.3 4647.4 4675.6 4681.6 4739.3 352409.0 353370.0 355672.0 355977.0 356864.2 64269.7 64616.7 64670.0 64753.0 64773.4 39705.0 40364.6 40539.2 42810.8 42844.1 19726.5 19887.0 19920.8 19949.0 19963.7 13593.9 13616.8 13617.5 13622.3 13630.7 19079.4 19205.5 20119.5 20439.3 20656.9 7537.6 7595.4 7644.5 7646.6 7743.3 845.7 853.6 950.6 958.6 975.2 30065.0 30344.8 30379.0 30532.4 30549.5 984.6 986.9 994.4 997.7 1063.6 15444.5 15863.2 15889.4 16102.2 19010.4 436806.0 586605.0 587420.0 588903.0 591161.0 45006.1 45272.5 45383.0 45535.1 45618.1 1233.9 1349.8 1390.8 1423.3 1428.8 32977.0 36016.5 36041.3 36944.3 36975.6 53826.0 54433.2 54505.5 54520.7 54528.0 434142.0 437979.0 438553.0 439368.0 439945.0 30985.8 32024.4 32069.7 33555.0 33557.8 52312.0 52445.2 52449.5 52484.7 52671.2 43093.6 43940.6 44058.2 44913.0 44935.8 44151.3 44476.8 45182.5 45278.5 45527.3 44571.1 45850.3 45888.0 45908.5 45937.3 35562.5 38703.0 39245.6 39382.6 39716.2 29991.4 30063.2 30105.0 30189.7 30390.7 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | [#2] jquery.html Cycles:180 Average:30810.55 Median:13534.74 stddev:91767.34 (678.0%) stddev-sans-first:91996.35 07:38:27 INFO - PROCESS | 15833 | Values: 394.4 420.6 422.4 430.5 437.7 14278.1 15500.7 19936.1 20945.0 21585.4 20063.0 20298.4 20390.7 20598.9 21019.2 5811.7 5850.6 5974.3 5989.3 6028.0 4345.7 4535.5 5854.1 5988.6 5994.3 6259.9 6506.7 6529.5 6639.9 6642.4 6474.0 6628.5 6675.3 6706.2 6720.7 5734.3 5945.4 5945.6 5946.2 5947.0 24027.5 24302.0 24347.1 24559.5 24609.6 2445.8 2459.8 2494.0 2716.3 2818.8 10595.0 10938.4 10979.8 11142.6 14988.7 1956.6 2055.4 2087.8 2101.9 2136.8 68347.3 70598.6 70607.6 77723.6 88966.6 10985.4 11673.4 11727.6 11849.6 11919.6 16873.6 16884.8 16912.0 16953.0 16970.5 8197.1 8870.6 8958.8 9005.2 9178.9 8778.4 8819.9 8827.0 8976.1 9074.8 4968.3 5046.9 5074.4 5111.1 5174.5 1996.3 2069.8 2071.5 2083.0 2109.6 993.0 997.9 1017.0 1025.9 1072.3 20794.9 20819.2 20963.3 21442.4 21629.4 987.2 988.4 1014.7 1028.2 1057.3 10532.3 10891.5 11180.7 11288.5 11375.1 546028.0 559319.0 563230.0 566054.0 567981.0 58650.1 59520.7 62465.7 100216.0 102958.0 987.2 999.9 1044.9 1052.1 1057.8 14328.8 17775.0 18001.9 19073.8 19102.7 31403.5 45126.0 46019.0 46424.5 46652.3 56297.4 56345.4 58467.6 59628.0 60054.4 7807.7 8283.5 8772.2 9172.1 9183.9 7855.0 11185.8 13670.0 13898.7 13959.3 11571.2 11775.8 11787.4 12006.0 12150.3 12065.6 12071.1 12260.7 12330.6 12595.5 12530.7 12631.5 12718.6 12855.7 12926.6 8237.6 8275.1 8555.7 8734.6 8740.3 12201.5 12430.8 12483.5 12504.1 12763.2 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | [#3] mootools.html Cycles:180 Average:5973.41 Median:4556.17 stddev:3327.14 (73.0%) stddev-sans-first:3319.88 07:38:27 INFO - PROCESS | 15833 | Values: 1551.1 1552.1 1743.6 1834.9 1858.6 8582.9 9208.4 9228.2 9243.6 9260.1 7584.7 7824.3 7837.7 8699.4 8978.1 2389.1 2423.8 2424.1 2430.5 2432.3 2411.0 2464.3 2473.6 2475.9 2489.7 2426.9 2444.1 2483.7 2502.8 2507.7 2346.4 2353.3 2360.8 2407.5 2452.8 2381.8 2396.0 2401.8 2404.6 2406.5 9105.0 9200.5 9241.0 9270.3 9296.6 5266.5 5399.1 5403.3 5408.9 5411.1 3367.1 3433.0 3522.5 3524.4 3527.9 1230.6 1261.0 1261.1 1293.4 1294.9 11988.4 12006.4 12029.6 12035.8 12043.2 4558.6 4654.2 4815.8 4816.9 4829.1 10260.2 10300.4 10317.2 10322.5 10335.0 5460.6 5469.7 5474.2 5488.4 5489.2 4467.9 4609.1 4776.1 4869.6 5016.5 4243.1 4325.7 4402.0 4441.5 4453.3 1407.2 1431.8 1433.9 1446.1 1455.3 854.2 982.2 1028.3 1037.0 1042.3 6035.1 6283.3 6308.3 6342.6 6386.4 994.8 998.2 1034.6 1036.5 1051.0 4247.6 4332.1 4350.1 4466.5 4553.8 11144.5 11509.8 11565.4 11570.4 11580.4 11089.3 11121.2 11457.4 11497.0 11499.9 8285.8 8449.6 8454.3 8458.2 8461.2 5935.5 6050.2 6084.3 6086.8 6144.4 9952.7 10267.7 10275.8 10299.8 10426.5 10447.9 10770.3 10773.4 10849.5 10879.1 7031.2 7507.9 7787.9 8001.7 8195.1 8789.0 8966.9 8973.0 8977.0 8981.6 7606.4 7712.7 8013.1 8047.9 8249.4 7539.6 7681.1 7793.6 7902.0 8127.8 7028.5 7105.5 7111.3 7116.7 7118.6 5400.6 5440.2 5511.5 5534.8 5627.0 5460.3 5480.9 5496.8 5614.1 5658.3 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | [#4] prototype.html Cycles:180 Average:4846.89 Median:5558.33 stddev:1427.05 (25.7%) stddev-sans-first:1390.34 07:38:27 INFO - PROCESS | 15833 | Values: 337.6 348.3 348.5 351.6 355.5 5525.8 5560.9 5586.5 5613.4 5623.6 5484.2 5517.5 5588.6 5594.8 5601.8 4031.8 4086.8 4303.9 4320.3 4363.5 4268.3 4285.3 4312.6 4318.4 4328.2 4254.8 4261.0 4262.5 4283.2 4329.7 4022.6 4029.9 4268.0 4290.3 4308.7 3804.0 3804.5 3816.7 3819.2 3830.3 5322.7 5331.7 5355.8 5357.0 5386.9 4792.4 4869.3 4881.6 4910.7 4937.2 5623.5 5653.2 5657.4 5659.0 5662.0 4030.7 4182.3 4184.2 4184.5 4230.7 5942.8 5958.7 5960.9 5961.7 5979.5 4226.2 4243.0 4253.9 4267.1 4269.8 4030.0 4315.7 4340.6 4357.8 4371.8 4788.5 4821.4 4828.0 4848.4 4879.9 5711.1 5760.6 5776.4 5786.9 5799.8 1454.3 1477.9 1485.8 1505.7 1507.3 917.7 922.3 934.9 935.9 949.3 5370.9 5441.3 5520.8 5534.3 5555.7 5876.5 5900.2 5909.3 5913.3 5914.2 5350.6 5470.8 5491.8 5522.2 5542.2 3053.5 3095.3 3097.5 3107.6 3113.7 5846.8 6054.2 6073.9 6097.3 6114.0 5969.2 5976.3 5996.7 6006.6 6012.2 6023.4 6027.4 6050.6 6054.2 6095.4 5712.6 5873.4 5904.9 5919.6 5948.2 5765.7 5812.7 5857.1 5861.6 5871.1 5912.3 6110.4 6110.5 6134.1 6159.2 4143.6 4241.0 4269.3 4283.9 4290.7 5980.9 5986.9 5993.6 6021.9 6030.4 5537.8 5747.6 5752.4 5781.9 5877.4 5756.2 5764.9 5772.2 5781.1 5781.8 5455.7 5692.0 5723.5 5752.6 5760.0 5295.7 5752.9 5800.8 5823.6 5835.4 5646.9 5665.9 5681.5 5694.1 5703.4 07:38:27 INFO - PROCESS | 15833 | 07:38:27 INFO - PROCESS | 15833 | [#5] yui.html Cycles:180 Average:22777.41 Median:4509.32 stddev:34521.52 (765.6%) stddev-sans-first:34578.86 07:38:27 INFO - PROCESS | 15833 | Values: 781.9 835.7 876.3 889.9 898.2 15084.9 15477.0 15684.5 15752.4 15778.9 15183.6 15225.8 15716.0 15853.2 15853.8 845.3 861.5 864.1 864.4 864.6 707.6 722.8 820.5 851.3 857.4 891.1 893.0 894.1 897.3 897.3 889.4 890.2 890.3 891.3 891.7 540.0 554.3 554.6 555.7 641.8 14878.9 15093.2 15126.2 15198.8 15237.5 14051.6 14266.4 14483.3 14486.3 14600.2 12763.6 12820.5 12955.7 13009.4 13109.0 4505.2 4525.4 4548.2 4590.2 4656.3 82846.2 82894.0 84227.6 84234.6 84627.2 11485.8 11535.8 11603.2 11899.0 11939.0 23439.8 23503.2 23529.2 23709.3 23718.5 8748.6 8864.8 9018.3 9331.5 9331.6 4900.7 4910.2 5141.5 5227.0 5291.9 3592.5 3717.4 3722.8 3723.8 3734.6 626.5 628.5 635.5 635.8 649.6 660.4 675.8 680.9 686.4 715.1 8755.5 9464.7 9793.0 9822.9 10031.3 518.8 594.6 679.5 710.5 731.5 4513.4 4592.4 4629.3 4653.4 4658.1 117903.0 130395.7 132203.7 132596.0 138656.0 117061.8 118881.0 119439.0 122003.0 123810.0 96426.0 103051.0 103748.0 105066.5 105100.5 8728.7 9171.7 9182.4 9198.9 9224.4 48128.8 49108.8 57182.1 57479.0 59703.4 68740.7 78134.6 78286.0 80733.2 80979.0 12377.6 13135.4 13320.3 13353.7 14094.6 13818.7 14631.3 14885.3 14922.6 14992.2 13380.9 13439.9 13644.7 13996.2 14054.1 11735.6 13186.0 13357.7 13492.9 13844.0 12322.8 12738.7 12894.7 12995.4 13385.2 10531.5 10798.2 10999.8 11127.0 11501.5 11074.5 11167.3 11350.2 11470.6 11567.7 07:38:27 INFO - PROCESS | 15833 | -------- Summary: end -------- 07:38:27 INFO - PROCESS | 15833 | 07:38:28 INFO - TEST-INFO | 15833: exit 0 07:38:28 INFO - TEST-OK | dromaeo_css | took 1113784ms 07:38:28 INFO - TEST-START | kraken 07:38:28 INFO - operating with platform_type : linux_ 07:38:28 INFO - Initialising browser for kraken test... 07:38:28 INFO - TEST-INFO | started process 16175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxEdyD/profile http://localhost:59364/getInfo.html) 07:38:32 INFO - PROCESS | 16175 | __metrics Screen width/height:1600/1200 07:38:32 INFO - PROCESS | 16175 | colorDepth:24 07:38:32 INFO - PROCESS | 16175 | Browser inner width/height: 1024/697 07:38:32 INFO - PROCESS | 16175 | __metrics 07:38:33 INFO - PROCESS | 16175 | 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:33 INFO - PROCESS | 16175 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:33 INFO - PROCESS | 16175 | console.error: PushService: 07:38:33 INFO - PROCESS | 16175 | stateChangeProcessEnqueue: Error transitioning state 07:38:33 INFO - PROCESS | 16175 | UnknownError 07:38:34 INFO - TEST-INFO | 16175: exit 0 07:38:34 INFO - Browser initialized. 07:38:34 INFO - Running cycle 1/1 for kraken test... 07:38:34 INFO - TEST-INFO | started process 16265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxEdyD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:46 INFO - PROCESS | 16265 | RSS: Main: 145489920 07:38:46 INFO - PROCESS | 16265 | 07:38:48 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:49 INFO - PROCESS | 16265 | RSS: Main: 187129856 07:38:49 INFO - PROCESS | 16265 | 07:38:51 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-dft) 07:38:52 INFO - PROCESS | 16265 | RSS: Main: 176607232 07:38:52 INFO - PROCESS | 16265 | 07:38:55 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-fft) 07:38:55 INFO - PROCESS | 16265 | RSS: Main: 267636736 07:38:55 INFO - PROCESS | 16265 | 07:38:58 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59364/tests/kraken/driver.html?testName=audio-oscillator) 07:38:58 INFO - PROCESS | 16265 | RSS: Main: 173785088 07:38:58 INFO - PROCESS | 16265 | 07:39:00 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:39:01 INFO - PROCESS | 16265 | RSS: Main: 175652864 07:39:01 INFO - PROCESS | 16265 | 07:39:04 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59364/tests/kraken/driver.html?testName=imaging-darkroom) 07:39:04 INFO - PROCESS | 16265 | RSS: Main: 211865600 07:39:04 INFO - PROCESS | 16265 | 07:39:08 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59364/tests/kraken/driver.html?testName=imaging-desaturate) 07:39:08 INFO - PROCESS | 16265 | RSS: Main: 210046976 07:39:08 INFO - PROCESS | 16265 | 07:39:11 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59364/tests/kraken/driver.html?testName=json-parse-financial) 07:39:12 INFO - PROCESS | 16265 | RSS: Main: 209969152 07:39:12 INFO - PROCESS | 16265 | 07:39:13 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:39:14 INFO - PROCESS | 16265 | RSS: Main: 172548096 07:39:14 INFO - PROCESS | 16265 | 07:39:16 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:39:16 INFO - PROCESS | 16265 | RSS: Main: 179453952 07:39:16 INFO - PROCESS | 16265 | 07:39:18 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:39:19 INFO - PROCESS | 16265 | RSS: Main: 189227008 07:39:19 INFO - PROCESS | 16265 | 07:39:21 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:22 INFO - PROCESS | 16265 | RSS: Main: 198422528 07:39:22 INFO - PROCESS | 16265 | 07:39:25 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:25 INFO - PROCESS | 16265 | RSS: Main: 194457600 07:39:25 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | Cycle 1(1): loaded http://localhost:59364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59364/tests/kraken/driver.html?testName=ai-astar) 07:39:27 INFO - PROCESS | 16265 | RSS: Main: 244510720 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | __start_tp_report 07:39:27 INFO - PROCESS | 16265 | _x_x_mozilla_page_load 07:39:27 INFO - PROCESS | 16265 | _x_x_mozilla_page_load_details 07:39:27 INFO - PROCESS | 16265 | |i|pagename|runs| 07:39:27 INFO - PROCESS | 16265 | |0;ai-astar;108;110;112;112;110;114;110;110;111;111 07:39:27 INFO - PROCESS | 16265 | |1;audio-beat-detection;152;120;116;165;118;119;115;116;143;123 07:39:27 INFO - PROCESS | 16265 | |2;audio-dft;161;161;162;160;163;160;162;161;163;160 07:39:27 INFO - PROCESS | 16265 | |3;audio-fft;77;76;77;113;76;76;77;76;97;75 07:39:27 INFO - PROCESS | 16265 | |4;audio-oscillator;82;82;113;82;82;82;109;83;82;107 07:39:27 INFO - PROCESS | 16265 | |5;imaging-gaussian-blur;121;118;118;117;117;116;118;117;117;117 07:39:27 INFO - PROCESS | 16265 | |6;imaging-darkroom;146;146;146;147;146;146;146;147;146;147 07:39:27 INFO - PROCESS | 16265 | |7;imaging-desaturate;94;96;95;95;96;96;95;95;97;97 07:39:27 INFO - PROCESS | 16265 | |8;json-parse-financial;50;49;50;50;50;53;50;49;50;49 07:39:27 INFO - PROCESS | 16265 | |9;json-stringify-tinderbox;59;61;59;60;60;58;59;59;59;59 07:39:27 INFO - PROCESS | 16265 | |10;stanford-crypto-aes;74;75;74;83;82;74;75;75;73;73 07:39:27 INFO - PROCESS | 16265 | |11;stanford-crypto-ccm;136;123;124;130;125;123;123;122;170;123 07:39:27 INFO - PROCESS | 16265 | |12;stanford-crypto-pbkdf2;158;158;154;156;152;155;154;153;154;154 07:39:27 INFO - PROCESS | 16265 | |13;stanford-crypto-sha256-iterative;63;61;63;65;63;63;61;63;63;61 07:39:27 INFO - PROCESS | 16265 | __end_tp_report 07:39:27 INFO - PROCESS | 16265 | __start_cc_report 07:39:27 INFO - PROCESS | 16265 | _x_x_mozilla_cycle_collect,1615 07:39:27 INFO - PROCESS | 16265 | __end_cc_report 07:39:27 INFO - PROCESS | 16265 | __startTimestamp1479137967605__endTimestamp 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | ------- Summary: start ------- 07:39:27 INFO - PROCESS | 16265 | Number of tests: 14 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.62 (1.5%) stddev-sans-first:1.36 07:39:27 INFO - PROCESS | 16265 | Values: 108.0 110.0 112.0 112.0 110.0 114.0 110.0 110.0 111.0 111.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:121.50 stddev:17.93 (14.8%) stddev-sans-first:16.91 07:39:27 INFO - PROCESS | 16265 | Values: 152.0 120.0 116.0 165.0 118.0 119.0 115.0 116.0 143.0 123.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 07:39:27 INFO - PROCESS | 16265 | Values: 161.0 161.0 162.0 160.0 163.0 160.0 162.0 161.0 163.0 160.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.50 stddev:12.71 (16.6%) stddev-sans-first:13.35 07:39:27 INFO - PROCESS | 16265 | Values: 77.0 76.0 77.0 113.0 76.0 76.0 77.0 76.0 97.0 75.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:13.38 (16.3%) stddev-sans-first:13.84 07:39:27 INFO - PROCESS | 16265 | Values: 82.0 82.0 113.0 82.0 82.0 82.0 109.0 83.0 82.0 107.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:1.35 (1.1%) stddev-sans-first:0.67 07:39:27 INFO - PROCESS | 16265 | Values: 121.0 118.0 118.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:39:27 INFO - PROCESS | 16265 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:0.83 07:39:27 INFO - PROCESS | 16265 | Values: 94.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 97.0 97.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:1.15 (2.3%) stddev-sans-first:1.22 07:39:27 INFO - PROCESS | 16265 | Values: 50.0 49.0 50.0 50.0 50.0 53.0 50.0 49.0 50.0 49.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 07:39:27 INFO - PROCESS | 16265 | Values: 59.0 61.0 59.0 60.0 60.0 58.0 59.0 59.0 59.0 59.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:3.61 (4.8%) stddev-sans-first:3.77 07:39:27 INFO - PROCESS | 16265 | Values: 74.0 75.0 74.0 83.0 82.0 74.0 75.0 75.0 73.0 73.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:124.50 stddev:14.75 (11.8%) stddev-sans-first:15.47 07:39:27 INFO - PROCESS | 16265 | Values: 136.0 123.0 124.0 130.0 125.0 123.0 123.0 122.0 170.0 123.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:154.50 stddev:1.99 (1.3%) stddev-sans-first:1.74 07:39:27 INFO - PROCESS | 16265 | Values: 158.0 158.0 154.0 156.0 152.0 155.0 154.0 153.0 154.0 154.0 07:39:27 INFO - PROCESS | 16265 | 07:39:27 INFO - PROCESS | 16265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 07:39:27 INFO - PROCESS | 16265 | Values: 63.0 61.0 63.0 65.0 63.0 63.0 61.0 63.0 63.0 61.0 07:39:27 INFO - PROCESS | 16265 | -------- Summary: end -------- 07:39:27 INFO - PROCESS | 16265 | 07:39:28 INFO - TEST-INFO | 16265: exit 0 07:39:28 INFO - TEST-OK | kraken | took 59939ms 07:39:28 INFO - SUITE-END | took 1173s 07:39:28 INFO - Completed test suite (00:19:33) 07:39:28 INFO - javascript benchmark 07:39:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.1458099022766, 3142.7485801135904, 3151.3539724356497, 3170.714635682788, 3190.58522392089, 5428.4028756836715, 5505.229267902497, 5511.972440137799, 5544.972275138629, 5560.58295627828, 5492.890142197154, 5517.172424136382, 5524.502794748471, 5528.530074943625, 5530.557555395569, 4932.062908047459, 4974.12952733273, 4991.525805048533, 5015.7492125393765, 5086.949130508685, 4952.87617809554, 5018.422881368635, 5078.898422031557, 5083.542481176693, 5100.107481190796, 4932.260160975864, 4951.727654978975, 4987.900241995158, 5018.372703412074, 5038.345015148044, 4993.051320249159, 5019.899602007976, 5024.547790698854, 5086.491350864921, 5122.026814905156, 4952.807869505666, 4980.950190498085, 5029.170186919154, 5047.4952504749235, 5058.671186372874, 5291.894162116774, 5314.92027619586, 5386.73066346685, 5410.3507579090365, 5411.053065713524, 5816.127580862904, 5835.883282334372, 5847.386024467412, 5910.704464776744, 5913.763449462016, 5954.196183515213, 5985.1022346647915, 6000.609960352606, 6000.939990600082, 6018.789342372996, 5315.760790764425, 5353.143497040455, 5433.565314774809, 5459.5359394451125, 5469.15228139639, 6007.639541627516, 6030.48740857032, 6056.3338032816355, 6061.787837425757, 6063.878722425527, 5793.8841223175305, 5794.913076303858, 5799.594028418054, 5803.738831752581, 5807.970960145172, 5685.545156387479, 5756.625819321731, 5840.269966254218, 5882.970585147133, 5901.409859014064, 5901.291844978544, 5923.466887980103, 5932.19915311436, 5941.22764040672, 5959.344472108065, 5882.088276317178, 5924.822255332347, 5939.376365481562, 5942.762289508458, 5968.283805943314, 4353.869383918487, 4393.253146965024, 4450.310201918708, 4510.616597589242, 4555.658325625525, 4021.8592349267633, 4075.0219947212454, 4077.959220407817, 4081.8774836919492, 4100.897477563025, 5577.776888924398, 5584.357798853184, 5587.189857470644, 5587.69267690281, 5590.888182236414, 5810.0, 5868.530517558585, 5889.293284805765, 5953.553483488756, 5964.671943043088, 5568.44315568448, 5627.549796016309, 5627.662340259598, 5652.519535839418, 5652.9152062719095, 5170.1469257572835, 5176.9741151294, 5177.611679124006, 5182.067227899014, 5212.739363031909, 5902.291724992942, 6009.909851352146, 6198.907016394758, 6198.969005154945, 6209.565330426917, 5839.532837373085, 5868.677222752619, 5870.882582348415, 5948.958932186936, 5985.491233245223, 6057.636541807506, 6061.454469097626, 6077.361877002851, 6077.665728384981, 6116.113163591343, 5629.155626656035, 5842.853928651818, 5846.41535846412, 5850.414958504286, 5860.179574859438, 5689.829305120853, 5910.586258962004, 5928.822135335947, 5953.136795164591, 6058.90911636317, 5849.239598852292, 5887.941120588739, 5888.411158884077, 5889.587728858939, 5896.17453556511, 5867.589268751147, 5882.117682347682, 5882.23530940975, 5887.470127688529, 5896.970515147397, 5459.863503412446, 5567.4432556744005, 5636.549076073986, 5679.119736440858, 5828.533717302521, 5783.0, 5795.94204057954, 5799.82600521985, 5829.621074630305, 5852.94147058524, 5488.1767734838495, 5666.546676265972, 5670.121131224667, 5671.744771485211, 5674.347450043133], "value": 5438.295996952708, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.3845293215655, 650.2814390098938, 654.6399480285843, 659.2155335151173, 661.1570247933885, 34725.65274347259, 37665.0, 37725.245495090116, 46018.53981460184, 47350.0, 49473.75263123679, 49718.751406243005, 49858.75070624642, 49866.25200621993, 50002.0, 9344.672936447225, 9480.952595237015, 9499.0, 9499.33504654671, 9502.952485237563, 8523.914760852374, 8691.826163476726, 8699.869501957475, 8743.650253989832, 9245.260379169684, 10921.508532116035, 11198.944005279962, 11210.383428911407, 11593.6521904343, 11596.188266821326, 11219.439028048564, 11302.321860688386, 11303.0, 11305.547778088907, 11316.717082073013, 11062.0, 11086.944565277123, 11129.332240065542, 11188.160887933438, 11193.776124477465, 45611.315830262574, 45801.0, 45952.77023614894, 45979.31031034537, 45988.54011459876, 3355.7147642450423, 3361.058903507022, 3458.723302135823, 3462.4633181856852, 3508.2281897982402, 34401.0, 34565.481517777254, 34603.4809477858, 34626.6537334626, 34718.30563388743, 4613.284940834176, 4647.3958385410015, 4675.602573781199, 4681.5530314323205, 4739.336492890998, 352409.0, 353370.0, 355672.0, 355977.0, 356864.21567892254, 64269.678651606446, 64616.67691661511, 64670.0, 64753.0, 64773.352266477676, 39705.0, 40364.59635403608, 40539.18921621551, 42810.78594607007, 42844.143117138105, 19726.506837329183, 19887.0, 19920.800791992184, 19949.0, 19963.700544491843, 13593.932030339984, 13616.795748063787, 13617.455301788015, 13622.250776207205, 13630.727385452434, 19079.427617171506, 19205.519862003563, 20119.497012574804, 20439.284625038053, 20656.896715516326, 7537.585432801248, 7595.392368610498, 7644.541327520366, 7646.59726421737, 7743.341815945595, 845.7420486751599, 853.5689476814293, 950.6150009246267, 958.6069711418285, 975.2490582251627, 30065.0, 30344.84827575848, 30379.0, 30532.389352213275, 30549.541756873663, 984.601236499219, 986.9358491698017, 994.4282037828277, 997.7405874472689, 1063.6489958313894, 15444.45944391941, 15863.206839658202, 15889.364425422853, 16102.19489025544, 19010.42968710941, 436806.0, 586605.0, 587420.0, 588903.0, 591161.0, 45006.09987800291, 45272.54727452749, 45383.0, 45535.08929821385, 45618.08763824705, 1233.8581063177849, 1349.7975303704523, 1390.8261467316586, 1423.252792284059, 1428.764253898116, 32977.0, 36016.4597531032, 36041.279174416886, 36944.26111477809, 36975.63024369722, 53826.0, 54433.18350224829, 54505.454945451624, 54520.72739636277, 54528.0, 434142.0, 437979.0, 438553.0, 439368.0, 439945.0, 30985.845070774503, 32024.35951281008, 32069.67930320667, 33555.0, 33557.83221083879, 52312.0, 52445.21332179944, 52449.47550524599, 52484.737576311876, 52671.20993185029, 43093.569064308955, 43940.56059439493, 44058.15864163746, 44913.0, 44935.77532112318, 44151.33772993343, 44476.777616111714, 45182.54817451783, 45278.54721452743, 45527.317090243014, 44571.10857782891, 45850.312245317014, 45888.0, 45908.540914591766, 45937.31094033525, 35562.46656300106, 38703.0, 39245.6075439242, 39382.60617393789, 39716.2056758869, 29991.400171996873, 30063.17428317676, 30105.0, 30189.698103018687, 30390.696093038787], "value": 20958.629772021333, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.42020230261505, 420.625643177572, 422.4107370218545, 430.46622188486276, 437.7373575854486, 14278.14331140131, 15500.689986200268, 19936.102875370623, 20945.0, 21585.352439426802, 20063.0, 20298.391048268575, 20390.69413958792, 20598.897005514988, 21019.159233630675, 5811.651300921937, 5850.648961062328, 5974.253218347707, 5989.251343582052, 6027.9752442084955, 4345.717528360647, 4535.478419981695, 5854.121881717755, 5988.550858685594, 5994.250718660168, 6259.87480250397, 6506.674666266691, 6529.51028672849, 6639.900401493981, 6642.4353929916015, 6473.967630161843, 6628.536002479828, 6675.33246675331, 6706.161729783777, 6720.66396680169, 5734.254546908917, 5945.375735547748, 5945.554083443759, 5946.167536544887, 5947.0, 24027.51944961091, 24302.0, 24347.14784982517, 24559.508809823703, 24609.63085553718, 2445.8287919845616, 2459.840110392837, 2493.962590561143, 2716.3209197700576, 2818.802683812134, 10595.0, 10938.398388088652, 10979.83530247047, 11142.610008649659, 14988.700225995419, 1956.5597740508415, 2055.393658870622, 2087.759907610614, 2101.8843963582, 2136.7970042845905, 68347.31652683509, 70598.64700676464, 70607.64696176538, 77723.61138194273, 88966.5551672244, 10985.395803230898, 11673.35796531182, 11727.589534366256, 11849.585264515874, 11919.642410727693, 16873.57816054584, 16884.831151688573, 16912.0, 16953.0, 16970.490885273462, 8197.096536979936, 8870.600822962982, 8958.835351404276, 9005.234555062762, 9178.908210917805, 8778.385513014155, 8819.85341905561, 8827.0, 8976.102389761103, 9074.773130671787, 4968.254761785761, 5046.899062018739, 5074.416442109131, 5111.080005599028, 5174.534291913746, 1996.2681925612637, 2069.8344132469365, 2071.5292142578937, 2082.958340833175, 2109.567538654572, 993.0417147452742, 997.9301448898652, 1016.9644062457926, 1025.8717660292464, 1072.3405105859997, 20794.896025519774, 20819.1672333108, 20963.26628567993, 21442.356729298146, 21629.351119466442, 987.2299606307092, 988.3526290279879, 1014.6905193915926, 1028.1928685981468, 1057.2704833664748, 10532.315399499008, 10891.455427228608, 11180.720481988015, 11288.54845806175, 11375.089992800557, 546028.0, 559319.0, 563230.0, 566054.0, 567981.0, 58650.12024819631, 59520.7023964886, 62465.687671561354, 100216.0, 102958.0, 987.2200961240683, 999.8554545952937, 1044.921630877672, 1052.0636633396284, 1057.7725788955258, 14328.785068223777, 17775.0, 18001.909990449964, 19073.809261907205, 19102.713459297844, 31403.528947065355, 45126.0, 46019.0, 46424.53575464337, 46652.300215497475, 56297.43702562922, 56345.43654563402, 58467.61492887965, 59628.0, 60054.39945600488, 7807.726729564438, 8283.461574997606, 8772.210501054935, 9172.12864777845, 9183.862242066241, 7854.960725196566, 11185.776284474428, 13670.0, 13898.742018964267, 13959.302034898417, 11571.19001669875, 11775.823362649397, 11787.410629468664, 12006.039516838806, 12150.331731754484, 12065.638030859089, 12071.094667900119, 12260.693482663004, 12330.568430104904, 12595.496180152692, 12530.686732831387, 12631.494740210288, 12718.618441446772, 12855.678608034874, 12926.612201633967, 8237.588120593826, 8275.089740128702, 8555.657773688983, 8734.563271836256, 8740.34447416459, 12201.450934707782, 12430.813537797121, 12483.500659973499, 12504.124711270124, 12763.170393924365], "value": 9606.956594489498, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.05385714714, 1552.107538165555, 1743.572824657958, 1834.944951651451, 1858.637565674694, 8582.87125693115, 9208.447493150406, 9228.16946474817, 9243.584038718249, 9260.120288572592, 7584.658690358933, 7824.256695613922, 7837.725679601215, 8699.434536755107, 8978.057303983085, 2389.1160270699866, 2423.8182136339756, 2424.0788500369836, 2430.4774473488196, 2432.2581612608146, 2410.95178096438, 2464.2607217834666, 2473.5671257529953, 2475.938101547458, 2489.7012358517004, 2426.8543887366727, 2444.1445494077107, 2483.726790053093, 2502.7997760179233, 2507.661465702125, 2346.436855154759, 2353.341064501942, 2360.8229382796358, 2407.518496300747, 2452.766987136219, 2381.761823817622, 2395.9760402395927, 2401.8438801478023, 2404.579198640231, 2406.5307265083316, 9105.0, 9200.493972831491, 9241.0, 9270.258379329638, 9296.628134874596, 5266.499682530153, 5399.082156033483, 5403.2705584745945, 5408.891822163535, 5411.053065713484, 3367.107716455141, 3432.9656703432897, 3522.4716292556063, 3524.4184709522897, 3527.894163175109, 1230.6246594788586, 1260.9747805043849, 1261.0983147049903, 1293.353323338331, 1294.8575656677758, 11988.400579970967, 12006.399680015964, 12029.578964736193, 12035.759284814254, 12043.156979011474, 4558.566936141061, 4654.185517534418, 4815.831445899376, 4816.8554943351755, 4829.106615276185, 10260.179185665129, 10300.433476158883, 10317.226208034428, 10322.535485903003, 10335.0, 5460.645058071292, 5469.671819690831, 5474.206240095164, 5488.396276409591, 5489.231507588941, 4467.865964021084, 4609.124266389375, 4776.068666609977, 4869.561739443467, 5016.523430274191, 4243.069403421436, 4325.653947684178, 4401.977990110029, 4441.4892287387365, 4453.265211240174, 1407.1627381707867, 1431.8115963750063, 1433.8637829406189, 1446.067286600158, 1455.316001479303, 854.2269246331955, 982.1602529836887, 1028.280203857303, 1036.9740756481149, 1042.3276986343917, 6035.094735789667, 6283.277423096311, 6308.3060863305, 6342.619442833445, 6386.361363863576, 994.7910938702953, 998.2413365842012, 1034.632705389576, 1036.4662198967537, 1051.0277992856577, 4247.617714405656, 4332.090261045153, 4350.129974005212, 4466.486354069259, 4553.772311384484, 11144.498497567629, 11509.827352589718, 11565.421728913521, 11570.363630000262, 11580.36308003068, 11089.27919685218, 11121.165912556591, 11457.369844658624, 11497.0, 11499.885001150049, 8285.751427457186, 8449.619767110495, 8454.32365410778, 8458.238758511641, 8461.153884611489, 5935.465808077293, 6050.152978582913, 6084.269887613515, 6086.756529738761, 6144.38556144382, 9952.701418957442, 10267.7433064174, 10275.84586231222, 10299.845502317321, 10426.478676066015, 10447.94776026115, 10770.299930504492, 10773.353598784099, 10849.511771970438, 10879.129669626569, 7031.191412987368, 7507.924920750723, 7787.922120778946, 8001.679932802623, 8195.057568379474, 8788.956055219684, 8966.86549701742, 8972.955135224282, 8976.955115224382, 8981.595828187877, 7606.429517786078, 7712.650286200005, 8013.118556958613, 8047.919520804951, 8249.373726910177, 7539.623018849145, 7681.078270607562, 7793.571353575381, 7902.0, 8127.83744325122, 7028.50800443964, 7105.538140020882, 7111.324424179695, 7116.679749411185, 7118.60847653384, 5400.648957817729, 5440.211169380497, 5511.5315198207, 5534.750936207961, 5626.971865140648, 5460.34475862899, 5480.890382192413, 5496.835094947158, 5614.101743720985, 5658.349289831722], "value": 4831.03025563774, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.55779928293936, 348.258210012673, 348.48250348232875, 351.57611672725454, 355.49342187382956, 5525.806596769114, 5560.944390556093, 5586.469285417889, 5613.4386561343945, 5623.578231632629, 5484.177373393983, 5517.475839795223, 5588.636738611997, 5594.776208951647, 5601.775928962837, 4031.778252196128, 4086.795660216992, 4303.935440968388, 4320.287152619814, 4363.476382834048, 4268.274393353122, 4285.250081235771, 4312.590303921138, 4318.438602981623, 4328.199283132615, 4254.808533615995, 4260.957390426087, 4262.509811371686, 4283.207606592775, 4329.653627709776, 4022.577629348935, 4029.858954936578, 4267.957320426787, 4290.334998075304, 4308.74147551148, 3803.980980095082, 3804.5434547854434, 3816.694664426839, 3819.178876541529, 3830.3296923038356, 5322.7072511011875, 5331.680099194061, 5355.758990845382, 5357.0, 5386.946130538684, 4792.353032340624, 4869.342638743759, 4881.585065269456, 4910.656254062182, 4937.185364414867, 5623.493885550321, 5653.1520271959125, 5657.43425657431, 5658.991058174372, 5661.971690141564, 4030.6775457963295, 4182.330827067685, 4184.163167366539, 4184.518780340239, 4230.7038507304505, 5942.762289508414, 5958.672273024982, 5960.850978725523, 5961.701914904281, 5979.531871514511, 4226.154769046203, 4242.957570424256, 4253.914921701548, 4267.146570685875, 4269.779714548417, 4029.9597004029583, 4315.741055536678, 4340.60934515895, 4357.8256869724855, 4371.846985355497, 4788.545088216614, 4821.397325334333, 4827.975860120747, 4848.393950756155, 4879.878003049952, 5711.143328500758, 5760.567957403212, 5776.364599894008, 5786.88426231473, 5799.797007104816, 1454.2946670864621, 1477.9113253204841, 1485.8365579786214, 1505.736496113176, 1507.2915729607066, 917.7292698653913, 922.34513495419, 934.9485778282124, 935.8830146231721, 949.3164921256684, 5370.92581483697, 5441.28599491159, 5520.779168833282, 5534.347330761678, 5555.722213889289, 5876.471117599436, 5900.1739756434135, 5909.3204281507315, 5913.309444202878, 5914.2311499504785, 5350.5987050971335, 5470.753816078286, 5491.835244942658, 5522.171674248895, 5542.168674698827, 3053.4656435123766, 3095.2880837407074, 3097.535369694519, 3107.6270847497995, 3113.6886311369135, 5846.795362162304, 6054.212952316171, 6073.908891366633, 6097.2683278006925, 6113.969430152821, 5969.224000879858, 5976.342602313742, 5996.730147143389, 6006.606267458872, 6012.158297838306, 6023.427774361428, 6027.402738274361, 6050.6369617823075, 6054.215061071956, 6095.3904609538695, 5712.600117991867, 5873.4126587342635, 5904.940950590611, 5919.6152250103605, 5948.226730525004, 5765.711714414347, 5812.73842677089, 5857.121431785266, 5861.6189947653265, 5871.1486834407915, 5912.250803376451, 6110.358412366638, 6110.541709371726, 6134.06776865286, 6159.168512250789, 4143.627073563393, 4241.0, 4269.2742233820945, 4283.935740963951, 4290.699651024398, 5980.910286345796, 5986.850328741816, 5993.6403815769445, 6021.885951099061, 6030.442039196895, 5537.7784888604, 5747.5689323300085, 5752.424757524214, 5781.884362312814, 5877.441643043904, 5756.222909907109, 5764.855878603068, 5772.200482765771, 5781.103928891029, 5781.82654520365, 5455.699936503531, 5691.971540142438, 5723.542116630576, 5752.63470869546, 5760.0, 5295.7087360195555, 5752.913706294493, 5800.767969281182, 5823.563232757476, 5835.387284335084, 5646.943530564806, 5665.886682266414, 5681.488666020078, 5694.092479019575, 5703.429657034263], "value": 4389.770325462237, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.9139894611592, 835.6768184447235, 876.2508055612451, 889.9021107678154, 898.1691934960161, 15084.924575377121, 15477.0, 15684.451044213454, 15752.448664296751, 15778.921105394471, 15183.620409489768, 15225.771613425808, 15716.0, 15853.20733963303, 15853.841461585409, 845.3406343052429, 861.530465896085, 864.1315477944688, 864.3517361978517, 864.5893200729635, 707.6426404665636, 722.8373615936398, 820.4502983001404, 851.3019324154196, 857.4126723194631, 891.0510306523564, 893.0221407558713, 894.0835643465467, 897.33148804141, 897.3359713811765, 889.3863234368298, 890.185480285538, 890.2788741119681, 891.2513488669549, 891.6789955615973, 539.9892002159974, 554.3209568278867, 554.5840619535348, 555.7165845418865, 641.8170821315903, 14878.925605372013, 15093.169875656835, 15126.168060756654, 15198.848011519854, 15237.466688665954, 14051.64870878226, 14266.3580138894, 14483.275836208148, 14486.348114334774, 14600.196989165592, 12763.617091487271, 12820.487180512862, 12955.740885182244, 13009.414576344087, 13109.0, 4505.211587972091, 4525.366448697185, 4548.158590660705, 4590.150822097922, 4656.278276867091, 82846.17153828444, 82894.0, 84227.57886210529, 84234.57882710609, 84627.15372846254, 11485.827712584318, 11535.76928461426, 11603.187776855708, 11899.0, 11939.0, 23439.765602344098, 23503.17738879131, 23529.1764788235, 23709.288721338387, 23718.525629487314, 8748.562571871382, 8864.822703546022, 9018.323625728097, 9331.486768227813, 9331.580078896466, 4900.705957642553, 4910.165271903785, 5141.53726164647, 5227.032998895216, 5291.920621190685, 3592.4611308303442, 3717.4423836424753, 3722.8324725387424, 3723.832427540767, 3734.6078661740125, 626.5175814622716, 628.5443053785968, 635.5360586771683, 635.7679447001811, 649.6102338596804, 660.359451332207, 675.7837492002512, 680.9489288303397, 686.3513979289523, 715.1239731329081, 8755.474671519729, 9464.716058518256, 9792.951035244778, 9822.867947059465, 10031.270040914636, 518.8495336352491, 594.6016169166669, 679.4564348521262, 710.499098135813, 731.4696844787486, 4513.435820522434, 4592.3800286961505, 4629.328747331618, 4653.441587009581, 4658.051689860835, 117903.0, 130395.69604304025, 132203.74573779744, 132596.0, 138656.0, 117061.79091978572, 118881.0, 119439.0, 122003.0, 123810.0, 96426.0, 103051.0, 103748.0, 105066.47466762617, 105100.47449762856, 8728.69449569262, 9171.724848254564, 9182.449053056838, 9198.926411565459, 9224.40041397307, 48128.796780080775, 49108.75445622749, 57182.14226786518, 57479.0, 59703.402965969784, 68740.6562967182, 78134.609326953, 78286.0, 80733.19266807492, 80979.0, 12377.566785162477, 13135.408906599418, 13320.333983300603, 13353.66615834612, 14094.577162685136, 13818.723625527635, 14631.341589628706, 14885.25573721288, 14922.552323430315, 14992.175430351435, 13380.866191337962, 13439.932800336326, 13644.65888352799, 13996.16023038621, 14054.086484378482, 11735.589254376056, 13186.0, 13357.731015553507, 13492.920566354864, 13844.0, 12322.75354492923, 12738.745225095632, 12894.67763305925, 12995.415206315549, 13385.19688818674, 10531.473426328806, 10798.244122911321, 10999.840567579442, 11127.0, 11501.539938402704, 11074.501647425725, 11167.290389362197, 11350.205485615928, 11470.598529051444, 11567.652970410902], "value": 7814.716583049609, "unit": "score"}], "name": "dromaeo_css", "value": 7524.454773046801, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 112.0, 112.0, 110.0, 114.0, 110.0, 110.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 116.0, 165.0, 118.0, 119.0, 115.0, 116.0, 143.0, 123.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 163.0, 160.0, 162.0, 161.0, 163.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 113.0, 76.0, 76.0, 77.0, 76.0, 97.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 82.0, 82.0, 82.0, 109.0, 83.0, 82.0, 107.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 118.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 97.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 50.0, 50.0, 53.0, 50.0, 49.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 60.0, 60.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 83.0, 82.0, 74.0, 75.0, 75.0, 73.0, 73.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 123.0, 124.0, 130.0, 125.0, 123.0, 123.0, 122.0, 170.0, 123.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 154.0, 156.0, 152.0, 155.0, 154.0, 153.0, 154.0, 154.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 65.0, 63.0, 63.0, 61.0, 63.0, 63.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1465.1000000000001, "alertThreshold": 2.0}]} 07:39:28 INFO - Return code: 0 07:39:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:28 INFO - # TBPL SUCCESS # 07:39:28 INFO - Running post-action listener: _resource_record_post_action 07:39:28 INFO - [mozharness: 2016-11-14 15:39:28.913601Z] Finished run-tests step (success) 07:39:28 INFO - Running post-run listener: _resource_record_post_run 07:39:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 118784; Write bytes: 358137856; Read time: 16; Write time: 254444 07:39:28 INFO - TinderboxPrint: CPU usage
13.0% 07:39:28 INFO - TinderboxPrint: I/O read bytes / time
118,784 / 16 07:39:28 INFO - TinderboxPrint: I/O write bytes / time
358,137,856 / 254,444 07:39:28 INFO - TinderboxPrint: CPU idle
8,261.3 (87.0%) 07:39:28 INFO - TinderboxPrint: CPU user
1,187.1 (12.5%) 07:39:28 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108085248; Read time: 0; Write time: 93312 07:39:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 114688; Write bytes: 250052608; Read time: 12; Write time: 161132 07:39:29 INFO - Running post-run listener: _upload_blobber_files 07:39:29 INFO - Blob upload gear active. 07:39:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:29 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:29 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:29 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:33 INFO - (blobuploader) - INFO - Done attempting. 07:39:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:33 INFO - (blobuploader) - INFO - Done attempting. 07:39:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:34 INFO - (blobuploader) - INFO - Done attempting. 07:39:34 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:34 INFO - Return code: 0 07:39:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63051be35673470332c8cce34f3f1bdb394d7dfbc9c4776829e1477c8fa248ac53b2cb177b809a4e7bd258093f69be17870b645c0260f1144683b3cd1482b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/918da64816a602e615050ec9e4313ee00566c207e146f1c6cc95261137fa1c67fb5999d2288cc4d0b1a619187476cfef9a29bef47afc50c8dd9bcac71544cdc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60723655eed1e7d5456e36e7951391913891511c68722d84b52985d9e10c76f0d4cfcd9814d2593fd45eb8bf89ffe50631e18a2c47a52f88f68f4a26037b1a57"} 07:39:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:34 INFO - Contents: 07:39:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63051be35673470332c8cce34f3f1bdb394d7dfbc9c4776829e1477c8fa248ac53b2cb177b809a4e7bd258093f69be17870b645c0260f1144683b3cd1482b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/918da64816a602e615050ec9e4313ee00566c207e146f1c6cc95261137fa1c67fb5999d2288cc4d0b1a619187476cfef9a29bef47afc50c8dd9bcac71544cdc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60723655eed1e7d5456e36e7951391913891511c68722d84b52985d9e10c76f0d4cfcd9814d2593fd45eb8bf89ffe50631e18a2c47a52f88f68f4a26037b1a57"} 07:39:34 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:34 INFO - Copying logs to upload dir... 07:39:34 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.437128 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-14 07:39:31.231846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:31.235581) ========= 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=52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63051be35673470332c8cce34f3f1bdb394d7dfbc9c4776829e1477c8fa248ac53b2cb177b809a4e7bd258093f69be17870b645c0260f1144683b3cd1482b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/918da64816a602e615050ec9e4313ee00566c207e146f1c6cc95261137fa1c67fb5999d2288cc4d0b1a619187476cfef9a29bef47afc50c8dd9bcac71544cdc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60723655eed1e7d5456e36e7951391913891511c68722d84b52985d9e10c76f0d4cfcd9814d2593fd45eb8bf89ffe50631e18a2c47a52f88f68f4a26037b1a57"} build_url:https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63051be35673470332c8cce34f3f1bdb394d7dfbc9c4776829e1477c8fa248ac53b2cb177b809a4e7bd258093f69be17870b645c0260f1144683b3cd1482b9c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/918da64816a602e615050ec9e4313ee00566c207e146f1c6cc95261137fa1c67fb5999d2288cc4d0b1a619187476cfef9a29bef47afc50c8dd9bcac71544cdc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60723655eed1e7d5456e36e7951391913891511c68722d84b52985d9e10c76f0d4cfcd9814d2593fd45eb8bf89ffe50631e18a2c47a52f88f68f4a26037b1a57"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:31.261653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:31.261999) ========= 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=52faae308a556c440401f8e5000001e8-1479136737.796178-1332016229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:31.347057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:39:31.347415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:39:31.347736) ========= ========= Total master_lag: 0.16 =========