builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1476788440.52 results: success (0) buildid: 20161018011649 builduid: 7345881497b94067b6ce82e213d425ab revision: b5e360058f76809eb7aea27452bbdf5e9ae24012 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.524157) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.524890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.525385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.542222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.542711) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 04:00:40-- 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% 37.9M=0s 2016-10-18 04:00:40 (37.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.634538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.634875) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014029 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:40.685764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 04:00:40.686298) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b5e360058f76809eb7aea27452bbdf5e9ae24012 --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 b5e360058f76809eb7aea27452bbdf5e9ae24012 --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=5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 04:00:40,985 truncating revision to first 12 chars 2016-10-18 04:00:40,985 Setting DEBUG logging. 2016-10-18 04:00:40,985 attempt 1/10 2016-10-18 04:00:40,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b5e360058f76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 04:00:42,370 unpacking tar archive at: mozilla-aurora-b5e360058f76/testing/mozharness/ program finished with exit code 0 elapsedTime=1.709902 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 04:00:42.412355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:42.412812) ========= script_repo_revision: b5e360058f76809eb7aea27452bbdf5e9ae24012 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:42.413536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:42.414022) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 04:00:42.425344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-10-18 04:00:42.425866) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:00:42 INFO - MultiFileLogger online at 20161018 04:00:42 in /builds/slave/test 04:00:42 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 04:00:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:42 INFO - {'append_to_log': False, 04:00:42 INFO - 'base_work_dir': '/builds/slave/test', 04:00:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:00:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:42 INFO - 'branch': 'Mozilla-Aurora', 04:00:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:42 INFO - 'config_files': ('talos/linux_config.py',), 04:00:42 INFO - 'default_actions': ('clobber', 04:00:42 INFO - 'read-buildbot-config', 04:00:42 INFO - 'download-and-extract', 04:00:42 INFO - 'populate-webroot', 04:00:42 INFO - 'create-virtualenv', 04:00:42 INFO - 'install', 04:00:42 INFO - 'run-tests'), 04:00:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:42 INFO - 'download_minidump_stackwalk': True, 04:00:42 INFO - 'download_symbols': 'ondemand', 04:00:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:42 INFO - 'installer_path': 'installer.exe', 04:00:42 INFO - 'log_level': 'info', 04:00:42 INFO - 'log_name': 'talos', 04:00:42 INFO - 'log_to_console': True, 04:00:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:00:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:00:42 INFO - 'opt_config_files': (), 04:00:42 INFO - 'pip_index': False, 04:00:42 INFO - 'sps_profile': False, 04:00:42 INFO - 'sps_profile_interval': 0, 04:00:42 INFO - 'suite': 'dromaeojs', 04:00:42 INFO - 'system_bits': '32', 04:00:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:42 INFO - 'title': 'talos-linux64-ix-051', 04:00:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:42 INFO - 'use_talos_json': True, 04:00:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:42 INFO - 'work_dir': 'build'} 04:00:42 INFO - [mozharness: 2016-10-18 11:00:42.819166Z] Running clobber step. 04:00:42 INFO - Running pre-action listener: _resource_record_pre_action 04:00:42 INFO - Running main action method: clobber 04:00:42 INFO - rmtree: /builds/slave/test/build 04:00:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:43 INFO - Running post-action listener: _resource_record_post_action 04:00:43 INFO - [mozharness: 2016-10-18 11:00:43.291165Z] Finished clobber step (success) 04:00:43 INFO - [mozharness: 2016-10-18 11:00:43.291266Z] Running read-buildbot-config step. 04:00:43 INFO - Running pre-action listener: _resource_record_pre_action 04:00:43 INFO - Running main action method: read_buildbot_config 04:00:43 INFO - Using buildbot properties: 04:00:43 INFO - { 04:00:43 INFO - "project": "", 04:00:43 INFO - "product": "firefox", 04:00:43 INFO - "script_repo_revision": "production", 04:00:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:00:43 INFO - "repository": "", 04:00:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:00:43 INFO - "buildid": "20161018011649", 04:00:43 INFO - "pgo_build": "True", 04:00:43 INFO - "basedir": "/builds/slave/test", 04:00:43 INFO - "buildnumber": 521, 04:00:43 INFO - "slavename": "talos-linux64-ix-051", 04:00:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:00:43 INFO - "platform": "ubuntu64_hw", 04:00:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:00:43 INFO - "branch": "mozilla-aurora", 04:00:43 INFO - "repo_path": "releases/mozilla-aurora", 04:00:43 INFO - "revision": "b5e360058f76809eb7aea27452bbdf5e9ae24012", 04:00:43 INFO - "stage_platform": "linux64-pgo", 04:00:43 INFO - "builduid": "7345881497b94067b6ce82e213d425ab", 04:00:43 INFO - "slavebuilddir": "test" 04:00:43 INFO - } 04:00:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 04:00:43 INFO - Running post-action listener: _resource_record_post_action 04:00:43 INFO - [mozharness: 2016-10-18 11:00:43.293732Z] Finished read-buildbot-config step (success) 04:00:43 INFO - [mozharness: 2016-10-18 11:00:43.293820Z] Running download-and-extract step. 04:00:43 INFO - Running pre-action listener: _resource_record_pre_action 04:00:43 INFO - Running main action method: download_and_extract 04:00:43 INFO - mkdir: /builds/slave/test/build/tests 04:00:43 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')]} 04:00:43 INFO - trying https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:00:43 INFO - Downloading https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/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 04:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/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 04:00:43 INFO - Downloaded 1361 bytes. 04:00:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:00:43 INFO - Using the following test package requirements: 04:00:43 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:00:43 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:00:43 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:00:43 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'jsshell-linux-x86_64.zip'], 04:00:43 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:00:43 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:00:43 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:00:43 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:00:43 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:00:43 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:00:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:00:43 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:00:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:00:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:43 INFO - Fetch https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:00:44 INFO - Expected file size: 21907281 04:00:48 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 04:00:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:00:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:48 INFO - Fetch https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:00:49 INFO - Expected file size: 21907281 04:00:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 04:00:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:00:53 INFO - Fetch https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:00:54 INFO - Expected file size: 14414081 04:00: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')]} 04:00:54 INFO - trying https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/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 04:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/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 04:00:56 INFO - Downloaded 63988383 bytes. 04:00:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:00:56 INFO - mkdir: /builds/slave/test/properties 04:00:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:56 INFO - Contents: 04:00:56 INFO - build_url:https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:00:56 INFO - Running post-action listener: _resource_record_post_action 04:00:56 INFO - Running post-action listener: set_extra_try_arguments 04:00:56 INFO - [mozharness: 2016-10-18 11:00:56.835340Z] Finished download-and-extract step (success) 04:00:56 INFO - [mozharness: 2016-10-18 11:00:56.835568Z] Running populate-webroot step. 04:00:56 INFO - Running pre-action listener: _resource_record_pre_action 04:00:56 INFO - Running main action method: populate_webroot 04:00:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:56 INFO - '--tppagecycles', 04:00:56 INFO - '7'], 04:00:56 INFO - 'tests': ['tsvgm']}}, 04:00:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:00:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['damp', 'tps']}, 04:00:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'tests': ['damp', 'tps']}, 04:00:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['dromaeo_dom']}, 04:00:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['basic_compositor_video']}, 04:00:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:00:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['a11yr', 04:00:56 INFO - 'ts_paint', 04:00:56 INFO - 'tpaint', 04:00:56 INFO - 'sessionrestore', 04:00:56 INFO - 'sessionrestore_no_auto_restore', 04:00:56 INFO - 'tabpaint']}, 04:00:56 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:56 INFO - 'ts_paint', 04:00:56 INFO - 'tpaint', 04:00:56 INFO - 'sessionrestore', 04:00:56 INFO - 'sessionrestore_no_auto_restore', 04:00:56 INFO - 'tabpaint']}, 04:00:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:00:56 INFO - 'ts_paint', 04:00:56 INFO - 'tpaint', 04:00:56 INFO - 'sessionrestore', 04:00:56 INFO - 'sessionrestore_no_auto_restore', 04:00:56 INFO - 'tabpaint']}, 04:00:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:00:56 INFO - 'ts_paint', 04:00:56 INFO - 'tpaint', 04:00:56 INFO - 'sessionrestore', 04:00:56 INFO - 'sessionrestore_no_auto_restore', 04:00:56 INFO - 'tabpaint']}, 04:00:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['a11yr', 04:00:56 INFO - 'ts_paint', 04:00:56 INFO - 'tpaint', 04:00:56 INFO - 'sessionrestore', 04:00:56 INFO - 'sessionrestore_no_auto_restore', 04:00:56 INFO - 'tabpaint']}, 04:00:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['a11yr', 04:00:56 INFO - 'ts_paint', 04:00:56 INFO - 'tpaint', 04:00:56 INFO - 'sessionrestore', 04:00:56 INFO - 'sessionrestore_no_auto_restore', 04:00:56 INFO - 'tabpaint']}, 04:00:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['tsvgx', 04:00:56 INFO - 'tsvgr_opacity', 04:00:56 INFO - 'tart', 04:00:56 INFO - 'tscrollx', 04:00:56 INFO - 'cart']}, 04:00:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:56 INFO - 'tsvgr_opacity', 04:00:56 INFO - 'tart', 04:00:56 INFO - 'tscrollx', 04:00:56 INFO - 'cart']}, 04:00:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'talos_options': ['--disable-e10s'], 04:00:56 INFO - 'tests': ['tp5o']}, 04:00:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'tests': ['tp5o']}, 04:00:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'talos_options': ['--disable-e10s', 04:00:56 INFO - '--xperf_path', 04:00:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:56 INFO - 'tests': ['tp5n']}, 04:00:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:56 INFO - 'talos_options': ['--xperf_path', 04:00:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:56 INFO - 'tests': ['tp5n']}}, 04:00:56 INFO - 'talos.zip': {'path': '', 04:00:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:56 INFO - Running post-action listener: _resource_record_post_action 04:00:56 INFO - [mozharness: 2016-10-18 11:00:56.855554Z] Finished populate-webroot step (success) 04:00:56 INFO - [mozharness: 2016-10-18 11:00:56.855642Z] Running create-virtualenv step. 04:00:56 INFO - Running pre-action listener: _resource_record_pre_action 04:00:56 INFO - Running main action method: create_virtualenv 04:00:56 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:56 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 04:00:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:56 INFO - Using real prefix '/usr' 04:00:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:59 INFO - Installing pip.................done. 04:00:59 INFO - Return code: 0 04:00:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00:59 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')]} 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:59 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')]} 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:59 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:00:59 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 04:00:59 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 04:00:59 INFO - Using env: {'DISPLAY': ':0', 04:00:59 INFO - 'HOME': '/home/cltbld', 04:00:59 INFO - 'LANG': 'en_US.UTF-8', 04:00:59 INFO - 'LANGUAGE': 'en_US:en', 04:00:59 INFO - 'LOGNAME': 'cltbld', 04:00:59 INFO - 'MAIL': '/var/mail/cltbld', 04:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:59 INFO - 'MOZ_NO_REMOTE': '1', 04:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:59 INFO - 'NO_EM_RESTART': '1', 04:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:59 INFO - 'PWD': '/builds/slave/test', 04:00:59 INFO - 'SHELL': '/bin/bash', 04:00:59 INFO - 'SHLVL': '1', 04:00:59 INFO - 'TERM': 'linux', 04:00:59 INFO - 'TMOUT': '86400', 04:00:59 INFO - 'USER': 'cltbld', 04:00:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:59 INFO - '_': '/tools/buildbot/bin/python'} 04:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:59 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 04:00:59 INFO - Cleaning up... 04:00:59 INFO - Return code: 0 04:00:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:00:59 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')]} 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:59 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')]} 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:59 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:00:59 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 04:00:59 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 04:00:59 INFO - Using env: {'DISPLAY': ':0', 04:00:59 INFO - 'HOME': '/home/cltbld', 04:00:59 INFO - 'LANG': 'en_US.UTF-8', 04:00:59 INFO - 'LANGUAGE': 'en_US:en', 04:00:59 INFO - 'LOGNAME': 'cltbld', 04:00:59 INFO - 'MAIL': '/var/mail/cltbld', 04:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:59 INFO - 'MOZ_NO_REMOTE': '1', 04:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:59 INFO - 'NO_EM_RESTART': '1', 04:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:59 INFO - 'PWD': '/builds/slave/test', 04:00:59 INFO - 'SHELL': '/bin/bash', 04:00:59 INFO - 'SHLVL': '1', 04:00:59 INFO - 'TERM': 'linux', 04:00:59 INFO - 'TMOUT': '86400', 04:00:59 INFO - 'USER': 'cltbld', 04:00:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:59 INFO - '_': '/tools/buildbot/bin/python'} 04:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:59 INFO - Downloading/unpacking psutil>=3.1.1 04:00:59 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 04:00:59 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 04:00:59 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 04:00:59 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 04:00:59 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 04:00:59 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 04:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:01 INFO - Installing collected packages: psutil 04:01:01 INFO - Running setup.py install for psutil 04:01:01 INFO - building 'psutil._psutil_linux' extension 04:01:01 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 04:01:02 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 04:01:02 INFO - building 'psutil._psutil_posix' extension 04:01:02 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 04:01:02 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 04:01:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:02 INFO - Successfully installed psutil 04:01:02 INFO - Cleaning up... 04:01:02 INFO - Return code: 0 04:01:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:02 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01:02 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 04:01:02 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 04:01:02 INFO - Using env: {'DISPLAY': ':0', 04:01:02 INFO - 'HOME': '/home/cltbld', 04:01:02 INFO - 'LANG': 'en_US.UTF-8', 04:01:02 INFO - 'LANGUAGE': 'en_US:en', 04:01:02 INFO - 'LOGNAME': 'cltbld', 04:01:02 INFO - 'MAIL': '/var/mail/cltbld', 04:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:02 INFO - 'MOZ_NO_REMOTE': '1', 04:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:02 INFO - 'NO_EM_RESTART': '1', 04:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:02 INFO - 'PWD': '/builds/slave/test', 04:01:02 INFO - 'SHELL': '/bin/bash', 04:01:02 INFO - 'SHLVL': '1', 04:01:02 INFO - 'TERM': 'linux', 04:01:02 INFO - 'TMOUT': '86400', 04:01:02 INFO - 'USER': 'cltbld', 04:01:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:02 INFO - '_': '/tools/buildbot/bin/python'} 04:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:01:04 INFO - Installing collected packages: mozsystemmonitor 04:01:04 INFO - Running setup.py install for mozsystemmonitor 04:01:04 INFO - Successfully installed mozsystemmonitor 04:01:04 INFO - Cleaning up... 04:01:04 INFO - Return code: 0 04:01:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:01:04 INFO - Using env: {'DISPLAY': ':0', 04:01:04 INFO - 'HOME': '/home/cltbld', 04:01:04 INFO - 'LANG': 'en_US.UTF-8', 04:01:04 INFO - 'LANGUAGE': 'en_US:en', 04:01:04 INFO - 'LOGNAME': 'cltbld', 04:01:04 INFO - 'MAIL': '/var/mail/cltbld', 04:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:04 INFO - 'MOZ_NO_REMOTE': '1', 04:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:04 INFO - 'NO_EM_RESTART': '1', 04:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:04 INFO - 'PWD': '/builds/slave/test', 04:01:04 INFO - 'SHELL': '/bin/bash', 04:01:04 INFO - 'SHLVL': '1', 04:01:04 INFO - 'TERM': 'linux', 04:01:04 INFO - 'TMOUT': '86400', 04:01:04 INFO - 'USER': 'cltbld', 04:01:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:04 INFO - '_': '/tools/buildbot/bin/python'} 04:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:04 INFO - Downloading/unpacking jsonschema==2.5.1 04:01:04 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 04:01:04 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 04:01:04 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 04:01:04 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 04:01:04 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 04:01:04 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 04:01:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 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 04:01:06 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 04:01:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:07 INFO - warning: no files found matching '*.txt' 04:01:07 INFO - no previously-included directories found matching 'build' 04:01:07 INFO - no previously-included directories found matching 'dist' 04:01:07 INFO - no previously-included directories found matching '.git*' 04:01:07 INFO - Installing collected packages: jsonschema, functools32 04:01:07 INFO - Running setup.py install for functools32 04:01:07 INFO - warning: no files found matching '*.txt' 04:01:07 INFO - no previously-included directories found matching 'build' 04:01:07 INFO - no previously-included directories found matching 'dist' 04:01:07 INFO - no previously-included directories found matching '.git*' 04:01:07 INFO - Successfully installed jsonschema functools32 04:01:07 INFO - Cleaning up... 04:01:07 INFO - Return code: 0 04:01:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:01:07 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')]} 04:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 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')]} 04:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01:07 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 04:01:07 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 04:01:07 INFO - Using env: {'DISPLAY': ':0', 04:01:07 INFO - 'HOME': '/home/cltbld', 04:01:07 INFO - 'LANG': 'en_US.UTF-8', 04:01:07 INFO - 'LANGUAGE': 'en_US:en', 04:01:07 INFO - 'LOGNAME': 'cltbld', 04:01:07 INFO - 'MAIL': '/var/mail/cltbld', 04:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:07 INFO - 'MOZ_NO_REMOTE': '1', 04:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:07 INFO - 'NO_EM_RESTART': '1', 04:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:07 INFO - 'PWD': '/builds/slave/test', 04:01:07 INFO - 'SHELL': '/bin/bash', 04:01:07 INFO - 'SHLVL': '1', 04:01:07 INFO - 'TERM': 'linux', 04:01:07 INFO - 'TMOUT': '86400', 04:01:07 INFO - 'USER': 'cltbld', 04:01:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:07 INFO - '_': '/tools/buildbot/bin/python'} 04:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:01:07 INFO - Cleaning up... 04:01:07 INFO - Return code: 0 04:01:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:07 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')]} 04:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 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')]} 04:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01:07 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 04:01:07 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 04:01:07 INFO - Using env: {'DISPLAY': ':0', 04:01:07 INFO - 'HOME': '/home/cltbld', 04:01:07 INFO - 'LANG': 'en_US.UTF-8', 04:01:07 INFO - 'LANGUAGE': 'en_US:en', 04:01:07 INFO - 'LOGNAME': 'cltbld', 04:01:07 INFO - 'MAIL': '/var/mail/cltbld', 04:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:07 INFO - 'MOZ_NO_REMOTE': '1', 04:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:07 INFO - 'NO_EM_RESTART': '1', 04:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:07 INFO - 'PWD': '/builds/slave/test', 04:01:07 INFO - 'SHELL': '/bin/bash', 04:01:07 INFO - 'SHLVL': '1', 04:01:07 INFO - 'TERM': 'linux', 04:01:07 INFO - 'TMOUT': '86400', 04:01:07 INFO - 'USER': 'cltbld', 04:01:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:07 INFO - '_': '/tools/buildbot/bin/python'} 04:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:09 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 04:01:09 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 04:01:09 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 04:01:09 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 04:01:09 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 04:01:09 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 04:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:10 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 04:01:10 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 04:01:10 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 04:01:10 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 04:01:10 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 04:01:10 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 04:01:10 INFO - Downloading docopt-0.6.1.tar.gz 04:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:10 INFO - Running setup.py install for blobuploader 04:01:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:10 INFO - Running setup.py install for requests 04:01:10 INFO - Running setup.py install for docopt 04:01:11 INFO - Successfully installed blobuploader requests docopt 04:01:11 INFO - Cleaning up... 04:01:11 INFO - Return code: 0 04:01:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:11 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')]} 04:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:11 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')]} 04:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:11 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01:11 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 04:01:11 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 04:01:11 INFO - Using env: {'DISPLAY': ':0', 04:01:11 INFO - 'HOME': '/home/cltbld', 04:01:11 INFO - 'LANG': 'en_US.UTF-8', 04:01:11 INFO - 'LANGUAGE': 'en_US:en', 04:01:11 INFO - 'LOGNAME': 'cltbld', 04:01:11 INFO - 'MAIL': '/var/mail/cltbld', 04:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:11 INFO - 'MOZ_NO_REMOTE': '1', 04:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:11 INFO - 'NO_EM_RESTART': '1', 04:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:11 INFO - 'PWD': '/builds/slave/test', 04:01:11 INFO - 'SHELL': '/bin/bash', 04:01:11 INFO - 'SHLVL': '1', 04:01:11 INFO - 'TERM': 'linux', 04:01:11 INFO - 'TMOUT': '86400', 04:01:11 INFO - 'USER': 'cltbld', 04:01:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:11 INFO - '_': '/tools/buildbot/bin/python'} 04:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:11 INFO - Running setup.py (path:/tmp/pip-1pCfun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:11 INFO - Running setup.py (path:/tmp/pip-HGUyh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:11 INFO - Running setup.py (path:/tmp/pip-loFbj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:11 INFO - Running setup.py (path:/tmp/pip-knPewB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:11 INFO - Running setup.py (path:/tmp/pip-Az1TgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:11 INFO - Running setup.py (path:/tmp/pip-ASSyZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:11 INFO - Running setup.py (path:/tmp/pip-GNHLca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:11 INFO - Running setup.py (path:/tmp/pip-nlKb6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:11 INFO - Running setup.py (path:/tmp/pip-i4iNZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:11 INFO - Running setup.py (path:/tmp/pip-YWEbiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:12 INFO - Running setup.py (path:/tmp/pip-hmCgRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:12 INFO - Running setup.py (path:/tmp/pip-jjca7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:12 INFO - Running setup.py (path:/tmp/pip-QmXTeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:12 INFO - Running setup.py (path:/tmp/pip-Tnm_hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:12 INFO - Running setup.py (path:/tmp/pip-2mlrAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:12 INFO - Running setup.py (path:/tmp/pip-NjxY8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:12 INFO - Running setup.py (path:/tmp/pip-MH6pm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:12 INFO - Running setup.py install for manifestparser 04:01:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:12 INFO - Running setup.py install for mozcrash 04:01:12 INFO - Running setup.py install for mozdebug 04:01:12 INFO - Running setup.py install for mozdevice 04:01:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:12 INFO - Running setup.py install for mozfile 04:01:13 INFO - Running setup.py install for mozhttpd 04:01:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Running setup.py install for mozinfo 04:01:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Running setup.py install for mozInstall 04:01:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Running setup.py install for mozleak 04:01:13 INFO - Running setup.py install for mozlog 04:01:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Running setup.py install for moznetwork 04:01:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Running setup.py install for mozprocess 04:01:13 INFO - Running setup.py install for mozprofile 04:01:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:13 INFO - Running setup.py install for mozrunner 04:01:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:14 INFO - Running setup.py install for mozscreenshot 04:01:14 INFO - Running setup.py install for moztest 04:01:14 INFO - Running setup.py install for mozversion 04:01:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:14 INFO - Cleaning up... 04:01:14 INFO - Return code: 0 04:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:14 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01:14 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 04:01:14 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 04:01:14 INFO - Using env: {'DISPLAY': ':0', 04:01:14 INFO - 'HOME': '/home/cltbld', 04:01:14 INFO - 'LANG': 'en_US.UTF-8', 04:01:14 INFO - 'LANGUAGE': 'en_US:en', 04:01:14 INFO - 'LOGNAME': 'cltbld', 04:01:14 INFO - 'MAIL': '/var/mail/cltbld', 04:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:14 INFO - 'MOZ_NO_REMOTE': '1', 04:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:14 INFO - 'NO_EM_RESTART': '1', 04:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:14 INFO - 'PWD': '/builds/slave/test', 04:01:14 INFO - 'SHELL': '/bin/bash', 04:01:14 INFO - 'SHLVL': '1', 04:01:14 INFO - 'TERM': 'linux', 04:01:14 INFO - 'TMOUT': '86400', 04:01:14 INFO - 'USER': 'cltbld', 04:01:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:14 INFO - '_': '/tools/buildbot/bin/python'} 04:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:14 INFO - Running setup.py (path:/tmp/pip-cl0qke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:14 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)) 04:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:14 INFO - Running setup.py (path:/tmp/pip-LUoXLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:14 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)) 04:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:14 INFO - Running setup.py (path:/tmp/pip-Qngh04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:14 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)) 04:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:14 INFO - Running setup.py (path:/tmp/pip-jXukrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:14 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)) 04:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:14 INFO - Running setup.py (path:/tmp/pip-h9YmS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:14 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)) 04:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:14 INFO - Running setup.py (path:/tmp/pip-tUxmdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:15 INFO - Running setup.py (path:/tmp/pip-nvA93y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:15 INFO - Running setup.py (path:/tmp/pip-ALMtQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:15 INFO - Running setup.py (path:/tmp/pip-FFXPd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:15 INFO - Running setup.py (path:/tmp/pip-wv8krt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:15 INFO - Running setup.py (path:/tmp/pip-rOrS2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:15 INFO - Running setup.py (path:/tmp/pip-_xOelt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:15 INFO - Running setup.py (path:/tmp/pip-BOvSZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:15 INFO - Running setup.py (path:/tmp/pip-ki4tpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:15 INFO - Running setup.py (path:/tmp/pip-h3gc4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:15 INFO - Running setup.py (path:/tmp/pip-R8PCcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:15 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)) 04:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:15 INFO - Running setup.py (path:/tmp/pip-j_gHkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:15 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)) 04:01:15 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)) 04:01:15 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)) 04:01:15 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)) 04:01:15 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)) 04:01:15 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)) 04:01:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:15 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 04:01:15 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 04:01:15 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 04:01:15 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 04:01:15 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 04:01:15 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 04:01:17 INFO - Downloading blessings-1.6.tar.gz 04:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:17 INFO - Installing collected packages: blessings 04:01:17 INFO - Running setup.py install for blessings 04:01:17 INFO - Successfully installed blessings 04:01:17 INFO - Cleaning up... 04:01:18 INFO - Return code: 0 04:01:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:18 INFO - Reading from file tmpfile_stdout 04:01:18 INFO - Current package versions: 04:01:18 INFO - argparse == 1.2.1 04:01:18 INFO - blessings == 1.6 04:01:18 INFO - blobuploader == 1.2.4 04:01:18 INFO - docopt == 0.6.1 04:01:18 INFO - functools32 == 3.2.3-2 04:01:18 INFO - jsonschema == 2.5.1 04:01:18 INFO - manifestparser == 1.1 04:01:18 INFO - mozInstall == 1.12 04:01:18 INFO - mozcrash == 0.17 04:01:18 INFO - mozdebug == 0.1 04:01:18 INFO - mozdevice == 0.48 04:01:18 INFO - mozfile == 1.2 04:01:18 INFO - mozhttpd == 0.7 04:01:18 INFO - mozinfo == 0.9 04:01:18 INFO - mozleak == 0.1 04:01:18 INFO - mozlog == 3.4 04:01:18 INFO - moznetwork == 0.27 04:01:18 INFO - mozprocess == 0.23 04:01:18 INFO - mozprofile == 0.28 04:01:18 INFO - mozrunner == 6.12 04:01:18 INFO - mozscreenshot == 0.1 04:01:18 INFO - mozsystemmonitor == 0.3 04:01:18 INFO - moztest == 0.7 04:01:18 INFO - mozversion == 1.4 04:01:18 INFO - psutil == 3.1.1 04:01:18 INFO - requests == 1.2.3 04:01:18 INFO - wsgiref == 0.1.2 04:01:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:18 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 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01:18 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 04:01:18 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 04:01:18 INFO - Using env: {'DISPLAY': ':0', 04:01:18 INFO - 'HOME': '/home/cltbld', 04:01:18 INFO - 'LANG': 'en_US.UTF-8', 04:01:18 INFO - 'LANGUAGE': 'en_US:en', 04:01:18 INFO - 'LOGNAME': 'cltbld', 04:01:18 INFO - 'MAIL': '/var/mail/cltbld', 04:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:18 INFO - 'MOZ_NO_REMOTE': '1', 04:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:18 INFO - 'NO_EM_RESTART': '1', 04:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:18 INFO - 'PWD': '/builds/slave/test', 04:01:18 INFO - 'SHELL': '/bin/bash', 04:01:18 INFO - 'SHLVL': '1', 04:01:18 INFO - 'TERM': 'linux', 04:01:18 INFO - 'TMOUT': '86400', 04:01:18 INFO - 'USER': 'cltbld', 04:01:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:18 INFO - '_': '/tools/buildbot/bin/python'} 04:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 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)) 04:01:18 INFO - Cleaning up... 04:01:18 INFO - Return code: 0 04:01:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4831410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2baaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', '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 04:01: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', 'jsonschema'] in /builds/slave/test/build 04:01: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 jsonschema 04:01:18 INFO - Using env: {'DISPLAY': ':0', 04:01:18 INFO - 'HOME': '/home/cltbld', 04:01:18 INFO - 'LANG': 'en_US.UTF-8', 04:01:18 INFO - 'LANGUAGE': 'en_US:en', 04:01:18 INFO - 'LOGNAME': 'cltbld', 04:01:18 INFO - 'MAIL': '/var/mail/cltbld', 04:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:18 INFO - 'MOZ_NO_REMOTE': '1', 04:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:18 INFO - 'NO_EM_RESTART': '1', 04:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:18 INFO - 'PWD': '/builds/slave/test', 04:01:18 INFO - 'SHELL': '/bin/bash', 04:01:18 INFO - 'SHLVL': '1', 04:01:18 INFO - 'TERM': 'linux', 04:01:18 INFO - 'TMOUT': '86400', 04:01:18 INFO - 'USER': 'cltbld', 04:01:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:18 INFO - '_': '/tools/buildbot/bin/python'} 04:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:01:18 INFO - Cleaning up... 04:01:18 INFO - Return code: 0 04:01:18 INFO - Running post-action listener: _resource_record_post_action 04:01:18 INFO - Running post-action listener: _start_resource_monitoring 04:01:18 INFO - Starting resource monitoring. 04:01:18 INFO - [mozharness: 2016-10-18 11:01:18.702807Z] Finished create-virtualenv step (success) 04:01:18 INFO - [mozharness: 2016-10-18 11:01:18.703312Z] Running install step. 04:01:18 INFO - Running pre-action listener: _resource_record_pre_action 04:01:18 INFO - Running main action method: install 04:01:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:18 INFO - Reading from file tmpfile_stdout 04:01:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:18 INFO - Reading from file tmpfile_stdout 04:01:18 INFO - Output received: 04:01:18 INFO - Usage: mozinstall [options] installer 04:01:18 INFO - Options: 04:01:18 INFO - -h, --help show this help message and exit 04:01:18 INFO - -d DEST, --destination=DEST 04:01:18 INFO - Directory to install application into. [default: 04:01:18 INFO - "/builds/slave/test"] 04:01:18 INFO - --app=APP Application being installed. [default: firefox] 04:01:18 INFO - mkdir: /builds/slave/test/build/application 04:01:18 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'] 04:01:18 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 04:01:34 INFO - Reading from file tmpfile_stdout 04:01:34 INFO - Output received: 04:01:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:01:34 INFO - Running post-action listener: _resource_record_post_action 04:01:34 INFO - [mozharness: 2016-10-18 11:01:34.955653Z] Finished install step (success) 04:01:34 INFO - [mozharness: 2016-10-18 11:01:34.955897Z] Running run-tests step. 04:01:34 INFO - Running pre-action listener: _resource_record_pre_action 04:01:34 INFO - Running main action method: run_tests 04:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:34 INFO - Python 2.7.3 04:01:34 INFO - Return code: 0 04:01:34 INFO - grabbing minidump binary from tooltool 04:01: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')]} 04:01:34 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 0x2ba7f60>, '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 0x2ba8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:34 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 04:01:34 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 04:01:34 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 04:01:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:35 INFO - Return code: 0 04:01:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:01:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:01:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:35 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/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 04:01:35 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/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 04:01:35 INFO - Using env: {'DISPLAY': ':0', 04:01:35 INFO - 'HOME': '/home/cltbld', 04:01:35 INFO - 'LANG': 'en_US.UTF-8', 04:01:35 INFO - 'LANGUAGE': 'en_US:en', 04:01:35 INFO - 'LOGNAME': 'cltbld', 04:01:35 INFO - 'MAIL': '/var/mail/cltbld', 04:01:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:35 INFO - 'MOZ_NO_REMOTE': '1', 04:01:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:35 INFO - 'NO_EM_RESTART': '1', 04:01:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:35 INFO - 'PWD': '/builds/slave/test', 04:01:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:35 INFO - 'SHELL': '/bin/bash', 04:01:35 INFO - 'SHLVL': '1', 04:01:35 INFO - 'TERM': 'linux', 04:01:35 INFO - 'TMOUT': '86400', 04:01:35 INFO - 'USER': 'cltbld', 04:01:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318', 04:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:35 INFO - '_': '/tools/buildbot/bin/python'} 04:01:35 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/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 04:01:35 INFO - mozversion application_buildid: 20161018011649 04:01:35 INFO - mozversion application_changeset: b5e360058f76809eb7aea27452bbdf5e9ae24012 04:01:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:01:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:35 INFO - mozversion application_name: Firefox 04:01:35 INFO - mozversion application_remotingname: firefox-dev 04:01:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:01:35 INFO - mozversion application_vendor: Mozilla 04:01:35 INFO - mozversion application_version: 51.0a2 04:01:35 INFO - mozversion platform_buildid: 20161018011649 04:01:35 INFO - mozversion platform_changeset: b5e360058f76809eb7aea27452bbdf5e9ae24012 04:01:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:01:35 INFO - mozversion platform_version: 51.0a2 04:01:35 INFO - using testdate: 1476788495 04:01:35 INFO - actual date: 1476788495 04:01:35 INFO - starting webserver on 'localhost:41860' 04:01:35 INFO - SUITE-START | Running 2 tests 04:01:35 INFO - TEST-START | dromaeo_css 04:01:35 INFO - operating with platform_type : linux_ 04:01:35 INFO - Initialising browser for dromaeo_css test... 04:01:35 INFO - TEST-INFO | started process 12903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jltmV/profile http://localhost:41860/getInfo.html) 04:01:39 INFO - PROCESS | 12903 | __metrics Screen width/height:1600/1200 04:01:39 INFO - PROCESS | 12903 | colorDepth:24 04:01:39 INFO - PROCESS | 12903 | Browser inner width/height: 1024/697 04:01:39 INFO - PROCESS | 12903 | __metrics 04:01:40 INFO - PROCESS | 12903 | 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" 04:01:40 INFO - PROCESS | 12903 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:01:40 INFO - PROCESS | 12903 | console.error: PushService: 04:01:40 INFO - PROCESS | 12903 | stateChangeProcessEnqueue: Error transitioning state 04:01:40 INFO - PROCESS | 12903 | UnknownError 04:01:41 INFO - TEST-INFO | 12903: exit 0 04:01:41 INFO - Browser initialized. 04:01:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:41 INFO - TEST-INFO | started process 12996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jltmV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:53 INFO - PROCESS | 12996 | RSS: Main: 145321984 04:01:53 INFO - PROCESS | 12996 | 04:02:44 INFO - PROCESS | 12996 | 1476788564020 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] 04:04:52 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41860/tests/dromaeo/cssquery-ext.html) 04:04:53 INFO - PROCESS | 12996 | RSS: Main: 238604288 04:04:53 INFO - PROCESS | 12996 | 04:07:56 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-ext.html (next: http://localhost:41860/tests/dromaeo/cssquery-jquery.html) 04:07:56 INFO - PROCESS | 12996 | RSS: Main: 229490688 04:07:56 INFO - PROCESS | 12996 | 04:10:58 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41860/tests/dromaeo/cssquery-mootools.html) 04:10:59 INFO - PROCESS | 12996 | RSS: Main: 173232128 04:10:59 INFO - PROCESS | 12996 | 04:14:01 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41860/tests/dromaeo/cssquery-prototype.html) 04:14:01 INFO - PROCESS | 12996 | RSS: Main: 221507584 04:14:01 INFO - PROCESS | 12996 | 04:17:04 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41860/tests/dromaeo/cssquery-yui.html) 04:17:05 INFO - PROCESS | 12996 | RSS: Main: 176705536 04:17:05 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-yui.html (next: http://localhost:41860/tests/dromaeo/cssquery-dojo.html) 04:20:07 INFO - PROCESS | 12996 | RSS: Main: 267509760 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | __start_tp_report 04:20:07 INFO - PROCESS | 12996 | _x_x_mozilla_page_load 04:20:07 INFO - PROCESS | 12996 | _x_x_mozilla_page_load_details 04:20:07 INFO - PROCESS | 12996 | |i|pagename|runs| 04:20:07 INFO - PROCESS | 12996 | |0;dojo.html;3089.706477884601;3121.3757248550282;3134.8746050157993;3156.0216332936775;3178.2054486378406;5354.518093371596;5383.219433182187;5385.246065550826;5394.676319420828;5412.323459567554;5458.536024437927;5475.178723191523;5476.58925580581;5490.725463726808;5491.148871924848;4933.876653083675;4948.183549714293;4989.625778066641;5011.949880501184;5020.196768517038;4786.83246086387;4967.751612419383;5027.798888044492;5034.84895453137;5060.11447996601;4757.238841785315;4841.927371089437;4859.076775412678;4885;4913.582345500618;4863.537963893425;4900.803967841282;4906.264060390934;4966.776495057731;4990.476000019982;4893.290472881412;4906.435759887623;4909.7790599423115;4935.481774413671;4937.555619994182;5220.817271395483;5310.734463276859;5319.281896943901;5347.54545863602;5365.03429382711;5675.460831221028;5697.202391665171;5706.229658996024;5767.279090113736;5785.074388097926;5827.737751801137;5828;5842.123681447774;5856.414358564152;5859.941400585983;5271.209318602202;5277.155655095166;5285.07511185541;5311.601629877736;5312.229726689686;5777.913331300034;5801.854953626109;5817.563682723728;5818.21454103699;5818.272715910512;5580.776768929279;5600.747966341524;5601.7759289628775;5602.355729091207;5607.214989901417;5552.639078459887;5584.664920104726;5647.463490968352;5689.374168841424;5690.6870122142855;5715.085586306171;5725.0267454531995;5729.914051289234;5730.7421166047625;5758.62568933018;5724.942750572441;5727.3699893011735;5727.742251598688;5728.742206600713;5758.971205144031;4372.846950356722;4378.824847006148;4387.056782791715;4398.010447649253;4404.031113155101;3948.368261078214;3970.404439334065;3985.7807820570147;3992.8203230854683;3998.620131087542;5424.267723857308;5465.508104270635;5471.06991811393;5486.61593688438;5490.066688662937;5634.746436410372;5667.234923285386;5683.090705487102;5749;5789.2763404574425;5424.294841670637;5490.945090549123;5491.7254137292975;5514.36584792754;5524.475174858382;4934.827281045218;4938.9012219755405;4942.604591632661;4949.628777841676;4976.925346119811;5832.650040997553;5834.620749651259;5993.760249589967;5995.580309378389;5996.280446346466;5607.747651355618;5675.262215911905;5683.77264909399;5708.8572785679025;5768.596198266081;5959.880802384015;5966.105084237225;5966.791162309299;5974.671393073423;5974.820755377345;5474.178873169057;5607.943920560905;5612.326520817364;5613.46672066153;5616.634918730269;5580.441955804549;5584.916226256528;5597.076482380525;5650.29371328584;5728.484436400744;5559.916601250903;5568.610197286151;5569.8607534810335;5572.247746554163;5572.86067848307;5535.7785688572;5566.443355664401;5582.0231459495235;5593.804216852391;5596.960908133254;5443.918341224806;5491.039068162976;5539.390667026543;5560.443955604407;5593.720313984366;5684.147377893349;5691.8292451226525;5696.145578163143;5704.201411802268;5735.3977832327;5371.248025276386;5528.308961379827;5567.610267281251;5567.860803479945;5580.079286917613 04:20:07 INFO - PROCESS | 12996 | |1;ext.html;592.5733471900234;613.460155063544;652.1977967100466;657.3722095398895;658.321928413734;32186.839065804666;35323.293534129305;35466.29067418653;35513.82243088787;35586.46620300691;45972.310415343796;47034.529654703445;47126.764366178206;50218.748906255416;50344;9058.411203271782;9316.301277404187;9328.813423731555;9329.580168892417;9337.439753614772;8612.655493780241;8801.163889430494;9112.407693499934;9221.53892305382;9224.354295199339;11215.38315392653;11421.54313827446;11428.428578571038;11779.057675385991;11784.057275417988;11185.049270811951;11253.156013299036;11267.887321126766;11276;11283.717907052349;11209.551617935273;11251.493682784294;11284.717882052932;11296.378699171542;11297.26567773092;44690;45027.77486112549;45082;45091.323630145576;45134.322985155246;3843.0584506795735;3897.3569361055393;3969.4442778011103;3979.422983667352;4188.486883003854;33956.83021584901;34352.65647343545;34407.13982150441;34420.31159376798;34653;4560.657950653715;4595.264757638762;4626.467956185048;4662.114198302312;4769.308450274691;380620;381534;382219;382721;383005;61217;61404.69297653573;61669.38330616726;61678.69160654168;61688.38311616916;40183.397249041285;40928.38607420891;41165;43057.13885722268;43062.13875722468;17813.554661133316;17904.91047544754;17919.641607168043;18002.279908803765;18008.909955450137;13782.586522404345;13876.58370248894;13888.583342499742;13904.930475347559;13905.4437822488;18124.728129078074;18376.356827510972;19813.504662383555;20174.29389971344;20424.489387765425;7257.782266532013;7572.734954276574;7653.885191722128;7674.884876726854;7794.22057794216;995.4773743784426;997.9950100249453;1010.5402042070987;1034.1468288661733;1102.9944850275697;33939;33959.32081358359;34223.4866477003;34399.65600344015;34442;1068.951897164614;1125.7523344864117;1132.0547342968548;1167.976640467203;1238.182799352423;17810.91094544519;17904.10479476021;17992.460226193234;18025.819741802676;18109;571074;574454;574733;576535;577287;60149;60446.395536044074;60495.39504604986;60499.395006050254;60592;1287.4914408808468;1304.7520971015476;1407.2541552976938;1455.6943041961306;1467.699121680053;33746.32507349888;35230;35335.469967951016;35537.28925421529;35544.46683299701;52880.41358759243;53317;53513.46486535085;53535.46464535461;53557.196642049625;419408;421504;423898;505558;522979;43286.56713432825;43611.78194109009;43965.560344396145;44458.3331250025;46035.53964460446;50317.496825032744;51295.74352128216;51873.740631296605;51968.740156298976;52010;43285;43785.12429751323;43892;44737.328940066574;44874.326885096096;43677;44162;44457.555424445345;44859.77570112129;45557.772211138734;43053.56946430621;43882;44204.33693494536;44271;44571;37320.06699832526;38501.6149838498;39237.80381098076;39689;39740.602593973694;28973.420531589672;29132;29412.056021077373;29688.851555742083;29884.701152989062 04:20:07 INFO - PROCESS | 12996 | |2;jquery.html;394.91509325495014;434.5806296923469;436.67031391299565;438.7762241256958;439.6175327465104;16616.501504954857;21179.788202117976;21461.785382146172;21696.566068678618;22283.108675652995;17072.487825365228;17082.231299591516;17090.487285381427;17125.229364678587;17225.655486890253;5960.612560183596;5972.9402705972925;6178.41305076017;6201.937980620181;6236.407541283571;6112.6638034908065;6186.072089186613;6193.845153871144;6196.380361963813;6201.906971395432;5938.287405511323;6115.1438798568015;6138.386161383871;6143.017117261239;6152.169457123276;5927.9407205928255;6121.632702037869;6150.04674275488;6169.722362493699;6173;5472.206530053159;5512;5514.751836167382;5516.282883225195;5517.227588137664;23753.287401377813;24895.377615559573;25245.36886577832;25320.366990825194;25359.619605705928;2326.7091613548305;2531.4430825218424;2681.4905168018013;3078.5382192671054;3149.7952633078776;10648.520816563274;11373.033292170176;11416;13624.727505449935;15099.01856379332;1953.794851540582;2036.5519585691125;2038.9286374976805;2049.5081180516568;2070.6997485364686;64310.3568964309;67716.32283677149;67805.66097169582;88807;89638.5518072412;9323.627054917863;11102.555897764161;11532.308061516169;12029.15795894279;12179.086568507397;16418.507444776675;16867.578310542336;16876.493705188863;16919.661606767797;16944.406945757088;8621.09478504748;8758.430702004349;8788.250780175349;8788.956055219684;8938.195562399414;8402.327813774884;8421;8599.957000215085;8612.827743445221;8667.956660216658;5089.9745501272255;5119.283300337956;5128.512791284822;5162.354705661793;5187.325647665779;2107.978920210809;2134.146341463396;2135.8825264610286;2147.1626065834025;2178.583920451719;970.9029097090375;1010.7725761703705;1052.936823790575;1060.8408738689104;1077.3051381858656;20015.799842001685;20155.294564690164;20237.494062648257;20402.59194816125;20489.48776280605;1021.3662263597831;1069.49199130414;1073.393532654048;1083.3824719909576;1118.4854966715238;10927.3989930553;11519.88480115205;11607.432996545527;11675.474603642857;11818.586349477728;488578;497359;498729;499771;501527;54649;93958.53020734852;94867.52566237125;95812;97948.51025744826;966.9516524173763;1003.7942221844651;1039.812833689943;1065.3661071662348;1070.6948519671855;18240;18248.817511824713;18521.259149633865;18765.249390024244;19001.80998190056;43522.56477435185;44218.015854430014;44699.9999999987;45396;46032.76983615194;57823.4217657818;58567.414325856196;58806;61004;62815;12141.332226727614;12448.62654120378;13450.12574182675;13772.586822395344;13969.58091257264;10100.54547545377;14348.784768228275;14770.778438323649;15061.774073389128;15116.168610726516;9034.186923176945;9285.62857485693;9575.856362154434;9713.163300496406;9900.950495247478;9568.665096721581;9603.567839447102;9623.518824058909;9697.175740061892;9743.9025609743;9627.181689556186;9651.227901767983;9705.078017588317;9812.215022798016;9937.006299370005;13404.664883377993;13765.931170344084;13877.583672489842;13892;13943.790843137158;13119.934400327937;13360.465581376637;13467.191968481531;13574.117682350616;13605.251711155586 04:20:07 INFO - PROCESS | 12996 | |3;mootools.html;1482.7479328514148;1539.3842463014794;1693.1534232883557;1802.1077868238347;1849.0569809397202;8578.270846978006;9108.407953483036;9139.360244782867;9151.31365147614;9151.450912945227;7816.374690024799;8147.388945829057;8511.702090426836;8731.825363492726;8740.8688869667;2459.963100553489;2478.330850670318;2479.1818699829105;2489.8630575318352;2497.900083996638;2107.6627739561673;2399.7360290368133;2483.8261321707487;2491.750824917512;2502.687164104487;2121.0561300221407;2403.927882163529;2462.741412151725;2480.776730094291;2488.029668429314;2374.3114496795906;2429.4047958250167;2432.3067925641194;2432.927012189637;2435.2937648082034;2415.9516809663883;2417.6736140620965;2420.056178090546;2421.4309637235237;2424.866632335221;8573.18554737299;8605.913940860573;8667.436616619963;8670.52312122833;8677.783055423602;5282.260483532308;5398.568114550866;5420.376656684453;5535.667859928417;5621.943780562183;3379.8648054077808;3490.5985811631735;3543.5039094526787;3571.0715214044276;3631.4371272452813;1222.3826967381503;1232.0266989078616;1238.851337839456;1248.2635245205372;1273.6433798536425;12669.873301266962;12672.87327126726;12681.809772853414;12714.809277860839;12774.16967897093;4793.616510679138;4880.1215781159735;4904.485029071968;4958.330625365602;4991.126552853236;10641.467926603638;10670.573177072985;10679.73300667474;10690.62582809598;10696.144308455305;5573.080441727069;5573.7770489179975;5576.972115139399;5587.944120558743;5589.385167631557;5070.797168113308;5076.416212135578;5082.669626474268;5145.819896303611;5152.098382782998;4202.621764041251;4258.850940217078;4343.1747967886;4368.060866913565;4375.518692943773;1275.9362031898368;1369.9726005479833;1401.831780186384;1413.7243237568575;1429.371076726258;883.8497455432592;1031.8761748590218;1051.138066785244;1051.8369652703843;1056.6037735849056;6108.602940808833;6108.75564977396;6207.751689932443;6256.4056414641445;6303.401176888188;961.7691753979135;1021.7394564386034;1026.4457193115784;1031.85038169465;1043.796459690353;4284.3145096784365;4336.891577710582;4389.978050109793;4414.55854414556;4479.843205487858;10714.678559643224;11078.781334053248;11089.05743011837;11090.667279981613;11104.555817767361;10982;10987.560497580167;11022.50398732059;11037.558497660164;11052.613158539412;8116.8782468263025;8198.344132469389;8298.460600060977;8321;8329.458585191944;6002.8294482575475;6037;6211.627302361872;6271.184745982993;6323.051542268697;10131.949340253252;10322.174226062047;10400.895991040295;10423.68728938133;10493.108085812792;10007.149392301735;10209.489525523843;10357.68926932163;10510.47447627631;10510.527026283988;7712.421568382281;7728.536287822749;7874;7883.7240696575345;7894.644740986784;8534.189252021048;8576.271016963628;8617.310615150898;8639;8641.438306510057;7554.697812087675;7665.808354791175;7754.573498457639;7776.416768742254;7834.647440865288;7761.9611901940125;7815.960920195363;7846.489978151402;8025.678972841021;8093.150219227132;7272.490925635155;7345.338919497271;7347;7369.594672293076;7379.298966598165;5435.184722291688;5507.614466987273;5534.391216966211;5592.636478628876;5625.766385823235;5235.031519168966;5251.632385732962;5326.97336513315;5365.463453654604;5370.785168593213 04:20:07 INFO - PROCESS | 12996 | |4;prototype.html;334.90622625664815;335.7432900861643;345.47487818515856;345.79079656807613;347.1685313673751;5244.659097158682;5283.260343551901;5358.133398631733;5436.885438485111;5460.372057213422;5170.896582068356;5253.921191182126;5283.916797056594;5298.417174110845;5313.070212712779;4234.851780187694;4235.343521754133;4236.279832428487;4236.5763423657545;4236.872893813191;4149.273877071516;4231.344141658048;4236.322188449849;4237.4491316129015;4241.1093670329265;4188.497380314367;4191.392248124021;4194.78351278129;4206.852760153395;4207.474065741782;4195.098053918407;4199.328107502815;4199.916001679964;4205.285101532716;4213.220554197484;3572.9991204925327;3692.7599706019023;3706.5181526401393;3716.2195938852874;3773.3773927301963;5253.605979551511;5268.683878967274;5280.656757310762;5291.470852914677;5295.364556253236;4817.807287708488;4824.855254342376;4826.662133650646;4827.975860120712;4830.589399901012;5449.656647641513;5593.692346920918;5630.605857589971;5644.463775941279;5647.265855438766;4049.493813273341;4053.5946405359523;4054.189162167578;4063.756174629532;4067.5322337930925;5830.47525722687;5875.6474611523445;5885.970570147165;5891.322497912709;5913.822585322404;3944.546377166605;4087.407325937782;4140.523839758466;4150.730202536825;4172.061286210578;4156.293430116827;4174.45732054837;4177.081042170717;4181.665466762713;4182.393552934807;4763.142634325785;4773.04539092176;4775.331453596499;4791.448983366958;4818.518148185153;5443.564514838803;5621.891790578533;5695.689991302023;5727.914081288784;5748.798792042258;1358.6752915906911;1390.450771945076;1402.0185869891118;1438.5324769449762;1445.2773613193403;962.5716556132454;974.3082411487782;989.3964681544252;989.4508547756064;999.3853779925294;5520.1443776214755;5520.944790552043;5521.861953451115;5528.612997090246;5531.363893152258;5769.423057694197;5772.5959182856795;5786.71066446676;5788.7684492620665;5791.218185544982;5291.708956007456;5477.534409575231;5513.669179849222;5534.308211473566;5543.223948647193;2687.5162470755063;2705;2711.444153948436;2713.1279417202068;2739.2740923655247;5248.685078895202;5252.474752524717;5270.7628156733035;5285.3351194373645;5308.946910530923;5183.844484665466;5597.6641401516035;5980.8803823924145;5994.640321580632;6006.819795406145;6108.72510737009;6121.592033832155;6133.877322453526;6154.815355539341;6157.907631385533;5663.603547751618;5889.204957330706;5907.556933229939;5938.465538101419;5942.909686962842;5837.328707198726;5843.415658434123;5843.883122337445;5845.503132233808;5866.794662186803;6144.201253836973;6145.586515101462;6150.384961503813;6210.472109870711;6218.378162183745;3979.462772525672;4128.483939507561;4162.812673429642;4166.104287578185;4174.311238645711;5642.60501764889;5850.1572004818345;5853.507355624289;5858;5858.619189752652;5587.776488940397;5702.401247868914;5728.312602487728;5744.138379243147;5756.913646295226;5731.312242530923;5741.569382296261;5754.3382511010095;5755.7409916553015;5755.942440575708;5574.386817450159;5606.299842104192;5634.32388113429;5667.291588551431;5708.860126930254;5738.626989245686;5751.194832723506;5756.280464941882;5778.30188679254;5783.277090363705;5487.286652735119;5608.158776183605;5630.408807075198;5630.4369563043365;5645.548356131418 04:20:07 INFO - PROCESS | 12996 | |5;yui.html;775.4649291988528;799.5083023940276;809.514291425145;872.1932212703248;892.0410558649453;15540.300686469107;16446.75329870053;16721.498355049353;16742.079185644783;17720.202590883408;16010.59973500663;16319.51041468755;16348.100854453;16356.591085222875;16399.59001024975;732.9523580967247;752.7892190186757;870.4733636150117;885.4908427654093;892.4243862708549;862.1550880137469;883.5361435246515;886.2289807867132;891.3092353426082;892.1524551675901;939.0421769794805;941.3222479814523;941.4915945389481;941.5339406993547;941.5433514745343;756.1719916691214;776.9766906992743;936.0171819589438;936.3164889630574;936.9437833729997;656.1699450195506;673.1148539670318;674.7301079568163;675.5507587454337;676.0467740485891;16006.359745610162;16022.519324420286;16049.117298548575;16054.438094666748;16055.197240138063;14999.100053996686;15348;15442.691146177014;15487.845121548753;15547.689046219126;13383.665408364772;13594.184348939096;13722.588322350346;13759.656008599764;14052.437902483991;4545.5908968193025;4711.175544279771;4744.359511465942;4803.471618122004;4817.638677099231;86509.56745216297;86862;87770;89607;90118.5494072532;11668.591599293984;11702.2978621283;11930.926216640544;11961.581344652895;12008;23397.883010585178;23551.411214719425;23571.17500887495;23660;23713.7628623715;8968.327375446737;8969.910300897038;8973.596188171548;8987.685431010013;9155.22180614642;4976.950230497649;5040.722760248148;5103;5190.636655434083;5301.496357846076;3446.7931924084132;3572.517710109154;3579.19468119671;3579.319929213493;3664.3770559005034;572.098944162945;583.6760597868224;587.3832475900288;590.7046476761619;606.130203158469;690.413148823506;731.8353370491596;739.737393225408;751.3500821789113;755.8374949385908;9301.90698093024;9762.560684769202;9939.900600993897;10013.249006324555;10048.346857454242;697.1216267502983;718.4539749790197;738.7783664900509;740.0564280542352;754.5095687802863;4694.248920172756;4710.882227944328;4781.641376896747;4814.975925120352;4852.126617208865;88615.55692221626;129081;140705;141282;141364;117693.41153294178;118011;120228.39885800515;120603;120630.05144191765;101213.49393253133;102717;104598;104626;107946;8615.82768344617;8706.47761134334;8798.47209167452;8960.955195223982;9030;57265;58758.70620646869;60067.39932600618;60167;61472.69263653653;84259.68052396218;90519.5474022652;91240.5437972806;91986;92901;11841.855729785013;11994.460249288628;12029.939850300692;12127.211731237441;12166.57416990401;12755.234685918875;12773.169743966613;12805.423755930819;12932.612021639367;13458.798118028433;11982.161248712506;12182.573609923611;12298.938505307775;12366.690832729253;12456.688582785502;12118.939405302917;12318.815217771562;12332.876671233173;12457.563985260473;12537.749245015231;11533.135014874086;11780.293182409083;12067.75864482688;12144.33206173669;12556.43496042662;10375.16998640122;10566.894331056592;10734.477397811352;11037.227394082338;11103.111751060058;10240.748820053253;10586.153107751208;10596.947015265183;10612.946935265274;10633.734156646145 04:20:07 INFO - PROCESS | 12996 | __end_tp_report 04:20:07 INFO - PROCESS | 12996 | __start_cc_report 04:20:07 INFO - PROCESS | 12996 | _x_x_mozilla_cycle_collect,810 04:20:07 INFO - PROCESS | 12996 | __end_cc_report 04:20:07 INFO - PROCESS | 12996 | __startTimestamp1476789607892__endTimestamp 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | ------- Summary: start ------- 04:20:07 INFO - PROCESS | 12996 | Number of tests: 6 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | [#0] dojo.html Cycles:165 Average:5333.34 Median:5552.64 stddev:586.11 (10.6%) stddev-sans-first:560.86 04:20:07 INFO - PROCESS | 12996 | Values: 3089.7 3121.4 3134.9 3156.0 3178.2 5354.5 5383.2 5385.2 5394.7 5412.3 5458.5 5475.2 5476.6 5490.7 5491.1 4933.9 4948.2 4989.6 5011.9 5020.2 4786.8 4967.8 5027.8 5034.8 5060.1 4757.2 4841.9 4859.1 4885.0 4913.6 4863.5 4900.8 4906.3 4966.8 4990.5 4893.3 4906.4 4909.8 4935.5 4937.6 5220.8 5310.7 5319.3 5347.5 5365.0 5675.5 5697.2 5706.2 5767.3 5785.1 5827.7 5828.0 5842.1 5856.4 5859.9 5271.2 5277.2 5285.1 5311.6 5312.2 5777.9 5801.9 5817.6 5818.2 5818.3 5580.8 5600.7 5601.8 5602.4 5607.2 5552.6 5584.7 5647.5 5689.4 5690.7 5715.1 5725.0 5729.9 5730.7 5758.6 5724.9 5727.4 5727.7 5728.7 5759.0 4372.8 4378.8 4387.1 4398.0 4404.0 3948.4 3970.4 3985.8 3992.8 3998.6 5424.3 5465.5 5471.1 5486.6 5490.1 5634.7 5667.2 5683.1 5749.0 5789.3 5424.3 5490.9 5491.7 5514.4 5524.5 4934.8 4938.9 4942.6 4949.6 4976.9 5832.7 5834.6 5993.8 5995.6 5996.3 5607.7 5675.3 5683.8 5708.9 5768.6 5959.9 5966.1 5966.8 5974.7 5974.8 5474.2 5607.9 5612.3 5613.5 5616.6 5580.4 5584.9 5597.1 5650.3 5728.5 5559.9 5568.6 5569.9 5572.2 5572.9 5535.8 5566.4 5582.0 5593.8 5597.0 5443.9 5491.0 5539.4 5560.4 5593.7 5684.1 5691.8 5696.1 5704.2 5735.4 5371.2 5528.3 5567.6 5567.9 5580.1 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | [#1] ext.html Cycles:180 Average:63964.13 Median:211798.24 stddev:127001.27 (60.0%) stddev-sans-first:127268.42 04:20:07 INFO - PROCESS | 12996 | Values: 592.6 613.5 652.2 657.4 658.3 32186.8 35323.3 35466.3 35513.8 35586.5 45972.3 47034.5 47126.8 50218.7 50344.0 9058.4 9316.3 9328.8 9329.6 9337.4 8612.7 8801.2 9112.4 9221.5 9224.4 11215.4 11421.5 11428.4 11779.1 11784.1 11185.0 11253.2 11267.9 11276.0 11283.7 11209.6 11251.5 11284.7 11296.4 11297.3 44690.0 45027.8 45082.0 45091.3 45134.3 3843.1 3897.4 3969.4 3979.4 4188.5 33956.8 34352.7 34407.1 34420.3 34653.0 4560.7 4595.3 4626.5 4662.1 4769.3 380620.0 381534.0 382219.0 382721.0 383005.0 61217.0 61404.7 61669.4 61678.7 61688.4 40183.4 40928.4 41165.0 43057.1 43062.1 17813.6 17904.9 17919.6 18002.3 18008.9 13782.6 13876.6 13888.6 13904.9 13905.4 18124.7 18376.4 19813.5 20174.3 20424.5 7257.8 7572.7 7653.9 7674.9 7794.2 995.5 998.0 1010.5 1034.1 1103.0 33939.0 33959.3 34223.5 34399.7 34442.0 1069.0 1125.8 1132.1 1168.0 1238.2 17810.9 17904.1 17992.5 18025.8 18109.0 571074.0 574454.0 574733.0 576535.0 577287.0 60149.0 60446.4 60495.4 60499.4 60592.0 1287.5 1304.8 1407.3 1455.7 1467.7 33746.3 35230.0 35335.5 35537.3 35544.5 52880.4 53317.0 53513.5 53535.5 53557.2 419408.0 421504.0 423898.0 505558.0 522979.0 43286.6 43611.8 43965.6 44458.3 46035.5 50317.5 51295.7 51873.7 51968.7 52010.0 43285.0 43785.1 43892.0 44737.3 44874.3 43677.0 44162.0 44457.6 44859.8 45557.8 43053.6 43882.0 44204.3 44271.0 44571.0 37320.1 38501.6 39237.8 39689.0 39740.6 28973.4 29132.0 29412.1 29688.9 29884.7 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | [#2] jquery.html Cycles:180 Average:29567.57 Median:3114.17 stddev:81756.86 (2625.3%) stddev-sans-first:81956.87 04:20:07 INFO - PROCESS | 12996 | Values: 394.9 434.6 436.7 438.8 439.6 16616.5 21179.8 21461.8 21696.6 22283.1 17072.5 17082.2 17090.5 17125.2 17225.7 5960.6 5972.9 6178.4 6201.9 6236.4 6112.7 6186.1 6193.8 6196.4 6201.9 5938.3 6115.1 6138.4 6143.0 6152.2 5927.9 6121.6 6150.0 6169.7 6173.0 5472.2 5512.0 5514.8 5516.3 5517.2 23753.3 24895.4 25245.4 25320.4 25359.6 2326.7 2531.4 2681.5 3078.5 3149.8 10648.5 11373.0 11416.0 13624.7 15099.0 1953.8 2036.6 2038.9 2049.5 2070.7 64310.4 67716.3 67805.7 88807.0 89638.6 9323.6 11102.6 11532.3 12029.2 12179.1 16418.5 16867.6 16876.5 16919.7 16944.4 8621.1 8758.4 8788.3 8789.0 8938.2 8402.3 8421.0 8600.0 8612.8 8668.0 5090.0 5119.3 5128.5 5162.4 5187.3 2108.0 2134.1 2135.9 2147.2 2178.6 970.9 1010.8 1052.9 1060.8 1077.3 20015.8 20155.3 20237.5 20402.6 20489.5 1021.4 1069.5 1073.4 1083.4 1118.5 10927.4 11519.9 11607.4 11675.5 11818.6 488578.0 497359.0 498729.0 499771.0 501527.0 54649.0 93958.5 94867.5 95812.0 97948.5 967.0 1003.8 1039.8 1065.4 1070.7 18240.0 18248.8 18521.3 18765.2 19001.8 43522.6 44218.0 44700.0 45396.0 46032.8 57823.4 58567.4 58806.0 61004.0 62815.0 12141.3 12448.6 13450.1 13772.6 13969.6 10100.5 14348.8 14770.8 15061.8 15116.2 9034.2 9285.6 9575.9 9713.2 9901.0 9568.7 9603.6 9623.5 9697.2 9743.9 9627.2 9651.2 9705.1 9812.2 9937.0 13404.7 13765.9 13877.6 13892.0 13943.8 13119.9 13360.5 13467.2 13574.1 13605.3 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | [#3] mootools.html Cycles:180 Average:5963.59 Median:4402.27 stddev:3307.91 (75.1%) stddev-sans-first:3300.05 04:20:07 INFO - PROCESS | 12996 | Values: 1482.7 1539.4 1693.2 1802.1 1849.1 8578.3 9108.4 9139.4 9151.3 9151.5 7816.4 8147.4 8511.7 8731.8 8740.9 2460.0 2478.3 2479.2 2489.9 2497.9 2107.7 2399.7 2483.8 2491.8 2502.7 2121.1 2403.9 2462.7 2480.8 2488.0 2374.3 2429.4 2432.3 2432.9 2435.3 2416.0 2417.7 2420.1 2421.4 2424.9 8573.2 8605.9 8667.4 8670.5 8677.8 5282.3 5398.6 5420.4 5535.7 5621.9 3379.9 3490.6 3543.5 3571.1 3631.4 1222.4 1232.0 1238.9 1248.3 1273.6 12669.9 12672.9 12681.8 12714.8 12774.2 4793.6 4880.1 4904.5 4958.3 4991.1 10641.5 10670.6 10679.7 10690.6 10696.1 5573.1 5573.8 5577.0 5587.9 5589.4 5070.8 5076.4 5082.7 5145.8 5152.1 4202.6 4258.9 4343.2 4368.1 4375.5 1275.9 1370.0 1401.8 1413.7 1429.4 883.8 1031.9 1051.1 1051.8 1056.6 6108.6 6108.8 6207.8 6256.4 6303.4 961.8 1021.7 1026.4 1031.9 1043.8 4284.3 4336.9 4390.0 4414.6 4479.8 10714.7 11078.8 11089.1 11090.7 11104.6 10982.0 10987.6 11022.5 11037.6 11052.6 8116.9 8198.3 8298.5 8321.0 8329.5 6002.8 6037.0 6211.6 6271.2 6323.1 10131.9 10322.2 10400.9 10423.7 10493.1 10007.1 10209.5 10357.7 10510.5 10510.5 7712.4 7728.5 7874.0 7883.7 7894.6 8534.2 8576.3 8617.3 8639.0 8641.4 7554.7 7665.8 7754.6 7776.4 7834.6 7762.0 7816.0 7846.5 8025.7 8093.2 7272.5 7345.3 7347.0 7369.6 7379.3 5435.2 5507.6 5534.4 5592.6 5625.8 5235.0 5251.6 5327.0 5365.5 5370.8 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | [#4] prototype.html Cycles:180 Average:4754.63 Median:5440.22 stddev:1420.02 (26.1%) stddev-sans-first:1384.71 04:20:07 INFO - PROCESS | 12996 | Values: 334.9 335.7 345.5 345.8 347.2 5244.7 5283.3 5358.1 5436.9 5460.4 5170.9 5253.9 5283.9 5298.4 5313.1 4234.9 4235.3 4236.3 4236.6 4236.9 4149.3 4231.3 4236.3 4237.4 4241.1 4188.5 4191.4 4194.8 4206.9 4207.5 4195.1 4199.3 4199.9 4205.3 4213.2 3573.0 3692.8 3706.5 3716.2 3773.4 5253.6 5268.7 5280.7 5291.5 5295.4 4817.8 4824.9 4826.7 4828.0 4830.6 5449.7 5593.7 5630.6 5644.5 5647.3 4049.5 4053.6 4054.2 4063.8 4067.5 5830.5 5875.6 5886.0 5891.3 5913.8 3944.5 4087.4 4140.5 4150.7 4172.1 4156.3 4174.5 4177.1 4181.7 4182.4 4763.1 4773.0 4775.3 4791.4 4818.5 5443.6 5621.9 5695.7 5727.9 5748.8 1358.7 1390.5 1402.0 1438.5 1445.3 962.6 974.3 989.4 989.5 999.4 5520.1 5520.9 5521.9 5528.6 5531.4 5769.4 5772.6 5786.7 5788.8 5791.2 5291.7 5477.5 5513.7 5534.3 5543.2 2687.5 2705.0 2711.4 2713.1 2739.3 5248.7 5252.5 5270.8 5285.3 5308.9 5183.8 5597.7 5980.9 5994.6 6006.8 6108.7 6121.6 6133.9 6154.8 6157.9 5663.6 5889.2 5907.6 5938.5 5942.9 5837.3 5843.4 5843.9 5845.5 5866.8 6144.2 6145.6 6150.4 6210.5 6218.4 3979.5 4128.5 4162.8 4166.1 4174.3 5642.6 5850.2 5853.5 5858.0 5858.6 5587.8 5702.4 5728.3 5744.1 5756.9 5731.3 5741.6 5754.3 5755.7 5755.9 5574.4 5606.3 5634.3 5667.3 5708.9 5738.6 5751.2 5756.3 5778.3 5783.3 5487.3 5608.2 5630.4 5630.4 5645.5 04:20:07 INFO - PROCESS | 12996 | 04:20:07 INFO - PROCESS | 12996 | [#5] yui.html Cycles:180 Average:23306.36 Median:4104.98 stddev:35512.26 (865.1%) stddev-sans-first:35571.59 04:20:07 INFO - PROCESS | 12996 | Values: 775.5 799.5 809.5 872.2 892.0 15540.3 16446.8 16721.5 16742.1 17720.2 16010.6 16319.5 16348.1 16356.6 16399.6 733.0 752.8 870.5 885.5 892.4 862.2 883.5 886.2 891.3 892.2 939.0 941.3 941.5 941.5 941.5 756.2 777.0 936.0 936.3 936.9 656.2 673.1 674.7 675.6 676.0 16006.4 16022.5 16049.1 16054.4 16055.2 14999.1 15348.0 15442.7 15487.8 15547.7 13383.7 13594.2 13722.6 13759.7 14052.4 4545.6 4711.2 4744.4 4803.5 4817.6 86509.6 86862.0 87770.0 89607.0 90118.5 11668.6 11702.3 11930.9 11961.6 12008.0 23397.9 23551.4 23571.2 23660.0 23713.8 8968.3 8969.9 8973.6 8987.7 9155.2 4977.0 5040.7 5103.0 5190.6 5301.5 3446.8 3572.5 3579.2 3579.3 3664.4 572.1 583.7 587.4 590.7 606.1 690.4 731.8 739.7 751.4 755.8 9301.9 9762.6 9939.9 10013.2 10048.3 697.1 718.5 738.8 740.1 754.5 4694.2 4710.9 4781.6 4815.0 4852.1 88615.6 129081.0 140705.0 141282.0 141364.0 117693.4 118011.0 120228.4 120603.0 120630.1 101213.5 102717.0 104598.0 104626.0 107946.0 8615.8 8706.5 8798.5 8961.0 9030.0 57265.0 58758.7 60067.4 60167.0 61472.7 84259.7 90519.5 91240.5 91986.0 92901.0 11841.9 11994.5 12029.9 12127.2 12166.6 12755.2 12773.2 12805.4 12932.6 13458.8 11982.2 12182.6 12298.9 12366.7 12456.7 12118.9 12318.8 12332.9 12457.6 12537.7 11533.1 11780.3 12067.8 12144.3 12556.4 10375.2 10566.9 10734.5 11037.2 11103.1 10240.7 10586.2 10596.9 10612.9 10633.7 04:20:07 INFO - PROCESS | 12996 | -------- Summary: end -------- 04:20:07 INFO - PROCESS | 12996 | 04:20:08 INFO - TEST-INFO | 12996: exit 0 04:20:08 INFO - TEST-OK | dromaeo_css | took 1113384ms 04:20:08 INFO - TEST-START | kraken 04:20:08 INFO - operating with platform_type : linux_ 04:20:08 INFO - Initialising browser for kraken test... 04:20:08 INFO - TEST-INFO | started process 13314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCFpAWd/profile http://localhost:41860/getInfo.html) 04:20:12 INFO - PROCESS | 13314 | __metrics Screen width/height:1600/1200 04:20:12 INFO - PROCESS | 13314 | colorDepth:24 04:20:12 INFO - PROCESS | 13314 | Browser inner width/height: 1024/697 04:20:12 INFO - PROCESS | 13314 | __metrics 04:20:13 INFO - PROCESS | 13314 | 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" 04:20:13 INFO - PROCESS | 13314 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:20:13 INFO - PROCESS | 13314 | console.error: PushService: 04:20:13 INFO - PROCESS | 13314 | stateChangeProcessEnqueue: Error transitioning state 04:20:13 INFO - PROCESS | 13314 | UnknownError 04:20:14 INFO - TEST-INFO | 13314: exit 0 04:20:14 INFO - Browser initialized. 04:20:14 INFO - Running cycle 1/1 for kraken test... 04:20:14 INFO - TEST-INFO | started process 13404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCFpAWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:26 INFO - PROCESS | 13404 | RSS: Main: 144785408 04:20:26 INFO - PROCESS | 13404 | 04:20:28 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:29 INFO - PROCESS | 13404 | RSS: Main: 186322944 04:20:29 INFO - PROCESS | 13404 | 04:20:31 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-dft) 04:20:32 INFO - PROCESS | 13404 | RSS: Main: 175374336 04:20:32 INFO - PROCESS | 13404 | 04:20:35 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-fft) 04:20:35 INFO - PROCESS | 13404 | RSS: Main: 266510336 04:20:35 INFO - PROCESS | 13404 | 04:20:38 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-oscillator) 04:20:38 INFO - PROCESS | 13404 | RSS: Main: 172830720 04:20:38 INFO - PROCESS | 13404 | 04:20:40 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:41 INFO - PROCESS | 13404 | RSS: Main: 175165440 04:20:41 INFO - PROCESS | 13404 | 04:20:44 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41860/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:44 INFO - PROCESS | 13404 | RSS: Main: 210505728 04:20:44 INFO - PROCESS | 13404 | 04:20:48 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41860/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:48 INFO - PROCESS | 13404 | RSS: Main: 209489920 04:20:48 INFO - PROCESS | 13404 | 04:20:51 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41860/tests/kraken/driver.html?testName=json-parse-financial) 04:20:52 INFO - PROCESS | 13404 | RSS: Main: 209846272 04:20:52 INFO - PROCESS | 13404 | 04:20:53 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:54 INFO - PROCESS | 13404 | RSS: Main: 171323392 04:20:54 INFO - PROCESS | 13404 | 04:20:55 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:56 INFO - PROCESS | 13404 | RSS: Main: 179101696 04:20:56 INFO - PROCESS | 13404 | 04:20:58 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:59 INFO - PROCESS | 13404 | RSS: Main: 188260352 04:20:59 INFO - PROCESS | 13404 | 04:21:01 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:02 INFO - PROCESS | 13404 | RSS: Main: 197050368 04:21:02 INFO - PROCESS | 13404 | 04:21:04 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:05 INFO - PROCESS | 13404 | RSS: Main: 192937984 04:21:05 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41860/tests/kraken/driver.html?testName=ai-astar) 04:21:07 INFO - PROCESS | 13404 | RSS: Main: 244973568 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | __start_tp_report 04:21:07 INFO - PROCESS | 13404 | _x_x_mozilla_page_load 04:21:07 INFO - PROCESS | 13404 | _x_x_mozilla_page_load_details 04:21:07 INFO - PROCESS | 13404 | |i|pagename|runs| 04:21:07 INFO - PROCESS | 13404 | |0;ai-astar;108;112;110;111;112;110;111;110;112;110 04:21:07 INFO - PROCESS | 13404 | |1;audio-beat-detection;148;119;116;159;117;119;118;120;142;117 04:21:07 INFO - PROCESS | 13404 | |2;audio-dft;161;161;160;162;162;176;161;160;162;161 04:21:07 INFO - PROCESS | 13404 | |3;audio-fft;76;75;74;104;75;76;76;75;111;76 04:21:07 INFO - PROCESS | 13404 | |4;audio-oscillator;81;83;116;80;81;80;109;81;81;113 04:21:07 INFO - PROCESS | 13404 | |5;imaging-gaussian-blur;117;117;118;116;117;117;117;117;116;116 04:21:07 INFO - PROCESS | 13404 | |6;imaging-darkroom;146;146;145;146;147;146;146;147;146;147 04:21:07 INFO - PROCESS | 13404 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;96;95 04:21:07 INFO - PROCESS | 13404 | |8;json-parse-financial;48;49;49;50;49;50;49;50;50;49 04:21:07 INFO - PROCESS | 13404 | |9;json-stringify-tinderbox;59;58;58;59;58;59;58;59;59;58 04:21:07 INFO - PROCESS | 13404 | |10;stanford-crypto-aes;73;76;73;77;80;74;73;73;78;73 04:21:07 INFO - PROCESS | 13404 | |11;stanford-crypto-ccm;121;121;130;130;125;119;119;120;163;119 04:21:07 INFO - PROCESS | 13404 | |12;stanford-crypto-pbkdf2;154;154;151;152;153;152;153;153;153;156 04:21:07 INFO - PROCESS | 13404 | |13;stanford-crypto-sha256-iterative;63;63;62;62;62;63;61;62;64;61 04:21:07 INFO - PROCESS | 13404 | __end_tp_report 04:21:07 INFO - PROCESS | 13404 | __start_cc_report 04:21:07 INFO - PROCESS | 13404 | _x_x_mozilla_cycle_collect,1580 04:21:07 INFO - PROCESS | 13404 | __end_cc_report 04:21:07 INFO - PROCESS | 13404 | __startTimestamp1476789667433__endTimestamp 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | ------- Summary: start ------- 04:21:07 INFO - PROCESS | 13404 | Number of tests: 14 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.26 (1.1%) stddev-sans-first:0.93 04:21:07 INFO - PROCESS | 13404 | Values: 108.0 112.0 110.0 111.0 112.0 110.0 111.0 110.0 112.0 110.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:119.50 stddev:15.87 (13.3%) stddev-sans-first:15.00 04:21:07 INFO - PROCESS | 13404 | Values: 148.0 119.0 116.0 159.0 117.0 119.0 118.0 120.0 142.0 117.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#2] audio-dft Cycles:10 Average:162.60 Median:161.50 stddev:4.77 (3.0%) stddev-sans-first:5.02 04:21:07 INFO - PROCESS | 13404 | Values: 161.0 161.0 160.0 162.0 162.0 176.0 161.0 160.0 162.0 161.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.66 (18.1%) stddev-sans-first:14.33 04:21:07 INFO - PROCESS | 13404 | Values: 76.0 75.0 74.0 104.0 75.0 76.0 76.0 75.0 111.0 76.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.00 stddev:15.41 (19.0%) stddev-sans-first:15.95 04:21:07 INFO - PROCESS | 13404 | Values: 81.0 83.0 116.0 80.0 81.0 80.0 109.0 81.0 81.0 113.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:21:07 INFO - PROCESS | 13404 | Values: 117.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:21:07 INFO - PROCESS | 13404 | Values: 146.0 146.0 145.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:21:07 INFO - PROCESS | 13404 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.50 stddev:0.67 (1.4%) stddev-sans-first:0.53 04:21:07 INFO - PROCESS | 13404 | Values: 48.0 49.0 49.0 50.0 49.0 50.0 49.0 50.0 50.0 49.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 04:21:07 INFO - PROCESS | 13404 | Values: 59.0 58.0 58.0 59.0 58.0 59.0 58.0 59.0 59.0 58.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:2.58 (3.4%) stddev-sans-first:2.64 04:21:07 INFO - PROCESS | 13404 | Values: 73.0 76.0 73.0 77.0 80.0 74.0 73.0 73.0 78.0 73.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:123.00 stddev:13.46 (10.9%) stddev-sans-first:14.12 04:21:07 INFO - PROCESS | 13404 | Values: 121.0 121.0 130.0 130.0 125.0 119.0 119.0 120.0 163.0 119.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:153.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 04:21:07 INFO - PROCESS | 13404 | Values: 154.0 154.0 151.0 152.0 153.0 152.0 153.0 153.0 153.0 156.0 04:21:07 INFO - PROCESS | 13404 | 04:21:07 INFO - PROCESS | 13404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 04:21:07 INFO - PROCESS | 13404 | Values: 63.0 63.0 62.0 62.0 62.0 63.0 61.0 62.0 64.0 61.0 04:21:07 INFO - PROCESS | 13404 | -------- Summary: end -------- 04:21:07 INFO - PROCESS | 13404 | 04:21:08 INFO - TEST-INFO | 13404: exit 0 04:21:08 INFO - TEST-OK | kraken | took 59867ms 04:21:08 INFO - SUITE-END | took 1173s 04:21:08 INFO - Completed test suite (00:19:33) 04:21:08 INFO - javascript benchmark 04:21:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.706477884601, 3121.3757248550282, 3134.8746050157993, 3156.0216332936775, 3178.2054486378406, 5354.518093371596, 5383.219433182187, 5385.246065550826, 5394.676319420828, 5412.323459567554, 5458.536024437927, 5475.178723191523, 5476.58925580581, 5490.725463726808, 5491.148871924848, 4933.876653083675, 4948.183549714293, 4989.625778066641, 5011.949880501184, 5020.196768517038, 4786.83246086387, 4967.751612419383, 5027.798888044492, 5034.84895453137, 5060.11447996601, 4757.238841785315, 4841.927371089437, 4859.076775412678, 4885.0, 4913.582345500618, 4863.537963893425, 4900.803967841282, 4906.264060390934, 4966.776495057731, 4990.476000019982, 4893.290472881412, 4906.435759887623, 4909.7790599423115, 4935.481774413671, 4937.555619994182, 5220.817271395483, 5310.734463276859, 5319.281896943901, 5347.54545863602, 5365.03429382711, 5675.460831221028, 5697.202391665171, 5706.229658996024, 5767.279090113736, 5785.074388097926, 5827.737751801137, 5828.0, 5842.123681447774, 5856.414358564152, 5859.941400585983, 5271.209318602202, 5277.155655095166, 5285.07511185541, 5311.601629877736, 5312.229726689686, 5777.913331300034, 5801.854953626109, 5817.563682723728, 5818.21454103699, 5818.272715910512, 5580.776768929279, 5600.747966341524, 5601.7759289628775, 5602.355729091207, 5607.214989901417, 5552.639078459887, 5584.664920104726, 5647.463490968352, 5689.374168841424, 5690.6870122142855, 5715.085586306171, 5725.0267454531995, 5729.914051289234, 5730.7421166047625, 5758.62568933018, 5724.942750572441, 5727.3699893011735, 5727.742251598688, 5728.742206600713, 5758.971205144031, 4372.846950356722, 4378.824847006148, 4387.056782791715, 4398.010447649253, 4404.031113155101, 3948.368261078214, 3970.404439334065, 3985.7807820570147, 3992.8203230854683, 3998.620131087542, 5424.267723857308, 5465.508104270635, 5471.06991811393, 5486.61593688438, 5490.066688662937, 5634.746436410372, 5667.234923285386, 5683.090705487102, 5749.0, 5789.2763404574425, 5424.294841670637, 5490.945090549123, 5491.7254137292975, 5514.36584792754, 5524.475174858382, 4934.827281045218, 4938.9012219755405, 4942.604591632661, 4949.628777841676, 4976.925346119811, 5832.650040997553, 5834.620749651259, 5993.760249589967, 5995.580309378389, 5996.280446346466, 5607.747651355618, 5675.262215911905, 5683.77264909399, 5708.8572785679025, 5768.596198266081, 5959.880802384015, 5966.105084237225, 5966.791162309299, 5974.671393073423, 5974.820755377345, 5474.178873169057, 5607.943920560905, 5612.326520817364, 5613.46672066153, 5616.634918730269, 5580.441955804549, 5584.916226256528, 5597.076482380525, 5650.29371328584, 5728.484436400744, 5559.916601250903, 5568.610197286151, 5569.8607534810335, 5572.247746554163, 5572.86067848307, 5535.7785688572, 5566.443355664401, 5582.0231459495235, 5593.804216852391, 5596.960908133254, 5443.918341224806, 5491.039068162976, 5539.390667026543, 5560.443955604407, 5593.720313984366, 5684.147377893349, 5691.8292451226525, 5696.145578163143, 5704.201411802268, 5735.3977832327, 5371.248025276386, 5528.308961379827, 5567.610267281251, 5567.860803479945, 5580.079286917613], "value": 5294.920234654297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5733471900234, 613.460155063544, 652.1977967100466, 657.3722095398895, 658.321928413734, 32186.839065804666, 35323.293534129305, 35466.29067418653, 35513.82243088787, 35586.46620300691, 45972.310415343796, 47034.529654703445, 47126.764366178206, 50218.748906255416, 50344.0, 9058.411203271782, 9316.301277404187, 9328.813423731555, 9329.580168892417, 9337.439753614772, 8612.655493780241, 8801.163889430494, 9112.407693499934, 9221.53892305382, 9224.354295199339, 11215.38315392653, 11421.54313827446, 11428.428578571038, 11779.057675385991, 11784.057275417988, 11185.049270811951, 11253.156013299036, 11267.887321126766, 11276.0, 11283.717907052349, 11209.551617935273, 11251.493682784294, 11284.717882052932, 11296.378699171542, 11297.26567773092, 44690.0, 45027.77486112549, 45082.0, 45091.323630145576, 45134.322985155246, 3843.0584506795735, 3897.3569361055393, 3969.4442778011103, 3979.422983667352, 4188.486883003854, 33956.83021584901, 34352.65647343545, 34407.13982150441, 34420.31159376798, 34653.0, 4560.657950653715, 4595.264757638762, 4626.467956185048, 4662.114198302312, 4769.308450274691, 380620.0, 381534.0, 382219.0, 382721.0, 383005.0, 61217.0, 61404.69297653573, 61669.38330616726, 61678.69160654168, 61688.38311616916, 40183.397249041285, 40928.38607420891, 41165.0, 43057.13885722268, 43062.13875722468, 17813.554661133316, 17904.91047544754, 17919.641607168043, 18002.279908803765, 18008.909955450137, 13782.586522404345, 13876.58370248894, 13888.583342499742, 13904.930475347559, 13905.4437822488, 18124.728129078074, 18376.356827510972, 19813.504662383555, 20174.29389971344, 20424.489387765425, 7257.782266532013, 7572.734954276574, 7653.885191722128, 7674.884876726854, 7794.22057794216, 995.4773743784426, 997.9950100249453, 1010.5402042070987, 1034.1468288661733, 1102.9944850275697, 33939.0, 33959.32081358359, 34223.4866477003, 34399.65600344015, 34442.0, 1068.951897164614, 1125.7523344864117, 1132.0547342968548, 1167.976640467203, 1238.182799352423, 17810.91094544519, 17904.10479476021, 17992.460226193234, 18025.819741802676, 18109.0, 571074.0, 574454.0, 574733.0, 576535.0, 577287.0, 60149.0, 60446.395536044074, 60495.39504604986, 60499.395006050254, 60592.0, 1287.4914408808468, 1304.7520971015476, 1407.2541552976938, 1455.6943041961306, 1467.699121680053, 33746.32507349888, 35230.0, 35335.469967951016, 35537.28925421529, 35544.46683299701, 52880.41358759243, 53317.0, 53513.46486535085, 53535.46464535461, 53557.196642049625, 419408.0, 421504.0, 423898.0, 505558.0, 522979.0, 43286.56713432825, 43611.78194109009, 43965.560344396145, 44458.3331250025, 46035.53964460446, 50317.496825032744, 51295.74352128216, 51873.740631296605, 51968.740156298976, 52010.0, 43285.0, 43785.12429751323, 43892.0, 44737.328940066574, 44874.326885096096, 43677.0, 44162.0, 44457.555424445345, 44859.77570112129, 45557.772211138734, 43053.56946430621, 43882.0, 44204.33693494536, 44271.0, 44571.0, 37320.06699832526, 38501.6149838498, 39237.80381098076, 39689.0, 39740.602593973694, 28973.420531589672, 29132.0, 29412.056021077373, 29688.851555742083, 29884.701152989062], "value": 21480.72136012799, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.91509325495014, 434.5806296923469, 436.67031391299565, 438.7762241256958, 439.6175327465104, 16616.501504954857, 21179.788202117976, 21461.785382146172, 21696.566068678618, 22283.108675652995, 17072.487825365228, 17082.231299591516, 17090.487285381427, 17125.229364678587, 17225.655486890253, 5960.612560183596, 5972.9402705972925, 6178.41305076017, 6201.937980620181, 6236.407541283571, 6112.6638034908065, 6186.072089186613, 6193.845153871144, 6196.380361963813, 6201.906971395432, 5938.287405511323, 6115.1438798568015, 6138.386161383871, 6143.017117261239, 6152.169457123276, 5927.9407205928255, 6121.632702037869, 6150.04674275488, 6169.722362493699, 6173.0, 5472.206530053159, 5512.0, 5514.751836167382, 5516.282883225195, 5517.227588137664, 23753.287401377813, 24895.377615559573, 25245.36886577832, 25320.366990825194, 25359.619605705928, 2326.7091613548305, 2531.4430825218424, 2681.4905168018013, 3078.5382192671054, 3149.7952633078776, 10648.520816563274, 11373.033292170176, 11416.0, 13624.727505449935, 15099.01856379332, 1953.794851540582, 2036.5519585691125, 2038.9286374976805, 2049.5081180516568, 2070.6997485364686, 64310.3568964309, 67716.32283677149, 67805.66097169582, 88807.0, 89638.5518072412, 9323.627054917863, 11102.555897764161, 11532.308061516169, 12029.15795894279, 12179.086568507397, 16418.507444776675, 16867.578310542336, 16876.493705188863, 16919.661606767797, 16944.406945757088, 8621.09478504748, 8758.430702004349, 8788.250780175349, 8788.956055219684, 8938.195562399414, 8402.327813774884, 8421.0, 8599.957000215085, 8612.827743445221, 8667.956660216658, 5089.9745501272255, 5119.283300337956, 5128.512791284822, 5162.354705661793, 5187.325647665779, 2107.978920210809, 2134.146341463396, 2135.8825264610286, 2147.1626065834025, 2178.583920451719, 970.9029097090375, 1010.7725761703705, 1052.936823790575, 1060.8408738689104, 1077.3051381858656, 20015.799842001685, 20155.294564690164, 20237.494062648257, 20402.59194816125, 20489.48776280605, 1021.3662263597831, 1069.49199130414, 1073.393532654048, 1083.3824719909576, 1118.4854966715238, 10927.3989930553, 11519.88480115205, 11607.432996545527, 11675.474603642857, 11818.586349477728, 488578.0, 497359.0, 498729.0, 499771.0, 501527.0, 54649.0, 93958.53020734852, 94867.52566237125, 95812.0, 97948.51025744826, 966.9516524173763, 1003.7942221844651, 1039.812833689943, 1065.3661071662348, 1070.6948519671855, 18240.0, 18248.817511824713, 18521.259149633865, 18765.249390024244, 19001.80998190056, 43522.56477435185, 44218.015854430014, 44699.9999999987, 45396.0, 46032.76983615194, 57823.4217657818, 58567.414325856196, 58806.0, 61004.0, 62815.0, 12141.332226727614, 12448.62654120378, 13450.12574182675, 13772.586822395344, 13969.58091257264, 10100.54547545377, 14348.784768228275, 14770.778438323649, 15061.774073389128, 15116.168610726516, 9034.186923176945, 9285.62857485693, 9575.856362154434, 9713.163300496406, 9900.950495247478, 9568.665096721581, 9603.567839447102, 9623.518824058909, 9697.175740061892, 9743.9025609743, 9627.181689556186, 9651.227901767983, 9705.078017588317, 9812.215022798016, 9937.006299370005, 13404.664883377993, 13765.931170344084, 13877.583672489842, 13892.0, 13943.790843137158, 13119.934400327937, 13360.465581376637, 13467.191968481531, 13574.117682350616, 13605.251711155586], "value": 9760.62197378683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.7479328514148, 1539.3842463014794, 1693.1534232883557, 1802.1077868238347, 1849.0569809397202, 8578.270846978006, 9108.407953483036, 9139.360244782867, 9151.31365147614, 9151.450912945227, 7816.374690024799, 8147.388945829057, 8511.702090426836, 8731.825363492726, 8740.8688869667, 2459.963100553489, 2478.330850670318, 2479.1818699829105, 2489.8630575318352, 2497.900083996638, 2107.6627739561673, 2399.7360290368133, 2483.8261321707487, 2491.750824917512, 2502.687164104487, 2121.0561300221407, 2403.927882163529, 2462.741412151725, 2480.776730094291, 2488.029668429314, 2374.3114496795906, 2429.4047958250167, 2432.3067925641194, 2432.927012189637, 2435.2937648082034, 2415.9516809663883, 2417.6736140620965, 2420.056178090546, 2421.4309637235237, 2424.866632335221, 8573.18554737299, 8605.913940860573, 8667.436616619963, 8670.52312122833, 8677.783055423602, 5282.260483532308, 5398.568114550866, 5420.376656684453, 5535.667859928417, 5621.943780562183, 3379.8648054077808, 3490.5985811631735, 3543.5039094526787, 3571.0715214044276, 3631.4371272452813, 1222.3826967381503, 1232.0266989078616, 1238.851337839456, 1248.2635245205372, 1273.6433798536425, 12669.873301266962, 12672.87327126726, 12681.809772853414, 12714.809277860839, 12774.16967897093, 4793.616510679138, 4880.1215781159735, 4904.485029071968, 4958.330625365602, 4991.126552853236, 10641.467926603638, 10670.573177072985, 10679.73300667474, 10690.62582809598, 10696.144308455305, 5573.080441727069, 5573.7770489179975, 5576.972115139399, 5587.944120558743, 5589.385167631557, 5070.797168113308, 5076.416212135578, 5082.669626474268, 5145.819896303611, 5152.098382782998, 4202.621764041251, 4258.850940217078, 4343.1747967886, 4368.060866913565, 4375.518692943773, 1275.9362031898368, 1369.9726005479833, 1401.831780186384, 1413.7243237568575, 1429.371076726258, 883.8497455432592, 1031.8761748590218, 1051.138066785244, 1051.8369652703843, 1056.6037735849056, 6108.602940808833, 6108.75564977396, 6207.751689932443, 6256.4056414641445, 6303.401176888188, 961.7691753979135, 1021.7394564386034, 1026.4457193115784, 1031.85038169465, 1043.796459690353, 4284.3145096784365, 4336.891577710582, 4389.978050109793, 4414.55854414556, 4479.843205487858, 10714.678559643224, 11078.781334053248, 11089.05743011837, 11090.667279981613, 11104.555817767361, 10982.0, 10987.560497580167, 11022.50398732059, 11037.558497660164, 11052.613158539412, 8116.8782468263025, 8198.344132469389, 8298.460600060977, 8321.0, 8329.458585191944, 6002.8294482575475, 6037.0, 6211.627302361872, 6271.184745982993, 6323.051542268697, 10131.949340253252, 10322.174226062047, 10400.895991040295, 10423.68728938133, 10493.108085812792, 10007.149392301735, 10209.489525523843, 10357.68926932163, 10510.47447627631, 10510.527026283988, 7712.421568382281, 7728.536287822749, 7874.0, 7883.7240696575345, 7894.644740986784, 8534.189252021048, 8576.271016963628, 8617.310615150898, 8639.0, 8641.438306510057, 7554.697812087675, 7665.808354791175, 7754.573498457639, 7776.416768742254, 7834.647440865288, 7761.9611901940125, 7815.960920195363, 7846.489978151402, 8025.678972841021, 8093.150219227132, 7272.490925635155, 7345.338919497271, 7347.0, 7369.594672293076, 7379.298966598165, 5435.184722291688, 5507.614466987273, 5534.391216966211, 5592.636478628876, 5625.766385823235, 5235.031519168966, 5251.632385732962, 5326.97336513315, 5365.463453654604, 5370.785168593213], "value": 4824.855733764561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.90622625664815, 335.7432900861643, 345.47487818515856, 345.79079656807613, 347.1685313673751, 5244.659097158682, 5283.260343551901, 5358.133398631733, 5436.885438485111, 5460.372057213422, 5170.896582068356, 5253.921191182126, 5283.916797056594, 5298.417174110845, 5313.070212712779, 4234.851780187694, 4235.343521754133, 4236.279832428487, 4236.5763423657545, 4236.872893813191, 4149.273877071516, 4231.344141658048, 4236.322188449849, 4237.4491316129015, 4241.1093670329265, 4188.497380314367, 4191.392248124021, 4194.78351278129, 4206.852760153395, 4207.474065741782, 4195.098053918407, 4199.328107502815, 4199.916001679964, 4205.285101532716, 4213.220554197484, 3572.9991204925327, 3692.7599706019023, 3706.5181526401393, 3716.2195938852874, 3773.3773927301963, 5253.605979551511, 5268.683878967274, 5280.656757310762, 5291.470852914677, 5295.364556253236, 4817.807287708488, 4824.855254342376, 4826.662133650646, 4827.975860120712, 4830.589399901012, 5449.656647641513, 5593.692346920918, 5630.605857589971, 5644.463775941279, 5647.265855438766, 4049.493813273341, 4053.5946405359523, 4054.189162167578, 4063.756174629532, 4067.5322337930925, 5830.47525722687, 5875.6474611523445, 5885.970570147165, 5891.322497912709, 5913.822585322404, 3944.546377166605, 4087.407325937782, 4140.523839758466, 4150.730202536825, 4172.061286210578, 4156.293430116827, 4174.45732054837, 4177.081042170717, 4181.665466762713, 4182.393552934807, 4763.142634325785, 4773.04539092176, 4775.331453596499, 4791.448983366958, 4818.518148185153, 5443.564514838803, 5621.891790578533, 5695.689991302023, 5727.914081288784, 5748.798792042258, 1358.6752915906911, 1390.450771945076, 1402.0185869891118, 1438.5324769449762, 1445.2773613193403, 962.5716556132454, 974.3082411487782, 989.3964681544252, 989.4508547756064, 999.3853779925294, 5520.1443776214755, 5520.944790552043, 5521.861953451115, 5528.612997090246, 5531.363893152258, 5769.423057694197, 5772.5959182856795, 5786.71066446676, 5788.7684492620665, 5791.218185544982, 5291.708956007456, 5477.534409575231, 5513.669179849222, 5534.308211473566, 5543.223948647193, 2687.5162470755063, 2705.0, 2711.444153948436, 2713.1279417202068, 2739.2740923655247, 5248.685078895202, 5252.474752524717, 5270.7628156733035, 5285.3351194373645, 5308.946910530923, 5183.844484665466, 5597.6641401516035, 5980.8803823924145, 5994.640321580632, 6006.819795406145, 6108.72510737009, 6121.592033832155, 6133.877322453526, 6154.815355539341, 6157.907631385533, 5663.603547751618, 5889.204957330706, 5907.556933229939, 5938.465538101419, 5942.909686962842, 5837.328707198726, 5843.415658434123, 5843.883122337445, 5845.503132233808, 5866.794662186803, 6144.201253836973, 6145.586515101462, 6150.384961503813, 6210.472109870711, 6218.378162183745, 3979.462772525672, 4128.483939507561, 4162.812673429642, 4166.104287578185, 4174.311238645711, 5642.60501764889, 5850.1572004818345, 5853.507355624289, 5858.0, 5858.619189752652, 5587.776488940397, 5702.401247868914, 5728.312602487728, 5744.138379243147, 5756.913646295226, 5731.312242530923, 5741.569382296261, 5754.3382511010095, 5755.7409916553015, 5755.942440575708, 5574.386817450159, 5606.299842104192, 5634.32388113429, 5667.291588551431, 5708.860126930254, 5738.626989245686, 5751.194832723506, 5756.280464941882, 5778.30188679254, 5783.277090363705, 5487.286652735119, 5608.158776183605, 5630.408807075198, 5630.4369563043365, 5645.548356131418], "value": 4302.787276985202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4649291988528, 799.5083023940276, 809.514291425145, 872.1932212703248, 892.0410558649453, 15540.300686469107, 16446.75329870053, 16721.498355049353, 16742.079185644783, 17720.202590883408, 16010.59973500663, 16319.51041468755, 16348.100854453, 16356.591085222875, 16399.59001024975, 732.9523580967247, 752.7892190186757, 870.4733636150117, 885.4908427654093, 892.4243862708549, 862.1550880137469, 883.5361435246515, 886.2289807867132, 891.3092353426082, 892.1524551675901, 939.0421769794805, 941.3222479814523, 941.4915945389481, 941.5339406993547, 941.5433514745343, 756.1719916691214, 776.9766906992743, 936.0171819589438, 936.3164889630574, 936.9437833729997, 656.1699450195506, 673.1148539670318, 674.7301079568163, 675.5507587454337, 676.0467740485891, 16006.359745610162, 16022.519324420286, 16049.117298548575, 16054.438094666748, 16055.197240138063, 14999.100053996686, 15348.0, 15442.691146177014, 15487.845121548753, 15547.689046219126, 13383.665408364772, 13594.184348939096, 13722.588322350346, 13759.656008599764, 14052.437902483991, 4545.5908968193025, 4711.175544279771, 4744.359511465942, 4803.471618122004, 4817.638677099231, 86509.56745216297, 86862.0, 87770.0, 89607.0, 90118.5494072532, 11668.591599293984, 11702.2978621283, 11930.926216640544, 11961.581344652895, 12008.0, 23397.883010585178, 23551.411214719425, 23571.17500887495, 23660.0, 23713.7628623715, 8968.327375446737, 8969.910300897038, 8973.596188171548, 8987.685431010013, 9155.22180614642, 4976.950230497649, 5040.722760248148, 5103.0, 5190.636655434083, 5301.496357846076, 3446.7931924084132, 3572.517710109154, 3579.19468119671, 3579.319929213493, 3664.3770559005034, 572.098944162945, 583.6760597868224, 587.3832475900288, 590.7046476761619, 606.130203158469, 690.413148823506, 731.8353370491596, 739.737393225408, 751.3500821789113, 755.8374949385908, 9301.90698093024, 9762.560684769202, 9939.900600993897, 10013.249006324555, 10048.346857454242, 697.1216267502983, 718.4539749790197, 738.7783664900509, 740.0564280542352, 754.5095687802863, 4694.248920172756, 4710.882227944328, 4781.641376896747, 4814.975925120352, 4852.126617208865, 88615.55692221626, 129081.0, 140705.0, 141282.0, 141364.0, 117693.41153294178, 118011.0, 120228.39885800515, 120603.0, 120630.05144191765, 101213.49393253133, 102717.0, 104598.0, 104626.0, 107946.0, 8615.82768344617, 8706.47761134334, 8798.47209167452, 8960.955195223982, 9030.0, 57265.0, 58758.70620646869, 60067.39932600618, 60167.0, 61472.69263653653, 84259.68052396218, 90519.5474022652, 91240.5437972806, 91986.0, 92901.0, 11841.855729785013, 11994.460249288628, 12029.939850300692, 12127.211731237441, 12166.57416990401, 12755.234685918875, 12773.169743966613, 12805.423755930819, 12932.612021639367, 13458.798118028433, 11982.161248712506, 12182.573609923611, 12298.938505307775, 12366.690832729253, 12456.688582785502, 12118.939405302917, 12318.815217771562, 12332.876671233173, 12457.563985260473, 12537.749245015231, 11533.135014874086, 11780.293182409083, 12067.75864482688, 12144.33206173669, 12556.43496042662, 10375.16998640122, 10566.894331056592, 10734.477397811352, 11037.227394082338, 11103.111751060058, 10240.748820053253, 10586.153107751208, 10596.947015265183, 10612.946935265274, 10633.734156646145], "value": 7904.6638408560275, "unit": "score"}], "name": "dromaeo_css", "value": 7529.364457990747, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 110.0, 111.0, 112.0, 110.0, 111.0, 110.0, 112.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 116.0, 159.0, 117.0, 119.0, 118.0, 120.0, 142.0, 117.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 162.0, 176.0, 161.0, 160.0, 162.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 104.0, 75.0, 76.0, 76.0, 75.0, 111.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 116.0, 80.0, 81.0, 80.0, 109.0, 81.0, 81.0, 113.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 49.0, 50.0, 49.0, 50.0, 49.0, 50.0, 50.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 77.0, 80.0, 74.0, 73.0, 73.0, 78.0, 73.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 130.0, 130.0, 125.0, 119.0, 119.0, 120.0, 163.0, 119.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 151.0, 152.0, 153.0, 152.0, 153.0, 153.0, 153.0, 156.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 61.0, 62.0, 64.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1456.1, "alertThreshold": 2.0}]} 04:21:08 INFO - Return code: 0 04:21:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:21:08 INFO - # TBPL SUCCESS # 04:21:08 INFO - Running post-action listener: _resource_record_post_action 04:21:08 INFO - [mozharness: 2016-10-18 11:21:08.746366Z] Finished run-tests step (success) 04:21:08 INFO - Running post-run listener: _resource_record_post_run 04:21:08 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 361029632; Read time: 48; Write time: 244568 04:21:08 INFO - TinderboxPrint: CPU usage
12.9% 04:21:08 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 48 04:21:08 INFO - TinderboxPrint: I/O write bytes / time
361,029,632 / 244,568 04:21:08 INFO - TinderboxPrint: CPU idle
8,262.9 (87.1%) 04:21:08 INFO - TinderboxPrint: CPU user
1,182.1 (12.5%) 04:21:08 INFO - TinderboxPrint: Swap in / out
0 / 0 04:21:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111071232; Read time: 0; Write time: 89956 04:21:08 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249958400; Read time: 16; Write time: 154612 04:21:09 INFO - Running post-run listener: _upload_blobber_files 04:21:09 INFO - Blob upload gear active. 04:21:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:09 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 04:21:09 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'] 04:21:09 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 04:21:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:10 INFO - (blobuploader) - INFO - Done attempting. 04:21:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:11 INFO - (blobuploader) - INFO - Done attempting. 04:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:14 INFO - (blobuploader) - INFO - Done attempting. 04:21:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:14 INFO - Return code: 0 04:21:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b96b22377cfa9f10ec8821d8a9d80df974d56646101a9dc9863083a8bd45d9d961915d13467b919ccea69352553de496a717d3f081b32105d3718b8f108d43ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0004826cfac85a71333667032cdcf992fda431a4740afb825d70454d5bdf52285308be31e061949207c4c80f64cc41fb36459081fec33219fb497be47b56d741", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a64864627ad289dbf5384a7c7c8e5adb163c897619498bce4b39f0f6959731adf59dbacd3958f77a619ba17ec291bb0fbec7c1c66ca4d7b9787731456b1a17d"} 04:21:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:14 INFO - Contents: 04:21:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b96b22377cfa9f10ec8821d8a9d80df974d56646101a9dc9863083a8bd45d9d961915d13467b919ccea69352553de496a717d3f081b32105d3718b8f108d43ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0004826cfac85a71333667032cdcf992fda431a4740afb825d70454d5bdf52285308be31e061949207c4c80f64cc41fb36459081fec33219fb497be47b56d741", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a64864627ad289dbf5384a7c7c8e5adb163c897619498bce4b39f0f6959731adf59dbacd3958f77a619ba17ec291bb0fbec7c1c66ca4d7b9787731456b1a17d"} 04:21:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:14 INFO - Copying logs to upload dir... 04:21:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.533404 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-10-18 04:21:13.967965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:21:13.971916) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318 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/b96b22377cfa9f10ec8821d8a9d80df974d56646101a9dc9863083a8bd45d9d961915d13467b919ccea69352553de496a717d3f081b32105d3718b8f108d43ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0004826cfac85a71333667032cdcf992fda431a4740afb825d70454d5bdf52285308be31e061949207c4c80f64cc41fb36459081fec33219fb497be47b56d741", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a64864627ad289dbf5384a7c7c8e5adb163c897619498bce4b39f0f6959731adf59dbacd3958f77a619ba17ec291bb0fbec7c1c66ca4d7b9787731456b1a17d"} build_url:https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/fX6W3hjsRRC3tvYhHQSvWw/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/b96b22377cfa9f10ec8821d8a9d80df974d56646101a9dc9863083a8bd45d9d961915d13467b919ccea69352553de496a717d3f081b32105d3718b8f108d43ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0004826cfac85a71333667032cdcf992fda431a4740afb825d70454d5bdf52285308be31e061949207c4c80f64cc41fb36459081fec33219fb497be47b56d741", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a64864627ad289dbf5384a7c7c8e5adb163c897619498bce4b39f0f6959731adf59dbacd3958f77a619ba17ec291bb0fbec7c1c66ca4d7b9787731456b1a17d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:21:14.016584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:21:14.016909) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476788440.57054-1875701318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:21:14.147368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:21:14.147686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:21:14.148997) ========= ========= Total master_lag: 0.24 =========