builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1477690072.52 results: success (0) buildid: 20161028114258 builduid: 9d22f8709a744667bc61ada6962e3dc5 revision: e7ceeddb165cf6be36356050551dbda8e2424865 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.523557) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.524047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.524400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.546419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.546819) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 14:27:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-28 14:27:52 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126510 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.909050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.909380) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020120 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:52.971318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 14:27:52.971661) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e7ceeddb165cf6be36356050551dbda8e2424865 --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 e7ceeddb165cf6be36356050551dbda8e2424865 --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=e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 14:27:53,106 truncating revision to first 12 chars 2016-10-28 14:27:53,106 Setting DEBUG logging. 2016-10-28 14:27:53,106 attempt 1/10 2016-10-28 14:27:53,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e7ceeddb165c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 14:27:53,494 unpacking tar archive at: mozilla-aurora-e7ceeddb165c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713340 ========= master_lag: 0.91 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 14:27:54.597745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:54.598013) ========= script_repo_revision: e7ceeddb165cf6be36356050551dbda8e2424865 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:54.598375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:54.598634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 14:27:54.651885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-28 14:27:54.652134) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:27:54 INFO - MultiFileLogger online at 20161028 14:27:54 in /builds/slave/test 14:27:54 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 14:27:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:27:54 INFO - {'append_to_log': False, 14:27:54 INFO - 'base_work_dir': '/builds/slave/test', 14:27:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:27:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:27:54 INFO - 'branch': 'Mozilla-Aurora', 14:27:54 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:54 INFO - 'config_files': ('talos/linux_config.py',), 14:27:54 INFO - 'default_actions': ('clobber', 14:27:54 INFO - 'read-buildbot-config', 14:27:54 INFO - 'download-and-extract', 14:27:54 INFO - 'populate-webroot', 14:27:54 INFO - 'create-virtualenv', 14:27:54 INFO - 'install', 14:27:54 INFO - 'run-tests'), 14:27:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:54 INFO - 'download_minidump_stackwalk': True, 14:27:54 INFO - 'download_symbols': 'ondemand', 14:27:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:27:54 INFO - 'tooltool.py': '/tools/tooltool.py', 14:27:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:27:54 INFO - '/tools/misc-python/virtualenv.py')}, 14:27:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:54 INFO - 'installer_path': 'installer.exe', 14:27:54 INFO - 'log_level': 'info', 14:27:54 INFO - 'log_name': 'talos', 14:27:54 INFO - 'log_to_console': True, 14:27:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:27:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:27:54 INFO - 'opt_config_files': (), 14:27:54 INFO - 'pip_index': False, 14:27:54 INFO - 'sps_profile': False, 14:27:54 INFO - 'sps_profile_interval': 0, 14:27:54 INFO - 'suite': 'dromaeojs', 14:27:54 INFO - 'system_bits': '32', 14:27:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:54 INFO - 'title': 'talos-linux64-ix-006', 14:27:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:54 INFO - 'use_talos_json': True, 14:27:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:27:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:54 INFO - 'work_dir': 'build'} 14:27:54 INFO - [mozharness: 2016-10-28 21:27:54.884673Z] Running clobber step. 14:27:54 INFO - Running pre-action listener: _resource_record_pre_action 14:27:54 INFO - Running main action method: clobber 14:27:54 INFO - rmtree: /builds/slave/test/build 14:27:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:27:55 INFO - Running post-action listener: _resource_record_post_action 14:27:55 INFO - [mozharness: 2016-10-28 21:27:55.337262Z] Finished clobber step (success) 14:27:55 INFO - [mozharness: 2016-10-28 21:27:55.337362Z] Running read-buildbot-config step. 14:27:55 INFO - Running pre-action listener: _resource_record_pre_action 14:27:55 INFO - Running main action method: read_buildbot_config 14:27:55 INFO - Using buildbot properties: 14:27:55 INFO - { 14:27:55 INFO - "project": "", 14:27:55 INFO - "product": "firefox", 14:27:55 INFO - "script_repo_revision": "production", 14:27:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:27:55 INFO - "repository": "", 14:27:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:27:55 INFO - "buildid": "20161028114258", 14:27:55 INFO - "pgo_build": "True", 14:27:55 INFO - "basedir": "/builds/slave/test", 14:27:55 INFO - "buildnumber": 840, 14:27:55 INFO - "slavename": "talos-linux64-ix-006", 14:27:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:27:55 INFO - "platform": "ubuntu64_hw", 14:27:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:27:55 INFO - "branch": "mozilla-aurora", 14:27:55 INFO - "repo_path": "releases/mozilla-aurora", 14:27:55 INFO - "revision": "e7ceeddb165cf6be36356050551dbda8e2424865", 14:27:55 INFO - "stage_platform": "linux64-pgo", 14:27:55 INFO - "builduid": "9d22f8709a744667bc61ada6962e3dc5", 14:27:55 INFO - "slavebuilddir": "test" 14:27:55 INFO - } 14:27:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 14:27:55 INFO - Running post-action listener: _resource_record_post_action 14:27:55 INFO - [mozharness: 2016-10-28 21:27:55.339916Z] Finished read-buildbot-config step (success) 14:27:55 INFO - [mozharness: 2016-10-28 21:27:55.340004Z] Running download-and-extract step. 14:27:55 INFO - Running pre-action listener: _resource_record_pre_action 14:27:55 INFO - Running main action method: download_and_extract 14:27:55 INFO - mkdir: /builds/slave/test/build/tests 14:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:55 INFO - trying https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:27:55 INFO - Downloading https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/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 14:27:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/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 14:27:55 INFO - Downloaded 1361 bytes. 14:27:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:27:55 INFO - Using the following test package requirements: 14:27:55 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:27:55 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:27:55 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:27:55 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'jsshell-linux-x86_64.zip'], 14:27:55 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:27:55 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:27:55 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:27:55 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:27:55 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:27:55 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:27:55 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:27:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:27:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:27:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:27:55 INFO - Fetch https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:27:56 INFO - Expected file size: 21895423 14:28:01 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 14:28:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:28:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:28:02 INFO - Expected file size: 21895423 14:28:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 14:28:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:28:07 INFO - Fetch https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:28:07 INFO - Expected file size: 14414081 14:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:09 INFO - trying https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:28:09 INFO - Downloading https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/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 14:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/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 14:28:11 INFO - Downloaded 63960785 bytes. 14:28:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:28:11 INFO - mkdir: /builds/slave/test/properties 14:28:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:28:11 INFO - Writing to file /builds/slave/test/properties/build_url 14:28:11 INFO - Contents: 14:28:11 INFO - build_url:https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:28:12 INFO - Running post-action listener: _resource_record_post_action 14:28:12 INFO - Running post-action listener: set_extra_try_arguments 14:28:12 INFO - [mozharness: 2016-10-28 21:28:12.464498Z] Finished download-and-extract step (success) 14:28:12 INFO - [mozharness: 2016-10-28 21:28:12.464726Z] Running populate-webroot step. 14:28:12 INFO - Running pre-action listener: _resource_record_pre_action 14:28:12 INFO - Running main action method: populate_webroot 14:28:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:12 INFO - '--tppagecycles', 14:28:12 INFO - '7'], 14:28:12 INFO - 'tests': ['tsvgm']}}, 14:28:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:28:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:28:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:28:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['damp', 'tps']}, 14:28:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'tests': ['damp', 'tps']}, 14:28:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['dromaeo_dom']}, 14:28:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['basic_compositor_video']}, 14:28:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:28:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['a11yr', 14:28:12 INFO - 'ts_paint', 14:28:12 INFO - 'tpaint', 14:28:12 INFO - 'sessionrestore', 14:28:12 INFO - 'sessionrestore_no_auto_restore', 14:28:12 INFO - 'tabpaint']}, 14:28:12 INFO - 'other-e10s': {'tests': ['a11yr', 14:28:12 INFO - 'ts_paint', 14:28:12 INFO - 'tpaint', 14:28:12 INFO - 'sessionrestore', 14:28:12 INFO - 'sessionrestore_no_auto_restore', 14:28:12 INFO - 'tabpaint']}, 14:28:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:28:12 INFO - 'ts_paint', 14:28:12 INFO - 'tpaint', 14:28:12 INFO - 'sessionrestore', 14:28:12 INFO - 'sessionrestore_no_auto_restore', 14:28:12 INFO - 'tabpaint']}, 14:28:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:28:12 INFO - 'ts_paint', 14:28:12 INFO - 'tpaint', 14:28:12 INFO - 'sessionrestore', 14:28:12 INFO - 'sessionrestore_no_auto_restore', 14:28:12 INFO - 'tabpaint']}, 14:28:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['a11yr', 14:28:12 INFO - 'ts_paint', 14:28:12 INFO - 'tpaint', 14:28:12 INFO - 'sessionrestore', 14:28:12 INFO - 'sessionrestore_no_auto_restore', 14:28:12 INFO - 'tabpaint']}, 14:28:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['a11yr', 14:28:12 INFO - 'ts_paint', 14:28:12 INFO - 'tpaint', 14:28:12 INFO - 'sessionrestore', 14:28:12 INFO - 'sessionrestore_no_auto_restore', 14:28:12 INFO - 'tabpaint']}, 14:28:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['tsvgx', 14:28:12 INFO - 'tsvgr_opacity', 14:28:12 INFO - 'tart', 14:28:12 INFO - 'tscrollx', 14:28:12 INFO - 'cart']}, 14:28:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:28:12 INFO - 'tsvgr_opacity', 14:28:12 INFO - 'tart', 14:28:12 INFO - 'tscrollx', 14:28:12 INFO - 'cart']}, 14:28:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'talos_options': ['--disable-e10s'], 14:28:12 INFO - 'tests': ['tp5o']}, 14:28:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'tests': ['tp5o']}, 14:28:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'talos_options': ['--disable-e10s', 14:28:12 INFO - '--xperf_path', 14:28:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:12 INFO - 'tests': ['tp5n']}, 14:28:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:12 INFO - 'talos_options': ['--xperf_path', 14:28:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:12 INFO - 'tests': ['tp5n']}}, 14:28:12 INFO - 'talos.zip': {'path': '', 14:28:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:12 INFO - Running post-action listener: _resource_record_post_action 14:28:12 INFO - [mozharness: 2016-10-28 21:28:12.484753Z] Finished populate-webroot step (success) 14:28:12 INFO - [mozharness: 2016-10-28 21:28:12.484841Z] Running create-virtualenv step. 14:28:12 INFO - Running pre-action listener: _resource_record_pre_action 14:28:12 INFO - Running main action method: create_virtualenv 14:28:12 INFO - Creating virtualenv /builds/slave/test/build/venv 14:28:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:28:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:28:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:12 INFO - Using real prefix '/usr' 14:28:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:28:13 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:15 INFO - Installing pip.................done. 14:28:15 INFO - Return code: 0 14:28:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:15 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:28:15 INFO - Using env: {'DISPLAY': ':0', 14:28:15 INFO - 'HOME': '/home/cltbld', 14:28:15 INFO - 'LANG': 'en_US.UTF-8', 14:28:15 INFO - 'LANGUAGE': 'en_US:en', 14:28:15 INFO - 'LOGNAME': 'cltbld', 14:28:15 INFO - 'MAIL': '/var/mail/cltbld', 14:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:15 INFO - 'MOZ_NO_REMOTE': '1', 14:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:15 INFO - 'NO_EM_RESTART': '1', 14:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:15 INFO - 'PWD': '/builds/slave/test', 14:28:15 INFO - 'SHELL': '/bin/bash', 14:28:15 INFO - 'SHLVL': '1', 14:28:15 INFO - 'TERM': 'linux', 14:28:15 INFO - 'TMOUT': '86400', 14:28:15 INFO - 'USER': 'cltbld', 14:28:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:15 INFO - '_': '/tools/buildbot/bin/python'} 14:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:28:15 INFO - Cleaning up... 14:28:15 INFO - Return code: 0 14:28:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:15 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:28:15 INFO - Using env: {'DISPLAY': ':0', 14:28:15 INFO - 'HOME': '/home/cltbld', 14:28:15 INFO - 'LANG': 'en_US.UTF-8', 14:28:15 INFO - 'LANGUAGE': 'en_US:en', 14:28:15 INFO - 'LOGNAME': 'cltbld', 14:28:15 INFO - 'MAIL': '/var/mail/cltbld', 14:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:15 INFO - 'MOZ_NO_REMOTE': '1', 14:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:15 INFO - 'NO_EM_RESTART': '1', 14:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:15 INFO - 'PWD': '/builds/slave/test', 14:28:15 INFO - 'SHELL': '/bin/bash', 14:28:15 INFO - 'SHLVL': '1', 14:28:15 INFO - 'TERM': 'linux', 14:28:15 INFO - 'TMOUT': '86400', 14:28:15 INFO - 'USER': 'cltbld', 14:28:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:15 INFO - '_': '/tools/buildbot/bin/python'} 14:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:15 INFO - Downloading/unpacking psutil>=3.1.1 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:17 INFO - Installing collected packages: psutil 14:28:17 INFO - Running setup.py install for psutil 14:28:17 INFO - building 'psutil._psutil_linux' extension 14:28:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:28:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:28:17 INFO - building 'psutil._psutil_posix' extension 14:28:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:28:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:28:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:18 INFO - Successfully installed psutil 14:28:18 INFO - Cleaning up... 14:28:18 INFO - Return code: 0 14:28:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:28: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 mozsystemmonitor==0.3 14:28:18 INFO - Using env: {'DISPLAY': ':0', 14:28:18 INFO - 'HOME': '/home/cltbld', 14:28:18 INFO - 'LANG': 'en_US.UTF-8', 14:28:18 INFO - 'LANGUAGE': 'en_US:en', 14:28:18 INFO - 'LOGNAME': 'cltbld', 14:28:18 INFO - 'MAIL': '/var/mail/cltbld', 14:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:18 INFO - 'MOZ_NO_REMOTE': '1', 14:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:18 INFO - 'NO_EM_RESTART': '1', 14:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:18 INFO - 'PWD': '/builds/slave/test', 14:28:18 INFO - 'SHELL': '/bin/bash', 14:28:18 INFO - 'SHLVL': '1', 14:28:18 INFO - 'TERM': 'linux', 14:28:18 INFO - 'TMOUT': '86400', 14:28:18 INFO - 'USER': 'cltbld', 14:28:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:18 INFO - '_': '/tools/buildbot/bin/python'} 14:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:20 INFO - Installing collected packages: mozsystemmonitor 14:28:20 INFO - Running setup.py install for mozsystemmonitor 14:28:20 INFO - Successfully installed mozsystemmonitor 14:28:20 INFO - Cleaning up... 14:28:20 INFO - Return code: 0 14:28:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:20 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:28:20 INFO - Using env: {'DISPLAY': ':0', 14:28:20 INFO - 'HOME': '/home/cltbld', 14:28:20 INFO - 'LANG': 'en_US.UTF-8', 14:28:20 INFO - 'LANGUAGE': 'en_US:en', 14:28:20 INFO - 'LOGNAME': 'cltbld', 14:28:20 INFO - 'MAIL': '/var/mail/cltbld', 14:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:20 INFO - 'MOZ_NO_REMOTE': '1', 14:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:20 INFO - 'NO_EM_RESTART': '1', 14:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:20 INFO - 'PWD': '/builds/slave/test', 14:28:20 INFO - 'SHELL': '/bin/bash', 14:28:20 INFO - 'SHLVL': '1', 14:28:20 INFO - 'TERM': 'linux', 14:28:20 INFO - 'TMOUT': '86400', 14:28:20 INFO - 'USER': 'cltbld', 14:28:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:20 INFO - '_': '/tools/buildbot/bin/python'} 14:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:20 INFO - Downloading/unpacking jsonschema==2.5.1 14:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:22 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:22 INFO - warning: no files found matching '*.txt' 14:28:22 INFO - no previously-included directories found matching 'build' 14:28:22 INFO - no previously-included directories found matching 'dist' 14:28:22 INFO - no previously-included directories found matching '.git*' 14:28:22 INFO - Installing collected packages: jsonschema, functools32 14:28:22 INFO - Running setup.py install for functools32 14:28:22 INFO - warning: no files found matching '*.txt' 14:28:22 INFO - no previously-included directories found matching 'build' 14:28:22 INFO - no previously-included directories found matching 'dist' 14:28:22 INFO - no previously-included directories found matching '.git*' 14:28:22 INFO - Successfully installed jsonschema functools32 14:28:22 INFO - Cleaning up... 14:28:23 INFO - Return code: 0 14:28:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:23 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:28:23 INFO - Using env: {'DISPLAY': ':0', 14:28:23 INFO - 'HOME': '/home/cltbld', 14:28:23 INFO - 'LANG': 'en_US.UTF-8', 14:28:23 INFO - 'LANGUAGE': 'en_US:en', 14:28:23 INFO - 'LOGNAME': 'cltbld', 14:28:23 INFO - 'MAIL': '/var/mail/cltbld', 14:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:23 INFO - 'MOZ_NO_REMOTE': '1', 14:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:23 INFO - 'NO_EM_RESTART': '1', 14:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:23 INFO - 'PWD': '/builds/slave/test', 14:28:23 INFO - 'SHELL': '/bin/bash', 14:28:23 INFO - 'SHLVL': '1', 14:28:23 INFO - 'TERM': 'linux', 14:28:23 INFO - 'TMOUT': '86400', 14:28:23 INFO - 'USER': 'cltbld', 14:28:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:23 INFO - '_': '/tools/buildbot/bin/python'} 14:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:28:23 INFO - Cleaning up... 14:28:23 INFO - Return code: 0 14:28:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:23 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:28:23 INFO - Using env: {'DISPLAY': ':0', 14:28:23 INFO - 'HOME': '/home/cltbld', 14:28:23 INFO - 'LANG': 'en_US.UTF-8', 14:28:23 INFO - 'LANGUAGE': 'en_US:en', 14:28:23 INFO - 'LOGNAME': 'cltbld', 14:28:23 INFO - 'MAIL': '/var/mail/cltbld', 14:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:23 INFO - 'MOZ_NO_REMOTE': '1', 14:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:23 INFO - 'NO_EM_RESTART': '1', 14:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:23 INFO - 'PWD': '/builds/slave/test', 14:28:23 INFO - 'SHELL': '/bin/bash', 14:28:23 INFO - 'SHLVL': '1', 14:28:23 INFO - 'TERM': 'linux', 14:28:23 INFO - 'TMOUT': '86400', 14:28:23 INFO - 'USER': 'cltbld', 14:28:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:23 INFO - '_': '/tools/buildbot/bin/python'} 14:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:26 INFO - Downloading docopt-0.6.1.tar.gz 14:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:26 INFO - Running setup.py install for blobuploader 14:28:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:26 INFO - Running setup.py install for requests 14:28:26 INFO - Running setup.py install for docopt 14:28:26 INFO - Successfully installed blobuploader requests docopt 14:28:26 INFO - Cleaning up... 14:28:26 INFO - Return code: 0 14:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:26 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:26 INFO - Using env: {'DISPLAY': ':0', 14:28:26 INFO - 'HOME': '/home/cltbld', 14:28:26 INFO - 'LANG': 'en_US.UTF-8', 14:28:26 INFO - 'LANGUAGE': 'en_US:en', 14:28:26 INFO - 'LOGNAME': 'cltbld', 14:28:26 INFO - 'MAIL': '/var/mail/cltbld', 14:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:26 INFO - 'MOZ_NO_REMOTE': '1', 14:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:26 INFO - 'NO_EM_RESTART': '1', 14:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:26 INFO - 'PWD': '/builds/slave/test', 14:28:26 INFO - 'SHELL': '/bin/bash', 14:28:26 INFO - 'SHLVL': '1', 14:28:26 INFO - 'TERM': 'linux', 14:28:26 INFO - 'TMOUT': '86400', 14:28:26 INFO - 'USER': 'cltbld', 14:28:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:26 INFO - '_': '/tools/buildbot/bin/python'} 14:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:26 INFO - Running setup.py (path:/tmp/pip-exCVwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:27 INFO - Running setup.py (path:/tmp/pip-x16FSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:27 INFO - Running setup.py (path:/tmp/pip-IAsJlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:27 INFO - Running setup.py (path:/tmp/pip-bLhLBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:27 INFO - Running setup.py (path:/tmp/pip-0PQmmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:27 INFO - Running setup.py (path:/tmp/pip-kgKRS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:27 INFO - Running setup.py (path:/tmp/pip-UXgpvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:27 INFO - Running setup.py (path:/tmp/pip-NA8M8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:27 INFO - Running setup.py (path:/tmp/pip-kY97vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:27 INFO - Running setup.py (path:/tmp/pip-ZV4U14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:27 INFO - Running setup.py (path:/tmp/pip-sYPHnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:27 INFO - Running setup.py (path:/tmp/pip-CNk0wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:27 INFO - Running setup.py (path:/tmp/pip-tPg7Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:27 INFO - Running setup.py (path:/tmp/pip-zIjcAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:27 INFO - Running setup.py (path:/tmp/pip-QXfvUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:28 INFO - Running setup.py (path:/tmp/pip-nzWolp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:28 INFO - Running setup.py (path:/tmp/pip-ATuTsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:28 INFO - Running setup.py install for manifestparser 14:28:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Running setup.py install for mozcrash 14:28:28 INFO - Running setup.py install for mozdebug 14:28:28 INFO - Running setup.py install for mozdevice 14:28:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Running setup.py install for mozfile 14:28:28 INFO - Running setup.py install for mozhttpd 14:28:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Running setup.py install for mozinfo 14:28:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Running setup.py install for mozInstall 14:28:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Running setup.py install for mozleak 14:28:29 INFO - Running setup.py install for mozlog 14:28:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Running setup.py install for moznetwork 14:28:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Running setup.py install for mozprocess 14:28:29 INFO - Running setup.py install for mozprofile 14:28:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Running setup.py install for mozrunner 14:28:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Running setup.py install for mozscreenshot 14:28:29 INFO - Running setup.py install for moztest 14:28:29 INFO - Running setup.py install for mozversion 14:28:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:29 INFO - Cleaning up... 14:28:30 INFO - Return code: 0 14:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:30 INFO - Using env: {'DISPLAY': ':0', 14:28:30 INFO - 'HOME': '/home/cltbld', 14:28:30 INFO - 'LANG': 'en_US.UTF-8', 14:28:30 INFO - 'LANGUAGE': 'en_US:en', 14:28:30 INFO - 'LOGNAME': 'cltbld', 14:28:30 INFO - 'MAIL': '/var/mail/cltbld', 14:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:30 INFO - 'MOZ_NO_REMOTE': '1', 14:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:30 INFO - 'NO_EM_RESTART': '1', 14:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:30 INFO - 'PWD': '/builds/slave/test', 14:28:30 INFO - 'SHELL': '/bin/bash', 14:28:30 INFO - 'SHLVL': '1', 14:28:30 INFO - 'TERM': 'linux', 14:28:30 INFO - 'TMOUT': '86400', 14:28:30 INFO - 'USER': 'cltbld', 14:28:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:30 INFO - '_': '/tools/buildbot/bin/python'} 14:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:30 INFO - Running setup.py (path:/tmp/pip-di7e0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:30 INFO - Running setup.py (path:/tmp/pip-nEPUUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:30 INFO - Running setup.py (path:/tmp/pip-bxo5fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:30 INFO - Running setup.py (path:/tmp/pip-Wyg6AQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:30 INFO - Running setup.py (path:/tmp/pip-myYFkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:30 INFO - Running setup.py (path:/tmp/pip-aQtt8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:30 INFO - Running setup.py (path:/tmp/pip-P2Nlmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:30 INFO - Running setup.py (path:/tmp/pip-xcGIYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:30 INFO - Running setup.py (path:/tmp/pip-bXkOtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:30 INFO - Running setup.py (path:/tmp/pip-2BZc_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:30 INFO - Running setup.py (path:/tmp/pip-45XAOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:31 INFO - Running setup.py (path:/tmp/pip-diw2yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:31 INFO - Running setup.py (path:/tmp/pip-iJey4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:31 INFO - Running setup.py (path:/tmp/pip-Caf2tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:31 INFO - Running setup.py (path:/tmp/pip-5vderE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:31 INFO - Running setup.py (path:/tmp/pip-lSSBiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:31 INFO - Running setup.py (path:/tmp/pip-sLFeDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:33 INFO - Downloading blessings-1.6.tar.gz 14:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:33 INFO - Installing collected packages: blessings 14:28:33 INFO - Running setup.py install for blessings 14:28:33 INFO - Successfully installed blessings 14:28:33 INFO - Cleaning up... 14:28:33 INFO - Return code: 0 14:28:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:33 INFO - Reading from file tmpfile_stdout 14:28:33 INFO - Current package versions: 14:28:33 INFO - argparse == 1.2.1 14:28:33 INFO - blessings == 1.6 14:28:33 INFO - blobuploader == 1.2.4 14:28:33 INFO - docopt == 0.6.1 14:28:33 INFO - functools32 == 3.2.3-2 14:28:33 INFO - jsonschema == 2.5.1 14:28:33 INFO - manifestparser == 1.1 14:28:33 INFO - mozInstall == 1.12 14:28:33 INFO - mozcrash == 0.17 14:28:33 INFO - mozdebug == 0.1 14:28:33 INFO - mozdevice == 0.48 14:28:33 INFO - mozfile == 1.2 14:28:33 INFO - mozhttpd == 0.7 14:28:33 INFO - mozinfo == 0.9 14:28:33 INFO - mozleak == 0.1 14:28:33 INFO - mozlog == 3.4 14:28:33 INFO - moznetwork == 0.27 14:28:33 INFO - mozprocess == 0.23 14:28:33 INFO - mozprofile == 0.28 14:28:33 INFO - mozrunner == 6.12 14:28:33 INFO - mozscreenshot == 0.1 14:28:33 INFO - mozsystemmonitor == 0.3 14:28:33 INFO - moztest == 0.7 14:28:33 INFO - mozversion == 1.4 14:28:33 INFO - psutil == 3.1.1 14:28:33 INFO - requests == 1.2.3 14:28:33 INFO - wsgiref == 0.1.2 14:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:33 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:33 INFO - Using env: {'DISPLAY': ':0', 14:28:33 INFO - 'HOME': '/home/cltbld', 14:28:33 INFO - 'LANG': 'en_US.UTF-8', 14:28:33 INFO - 'LANGUAGE': 'en_US:en', 14:28:33 INFO - 'LOGNAME': 'cltbld', 14:28:33 INFO - 'MAIL': '/var/mail/cltbld', 14:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:33 INFO - 'MOZ_NO_REMOTE': '1', 14:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:33 INFO - 'NO_EM_RESTART': '1', 14:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:33 INFO - 'PWD': '/builds/slave/test', 14:28:33 INFO - 'SHELL': '/bin/bash', 14:28:33 INFO - 'SHLVL': '1', 14:28:33 INFO - 'TERM': 'linux', 14:28:33 INFO - 'TMOUT': '86400', 14:28:33 INFO - 'USER': 'cltbld', 14:28:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:33 INFO - '_': '/tools/buildbot/bin/python'} 14:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:34 INFO - Cleaning up... 14:28:34 INFO - Return code: 0 14:28:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:34 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 0x7fa5f439bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c62ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:28:34 INFO - Using env: {'DISPLAY': ':0', 14:28:34 INFO - 'HOME': '/home/cltbld', 14:28:34 INFO - 'LANG': 'en_US.UTF-8', 14:28:34 INFO - 'LANGUAGE': 'en_US:en', 14:28:34 INFO - 'LOGNAME': 'cltbld', 14:28:34 INFO - 'MAIL': '/var/mail/cltbld', 14:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:34 INFO - 'MOZ_NO_REMOTE': '1', 14:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:34 INFO - 'NO_EM_RESTART': '1', 14:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:34 INFO - 'PWD': '/builds/slave/test', 14:28:34 INFO - 'SHELL': '/bin/bash', 14:28:34 INFO - 'SHLVL': '1', 14:28:34 INFO - 'TERM': 'linux', 14:28:34 INFO - 'TMOUT': '86400', 14:28:34 INFO - 'USER': 'cltbld', 14:28:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:34 INFO - '_': '/tools/buildbot/bin/python'} 14:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:28:34 INFO - Cleaning up... 14:28:34 INFO - Return code: 0 14:28:34 INFO - Running post-action listener: _resource_record_post_action 14:28:34 INFO - Running post-action listener: _start_resource_monitoring 14:28:34 INFO - Starting resource monitoring. 14:28:34 INFO - [mozharness: 2016-10-28 21:28:34.372251Z] Finished create-virtualenv step (success) 14:28:34 INFO - [mozharness: 2016-10-28 21:28:34.372756Z] Running install step. 14:28:34 INFO - Running pre-action listener: _resource_record_pre_action 14:28:34 INFO - Running main action method: install 14:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:34 INFO - Reading from file tmpfile_stdout 14:28:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:34 INFO - Reading from file tmpfile_stdout 14:28:34 INFO - Output received: 14:28:34 INFO - Usage: mozinstall [options] installer 14:28:34 INFO - Options: 14:28:34 INFO - -h, --help show this help message and exit 14:28:34 INFO - -d DEST, --destination=DEST 14:28:34 INFO - Directory to install application into. [default: 14:28:34 INFO - "/builds/slave/test"] 14:28:34 INFO - --app=APP Application being installed. [default: firefox] 14:28:34 INFO - mkdir: /builds/slave/test/build/application 14:28:34 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'] 14:28:34 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 14:28:50 INFO - Reading from file tmpfile_stdout 14:28:50 INFO - Output received: 14:28:50 INFO - /builds/slave/test/build/application/firefox/firefox 14:28:50 INFO - Running post-action listener: _resource_record_post_action 14:28:50 INFO - [mozharness: 2016-10-28 21:28:50.618098Z] Finished install step (success) 14:28:50 INFO - [mozharness: 2016-10-28 21:28:50.618343Z] Running run-tests step. 14:28:50 INFO - Running pre-action listener: _resource_record_pre_action 14:28:50 INFO - Running main action method: run_tests 14:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:50 INFO - Python 2.7.3 14:28:50 INFO - Return code: 0 14:28:50 INFO - grabbing minidump binary from tooltool 14:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:50 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 0x2c5ff60>, '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 0x2c60d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c611d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:28:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:28:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:28:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:50 INFO - Return code: 0 14:28:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:28:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:28:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:50 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/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:28:50 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/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:28:50 INFO - Using env: {'DISPLAY': ':0', 14:28:50 INFO - 'HOME': '/home/cltbld', 14:28:50 INFO - 'LANG': 'en_US.UTF-8', 14:28:50 INFO - 'LANGUAGE': 'en_US:en', 14:28:50 INFO - 'LOGNAME': 'cltbld', 14:28:50 INFO - 'MAIL': '/var/mail/cltbld', 14:28:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:50 INFO - 'MOZ_NO_REMOTE': '1', 14:28:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:50 INFO - 'NO_EM_RESTART': '1', 14:28:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:50 INFO - 'PWD': '/builds/slave/test', 14:28:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:50 INFO - 'SHELL': '/bin/bash', 14:28:50 INFO - 'SHLVL': '1', 14:28:50 INFO - 'TERM': 'linux', 14:28:50 INFO - 'TMOUT': '86400', 14:28:50 INFO - 'USER': 'cltbld', 14:28:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549', 14:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:50 INFO - '_': '/tools/buildbot/bin/python'} 14:28:50 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/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:28:50 INFO - mozversion application_buildid: 20161028114258 14:28:50 INFO - mozversion application_changeset: e7ceeddb165cf6be36356050551dbda8e2424865 14:28:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:28:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:50 INFO - mozversion application_name: Firefox 14:28:50 INFO - mozversion application_remotingname: firefox-dev 14:28:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:28:50 INFO - mozversion application_vendor: Mozilla 14:28:50 INFO - mozversion application_version: 51.0a2 14:28:50 INFO - mozversion platform_buildid: 20161028114258 14:28:50 INFO - mozversion platform_changeset: e7ceeddb165cf6be36356050551dbda8e2424865 14:28:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:28:50 INFO - mozversion platform_version: 51.0a2 14:28:50 INFO - using testdate: 1477690130 14:28:50 INFO - actual date: 1477690130 14:28:50 INFO - starting webserver on 'localhost:53683' 14:28:50 INFO - SUITE-START | Running 2 tests 14:28:50 INFO - TEST-START | dromaeo_css 14:28:50 INFO - operating with platform_type : linux_ 14:28:50 INFO - Initialising browser for dromaeo_css test... 14:28:50 INFO - TEST-INFO | started process 8186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpql4bEf/profile http://localhost:53683/getInfo.html) 14:28:54 INFO - PROCESS | 8186 | __metrics Screen width/height:1600/1200 14:28:54 INFO - PROCESS | 8186 | colorDepth:24 14:28:54 INFO - PROCESS | 8186 | Browser inner width/height: 1024/697 14:28:54 INFO - PROCESS | 8186 | __metrics 14:28:55 INFO - PROCESS | 8186 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:28:55 INFO - PROCESS | 8186 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:55 INFO - PROCESS | 8186 | console.error: PushService: 14:28:55 INFO - PROCESS | 8186 | stateChangeProcessEnqueue: Error transitioning state 14:28:55 INFO - PROCESS | 8186 | UnknownError 14:28:56 INFO - TEST-INFO | 8186: exit 0 14:28:56 INFO - Browser initialized. 14:28:56 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:56 INFO - TEST-INFO | started process 8281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpql4bEf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:07 INFO - PROCESS | 8281 | RSS: Main: 145641472 14:29:07 INFO - PROCESS | 8281 | 14:29:59 INFO - PROCESS | 8281 | 1477690199486 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:32:09 INFO - PROCESS | 8281 | Cycle 1(1): loaded http://localhost:53683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53683/tests/dromaeo/cssquery-ext.html) 14:32:10 INFO - PROCESS | 8281 | RSS: Main: 238505984 14:32:10 INFO - PROCESS | 8281 | 14:35:12 INFO - PROCESS | 8281 | Cycle 1(1): loaded http://localhost:53683/tests/dromaeo/cssquery-ext.html (next: http://localhost:53683/tests/dromaeo/cssquery-jquery.html) 14:35:13 INFO - PROCESS | 8281 | RSS: Main: 230682624 14:35:13 INFO - PROCESS | 8281 | 14:38:15 INFO - PROCESS | 8281 | Cycle 1(1): loaded http://localhost:53683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53683/tests/dromaeo/cssquery-mootools.html) 14:38:15 INFO - PROCESS | 8281 | RSS: Main: 217239552 14:38:15 INFO - PROCESS | 8281 | 14:41:17 INFO - PROCESS | 8281 | Cycle 1(1): loaded http://localhost:53683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53683/tests/dromaeo/cssquery-prototype.html) 14:41:18 INFO - PROCESS | 8281 | RSS: Main: 218247168 14:41:18 INFO - PROCESS | 8281 | 14:44:20 INFO - PROCESS | 8281 | Cycle 1(1): loaded http://localhost:53683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53683/tests/dromaeo/cssquery-yui.html) 14:44:21 INFO - PROCESS | 8281 | RSS: Main: 177135616 14:44:21 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | Cycle 1(1): loaded http://localhost:53683/tests/dromaeo/cssquery-yui.html (next: http://localhost:53683/tests/dromaeo/cssquery-dojo.html) 14:47:24 INFO - PROCESS | 8281 | RSS: Main: 264904704 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | __start_tp_report 14:47:24 INFO - PROCESS | 8281 | _x_x_mozilla_page_load 14:47:24 INFO - PROCESS | 8281 | _x_x_mozilla_page_load_details 14:47:24 INFO - PROCESS | 8281 | |i|pagename|runs| 14:47:24 INFO - PROCESS | 8281 | |0;dojo.html;3114.3148507328387;3145.1508092814943;3158.857851396687;3186.060112266881;3200;5479.0411677956345;5553.4724201200925;5582.972085139579;5591.832245032645;5594.776208951642;5505.229267902487;5555.472230138141;5556.249906262653;5568.415316391782;5574.275344205248;4989.476105008967;5006.4492905780335;5035.269885866547;5040.546350828425;5104.795808167669;5045.091883460976;5045.243213517965;5099.15863882459;5103.642745007851;5107.69353838769;5019.071471777715;5064.442911279756;5068.594512438996;5088.720120393377;5107.8467645970495;5102.897942041157;5130.51260130287;5132.461091585367;5190.221466779975;5192.402873669501;5058.494150584949;5142.048720986592;5192.8961420771375;5209.765560549784;5229.764660590283;5478.45215478453;5486.259354987065;5496.532794712454;5518.310211223597;5552.333719953632;5998.790042348541;5999.340072592011;6005.039193728982;6087.2086628738425;6098.054801505774;6140.84647883802;6145.108959200936;6158.692065396713;6161.7535298588455;6162.198914141178;5427.185922111676;5470.206820011116;5563.833085007497;5626.2685850839125;5643.351014633287;6178.69106544671;6212.596181248295;6214.347493513206;6218.533609979179;6224.751009959551;5941.257342832146;5941.851453713692;5946.197263369476;5954.19618351517;5955.583109182316;5846.678432686158;5917.881642367129;5938.109283607407;6004.219451471281;6013.609115407485;6012.458878700938;6025.969870150621;6031.306399764083;6062.211912451353;6062.939370606326;5966.49284810796;6021.969890150609;6030.577859549877;6032.517398608101;6045.758169673164;4519.683622146484;4559.931601025987;4568.565986231302;4608.815647374067;4665.2535594304745;4096.815643296059;4113.382992551141;4134.028503301722;4135.069609337875;4151.252774500619;5616.045272303718;5660.2075709400715;5662.235598194274;5666.829995100154;5672.347680016768;5814.912776308359;5820.88358232833;5979.282486101695;5987.43119403656;5990.4908082813445;5698.943010569841;5743.741531631003;5759.366469688331;5768.336641286306;5791.391903850119;5095.31213286209;5106.565941894906;5107.770150343244;5110.156824124052;5146.176611742103;6000.189974353407;6047.304559975659;6254.74981000764;6267.370001541252;6315.052742088724;5918.615290006136;5962.403759624003;5982.49148822355;6016.578839481194;6118.235220597426;6253.7185826637;6259.96870015647;6285.308616052322;6290;6305.5901366411035;5948.851278718067;5954.821355359346;5955.791547295998;5959.135925290895;5992.910106348496;5790.536757059509;5870.471657550841;6109.6639684817765;6112.47308512798;6130.0924101957135;5921.111833224878;5957.672328021827;5975.7012149391485;5991.550633702403;6018.849528761816;5964.642121472725;5969.343372228965;5970.671613061323;5974.312954010345;5976.19321391624;5764.048931926185;5822.796202132905;5849.210356601804;5878.177055212188;5890.558208134493;5988.6706231157705;5990.400959903975;5995.850103747442;6000.8799824004145;6031.09533569968;5619.325680918316;5724.742386592697;5837.591368604157;5851.063829787214;5851.414858514285 14:47:24 INFO - PROCESS | 8281 | |1;ext.html;576.4782871501293;593.8070127208658;600.5465873265687;621.6643012773103;647;31337.216569585744;46461;47480;47523.5247647523;52088.47911520893;50418;50904.74547627266;50975;51005.48994510054;51009.74495127529;8172.591370431484;9470.952645236765;9613.375130616487;9621.807563848719;9628.422294662343;8195.385346099036;8428.831423371528;8449.197326253996;11093.3898635575;11415.885841141608;11534.942325288363;11642.825357619642;11651.592194273202;11655.067594592454;11655.766884662302;11401.48693308803;11403.258788178784;11414.42927853604;11442.14183936208;11484.081273498143;11292.153088518311;11365.374904380256;11372;11387.089032877433;11387.772244555063;47659.76170119127;47792;47818.760906195595;47873;48063;3708.740388172829;3839.9616003839883;3893.435451859493;4198.580141985777;4555.2711566149255;35875.28249435023;36074.27851442956;36113.27773444543;36135.4579681305;37681;4764.904701905977;4876.268559716035;4888.828890988798;4888.877778055541;4948.307236986825;402878.98560507305;402978;403713;404759;405146;39927.2014559713;67319.66340168366;67348.66325668438;67593;67830.3216967824;40593;42215.366769497865;42283.577164228576;42333.36499952503;42410.36384454236;17299.56751081233;17517.12414379276;17521;17528.561785955197;17538.123093845257;11217.326960382403;14501.564953051426;14725;14725.263736813116;14732.55802325932;8176.3867709922;9470.431774093577;9707;9725.367851089657;9801.558929848174;3592.2815436912724;3703.3519134151416;3704.814759262026;3729.1982223821465;3738.9439158412647;1072.758629308415;1093.2019625673304;1097.7639807441437;1102.2890235797865;1151.1999160583482;36089.63910360863;36160.63839361625;36544.63455365413;36595.085122872144;36874.26251474956;1242.937853107341;1266.1833117639255;1295.3264302562616;1309.214471317221;1331.5406184866206;18816.529586760167;18817.247310107716;18932.43202703921;19058.618827623646;19128.904355478135;568711;917730;920761;924603;924619;67338.66330668316;68051;68165.31834681689;68211.31788682149;68388;1154.099802154321;1206.1737709668905;1414.462504248379;1440.3950340856866;1472.6023973527087;34770.65229347775;36933.509511106895;39045.21909561736;39565.40651890166;39622.60377396304;63701.362986369546;63900;63922.68038659777;64270.678646606466;64587.35412646001;520848;521409;523760;524490;526046;25901.22296331113;32253.35493290168;33394;33424;33635.831820840736;36286.63713362938;52122.47877521176;55797.721011394686;56607.16964151858;56623.433765661815;43190;46255.53744462647;46747.065058699314;46812.35524319176;47713.76143119262;44611;45844.54155458403;46163.76918115388;46300.7684961573;46631;45612;46194.307085394415;46490.767546163406;47156.52843471521;47364.52635473739;38143.618563815115;40021.79989100036;40588.1882362357;40912.8416196926;41051.794741026104;30544.389112217188;31091.647169396754;31121.8443907779;31270.53094203634;31305.686943130277 14:47:24 INFO - PROCESS | 8281 | |2;jquery.html;368.13671939302327;389.5092183848352;417.34268527069855;422.17886211318984;422.6850996007973;13078.673033174164;14416.135031898093;20336.08487618059;20819.791802081974;21089.789102108974;20512.487187820276;20762.584748305024;20784.168633254652;20983.790162098376;21196.152153913827;5814.854628634275;5825.533957283407;5992.191054207691;6035.788747393842;6036.69816509175;3720.534933133358;3852.6917846572346;5935.228420305354;6009.1286763419275;6022;6379.872402551946;6609.3390660934;6630.701618427182;6725.630090345029;6731.259561448237;6484.546081774278;6695.196576410837;6708.765193218214;6747.561408508432;6748.561343512656;5807.738651760681;6013.248343957005;6022.3676513966275;6023.909641355383;6024.518038556905;20165;20463.18147274122;20476.18095276187;23034.42413939648;24730;2522.2181123851665;2525.02786427225;2590.922272331833;2593.2220333899754;2998.265424970896;15534.378624854991;15650.608734781608;15813.367465301375;16085.517434476867;16440.917795411067;1999.6800511918168;2093.3615247349553;2117.68234764785;2140.1439424230275;2171.457135716071;69247.96128058083;71027.28972710259;73794.63102684506;86278;92093.53953230257;11574.131940104357;11655;11789.941050294694;11817.527298907948;11868.347240901834;14729.263536823117;14826.851731482548;16175.676486470205;16629.667406652043;16659.66680666404;8512.446690965067;8520.230924949416;8763.211310982042;8873.689420870238;8966.730998070068;8520.403571749917;8647.308215342757;8738.257248133852;8797.38418310712;8891.599878005505;6768.796936091925;6836.965815170893;6918.8962165567555;6936.375726184567;6988.825279368057;2004.6692295771034;2056.352249041547;2071.4200023993308;2074.159965214091;2130.9147634094775;1078.703356576932;1103.4648195625116;1111.2388014210292;1115.6206889657556;1134.3987686526154;20652.690209646866;21077.367678969655;21894.562108757735;22231.444213894458;22295.665565016538;1042.3902017319801;1059.4120263253967;1116.8827273136203;1163.8428812110426;1185.7035741064733;11995.940020299842;12302.630921072383;12305.630831075083;12625;12633.368331583384;490613.7058832287;496176;497106;507713;511489;86476;88377;88389.55805221062;88445;89742.55128724314;1041.8489319048695;1078.3475997021847;1150.988490115105;1153.7865494883474;1154.8267759836092;18872.52818679544;19321.130549125042;19428.417147485598;19599.31402400909;19708.50728731793;41964.19711433422;42336.576634233264;42887.14225715406;43528.78235608801;44424.5566493833;56311.71844140753;56857;57316.42683573111;57413;57567.7121614406;8103.878441823495;8130.9266137134655;8190.262876341158;8702.651893924172;9265.19328730891;12107.455164517442;12367;12687.11190216676;13024.674383140118;13051.086423950232;10991.340519568852;11366.886331136582;11375.32679820225;11544.249623774427;11715.531378745096;10947.452627368759;11053.502592383524;11148.721281968015;11171.162162837658;11413.543458261576;11294.830577541179;11331.546738130712;11435.771284574428;11515.596954106566;11649.883501165219;8050.235227653364;8196.385271104571;8205.179482051986;8530.914690853013;8681.956590217009;9014.459132451811;11047;11052.447377631248;11299.152563557602;11707.648770536898 14:47:24 INFO - PROCESS | 8281 | |3;mootools.html;1146.3924120216277;1485.7548504496758;1536.8616824485794;1670.9582260443487;1837.5130590393549;7993.560354180518;8792.736217913465;9034.503102329369;9041.909580904188;9369.250459963203;9110.908890911089;9174.770630734234;9175.632974681004;9175.954120229406;9183.862242066374;2527.9747202527924;2559.5648739714293;2560.334313078604;2560.3983063980045;2562.1160699558623;2491.4394261291154;2558.206955843685;2561;2563.1797824696105;2563.846169229843;2519.4709111086695;2533.4553071089713;2553.8595377254337;2558.5394628966874;2559.34736642156;2454.202384225125;2462.310553045141;2470.419451428913;2524.217492577307;2525.444402231506;2452.730199678034;2456.545539075277;2474.270090323359;2482.0692240409844;2495.5008998200433;9189.954050229706;9198.310126740522;9284.628614855397;9455.196308313802;9540.522973851279;5447.836564903059;5595.1886976388605;5648.519875810561;5673.886522269573;5687.289088863892;3595.9640403596154;3645.471406646048;3662.597114317423;3663;3690.704743620504;1217.2148963918312;1236.5548402575066;1239.3121817391345;1259.0242562014512;1268.3404629592653;13155.144915580457;13514.526991555347;13515;13515.59453216405;13516.459341626422;4865.416150062015;4873.122837889214;4957.157283261854;5048;5049.394072711299;11184.496697648463;11189.72025699364;11190.272632278877;11190.32858028521;11190.552377904793;5727.398623144593;5730.169125476866;5739.339975902742;5739.885202295931;5740.971295143498;4384.408104905797;4395.626371758436;4413.183561041217;4557.931631025537;5299.761510732026;4251.29853574163;4373.212821692063;4467.039586488921;4468.419105516327;4476.283794592915;1390.2353705461956;1412.2091628687967;1424.266502751084;1434.2470203143432;1447.978280325796;835.3692961813791;920.742192186189;987.0622908237203;996.9102780749768;1001.6293971230546;6069.575129740876;6322.33615470369;6357.523185761086;6384.48924086072;6485.578437401554;446.1634435433562;458.2073013686275;461.69758807980156;462.12427449982096;475.0664943386263;4290.806913688892;4334.739915605074;4398.362237475612;4403.779811009436;4433.357163211316;12086.637400877988;12276.447559859827;12326.691832704075;12327.75344493123;12344.074194435274;12219.327936963553;12252.571160009356;12258.693532661755;12270.202436841577;12270.32513211782;8617.310615150773;8910.420822646507;8995.100489950952;9155.13026262504;9204.63181472747;5979.940200597938;6118.663473509;6154.815355539341;6198.659073750987;6320.5259605528845;11359.318440893572;11466.885331146581;11588.304701717923;11592.826107608224;11607.419629018346;11261.887381126084;11296.661100167008;11323.207375483636;11343.943280283545;11696.35670038156;8763.737087887373;9121.954390228271;9242.630294788134;9303.255739540686;9314.813703726024;9272.768180795534;9381.765455863659;9417.764555886157;9441.103095205945;9448.574814133519;8064.959675201587;8356.498610083414;8396.118407567361;8442.32461403074;8574.356923230658;7991.2408321211715;8260.29787468072;8297.502149871027;8431.451955622864;8552.358573106918;7421.2949769771785;7422.591757453176;7491.363234124942;7501.062367204099;7502.287282708134;5269.683818970874;5345.438728933406;5378.865528361822;5475.780968761364;5494.945050549443;5338.706371149624;5438.592105592017;5490.368607610176;5490.615656904138;5655.575831812548 14:47:24 INFO - PROCESS | 8281 | |4;prototype.html;334.37805681432536;335.2122512096572;338.1950956722999;342.108806558914;345.20774821784005;5304.77990062285;5458;5462.808801691942;5487.53355964743;5499.422560631131;5255.185446255837;5371.838844834661;5385.67685938844;5400.6498375406145;5423.2136340230645;4264.147170565884;4268;4278.828846846138;4291.35629655551;4296.935545966798;4158.97920510397;4247.384129301249;4280.208161490119;4280.293751530994;4281.914361712764;4233.259179643565;4233.555476674951;4234.555371685975;4247.702660813744;4249.19265339586;4222.303319952204;4222.944263934017;4233.216854881856;4251.766152861592;4279.930017495626;3734.439834024918;3803.2773772983046;3808.0860593457646;3820.522434695663;3831.4827498287655;5252.1596544552685;5263;5273.4462881397285;5294.41761406245;5295.443978382292;4871.196252618313;4871.197656866946;4918.3360246367;4924.3105965164905;4941.135301322254;5465.125579907235;5621.353544342372;5655.123455864347;5659.745311460994;5667.971660141714;4101.425800387948;4141.420201171808;4145.937810932838;4155.958440415588;4161.334186530141;5876.177335173079;5889.1755154278435;5892.970535147297;5900.527957763368;5995.370486098984;4156.147989662112;4210.810513526899;4275.187714334266;4276.18752437036;4276.828926842892;4251.893702657397;4256.9996050928;4302.806373713191;4313.223619748475;4328.220920234388;4875.219964805614;4877.585405240523;4886.315915771795;4888.655619704609;4892.8532144035735;5456.536194423439;5655.575831812631;5662.37713851476;5695.658260504383;5751.453611906946;1448.449589156114;1460.9269536523132;1464.7509923313062;1468.9632759180893;1472.0578829549097;901.5762591581946;938.1650331205233;940.3464592108555;942.4816351007056;942.6465075596651;4903.803847846118;4911.4106307243355;4926.438252108955;4931.3835770528685;4935.457099719028;5177.844664660066;5179.404368497671;5182.046233646861;5188.429272779991;5242.633015688865;4763.856674398189;4868.393430168036;4946.258061290763;4959.950400495949;4986.950130498722;2746.917592472229;2750.4499100180046;2754.73829986151;2756.54517004696;2770.362816552164;5320.802819365689;5354.54486368663;5359.11464188468;5388.787522807415;5400.810971615974;4929.088118698052;5245.842624721265;5250.369955605352;5264.5525130363585;5272.578193744491;5249.895002099936;5279.868003299948;5306.575473962073;5313.0247061645605;5313.468653134656;5166.2508936204795;5178.300929374486;5189.818356357509;5211.583073354198;5234.738263086907;5167.276581278699;5478.808241711521;5832.825015249549;5856.180134781219;5873.618214816023;6080.939190608037;6098.908516372347;6100.969495152496;6123.510119190543;6127.264728232641;3890.3580909150805;4005.759654420744;4095.0990782027907;4144.834206631701;4313.0726893718;5840.328362238397;5867.002609556301;5873.706314684163;5894.587378883609;5899.203607512931;5665.66006039639;5756.194132821324;5770.2498675171955;5787.623804452697;5810.750688601971;5683.630564013326;5687.544996400361;5725.770969161187;5733.254676891977;5744.741486633028;5709.51469125129;5714.971425142848;5724.227229324155;5736.397678243724;5758.523834751098;5508.504234618904;5710.885782284414;5736.139579063174;5756;5842.977478941253;5594.41258667834;5612.7193640317;5618.2415373924;5624.718764061862;5680.914786278292 14:47:24 INFO - PROCESS | 8281 | |5;yui.html;784.4626430894841;790.5730905311133;847.1063028504929;868;882.5146169606714;16205.83794162058;17170.141492925366;17180;17202.741958870625;17207.82792172078;16023.038617682947;16151.353945842182;16180.919095404535;16270.186490675478;16397.67204655909;529.134864496547;541.1368866657675;852.6120615120136;861.0356400831063;873.0789017586444;871.6426265231256;877.6928075173702;878.8418084744743;879.3536750488386;883.8188171424874;939.7462685075026;940.4216406909735;941.2187884056217;941.8822647169104;942.2838642631581;551.9199716041171;563.0877977676171;892.3797960417512;920.7559996600907;933.276710549323;679.2358596578849;679.813051410861;680.7175022365712;682.8224661587973;683.0676127086491;16476.67046659072;16530.00819950795;16532.09073500957;16548.75176872348;16552.337906483725;15123.39506419753;15628.282023842092;15715.842841571552;15717.842821571752;16032.599185020352;11588.88411115895;11803.704907377385;11857.347845868473;13770.311484425738;14720.558383248519;4808.364457049284;4810.78351474181;5066.873328166826;5108.591312695013;5129.384473863161;50747.23879141816;51046.7447662763;64537.354626453605;84038.15961840303;85374;12823.35883205836;13249.602511924657;13517.32413379327;13545.458181672622;14049.929750351388;24444.755552444247;24675.136370226955;24704.13535526248;24802.25593232206;24857.378565535644;9714.125728684452;9719.416834989923;9796.412215267106;9891.554880030415;9969.302148849656;5010.1983682611335;5177.896442071213;5188.92216616751;5293.364796224478;5402.91895621566;3730.869419570302;3858.401947698111;3862.787546684903;3863;3868.6518213360932;654.4371840217409;657.3907026172077;660.4386271669139;663.1081195791653;667.8363800868818;619.2352444730844;746.4625469661835;824.5712229640553;828.1759649149135;852.4331319672349;10108.646197383056;10613.5223914924;11037.172212084126;11090.809790973604;11362.886371136348;698.183125742882;729.6825880741894;766.6894907562446;802.6428239433396;830.2527725047505;5201.29782479368;5397.622166448311;5461.6996065216;5474.42518535556;5507.531859791882;73184.26815731774;76818.61590692123;132283.67716322906;133084.3345783265;134509;109563;111582;113789.43105284586;114095;119158;98218;99374.00625993648;99851.50074249727;102322.48838755759;102736;10144.442055687008;10277.434741089312;10374.585016599553;10622.8406573903;10646.89353106459;40189.59810401859;42908;47811;49160;49987.50012499974;76920;77495.61252193703;79952.60023700076;80986.19013809787;81203.5939820297;13840.377183026587;13924.791128132883;13935.09421887574;14326.426942922166;14574.635634109232;15007.924960375129;15267;15281.235938203268;15754.606134846721;15804.60488487797;15251.542453726406;15445.922770386076;15488.690226195638;15729.606759831096;16709.331626734795;14465.927670361581;15261;15360.462383816513;15664.451744188898;15802.209889505708;14351.784723228951;14438.927805360907;14470.276486175439;14684.706305874037;15165.393384264506;12516.624501264976;12678.809817852554;13179.406926688514;13247.735045298847;13423.932880335537;13217.14088584239;13252.602421926971;13304.401301941241;13347.399367028313;13625 14:47:24 INFO - PROCESS | 8281 | __end_tp_report 14:47:24 INFO - PROCESS | 8281 | __start_cc_report 14:47:24 INFO - PROCESS | 8281 | _x_x_mozilla_cycle_collect,855 14:47:24 INFO - PROCESS | 8281 | __end_cc_report 14:47:24 INFO - PROCESS | 8281 | __startTimestamp1477691244308__endTimestamp 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | ------- Summary: start ------- 14:47:24 INFO - PROCESS | 8281 | Number of tests: 6 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | [#0] dojo.html Cycles:165 Average:5585.23 Median:5837.59 stddev:656.37 (11.2%) stddev-sans-first:629.11 14:47:24 INFO - PROCESS | 8281 | Values: 3114.3 3145.2 3158.9 3186.1 3200.0 5479.0 5553.5 5583.0 5591.8 5594.8 5505.2 5555.5 5556.2 5568.4 5574.3 4989.5 5006.4 5035.3 5040.5 5104.8 5045.1 5045.2 5099.2 5103.6 5107.7 5019.1 5064.4 5068.6 5088.7 5107.8 5102.9 5130.5 5132.5 5190.2 5192.4 5058.5 5142.0 5192.9 5209.8 5229.8 5478.5 5486.3 5496.5 5518.3 5552.3 5998.8 5999.3 6005.0 6087.2 6098.1 6140.8 6145.1 6158.7 6161.8 6162.2 5427.2 5470.2 5563.8 5626.3 5643.4 6178.7 6212.6 6214.3 6218.5 6224.8 5941.3 5941.9 5946.2 5954.2 5955.6 5846.7 5917.9 5938.1 6004.2 6013.6 6012.5 6026.0 6031.3 6062.2 6062.9 5966.5 6022.0 6030.6 6032.5 6045.8 4519.7 4559.9 4568.6 4608.8 4665.3 4096.8 4113.4 4134.0 4135.1 4151.3 5616.0 5660.2 5662.2 5666.8 5672.3 5814.9 5820.9 5979.3 5987.4 5990.5 5698.9 5743.7 5759.4 5768.3 5791.4 5095.3 5106.6 5107.8 5110.2 5146.2 6000.2 6047.3 6254.7 6267.4 6315.1 5918.6 5962.4 5982.5 6016.6 6118.2 6253.7 6260.0 6285.3 6290.0 6305.6 5948.9 5954.8 5955.8 5959.1 5992.9 5790.5 5870.5 6109.7 6112.5 6130.1 5921.1 5957.7 5975.7 5991.6 6018.8 5964.6 5969.3 5970.7 5974.3 5976.2 5764.0 5822.8 5849.2 5878.2 5890.6 5988.7 5990.4 5995.9 6000.9 6031.1 5619.3 5724.7 5837.6 5851.1 5851.4 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | [#1] ext.html Cycles:180 Average:74779.79 Median:40590.59 stddev:168806.08 (415.9%) stddev-sans-first:169187.69 14:47:24 INFO - PROCESS | 8281 | Values: 576.5 593.8 600.5 621.7 647.0 31337.2 46461.0 47480.0 47523.5 52088.5 50418.0 50904.7 50975.0 51005.5 51009.7 8172.6 9471.0 9613.4 9621.8 9628.4 8195.4 8428.8 8449.2 11093.4 11415.9 11534.9 11642.8 11651.6 11655.1 11655.8 11401.5 11403.3 11414.4 11442.1 11484.1 11292.2 11365.4 11372.0 11387.1 11387.8 47659.8 47792.0 47818.8 47873.0 48063.0 3708.7 3840.0 3893.4 4198.6 4555.3 35875.3 36074.3 36113.3 36135.5 37681.0 4764.9 4876.3 4888.8 4888.9 4948.3 402879.0 402978.0 403713.0 404759.0 405146.0 39927.2 67319.7 67348.7 67593.0 67830.3 40593.0 42215.4 42283.6 42333.4 42410.4 17299.6 17517.1 17521.0 17528.6 17538.1 11217.3 14501.6 14725.0 14725.3 14732.6 8176.4 9470.4 9707.0 9725.4 9801.6 3592.3 3703.4 3704.8 3729.2 3738.9 1072.8 1093.2 1097.8 1102.3 1151.2 36089.6 36160.6 36544.6 36595.1 36874.3 1242.9 1266.2 1295.3 1309.2 1331.5 18816.5 18817.2 18932.4 19058.6 19128.9 568711.0 917730.0 920761.0 924603.0 924619.0 67338.7 68051.0 68165.3 68211.3 68388.0 1154.1 1206.2 1414.5 1440.4 1472.6 34770.7 36933.5 39045.2 39565.4 39622.6 63701.4 63900.0 63922.7 64270.7 64587.4 520848.0 521409.0 523760.0 524490.0 526046.0 25901.2 32253.4 33394.0 33424.0 33635.8 36286.6 52122.5 55797.7 56607.2 56623.4 43190.0 46255.5 46747.1 46812.4 47713.8 44611.0 45844.5 46163.8 46300.8 46631.0 45612.0 46194.3 46490.8 47156.5 47364.5 38143.6 40021.8 40588.2 40912.8 41051.8 30544.4 31091.6 31121.8 31270.5 31305.7 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | [#2] jquery.html Cycles:180 Average:29567.06 Median:22263.55 stddev:82294.97 (369.6%) stddev-sans-first:82496.63 14:47:24 INFO - PROCESS | 8281 | Values: 368.1 389.5 417.3 422.2 422.7 13078.7 14416.1 20336.1 20819.8 21089.8 20512.5 20762.6 20784.2 20983.8 21196.2 5814.9 5825.5 5992.2 6035.8 6036.7 3720.5 3852.7 5935.2 6009.1 6022.0 6379.9 6609.3 6630.7 6725.6 6731.3 6484.5 6695.2 6708.8 6747.6 6748.6 5807.7 6013.2 6022.4 6023.9 6024.5 20165.0 20463.2 20476.2 23034.4 24730.0 2522.2 2525.0 2590.9 2593.2 2998.3 15534.4 15650.6 15813.4 16085.5 16440.9 1999.7 2093.4 2117.7 2140.1 2171.5 69248.0 71027.3 73794.6 86278.0 92093.5 11574.1 11655.0 11789.9 11817.5 11868.3 14729.3 14826.9 16175.7 16629.7 16659.7 8512.4 8520.2 8763.2 8873.7 8966.7 8520.4 8647.3 8738.3 8797.4 8891.6 6768.8 6837.0 6918.9 6936.4 6988.8 2004.7 2056.4 2071.4 2074.2 2130.9 1078.7 1103.5 1111.2 1115.6 1134.4 20652.7 21077.4 21894.6 22231.4 22295.7 1042.4 1059.4 1116.9 1163.8 1185.7 11995.9 12302.6 12305.6 12625.0 12633.4 490613.7 496176.0 497106.0 507713.0 511489.0 86476.0 88377.0 88389.6 88445.0 89742.6 1041.8 1078.3 1151.0 1153.8 1154.8 18872.5 19321.1 19428.4 19599.3 19708.5 41964.2 42336.6 42887.1 43528.8 44424.6 56311.7 56857.0 57316.4 57413.0 57567.7 8103.9 8130.9 8190.3 8702.7 9265.2 12107.5 12367.0 12687.1 13024.7 13051.1 10991.3 11366.9 11375.3 11544.2 11715.5 10947.5 11053.5 11148.7 11171.2 11413.5 11294.8 11331.5 11435.8 11515.6 11649.9 8050.2 8196.4 8205.2 8530.9 8682.0 9014.5 11047.0 11052.4 11299.2 11707.6 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | [#3] mootools.html Cycles:180 Average:6277.40 Median:2508.07 stddev:3683.53 (146.9%) stddev-sans-first:3673.67 14:47:24 INFO - PROCESS | 8281 | Values: 1146.4 1485.8 1536.9 1671.0 1837.5 7993.6 8792.7 9034.5 9041.9 9369.3 9110.9 9174.8 9175.6 9176.0 9183.9 2528.0 2559.6 2560.3 2560.4 2562.1 2491.4 2558.2 2561.0 2563.2 2563.8 2519.5 2533.5 2553.9 2558.5 2559.3 2454.2 2462.3 2470.4 2524.2 2525.4 2452.7 2456.5 2474.3 2482.1 2495.5 9190.0 9198.3 9284.6 9455.2 9540.5 5447.8 5595.2 5648.5 5673.9 5687.3 3596.0 3645.5 3662.6 3663.0 3690.7 1217.2 1236.6 1239.3 1259.0 1268.3 13155.1 13514.5 13515.0 13515.6 13516.5 4865.4 4873.1 4957.2 5048.0 5049.4 11184.5 11189.7 11190.3 11190.3 11190.6 5727.4 5730.2 5739.3 5739.9 5741.0 4384.4 4395.6 4413.2 4557.9 5299.8 4251.3 4373.2 4467.0 4468.4 4476.3 1390.2 1412.2 1424.3 1434.2 1448.0 835.4 920.7 987.1 996.9 1001.6 6069.6 6322.3 6357.5 6384.5 6485.6 446.2 458.2 461.7 462.1 475.1 4290.8 4334.7 4398.4 4403.8 4433.4 12086.6 12276.4 12326.7 12327.8 12344.1 12219.3 12252.6 12258.7 12270.2 12270.3 8617.3 8910.4 8995.1 9155.1 9204.6 5979.9 6118.7 6154.8 6198.7 6320.5 11359.3 11466.9 11588.3 11592.8 11607.4 11261.9 11296.7 11323.2 11343.9 11696.4 8763.7 9122.0 9242.6 9303.3 9314.8 9272.8 9381.8 9417.8 9441.1 9448.6 8065.0 8356.5 8396.1 8442.3 8574.4 7991.2 8260.3 8297.5 8431.5 8552.4 7421.3 7422.6 7491.4 7501.1 7502.3 5269.7 5345.4 5378.9 5475.8 5494.9 5338.7 5438.6 5490.4 5490.6 5655.6 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | [#4] prototype.html Cycles:180 Average:4675.98 Median:5238.69 stddev:1356.19 (25.9%) stddev-sans-first:1320.27 14:47:24 INFO - PROCESS | 8281 | Values: 334.4 335.2 338.2 342.1 345.2 5304.8 5458.0 5462.8 5487.5 5499.4 5255.2 5371.8 5385.7 5400.6 5423.2 4264.1 4268.0 4278.8 4291.4 4296.9 4159.0 4247.4 4280.2 4280.3 4281.9 4233.3 4233.6 4234.6 4247.7 4249.2 4222.3 4222.9 4233.2 4251.8 4279.9 3734.4 3803.3 3808.1 3820.5 3831.5 5252.2 5263.0 5273.4 5294.4 5295.4 4871.2 4871.2 4918.3 4924.3 4941.1 5465.1 5621.4 5655.1 5659.7 5668.0 4101.4 4141.4 4145.9 4156.0 4161.3 5876.2 5889.2 5893.0 5900.5 5995.4 4156.1 4210.8 4275.2 4276.2 4276.8 4251.9 4257.0 4302.8 4313.2 4328.2 4875.2 4877.6 4886.3 4888.7 4892.9 5456.5 5655.6 5662.4 5695.7 5751.5 1448.4 1460.9 1464.8 1469.0 1472.1 901.6 938.2 940.3 942.5 942.6 4903.8 4911.4 4926.4 4931.4 4935.5 5177.8 5179.4 5182.0 5188.4 5242.6 4763.9 4868.4 4946.3 4960.0 4987.0 2746.9 2750.4 2754.7 2756.5 2770.4 5320.8 5354.5 5359.1 5388.8 5400.8 4929.1 5245.8 5250.4 5264.6 5272.6 5249.9 5279.9 5306.6 5313.0 5313.5 5166.3 5178.3 5189.8 5211.6 5234.7 5167.3 5478.8 5832.8 5856.2 5873.6 6080.9 6098.9 6101.0 6123.5 6127.3 3890.4 4005.8 4095.1 4144.8 4313.1 5840.3 5867.0 5873.7 5894.6 5899.2 5665.7 5756.2 5770.2 5787.6 5810.8 5683.6 5687.5 5725.8 5733.3 5744.7 5709.5 5715.0 5724.2 5736.4 5758.5 5508.5 5710.9 5736.1 5756.0 5843.0 5594.4 5612.7 5618.2 5624.7 5680.9 14:47:24 INFO - PROCESS | 8281 | 14:47:24 INFO - PROCESS | 8281 | [#5] yui.html Cycles:180 Average:21998.74 Median:3794.64 stddev:31539.36 (831.2%) stddev-sans-first:31587.61 14:47:24 INFO - PROCESS | 8281 | Values: 784.5 790.6 847.1 868.0 882.5 16205.8 17170.1 17180.0 17202.7 17207.8 16023.0 16151.4 16180.9 16270.2 16397.7 529.1 541.1 852.6 861.0 873.1 871.6 877.7 878.8 879.4 883.8 939.7 940.4 941.2 941.9 942.3 551.9 563.1 892.4 920.8 933.3 679.2 679.8 680.7 682.8 683.1 16476.7 16530.0 16532.1 16548.8 16552.3 15123.4 15628.3 15715.8 15717.8 16032.6 11588.9 11803.7 11857.3 13770.3 14720.6 4808.4 4810.8 5066.9 5108.6 5129.4 50747.2 51046.7 64537.4 84038.2 85374.0 12823.4 13249.6 13517.3 13545.5 14049.9 24444.8 24675.1 24704.1 24802.3 24857.4 9714.1 9719.4 9796.4 9891.6 9969.3 5010.2 5177.9 5188.9 5293.4 5402.9 3730.9 3858.4 3862.8 3863.0 3868.7 654.4 657.4 660.4 663.1 667.8 619.2 746.5 824.6 828.2 852.4 10108.6 10613.5 11037.2 11090.8 11362.9 698.2 729.7 766.7 802.6 830.3 5201.3 5397.6 5461.7 5474.4 5507.5 73184.3 76818.6 132283.7 133084.3 134509.0 109563.0 111582.0 113789.4 114095.0 119158.0 98218.0 99374.0 99851.5 102322.5 102736.0 10144.4 10277.4 10374.6 10622.8 10646.9 40189.6 42908.0 47811.0 49160.0 49987.5 76920.0 77495.6 79952.6 80986.2 81203.6 13840.4 13924.8 13935.1 14326.4 14574.6 15007.9 15267.0 15281.2 15754.6 15804.6 15251.5 15445.9 15488.7 15729.6 16709.3 14465.9 15261.0 15360.5 15664.5 15802.2 14351.8 14438.9 14470.3 14684.7 15165.4 12516.6 12678.8 13179.4 13247.7 13423.9 13217.1 13252.6 13304.4 13347.4 13625.0 14:47:24 INFO - PROCESS | 8281 | -------- Summary: end -------- 14:47:24 INFO - PROCESS | 8281 | 14:47:25 INFO - TEST-INFO | 8281: exit 0 14:47:25 INFO - TEST-OK | dromaeo_css | took 1114205ms 14:47:25 INFO - TEST-START | kraken 14:47:25 INFO - operating with platform_type : linux_ 14:47:25 INFO - Initialising browser for kraken test... 14:47:25 INFO - TEST-INFO | started process 8602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUqD4c1/profile http://localhost:53683/getInfo.html) 14:47:28 INFO - PROCESS | 8602 | __metrics Screen width/height:1600/1200 14:47:28 INFO - PROCESS | 8602 | colorDepth:24 14:47:28 INFO - PROCESS | 8602 | Browser inner width/height: 1024/697 14:47:28 INFO - PROCESS | 8602 | __metrics 14:47:29 INFO - PROCESS | 8602 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:47:29 INFO - PROCESS | 8602 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:47:29 INFO - PROCESS | 8602 | console.error: PushService: 14:47:29 INFO - PROCESS | 8602 | stateChangeProcessEnqueue: Error transitioning state 14:47:29 INFO - PROCESS | 8602 | UnknownError 14:47:30 INFO - TEST-INFO | 8602: exit 0 14:47:30 INFO - Browser initialized. 14:47:30 INFO - Running cycle 1/1 for kraken test... 14:47:30 INFO - TEST-INFO | started process 8698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUqD4c1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:42 INFO - PROCESS | 8698 | RSS: Main: 144846848 14:47:42 INFO - PROCESS | 8698 | 14:47:44 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53683/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:45 INFO - PROCESS | 8698 | RSS: Main: 186339328 14:47:45 INFO - PROCESS | 8698 | 14:47:48 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53683/tests/kraken/driver.html?testName=audio-dft) 14:47:48 INFO - PROCESS | 8698 | RSS: Main: 175423488 14:47:48 INFO - PROCESS | 8698 | 14:47:51 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53683/tests/kraken/driver.html?testName=audio-fft) 14:47:52 INFO - PROCESS | 8698 | RSS: Main: 267059200 14:47:52 INFO - PROCESS | 8698 | 14:47:54 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53683/tests/kraken/driver.html?testName=audio-oscillator) 14:47:54 INFO - PROCESS | 8698 | RSS: Main: 173465600 14:47:54 INFO - PROCESS | 8698 | 14:47:56 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:57 INFO - PROCESS | 8698 | RSS: Main: 174428160 14:47:57 INFO - PROCESS | 8698 | 14:48:00 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53683/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:01 INFO - PROCESS | 8698 | RSS: Main: 210309120 14:48:01 INFO - PROCESS | 8698 | 14:48:04 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53683/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:05 INFO - PROCESS | 8698 | RSS: Main: 209379328 14:48:05 INFO - PROCESS | 8698 | 14:48:07 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53683/tests/kraken/driver.html?testName=json-parse-financial) 14:48:08 INFO - PROCESS | 8698 | RSS: Main: 209907712 14:48:08 INFO - PROCESS | 8698 | 14:48:09 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:10 INFO - PROCESS | 8698 | RSS: Main: 171606016 14:48:10 INFO - PROCESS | 8698 | 14:48:12 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:12 INFO - PROCESS | 8698 | RSS: Main: 178704384 14:48:12 INFO - PROCESS | 8698 | 14:48:14 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:15 INFO - PROCESS | 8698 | RSS: Main: 188317696 14:48:15 INFO - PROCESS | 8698 | 14:48:17 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:18 INFO - PROCESS | 8698 | RSS: Main: 196489216 14:48:18 INFO - PROCESS | 8698 | 14:48:21 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:21 INFO - PROCESS | 8698 | RSS: Main: 193146880 14:48:21 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | Cycle 1(1): loaded http://localhost:53683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53683/tests/kraken/driver.html?testName=ai-astar) 14:48:23 INFO - PROCESS | 8698 | RSS: Main: 244699136 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | __start_tp_report 14:48:23 INFO - PROCESS | 8698 | _x_x_mozilla_page_load 14:48:23 INFO - PROCESS | 8698 | _x_x_mozilla_page_load_details 14:48:23 INFO - PROCESS | 8698 | |i|pagename|runs| 14:48:23 INFO - PROCESS | 8698 | |0;ai-astar;108;109;109;109;109;109;111;110;110;111 14:48:23 INFO - PROCESS | 8698 | |1;audio-beat-detection;140;119;118;145;117;118;121;117;151;119 14:48:23 INFO - PROCESS | 8698 | |2;audio-dft;161;160;161;161;160;162;161;161;162;162 14:48:23 INFO - PROCESS | 8698 | |3;audio-fft;75;75;74;118;75;75;76;75;101;74 14:48:23 INFO - PROCESS | 8698 | |4;audio-oscillator;82;81;110;81;81;82;106;81;82;117 14:48:23 INFO - PROCESS | 8698 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;117;117;117 14:48:23 INFO - PROCESS | 8698 | |6;imaging-darkroom;146;145;145;148;148;145;146;146;146;146 14:48:23 INFO - PROCESS | 8698 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;94 14:48:23 INFO - PROCESS | 8698 | |8;json-parse-financial;51;49;48;48;49;48;48;48;48;49 14:48:23 INFO - PROCESS | 8698 | |9;json-stringify-tinderbox;60;60;60;60;59;60;60;61;60;60 14:48:23 INFO - PROCESS | 8698 | |10;stanford-crypto-aes;73;73;74;73;72;73;74;73;81;73 14:48:23 INFO - PROCESS | 8698 | |11;stanford-crypto-ccm;121;121;125;119;120;120;119;118;156;122 14:48:23 INFO - PROCESS | 8698 | |12;stanford-crypto-pbkdf2;154;155;158;158;155;153;152;151;155;153 14:48:23 INFO - PROCESS | 8698 | |13;stanford-crypto-sha256-iterative;62;63;65;62;61;62;61;62;60;59 14:48:23 INFO - PROCESS | 8698 | __end_tp_report 14:48:23 INFO - PROCESS | 8698 | __start_cc_report 14:48:23 INFO - PROCESS | 8698 | _x_x_mozilla_cycle_collect,1637 14:48:23 INFO - PROCESS | 8698 | __end_cc_report 14:48:23 INFO - PROCESS | 8698 | __startTimestamp1477691303559__endTimestamp 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | ------- Summary: start ------- 14:48:23 INFO - PROCESS | 8698 | Number of tests: 14 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#0] ai-astar Cycles:10 Average:109.50 Median:109.50 stddev:0.97 (0.9%) stddev-sans-first:0.87 14:48:23 INFO - PROCESS | 8698 | Values: 108.0 109.0 109.0 109.0 109.0 109.0 111.0 110.0 110.0 111.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#1] audio-beat-detection Cycles:10 Average:126.50 Median:120.00 stddev:13.30 (11.1%) stddev-sans-first:13.18 14:48:23 INFO - PROCESS | 8698 | Values: 140.0 119.0 118.0 145.0 117.0 118.0 121.0 117.0 151.0 119.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:48:23 INFO - PROCESS | 8698 | Values: 161.0 160.0 161.0 161.0 160.0 162.0 161.0 161.0 162.0 162.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:15.15 (20.2%) stddev-sans-first:15.87 14:48:23 INFO - PROCESS | 8698 | Values: 75.0 75.0 74.0 118.0 75.0 75.0 76.0 75.0 101.0 74.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:81.00 stddev:14.53 (17.9%) stddev-sans-first:15.10 14:48:23 INFO - PROCESS | 8698 | Values: 82.0 81.0 110.0 81.0 81.0 82.0 106.0 81.0 82.0 117.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:48:23 INFO - PROCESS | 8698 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:1.10 (0.8%) stddev-sans-first:1.17 14:48:23 INFO - PROCESS | 8698 | Values: 146.0 145.0 145.0 148.0 148.0 145.0 146.0 146.0 146.0 146.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:48:23 INFO - PROCESS | 8698 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:48.50 stddev:0.97 (2.0%) stddev-sans-first:0.50 14:48:23 INFO - PROCESS | 8698 | Values: 51.0 49.0 48.0 48.0 49.0 48.0 48.0 48.0 48.0 49.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 14:48:23 INFO - PROCESS | 8698 | Values: 60.0 60.0 60.0 60.0 59.0 60.0 60.0 61.0 60.0 60.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.00 stddev:2.56 (3.5%) stddev-sans-first:2.69 14:48:23 INFO - PROCESS | 8698 | Values: 73.0 73.0 74.0 73.0 72.0 73.0 74.0 73.0 81.0 73.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:121.00 stddev:11.38 (9.4%) stddev-sans-first:12.01 14:48:23 INFO - PROCESS | 8698 | Values: 121.0 121.0 125.0 119.0 120.0 120.0 119.0 118.0 156.0 122.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:155.00 stddev:2.32 (1.5%) stddev-sans-first:2.46 14:48:23 INFO - PROCESS | 8698 | Values: 154.0 155.0 158.0 158.0 155.0 153.0 152.0 151.0 155.0 153.0 14:48:23 INFO - PROCESS | 8698 | 14:48:23 INFO - PROCESS | 8698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.64 (2.6%) stddev-sans-first:1.73 14:48:23 INFO - PROCESS | 8698 | Values: 62.0 63.0 65.0 62.0 61.0 62.0 61.0 62.0 60.0 59.0 14:48:23 INFO - PROCESS | 8698 | -------- Summary: end -------- 14:48:23 INFO - PROCESS | 8698 | 14:48:24 INFO - TEST-INFO | 8698: exit 0 14:48:24 INFO - TEST-OK | kraken | took 59438ms 14:48:24 INFO - SUITE-END | took 1173s 14:48:24 INFO - Completed test suite (00:19:33) 14:48:24 INFO - javascript benchmark 14:48:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.3148507328387, 3145.1508092814943, 3158.857851396687, 3186.060112266881, 3200.0, 5479.0411677956345, 5553.4724201200925, 5582.972085139579, 5591.832245032645, 5594.776208951642, 5505.229267902487, 5555.472230138141, 5556.249906262653, 5568.415316391782, 5574.275344205248, 4989.476105008967, 5006.4492905780335, 5035.269885866547, 5040.546350828425, 5104.795808167669, 5045.091883460976, 5045.243213517965, 5099.15863882459, 5103.642745007851, 5107.69353838769, 5019.071471777715, 5064.442911279756, 5068.594512438996, 5088.720120393377, 5107.8467645970495, 5102.897942041157, 5130.51260130287, 5132.461091585367, 5190.221466779975, 5192.402873669501, 5058.494150584949, 5142.048720986592, 5192.8961420771375, 5209.765560549784, 5229.764660590283, 5478.45215478453, 5486.259354987065, 5496.532794712454, 5518.310211223597, 5552.333719953632, 5998.790042348541, 5999.340072592011, 6005.039193728982, 6087.2086628738425, 6098.054801505774, 6140.84647883802, 6145.108959200936, 6158.692065396713, 6161.7535298588455, 6162.198914141178, 5427.185922111676, 5470.206820011116, 5563.833085007497, 5626.2685850839125, 5643.351014633287, 6178.69106544671, 6212.596181248295, 6214.347493513206, 6218.533609979179, 6224.751009959551, 5941.257342832146, 5941.851453713692, 5946.197263369476, 5954.19618351517, 5955.583109182316, 5846.678432686158, 5917.881642367129, 5938.109283607407, 6004.219451471281, 6013.609115407485, 6012.458878700938, 6025.969870150621, 6031.306399764083, 6062.211912451353, 6062.939370606326, 5966.49284810796, 6021.969890150609, 6030.577859549877, 6032.517398608101, 6045.758169673164, 4519.683622146484, 4559.931601025987, 4568.565986231302, 4608.815647374067, 4665.2535594304745, 4096.815643296059, 4113.382992551141, 4134.028503301722, 4135.069609337875, 4151.252774500619, 5616.045272303718, 5660.2075709400715, 5662.235598194274, 5666.829995100154, 5672.347680016768, 5814.912776308359, 5820.88358232833, 5979.282486101695, 5987.43119403656, 5990.4908082813445, 5698.943010569841, 5743.741531631003, 5759.366469688331, 5768.336641286306, 5791.391903850119, 5095.31213286209, 5106.565941894906, 5107.770150343244, 5110.156824124052, 5146.176611742103, 6000.189974353407, 6047.304559975659, 6254.74981000764, 6267.370001541252, 6315.052742088724, 5918.615290006136, 5962.403759624003, 5982.49148822355, 6016.578839481194, 6118.235220597426, 6253.7185826637, 6259.96870015647, 6285.308616052322, 6290.0, 6305.5901366411035, 5948.851278718067, 5954.821355359346, 5955.791547295998, 5959.135925290895, 5992.910106348496, 5790.536757059509, 5870.471657550841, 6109.6639684817765, 6112.47308512798, 6130.0924101957135, 5921.111833224878, 5957.672328021827, 5975.7012149391485, 5991.550633702403, 6018.849528761816, 5964.642121472725, 5969.343372228965, 5970.671613061323, 5974.312954010345, 5976.19321391624, 5764.048931926185, 5822.796202132905, 5849.210356601804, 5878.177055212188, 5890.558208134493, 5988.6706231157705, 5990.400959903975, 5995.850103747442, 6000.8799824004145, 6031.09533569968, 5619.325680918316, 5724.742386592697, 5837.591368604157, 5851.063829787214, 5851.414858514285], "value": 5539.077303149647, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.4782871501293, 593.8070127208658, 600.5465873265687, 621.6643012773103, 647.0, 31337.216569585744, 46461.0, 47480.0, 47523.5247647523, 52088.47911520893, 50418.0, 50904.74547627266, 50975.0, 51005.48994510054, 51009.74495127529, 8172.591370431484, 9470.952645236765, 9613.375130616487, 9621.807563848719, 9628.422294662343, 8195.385346099036, 8428.831423371528, 8449.197326253996, 11093.3898635575, 11415.885841141608, 11534.942325288363, 11642.825357619642, 11651.592194273202, 11655.067594592454, 11655.766884662302, 11401.48693308803, 11403.258788178784, 11414.42927853604, 11442.14183936208, 11484.081273498143, 11292.153088518311, 11365.374904380256, 11372.0, 11387.089032877433, 11387.772244555063, 47659.76170119127, 47792.0, 47818.760906195595, 47873.0, 48063.0, 3708.740388172829, 3839.9616003839883, 3893.435451859493, 4198.580141985777, 4555.2711566149255, 35875.28249435023, 36074.27851442956, 36113.27773444543, 36135.4579681305, 37681.0, 4764.904701905977, 4876.268559716035, 4888.828890988798, 4888.877778055541, 4948.307236986825, 402878.98560507305, 402978.0, 403713.0, 404759.0, 405146.0, 39927.2014559713, 67319.66340168366, 67348.66325668438, 67593.0, 67830.3216967824, 40593.0, 42215.366769497865, 42283.577164228576, 42333.36499952503, 42410.36384454236, 17299.56751081233, 17517.12414379276, 17521.0, 17528.561785955197, 17538.123093845257, 11217.326960382403, 14501.564953051426, 14725.0, 14725.263736813116, 14732.55802325932, 8176.3867709922, 9470.431774093577, 9707.0, 9725.367851089657, 9801.558929848174, 3592.2815436912724, 3703.3519134151416, 3704.814759262026, 3729.1982223821465, 3738.9439158412647, 1072.758629308415, 1093.2019625673304, 1097.7639807441437, 1102.2890235797865, 1151.1999160583482, 36089.63910360863, 36160.63839361625, 36544.63455365413, 36595.085122872144, 36874.26251474956, 1242.937853107341, 1266.1833117639255, 1295.3264302562616, 1309.214471317221, 1331.5406184866206, 18816.529586760167, 18817.247310107716, 18932.43202703921, 19058.618827623646, 19128.904355478135, 568711.0, 917730.0, 920761.0, 924603.0, 924619.0, 67338.66330668316, 68051.0, 68165.31834681689, 68211.31788682149, 68388.0, 1154.099802154321, 1206.1737709668905, 1414.462504248379, 1440.3950340856866, 1472.6023973527087, 34770.65229347775, 36933.509511106895, 39045.21909561736, 39565.40651890166, 39622.60377396304, 63701.362986369546, 63900.0, 63922.68038659777, 64270.678646606466, 64587.35412646001, 520848.0, 521409.0, 523760.0, 524490.0, 526046.0, 25901.22296331113, 32253.35493290168, 33394.0, 33424.0, 33635.831820840736, 36286.63713362938, 52122.47877521176, 55797.721011394686, 56607.16964151858, 56623.433765661815, 43190.0, 46255.53744462647, 46747.065058699314, 46812.35524319176, 47713.76143119262, 44611.0, 45844.54155458403, 46163.76918115388, 46300.7684961573, 46631.0, 45612.0, 46194.307085394415, 46490.767546163406, 47156.52843471521, 47364.52635473739, 38143.618563815115, 40021.79989100036, 40588.1882362357, 40912.8416196926, 41051.794741026104, 30544.389112217188, 31091.647169396754, 31121.8443907779, 31270.53094203634, 31305.686943130277], "value": 21605.843876770723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.13671939302327, 389.5092183848352, 417.34268527069855, 422.17886211318984, 422.6850996007973, 13078.673033174164, 14416.135031898093, 20336.08487618059, 20819.791802081974, 21089.789102108974, 20512.487187820276, 20762.584748305024, 20784.168633254652, 20983.790162098376, 21196.152153913827, 5814.854628634275, 5825.533957283407, 5992.191054207691, 6035.788747393842, 6036.69816509175, 3720.534933133358, 3852.6917846572346, 5935.228420305354, 6009.1286763419275, 6022.0, 6379.872402551946, 6609.3390660934, 6630.701618427182, 6725.630090345029, 6731.259561448237, 6484.546081774278, 6695.196576410837, 6708.765193218214, 6747.561408508432, 6748.561343512656, 5807.738651760681, 6013.248343957005, 6022.3676513966275, 6023.909641355383, 6024.518038556905, 20165.0, 20463.18147274122, 20476.18095276187, 23034.42413939648, 24730.0, 2522.2181123851665, 2525.02786427225, 2590.922272331833, 2593.2220333899754, 2998.265424970896, 15534.378624854991, 15650.608734781608, 15813.367465301375, 16085.517434476867, 16440.917795411067, 1999.6800511918168, 2093.3615247349553, 2117.68234764785, 2140.1439424230275, 2171.457135716071, 69247.96128058083, 71027.28972710259, 73794.63102684506, 86278.0, 92093.53953230257, 11574.131940104357, 11655.0, 11789.941050294694, 11817.527298907948, 11868.347240901834, 14729.263536823117, 14826.851731482548, 16175.676486470205, 16629.667406652043, 16659.66680666404, 8512.446690965067, 8520.230924949416, 8763.211310982042, 8873.689420870238, 8966.730998070068, 8520.403571749917, 8647.308215342757, 8738.257248133852, 8797.38418310712, 8891.599878005505, 6768.796936091925, 6836.965815170893, 6918.8962165567555, 6936.375726184567, 6988.825279368057, 2004.6692295771034, 2056.352249041547, 2071.4200023993308, 2074.159965214091, 2130.9147634094775, 1078.703356576932, 1103.4648195625116, 1111.2388014210292, 1115.6206889657556, 1134.3987686526154, 20652.690209646866, 21077.367678969655, 21894.562108757735, 22231.444213894458, 22295.665565016538, 1042.3902017319801, 1059.4120263253967, 1116.8827273136203, 1163.8428812110426, 1185.7035741064733, 11995.940020299842, 12302.630921072383, 12305.630831075083, 12625.0, 12633.368331583384, 490613.7058832287, 496176.0, 497106.0, 507713.0, 511489.0, 86476.0, 88377.0, 88389.55805221062, 88445.0, 89742.55128724314, 1041.8489319048695, 1078.3475997021847, 1150.988490115105, 1153.7865494883474, 1154.8267759836092, 18872.52818679544, 19321.130549125042, 19428.417147485598, 19599.31402400909, 19708.50728731793, 41964.19711433422, 42336.576634233264, 42887.14225715406, 43528.78235608801, 44424.5566493833, 56311.71844140753, 56857.0, 57316.42683573111, 57413.0, 57567.7121614406, 8103.878441823495, 8130.9266137134655, 8190.262876341158, 8702.651893924172, 9265.19328730891, 12107.455164517442, 12367.0, 12687.11190216676, 13024.674383140118, 13051.086423950232, 10991.340519568852, 11366.886331136582, 11375.32679820225, 11544.249623774427, 11715.531378745096, 10947.452627368759, 11053.502592383524, 11148.721281968015, 11171.162162837658, 11413.543458261576, 11294.830577541179, 11331.546738130712, 11435.771284574428, 11515.596954106566, 11649.883501165219, 8050.235227653364, 8196.385271104571, 8205.179482051986, 8530.914690853013, 8681.956590217009, 9014.459132451811, 11047.0, 11052.447377631248, 11299.152563557602, 11707.648770536898], "value": 9751.851927875568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1146.3924120216277, 1485.7548504496758, 1536.8616824485794, 1670.9582260443487, 1837.5130590393549, 7993.560354180518, 8792.736217913465, 9034.503102329369, 9041.909580904188, 9369.250459963203, 9110.908890911089, 9174.770630734234, 9175.632974681004, 9175.954120229406, 9183.862242066374, 2527.9747202527924, 2559.5648739714293, 2560.334313078604, 2560.3983063980045, 2562.1160699558623, 2491.4394261291154, 2558.206955843685, 2561.0, 2563.1797824696105, 2563.846169229843, 2519.4709111086695, 2533.4553071089713, 2553.8595377254337, 2558.5394628966874, 2559.34736642156, 2454.202384225125, 2462.310553045141, 2470.419451428913, 2524.217492577307, 2525.444402231506, 2452.730199678034, 2456.545539075277, 2474.270090323359, 2482.0692240409844, 2495.5008998200433, 9189.954050229706, 9198.310126740522, 9284.628614855397, 9455.196308313802, 9540.522973851279, 5447.836564903059, 5595.1886976388605, 5648.519875810561, 5673.886522269573, 5687.289088863892, 3595.9640403596154, 3645.471406646048, 3662.597114317423, 3663.0, 3690.704743620504, 1217.2148963918312, 1236.5548402575066, 1239.3121817391345, 1259.0242562014512, 1268.3404629592653, 13155.144915580457, 13514.526991555347, 13515.0, 13515.59453216405, 13516.459341626422, 4865.416150062015, 4873.122837889214, 4957.157283261854, 5048.0, 5049.394072711299, 11184.496697648463, 11189.72025699364, 11190.272632278877, 11190.32858028521, 11190.552377904793, 5727.398623144593, 5730.169125476866, 5739.339975902742, 5739.885202295931, 5740.971295143498, 4384.408104905797, 4395.626371758436, 4413.183561041217, 4557.931631025537, 5299.761510732026, 4251.29853574163, 4373.212821692063, 4467.039586488921, 4468.419105516327, 4476.283794592915, 1390.2353705461956, 1412.2091628687967, 1424.266502751084, 1434.2470203143432, 1447.978280325796, 835.3692961813791, 920.742192186189, 987.0622908237203, 996.9102780749768, 1001.6293971230546, 6069.575129740876, 6322.33615470369, 6357.523185761086, 6384.48924086072, 6485.578437401554, 446.1634435433562, 458.2073013686275, 461.69758807980156, 462.12427449982096, 475.0664943386263, 4290.806913688892, 4334.739915605074, 4398.362237475612, 4403.779811009436, 4433.357163211316, 12086.637400877988, 12276.447559859827, 12326.691832704075, 12327.75344493123, 12344.074194435274, 12219.327936963553, 12252.571160009356, 12258.693532661755, 12270.202436841577, 12270.32513211782, 8617.310615150773, 8910.420822646507, 8995.100489950952, 9155.13026262504, 9204.63181472747, 5979.940200597938, 6118.663473509, 6154.815355539341, 6198.659073750987, 6320.5259605528845, 11359.318440893572, 11466.885331146581, 11588.304701717923, 11592.826107608224, 11607.419629018346, 11261.887381126084, 11296.661100167008, 11323.207375483636, 11343.943280283545, 11696.35670038156, 8763.737087887373, 9121.954390228271, 9242.630294788134, 9303.255739540686, 9314.813703726024, 9272.768180795534, 9381.765455863659, 9417.764555886157, 9441.103095205945, 9448.574814133519, 8064.959675201587, 8356.498610083414, 8396.118407567361, 8442.32461403074, 8574.356923230658, 7991.2408321211715, 8260.29787468072, 8297.502149871027, 8431.451955622864, 8552.358573106918, 7421.2949769771785, 7422.591757453176, 7491.363234124942, 7501.062367204099, 7502.287282708134, 5269.683818970874, 5345.438728933406, 5378.865528361822, 5475.780968761364, 5494.945050549443, 5338.706371149624, 5438.592105592017, 5490.368607610176, 5490.615656904138, 5655.575831812548], "value": 4889.180024431769, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.37805681432536, 335.2122512096572, 338.1950956722999, 342.108806558914, 345.20774821784005, 5304.77990062285, 5458.0, 5462.808801691942, 5487.53355964743, 5499.422560631131, 5255.185446255837, 5371.838844834661, 5385.67685938844, 5400.6498375406145, 5423.2136340230645, 4264.147170565884, 4268.0, 4278.828846846138, 4291.35629655551, 4296.935545966798, 4158.97920510397, 4247.384129301249, 4280.208161490119, 4280.293751530994, 4281.914361712764, 4233.259179643565, 4233.555476674951, 4234.555371685975, 4247.702660813744, 4249.19265339586, 4222.303319952204, 4222.944263934017, 4233.216854881856, 4251.766152861592, 4279.930017495626, 3734.439834024918, 3803.2773772983046, 3808.0860593457646, 3820.522434695663, 3831.4827498287655, 5252.1596544552685, 5263.0, 5273.4462881397285, 5294.41761406245, 5295.443978382292, 4871.196252618313, 4871.197656866946, 4918.3360246367, 4924.3105965164905, 4941.135301322254, 5465.125579907235, 5621.353544342372, 5655.123455864347, 5659.745311460994, 5667.971660141714, 4101.425800387948, 4141.420201171808, 4145.937810932838, 4155.958440415588, 4161.334186530141, 5876.177335173079, 5889.1755154278435, 5892.970535147297, 5900.527957763368, 5995.370486098984, 4156.147989662112, 4210.810513526899, 4275.187714334266, 4276.18752437036, 4276.828926842892, 4251.893702657397, 4256.9996050928, 4302.806373713191, 4313.223619748475, 4328.220920234388, 4875.219964805614, 4877.585405240523, 4886.315915771795, 4888.655619704609, 4892.8532144035735, 5456.536194423439, 5655.575831812631, 5662.37713851476, 5695.658260504383, 5751.453611906946, 1448.449589156114, 1460.9269536523132, 1464.7509923313062, 1468.9632759180893, 1472.0578829549097, 901.5762591581946, 938.1650331205233, 940.3464592108555, 942.4816351007056, 942.6465075596651, 4903.803847846118, 4911.4106307243355, 4926.438252108955, 4931.3835770528685, 4935.457099719028, 5177.844664660066, 5179.404368497671, 5182.046233646861, 5188.429272779991, 5242.633015688865, 4763.856674398189, 4868.393430168036, 4946.258061290763, 4959.950400495949, 4986.950130498722, 2746.917592472229, 2750.4499100180046, 2754.73829986151, 2756.54517004696, 2770.362816552164, 5320.802819365689, 5354.54486368663, 5359.11464188468, 5388.787522807415, 5400.810971615974, 4929.088118698052, 5245.842624721265, 5250.369955605352, 5264.5525130363585, 5272.578193744491, 5249.895002099936, 5279.868003299948, 5306.575473962073, 5313.0247061645605, 5313.468653134656, 5166.2508936204795, 5178.300929374486, 5189.818356357509, 5211.583073354198, 5234.738263086907, 5167.276581278699, 5478.808241711521, 5832.825015249549, 5856.180134781219, 5873.618214816023, 6080.939190608037, 6098.908516372347, 6100.969495152496, 6123.510119190543, 6127.264728232641, 3890.3580909150805, 4005.759654420744, 4095.0990782027907, 4144.834206631701, 4313.0726893718, 5840.328362238397, 5867.002609556301, 5873.706314684163, 5894.587378883609, 5899.203607512931, 5665.66006039639, 5756.194132821324, 5770.2498675171955, 5787.623804452697, 5810.750688601971, 5683.630564013326, 5687.544996400361, 5725.770969161187, 5733.254676891977, 5744.741486633028, 5709.51469125129, 5714.971425142848, 5724.227229324155, 5736.397678243724, 5758.523834751098, 5508.504234618904, 5710.885782284414, 5736.139579063174, 5756.0, 5842.977478941253, 5594.41258667834, 5612.7193640317, 5618.2415373924, 5624.718764061862, 5680.914786278292], "value": 4244.239406660563, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.4626430894841, 790.5730905311133, 847.1063028504929, 868.0, 882.5146169606714, 16205.83794162058, 17170.141492925366, 17180.0, 17202.741958870625, 17207.82792172078, 16023.038617682947, 16151.353945842182, 16180.919095404535, 16270.186490675478, 16397.67204655909, 529.134864496547, 541.1368866657675, 852.6120615120136, 861.0356400831063, 873.0789017586444, 871.6426265231256, 877.6928075173702, 878.8418084744743, 879.3536750488386, 883.8188171424874, 939.7462685075026, 940.4216406909735, 941.2187884056217, 941.8822647169104, 942.2838642631581, 551.9199716041171, 563.0877977676171, 892.3797960417512, 920.7559996600907, 933.276710549323, 679.2358596578849, 679.813051410861, 680.7175022365712, 682.8224661587973, 683.0676127086491, 16476.67046659072, 16530.00819950795, 16532.09073500957, 16548.75176872348, 16552.337906483725, 15123.39506419753, 15628.282023842092, 15715.842841571552, 15717.842821571752, 16032.599185020352, 11588.88411115895, 11803.704907377385, 11857.347845868473, 13770.311484425738, 14720.558383248519, 4808.364457049284, 4810.78351474181, 5066.873328166826, 5108.591312695013, 5129.384473863161, 50747.23879141816, 51046.7447662763, 64537.354626453605, 84038.15961840303, 85374.0, 12823.35883205836, 13249.602511924657, 13517.32413379327, 13545.458181672622, 14049.929750351388, 24444.755552444247, 24675.136370226955, 24704.13535526248, 24802.25593232206, 24857.378565535644, 9714.125728684452, 9719.416834989923, 9796.412215267106, 9891.554880030415, 9969.302148849656, 5010.1983682611335, 5177.896442071213, 5188.92216616751, 5293.364796224478, 5402.91895621566, 3730.869419570302, 3858.401947698111, 3862.787546684903, 3863.0, 3868.6518213360932, 654.4371840217409, 657.3907026172077, 660.4386271669139, 663.1081195791653, 667.8363800868818, 619.2352444730844, 746.4625469661835, 824.5712229640553, 828.1759649149135, 852.4331319672349, 10108.646197383056, 10613.5223914924, 11037.172212084126, 11090.809790973604, 11362.886371136348, 698.183125742882, 729.6825880741894, 766.6894907562446, 802.6428239433396, 830.2527725047505, 5201.29782479368, 5397.622166448311, 5461.6996065216, 5474.42518535556, 5507.531859791882, 73184.26815731774, 76818.61590692123, 132283.67716322906, 133084.3345783265, 134509.0, 109563.0, 111582.0, 113789.43105284586, 114095.0, 119158.0, 98218.0, 99374.00625993648, 99851.50074249727, 102322.48838755759, 102736.0, 10144.442055687008, 10277.434741089312, 10374.585016599553, 10622.8406573903, 10646.89353106459, 40189.59810401859, 42908.0, 47811.0, 49160.0, 49987.50012499974, 76920.0, 77495.61252193703, 79952.60023700076, 80986.19013809787, 81203.5939820297, 13840.377183026587, 13924.791128132883, 13935.09421887574, 14326.426942922166, 14574.635634109232, 15007.924960375129, 15267.0, 15281.235938203268, 15754.606134846721, 15804.60488487797, 15251.542453726406, 15445.922770386076, 15488.690226195638, 15729.606759831096, 16709.331626734795, 14465.927670361581, 15261.0, 15360.462383816513, 15664.451744188898, 15802.209889505708, 14351.784723228951, 14438.927805360907, 14470.276486175439, 14684.706305874037, 15165.393384264506, 12516.624501264976, 12678.809817852554, 13179.406926688514, 13247.735045298847, 13423.932880335537, 13217.14088584239, 13252.602421926971, 13304.401301941241, 13347.399367028313, 13625.0], "value": 8195.530274693672, "unit": "score"}], "name": "dromaeo_css", "value": 7637.638869553195, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 111.0, 110.0, 110.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 119.0, 118.0, 145.0, 117.0, 118.0, 121.0, 117.0, 151.0, 119.0], "value": 126.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 161.0, 161.0, 162.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 118.0, 75.0, 75.0, 76.0, 75.0, 101.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 110.0, 81.0, 81.0, 82.0, 106.0, 81.0, 82.0, 117.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 148.0, 148.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 48.0, 48.0, 49.0, 48.0, 48.0, 48.0, 48.0, 49.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 73.0, 72.0, 73.0, 74.0, 73.0, 81.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 125.0, 119.0, 120.0, 120.0, 119.0, 118.0, 156.0, 122.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 158.0, 158.0, 155.0, 153.0, 152.0, 151.0, 155.0, 153.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 62.0, 61.0, 62.0, 61.0, 62.0, 60.0, 59.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1449.4000000000003, "alertThreshold": 2.0}]} 14:48:24 INFO - Return code: 0 14:48:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:48:24 INFO - # TBPL SUCCESS # 14:48:24 INFO - Running post-action listener: _resource_record_post_action 14:48:24 INFO - [mozharness: 2016-10-28 21:48:24.864974Z] Finished run-tests step (success) 14:48:24 INFO - Running post-run listener: _resource_record_post_run 14:48:24 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 16384; Write bytes: 358121472; Read time: 408; Write time: 240296 14:48:24 INFO - TinderboxPrint: CPU usage
13.0% 14:48:24 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 408 14:48:24 INFO - TinderboxPrint: I/O write bytes / time
358,121,472 / 240,296 14:48:24 INFO - TinderboxPrint: CPU idle
8,264.8 (87.0%) 14:48:24 INFO - TinderboxPrint: CPU user
1,190.3 (12.5%) 14:48:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:48:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107425792; Read time: 188; Write time: 91068 14:48:24 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250695680; Read time: 208; Write time: 149228 14:48:25 INFO - Running post-run listener: _upload_blobber_files 14:48:25 INFO - Blob upload gear active. 14:48:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:48:25 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'] 14:48:25 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 14:48:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:30 INFO - (blobuploader) - INFO - Done attempting. 14:48:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:48:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:48:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:31 INFO - (blobuploader) - INFO - Done attempting. 14:48:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:48:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:48:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:32 INFO - (blobuploader) - INFO - Done attempting. 14:48:32 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:32 INFO - Return code: 0 14:48:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f4fab123f0f591ec6bd459586ab506a1c2ea71fca60b603bd1dc1d4d539635d717e70f74c91de1f30a2416cee1a2a5bc6d60db87c03201955143ea9d9e06480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53de591965fe31ffbf484d84696b57bdb4a20060821492d7c8aa4a9b6564c89f28a059723f58485a2f548a7f212045b46c8f6bdcc780858dd015d571749f0da6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96459ef7362413be38d87aca670488568d62ec3612a3a6be826edf91f3497a500d00ad7d83652c242bbd72897ea555a1ea0168131a986a5dc57a76e47c82250a"} 14:48:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:32 INFO - Contents: 14:48:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f4fab123f0f591ec6bd459586ab506a1c2ea71fca60b603bd1dc1d4d539635d717e70f74c91de1f30a2416cee1a2a5bc6d60db87c03201955143ea9d9e06480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53de591965fe31ffbf484d84696b57bdb4a20060821492d7c8aa4a9b6564c89f28a059723f58485a2f548a7f212045b46c8f6bdcc780858dd015d571749f0da6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96459ef7362413be38d87aca670488568d62ec3612a3a6be826edf91f3497a500d00ad7d83652c242bbd72897ea555a1ea0168131a986a5dc57a76e47c82250a"} 14:48:32 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:32 INFO - Copying logs to upload dir... 14:48:32 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.613581 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-28 14:48:32.296705) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 14:48:32.301752) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549 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/8f4fab123f0f591ec6bd459586ab506a1c2ea71fca60b603bd1dc1d4d539635d717e70f74c91de1f30a2416cee1a2a5bc6d60db87c03201955143ea9d9e06480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53de591965fe31ffbf484d84696b57bdb4a20060821492d7c8aa4a9b6564c89f28a059723f58485a2f548a7f212045b46c8f6bdcc780858dd015d571749f0da6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96459ef7362413be38d87aca670488568d62ec3612a3a6be826edf91f3497a500d00ad7d83652c242bbd72897ea555a1ea0168131a986a5dc57a76e47c82250a"} build_url:https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/GN9-COLPSoudayNDOYcWKw/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/8f4fab123f0f591ec6bd459586ab506a1c2ea71fca60b603bd1dc1d4d539635d717e70f74c91de1f30a2416cee1a2a5bc6d60db87c03201955143ea9d9e06480", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53de591965fe31ffbf484d84696b57bdb4a20060821492d7c8aa4a9b6564c89f28a059723f58485a2f548a7f212045b46c8f6bdcc780858dd015d571749f0da6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96459ef7362413be38d87aca670488568d62ec3612a3a6be826edf91f3497a500d00ad7d83652c242bbd72897ea555a1ea0168131a986a5dc57a76e47c82250a"}' ========= master_lag: 0.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 14:48:32.609175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 14:48:32.612522) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477687574.629045-1772405549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 14:48:32.692002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 14:48:32.692326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 14:48:32.692615) ========= ========= Total master_lag: 1.59 =========