builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1481729820.71 results: success (0) buildid: 20161214064000 builduid: 37fba335eab44119a68e556670742965 revision: 2ff0593e62770ffecbf993063a9c0d271beaeb03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:00.707901) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:00.708410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:00.708702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:00.725435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:00.725879) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 07:37:01-- 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% 229M=0s 2016-12-14 07:37:01 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.319528 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.059474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.059809) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019842 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.109451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.109812) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ff0593e62770ffecbf993063a9c0d271beaeb03 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2ff0593e62770ffecbf993063a9c0d271beaeb03 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 07:37:01,978 truncating revision to first 12 chars 2016-12-14 07:37:01,978 Setting DEBUG logging. 2016-12-14 07:37:01,978 attempt 1/10 2016-12-14 07:37:01,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ff0593e6277?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 07:37:02,291 unpacking tar archive at: mozilla-central-2ff0593e6277/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631463 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.755666) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.756004) ========= script_repo_revision: 2ff0593e62770ffecbf993063a9c0d271beaeb03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.756480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.756781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 07:37:01.768394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-14 07:37:01.768675) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:02 INFO - MultiFileLogger online at 20161214 07:37:02 in /builds/slave/test 07:37:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:37:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:02 INFO - {'append_to_log': False, 07:37:02 INFO - 'base_work_dir': '/builds/slave/test', 07:37:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:37:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:02 INFO - 'branch': 'Firefox-Non-PGO', 07:37:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:02 INFO - 'config_files': ('talos/linux_config.py',), 07:37:02 INFO - 'default_actions': ('clobber', 07:37:02 INFO - 'read-buildbot-config', 07:37:02 INFO - 'download-and-extract', 07:37:02 INFO - 'populate-webroot', 07:37:02 INFO - 'create-virtualenv', 07:37:02 INFO - 'install', 07:37:02 INFO - 'run-tests'), 07:37:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:02 INFO - 'download_minidump_stackwalk': True, 07:37:02 INFO - 'download_symbols': 'ondemand', 07:37:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:02 INFO - 'installer_path': 'installer.exe', 07:37:02 INFO - 'log_level': 'info', 07:37:02 INFO - 'log_name': 'talos', 07:37:02 INFO - 'log_to_console': True, 07:37:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:02 INFO - 'opt_config_files': (), 07:37:02 INFO - 'pip_index': False, 07:37:02 INFO - 'sps_profile': False, 07:37:02 INFO - 'sps_profile_interval': 0, 07:37:02 INFO - 'suite': 'dromaeojs', 07:37:02 INFO - 'system_bits': '32', 07:37:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:02 INFO - 'title': 'talos-linux64-ix-051', 07:37:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:02 INFO - 'use_talos_json': True, 07:37:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:02 INFO - 'work_dir': 'build'} 07:37:02 INFO - [mozharness: 2016-12-14 15:37:02.737916Z] Running clobber step. 07:37:02 INFO - Running pre-action listener: _resource_record_pre_action 07:37:02 INFO - Running main action method: clobber 07:37:02 INFO - rmtree: /builds/slave/test/build 07:37:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:03 INFO - Running post-action listener: _resource_record_post_action 07:37:03 INFO - [mozharness: 2016-12-14 15:37:03.203311Z] Finished clobber step (success) 07:37:03 INFO - [mozharness: 2016-12-14 15:37:03.203411Z] Running read-buildbot-config step. 07:37:03 INFO - Running pre-action listener: _resource_record_pre_action 07:37:03 INFO - Running main action method: read_buildbot_config 07:37:03 INFO - Using buildbot properties: 07:37:03 INFO - { 07:37:03 INFO - "project": "", 07:37:03 INFO - "product": "firefox", 07:37:03 INFO - "script_repo_revision": "production", 07:37:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:37:03 INFO - "repository": "", 07:37:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:37:03 INFO - "buildid": "20161214064000", 07:37:03 INFO - "pgo_build": "False", 07:37:03 INFO - "basedir": "/builds/slave/test", 07:37:03 INFO - "buildnumber": 342, 07:37:03 INFO - "slavename": "talos-linux64-ix-051", 07:37:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:37:03 INFO - "platform": "ubuntu64_hw", 07:37:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:37:03 INFO - "branch": "mozilla-central", 07:37:03 INFO - "repo_path": "mozilla-central", 07:37:03 INFO - "revision": "2ff0593e62770ffecbf993063a9c0d271beaeb03", 07:37:03 INFO - "stage_platform": "linux64", 07:37:03 INFO - "builduid": "37fba335eab44119a68e556670742965", 07:37:03 INFO - "slavebuilddir": "test" 07:37:03 INFO - } 07:37:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:37:03 INFO - Running post-action listener: _resource_record_post_action 07:37:03 INFO - [mozharness: 2016-12-14 15:37:03.205839Z] Finished read-buildbot-config step (success) 07:37:03 INFO - [mozharness: 2016-12-14 15:37:03.205927Z] Running download-and-extract step. 07:37:03 INFO - Running pre-action listener: _resource_record_pre_action 07:37:03 INFO - Running main action method: download_and_extract 07:37:03 INFO - mkdir: /builds/slave/test/build/tests 07:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:03 INFO - trying https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:37:03 INFO - Downloaded 1361 bytes. 07:37:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:37:03 INFO - Using the following test package requirements: 07:37:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'jsshell-linux-x86_64.zip'], 07:37:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:37:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:03 INFO - Fetch https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:04 INFO - Expected file size: 20212057 07:37:04 INFO - Obtained file size: 20212057 07:37:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:37:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:37:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:08 INFO - Fetch https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:09 INFO - Expected file size: 20212057 07:37:09 INFO - Obtained file size: 20212057 07:37:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:13 INFO - Fetch https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:37:15 INFO - Expected file size: 14409734 07:37:15 INFO - Obtained file size: 14409734 07:37: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')]} 07:37:15 INFO - trying https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:15 INFO - Downloading https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:17 INFO - Downloaded 55774978 bytes. 07:37:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:17 INFO - mkdir: /builds/slave/test/properties 07:37:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:17 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:17 INFO - Contents: 07:37:17 INFO - build_url:https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:37:18 INFO - Running post-action listener: _resource_record_post_action 07:37:18 INFO - Running post-action listener: set_extra_try_arguments 07:37:18 INFO - [mozharness: 2016-12-14 15:37:18.605061Z] Finished download-and-extract step (success) 07:37:18 INFO - [mozharness: 2016-12-14 15:37:18.605288Z] Running populate-webroot step. 07:37:18 INFO - Running pre-action listener: _resource_record_pre_action 07:37:18 INFO - Running main action method: populate_webroot 07:37:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:18 INFO - '--tppagecycles', 07:37:18 INFO - '7'], 07:37:18 INFO - 'tests': ['tsvgm']}}, 07:37:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['damp', 'tps']}, 07:37:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:37:18 INFO - 'tests': ['damp', 'tps']}, 07:37:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['dromaeo_dom']}, 07:37:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['basic_compositor_video']}, 07:37:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['a11yr', 07:37:18 INFO - 'ts_paint', 07:37:18 INFO - 'tpaint', 07:37:18 INFO - 'sessionrestore', 07:37:18 INFO - 'sessionrestore_no_auto_restore', 07:37:18 INFO - 'tabpaint']}, 07:37:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tsvgx', 07:37:18 INFO - 'tsvgr_opacity', 07:37:18 INFO - 'tart', 07:37:18 INFO - 'tscrollx', 07:37:18 INFO - 'cart', 07:37:18 INFO - 'tsvg_static']}, 07:37:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:18 INFO - 'tsvgr_opacity', 07:37:18 INFO - 'tart', 07:37:18 INFO - 'tscrollx', 07:37:18 INFO - 'cart', 07:37:18 INFO - 'tsvg_static']}, 07:37:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s'], 07:37:18 INFO - 'tests': ['tp5o']}, 07:37:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:37:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:37:18 INFO - 'talos_options': ['--disable-e10s', 07:37:18 INFO - '--xperf_path', 07:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:18 INFO - 'tests': ['tp5n']}, 07:37:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:37:18 INFO - 'talos_options': ['--xperf_path', 07:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:18 INFO - 'tests': ['tp5n']}}, 07:37:18 INFO - 'talos.zip': {'path': '', 07:37:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:18 INFO - Running post-action listener: _resource_record_post_action 07:37:18 INFO - [mozharness: 2016-12-14 15:37:18.621965Z] Finished populate-webroot step (success) 07:37:18 INFO - [mozharness: 2016-12-14 15:37:18.622053Z] Running create-virtualenv step. 07:37:18 INFO - Running pre-action listener: _resource_record_pre_action 07:37:18 INFO - Running main action method: create_virtualenv 07:37:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:37:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:18 INFO - Using real prefix '/usr' 07:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:21 INFO - Installing pip.................done. 07:37:21 INFO - Return code: 0 07:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:37:21 INFO - Reading from file tmpfile_stdout 07:37:21 INFO - Output received: 07:37:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:37:21 INFO - Using env: {'DISPLAY': ':0', 07:37:21 INFO - 'HOME': '/home/cltbld', 07:37:21 INFO - 'LANG': 'en_US.UTF-8', 07:37:21 INFO - 'LANGUAGE': 'en_US:en', 07:37:21 INFO - 'LOGNAME': 'cltbld', 07:37:21 INFO - 'MAIL': '/var/mail/cltbld', 07:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:21 INFO - 'MOZ_NO_REMOTE': '1', 07:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:21 INFO - 'NO_EM_RESTART': '1', 07:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:21 INFO - 'PWD': '/builds/slave/test', 07:37:21 INFO - 'SHELL': '/bin/bash', 07:37:21 INFO - 'SHLVL': '1', 07:37:21 INFO - 'TERM': 'linux', 07:37:21 INFO - 'TMOUT': '86400', 07:37:21 INFO - 'USER': 'cltbld', 07:37:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:21 INFO - '_': '/tools/buildbot/bin/python'} 07:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:37:21 INFO - Cleaning up... 07:37:21 INFO - Return code: 0 07:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:37:21 INFO - Using env: {'DISPLAY': ':0', 07:37:21 INFO - 'HOME': '/home/cltbld', 07:37:21 INFO - 'LANG': 'en_US.UTF-8', 07:37:21 INFO - 'LANGUAGE': 'en_US:en', 07:37:21 INFO - 'LOGNAME': 'cltbld', 07:37:21 INFO - 'MAIL': '/var/mail/cltbld', 07:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:21 INFO - 'MOZ_NO_REMOTE': '1', 07:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:21 INFO - 'NO_EM_RESTART': '1', 07:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:21 INFO - 'PWD': '/builds/slave/test', 07:37:21 INFO - 'SHELL': '/bin/bash', 07:37:21 INFO - 'SHLVL': '1', 07:37:21 INFO - 'TERM': 'linux', 07:37:21 INFO - 'TMOUT': '86400', 07:37:21 INFO - 'USER': 'cltbld', 07:37:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:21 INFO - '_': '/tools/buildbot/bin/python'} 07:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:21 INFO - Downloading/unpacking psutil>=3.1.1 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:23 INFO - Installing collected packages: psutil 07:37:23 INFO - Running setup.py install for psutil 07:37:23 INFO - building 'psutil._psutil_linux' extension 07:37:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:37:24 INFO - building 'psutil._psutil_posix' extension 07:37:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:37:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:24 INFO - Successfully installed psutil 07:37:24 INFO - Cleaning up... 07:37:24 INFO - Return code: 0 07:37:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:37:24 INFO - Using env: {'DISPLAY': ':0', 07:37:24 INFO - 'HOME': '/home/cltbld', 07:37:24 INFO - 'LANG': 'en_US.UTF-8', 07:37:24 INFO - 'LANGUAGE': 'en_US:en', 07:37:24 INFO - 'LOGNAME': 'cltbld', 07:37:24 INFO - 'MAIL': '/var/mail/cltbld', 07:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:24 INFO - 'MOZ_NO_REMOTE': '1', 07:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:24 INFO - 'NO_EM_RESTART': '1', 07:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:24 INFO - 'PWD': '/builds/slave/test', 07:37:24 INFO - 'SHELL': '/bin/bash', 07:37:24 INFO - 'SHLVL': '1', 07:37:24 INFO - 'TERM': 'linux', 07:37:24 INFO - 'TMOUT': '86400', 07:37:24 INFO - 'USER': 'cltbld', 07:37:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:24 INFO - '_': '/tools/buildbot/bin/python'} 07:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:26 INFO - Installing collected packages: mozsystemmonitor 07:37:26 INFO - Running setup.py install for mozsystemmonitor 07:37:26 INFO - Successfully installed mozsystemmonitor 07:37:26 INFO - Cleaning up... 07:37:26 INFO - Return code: 0 07:37:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:37:26 INFO - Using env: {'DISPLAY': ':0', 07:37:26 INFO - 'HOME': '/home/cltbld', 07:37:26 INFO - 'LANG': 'en_US.UTF-8', 07:37:26 INFO - 'LANGUAGE': 'en_US:en', 07:37:26 INFO - 'LOGNAME': 'cltbld', 07:37:26 INFO - 'MAIL': '/var/mail/cltbld', 07:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:26 INFO - 'MOZ_NO_REMOTE': '1', 07:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:26 INFO - 'NO_EM_RESTART': '1', 07:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:26 INFO - 'PWD': '/builds/slave/test', 07:37:26 INFO - 'SHELL': '/bin/bash', 07:37:26 INFO - 'SHLVL': '1', 07:37:26 INFO - 'TERM': 'linux', 07:37:26 INFO - 'TMOUT': '86400', 07:37:26 INFO - 'USER': 'cltbld', 07:37:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:26 INFO - '_': '/tools/buildbot/bin/python'} 07:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:27 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:29 INFO - warning: no files found matching '*.txt' 07:37:29 INFO - no previously-included directories found matching 'build' 07:37:29 INFO - no previously-included directories found matching 'dist' 07:37:29 INFO - no previously-included directories found matching '.git*' 07:37:29 INFO - Installing collected packages: jsonschema, functools32 07:37:29 INFO - Running setup.py install for functools32 07:37:29 INFO - warning: no files found matching '*.txt' 07:37:29 INFO - no previously-included directories found matching 'build' 07:37:29 INFO - no previously-included directories found matching 'dist' 07:37:29 INFO - no previously-included directories found matching '.git*' 07:37:29 INFO - Successfully installed jsonschema functools32 07:37:29 INFO - Cleaning up... 07:37:29 INFO - Return code: 0 07:37:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:37:29 INFO - Using env: {'DISPLAY': ':0', 07:37:29 INFO - 'HOME': '/home/cltbld', 07:37:29 INFO - 'LANG': 'en_US.UTF-8', 07:37:29 INFO - 'LANGUAGE': 'en_US:en', 07:37:29 INFO - 'LOGNAME': 'cltbld', 07:37:29 INFO - 'MAIL': '/var/mail/cltbld', 07:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:29 INFO - 'MOZ_NO_REMOTE': '1', 07:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:29 INFO - 'NO_EM_RESTART': '1', 07:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:29 INFO - 'PWD': '/builds/slave/test', 07:37:29 INFO - 'SHELL': '/bin/bash', 07:37:29 INFO - 'SHLVL': '1', 07:37:29 INFO - 'TERM': 'linux', 07:37:29 INFO - 'TMOUT': '86400', 07:37:29 INFO - 'USER': 'cltbld', 07:37:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:29 INFO - '_': '/tools/buildbot/bin/python'} 07:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:37:29 INFO - Cleaning up... 07:37:29 INFO - Return code: 0 07:37:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:29 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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:37:29 INFO - Using env: {'DISPLAY': ':0', 07:37:29 INFO - 'HOME': '/home/cltbld', 07:37:29 INFO - 'LANG': 'en_US.UTF-8', 07:37:29 INFO - 'LANGUAGE': 'en_US:en', 07:37:29 INFO - 'LOGNAME': 'cltbld', 07:37:29 INFO - 'MAIL': '/var/mail/cltbld', 07:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:29 INFO - 'MOZ_NO_REMOTE': '1', 07:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:29 INFO - 'NO_EM_RESTART': '1', 07:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:29 INFO - 'PWD': '/builds/slave/test', 07:37:29 INFO - 'SHELL': '/bin/bash', 07:37:29 INFO - 'SHLVL': '1', 07:37:29 INFO - 'TERM': 'linux', 07:37:29 INFO - 'TMOUT': '86400', 07:37:29 INFO - 'USER': 'cltbld', 07:37:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:29 INFO - '_': '/tools/buildbot/bin/python'} 07:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:32 INFO - Downloading docopt-0.6.1.tar.gz 07:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:32 INFO - Running setup.py install for blobuploader 07:37:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:32 INFO - Running setup.py install for requests 07:37:33 INFO - Running setup.py install for docopt 07:37:33 INFO - Successfully installed blobuploader requests docopt 07:37:33 INFO - Cleaning up... 07:37:33 INFO - Return code: 0 07:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:33 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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:33 INFO - Using env: {'DISPLAY': ':0', 07:37:33 INFO - 'HOME': '/home/cltbld', 07:37:33 INFO - 'LANG': 'en_US.UTF-8', 07:37:33 INFO - 'LANGUAGE': 'en_US:en', 07:37:33 INFO - 'LOGNAME': 'cltbld', 07:37:33 INFO - 'MAIL': '/var/mail/cltbld', 07:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:33 INFO - 'MOZ_NO_REMOTE': '1', 07:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:33 INFO - 'NO_EM_RESTART': '1', 07:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:33 INFO - 'PWD': '/builds/slave/test', 07:37:33 INFO - 'SHELL': '/bin/bash', 07:37:33 INFO - 'SHLVL': '1', 07:37:33 INFO - 'TERM': 'linux', 07:37:33 INFO - 'TMOUT': '86400', 07:37:33 INFO - 'USER': 'cltbld', 07:37:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:33 INFO - '_': '/tools/buildbot/bin/python'} 07:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:33 INFO - Running setup.py (path:/tmp/pip-bwhsNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:33 INFO - Running setup.py (path:/tmp/pip-cOPbZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:33 INFO - Running setup.py (path:/tmp/pip-odHjf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:33 INFO - Running setup.py (path:/tmp/pip-SR3lAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:33 INFO - Running setup.py (path:/tmp/pip-gFuVpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:33 INFO - Running setup.py (path:/tmp/pip-7LpXs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:34 INFO - Running setup.py (path:/tmp/pip-5mMA2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:34 INFO - Running setup.py (path:/tmp/pip-eCAKnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:34 INFO - Running setup.py (path:/tmp/pip-ufVle6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:34 INFO - Running setup.py (path:/tmp/pip-taDX6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:34 INFO - Running setup.py (path:/tmp/pip-CvKJja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:34 INFO - Running setup.py (path:/tmp/pip-yrGxmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:34 INFO - Running setup.py (path:/tmp/pip-65bjhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:34 INFO - Running setup.py (path:/tmp/pip-z2aI8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:34 INFO - Running setup.py (path:/tmp/pip-ctY6zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:34 INFO - Running setup.py (path:/tmp/pip-140cdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:34 INFO - Running setup.py (path:/tmp/pip-YrWG2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:34 INFO - Running setup.py install for manifestparser 07:37:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:34 INFO - Running setup.py install for mozcrash 07:37:35 INFO - Running setup.py install for mozdebug 07:37:35 INFO - Running setup.py install for mozdevice 07:37:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozfile 07:37:35 INFO - Running setup.py install for mozhttpd 07:37:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozinfo 07:37:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozInstall 07:37:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozleak 07:37:35 INFO - Running setup.py install for mozlog 07:37:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for moznetwork 07:37:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:35 INFO - Running setup.py install for mozprocess 07:37:36 INFO - Running setup.py install for mozprofile 07:37:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:36 INFO - Running setup.py install for mozrunner 07:37:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:36 INFO - Running setup.py install for mozscreenshot 07:37:36 INFO - Running setup.py install for moztest 07:37:36 INFO - Running setup.py install for mozversion 07:37:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:36 INFO - Cleaning up... 07:37:36 INFO - Return code: 0 07:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:36 INFO - Using env: {'DISPLAY': ':0', 07:37:36 INFO - 'HOME': '/home/cltbld', 07:37:36 INFO - 'LANG': 'en_US.UTF-8', 07:37:36 INFO - 'LANGUAGE': 'en_US:en', 07:37:36 INFO - 'LOGNAME': 'cltbld', 07:37:36 INFO - 'MAIL': '/var/mail/cltbld', 07:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:36 INFO - 'MOZ_NO_REMOTE': '1', 07:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:36 INFO - 'NO_EM_RESTART': '1', 07:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:36 INFO - 'PWD': '/builds/slave/test', 07:37:36 INFO - 'SHELL': '/bin/bash', 07:37:36 INFO - 'SHLVL': '1', 07:37:36 INFO - 'TERM': 'linux', 07:37:36 INFO - 'TMOUT': '86400', 07:37:36 INFO - 'USER': 'cltbld', 07:37:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:36 INFO - '_': '/tools/buildbot/bin/python'} 07:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:36 INFO - Running setup.py (path:/tmp/pip-bPQOZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:36 INFO - Running setup.py (path:/tmp/pip-lhYXGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:37 INFO - Running setup.py (path:/tmp/pip-hBxy4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:37 INFO - Running setup.py (path:/tmp/pip-y5sYCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:37 INFO - Running setup.py (path:/tmp/pip-V5Qyja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:37 INFO - Running setup.py (path:/tmp/pip-QMlAKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:37 INFO - Running setup.py (path:/tmp/pip-h_d8oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:37 INFO - Running setup.py (path:/tmp/pip-awr6Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:37 INFO - Running setup.py (path:/tmp/pip-IplGB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:37 INFO - Running setup.py (path:/tmp/pip-5W4xIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:37 INFO - Running setup.py (path:/tmp/pip-ywkmCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:37 INFO - Running setup.py (path:/tmp/pip-JCe4Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:37 INFO - Running setup.py (path:/tmp/pip-f8tQa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:37 INFO - Running setup.py (path:/tmp/pip-x59FjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:37 INFO - Running setup.py (path:/tmp/pip-Kg3FH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:37 INFO - Running setup.py (path:/tmp/pip-CWqJJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:38 INFO - Running setup.py (path:/tmp/pip-TeBzf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:40 INFO - Downloading blessings-1.6.tar.gz 07:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:40 INFO - Installing collected packages: blessings 07:37:40 INFO - Running setup.py install for blessings 07:37:40 INFO - Successfully installed blessings 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:40 INFO - Reading from file tmpfile_stdout 07:37:40 INFO - Current package versions: 07:37:40 INFO - argparse == 1.2.1 07:37:40 INFO - blessings == 1.6 07:37:40 INFO - blobuploader == 1.2.4 07:37:40 INFO - docopt == 0.6.1 07:37:40 INFO - functools32 == 3.2.3-2 07:37:40 INFO - jsonschema == 2.5.1 07:37:40 INFO - manifestparser == 1.1 07:37:40 INFO - mozInstall == 1.12 07:37:40 INFO - mozcrash == 1.0 07:37:40 INFO - mozdebug == 0.1 07:37:40 INFO - mozdevice == 0.49 07:37:40 INFO - mozfile == 1.2 07:37:40 INFO - mozhttpd == 0.7 07:37:40 INFO - mozinfo == 0.9 07:37:40 INFO - mozleak == 0.1 07:37:40 INFO - mozlog == 3.4 07:37:40 INFO - moznetwork == 0.27 07:37:40 INFO - mozprocess == 0.23 07:37:40 INFO - mozprofile == 0.28 07:37:40 INFO - mozrunner == 6.13 07:37:40 INFO - mozscreenshot == 0.1 07:37:40 INFO - mozsystemmonitor == 0.3 07:37:40 INFO - moztest == 0.7 07:37:40 INFO - mozversion == 1.4 07:37:40 INFO - psutil == 3.1.1 07:37:40 INFO - requests == 1.2.3 07:37:40 INFO - wsgiref == 0.1.2 07:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:40 INFO - Using env: {'DISPLAY': ':0', 07:37:40 INFO - 'HOME': '/home/cltbld', 07:37:40 INFO - 'LANG': 'en_US.UTF-8', 07:37:40 INFO - 'LANGUAGE': 'en_US:en', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MAIL': '/var/mail/cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SHLVL': '1', 07:37:40 INFO - 'TERM': 'linux', 07:37:40 INFO - 'TMOUT': '86400', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - '_': '/tools/buildbot/bin/python'} 07:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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 0x7fcaee22be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:37:40 INFO - Using env: {'DISPLAY': ':0', 07:37:40 INFO - 'HOME': '/home/cltbld', 07:37:40 INFO - 'LANG': 'en_US.UTF-8', 07:37:40 INFO - 'LANGUAGE': 'en_US:en', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MAIL': '/var/mail/cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SHLVL': '1', 07:37:40 INFO - 'TERM': 'linux', 07:37:40 INFO - 'TMOUT': '86400', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - '_': '/tools/buildbot/bin/python'} 07:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:41 INFO - Cleaning up... 07:37:41 INFO - Return code: 0 07:37:41 INFO - Running post-action listener: _resource_record_post_action 07:37:41 INFO - Running post-action listener: _start_resource_monitoring 07:37:41 INFO - Starting resource monitoring. 07:37:41 INFO - [mozharness: 2016-12-14 15:37:41.067531Z] Finished create-virtualenv step (success) 07:37:41 INFO - [mozharness: 2016-12-14 15:37:41.068053Z] Running install step. 07:37:41 INFO - Running pre-action listener: _resource_record_pre_action 07:37:41 INFO - Running main action method: install 07:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:41 INFO - Reading from file tmpfile_stdout 07:37:41 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:41 INFO - Reading from file tmpfile_stdout 07:37:41 INFO - Output received: 07:37:41 INFO - Usage: mozinstall [options] installer 07:37:41 INFO - Options: 07:37:41 INFO - -h, --help show this help message and exit 07:37:41 INFO - -d DEST, --destination=DEST 07:37:41 INFO - Directory to install application into. [default: 07:37:41 INFO - "/builds/slave/test"] 07:37:41 INFO - --app=APP Application being installed. [default: firefox] 07:37:41 INFO - mkdir: /builds/slave/test/build/application 07:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:37:57 INFO - Reading from file tmpfile_stdout 07:37:57 INFO - Output received: 07:37:57 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:57 INFO - Running post-action listener: _resource_record_post_action 07:37:57 INFO - [mozharness: 2016-12-14 15:37:57.445502Z] Finished install step (success) 07:37:57 INFO - [mozharness: 2016-12-14 15:37:57.445743Z] Running run-tests step. 07:37:57 INFO - Running pre-action listener: _resource_record_pre_action 07:37:57 INFO - Running main action method: run_tests 07:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:57 INFO - Python 2.7.3 07:37:57 INFO - Return code: 0 07:37:57 INFO - grabbing minidump binary from tooltool 07:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:57 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 0x11fef20>, '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 0x116bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:37:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:37:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:37:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:57 INFO - Return code: 0 07:37:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:37:57 INFO - Using env: {'DISPLAY': ':0', 07:37:57 INFO - 'HOME': '/home/cltbld', 07:37:57 INFO - 'LANG': 'en_US.UTF-8', 07:37:57 INFO - 'LANGUAGE': 'en_US:en', 07:37:57 INFO - 'LOGNAME': 'cltbld', 07:37:57 INFO - 'MAIL': '/var/mail/cltbld', 07:37:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:57 INFO - 'MOZ_NO_REMOTE': '1', 07:37:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:57 INFO - 'NO_EM_RESTART': '1', 07:37:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:57 INFO - 'PWD': '/builds/slave/test', 07:37:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:57 INFO - 'SHELL': '/bin/bash', 07:37:57 INFO - 'SHLVL': '1', 07:37:57 INFO - 'TERM': 'linux', 07:37:57 INFO - 'TMOUT': '86400', 07:37:57 INFO - 'USER': 'cltbld', 07:37:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760', 07:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:57 INFO - '_': '/tools/buildbot/bin/python'} 07:37:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:37:57 INFO - mozversion application_buildid: 20161214064000 07:37:57 INFO - mozversion application_changeset: 2ff0593e62770ffecbf993063a9c0d271beaeb03 07:37:57 INFO - mozversion application_display_name: Nightly 07:37:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:57 INFO - mozversion application_name: Firefox 07:37:57 INFO - mozversion application_remotingname: firefox 07:37:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:37:57 INFO - mozversion application_vendor: Mozilla 07:37:57 INFO - mozversion application_version: 53.0a1 07:37:57 INFO - mozversion platform_buildid: 20161214064000 07:37:57 INFO - mozversion platform_changeset: 2ff0593e62770ffecbf993063a9c0d271beaeb03 07:37:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:37:57 INFO - mozversion platform_version: 53.0a1 07:37:57 INFO - using testdate: 1481729877 07:37:57 INFO - actual date: 1481729877 07:37:57 INFO - starting webserver on 'localhost:53166' 07:37:57 INFO - SUITE-START | Running 2 tests 07:37:57 INFO - TEST-START | dromaeo_css 07:37:57 INFO - operating with platform_type : linux_ 07:37:57 INFO - Initialising browser for dromaeo_css test... 07:37:57 INFO - TEST-INFO | started process 10001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDy_ytP/profile http://localhost:53166/getInfo.html) 07:38:01 INFO - PROCESS | 10001 | __metrics Screen width/height:1600/1200 07:38:01 INFO - PROCESS | 10001 | colorDepth:24 07:38:01 INFO - PROCESS | 10001 | Browser inner width/height: 1024/697 07:38:01 INFO - PROCESS | 10001 | __metrics 07:38:02 INFO - PROCESS | 10001 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:02 INFO - PROCESS | 10001 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:03 INFO - TEST-INFO | 10001: exit 0 07:38:03 INFO - Browser initialized. 07:38:03 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:03 INFO - TEST-INFO | started process 10084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDy_ytP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:16 INFO - PROCESS | 10084 | RSS: Main: 173379584 07:38:16 INFO - PROCESS | 10084 | 07:39:07 INFO - PROCESS | 10084 | 1481729947834 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:41:19 INFO - PROCESS | 10084 | Cycle 1(1): loaded http://localhost:53166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53166/tests/dromaeo/cssquery-ext.html) 07:41:22 INFO - PROCESS | 10084 | RSS: Main: 382967808 07:41:22 INFO - PROCESS | 10084 | 07:44:25 INFO - PROCESS | 10084 | Cycle 1(1): loaded http://localhost:53166/tests/dromaeo/cssquery-ext.html (next: http://localhost:53166/tests/dromaeo/cssquery-jquery.html) 07:44:25 INFO - PROCESS | 10084 | RSS: Main: 285249536 07:44:25 INFO - PROCESS | 10084 | 07:47:28 INFO - PROCESS | 10084 | Cycle 1(1): loaded http://localhost:53166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53166/tests/dromaeo/cssquery-mootools.html) 07:47:28 INFO - PROCESS | 10084 | RSS: Main: 251449344 07:47:28 INFO - PROCESS | 10084 | 07:50:31 INFO - PROCESS | 10084 | Cycle 1(1): loaded http://localhost:53166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53166/tests/dromaeo/cssquery-prototype.html) 07:50:31 INFO - PROCESS | 10084 | RSS: Main: 221163520 07:50:31 INFO - PROCESS | 10084 | 07:53:34 INFO - PROCESS | 10084 | Cycle 1(1): loaded http://localhost:53166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53166/tests/dromaeo/cssquery-yui.html) 07:53:35 INFO - PROCESS | 10084 | RSS: Main: 224624640 07:53:35 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | Cycle 1(1): loaded http://localhost:53166/tests/dromaeo/cssquery-yui.html (next: http://localhost:53166/tests/dromaeo/cssquery-dojo.html) 07:56:38 INFO - PROCESS | 10084 | RSS: Main: 319361024 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | __start_tp_report 07:56:38 INFO - PROCESS | 10084 | _x_x_mozilla_page_load 07:56:38 INFO - PROCESS | 10084 | _x_x_mozilla_page_load_details 07:56:38 INFO - PROCESS | 10084 | |i|pagename|runs| 07:56:38 INFO - PROCESS | 10084 | |0;dojo.html;2528.822982391232;2532.778004194789;2566.3840678237225;2581.057913861441;2590.5078035173315;4412.646988240941;4458.487273963495;4520.208963431399;4572;4572.725636461811;4498.100379924012;4499.707519011262;4522.118186953546;4531;4536.364908912747;4195.559466256045;4218.367244913257;4220;4252.447181866353;4309.504406993189;3895.0749773123457;4280.5291417944;4288.099499105176;4335.0679603885155;4380.364847097169;4075.9796201019103;4091.6931230157857;4284.592963668447;4336.978315108436;4358.411614432059;4164.6251837334485;4170.562090980434;4178.8328466861285;4182.393552934807;4185.97907010466;4142.668586513072;4146.419501269825;4153.190127925056;4158.9376159357635;4161.271777438936;4515.977420112911;4535.365048893158;4565.383673204141;4586.610138138262;4608.608268297199;4878.0975519529;4885.682430641997;4887.657863949525;4894.7063176209185;4937.407511098655;4716.622670186377;4748.548887855648;4913.410390753097;4919.90160196794;4936.6050715943;4512.165249428834;4563.315502674593;4597.931031034537;4646.3495110684535;4655.3249778782565;5004.499550044967;5004.799808007639;5008.6744361616375;5011.373578302712;5012.758661935303;4808.182608956486;4808.3989501312335;4817.108834865561;4817.855464336076;4867.172580661296;4734.976325118352;4770.165221086296;4779.3070004849105;4820.3492528508905;4834.444038935568;4782.163121453732;4849.4908034655855;4850.95149048512;4853;4857.101436234308;4791;4796.592289655348;4803.975980120147;4809.759512024385;4846.588040016568;3991.6207960243732;4012.498437695288;4066.674666026711;4084;4111.5477297497255;3546.556680414948;3548.3258180945536;3551.076720052805;3581.83881725323;3647.6534729200685;4182.247195504778;4185.121124563815;4185.288500954845;4188.8324467020975;4226.873193804191;4903.607711383081;4905.533974272438;4908.803647854046;4911.68074075184;4942.258661200849;4040.1919616076316;4069.348904175318;4103.97948010258;4108.91782164355;4123;4323.675724320626;4337.934930976038;4340.414044104069;4382.824687012548;4387.473503179639;4384.188925048876;4386.846460373871;4388.451443569554;4391.473023237232;4427.180971520279;4688.026981450226;4691.179043667276;4737.526247375235;4824.49342818999;4850.975745121252;4385.407969924019;4417.845375411845;4434.911301773882;4446.155230506193;4448.510663827041;4784.880377990578;4796.184648609675;4797.928031079467;4798.23228283473;4845.030993801324;4715.174844402147;4828.058528586892;4831.178699621143;4831.903361932812;4877.12211801879;4622.329762184531;4679.508651591534;4681.953180468288;4682.789274482725;4683.953160468352;4625.421822272216;4678.69588476748;4686.156491831503;4688.531146885284;4690.132325519789;4611.031683346535;4617.145828021827;4618.63050955916;4623.098495793288;4633.884152896069;4667.83662571822;4697.177993851131;4711.15199264122;4711.952880471152;4713.033828065307;4616.007558374831;4633.698809577501;4633.76831158434;4636.049609829909;4659.603933665677 07:56:38 INFO - PROCESS | 10084 | |1;ext.html;510.8927125303686;531.4366771222504;544.0913674164145;554.8807006493603;565.8839937812746;37086.81456592717;39039.804800976024;39152;42411.575884241145;42523.36214956778;39665.801670991605;40442.797786011026;40473.797631011876;40522.18955620886;40567.59432405682;7115.43076553877;7423.517471364357;7694.807629809244;7702.807429814244;7703.614819259043;7039.894401583981;9557.092076252746;9769.218462523017;9785.168260697848;10108.595656173744;10073.44596047217;10162.441065741381;10166.89833101667;10167.288289819715;10167.644132455365;9998.650047248348;10044.447555384451;10065.547050382676;10070.395776253376;10085.49572521371;9821.165200957927;9854.176977259158;9885.654002109892;9887.307888447811;9890.357126786736;36857.44713829295;37220.44169337462;37253.81373093144;37271;37327.62672373296;3051.1761824307314;3092.597962264914;3169.857356418967;3213.935721285585;3387.6273609903137;27419.588706169423;27790.583141252897;28029.57955630667;28413.431731365465;28967.42065158706;3437.295354452331;3447.1037530242065;3507.013033422328;3531.1348719563616;3541.592716837571;229652;231780.59729845967;232471;232753;232889;51920.74039629778;52352.738236309335;52406;52410.47589524056;52427;53669.73165134228;53764.73117634387;53810.192847107326;53834.19248711273;53842.46157538453;11993.460294286779;12202.816957745641;12227.205231660091;12237.877621223673;12242.204256723284;8138.145494722969;8354.958225208835;8983.326250531236;9433.198178154797;9438.244940404751;16171.353145874033;16344.836551634331;16468.505944821674;16517.669646607;16807.495775126765;5511.200875872976;5536.335639723259;5551.8889622208135;5638.830835074954;5730.36965933747;774.7365895595525;819.8852160697508;865.385576240876;872.1583671756786;888.8444522208588;26294.474110517684;27661.446771064468;28054.158375248775;28128;28172.295692607848;908.150878928191;930.0517359968915;942.3544871762864;942.9198518126036;958.750724811554;14407.42370305197;14734.852651473348;14755.336009879367;14951.476698315724;15018.098914065191;329023;330870;332846;333003;333269;48166.5183348169;48262.5173748258;48270.27594586084;48302.75848620734;48384.338861362965;1030.4229631406436;1075.5805235957982;1100.9614663486739;1161.1697636190165;1162.4826952006276;26536.601950970366;27829.52469376106;28571;28783.71216287894;29085.418291634473;41048.384274235315;41603.1679366417;41615;41654.583454166284;41664.58335416607;255262;255642;255962;256662;256996;22512.77487225107;22984.770152298264;23363.76636233616;24258.636120457853;35814.4627830588;35764.105897352776;35852;35863.64136358707;35933;36482.63517364899;30656.846715766278;31015.379692406477;31249.218769530944;31284.843575781975;31819.36361272808;30799.692003080578;31007.84496077505;31216.473611325775;31418.842905785325;32326.515102273013;31271.84364078165;31498.84250578824;31691.683083168875;31742.841285793424;32207.677923220468;27000.86499567568;28729.13812585542;28937.610753445442;29206.41587168287;29233.85383073071;22563.887180563994;22800.885995569915;22808.771912280667;23120.4219894504;23237.41906452352 07:56:38 INFO - PROCESS | 10084 | |2;jquery.html;339.5772263531903;349.9125218695326;361.1332801276935;362.7497027051334;381.5824213048526;12349.814752778715;15500.302486388111;15584.68830623387;16804.663906721857;16888.662226755456;16371.345146194139;16435.83564164361;16539.751903721455;16664.75002874958;16679.583010424714;4776.164171270014;4813.398325209358;4909.3126962225315;4959.107360675077;5047.671901326402;3642.562892452909;3822.445745366934;4823.469418363977;4914.410270767495;4920.901581968358;5351.384590772072;5592.217089607459;5600.5799565032585;5679.2049113123985;5689.658620482764;5462.644928079662;5668.744906479218;5676.858078548028;5684.602077854552;5746.626469279525;5088.338515992934;5100.464451232641;5103.54068133866;5103.9489605103845;5104.208847628586;19311.130999105073;19444.611107777764;19630;19763.30828421013;20167.394978150533;1879.351623689825;1879.3610172541264;1880.4452686457391;1882.9623407531772;1930.2279088364626;11977.520899164023;12947;12947.611571652771;13259.138156019924;13615.591532254048;1657.78448801655;1658.784358033448;1694.466243133409;1717.845393914541;1818.0727828807403;40230;54317.45682543163;54658.726706366615;60880.39119608791;63158;8989.820203595891;9273.67542136022;9288.860667089999;9371.203447707021;9567.61729530825;12890;12898.097133200587;12904.548340808027;12911.741765164832;12917.095803293867;6522.673866306665;6563.442107420828;6711.563748356341;6724.159480064992;6749.763758268437;6154.076888466766;6197.101420294032;6295.150154729145;6297.905531417033;6353.777617783356;5815.970920145457;5932.525397968152;5966.701664916824;6007.249093863267;6075.934182377924;1629.266829926514;1653.4378311374192;1667.7581750646332;1689.1554222888556;1691.7631531585587;691.5885048396196;794.8529522038441;851.0765819086237;911.4303560274828;920.9585568649293;15859;16574.883813902306;17132.314707411813;17242.827571724374;17368.47894563165;808.8099296665279;846.5428668518931;884.7478468636408;913.2420091324175;931.5854444772011;7714.459987800912;9332.34673572857;9768.120869121813;9842.409455432697;10020.649277275406;330815;334224;346830;353843;353878;73523;78260.21739782643;79349.20650793533;80266;80572.59713701395;816.8447994880953;824.7402068348451;846.9618867150994;848.291676450171;857.6355049104105;13759.243241621407;14528.709425811636;14548.563543093724;15117.319720612819;15739.685206296039;32267;32530;32999.835000825806;33181.50227746538;36178.8191059043;41730.45291150165;45278.54721452743;45707;46082;46902.76548617235;7345.5959922202655;7558.01745773046;7558.13081495613;7728;7843.215678432111;10369.896301036893;10535.367877927349;10575.524101415609;11225.158113141384;11929.46317415701;9889.901100989186;10040.69877903664;10051.396916185053;10207;10404.11565016982;9569.28230382738;9680.128788408796;9715.22278217755;10091.243156763125;10091.646792362231;9668.419894806335;9674.70975870725;9919.45443000613;10043.397396156253;10255.487225638837;7361.447891408059;7502.512336698097;7502.924970750222;7561.621918903923;7598.772036838904;9390.483523406278;9701.272404569827;9737;9802.26483013791;10167.237457190593 07:56:38 INFO - PROCESS | 10084 | |3;mootools.html;1176.7881781279373;1177.6702523293482;1179.6402097360303;1575.487966410916;1628.6498402843386;5931.169636250928;6165.7533698652;6278;6619.933800661992;6630.834229144268;6236.750529978806;6374.07575901494;6453.548251622388;6533.379328963752;6564.737410503574;2019.0409555461185;2059.083707750052;2060.2994981706215;2061.742282214723;2061.8247448966854;1786.4015554789162;1861.7672790901138;2055.0649454498166;2059.5263089489426;2061.6082944240547;1970.812772786583;2043.0704029666465;2049.610573990937;2056.516718571135;2068.803463670949;2031.4053468027676;2034.5422279987033;2060.536379314657;2061.319764477726;2063.4531849060013;2043.6627956387179;2102.98948505258;2104.4844013216707;2107.115011695076;2112.6619740841547;6643.867122657568;6678.899816502756;6703.396694297488;6706.5640733352175;6709.664516774142;4043.939340909889;4166.541680415152;4170.145120250341;4170.52039015511;4177.874663760092;2662.480816240834;2668.759811616964;2871.3970066286106;2875.09434528123;2885.2498350428828;817.38287592867;841.1294310388779;870.5777697816554;884.2218847414299;890.7773056735816;8586.098459661707;8590.441621294596;8598.4840909545;8639.265662418702;8673.82652346956;3661.798601076913;3789.1663833956486;3832.674222691047;3936.173403585279;3962.643362097425;7341.082364704412;7355.448341374418;7358.190599034102;7359.77920662381;7369.078865141857;4145.3781932710335;4156.314208155621;4175.269327867611;4175.812088455966;4181.163767246502;3710.7216958728204;3828.3109040373;3831.3869780834934;3832.2718683450057;3833.9041523962123;3215.244417561871;3223.903282901517;3247.7590462580742;3298.65364136767;3299.851506682205;1012.7518757904213;1037.8547003419528;1112.0547534595692;1112.3993043756282;1140.7832511822728;688.9069975553236;805.0500409516826;813.7396033269415;817.5054092274207;821.1296026212234;4546.52261512543;4662.300654901792;4683.95316046842;4726.905461890743;4903.436104847917;793.2147174297404;814.8044469327318;847.2671139464319;859.6518410043942;881.2025117268882;3144;3170.9841450792596;3222.4038552867796;3247.0421225738464;3279.917627183024;7559.584222867795;7858.292753652198;7862.960685196537;7890.289873911375;7930.325922296554;7750.418718596128;7817.218278172138;7824.6870125194355;7829.138794732575;7833.725819596287;6147.84630384244;6240.625562466266;6248.937510624926;6253.343398943137;6262.874742505124;4587.931181032221;4598.241290187082;4609.654275929386;4645.465771436193;4747.976260118678;7084.929150708427;7109.715611375487;7126.608036557832;7157.1769246537315;7260.927390726237;7135.179454362815;7172.462065345225;7198.244184360567;7307.086614173229;7341.449391295568;5428.6199966002005;5552.69460179694;5555.583331250092;5556.944430555643;5562.805301814417;6164.4143806338325;6254.8123556293385;6297.559170857996;6309.211348581427;6338.904916426165;4486.618637415856;5646.040173170653;5829.504492118217;5843.1235314703135;5904.940950590439;5728.828135155952;5764.942350576441;5832.445917637818;5842.503387212135;5845.620034697731;5335.093034184276;5340.75966581497;5354.919676204782;5407.567394608343;5407.78368865241;3979.383195604686;4017.6785857131945;4023.155137421057;4037.5356833963297;4103.712740108163;3925.0972276376024;3966.960330396659;3986.362182050858;4024.577419371041;4055.432239486533 07:56:38 INFO - PROCESS | 10084 | |4;prototype.html;347.73398350262056;348.21825002868553;351.0364050680881;360.1985582079871;363.61275241867395;4749.47755746868;4779.689320194185;4783.904321913564;4784.712917224969;4798.856034318967;4739.431268247807;4745.549172828584;4760.9523904760945;4762.499937506564;4771;3592.730545209113;3684.3736564783917;3691.7231207659397;3742.251549690073;3790.905227369324;3788.7347885648014;3792.7534710243885;3820.522434695663;3823;3825.0437390652337;3774.2640185163905;3792.0140763401437;3795.601461846508;3797.7721336719746;3803;3646.762960407565;3730.7201959852982;3730.850765969358;3799.7720136791604;3835.86574469895;3428.1659312268066;3440.8107554084513;3444.0196886789945;3454.2573346730574;3462.4460086386307;4607.424071991001;4621.792019359137;4639.164950308943;4640.466346370177;4641.489436162019;3982.2234664240486;4145.233131870614;4337.110892267077;4364.716293440948;4375.103103863732;4918.852434426973;4933.80264789408;4940.481249468826;4949.7772600233075;4953.504649535053;3533.116720819795;3547.3614749345106;3548.591911930135;3554.9822250888838;3559.18138828071;5012.8496145115705;5212.400573934008;5234.659747116425;5239.318888544503;5239.607029472767;3514.61339252682;3531.2584357284745;3545.663161999606;3556.91107722309;3562.3613137956313;3592.407252803258;3592.760497628314;3595.424732042861;3610.981945090258;3627.3108109459117;4107.281225785536;4125.64931980779;4126.319157339066;4147.149834283965;4158.6465150462545;4679.883002924886;4902.28916807061;4994.502748625687;5010.073136469765;5025.4974502550185;1231.9322437266037;1234.3211233821542;1236.394166858251;1236.6661001529537;1239.39269757818;805.4321703199348;812.6749300279818;833.2708879730236;841.5119230846094;845.9746207613781;4118.897027574275;4256.297710877732;4295.634871035934;4308.67684923632;4342.565743425632;5032.169692000779;5084.593232541388;5087.583397885975;5096.490350964948;5132.897342053213;4299.935500967488;4328.43730315057;4335.414719012893;4337.306031035019;4340.676093791424;2513.642632978208;2595.2214335699214;2601.6487774150246;2611.817172797924;2640.1815437214523;4444.466664000341;4479.910401792011;4480.596746292849;4500.639948804088;4512.661550383735;5054.1407960646775;5075.568576671024;5078.698845750292;5102.066311870689;5114.207297868837;4342.0257123869615;4458.732476051382;4465.352523884018;4491.438570178728;4552.338396485326;4876.195427754381;4900.509949005071;4906.362172917497;4937;4943.826966056171;4751.928721069117;4835.564799168092;4877.1956125227425;4883.658143929891;4900.705957642553;4247.936280955726;4491.191585514639;4526.502084770606;4555.749433781174;4560.6807523473035;3463.203463203427;3467.3758723430024;3494.598121215991;3497.2830569732637;3498.510208570853;5010.394594810751;5014.147594908947;5024.286885082015;5025.8240961567635;5041.924371134362;4699.76761038504;4749.453812811433;4765.617970788432;4794.880127996828;4889.3888263967;4752.52474752522;4759.381280433521;4760.048380164116;4766.237402015661;4781.617470602413;4641.74470404131;4676.812927482999;4705.482396936266;4726.929096063493;4751.952480475289;4652.511486294025;4828.275758636232;4844.249141383091;4848.442429120696;4866.418414015388;4693.577578017995;4716.834910778243;4719.230288641759;4727.17274476972;4738.620910327235 07:56:38 INFO - PROCESS | 10084 | |5;yui.html;633.6388258692547;647.7797548833396;669.9162604674412;719.6509692798992;730.769807510634;12635.747285054305;14080.29598520075;14120.929395353021;14133.646658833535;14153.575392738221;12816.29510376929;12926.159799613019;13138;13142.47430102797;13143.079984401096;768.7539987204096;778.3734094054284;779.9961000195019;787.09877190617;789.6801795272895;773.446985405435;775.0157300228706;775.0196002057373;777.1257335497565;778.1673609238118;807.7738233294657;812.0499016151117;812.7927378518469;814.4217605500102;816.1552792859392;812.9187081291883;813.3493205435658;813.4387272781762;813.446856137826;813.6094674556247;596.5376832954495;597.0894386061248;597.742970522675;601.4947444146937;603.1375133559009;11289.774204515863;11347.375894325809;11426.771464570746;11510.136739744468;12630.557930472482;9507.762305942337;9606.807863842683;9680.612775488971;9688.854667179998;9962.252831037702;9046.547672616409;9213.723588292294;9224.815503689955;9291.163795258391;9322.673706420243;3080.2915329474345;3166.145140811968;3195.344954284366;3269.8365081746056;3328.650491698361;60661.69669151626;61475;61842.690786545776;61953.69023154901;62313.688431558;8176.877346839802;8436.507936507936;8500.192481714228;8537.274331681752;8538;16531.421400250932;16929.322827087024;16931.661366772594;17086.82913170877;17097.658046838995;6180.351063138306;6482.837929051811;6637.502187335873;6719.832004199934;6841.726330946806;3546.3971124908826;3587.408077667156;3634.400323946519;3688.963110368862;3780.584135745066;2690.085370973839;2750.0787236275673;2773.2789474736715;2781.4019985702766;2786.972130278671;468.62978247185026;502.6506577928305;508.2021226674086;509.38873351977776;524.6799452334074;408.4451460142103;480.94469136049105;509.3454910440067;540.664787831547;574.3911453858923;7321.414286857039;7373.410127189812;7628.351590114902;7842.568658723825;7855.072463768116;525.1178020924883;548.3091304955784;582.2721598002497;589.7699897040158;595.5116804220497;3420.7776494527775;3487.3548393547276;3545.2023294758474;3591.51514545533;3672.540932383452;51968.22047669288;58355.70822145947;66253;69201;69258.65370673215;57202.42797571971;57740;57815;58612.41387586069;60881.69559152264;51943;52952.73523632434;53499.19751203735;53626.46373536293;53722.194167087524;6796.4902632303765;6815.693293801692;6838.965805171141;6876.243613202644;7154.284571542804;36791;37587.62412375841;37967;38068.80965595154;38636.61363386443;44813.551864480934;44903;48057.5194248053;50450.495495046045;50590.7352316195;8560.272376848037;8677.219050285505;8738;8762.430442021248;8878.334124940526;10010.149137323118;10051.145652619609;10089.24330675217;10362.68911932613;10440.94779526128;9450.669226577036;9673.467959262309;9713.611455541699;9754.512274386394;9965.50172491358;9669.129778319704;9863.457509837028;9922.107010369102;10029.849552256575;10096.646617368357;9145.77135571616;9258.768530786514;9281.443113413217;9389.154976052188;9416.76458088526;7022.495555852625;7377.4098072155175;7447.329740323397;7457;7557.2820582044615;7459.888101678371;7539.585322807298;7571.129320128035;7802.687892484237;7892.960535197287 07:56:38 INFO - PROCESS | 10084 | __end_tp_report 07:56:38 INFO - PROCESS | 10084 | __start_cc_report 07:56:38 INFO - PROCESS | 10084 | _x_x_mozilla_cycle_collect,2402 07:56:38 INFO - PROCESS | 10084 | __end_cc_report 07:56:38 INFO - PROCESS | 10084 | __startTimestamp1481730998512__endTimestamp 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | ------- Summary: start ------- 07:56:38 INFO - PROCESS | 10084 | Number of tests: 6 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | [#0] dojo.html Cycles:165 Average:4468.78 Median:4608.61 stddev:465.87 (10.1%) stddev-sans-first:441.74 07:56:38 INFO - PROCESS | 10084 | Values: 2528.8 2532.8 2566.4 2581.1 2590.5 4412.6 4458.5 4520.2 4572.0 4572.7 4498.1 4499.7 4522.1 4531.0 4536.4 4195.6 4218.4 4220.0 4252.4 4309.5 3895.1 4280.5 4288.1 4335.1 4380.4 4076.0 4091.7 4284.6 4337.0 4358.4 4164.6 4170.6 4178.8 4182.4 4186.0 4142.7 4146.4 4153.2 4158.9 4161.3 4516.0 4535.4 4565.4 4586.6 4608.6 4878.1 4885.7 4887.7 4894.7 4937.4 4716.6 4748.5 4913.4 4919.9 4936.6 4512.2 4563.3 4597.9 4646.3 4655.3 5004.5 5004.8 5008.7 5011.4 5012.8 4808.2 4808.4 4817.1 4817.9 4867.2 4735.0 4770.2 4779.3 4820.3 4834.4 4782.2 4849.5 4851.0 4853.0 4857.1 4791.0 4796.6 4804.0 4809.8 4846.6 3991.6 4012.5 4066.7 4084.0 4111.5 3546.6 3548.3 3551.1 3581.8 3647.7 4182.2 4185.1 4185.3 4188.8 4226.9 4903.6 4905.5 4908.8 4911.7 4942.3 4040.2 4069.3 4104.0 4108.9 4123.0 4323.7 4337.9 4340.4 4382.8 4387.5 4384.2 4386.8 4388.5 4391.5 4427.2 4688.0 4691.2 4737.5 4824.5 4851.0 4385.4 4417.8 4434.9 4446.2 4448.5 4784.9 4796.2 4797.9 4798.2 4845.0 4715.2 4828.1 4831.2 4831.9 4877.1 4622.3 4679.5 4682.0 4682.8 4684.0 4625.4 4678.7 4686.2 4688.5 4690.1 4611.0 4617.1 4618.6 4623.1 4633.9 4667.8 4697.2 4711.2 4712.0 4713.0 4616.0 4633.7 4633.8 4636.0 4659.6 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | [#1] ext.html Cycles:180 Average:42766.00 Median:332924.50 stddev:72425.60 (21.8%) stddev-sans-first:72559.29 07:56:38 INFO - PROCESS | 10084 | Values: 510.9 531.4 544.1 554.9 565.9 37086.8 39039.8 39152.0 42411.6 42523.4 39665.8 40442.8 40473.8 40522.2 40567.6 7115.4 7423.5 7694.8 7702.8 7703.6 7039.9 9557.1 9769.2 9785.2 10108.6 10073.4 10162.4 10166.9 10167.3 10167.6 9998.7 10044.4 10065.5 10070.4 10085.5 9821.2 9854.2 9885.7 9887.3 9890.4 36857.4 37220.4 37253.8 37271.0 37327.6 3051.2 3092.6 3169.9 3213.9 3387.6 27419.6 27790.6 28029.6 28413.4 28967.4 3437.3 3447.1 3507.0 3531.1 3541.6 229652.0 231780.6 232471.0 232753.0 232889.0 51920.7 52352.7 52406.0 52410.5 52427.0 53669.7 53764.7 53810.2 53834.2 53842.5 11993.5 12202.8 12227.2 12237.9 12242.2 8138.1 8355.0 8983.3 9433.2 9438.2 16171.4 16344.8 16468.5 16517.7 16807.5 5511.2 5536.3 5551.9 5638.8 5730.4 774.7 819.9 865.4 872.2 888.8 26294.5 27661.4 28054.2 28128.0 28172.3 908.2 930.1 942.4 942.9 958.8 14407.4 14734.9 14755.3 14951.5 15018.1 329023.0 330870.0 332846.0 333003.0 333269.0 48166.5 48262.5 48270.3 48302.8 48384.3 1030.4 1075.6 1101.0 1161.2 1162.5 26536.6 27829.5 28571.0 28783.7 29085.4 41048.4 41603.2 41615.0 41654.6 41664.6 255262.0 255642.0 255962.0 256662.0 256996.0 22512.8 22984.8 23363.8 24258.6 35814.5 35764.1 35852.0 35863.6 35933.0 36482.6 30656.8 31015.4 31249.2 31284.8 31819.4 30799.7 31007.8 31216.5 31418.8 32326.5 31271.8 31498.8 31691.7 31742.8 32207.7 27000.9 28729.1 28937.6 29206.4 29233.9 22563.9 22800.9 22808.8 23120.4 23237.4 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | [#2] jquery.html Cycles:180 Average:22266.27 Median:4866.39 stddev:56846.89 (1168.2%) stddev-sans-first:56982.52 07:56:38 INFO - PROCESS | 10084 | Values: 339.6 349.9 361.1 362.7 381.6 12349.8 15500.3 15584.7 16804.7 16888.7 16371.3 16435.8 16539.8 16664.8 16679.6 4776.2 4813.4 4909.3 4959.1 5047.7 3642.6 3822.4 4823.5 4914.4 4920.9 5351.4 5592.2 5600.6 5679.2 5689.7 5462.6 5668.7 5676.9 5684.6 5746.6 5088.3 5100.5 5103.5 5103.9 5104.2 19311.1 19444.6 19630.0 19763.3 20167.4 1879.4 1879.4 1880.4 1883.0 1930.2 11977.5 12947.0 12947.6 13259.1 13615.6 1657.8 1658.8 1694.5 1717.8 1818.1 40230.0 54317.5 54658.7 60880.4 63158.0 8989.8 9273.7 9288.9 9371.2 9567.6 12890.0 12898.1 12904.5 12911.7 12917.1 6522.7 6563.4 6711.6 6724.2 6749.8 6154.1 6197.1 6295.2 6297.9 6353.8 5816.0 5932.5 5966.7 6007.2 6075.9 1629.3 1653.4 1667.8 1689.2 1691.8 691.6 794.9 851.1 911.4 921.0 15859.0 16574.9 17132.3 17242.8 17368.5 808.8 846.5 884.7 913.2 931.6 7714.5 9332.3 9768.1 9842.4 10020.6 330815.0 334224.0 346830.0 353843.0 353878.0 73523.0 78260.2 79349.2 80266.0 80572.6 816.8 824.7 847.0 848.3 857.6 13759.2 14528.7 14548.6 15117.3 15739.7 32267.0 32530.0 32999.8 33181.5 36178.8 41730.5 45278.5 45707.0 46082.0 46902.8 7345.6 7558.0 7558.1 7728.0 7843.2 10369.9 10535.4 10575.5 11225.2 11929.5 9889.9 10040.7 10051.4 10207.0 10404.1 9569.3 9680.1 9715.2 10091.2 10091.6 9668.4 9674.7 9919.5 10043.4 10255.5 7361.4 7502.5 7502.9 7561.6 7598.8 9390.5 9701.3 9737.0 9802.3 10167.2 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | [#3] mootools.html Cycles:180 Average:4385.69 Median:5119.26 stddev:2269.16 (44.3%) stddev-sans-first:2262.71 07:56:38 INFO - PROCESS | 10084 | Values: 1176.8 1177.7 1179.6 1575.5 1628.6 5931.2 6165.8 6278.0 6619.9 6630.8 6236.8 6374.1 6453.5 6533.4 6564.7 2019.0 2059.1 2060.3 2061.7 2061.8 1786.4 1861.8 2055.1 2059.5 2061.6 1970.8 2043.1 2049.6 2056.5 2068.8 2031.4 2034.5 2060.5 2061.3 2063.5 2043.7 2103.0 2104.5 2107.1 2112.7 6643.9 6678.9 6703.4 6706.6 6709.7 4043.9 4166.5 4170.1 4170.5 4177.9 2662.5 2668.8 2871.4 2875.1 2885.2 817.4 841.1 870.6 884.2 890.8 8586.1 8590.4 8598.5 8639.3 8673.8 3661.8 3789.2 3832.7 3936.2 3962.6 7341.1 7355.4 7358.2 7359.8 7369.1 4145.4 4156.3 4175.3 4175.8 4181.2 3710.7 3828.3 3831.4 3832.3 3833.9 3215.2 3223.9 3247.8 3298.7 3299.9 1012.8 1037.9 1112.1 1112.4 1140.8 688.9 805.1 813.7 817.5 821.1 4546.5 4662.3 4684.0 4726.9 4903.4 793.2 814.8 847.3 859.7 881.2 3144.0 3171.0 3222.4 3247.0 3279.9 7559.6 7858.3 7863.0 7890.3 7930.3 7750.4 7817.2 7824.7 7829.1 7833.7 6147.8 6240.6 6248.9 6253.3 6262.9 4587.9 4598.2 4609.7 4645.5 4748.0 7084.9 7109.7 7126.6 7157.2 7260.9 7135.2 7172.5 7198.2 7307.1 7341.4 5428.6 5552.7 5555.6 5556.9 5562.8 6164.4 6254.8 6297.6 6309.2 6338.9 4486.6 5646.0 5829.5 5843.1 5904.9 5728.8 5764.9 5832.4 5842.5 5845.6 5335.1 5340.8 5354.9 5407.6 5407.8 3979.4 4017.7 4023.2 4037.5 4103.7 3925.1 3967.0 3986.4 4024.6 4055.4 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | [#4] prototype.html Cycles:180 Average:4056.09 Median:4519.58 stddev:1155.55 (25.6%) stddev-sans-first:1124.77 07:56:38 INFO - PROCESS | 10084 | Values: 347.7 348.2 351.0 360.2 363.6 4749.5 4779.7 4783.9 4784.7 4798.9 4739.4 4745.5 4761.0 4762.5 4771.0 3592.7 3684.4 3691.7 3742.3 3790.9 3788.7 3792.8 3820.5 3823.0 3825.0 3774.3 3792.0 3795.6 3797.8 3803.0 3646.8 3730.7 3730.9 3799.8 3835.9 3428.2 3440.8 3444.0 3454.3 3462.4 4607.4 4621.8 4639.2 4640.5 4641.5 3982.2 4145.2 4337.1 4364.7 4375.1 4918.9 4933.8 4940.5 4949.8 4953.5 3533.1 3547.4 3548.6 3555.0 3559.2 5012.8 5212.4 5234.7 5239.3 5239.6 3514.6 3531.3 3545.7 3556.9 3562.4 3592.4 3592.8 3595.4 3611.0 3627.3 4107.3 4125.6 4126.3 4147.1 4158.6 4679.9 4902.3 4994.5 5010.1 5025.5 1231.9 1234.3 1236.4 1236.7 1239.4 805.4 812.7 833.3 841.5 846.0 4118.9 4256.3 4295.6 4308.7 4342.6 5032.2 5084.6 5087.6 5096.5 5132.9 4299.9 4328.4 4335.4 4337.3 4340.7 2513.6 2595.2 2601.6 2611.8 2640.2 4444.5 4479.9 4480.6 4500.6 4512.7 5054.1 5075.6 5078.7 5102.1 5114.2 4342.0 4458.7 4465.4 4491.4 4552.3 4876.2 4900.5 4906.4 4937.0 4943.8 4751.9 4835.6 4877.2 4883.7 4900.7 4247.9 4491.2 4526.5 4555.7 4560.7 3463.2 3467.4 3494.6 3497.3 3498.5 5010.4 5014.1 5024.3 5025.8 5041.9 4699.8 4749.5 4765.6 4794.9 4889.4 4752.5 4759.4 4760.0 4766.2 4781.6 4641.7 4676.8 4705.5 4726.9 4752.0 4652.5 4828.3 4844.2 4848.4 4866.4 4693.6 4716.8 4719.2 4727.2 4738.6 07:56:38 INFO - PROCESS | 10084 | 07:56:38 INFO - PROCESS | 10084 | [#5] yui.html Cycles:180 Average:14103.34 Median:33827.68 stddev:18625.93 (55.1%) stddev-sans-first:18650.72 07:56:38 INFO - PROCESS | 10084 | Values: 633.6 647.8 669.9 719.7 730.8 12635.7 14080.3 14120.9 14133.6 14153.6 12816.3 12926.2 13138.0 13142.5 13143.1 768.8 778.4 780.0 787.1 789.7 773.4 775.0 775.0 777.1 778.2 807.8 812.0 812.8 814.4 816.2 812.9 813.3 813.4 813.4 813.6 596.5 597.1 597.7 601.5 603.1 11289.8 11347.4 11426.8 11510.1 12630.6 9507.8 9606.8 9680.6 9688.9 9962.3 9046.5 9213.7 9224.8 9291.2 9322.7 3080.3 3166.1 3195.3 3269.8 3328.7 60661.7 61475.0 61842.7 61953.7 62313.7 8176.9 8436.5 8500.2 8537.3 8538.0 16531.4 16929.3 16931.7 17086.8 17097.7 6180.4 6482.8 6637.5 6719.8 6841.7 3546.4 3587.4 3634.4 3689.0 3780.6 2690.1 2750.1 2773.3 2781.4 2787.0 468.6 502.7 508.2 509.4 524.7 408.4 480.9 509.3 540.7 574.4 7321.4 7373.4 7628.4 7842.6 7855.1 525.1 548.3 582.3 589.8 595.5 3420.8 3487.4 3545.2 3591.5 3672.5 51968.2 58355.7 66253.0 69201.0 69258.7 57202.4 57740.0 57815.0 58612.4 60881.7 51943.0 52952.7 53499.2 53626.5 53722.2 6796.5 6815.7 6839.0 6876.2 7154.3 36791.0 37587.6 37967.0 38068.8 38636.6 44813.6 44903.0 48057.5 50450.5 50590.7 8560.3 8677.2 8738.0 8762.4 8878.3 10010.1 10051.1 10089.2 10362.7 10440.9 9450.7 9673.5 9713.6 9754.5 9965.5 9669.1 9863.5 9922.1 10029.8 10096.6 9145.8 9258.8 9281.4 9389.2 9416.8 7022.5 7377.4 7447.3 7457.0 7557.3 7459.9 7539.6 7571.1 7802.7 7893.0 07:56:38 INFO - PROCESS | 10084 | -------- Summary: end -------- 07:56:38 INFO - PROCESS | 10084 | 07:56:39 INFO - TEST-INFO | 10084: exit 0 07:56:39 INFO - TEST-OK | dromaeo_css | took 1121817ms 07:56:39 INFO - TEST-START | kraken 07:56:39 INFO - operating with platform_type : linux_ 07:56:39 INFO - Initialising browser for kraken test... 07:56:39 INFO - TEST-INFO | started process 10388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8JyDbl/profile http://localhost:53166/getInfo.html) 07:56:43 INFO - PROCESS | 10388 | __metrics Screen width/height:1600/1200 07:56:43 INFO - PROCESS | 10388 | colorDepth:24 07:56:43 INFO - PROCESS | 10388 | Browser inner width/height: 1024/697 07:56:43 INFO - PROCESS | 10388 | __metrics 07:56:44 INFO - PROCESS | 10388 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:56:44 INFO - PROCESS | 10388 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:45 INFO - TEST-INFO | 10388: exit 0 07:56:45 INFO - Browser initialized. 07:56:45 INFO - Running cycle 1/1 for kraken test... 07:56:45 INFO - TEST-INFO | started process 10470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8JyDbl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:58 INFO - PROCESS | 10470 | RSS: Main: 173723648 07:56:58 INFO - PROCESS | 10470 | 07:57:00 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53166/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:01 INFO - PROCESS | 10470 | RSS: Main: 239861760 07:57:01 INFO - PROCESS | 10470 | 07:57:04 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53166/tests/kraken/driver.html?testName=audio-dft) 07:57:05 INFO - PROCESS | 10470 | RSS: Main: 218255360 07:57:05 INFO - PROCESS | 10470 | 07:57:08 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53166/tests/kraken/driver.html?testName=audio-fft) 07:57:09 INFO - PROCESS | 10470 | RSS: Main: 300359680 07:57:09 INFO - PROCESS | 10470 | 07:57:11 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53166/tests/kraken/driver.html?testName=audio-oscillator) 07:57:11 INFO - PROCESS | 10470 | RSS: Main: 211124224 07:57:11 INFO - PROCESS | 10470 | 07:57:14 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:14 INFO - PROCESS | 10470 | RSS: Main: 215068672 07:57:14 INFO - PROCESS | 10470 | 07:57:17 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53166/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:18 INFO - PROCESS | 10470 | RSS: Main: 254140416 07:57:18 INFO - PROCESS | 10470 | 07:57:22 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53166/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:22 INFO - PROCESS | 10470 | RSS: Main: 248172544 07:57:22 INFO - PROCESS | 10470 | 07:57:25 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53166/tests/kraken/driver.html?testName=json-parse-financial) 07:57:26 INFO - PROCESS | 10470 | RSS: Main: 249401344 07:57:26 INFO - PROCESS | 10470 | 07:57:27 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:28 INFO - PROCESS | 10470 | RSS: Main: 213086208 07:57:28 INFO - PROCESS | 10470 | 07:57:30 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:31 INFO - PROCESS | 10470 | RSS: Main: 220557312 07:57:31 INFO - PROCESS | 10470 | 07:57:33 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:33 INFO - PROCESS | 10470 | RSS: Main: 229310464 07:57:33 INFO - PROCESS | 10470 | 07:57:36 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:37 INFO - PROCESS | 10470 | RSS: Main: 238620672 07:57:37 INFO - PROCESS | 10470 | 07:57:40 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:41 INFO - PROCESS | 10470 | RSS: Main: 235708416 07:57:41 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | Cycle 1(1): loaded http://localhost:53166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53166/tests/kraken/driver.html?testName=ai-astar) 07:57:43 INFO - PROCESS | 10470 | RSS: Main: 287846400 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | __start_tp_report 07:57:43 INFO - PROCESS | 10470 | _x_x_mozilla_page_load 07:57:43 INFO - PROCESS | 10470 | _x_x_mozilla_page_load_details 07:57:43 INFO - PROCESS | 10470 | |i|pagename|runs| 07:57:43 INFO - PROCESS | 10470 | |0;ai-astar;108;117;116;118;115;115;115;114;114;116 07:57:43 INFO - PROCESS | 10470 | |1;audio-beat-detection;156;135;130;176;130;133;129;129;152;129 07:57:43 INFO - PROCESS | 10470 | |2;audio-dft;162;161;162;163;165;164;163;163;162;162 07:57:43 INFO - PROCESS | 10470 | |3;audio-fft;77;76;76;102;77;76;77;77;98;76 07:57:43 INFO - PROCESS | 10470 | |4;audio-oscillator;85;86;108;87;87;86;97;85;85;108 07:57:43 INFO - PROCESS | 10470 | |5;imaging-gaussian-blur;127;127;127;127;127;127;128;127;127;126 07:57:43 INFO - PROCESS | 10470 | |6;imaging-darkroom;146;147;148;148;148;148;148;147;147;147 07:57:43 INFO - PROCESS | 10470 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 07:57:43 INFO - PROCESS | 10470 | |8;json-parse-financial;66;65;65;65;67;67;67;66;66;67 07:57:43 INFO - PROCESS | 10470 | |9;json-stringify-tinderbox;66;66;65;66;73;67;65;65;65;65 07:57:43 INFO - PROCESS | 10470 | |10;stanford-crypto-aes;86;85;85;84;85;84;85;86;89;85 07:57:43 INFO - PROCESS | 10470 | |11;stanford-crypto-ccm;154;145;141;141;142;141;182;142;200;144 07:57:43 INFO - PROCESS | 10470 | |12;stanford-crypto-pbkdf2;183;183;181;178;179;179;177;180;183;177 07:57:43 INFO - PROCESS | 10470 | |13;stanford-crypto-sha256-iterative;75;73;70;68;70;69;67;68;69;68 07:57:43 INFO - PROCESS | 10470 | __end_tp_report 07:57:43 INFO - PROCESS | 10470 | __start_cc_report 07:57:43 INFO - PROCESS | 10470 | _x_x_mozilla_cycle_collect,1961 07:57:43 INFO - PROCESS | 10470 | __end_cc_report 07:57:43 INFO - PROCESS | 10470 | __startTimestamp1481731063355__endTimestamp 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | ------- Summary: start ------- 07:57:43 INFO - PROCESS | 10470 | Number of tests: 14 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:2.70 (2.3%) stddev-sans-first:1.33 07:57:43 INFO - PROCESS | 10470 | Values: 108.0 117.0 116.0 118.0 115.0 115.0 115.0 114.0 114.0 116.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:134.00 stddev:16.10 (12.0%) stddev-sans-first:15.99 07:57:43 INFO - PROCESS | 10470 | Values: 156.0 135.0 130.0 176.0 130.0 133.0 129.0 129.0 152.0 129.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 07:57:43 INFO - PROCESS | 10470 | Values: 162.0 161.0 162.0 163.0 165.0 164.0 163.0 163.0 162.0 162.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#3] audio-fft Cycles:10 Average:81.20 Median:77.00 stddev:9.96 (12.9%) stddev-sans-first:10.45 07:57:43 INFO - PROCESS | 10470 | Values: 77.0 76.0 76.0 102.0 77.0 76.0 77.0 77.0 98.0 76.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:86.00 stddev:9.44 (11.0%) stddev-sans-first:9.73 07:57:43 INFO - PROCESS | 10470 | Values: 85.0 86.0 108.0 87.0 87.0 86.0 97.0 85.0 85.0 108.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:57:43 INFO - PROCESS | 10470 | Values: 127.0 127.0 127.0 127.0 127.0 127.0 128.0 127.0 127.0 126.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 07:57:43 INFO - PROCESS | 10470 | Values: 146.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:57:43 INFO - PROCESS | 10470 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 07:57:43 INFO - PROCESS | 10470 | Values: 66.0 65.0 65.0 65.0 67.0 67.0 67.0 66.0 66.0 67.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:2.45 (3.7%) stddev-sans-first:2.60 07:57:43 INFO - PROCESS | 10470 | Values: 66.0 66.0 65.0 66.0 73.0 67.0 65.0 65.0 65.0 65.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.50 07:57:43 INFO - PROCESS | 10470 | Values: 86.0 85.0 85.0 84.0 85.0 84.0 85.0 86.0 89.0 85.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:144.50 stddev:20.74 (14.3%) stddev-sans-first:21.99 07:57:43 INFO - PROCESS | 10470 | Values: 154.0 145.0 141.0 141.0 142.0 141.0 182.0 142.0 200.0 144.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:180.50 stddev:2.40 (1.3%) stddev-sans-first:2.29 07:57:43 INFO - PROCESS | 10470 | Values: 183.0 183.0 181.0 178.0 179.0 179.0 177.0 180.0 183.0 177.0 07:57:43 INFO - PROCESS | 10470 | 07:57:43 INFO - PROCESS | 10470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:2.50 (3.6%) stddev-sans-first:1.76 07:57:43 INFO - PROCESS | 10470 | Values: 75.0 73.0 70.0 68.0 70.0 69.0 67.0 68.0 69.0 68.0 07:57:43 INFO - PROCESS | 10470 | -------- Summary: end -------- 07:57:43 INFO - PROCESS | 10470 | 07:57:44 INFO - TEST-INFO | 10470: exit 0 07:57:44 INFO - TEST-OK | kraken | took 65173ms 07:57:44 INFO - SUITE-END | took 1186s 07:57:45 INFO - Completed test suite (00:19:47) 07:57:45 INFO - javascript benchmark 07:57:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2528.822982391232, 2532.778004194789, 2566.3840678237225, 2581.057913861441, 2590.5078035173315, 4412.646988240941, 4458.487273963495, 4520.208963431399, 4572.0, 4572.725636461811, 4498.100379924012, 4499.707519011262, 4522.118186953546, 4531.0, 4536.364908912747, 4195.559466256045, 4218.367244913257, 4220.0, 4252.447181866353, 4309.504406993189, 3895.0749773123457, 4280.5291417944, 4288.099499105176, 4335.0679603885155, 4380.364847097169, 4075.9796201019103, 4091.6931230157857, 4284.592963668447, 4336.978315108436, 4358.411614432059, 4164.6251837334485, 4170.562090980434, 4178.8328466861285, 4182.393552934807, 4185.97907010466, 4142.668586513072, 4146.419501269825, 4153.190127925056, 4158.9376159357635, 4161.271777438936, 4515.977420112911, 4535.365048893158, 4565.383673204141, 4586.610138138262, 4608.608268297199, 4878.0975519529, 4885.682430641997, 4887.657863949525, 4894.7063176209185, 4937.407511098655, 4716.622670186377, 4748.548887855648, 4913.410390753097, 4919.90160196794, 4936.6050715943, 4512.165249428834, 4563.315502674593, 4597.931031034537, 4646.3495110684535, 4655.3249778782565, 5004.499550044967, 5004.799808007639, 5008.6744361616375, 5011.373578302712, 5012.758661935303, 4808.182608956486, 4808.3989501312335, 4817.108834865561, 4817.855464336076, 4867.172580661296, 4734.976325118352, 4770.165221086296, 4779.3070004849105, 4820.3492528508905, 4834.444038935568, 4782.163121453732, 4849.4908034655855, 4850.95149048512, 4853.0, 4857.101436234308, 4791.0, 4796.592289655348, 4803.975980120147, 4809.759512024385, 4846.588040016568, 3991.6207960243732, 4012.498437695288, 4066.674666026711, 4084.0, 4111.5477297497255, 3546.556680414948, 3548.3258180945536, 3551.076720052805, 3581.83881725323, 3647.6534729200685, 4182.247195504778, 4185.121124563815, 4185.288500954845, 4188.8324467020975, 4226.873193804191, 4903.607711383081, 4905.533974272438, 4908.803647854046, 4911.68074075184, 4942.258661200849, 4040.1919616076316, 4069.348904175318, 4103.97948010258, 4108.91782164355, 4123.0, 4323.675724320626, 4337.934930976038, 4340.414044104069, 4382.824687012548, 4387.473503179639, 4384.188925048876, 4386.846460373871, 4388.451443569554, 4391.473023237232, 4427.180971520279, 4688.026981450226, 4691.179043667276, 4737.526247375235, 4824.49342818999, 4850.975745121252, 4385.407969924019, 4417.845375411845, 4434.911301773882, 4446.155230506193, 4448.510663827041, 4784.880377990578, 4796.184648609675, 4797.928031079467, 4798.23228283473, 4845.030993801324, 4715.174844402147, 4828.058528586892, 4831.178699621143, 4831.903361932812, 4877.12211801879, 4622.329762184531, 4679.508651591534, 4681.953180468288, 4682.789274482725, 4683.953160468352, 4625.421822272216, 4678.69588476748, 4686.156491831503, 4688.531146885284, 4690.132325519789, 4611.031683346535, 4617.145828021827, 4618.63050955916, 4623.098495793288, 4633.884152896069, 4667.83662571822, 4697.177993851131, 4711.15199264122, 4711.952880471152, 4713.033828065307, 4616.007558374831, 4633.698809577501, 4633.76831158434, 4636.049609829909, 4659.603933665677], "value": 4439.556959242705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.8927125303686, 531.4366771222504, 544.0913674164145, 554.8807006493603, 565.8839937812746, 37086.81456592717, 39039.804800976024, 39152.0, 42411.575884241145, 42523.36214956778, 39665.801670991605, 40442.797786011026, 40473.797631011876, 40522.18955620886, 40567.59432405682, 7115.43076553877, 7423.517471364357, 7694.807629809244, 7702.807429814244, 7703.614819259043, 7039.894401583981, 9557.092076252746, 9769.218462523017, 9785.168260697848, 10108.595656173744, 10073.44596047217, 10162.441065741381, 10166.89833101667, 10167.288289819715, 10167.644132455365, 9998.650047248348, 10044.447555384451, 10065.547050382676, 10070.395776253376, 10085.49572521371, 9821.165200957927, 9854.176977259158, 9885.654002109892, 9887.307888447811, 9890.357126786736, 36857.44713829295, 37220.44169337462, 37253.81373093144, 37271.0, 37327.62672373296, 3051.1761824307314, 3092.597962264914, 3169.857356418967, 3213.935721285585, 3387.6273609903137, 27419.588706169423, 27790.583141252897, 28029.57955630667, 28413.431731365465, 28967.42065158706, 3437.295354452331, 3447.1037530242065, 3507.013033422328, 3531.1348719563616, 3541.592716837571, 229652.0, 231780.59729845967, 232471.0, 232753.0, 232889.0, 51920.74039629778, 52352.738236309335, 52406.0, 52410.47589524056, 52427.0, 53669.73165134228, 53764.73117634387, 53810.192847107326, 53834.19248711273, 53842.46157538453, 11993.460294286779, 12202.816957745641, 12227.205231660091, 12237.877621223673, 12242.204256723284, 8138.145494722969, 8354.958225208835, 8983.326250531236, 9433.198178154797, 9438.244940404751, 16171.353145874033, 16344.836551634331, 16468.505944821674, 16517.669646607, 16807.495775126765, 5511.200875872976, 5536.335639723259, 5551.8889622208135, 5638.830835074954, 5730.36965933747, 774.7365895595525, 819.8852160697508, 865.385576240876, 872.1583671756786, 888.8444522208588, 26294.474110517684, 27661.446771064468, 28054.158375248775, 28128.0, 28172.295692607848, 908.150878928191, 930.0517359968915, 942.3544871762864, 942.9198518126036, 958.750724811554, 14407.42370305197, 14734.852651473348, 14755.336009879367, 14951.476698315724, 15018.098914065191, 329023.0, 330870.0, 332846.0, 333003.0, 333269.0, 48166.5183348169, 48262.5173748258, 48270.27594586084, 48302.75848620734, 48384.338861362965, 1030.4229631406436, 1075.5805235957982, 1100.9614663486739, 1161.1697636190165, 1162.4826952006276, 26536.601950970366, 27829.52469376106, 28571.0, 28783.71216287894, 29085.418291634473, 41048.384274235315, 41603.1679366417, 41615.0, 41654.583454166284, 41664.58335416607, 255262.0, 255642.0, 255962.0, 256662.0, 256996.0, 22512.77487225107, 22984.770152298264, 23363.76636233616, 24258.636120457853, 35814.4627830588, 35764.105897352776, 35852.0, 35863.64136358707, 35933.0, 36482.63517364899, 30656.846715766278, 31015.379692406477, 31249.218769530944, 31284.843575781975, 31819.36361272808, 30799.692003080578, 31007.84496077505, 31216.473611325775, 31418.842905785325, 32326.515102273013, 31271.84364078165, 31498.84250578824, 31691.683083168875, 31742.841285793424, 32207.677923220468, 27000.86499567568, 28729.13812585542, 28937.610753445442, 29206.41587168287, 29233.85383073071, 22563.887180563994, 22800.885995569915, 22808.771912280667, 23120.4219894504, 23237.41906452352], "value": 16870.827744460985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5772263531903, 349.9125218695326, 361.1332801276935, 362.7497027051334, 381.5824213048526, 12349.814752778715, 15500.302486388111, 15584.68830623387, 16804.663906721857, 16888.662226755456, 16371.345146194139, 16435.83564164361, 16539.751903721455, 16664.75002874958, 16679.583010424714, 4776.164171270014, 4813.398325209358, 4909.3126962225315, 4959.107360675077, 5047.671901326402, 3642.562892452909, 3822.445745366934, 4823.469418363977, 4914.410270767495, 4920.901581968358, 5351.384590772072, 5592.217089607459, 5600.5799565032585, 5679.2049113123985, 5689.658620482764, 5462.644928079662, 5668.744906479218, 5676.858078548028, 5684.602077854552, 5746.626469279525, 5088.338515992934, 5100.464451232641, 5103.54068133866, 5103.9489605103845, 5104.208847628586, 19311.130999105073, 19444.611107777764, 19630.0, 19763.30828421013, 20167.394978150533, 1879.351623689825, 1879.3610172541264, 1880.4452686457391, 1882.9623407531772, 1930.2279088364626, 11977.520899164023, 12947.0, 12947.611571652771, 13259.138156019924, 13615.591532254048, 1657.78448801655, 1658.784358033448, 1694.466243133409, 1717.845393914541, 1818.0727828807403, 40230.0, 54317.45682543163, 54658.726706366615, 60880.39119608791, 63158.0, 8989.820203595891, 9273.67542136022, 9288.860667089999, 9371.203447707021, 9567.61729530825, 12890.0, 12898.097133200587, 12904.548340808027, 12911.741765164832, 12917.095803293867, 6522.673866306665, 6563.442107420828, 6711.563748356341, 6724.159480064992, 6749.763758268437, 6154.076888466766, 6197.101420294032, 6295.150154729145, 6297.905531417033, 6353.777617783356, 5815.970920145457, 5932.525397968152, 5966.701664916824, 6007.249093863267, 6075.934182377924, 1629.266829926514, 1653.4378311374192, 1667.7581750646332, 1689.1554222888556, 1691.7631531585587, 691.5885048396196, 794.8529522038441, 851.0765819086237, 911.4303560274828, 920.9585568649293, 15859.0, 16574.883813902306, 17132.314707411813, 17242.827571724374, 17368.47894563165, 808.8099296665279, 846.5428668518931, 884.7478468636408, 913.2420091324175, 931.5854444772011, 7714.459987800912, 9332.34673572857, 9768.120869121813, 9842.409455432697, 10020.649277275406, 330815.0, 334224.0, 346830.0, 353843.0, 353878.0, 73523.0, 78260.21739782643, 79349.20650793533, 80266.0, 80572.59713701395, 816.8447994880953, 824.7402068348451, 846.9618867150994, 848.291676450171, 857.6355049104105, 13759.243241621407, 14528.709425811636, 14548.563543093724, 15117.319720612819, 15739.685206296039, 32267.0, 32530.0, 32999.835000825806, 33181.50227746538, 36178.8191059043, 41730.45291150165, 45278.54721452743, 45707.0, 46082.0, 46902.76548617235, 7345.5959922202655, 7558.01745773046, 7558.13081495613, 7728.0, 7843.215678432111, 10369.896301036893, 10535.367877927349, 10575.524101415609, 11225.158113141384, 11929.46317415701, 9889.901100989186, 10040.69877903664, 10051.396916185053, 10207.0, 10404.11565016982, 9569.28230382738, 9680.128788408796, 9715.22278217755, 10091.243156763125, 10091.646792362231, 9668.419894806335, 9674.70975870725, 9919.45443000613, 10043.397396156253, 10255.487225638837, 7361.447891408059, 7502.512336698097, 7502.924970750222, 7561.621918903923, 7598.772036838904, 9390.483523406278, 9701.272404569827, 9737.0, 9802.26483013791, 10167.237457190593], "value": 7941.37258188445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1176.7881781279373, 1177.6702523293482, 1179.6402097360303, 1575.487966410916, 1628.6498402843386, 5931.169636250928, 6165.7533698652, 6278.0, 6619.933800661992, 6630.834229144268, 6236.750529978806, 6374.07575901494, 6453.548251622388, 6533.379328963752, 6564.737410503574, 2019.0409555461185, 2059.083707750052, 2060.2994981706215, 2061.742282214723, 2061.8247448966854, 1786.4015554789162, 1861.7672790901138, 2055.0649454498166, 2059.5263089489426, 2061.6082944240547, 1970.812772786583, 2043.0704029666465, 2049.610573990937, 2056.516718571135, 2068.803463670949, 2031.4053468027676, 2034.5422279987033, 2060.536379314657, 2061.319764477726, 2063.4531849060013, 2043.6627956387179, 2102.98948505258, 2104.4844013216707, 2107.115011695076, 2112.6619740841547, 6643.867122657568, 6678.899816502756, 6703.396694297488, 6706.5640733352175, 6709.664516774142, 4043.939340909889, 4166.541680415152, 4170.145120250341, 4170.52039015511, 4177.874663760092, 2662.480816240834, 2668.759811616964, 2871.3970066286106, 2875.09434528123, 2885.2498350428828, 817.38287592867, 841.1294310388779, 870.5777697816554, 884.2218847414299, 890.7773056735816, 8586.098459661707, 8590.441621294596, 8598.4840909545, 8639.265662418702, 8673.82652346956, 3661.798601076913, 3789.1663833956486, 3832.674222691047, 3936.173403585279, 3962.643362097425, 7341.082364704412, 7355.448341374418, 7358.190599034102, 7359.77920662381, 7369.078865141857, 4145.3781932710335, 4156.314208155621, 4175.269327867611, 4175.812088455966, 4181.163767246502, 3710.7216958728204, 3828.3109040373, 3831.3869780834934, 3832.2718683450057, 3833.9041523962123, 3215.244417561871, 3223.903282901517, 3247.7590462580742, 3298.65364136767, 3299.851506682205, 1012.7518757904213, 1037.8547003419528, 1112.0547534595692, 1112.3993043756282, 1140.7832511822728, 688.9069975553236, 805.0500409516826, 813.7396033269415, 817.5054092274207, 821.1296026212234, 4546.52261512543, 4662.300654901792, 4683.95316046842, 4726.905461890743, 4903.436104847917, 793.2147174297404, 814.8044469327318, 847.2671139464319, 859.6518410043942, 881.2025117268882, 3144.0, 3170.9841450792596, 3222.4038552867796, 3247.0421225738464, 3279.917627183024, 7559.584222867795, 7858.292753652198, 7862.960685196537, 7890.289873911375, 7930.325922296554, 7750.418718596128, 7817.218278172138, 7824.6870125194355, 7829.138794732575, 7833.725819596287, 6147.84630384244, 6240.625562466266, 6248.937510624926, 6253.343398943137, 6262.874742505124, 4587.931181032221, 4598.241290187082, 4609.654275929386, 4645.465771436193, 4747.976260118678, 7084.929150708427, 7109.715611375487, 7126.608036557832, 7157.1769246537315, 7260.927390726237, 7135.179454362815, 7172.462065345225, 7198.244184360567, 7307.086614173229, 7341.449391295568, 5428.6199966002005, 5552.69460179694, 5555.583331250092, 5556.944430555643, 5562.805301814417, 6164.4143806338325, 6254.8123556293385, 6297.559170857996, 6309.211348581427, 6338.904916426165, 4486.618637415856, 5646.040173170653, 5829.504492118217, 5843.1235314703135, 5904.940950590439, 5728.828135155952, 5764.942350576441, 5832.445917637818, 5842.503387212135, 5845.620034697731, 5335.093034184276, 5340.75966581497, 5354.919676204782, 5407.567394608343, 5407.78368865241, 3979.383195604686, 4017.6785857131945, 4023.155137421057, 4037.5356833963297, 4103.712740108163, 3925.0972276376024, 3966.960330396659, 3986.362182050858, 4024.577419371041, 4055.432239486533], "value": 3637.902016810079, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.73398350262056, 348.21825002868553, 351.0364050680881, 360.1985582079871, 363.61275241867395, 4749.47755746868, 4779.689320194185, 4783.904321913564, 4784.712917224969, 4798.856034318967, 4739.431268247807, 4745.549172828584, 4760.9523904760945, 4762.499937506564, 4771.0, 3592.730545209113, 3684.3736564783917, 3691.7231207659397, 3742.251549690073, 3790.905227369324, 3788.7347885648014, 3792.7534710243885, 3820.522434695663, 3823.0, 3825.0437390652337, 3774.2640185163905, 3792.0140763401437, 3795.601461846508, 3797.7721336719746, 3803.0, 3646.762960407565, 3730.7201959852982, 3730.850765969358, 3799.7720136791604, 3835.86574469895, 3428.1659312268066, 3440.8107554084513, 3444.0196886789945, 3454.2573346730574, 3462.4460086386307, 4607.424071991001, 4621.792019359137, 4639.164950308943, 4640.466346370177, 4641.489436162019, 3982.2234664240486, 4145.233131870614, 4337.110892267077, 4364.716293440948, 4375.103103863732, 4918.852434426973, 4933.80264789408, 4940.481249468826, 4949.7772600233075, 4953.504649535053, 3533.116720819795, 3547.3614749345106, 3548.591911930135, 3554.9822250888838, 3559.18138828071, 5012.8496145115705, 5212.400573934008, 5234.659747116425, 5239.318888544503, 5239.607029472767, 3514.61339252682, 3531.2584357284745, 3545.663161999606, 3556.91107722309, 3562.3613137956313, 3592.407252803258, 3592.760497628314, 3595.424732042861, 3610.981945090258, 3627.3108109459117, 4107.281225785536, 4125.64931980779, 4126.319157339066, 4147.149834283965, 4158.6465150462545, 4679.883002924886, 4902.28916807061, 4994.502748625687, 5010.073136469765, 5025.4974502550185, 1231.9322437266037, 1234.3211233821542, 1236.394166858251, 1236.6661001529537, 1239.39269757818, 805.4321703199348, 812.6749300279818, 833.2708879730236, 841.5119230846094, 845.9746207613781, 4118.897027574275, 4256.297710877732, 4295.634871035934, 4308.67684923632, 4342.565743425632, 5032.169692000779, 5084.593232541388, 5087.583397885975, 5096.490350964948, 5132.897342053213, 4299.935500967488, 4328.43730315057, 4335.414719012893, 4337.306031035019, 4340.676093791424, 2513.642632978208, 2595.2214335699214, 2601.6487774150246, 2611.817172797924, 2640.1815437214523, 4444.466664000341, 4479.910401792011, 4480.596746292849, 4500.639948804088, 4512.661550383735, 5054.1407960646775, 5075.568576671024, 5078.698845750292, 5102.066311870689, 5114.207297868837, 4342.0257123869615, 4458.732476051382, 4465.352523884018, 4491.438570178728, 4552.338396485326, 4876.195427754381, 4900.509949005071, 4906.362172917497, 4937.0, 4943.826966056171, 4751.928721069117, 4835.564799168092, 4877.1956125227425, 4883.658143929891, 4900.705957642553, 4247.936280955726, 4491.191585514639, 4526.502084770606, 4555.749433781174, 4560.6807523473035, 3463.203463203427, 3467.3758723430024, 3494.598121215991, 3497.2830569732637, 3498.510208570853, 5010.394594810751, 5014.147594908947, 5024.286885082015, 5025.8240961567635, 5041.924371134362, 4699.76761038504, 4749.453812811433, 4765.617970788432, 4794.880127996828, 4889.3888263967, 4752.52474752522, 4759.381280433521, 4760.048380164116, 4766.237402015661, 4781.617470602413, 4641.74470404131, 4676.812927482999, 4705.482396936266, 4726.929096063493, 4751.952480475289, 4652.511486294025, 4828.275758636232, 4844.249141383091, 4848.442429120696, 4866.418414015388, 4693.577578017995, 4716.834910778243, 4719.230288641759, 4727.17274476972, 4738.620910327235], "value": 3704.1127198925033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.6388258692547, 647.7797548833396, 669.9162604674412, 719.6509692798992, 730.769807510634, 12635.747285054305, 14080.29598520075, 14120.929395353021, 14133.646658833535, 14153.575392738221, 12816.29510376929, 12926.159799613019, 13138.0, 13142.47430102797, 13143.079984401096, 768.7539987204096, 778.3734094054284, 779.9961000195019, 787.09877190617, 789.6801795272895, 773.446985405435, 775.0157300228706, 775.0196002057373, 777.1257335497565, 778.1673609238118, 807.7738233294657, 812.0499016151117, 812.7927378518469, 814.4217605500102, 816.1552792859392, 812.9187081291883, 813.3493205435658, 813.4387272781762, 813.446856137826, 813.6094674556247, 596.5376832954495, 597.0894386061248, 597.742970522675, 601.4947444146937, 603.1375133559009, 11289.774204515863, 11347.375894325809, 11426.771464570746, 11510.136739744468, 12630.557930472482, 9507.762305942337, 9606.807863842683, 9680.612775488971, 9688.854667179998, 9962.252831037702, 9046.547672616409, 9213.723588292294, 9224.815503689955, 9291.163795258391, 9322.673706420243, 3080.2915329474345, 3166.145140811968, 3195.344954284366, 3269.8365081746056, 3328.650491698361, 60661.69669151626, 61475.0, 61842.690786545776, 61953.69023154901, 62313.688431558, 8176.877346839802, 8436.507936507936, 8500.192481714228, 8537.274331681752, 8538.0, 16531.421400250932, 16929.322827087024, 16931.661366772594, 17086.82913170877, 17097.658046838995, 6180.351063138306, 6482.837929051811, 6637.502187335873, 6719.832004199934, 6841.726330946806, 3546.3971124908826, 3587.408077667156, 3634.400323946519, 3688.963110368862, 3780.584135745066, 2690.085370973839, 2750.0787236275673, 2773.2789474736715, 2781.4019985702766, 2786.972130278671, 468.62978247185026, 502.6506577928305, 508.2021226674086, 509.38873351977776, 524.6799452334074, 408.4451460142103, 480.94469136049105, 509.3454910440067, 540.664787831547, 574.3911453858923, 7321.414286857039, 7373.410127189812, 7628.351590114902, 7842.568658723825, 7855.072463768116, 525.1178020924883, 548.3091304955784, 582.2721598002497, 589.7699897040158, 595.5116804220497, 3420.7776494527775, 3487.3548393547276, 3545.2023294758474, 3591.51514545533, 3672.540932383452, 51968.22047669288, 58355.70822145947, 66253.0, 69201.0, 69258.65370673215, 57202.42797571971, 57740.0, 57815.0, 58612.41387586069, 60881.69559152264, 51943.0, 52952.73523632434, 53499.19751203735, 53626.46373536293, 53722.194167087524, 6796.4902632303765, 6815.693293801692, 6838.965805171141, 6876.243613202644, 7154.284571542804, 36791.0, 37587.62412375841, 37967.0, 38068.80965595154, 38636.61363386443, 44813.551864480934, 44903.0, 48057.5194248053, 50450.495495046045, 50590.7352316195, 8560.272376848037, 8677.219050285505, 8738.0, 8762.430442021248, 8878.334124940526, 10010.149137323118, 10051.145652619609, 10089.24330675217, 10362.68911932613, 10440.94779526128, 9450.669226577036, 9673.467959262309, 9713.611455541699, 9754.512274386394, 9965.50172491358, 9669.129778319704, 9863.457509837028, 9922.107010369102, 10029.849552256575, 10096.646617368357, 9145.77135571616, 9258.768530786514, 9281.443113413217, 9389.154976052188, 9416.76458088526, 7022.495555852625, 7377.4098072155175, 7447.329740323397, 7457.0, 7557.2820582044615, 7459.888101678371, 7539.585322807298, 7571.129320128035, 7802.687892484237, 7892.960535197287], "value": 5764.686375845324, "unit": "score"}], "name": "dromaeo_css", "value": 5990.406312863412, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 116.0, 118.0, 115.0, 115.0, 115.0, 114.0, 114.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 130.0, 176.0, 130.0, 133.0, 129.0, 129.0, 152.0, 129.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 165.0, 164.0, 163.0, 163.0, 162.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 102.0, 77.0, 76.0, 77.0, 77.0, 98.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 108.0, 87.0, 87.0, 86.0, 97.0, 85.0, 85.0, 108.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 128.0, 127.0, 127.0, 126.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 73.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 86.0, 89.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 145.0, 141.0, 141.0, 142.0, 141.0, 182.0, 142.0, 200.0, 144.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 181.0, 178.0, 179.0, 179.0, 177.0, 180.0, 183.0, 177.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 70.0, 68.0, 70.0, 69.0, 67.0, 68.0, 69.0, 68.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1580.2, "alertThreshold": 2.0}]} 07:57:45 INFO - Return code: 0 07:57:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:45 INFO - # TBPL SUCCESS # 07:57:45 INFO - Running post-action listener: _resource_record_post_action 07:57:45 INFO - [mozharness: 2016-12-14 15:57:45.152790Z] Finished run-tests step (success) 07:57:45 INFO - Running post-run listener: _resource_record_post_run 07:57:45 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401793024; Read time: 16; Write time: 301180 07:57:45 INFO - TinderboxPrint: CPU usage
13.2% 07:57:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:57:45 INFO - TinderboxPrint: I/O write bytes / time
401,793,024 / 301,180 07:57:45 INFO - TinderboxPrint: CPU idle
8,339.2 (86.8%) 07:57:45 INFO - TinderboxPrint: CPU user
1,216.8 (12.7%) 07:57:45 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100065280; Read time: 0; Write time: 95748 07:57:45 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290471936; Read time: 0; Write time: 202656 07:57:45 INFO - Running post-run listener: _upload_blobber_files 07:57:45 INFO - Blob upload gear active. 07:57:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:57:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:46 INFO - (blobuploader) - INFO - Done attempting. 07:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:47 INFO - (blobuploader) - INFO - Done attempting. 07:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:50 INFO - (blobuploader) - INFO - Done attempting. 07:57:50 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:50 INFO - Return code: 0 07:57:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf400bf2b605c5da1ce04cf075371421910a9f6f8de99c1b0b0ccd27f3d3ba4d9ade31505af0908ca9c6e33ca5d0cb3455f193683ab3b1e5d0c4c77ccc6d81fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da314dd4e5ec5db30c9b5dcb2a3b1c8e3018b9b097b64cf53c2fac63e76daae7e319fc07130281d57c48c9bd501d3b4ee3c7f2601aa25e123f5fc880919ce7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e7708c4f4b8dc9dc471c0f19e36f463f9b4001ee114f604979fba135f48d018780e2cd287a430f77019f74727c2833e52ec3b737eef6caa506311aff719281"} 07:57:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:50 INFO - Contents: 07:57:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf400bf2b605c5da1ce04cf075371421910a9f6f8de99c1b0b0ccd27f3d3ba4d9ade31505af0908ca9c6e33ca5d0cb3455f193683ab3b1e5d0c4c77ccc6d81fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da314dd4e5ec5db30c9b5dcb2a3b1c8e3018b9b097b64cf53c2fac63e76daae7e319fc07130281d57c48c9bd501d3b4ee3c7f2601aa25e123f5fc880919ce7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e7708c4f4b8dc9dc471c0f19e36f463f9b4001ee114f604979fba135f48d018780e2cd287a430f77019f74727c2833e52ec3b737eef6caa506311aff719281"} 07:57:50 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:50 INFO - Copying logs to upload dir... 07:57:50 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.288073 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-14 07:57:50.064160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 07:57:50.068073) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf400bf2b605c5da1ce04cf075371421910a9f6f8de99c1b0b0ccd27f3d3ba4d9ade31505af0908ca9c6e33ca5d0cb3455f193683ab3b1e5d0c4c77ccc6d81fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da314dd4e5ec5db30c9b5dcb2a3b1c8e3018b9b097b64cf53c2fac63e76daae7e319fc07130281d57c48c9bd501d3b4ee3c7f2601aa25e123f5fc880919ce7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e7708c4f4b8dc9dc471c0f19e36f463f9b4001ee114f604979fba135f48d018780e2cd287a430f77019f74727c2833e52ec3b737eef6caa506311aff719281"} build_url:https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/chCAqdySSF-NO5K43lF2lg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf400bf2b605c5da1ce04cf075371421910a9f6f8de99c1b0b0ccd27f3d3ba4d9ade31505af0908ca9c6e33ca5d0cb3455f193683ab3b1e5d0c4c77ccc6d81fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da314dd4e5ec5db30c9b5dcb2a3b1c8e3018b9b097b64cf53c2fac63e76daae7e319fc07130281d57c48c9bd501d3b4ee3c7f2601aa25e123f5fc880919ce7c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00e7708c4f4b8dc9dc471c0f19e36f463f9b4001ee114f604979fba135f48d018780e2cd287a430f77019f74727c2833e52ec3b737eef6caa506311aff719281"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 07:57:50.093680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:57:50.093979) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481728950.404643-932384760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 07:57:50.177495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 07:57:50.177827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 07:57:50.178123) ========= ========= Total master_lag: 0.16 =========