builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1477478356.67 results: success (0) buildid: 20161026004014 builduid: 0ff6334abedd49bb95ab30a9518c83be revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.669408) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.670190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.670481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.685192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.685530) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 03:39:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-10-26 03:39:17 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.774776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.775066) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016078 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.825548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:16.825865) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a16ab27e533088e1711a82ff380d3ebd262ca837 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a16ab27e533088e1711a82ff380d3ebd262ca837 --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=2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 03:39:17,154 truncating revision to first 12 chars 2016-10-26 03:39:17,154 Setting DEBUG logging. 2016-10-26 03:39:17,154 attempt 1/10 2016-10-26 03:39:17,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a16ab27e5330?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 03:39:17,519 unpacking tar archive at: mozilla-aurora-a16ab27e5330/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:17.550804) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:17.551147) ========= script_repo_revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:17.551547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:17.551818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 03:39:17.563514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-26 03:39:17.563780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:17 INFO - MultiFileLogger online at 20161026 03:39:17 in /builds/slave/test 03:39:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:39:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:17 INFO - {'append_to_log': False, 03:39:17 INFO - 'base_work_dir': '/builds/slave/test', 03:39:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:17 INFO - 'branch': 'Mozilla-Aurora', 03:39:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:17 INFO - 'config_files': ('talos/linux_config.py',), 03:39:17 INFO - 'default_actions': ('clobber', 03:39:17 INFO - 'read-buildbot-config', 03:39:17 INFO - 'download-and-extract', 03:39:17 INFO - 'populate-webroot', 03:39:17 INFO - 'create-virtualenv', 03:39:17 INFO - 'install', 03:39:17 INFO - 'run-tests'), 03:39:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:17 INFO - 'download_minidump_stackwalk': True, 03:39:17 INFO - 'download_symbols': 'ondemand', 03:39:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:17 INFO - 'installer_path': 'installer.exe', 03:39:17 INFO - 'log_level': 'info', 03:39:17 INFO - 'log_name': 'talos', 03:39:17 INFO - 'log_to_console': True, 03:39:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:17 INFO - 'opt_config_files': (), 03:39:17 INFO - 'pip_index': False, 03:39:17 INFO - 'sps_profile': False, 03:39:17 INFO - 'sps_profile_interval': 0, 03:39:17 INFO - 'suite': 'dromaeojs', 03:39:17 INFO - 'system_bits': '32', 03:39:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:17 INFO - 'title': 'talos-linux64-ix-012', 03:39:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:17 INFO - 'use_talos_json': True, 03:39:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:17 INFO - 'work_dir': 'build'} 03:39:17 INFO - [mozharness: 2016-10-26 10:39:17.987110Z] Running clobber step. 03:39:17 INFO - Running pre-action listener: _resource_record_pre_action 03:39:17 INFO - Running main action method: clobber 03:39:17 INFO - rmtree: /builds/slave/test/build 03:39:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:18 INFO - Running post-action listener: _resource_record_post_action 03:39:18 INFO - [mozharness: 2016-10-26 10:39:18.446120Z] Finished clobber step (success) 03:39:18 INFO - [mozharness: 2016-10-26 10:39:18.446219Z] Running read-buildbot-config step. 03:39:18 INFO - Running pre-action listener: _resource_record_pre_action 03:39:18 INFO - Running main action method: read_buildbot_config 03:39:18 INFO - Using buildbot properties: 03:39:18 INFO - { 03:39:18 INFO - "project": "", 03:39:18 INFO - "product": "firefox", 03:39:18 INFO - "script_repo_revision": "production", 03:39:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:39:18 INFO - "repository": "", 03:39:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:39:18 INFO - "buildid": "20161026004014", 03:39:18 INFO - "stage_platform": "linux64-pgo", 03:39:18 INFO - "basedir": "/builds/slave/test", 03:39:18 INFO - "nightly_build": "True", 03:39:18 INFO - "buildnumber": 590, 03:39:18 INFO - "slavename": "talos-linux64-ix-012", 03:39:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:39:18 INFO - "platform": "ubuntu64_hw", 03:39:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:18 INFO - "branch": "mozilla-aurora", 03:39:18 INFO - "repo_path": "releases/mozilla-aurora", 03:39:18 INFO - "revision": "a16ab27e533088e1711a82ff380d3ebd262ca837", 03:39:18 INFO - "pgo_build": "True", 03:39:18 INFO - "builduid": "0ff6334abedd49bb95ab30a9518c83be", 03:39:18 INFO - "slavebuilddir": "test" 03:39:18 INFO - } 03:39:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:39:18 INFO - Running post-action listener: _resource_record_post_action 03:39:18 INFO - [mozharness: 2016-10-26 10:39:18.448726Z] Finished read-buildbot-config step (success) 03:39:18 INFO - [mozharness: 2016-10-26 10:39:18.448815Z] Running download-and-extract step. 03:39:18 INFO - Running pre-action listener: _resource_record_pre_action 03:39:18 INFO - Running main action method: download_and_extract 03:39:18 INFO - mkdir: /builds/slave/test/build/tests 03:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:18 INFO - trying https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:39:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:39:19 INFO - Downloaded 1361 bytes. 03:39:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:39:19 INFO - Using the following test package requirements: 03:39:19 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:19 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:19 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:39:19 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'jsshell-linux-x86_64.zip'], 03:39:19 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:19 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:19 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:19 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:19 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:19 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:39:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:39:19 INFO - Expected file size: 21894102 03:39:23 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:39:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:39:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:39:24 INFO - Expected file size: 21894102 03:39:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:39:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:39:29 INFO - Expected file size: 14414081 03:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:30 INFO - trying https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:39:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:39:32 INFO - Downloaded 63962616 bytes. 03:39:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:39:32 INFO - mkdir: /builds/slave/test/properties 03:39:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:32 INFO - Contents: 03:39:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:39:32 INFO - Running post-action listener: _resource_record_post_action 03:39:32 INFO - Running post-action listener: set_extra_try_arguments 03:39:32 INFO - [mozharness: 2016-10-26 10:39:32.794800Z] Finished download-and-extract step (success) 03:39:32 INFO - [mozharness: 2016-10-26 10:39:32.795026Z] Running populate-webroot step. 03:39:32 INFO - Running pre-action listener: _resource_record_pre_action 03:39:32 INFO - Running main action method: populate_webroot 03:39:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:32 INFO - '--tppagecycles', 03:39:32 INFO - '7'], 03:39:32 INFO - 'tests': ['tsvgm']}}, 03:39:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:39:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:39:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['damp', 'tps']}, 03:39:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'tests': ['damp', 'tps']}, 03:39:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['dromaeo_dom']}, 03:39:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['basic_compositor_video']}, 03:39:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:39:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['a11yr', 03:39:32 INFO - 'ts_paint', 03:39:32 INFO - 'tpaint', 03:39:32 INFO - 'sessionrestore', 03:39:32 INFO - 'sessionrestore_no_auto_restore', 03:39:32 INFO - 'tabpaint']}, 03:39:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:39:32 INFO - 'ts_paint', 03:39:32 INFO - 'tpaint', 03:39:32 INFO - 'sessionrestore', 03:39:32 INFO - 'sessionrestore_no_auto_restore', 03:39:32 INFO - 'tabpaint']}, 03:39:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:39:32 INFO - 'ts_paint', 03:39:32 INFO - 'tpaint', 03:39:32 INFO - 'sessionrestore', 03:39:32 INFO - 'sessionrestore_no_auto_restore', 03:39:32 INFO - 'tabpaint']}, 03:39:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:39:32 INFO - 'ts_paint', 03:39:32 INFO - 'tpaint', 03:39:32 INFO - 'sessionrestore', 03:39:32 INFO - 'sessionrestore_no_auto_restore', 03:39:32 INFO - 'tabpaint']}, 03:39:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['a11yr', 03:39:32 INFO - 'ts_paint', 03:39:32 INFO - 'tpaint', 03:39:32 INFO - 'sessionrestore', 03:39:32 INFO - 'sessionrestore_no_auto_restore', 03:39:32 INFO - 'tabpaint']}, 03:39:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['a11yr', 03:39:32 INFO - 'ts_paint', 03:39:32 INFO - 'tpaint', 03:39:32 INFO - 'sessionrestore', 03:39:32 INFO - 'sessionrestore_no_auto_restore', 03:39:32 INFO - 'tabpaint']}, 03:39:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['tsvgx', 03:39:32 INFO - 'tsvgr_opacity', 03:39:32 INFO - 'tart', 03:39:32 INFO - 'tscrollx', 03:39:32 INFO - 'cart']}, 03:39:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:39:32 INFO - 'tsvgr_opacity', 03:39:32 INFO - 'tart', 03:39:32 INFO - 'tscrollx', 03:39:32 INFO - 'cart']}, 03:39:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'talos_options': ['--disable-e10s'], 03:39:32 INFO - 'tests': ['tp5o']}, 03:39:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'tests': ['tp5o']}, 03:39:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'talos_options': ['--disable-e10s', 03:39:32 INFO - '--xperf_path', 03:39:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:32 INFO - 'tests': ['tp5n']}, 03:39:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:32 INFO - 'talos_options': ['--xperf_path', 03:39:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:32 INFO - 'tests': ['tp5n']}}, 03:39:32 INFO - 'talos.zip': {'path': '', 03:39:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:32 INFO - Running post-action listener: _resource_record_post_action 03:39:32 INFO - [mozharness: 2016-10-26 10:39:32.814903Z] Finished populate-webroot step (success) 03:39:32 INFO - [mozharness: 2016-10-26 10:39:32.814991Z] Running create-virtualenv step. 03:39:32 INFO - Running pre-action listener: _resource_record_pre_action 03:39:32 INFO - Running main action method: create_virtualenv 03:39:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:32 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 03:39:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:32 INFO - Using real prefix '/usr' 03:39:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:35 INFO - Installing pip.................done. 03:39:35 INFO - Return code: 0 03:39:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39:35 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')]} 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:35 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')]} 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:35 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:35 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 03:39:35 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 03:39:35 INFO - Using env: {'DISPLAY': ':0', 03:39:35 INFO - 'HOME': '/home/cltbld', 03:39:35 INFO - 'LANG': 'en_US.UTF-8', 03:39:35 INFO - 'LANGUAGE': 'en_US:en', 03:39:35 INFO - 'LOGNAME': 'cltbld', 03:39:35 INFO - 'MAIL': '/var/mail/cltbld', 03:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:35 INFO - 'MOZ_NO_REMOTE': '1', 03:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:35 INFO - 'NO_EM_RESTART': '1', 03:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:35 INFO - 'PWD': '/builds/slave/test', 03:39:35 INFO - 'SHELL': '/bin/bash', 03:39:35 INFO - 'SHLVL': '1', 03:39:35 INFO - 'TERM': 'linux', 03:39:35 INFO - 'TMOUT': '86400', 03:39:35 INFO - 'USER': 'cltbld', 03:39:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:35 INFO - '_': '/tools/buildbot/bin/python'} 03:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:35 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 03:39:35 INFO - Cleaning up... 03:39:35 INFO - Return code: 0 03:39:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39:35 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')]} 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:35 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')]} 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:35 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:35 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 03:39:35 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 03:39:35 INFO - Using env: {'DISPLAY': ':0', 03:39:35 INFO - 'HOME': '/home/cltbld', 03:39:35 INFO - 'LANG': 'en_US.UTF-8', 03:39:35 INFO - 'LANGUAGE': 'en_US:en', 03:39:35 INFO - 'LOGNAME': 'cltbld', 03:39:35 INFO - 'MAIL': '/var/mail/cltbld', 03:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:35 INFO - 'MOZ_NO_REMOTE': '1', 03:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:35 INFO - 'NO_EM_RESTART': '1', 03:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:35 INFO - 'PWD': '/builds/slave/test', 03:39:35 INFO - 'SHELL': '/bin/bash', 03:39:35 INFO - 'SHLVL': '1', 03:39:35 INFO - 'TERM': 'linux', 03:39:35 INFO - 'TMOUT': '86400', 03:39:35 INFO - 'USER': 'cltbld', 03:39:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:35 INFO - '_': '/tools/buildbot/bin/python'} 03:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:35 INFO - Downloading/unpacking psutil>=3.1.1 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:37 INFO - Installing collected packages: psutil 03:39:37 INFO - Running setup.py install for psutil 03:39:37 INFO - building 'psutil._psutil_linux' extension 03:39:37 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 03:39:38 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 03:39:38 INFO - building 'psutil._psutil_posix' extension 03:39:38 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 03:39:38 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 03:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:38 INFO - Successfully installed psutil 03:39:38 INFO - Cleaning up... 03:39:38 INFO - Return code: 0 03:39:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:39:38 INFO - Using env: {'DISPLAY': ':0', 03:39:38 INFO - 'HOME': '/home/cltbld', 03:39:38 INFO - 'LANG': 'en_US.UTF-8', 03:39:38 INFO - 'LANGUAGE': 'en_US:en', 03:39:38 INFO - 'LOGNAME': 'cltbld', 03:39:38 INFO - 'MAIL': '/var/mail/cltbld', 03:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:38 INFO - 'MOZ_NO_REMOTE': '1', 03:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:38 INFO - 'NO_EM_RESTART': '1', 03:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:38 INFO - 'PWD': '/builds/slave/test', 03:39:38 INFO - 'SHELL': '/bin/bash', 03:39:38 INFO - 'SHLVL': '1', 03:39:38 INFO - 'TERM': 'linux', 03:39:38 INFO - 'TMOUT': '86400', 03:39:38 INFO - 'USER': 'cltbld', 03:39:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:38 INFO - '_': '/tools/buildbot/bin/python'} 03:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:39:40 INFO - Installing collected packages: mozsystemmonitor 03:39:40 INFO - Running setup.py install for mozsystemmonitor 03:39:40 INFO - Successfully installed mozsystemmonitor 03:39:40 INFO - Cleaning up... 03:39:40 INFO - Return code: 0 03:39:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39: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==2.5.1'] in /builds/slave/test/build 03:39: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==2.5.1 03:39:40 INFO - Using env: {'DISPLAY': ':0', 03:39:40 INFO - 'HOME': '/home/cltbld', 03:39:40 INFO - 'LANG': 'en_US.UTF-8', 03:39:40 INFO - 'LANGUAGE': 'en_US:en', 03:39:40 INFO - 'LOGNAME': 'cltbld', 03:39:40 INFO - 'MAIL': '/var/mail/cltbld', 03:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:40 INFO - 'MOZ_NO_REMOTE': '1', 03:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:40 INFO - 'NO_EM_RESTART': '1', 03:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:40 INFO - 'PWD': '/builds/slave/test', 03:39:40 INFO - 'SHELL': '/bin/bash', 03:39:40 INFO - 'SHLVL': '1', 03:39:40 INFO - 'TERM': 'linux', 03:39:40 INFO - 'TMOUT': '86400', 03:39:40 INFO - 'USER': 'cltbld', 03:39:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:40 INFO - '_': '/tools/buildbot/bin/python'} 03:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:41 INFO - Downloading/unpacking jsonschema==2.5.1 03:39:41 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 03:39:41 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 03:39:41 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 03:39:41 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 03:39:41 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 03:39:41 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 03:39:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:39:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:39:42 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 03:39:42 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 03:39:42 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 03:39:42 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 03:39:42 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 03:39:42 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 03:39:43 INFO - Downloading functools32-3.2.3-2.tar.gz 03:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:39:43 INFO - warning: no files found matching '*.txt' 03:39:43 INFO - no previously-included directories found matching 'build' 03:39:43 INFO - no previously-included directories found matching 'dist' 03:39:43 INFO - no previously-included directories found matching '.git*' 03:39:43 INFO - Installing collected packages: jsonschema, functools32 03:39:43 INFO - Running setup.py install for functools32 03:39:43 INFO - warning: no files found matching '*.txt' 03:39:43 INFO - no previously-included directories found matching 'build' 03:39:43 INFO - no previously-included directories found matching 'dist' 03:39:43 INFO - no previously-included directories found matching '.git*' 03:39:43 INFO - Successfully installed jsonschema functools32 03:39:43 INFO - Cleaning up... 03:39:43 INFO - Return code: 0 03:39:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:43 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:43 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 03:39:43 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 03:39:43 INFO - Using env: {'DISPLAY': ':0', 03:39:43 INFO - 'HOME': '/home/cltbld', 03:39:43 INFO - 'LANG': 'en_US.UTF-8', 03:39:43 INFO - 'LANGUAGE': 'en_US:en', 03:39:43 INFO - 'LOGNAME': 'cltbld', 03:39:43 INFO - 'MAIL': '/var/mail/cltbld', 03:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:43 INFO - 'MOZ_NO_REMOTE': '1', 03:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:43 INFO - 'NO_EM_RESTART': '1', 03:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:43 INFO - 'PWD': '/builds/slave/test', 03:39:43 INFO - 'SHELL': '/bin/bash', 03:39:43 INFO - 'SHLVL': '1', 03:39:43 INFO - 'TERM': 'linux', 03:39:43 INFO - 'TMOUT': '86400', 03:39:43 INFO - 'USER': 'cltbld', 03:39:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:43 INFO - '_': '/tools/buildbot/bin/python'} 03:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:39:43 INFO - Cleaning up... 03:39:43 INFO - Return code: 0 03:39:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:43 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:43 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 03:39:43 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 03:39:43 INFO - Using env: {'DISPLAY': ':0', 03:39:43 INFO - 'HOME': '/home/cltbld', 03:39:43 INFO - 'LANG': 'en_US.UTF-8', 03:39:43 INFO - 'LANGUAGE': 'en_US:en', 03:39:43 INFO - 'LOGNAME': 'cltbld', 03:39:43 INFO - 'MAIL': '/var/mail/cltbld', 03:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:43 INFO - 'MOZ_NO_REMOTE': '1', 03:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:43 INFO - 'NO_EM_RESTART': '1', 03:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:43 INFO - 'PWD': '/builds/slave/test', 03:39:43 INFO - 'SHELL': '/bin/bash', 03:39:43 INFO - 'SHLVL': '1', 03:39:43 INFO - 'TERM': 'linux', 03:39:43 INFO - 'TMOUT': '86400', 03:39:43 INFO - 'USER': 'cltbld', 03:39:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:43 INFO - '_': '/tools/buildbot/bin/python'} 03:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:39:43 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 03:39:43 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 03:39:43 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 03:39:43 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 03:39:43 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 03:39:43 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 03:39:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:39:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39:45 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 03:39:45 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 03:39:45 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 03:39:45 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 03:39:45 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 03:39:45 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 03:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:39:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:46 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 03:39:46 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 03:39:46 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 03:39:46 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 03:39:46 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 03:39:46 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 03:39:46 INFO - Downloading docopt-0.6.1.tar.gz 03:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:39:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:39:46 INFO - Running setup.py install for blobuploader 03:39:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:39:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:39:46 INFO - Running setup.py install for requests 03:39:47 INFO - Running setup.py install for docopt 03:39:47 INFO - Successfully installed blobuploader requests docopt 03:39:47 INFO - Cleaning up... 03:39:47 INFO - Return code: 0 03:39:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:47 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')]} 03:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:47 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')]} 03:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:47 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:47 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 03:39:47 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 03:39:47 INFO - Using env: {'DISPLAY': ':0', 03:39:47 INFO - 'HOME': '/home/cltbld', 03:39:47 INFO - 'LANG': 'en_US.UTF-8', 03:39:47 INFO - 'LANGUAGE': 'en_US:en', 03:39:47 INFO - 'LOGNAME': 'cltbld', 03:39:47 INFO - 'MAIL': '/var/mail/cltbld', 03:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:47 INFO - 'MOZ_NO_REMOTE': '1', 03:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:47 INFO - 'NO_EM_RESTART': '1', 03:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:47 INFO - 'PWD': '/builds/slave/test', 03:39:47 INFO - 'SHELL': '/bin/bash', 03:39:47 INFO - 'SHLVL': '1', 03:39:47 INFO - 'TERM': 'linux', 03:39:47 INFO - 'TMOUT': '86400', 03:39:47 INFO - 'USER': 'cltbld', 03:39:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:47 INFO - '_': '/tools/buildbot/bin/python'} 03:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:47 INFO - Running setup.py (path:/tmp/pip-KoIjNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:47 INFO - Running setup.py (path:/tmp/pip-5dcT67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:47 INFO - Running setup.py (path:/tmp/pip-KoIC4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:47 INFO - Running setup.py (path:/tmp/pip-4_1kLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:47 INFO - Running setup.py (path:/tmp/pip-kl6Kyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:47 INFO - Running setup.py (path:/tmp/pip-PvWXCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:47 INFO - Running setup.py (path:/tmp/pip-JTznt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:47 INFO - Running setup.py (path:/tmp/pip-gZwZom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:47 INFO - Running setup.py (path:/tmp/pip-30EwNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:48 INFO - Running setup.py (path:/tmp/pip-gsYkNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:48 INFO - Running setup.py (path:/tmp/pip-DarYiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:48 INFO - Running setup.py (path:/tmp/pip-W5L_9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:48 INFO - Running setup.py (path:/tmp/pip-58NzeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:48 INFO - Running setup.py (path:/tmp/pip-Oq7QOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:48 INFO - Running setup.py (path:/tmp/pip-P8DBKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:48 INFO - Running setup.py (path:/tmp/pip-bcVXm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:48 INFO - Running setup.py (path:/tmp/pip-oiKF6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:39:48 INFO - Running setup.py install for manifestparser 03:39:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:39:48 INFO - Running setup.py install for mozcrash 03:39:48 INFO - Running setup.py install for mozdebug 03:39:48 INFO - Running setup.py install for mozdevice 03:39:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Running setup.py install for mozfile 03:39:49 INFO - Running setup.py install for mozhttpd 03:39:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Running setup.py install for mozinfo 03:39:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Running setup.py install for mozInstall 03:39:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Running setup.py install for mozleak 03:39:49 INFO - Running setup.py install for mozlog 03:39:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Running setup.py install for moznetwork 03:39:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Running setup.py install for mozprocess 03:39:49 INFO - Running setup.py install for mozprofile 03:39:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:39:49 INFO - Running setup.py install for mozrunner 03:39:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:39:50 INFO - Running setup.py install for mozscreenshot 03:39:50 INFO - Running setup.py install for moztest 03:39:50 INFO - Running setup.py install for mozversion 03:39:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:39:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:50 INFO - Cleaning up... 03:39:50 INFO - Return code: 0 03:39:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:50 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:50 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 03:39:50 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 03:39:50 INFO - Using env: {'DISPLAY': ':0', 03:39:50 INFO - 'HOME': '/home/cltbld', 03:39:50 INFO - 'LANG': 'en_US.UTF-8', 03:39:50 INFO - 'LANGUAGE': 'en_US:en', 03:39:50 INFO - 'LOGNAME': 'cltbld', 03:39:50 INFO - 'MAIL': '/var/mail/cltbld', 03:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:50 INFO - 'MOZ_NO_REMOTE': '1', 03:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:50 INFO - 'NO_EM_RESTART': '1', 03:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:50 INFO - 'PWD': '/builds/slave/test', 03:39:50 INFO - 'SHELL': '/bin/bash', 03:39:50 INFO - 'SHLVL': '1', 03:39:50 INFO - 'TERM': 'linux', 03:39:50 INFO - 'TMOUT': '86400', 03:39:50 INFO - 'USER': 'cltbld', 03:39:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:50 INFO - '_': '/tools/buildbot/bin/python'} 03:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:50 INFO - Running setup.py (path:/tmp/pip-g_HvTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:50 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)) 03:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:50 INFO - Running setup.py (path:/tmp/pip-6t4sn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:50 INFO - Running setup.py (path:/tmp/pip-EzOBbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:50 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)) 03:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:50 INFO - Running setup.py (path:/tmp/pip-somQ5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:50 INFO - Running setup.py (path:/tmp/pip-KJGWJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:50 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)) 03:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:50 INFO - Running setup.py (path:/tmp/pip-_TqzLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:51 INFO - Running setup.py (path:/tmp/pip-ToEahD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:51 INFO - Running setup.py (path:/tmp/pip-iAoJr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:51 INFO - Running setup.py (path:/tmp/pip-g6KB6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:51 INFO - Running setup.py (path:/tmp/pip-Ev0s11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:51 INFO - Running setup.py (path:/tmp/pip-sd092d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:51 INFO - Running setup.py (path:/tmp/pip-GOI8EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:51 INFO - Running setup.py (path:/tmp/pip-hrkels-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:51 INFO - Running setup.py (path:/tmp/pip-jf48lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:51 INFO - Running setup.py (path:/tmp/pip-q_gLeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:51 INFO - Running setup.py (path:/tmp/pip-NDpNFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:51 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)) 03:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:51 INFO - Running setup.py (path:/tmp/pip-j81U_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:51 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)) 03:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:51 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)) 03:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:39:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:51 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 03:39:51 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 03:39:51 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 03:39:51 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 03:39:51 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 03:39:51 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 03:39:53 INFO - Downloading blessings-1.6.tar.gz 03:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:53 INFO - Installing collected packages: blessings 03:39:53 INFO - Running setup.py install for blessings 03:39:53 INFO - Successfully installed blessings 03:39:53 INFO - Cleaning up... 03:39:54 INFO - Return code: 0 03:39:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:54 INFO - Reading from file tmpfile_stdout 03:39:54 INFO - Current package versions: 03:39:54 INFO - argparse == 1.2.1 03:39:54 INFO - blessings == 1.6 03:39:54 INFO - blobuploader == 1.2.4 03:39:54 INFO - docopt == 0.6.1 03:39:54 INFO - functools32 == 3.2.3-2 03:39:54 INFO - jsonschema == 2.5.1 03:39:54 INFO - manifestparser == 1.1 03:39:54 INFO - mozInstall == 1.12 03:39:54 INFO - mozcrash == 0.17 03:39:54 INFO - mozdebug == 0.1 03:39:54 INFO - mozdevice == 0.48 03:39:54 INFO - mozfile == 1.2 03:39:54 INFO - mozhttpd == 0.7 03:39:54 INFO - mozinfo == 0.9 03:39:54 INFO - mozleak == 0.1 03:39:54 INFO - mozlog == 3.4 03:39:54 INFO - moznetwork == 0.27 03:39:54 INFO - mozprocess == 0.23 03:39:54 INFO - mozprofile == 0.28 03:39:54 INFO - mozrunner == 6.12 03:39:54 INFO - mozscreenshot == 0.1 03:39:54 INFO - mozsystemmonitor == 0.3 03:39:54 INFO - moztest == 0.7 03:39:54 INFO - mozversion == 1.4 03:39:54 INFO - psutil == 3.1.1 03:39:54 INFO - requests == 1.2.3 03:39:54 INFO - wsgiref == 0.1.2 03:39:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:54 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:54 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 03:39:54 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 03:39:54 INFO - Using env: {'DISPLAY': ':0', 03:39:54 INFO - 'HOME': '/home/cltbld', 03:39:54 INFO - 'LANG': 'en_US.UTF-8', 03:39:54 INFO - 'LANGUAGE': 'en_US:en', 03:39:54 INFO - 'LOGNAME': 'cltbld', 03:39:54 INFO - 'MAIL': '/var/mail/cltbld', 03:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:54 INFO - 'MOZ_NO_REMOTE': '1', 03:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:54 INFO - 'NO_EM_RESTART': '1', 03:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:54 INFO - 'PWD': '/builds/slave/test', 03:39:54 INFO - 'SHELL': '/bin/bash', 03:39:54 INFO - 'SHLVL': '1', 03:39:54 INFO - 'TERM': 'linux', 03:39:54 INFO - 'TMOUT': '86400', 03:39:54 INFO - 'USER': 'cltbld', 03:39:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:54 INFO - '_': '/tools/buildbot/bin/python'} 03:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 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)) 03:39:54 INFO - Cleaning up... 03:39:54 INFO - Return code: 0 03:39:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:54 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 0x7f89f0a14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', '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 03:39:54 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 03:39:54 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 03:39:54 INFO - Using env: {'DISPLAY': ':0', 03:39:54 INFO - 'HOME': '/home/cltbld', 03:39:54 INFO - 'LANG': 'en_US.UTF-8', 03:39:54 INFO - 'LANGUAGE': 'en_US:en', 03:39:54 INFO - 'LOGNAME': 'cltbld', 03:39:54 INFO - 'MAIL': '/var/mail/cltbld', 03:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:54 INFO - 'MOZ_NO_REMOTE': '1', 03:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:54 INFO - 'NO_EM_RESTART': '1', 03:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:54 INFO - 'PWD': '/builds/slave/test', 03:39:54 INFO - 'SHELL': '/bin/bash', 03:39:54 INFO - 'SHLVL': '1', 03:39:54 INFO - 'TERM': 'linux', 03:39:54 INFO - 'TMOUT': '86400', 03:39:54 INFO - 'USER': 'cltbld', 03:39:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:54 INFO - '_': '/tools/buildbot/bin/python'} 03:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:39:54 INFO - Cleaning up... 03:39:54 INFO - Return code: 0 03:39:54 INFO - Running post-action listener: _resource_record_post_action 03:39:54 INFO - Running post-action listener: _start_resource_monitoring 03:39:54 INFO - Starting resource monitoring. 03:39:54 INFO - [mozharness: 2016-10-26 10:39:54.733013Z] Finished create-virtualenv step (success) 03:39:54 INFO - [mozharness: 2016-10-26 10:39:54.733585Z] Running install step. 03:39:54 INFO - Running pre-action listener: _resource_record_pre_action 03:39:54 INFO - Running main action method: install 03:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:54 INFO - Reading from file tmpfile_stdout 03:39:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:55 INFO - Reading from file tmpfile_stdout 03:39:55 INFO - Output received: 03:39:55 INFO - Usage: mozinstall [options] installer 03:39:55 INFO - Options: 03:39:55 INFO - -h, --help show this help message and exit 03:39:55 INFO - -d DEST, --destination=DEST 03:39:55 INFO - Directory to install application into. [default: 03:39:55 INFO - "/builds/slave/test"] 03:39:55 INFO - --app=APP Application being installed. [default: firefox] 03:39:55 INFO - mkdir: /builds/slave/test/build/application 03:39:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:40:10 INFO - Reading from file tmpfile_stdout 03:40:10 INFO - Output received: 03:40:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:40:10 INFO - Running post-action listener: _resource_record_post_action 03:40:10 INFO - [mozharness: 2016-10-26 10:40:10.990822Z] Finished install step (success) 03:40:10 INFO - [mozharness: 2016-10-26 10:40:10.991153Z] Running run-tests step. 03:40:10 INFO - Running pre-action listener: _resource_record_pre_action 03:40:10 INFO - Running main action method: run_tests 03:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:10 INFO - Python 2.7.3 03:40:10 INFO - Return code: 0 03:40:10 INFO - grabbing minidump binary from tooltool 03:40:10 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')]} 03:40:11 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 0x1f86f60>, '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 0x1f87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f881d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:11 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 03:40:11 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 03:40:11 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 03:40:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:11 INFO - Return code: 0 03:40:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:40:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:40:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 03:40:11 INFO - Using env: {'DISPLAY': ':0', 03:40:11 INFO - 'HOME': '/home/cltbld', 03:40:11 INFO - 'LANG': 'en_US.UTF-8', 03:40:11 INFO - 'LANGUAGE': 'en_US:en', 03:40:11 INFO - 'LOGNAME': 'cltbld', 03:40:11 INFO - 'MAIL': '/var/mail/cltbld', 03:40:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:11 INFO - 'MOZ_NO_REMOTE': '1', 03:40:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:11 INFO - 'NO_EM_RESTART': '1', 03:40:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:11 INFO - 'PWD': '/builds/slave/test', 03:40:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:11 INFO - 'SHELL': '/bin/bash', 03:40:11 INFO - 'SHLVL': '1', 03:40:11 INFO - 'TERM': 'linux', 03:40:11 INFO - 'TMOUT': '86400', 03:40:11 INFO - 'USER': 'cltbld', 03:40:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923', 03:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:11 INFO - '_': '/tools/buildbot/bin/python'} 03:40:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:40:11 INFO - mozversion application_buildid: 20161026004014 03:40:11 INFO - mozversion application_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 03:40:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:11 INFO - mozversion application_name: Firefox 03:40:11 INFO - mozversion application_remotingname: firefox-dev 03:40:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:11 INFO - mozversion application_vendor: Mozilla 03:40:11 INFO - mozversion application_version: 51.0a2 03:40:11 INFO - mozversion platform_buildid: 20161026004014 03:40:11 INFO - mozversion platform_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 03:40:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:11 INFO - mozversion platform_version: 51.0a2 03:40:11 INFO - using testdate: 1477478411 03:40:11 INFO - actual date: 1477478411 03:40:11 INFO - starting webserver on 'localhost:60007' 03:40:11 INFO - SUITE-START | Running 2 tests 03:40:11 INFO - TEST-START | dromaeo_css 03:40:11 INFO - operating with platform_type : linux_ 03:40:11 INFO - Initialising browser for dromaeo_css test... 03:40:11 INFO - TEST-INFO | started process 26965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8C1SB/profile http://localhost:60007/getInfo.html) 03:40:14 INFO - PROCESS | 26965 | __metrics Screen width/height:1600/1200 03:40:14 INFO - PROCESS | 26965 | colorDepth:24 03:40:14 INFO - PROCESS | 26965 | Browser inner width/height: 1024/697 03:40:14 INFO - PROCESS | 26965 | __metrics 03:40:15 INFO - PROCESS | 26965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:40:15 INFO - PROCESS | 26965 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:40:15 INFO - PROCESS | 26965 | console.error: PushService: 03:40:15 INFO - PROCESS | 26965 | stateChangeProcessEnqueue: Error transitioning state 03:40:15 INFO - PROCESS | 26965 | UnknownError 03:40:16 INFO - TEST-INFO | 26965: exit 0 03:40:16 INFO - Browser initialized. 03:40:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:16 INFO - TEST-INFO | started process 27055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8C1SB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:28 INFO - PROCESS | 27055 | RSS: Main: 144846848 03:40:28 INFO - PROCESS | 27055 | 03:41:19 INFO - PROCESS | 27055 | 1477478479194 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] 03:43:27 INFO - PROCESS | 27055 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60007/tests/dromaeo/cssquery-ext.html) 03:43:28 INFO - PROCESS | 27055 | RSS: Main: 218095616 03:43:28 INFO - PROCESS | 27055 | 03:46:31 INFO - PROCESS | 27055 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-ext.html (next: http://localhost:60007/tests/dromaeo/cssquery-jquery.html) 03:46:31 INFO - PROCESS | 27055 | RSS: Main: 228413440 03:46:31 INFO - PROCESS | 27055 | 03:49:33 INFO - PROCESS | 27055 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60007/tests/dromaeo/cssquery-mootools.html) 03:49:34 INFO - PROCESS | 27055 | RSS: Main: 202952704 03:49:34 INFO - PROCESS | 27055 | 03:52:36 INFO - PROCESS | 27055 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60007/tests/dromaeo/cssquery-prototype.html) 03:52:36 INFO - PROCESS | 27055 | RSS: Main: 220782592 03:52:36 INFO - PROCESS | 27055 | 03:55:39 INFO - PROCESS | 27055 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60007/tests/dromaeo/cssquery-yui.html) 03:55:40 INFO - PROCESS | 27055 | RSS: Main: 174403584 03:55:40 INFO - PROCESS | 27055 | 03:58:42 INFO - PROCESS | 27055 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-yui.html (next: http://localhost:60007/tests/dromaeo/cssquery-dojo.html) 03:58:43 INFO - PROCESS | 27055 | RSS: Main: 265752576 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | __start_tp_report 03:58:43 INFO - PROCESS | 27055 | _x_x_mozilla_page_load 03:58:43 INFO - PROCESS | 27055 | _x_x_mozilla_page_load_details 03:58:43 INFO - PROCESS | 27055 | |i|pagename|runs| 03:58:43 INFO - PROCESS | 27055 | |0;dojo.html;3017.1250337402153;3051.7253447189755;3062.632484101908;3083.599132112825;3096.6903309669037;5230.764615592298;5318.0693378658725;5325.227841962923;5335.679859208451;5341.5192632663;5324.92012619811;5342.145256758909;5360.088784906575;5363.302770639812;5377.892442151155;4822.132016237085;4872.2691596260665;4873.244647079709;4897.412310522743;4909.631777616675;4758.619310455155;4903.607711383099;4911.115999120157;4922.01559688062;4925.916298414361;4756.453007904101;4782.97608511957;4789.185838407461;4808.3989501312335;4826.613870890338;4828.179209534387;4854.077725232195;4864.781084851173;4931.901361972777;4963.553280204799;4820.108279968182;4877.6341774367065;4884.535969082932;4906.803727850882;4907.214845624683;5124.359455068116;5133.230015497668;5194.428612852583;5200.323957885451;5279.894402111975;5563.499285064323;5576.581756368248;5588.385277619499;5655.0386434306265;5685.658860468344;5713.085906254979;5721.6853073080965;5731.025725626653;5735.713214339266;5736.598438109334;5159.5614372778355;5210.713410762407;5241.9213711794355;5297.337832770903;5390.460953904578;5786.971065144731;5801.390853960358;5812.157237200582;5816.767329306865;5837.211976383219;5565.026120428909;5571.220029195916;5580.051391263495;5583.134614134816;5584.0507113789945;5502.394736578973;5559.971405290034;5560.555155587544;5624.606277560531;5653.23681303027;5551.555875529948;5595.244641973363;5603.439656034446;5611.410801865827;5664.291963504562;5569.192467092249;5625.578081643893;5655.971720141373;5668.433156684298;5675.971620141873;4386.385905973167;4406.647468202536;4419.315006174048;4432.933505997413;4444.466664000276;3874.593167717349;3893.124047089382;3895.240428116547;3928.2143571285856;3937;5417.83746487606;5423.105187644073;5433.103537916279;5439.5104440600535;5453.345598528202;5733.111367738007;5740.454656807597;5741.224934633855;5742.971285143548;5745.6552606843725;5194.0910340690225;5206.245094461282;5273.973630131824;5424.457554244623;5461.290032295856;4890.853274401774;4940.209566469348;4946.258061290835;4970.701757894465;4971.527704868104;5737.569682273846;5763.769449221984;5779.711014449261;5785.971070144622;5861.70691465425;5466.1527463243265;5501.422350653123;5650.745716442852;5652.2086907833755;5689.943100568941;5813.709314534341;5881.38245484218;5881.441263080001;5914.970425147847;5919.319278283053;5586.888262234814;5594.13290939905;5597.04850175463;5598.720063996702;5613.242212301287;5443.510084092292;5706.229658995982;5709.229254050816;5713.914291285717;5718.914216286842;5414.10667239901;5478.45215478449;5540.252065971043;5551.611387202857;5632.464915832989;5553.500184983371;5588.77644894216;5593.636413633101;5597.272354593877;5599.132134519156;5534.529564987021;5555.333359996826;5559.33288005442;5567.721613919207;5597.328320601554;5417.485338892799;5459.890802184013;5499.587530935276;5536.2249285100925;5548.472895074961;5430.864228394322;5432.728363581726;5435.809746658848;5449.591280654046;5486.875190585841 03:58:43 INFO - PROCESS | 27055 | |1;ext.html;593.8930992421365;603.9818805435837;630.3664816859056;636.4526507203803;661.9834504137399;33911.321773564545;46138.307925381145;47146;47185.52814471863;47344.763276183614;47440;47932.76033619827;47952;47964.28053579199;47966.28050579244;8518.787030324229;8722.651093956265;9341.719748407542;9495.145436910676;9498.382605130644;11036.834447483294;11310.09519238459;11328.830067548994;11638.709032274177;11648.068154547658;11355.091592672608;11443.141764367705;11447.427628618578;11454.656360309204;11454.942725286404;11221.158413119008;11264.380459074748;11282.435878206057;11285.097192224643;11291.54833806655;11106.44467776608;11143.33140011602;11147.944260278728;11172;11173.83239251412;42770.35844462336;42916;43114.35328470075;43209.567904320866;43267.350989735176;3778.3199024175638;3840.1551658635058;3875.2636998970106;4175.436316097318;4499.842505512292;34137.65862341395;34477.310453790786;34587.82706086479;34947.650523494696;36456.63543364559;4550.8862278442975;4705.505921878188;4728.574428301469;4805.135075686375;4821;380733;380953.9999999972;381155;383358;384371;38247.80876095602;39875.40186897199;63897;64505;64526.677366612865;40055.59944400577;40360.39459408111;40397.798011009756;40407.1918561633;40471.79764101161;15684.215789210493;15821.841781582267;15831.920840395724;15840.603984900239;15855.048697078213;11119.888801112047;11366.033887119687;12654.936725316498;13023.47906083765;13025.283609401384;9409.059094090537;9475.099865512902;9478.857817132748;9524.761880953032;9570.377925434963;3693.2244228711734;3698.0754811297174;3736.813159342022;3748.9625103748613;3775.0562359410146;944.5088553951906;1048.7692707604315;1049.9580016799396;1090.6128324444867;1126.622581435212;33876.66123338735;34280.31439371199;34535.654643453745;34634.82682586571;34701.65298347035;1119.5130118398522;1128.9322640641587;1156.531604700098;1198.610451603215;1213.7875871722413;17902.55243618894;18009.909950450427;18089.36687215941;18381.81618183828;18417.81582184188;570110;572445;579119;583099;586198;43014.35478467825;43238.35142472865;43247.35128973005;43335;43453;1311.1084462565548;1353.1272329347712;1363.9590812275649;1414.0455192745062;1415.1084816565703;29906.85046574753;35244.823775880956;35293.82353088218;35403.46894796529;35498.46752298666;52609;53467.197992029374;53486.465135348146;53500.46499534955;53518.46481535135;354156;354831;355938;357989;358026;27155.72844271532;28358.291042724097;28936.009388737726;31311.843440783563;31757.523637145;50443;51287.48712512827;51309.48690513047;51317.7434112827;51361;45668.314975274734;48099;50969.49030509647;52104.47895520996;52486.737566311924;43598.564014360716;46393.30410043919;47034.35379761692;47636.52363476321;47681;46553;47414.28878566755;47507.52492475169;47615;47992.5200748002;45569.31646025379;45677;46226.844328892046;47647;47793.28310075282;29875.55186672245;30518.542221866246;30604.84697576498;30664.233394165323;30870 03:58:43 INFO - PROCESS | 27055 | |2;jquery.html;402.7442573965531;410.15712710380154;419.2893046286544;423.79234175254123;439.9472063352398;19445.611087778238;20405.48986275344;20920.372388828342;21006.579868402623;21167.788322116776;19443.805561944377;19471.610567788637;20415.591688166227;20512.897435512838;20748.066337014832;5759.251297331341;6010.068439391879;6016.939830601704;6019.7893073742425;6024.036154215304;4390.100029493946;4568.748718820463;4601.700889442175;5888;6633.668316584176;6659.733610655592;6667.699953502104;6670.93329066708;6681.66591670417;6683.899741503881;5763.366029736726;6000.579959402866;6019.337872833985;6105.847353816146;6658.800235992928;5702;5931.525477961753;5939;5939.4357536034;5945.940540594625;14603.70792584153;14906.925465372713;15089.320980555902;15109.697806043818;15182.392704291815;2326.651002349661;2518.8110891683195;2643.127767836609;2688.7042425333198;2977.389635124794;11244.718882027933;11279.605213817476;11309.208355415125;15009.549713508612;15327.693446131016;1987.9105440255223;1987.9602407951904;2042.9182832686824;2121.5120522279963;2132.9253476128415;84051.5797421009;90589.54705226432;90920.5453972726;91949.5402522983;93483.53258233733;11610.303381797119;11710.590129345432;11854.762904742029;11940.283582985048;12007.519699211934;16659.833401665826;16663.25015374311;16681.416150434678;16691.833081669272;16702.665946680998;8629.568521573896;8745.606447709868;8753.737387878375;8817.16236957488;8924.821503569892;7913;7920.603969801602;8385.874211886705;8582.914170858336;8680.782980425414;4968.378952630921;4977.65156439053;5049.772760225798;5137.845864624067;5177.637565370464;2056.7856005097246;2077.7298951136254;2080.0847627044054;2113.968290475644;2120.9257675981266;1000.7698229407132;1003.4230317567428;1006.1246715357686;1011.2769369900557;1035.492608621785;19983.800161998486;20265.189392424138;20611.278605248743;20798.64737182332;20823.58352832965;1033.1579762493543;1044.368157264859;1071.5606601293432;1082.285691443659;1085.2511766880984;11166.162537809696;11498.770024599462;11598.71003224926;11621.9540241377;11697.23967942081;469258;472182;473527;473825;478847;91951.54024229836;92766;93391.0660893396;94293;103412;1052.315994603514;1053.5575058475458;1096.2435919215716;1101.2236373356925;1102.0412241350077;17935.910320448314;18059.54851128732;18465.446036618923;18602.720959185895;18712.064396779835;35644.10889727777;43888.561114388445;44070.77964610157;44426.77786611046;45533.31700024568;60741.69629151826;63568.36431635809;64127.679361602895;64517.67741161264;64905.67547162423;9050.502222377832;9138.908610914072;9267.907320926704;9345.205657519187;9584.945655977697;9884.604615815575;10406.843897341698;10775.407352595683;12849.614511564669;14080.22558759278;11717.296962182296;11980.580679676517;11992.100592455427;12253.488034952992;12684.429200686176;12415.503379864704;12683.429245683781;12758.362081895682;12796.942472824665;13067.085304029008;12161.513539458323;12473.688157796129;12828.734453262565;13079.803802942773;13210.27343496117;9172.12864777845;9278.860817087883;9319.207867331354;9424.198943089914;9729.367591106555;11692.88307116952;12699.55551555691;12813.359332033548;12839.422225999666;12933.611991640266 03:58:43 INFO - PROCESS | 27055 | |3;mootools.html;1309.3649579953715;1479.4156308258239;1494.2752764909017;1595.4814685227298;1762.453639371794;7751.922480775191;8539.615717292729;8792.296616270683;8797.296216302697;9096.272298216143;8908.688195913144;8973;8978.102189781019;8979.326550508722;8984;2443.645671377654;2470.6047032474808;2473.5052989402193;2475.10896077412;2480.8015358771345;2360.327306717586;2456.91400800972;2457.680501534798;2459.8524088554655;2463.0640356664444;2410.433548116191;2425.405775584984;2436.4517983453757;2438.51229754049;2444.511097780442;2293.346396277053;2319.605667036608;2325.1280769711357;2325.8720770357622;2326.488172602025;2296.1159953417887;2302.3783578433895;2306.8269879759087;2307.8460769615194;2311.0293676655847;8708.695195668184;8833.69082082124;8896.154865287788;8993.820123597492;8999.775005624846;5412.648177868426;5558.277423934903;5564.8330550083565;5568.136938774496;5572.498475137217;3298.323843612078;3311.503274508819;3346.498025296201;3358.227607650254;3378.864845406181;1245.0763570283843;1245.688577855536;1277.1124068772208;1277.6039427777418;2245.797878190954;11977.101717371144;12431.875681243071;12478.50085996559;12504.3747812609;12509.374531273492;4618.722876627413;4704.95295047052;4745.928811067837;4760.357351757469;4770.522947705202;9855.26085543587;9866;9866.161376282953;9868;9879.950600246953;5329.040772660881;5360.571154307646;5363.329583802025;5365.22204280385;5368.8389348319615;4076.490438695163;4293.2272191005295;4377.474703035656;4414.955850441519;5006.549410553068;3773.716971227169;3891.1633998690418;3893.435451859521;3894.337962546374;3902.102516421239;1186.7507823357018;1192.8807119288;1194.2237545595433;1205.9819102713466;1207.3178654060428;990.1534188268927;1006.8540061691014;1023.6059117239917;1027.4041056187393;1037.527924794217;5787.681677507693;5875.706214689249;6142.201513803177;6214.906776398358;6295.842603934938;996.1632228927735;1046.6755305855208;1101.4878081692052;1112.9554817807198;1126.58909932744;4122.34042553196;4224.55642157569;4228.450301460852;4282.207791558571;4285.485741710952;11036.668899933014;11428.542858285742;11442.370669613085;11462.770744585061;11463.484143213574;10428.739281517872;11288.322700637988;11324.320540767416;11330.716732081599;11339.886601134049;7948.84102317962;8384.077751447336;8401.327893768606;8403.285720713808;8420.53687047206;6334.524910631629;6336.904946425715;6354.777582784581;6397.712102955285;6442.774502892376;9810.16613587853;9973.152282056106;9986.151177149733;10108.39349639024;10164;9223.21602663781;10195.23535734808;10351.120154786626;10456.32033917793;10462.843057353994;7562.659680314289;8019.318357939641;8143.714969976022;8296.423679500875;8301.543415111984;8288.958555207186;8626.611802468778;8719.65121395137;8845.24815390699;8916.375853690179;7901;7985.64064617082;8051.194880511902;8095.797605059921;8123;7909.564973926489;7923.3661307096445;7950;8045.07481639619;8114.107448180814;7157.463190260647;7247.9637601811655;7267.854642907007;7284.089488813898;7287.781366559012;5149.401446898086;5295.152775555893;5319.6808191508635;5379.811706590251;5423.484768946943;5172.120739474373;5376.408595054619;5417.214503896992;5419.945800541944;5443.918341224964 03:58:43 INFO - PROCESS | 27055 | |4;prototype.html;334.9681780230877;348.907539502032;349.0418800392922;353.9185987222939;353.9663731945466;5374.059539580572;5431.321084864392;5477.315335583052;5496.835094947153;5523.392426833045;5322.281491998579;5360.65155764875;5376.623636345457;5391.81128660497;5421.728913554316;4076.5311989121333;4308.547602501739;4318.5033721122;4327.13457308538;4377.08081302926;4022.698297627675;4130.295933574624;4271.1671224111315;4271.466066741657;4276.657867370618;4249.851255206068;4265.44549208604;4266.168097221043;4267.335739061753;4279.74321540707;4256.255155347817;4263.467066616673;4267.957320426787;4300.9139817203795;4309.245881970643;3633.327834350627;3741.420079887622;3756.34264003801;3770.2459508098214;3773.47171396002;5290.55030322423;5309.867253318659;5319.228711836762;5323.866903327409;5330.987991784629;4895.363602731658;4908.656394052417;4917.311576379309;4928.8767780805765;4936.851894443136;5536.916946245809;5646.971765141189;5669.780997085605;5681.23303354046;5693.629914055573;4132.442120313749;4136.896577585554;4149.439825623563;4153.854615088458;4164.8542301019625;5627.8593035174445;5969.283685957669;5976.252968378953;6000.489958353545;6005.6487290359755;4205.600467955539;4208.600182982612;4209.116085622054;4210.989362552965;4216.620504154641;4264.1471705659;4287.785610719514;4294.162638285567;4297.119090586422;4307.612314891675;4827.310441345571;4859.927101093415;4888.560029597354;4926.359573255454;4933.186024306021;5678.858028549237;5685.658860468302;5707.4577915098;5716.657000579979;5764.279465066867;1446.848080951485;1461.2474575593578;1463.1367493179075;1472.7643577027625;1475.4762059468735;894.5706061090583;947.696737044153;949.392388871123;950.5199874063692;961.7643677299106;4847.878803029882;4907.2393778964315;5313.203019547099;5460.180972854104;5468.398476167618;5697.487226149667;5716.685582293014;5725.1698503716725;5830.125481177857;5878.676672783038;5508.07217473881;5517.041450285171;5523.917141242885;5553.916691249635;5556.333240011225;2982.463156631784;3078.3843231353817;3117.703818137273;3122.4223518649123;3122.8282444465317;5998.550108741862;6005.879882402328;6013.609115407485;6027.487663548647;6049.576529642971;5645.80239691617;5988.700564971734;5997.970010149921;6009.759609615654;6040.426159514839;6085.300190478151;6089.939100609025;6092.329843717188;6100.511959043266;6100.725467354068;5584.190292407659;5886.705664716833;5906.114082887601;5912.733926973383;5917.230760001173;5756.884862302647;5798.507126894261;5817.476427121579;5822.446867547576;5834.891370639565;6074.939250607614;6077.453029227391;6083.756649733961;6092.969535152296;6093.9390606093375;4235.729281215561;4289.442372491556;4340.327249276367;4341.438551254775;4345.369921361448;5841.737121829613;5854.795082172103;5857.765689372377;5866.208061911588;5870.354261031198;5655.208270842168;5759.840059977509;5796.826095216981;5801.1878337032;5801.535877129904;5669.165417291354;5675.148727690879;5688.829335119953;5695.430456954437;5726.484616384545;5668.773249069991;5685.403032681509;5695.715214239189;5722.971385143048;5736.569757268138;5344.438833922538;5440.646357986719;5709.429057094258;5781.219535362672;5788.334341550607;5625.634333768292;5632.408597097246;5638.956792993309;5639.943600563942;5648.881669373985 03:58:43 INFO - PROCESS | 27055 | |5;yui.html;767.7773445700747;773.9729109481168;782.3232903538441;789.0255534414993;831.1231650608607;15783.36866525339;16121.838781612181;16657.583560410996;16692.833071669294;16693.666126677475;14459.710805783878;14517.056391334583;14815.629609259748;14823.555293341216;14848.183349915751;738.5827007740636;757.6742000939594;851.1190917400492;856.802935324874;890.4256754393413;864.1272314961902;883.3816328569994;883.9779005524849;884.3146561414891;884.4737381258141;936.1621348892737;939.4316438554679;939.5161491831713;939.8402271613808;940.1068984464752;765.2729906588763;781.7303030454484;887.8890138732659;933.3093510802025;935.4106912645058;667.4426853577269;671.516508114157;672.0792514255453;672.1027428383114;672.3377473188905;14648.194349310783;14650.34073466686;14674.926625366912;14679.926600366929;14692.48576299835;15014.549563513112;15294.847051529565;15310.693786124326;15345.386184552604;15452;13122.34388280582;13273.535426260034;13524.25616591087;13540.187588744708;13988.790168147487;4576.679632425731;4771.188897887368;4790.161721698723;4810.374651295309;4871.488493708181;79794.20205797926;80158;80793;87399.56300218459;87612;11322.37726925027;11329.441667457279;11566.65300041;11952.342621155745;12114.636560903187;21528.461788455414;21885.562288754136;21918.89040554787;21922;21922.45193870166;8690.087540808125;8734.737957861274;8804.427712198687;8887.200151986352;8892.822143557092;4919.803207871717;4967;5128.9230661540105;5157.097507936096;5209.426963034063;3708.165662725865;3853.344931361675;3865.8260378283044;3866.9226615467533;3868.883933482;616.442119881508;631.5421319543294;634.80321100459;640.1869625575494;651.5276424592133;605.8303674971015;615.4368752591419;640.2636967487426;666.8799616069057;696.8919817428307;8856.734297971072;9143.901817691307;9218.86171707425;9267.119623635745;9791.951040244754;608.193664815506;611.4405319133033;623.7879121098848;634.8730253949228;693.5712432389194;4740.099381117577;4839.225723884161;4927.992687494744;4944.332515110414;4947.777350019258;72688;72789.6360518194;89812.5509372462;126383;128608;65320.34679653143;104412;108178;110148.4492577532;110302;58835.41164588385;59715.402845971854;76407;97068.51465742626;99773.50113249532;8925.866112008196;9244.583993720164;9314.20829229523;9317.11487408695;9334.766630834012;54735.726321368136;56560;57306.42693573011;57529.71235143798;57641.42358576361;83177.58411207906;84328.57835710782;84748;87040.56479717561;87765.56117219628;11788.329553741905;12522.812157817822;12657.746845062862;12898.161619494704;13104.73790524165;14409.711805764036;14418.711625767635;14554.85445145535;14628.195449250394;15176.620584485476;11168.38573878412;12611.81082283748;13405.262710551013;13966.162030278216;14770.926145369205;13843.515476958259;14424.927875360976;14445.205513696426;14974.101553906801;15038;12702.428390722625;12844.357782111045;12859.16415432994;13017.479300827861;13435.19388836673;10343.689689309333;10519.26365154432;10731.463426828783;10836.429100710671;10847.945760271148;10922.945385273022;10927.890721092688;10947.671569852917;11056.391898445663;11113.22207445471 03:58:43 INFO - PROCESS | 27055 | __end_tp_report 03:58:43 INFO - PROCESS | 27055 | __start_cc_report 03:58:43 INFO - PROCESS | 27055 | _x_x_mozilla_cycle_collect,967 03:58:43 INFO - PROCESS | 27055 | __end_cc_report 03:58:43 INFO - PROCESS | 27055 | __startTimestamp1477479523057__endTimestamp 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | ------- Summary: start ------- 03:58:43 INFO - PROCESS | 27055 | Number of tests: 6 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | [#0] dojo.html Cycles:165 Average:5270.54 Median:5461.29 stddev:582.59 (10.7%) stddev-sans-first:556.91 03:58:43 INFO - PROCESS | 27055 | Values: 3017.1 3051.7 3062.6 3083.6 3096.7 5230.8 5318.1 5325.2 5335.7 5341.5 5324.9 5342.1 5360.1 5363.3 5377.9 4822.1 4872.3 4873.2 4897.4 4909.6 4758.6 4903.6 4911.1 4922.0 4925.9 4756.5 4783.0 4789.2 4808.4 4826.6 4828.2 4854.1 4864.8 4931.9 4963.6 4820.1 4877.6 4884.5 4906.8 4907.2 5124.4 5133.2 5194.4 5200.3 5279.9 5563.5 5576.6 5588.4 5655.0 5685.7 5713.1 5721.7 5731.0 5735.7 5736.6 5159.6 5210.7 5241.9 5297.3 5390.5 5787.0 5801.4 5812.2 5816.8 5837.2 5565.0 5571.2 5580.1 5583.1 5584.1 5502.4 5560.0 5560.6 5624.6 5653.2 5551.6 5595.2 5603.4 5611.4 5664.3 5569.2 5625.6 5656.0 5668.4 5676.0 4386.4 4406.6 4419.3 4432.9 4444.5 3874.6 3893.1 3895.2 3928.2 3937.0 5417.8 5423.1 5433.1 5439.5 5453.3 5733.1 5740.5 5741.2 5743.0 5745.7 5194.1 5206.2 5274.0 5424.5 5461.3 4890.9 4940.2 4946.3 4970.7 4971.5 5737.6 5763.8 5779.7 5786.0 5861.7 5466.2 5501.4 5650.7 5652.2 5689.9 5813.7 5881.4 5881.4 5915.0 5919.3 5586.9 5594.1 5597.0 5598.7 5613.2 5443.5 5706.2 5709.2 5713.9 5718.9 5414.1 5478.5 5540.3 5551.6 5632.5 5553.5 5588.8 5593.6 5597.3 5599.1 5534.5 5555.3 5559.3 5567.7 5597.3 5417.5 5459.9 5499.6 5536.2 5548.5 5430.9 5432.7 5435.8 5449.6 5486.9 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | [#1] ext.html Cycles:180 Average:60408.54 Median:193599.08 stddev:119353.71 (61.6%) stddev-sans-first:119604.04 03:58:43 INFO - PROCESS | 27055 | Values: 593.9 604.0 630.4 636.5 662.0 33911.3 46138.3 47146.0 47185.5 47344.8 47440.0 47932.8 47952.0 47964.3 47966.3 8518.8 8722.7 9341.7 9495.1 9498.4 11036.8 11310.1 11328.8 11638.7 11648.1 11355.1 11443.1 11447.4 11454.7 11454.9 11221.2 11264.4 11282.4 11285.1 11291.5 11106.4 11143.3 11147.9 11172.0 11173.8 42770.4 42916.0 43114.4 43209.6 43267.4 3778.3 3840.2 3875.3 4175.4 4499.8 34137.7 34477.3 34587.8 34947.7 36456.6 4550.9 4705.5 4728.6 4805.1 4821.0 380733.0 380954.0 381155.0 383358.0 384371.0 38247.8 39875.4 63897.0 64505.0 64526.7 40055.6 40360.4 40397.8 40407.2 40471.8 15684.2 15821.8 15831.9 15840.6 15855.0 11119.9 11366.0 12654.9 13023.5 13025.3 9409.1 9475.1 9478.9 9524.8 9570.4 3693.2 3698.1 3736.8 3749.0 3775.1 944.5 1048.8 1050.0 1090.6 1126.6 33876.7 34280.3 34535.7 34634.8 34701.7 1119.5 1128.9 1156.5 1198.6 1213.8 17902.6 18009.9 18089.4 18381.8 18417.8 570110.0 572445.0 579119.0 583099.0 586198.0 43014.4 43238.4 43247.4 43335.0 43453.0 1311.1 1353.1 1364.0 1414.0 1415.1 29906.9 35244.8 35293.8 35403.5 35498.5 52609.0 53467.2 53486.5 53500.5 53518.5 354156.0 354831.0 355938.0 357989.0 358026.0 27155.7 28358.3 28936.0 31311.8 31757.5 50443.0 51287.5 51309.5 51317.7 51361.0 45668.3 48099.0 50969.5 52104.5 52486.7 43598.6 46393.3 47034.4 47636.5 47681.0 46553.0 47414.3 47507.5 47615.0 47992.5 45569.3 45677.0 46226.8 47647.0 47793.3 29875.6 30518.5 30604.8 30664.2 30870.0 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | [#2] jquery.html Cycles:180 Average:29316.26 Median:11640.88 stddev:78434.84 (673.8%) stddev-sans-first:78624.82 03:58:43 INFO - PROCESS | 27055 | Values: 402.7 410.2 419.3 423.8 439.9 19445.6 20405.5 20920.4 21006.6 21167.8 19443.8 19471.6 20415.6 20512.9 20748.1 5759.3 6010.1 6016.9 6019.8 6024.0 4390.1 4568.7 4601.7 5888.0 6633.7 6659.7 6667.7 6670.9 6681.7 6683.9 5763.4 6000.6 6019.3 6105.8 6658.8 5702.0 5931.5 5939.0 5939.4 5945.9 14603.7 14906.9 15089.3 15109.7 15182.4 2326.7 2518.8 2643.1 2688.7 2977.4 11244.7 11279.6 11309.2 15009.5 15327.7 1987.9 1988.0 2042.9 2121.5 2132.9 84051.6 90589.5 90920.5 91949.5 93483.5 11610.3 11710.6 11854.8 11940.3 12007.5 16659.8 16663.3 16681.4 16691.8 16702.7 8629.6 8745.6 8753.7 8817.2 8924.8 7913.0 7920.6 8385.9 8582.9 8680.8 4968.4 4977.7 5049.8 5137.8 5177.6 2056.8 2077.7 2080.1 2114.0 2120.9 1000.8 1003.4 1006.1 1011.3 1035.5 19983.8 20265.2 20611.3 20798.6 20823.6 1033.2 1044.4 1071.6 1082.3 1085.3 11166.2 11498.8 11598.7 11622.0 11697.2 469258.0 472182.0 473527.0 473825.0 478847.0 91951.5 92766.0 93391.1 94293.0 103412.0 1052.3 1053.6 1096.2 1101.2 1102.0 17935.9 18059.5 18465.4 18602.7 18712.1 35644.1 43888.6 44070.8 44426.8 45533.3 60741.7 63568.4 64127.7 64517.7 64905.7 9050.5 9138.9 9267.9 9345.2 9584.9 9884.6 10406.8 10775.4 12849.6 14080.2 11717.3 11980.6 11992.1 12253.5 12684.4 12415.5 12683.4 12758.4 12796.9 13067.1 12161.5 12473.7 12828.7 13079.8 13210.3 9172.1 9278.9 9319.2 9424.2 9729.4 11692.9 12699.6 12813.4 12839.4 12933.6 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | [#3] mootools.html Cycles:180 Average:5903.18 Median:4753.14 stddev:3315.60 (69.8%) stddev-sans-first:3306.92 03:58:43 INFO - PROCESS | 27055 | Values: 1309.4 1479.4 1494.3 1595.5 1762.5 7751.9 8539.6 8792.3 8797.3 9096.3 8908.7 8973.0 8978.1 8979.3 8984.0 2443.6 2470.6 2473.5 2475.1 2480.8 2360.3 2456.9 2457.7 2459.9 2463.1 2410.4 2425.4 2436.5 2438.5 2444.5 2293.3 2319.6 2325.1 2325.9 2326.5 2296.1 2302.4 2306.8 2307.8 2311.0 8708.7 8833.7 8896.2 8993.8 8999.8 5412.6 5558.3 5564.8 5568.1 5572.5 3298.3 3311.5 3346.5 3358.2 3378.9 1245.1 1245.7 1277.1 1277.6 2245.8 11977.1 12431.9 12478.5 12504.4 12509.4 4618.7 4705.0 4745.9 4760.4 4770.5 9855.3 9866.0 9866.2 9868.0 9880.0 5329.0 5360.6 5363.3 5365.2 5368.8 4076.5 4293.2 4377.5 4415.0 5006.5 3773.7 3891.2 3893.4 3894.3 3902.1 1186.8 1192.9 1194.2 1206.0 1207.3 990.2 1006.9 1023.6 1027.4 1037.5 5787.7 5875.7 6142.2 6214.9 6295.8 996.2 1046.7 1101.5 1113.0 1126.6 4122.3 4224.6 4228.5 4282.2 4285.5 11036.7 11428.5 11442.4 11462.8 11463.5 10428.7 11288.3 11324.3 11330.7 11339.9 7948.8 8384.1 8401.3 8403.3 8420.5 6334.5 6336.9 6354.8 6397.7 6442.8 9810.2 9973.2 9986.2 10108.4 10164.0 9223.2 10195.2 10351.1 10456.3 10462.8 7562.7 8019.3 8143.7 8296.4 8301.5 8289.0 8626.6 8719.7 8845.2 8916.4 7901.0 7985.6 8051.2 8095.8 8123.0 7909.6 7923.4 7950.0 8045.1 8114.1 7157.5 7248.0 7267.9 7284.1 7287.8 5149.4 5295.2 5319.7 5379.8 5423.5 5172.1 5376.4 5417.2 5419.9 5443.9 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | [#4] prototype.html Cycles:180 Average:4814.59 Median:5502.45 stddev:1411.10 (25.6%) stddev-sans-first:1374.41 03:58:43 INFO - PROCESS | 27055 | Values: 335.0 348.9 349.0 353.9 354.0 5374.1 5431.3 5477.3 5496.8 5523.4 5322.3 5360.7 5376.6 5391.8 5421.7 4076.5 4308.5 4318.5 4327.1 4377.1 4022.7 4130.3 4271.2 4271.5 4276.7 4249.9 4265.4 4266.2 4267.3 4279.7 4256.3 4263.5 4268.0 4300.9 4309.2 3633.3 3741.4 3756.3 3770.2 3773.5 5290.6 5309.9 5319.2 5323.9 5331.0 4895.4 4908.7 4917.3 4928.9 4936.9 5536.9 5647.0 5669.8 5681.2 5693.6 4132.4 4136.9 4149.4 4153.9 4164.9 5627.9 5969.3 5976.3 6000.5 6005.6 4205.6 4208.6 4209.1 4211.0 4216.6 4264.1 4287.8 4294.2 4297.1 4307.6 4827.3 4859.9 4888.6 4926.4 4933.2 5678.9 5685.7 5707.5 5716.7 5764.3 1446.8 1461.2 1463.1 1472.8 1475.5 894.6 947.7 949.4 950.5 961.8 4847.9 4907.2 5313.2 5460.2 5468.4 5697.5 5716.7 5725.2 5830.1 5878.7 5508.1 5517.0 5523.9 5553.9 5556.3 2982.5 3078.4 3117.7 3122.4 3122.8 5998.6 6005.9 6013.6 6027.5 6049.6 5645.8 5988.7 5998.0 6009.8 6040.4 6085.3 6089.9 6092.3 6100.5 6100.7 5584.2 5886.7 5906.1 5912.7 5917.2 5756.9 5798.5 5817.5 5822.4 5834.9 6074.9 6077.5 6083.8 6093.0 6093.9 4235.7 4289.4 4340.3 4341.4 4345.4 5841.7 5854.8 5857.8 5866.2 5870.4 5655.2 5759.8 5796.8 5801.2 5801.5 5669.2 5675.1 5688.8 5695.4 5726.5 5668.8 5685.4 5695.7 5723.0 5736.6 5344.4 5440.6 5709.4 5781.2 5788.3 5625.6 5632.4 5639.0 5639.9 5648.9 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - PROCESS | 27055 | [#5] yui.html Cycles:180 Average:20881.05 Median:4946.05 stddev:29849.52 (603.5%) stddev-sans-first:29895.05 03:58:43 INFO - PROCESS | 27055 | Values: 767.8 774.0 782.3 789.0 831.1 15783.4 16121.8 16657.6 16692.8 16693.7 14459.7 14517.1 14815.6 14823.6 14848.2 738.6 757.7 851.1 856.8 890.4 864.1 883.4 884.0 884.3 884.5 936.2 939.4 939.5 939.8 940.1 765.3 781.7 887.9 933.3 935.4 667.4 671.5 672.1 672.1 672.3 14648.2 14650.3 14674.9 14679.9 14692.5 15014.5 15294.8 15310.7 15345.4 15452.0 13122.3 13273.5 13524.3 13540.2 13988.8 4576.7 4771.2 4790.2 4810.4 4871.5 79794.2 80158.0 80793.0 87399.6 87612.0 11322.4 11329.4 11566.7 11952.3 12114.6 21528.5 21885.6 21918.9 21922.0 21922.5 8690.1 8734.7 8804.4 8887.2 8892.8 4919.8 4967.0 5128.9 5157.1 5209.4 3708.2 3853.3 3865.8 3866.9 3868.9 616.4 631.5 634.8 640.2 651.5 605.8 615.4 640.3 666.9 696.9 8856.7 9143.9 9218.9 9267.1 9792.0 608.2 611.4 623.8 634.9 693.6 4740.1 4839.2 4928.0 4944.3 4947.8 72688.0 72789.6 89812.6 126383.0 128608.0 65320.3 104412.0 108178.0 110148.4 110302.0 58835.4 59715.4 76407.0 97068.5 99773.5 8925.9 9244.6 9314.2 9317.1 9334.8 54735.7 56560.0 57306.4 57529.7 57641.4 83177.6 84328.6 84748.0 87040.6 87765.6 11788.3 12522.8 12657.7 12898.2 13104.7 14409.7 14418.7 14554.9 14628.2 15176.6 11168.4 12611.8 13405.3 13966.2 14770.9 13843.5 14424.9 14445.2 14974.1 15038.0 12702.4 12844.4 12859.2 13017.5 13435.2 10343.7 10519.3 10731.5 10836.4 10847.9 10922.9 10927.9 10947.7 11056.4 11113.2 03:58:43 INFO - PROCESS | 27055 | -------- Summary: end -------- 03:58:43 INFO - PROCESS | 27055 | 03:58:43 INFO - TEST-INFO | 27055: exit 0 03:58:43 INFO - TEST-OK | dromaeo_css | took 1112497ms 03:58:43 INFO - TEST-START | kraken 03:58:43 INFO - operating with platform_type : linux_ 03:58:43 INFO - Initialising browser for kraken test... 03:58:43 INFO - TEST-INFO | started process 27371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG0cOIo/profile http://localhost:60007/getInfo.html) 03:58:47 INFO - PROCESS | 27371 | __metrics Screen width/height:1600/1200 03:58:47 INFO - PROCESS | 27371 | colorDepth:24 03:58:47 INFO - PROCESS | 27371 | Browser inner width/height: 1024/697 03:58:47 INFO - PROCESS | 27371 | __metrics 03:58:47 INFO - PROCESS | 27371 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:58:47 INFO - PROCESS | 27371 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:58:48 INFO - PROCESS | 27371 | console.error: PushService: 03:58:48 INFO - PROCESS | 27371 | stateChangeProcessEnqueue: Error transitioning state 03:58:48 INFO - PROCESS | 27371 | UnknownError 03:58:48 INFO - TEST-INFO | 27371: exit 0 03:58:48 INFO - Browser initialized. 03:58:48 INFO - Running cycle 1/1 for kraken test... 03:58:48 INFO - TEST-INFO | started process 27462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG0cOIo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:00 INFO - PROCESS | 27462 | RSS: Main: 145002496 03:59:00 INFO - PROCESS | 27462 | 03:59:03 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:03 INFO - PROCESS | 27462 | RSS: Main: 185909248 03:59:03 INFO - PROCESS | 27462 | 03:59:06 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-dft) 03:59:07 INFO - PROCESS | 27462 | RSS: Main: 175554560 03:59:07 INFO - PROCESS | 27462 | 03:59:09 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-fft) 03:59:10 INFO - PROCESS | 27462 | RSS: Main: 267124736 03:59:10 INFO - PROCESS | 27462 | 03:59:12 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-oscillator) 03:59:13 INFO - PROCESS | 27462 | RSS: Main: 173473792 03:59:13 INFO - PROCESS | 27462 | 03:59:15 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:15 INFO - PROCESS | 27462 | RSS: Main: 175013888 03:59:15 INFO - PROCESS | 27462 | 03:59:18 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60007/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:19 INFO - PROCESS | 27462 | RSS: Main: 211746816 03:59:19 INFO - PROCESS | 27462 | 03:59:22 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60007/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:23 INFO - PROCESS | 27462 | RSS: Main: 210063360 03:59:23 INFO - PROCESS | 27462 | 03:59:26 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60007/tests/kraken/driver.html?testName=json-parse-financial) 03:59:26 INFO - PROCESS | 27462 | RSS: Main: 209461248 03:59:26 INFO - PROCESS | 27462 | 03:59:28 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:28 INFO - PROCESS | 27462 | RSS: Main: 171585536 03:59:28 INFO - PROCESS | 27462 | 03:59:30 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:31 INFO - PROCESS | 27462 | RSS: Main: 178753536 03:59:31 INFO - PROCESS | 27462 | 03:59:33 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:33 INFO - PROCESS | 27462 | RSS: Main: 188149760 03:59:33 INFO - PROCESS | 27462 | 03:59:36 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:36 INFO - PROCESS | 27462 | RSS: Main: 196579328 03:59:36 INFO - PROCESS | 27462 | 03:59:39 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:40 INFO - PROCESS | 27462 | RSS: Main: 193794048 03:59:40 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60007/tests/kraken/driver.html?testName=ai-astar) 03:59:41 INFO - PROCESS | 27462 | RSS: Main: 245391360 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | __start_tp_report 03:59:41 INFO - PROCESS | 27462 | _x_x_mozilla_page_load 03:59:41 INFO - PROCESS | 27462 | _x_x_mozilla_page_load_details 03:59:41 INFO - PROCESS | 27462 | |i|pagename|runs| 03:59:41 INFO - PROCESS | 27462 | |0;ai-astar;111;116;114;113;114;114;115;113;113;113 03:59:41 INFO - PROCESS | 27462 | |1;audio-beat-detection;141;116;117;159;118;119;118;119;143;117 03:59:41 INFO - PROCESS | 27462 | |2;audio-dft;159;159;161;160;159;159;160;160;160;161 03:59:41 INFO - PROCESS | 27462 | |3;audio-fft;74;77;76;111;76;77;77;76;97;76 03:59:41 INFO - PROCESS | 27462 | |4;audio-oscillator;81;81;114;81;81;81;100;82;81;105 03:59:41 INFO - PROCESS | 27462 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;117;117 03:59:41 INFO - PROCESS | 27462 | |6;imaging-darkroom;145;146;146;145;146;146;146;145;146;145 03:59:41 INFO - PROCESS | 27462 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;95;95 03:59:41 INFO - PROCESS | 27462 | |8;json-parse-financial;52;52;51;50;50;50;50;50;50;50 03:59:41 INFO - PROCESS | 27462 | |9;json-stringify-tinderbox;60;60;59;61;61;60;60;60;60;60 03:59:41 INFO - PROCESS | 27462 | |10;stanford-crypto-aes;74;73;78;74;75;79;73;73;75;74 03:59:41 INFO - PROCESS | 27462 | |11;stanford-crypto-ccm;121;119;125;135;133;129;119;117;169;121 03:59:41 INFO - PROCESS | 27462 | |12;stanford-crypto-pbkdf2;154;151;155;150;149;152;151;151;150;149 03:59:41 INFO - PROCESS | 27462 | |13;stanford-crypto-sha256-iterative;62;62;62;61;61;61;61;64;64;61 03:59:41 INFO - PROCESS | 27462 | __end_tp_report 03:59:41 INFO - PROCESS | 27462 | __start_cc_report 03:59:41 INFO - PROCESS | 27462 | _x_x_mozilla_cycle_collect,1587 03:59:41 INFO - PROCESS | 27462 | __end_cc_report 03:59:41 INFO - PROCESS | 27462 | __startTimestamp1477479581931__endTimestamp 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | ------- Summary: start ------- 03:59:41 INFO - PROCESS | 27462 | Number of tests: 14 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.05 03:59:41 INFO - PROCESS | 27462 | Values: 111.0 116.0 114.0 113.0 114.0 114.0 115.0 113.0 113.0 113.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:119.00 stddev:15.22 (12.8%) stddev-sans-first:15.24 03:59:41 INFO - PROCESS | 27462 | Values: 141.0 116.0 117.0 159.0 118.0 119.0 118.0 119.0 143.0 117.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 03:59:41 INFO - PROCESS | 27462 | Values: 159.0 159.0 161.0 160.0 159.0 159.0 160.0 160.0 160.0 161.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.50 stddev:12.24 (16.0%) stddev-sans-first:12.66 03:59:41 INFO - PROCESS | 27462 | Values: 74.0 77.0 76.0 111.0 76.0 77.0 77.0 76.0 97.0 76.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:81.00 stddev:12.62 (15.6%) stddev-sans-first:13.08 03:59:41 INFO - PROCESS | 27462 | Values: 81.0 81.0 114.0 81.0 81.0 81.0 100.0 82.0 81.0 105.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:59:41 INFO - PROCESS | 27462 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:59:41 INFO - PROCESS | 27462 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:59:41 INFO - PROCESS | 27462 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.00 stddev:0.85 (1.7%) stddev-sans-first:0.71 03:59:41 INFO - PROCESS | 27462 | Values: 52.0 52.0 51.0 50.0 50.0 50.0 50.0 50.0 50.0 50.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 03:59:41 INFO - PROCESS | 27462 | Values: 60.0 60.0 59.0 61.0 61.0 60.0 60.0 60.0 60.0 60.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.50 stddev:2.10 (2.8%) stddev-sans-first:2.20 03:59:41 INFO - PROCESS | 27462 | Values: 74.0 73.0 78.0 74.0 75.0 79.0 73.0 73.0 75.0 74.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.00 stddev:15.42 (12.1%) stddev-sans-first:16.09 03:59:41 INFO - PROCESS | 27462 | Values: 121.0 119.0 125.0 135.0 133.0 129.0 119.0 117.0 169.0 121.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:151.00 stddev:1.99 (1.3%) stddev-sans-first:1.83 03:59:41 INFO - PROCESS | 27462 | Values: 154.0 151.0 155.0 150.0 149.0 152.0 151.0 151.0 150.0 149.0 03:59:41 INFO - PROCESS | 27462 | 03:59:41 INFO - PROCESS | 27462 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 03:59:41 INFO - PROCESS | 27462 | Values: 62.0 62.0 62.0 61.0 61.0 61.0 61.0 64.0 64.0 61.0 03:59:41 INFO - PROCESS | 27462 | -------- Summary: end -------- 03:59:41 INFO - PROCESS | 27462 | 03:59:42 INFO - TEST-INFO | 27462: exit 0 03:59:42 INFO - TEST-OK | kraken | took 59143ms 03:59:42 INFO - SUITE-END | took 1171s 03:59:43 INFO - Completed test suite (00:19:31) 03:59:43 INFO - javascript benchmark 03:59:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.1250337402153, 3051.7253447189755, 3062.632484101908, 3083.599132112825, 3096.6903309669037, 5230.764615592298, 5318.0693378658725, 5325.227841962923, 5335.679859208451, 5341.5192632663, 5324.92012619811, 5342.145256758909, 5360.088784906575, 5363.302770639812, 5377.892442151155, 4822.132016237085, 4872.2691596260665, 4873.244647079709, 4897.412310522743, 4909.631777616675, 4758.619310455155, 4903.607711383099, 4911.115999120157, 4922.01559688062, 4925.916298414361, 4756.453007904101, 4782.97608511957, 4789.185838407461, 4808.3989501312335, 4826.613870890338, 4828.179209534387, 4854.077725232195, 4864.781084851173, 4931.901361972777, 4963.553280204799, 4820.108279968182, 4877.6341774367065, 4884.535969082932, 4906.803727850882, 4907.214845624683, 5124.359455068116, 5133.230015497668, 5194.428612852583, 5200.323957885451, 5279.894402111975, 5563.499285064323, 5576.581756368248, 5588.385277619499, 5655.0386434306265, 5685.658860468344, 5713.085906254979, 5721.6853073080965, 5731.025725626653, 5735.713214339266, 5736.598438109334, 5159.5614372778355, 5210.713410762407, 5241.9213711794355, 5297.337832770903, 5390.460953904578, 5786.971065144731, 5801.390853960358, 5812.157237200582, 5816.767329306865, 5837.211976383219, 5565.026120428909, 5571.220029195916, 5580.051391263495, 5583.134614134816, 5584.0507113789945, 5502.394736578973, 5559.971405290034, 5560.555155587544, 5624.606277560531, 5653.23681303027, 5551.555875529948, 5595.244641973363, 5603.439656034446, 5611.410801865827, 5664.291963504562, 5569.192467092249, 5625.578081643893, 5655.971720141373, 5668.433156684298, 5675.971620141873, 4386.385905973167, 4406.647468202536, 4419.315006174048, 4432.933505997413, 4444.466664000276, 3874.593167717349, 3893.124047089382, 3895.240428116547, 3928.2143571285856, 3937.0, 5417.83746487606, 5423.105187644073, 5433.103537916279, 5439.5104440600535, 5453.345598528202, 5733.111367738007, 5740.454656807597, 5741.224934633855, 5742.971285143548, 5745.6552606843725, 5194.0910340690225, 5206.245094461282, 5273.973630131824, 5424.457554244623, 5461.290032295856, 4890.853274401774, 4940.209566469348, 4946.258061290835, 4970.701757894465, 4971.527704868104, 5737.569682273846, 5763.769449221984, 5779.711014449261, 5785.971070144622, 5861.70691465425, 5466.1527463243265, 5501.422350653123, 5650.745716442852, 5652.2086907833755, 5689.943100568941, 5813.709314534341, 5881.38245484218, 5881.441263080001, 5914.970425147847, 5919.319278283053, 5586.888262234814, 5594.13290939905, 5597.04850175463, 5598.720063996702, 5613.242212301287, 5443.510084092292, 5706.229658995982, 5709.229254050816, 5713.914291285717, 5718.914216286842, 5414.10667239901, 5478.45215478449, 5540.252065971043, 5551.611387202857, 5632.464915832989, 5553.500184983371, 5588.77644894216, 5593.636413633101, 5597.272354593877, 5599.132134519156, 5534.529564987021, 5555.333359996826, 5559.33288005442, 5567.721613919207, 5597.328320601554, 5417.485338892799, 5459.890802184013, 5499.587530935276, 5536.2249285100925, 5548.472895074961, 5430.864228394322, 5432.728363581726, 5435.809746658848, 5449.591280654046, 5486.875190585841], "value": 5231.95602913755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8930992421365, 603.9818805435837, 630.3664816859056, 636.4526507203803, 661.9834504137399, 33911.321773564545, 46138.307925381145, 47146.0, 47185.52814471863, 47344.763276183614, 47440.0, 47932.76033619827, 47952.0, 47964.28053579199, 47966.28050579244, 8518.787030324229, 8722.651093956265, 9341.719748407542, 9495.145436910676, 9498.382605130644, 11036.834447483294, 11310.09519238459, 11328.830067548994, 11638.709032274177, 11648.068154547658, 11355.091592672608, 11443.141764367705, 11447.427628618578, 11454.656360309204, 11454.942725286404, 11221.158413119008, 11264.380459074748, 11282.435878206057, 11285.097192224643, 11291.54833806655, 11106.44467776608, 11143.33140011602, 11147.944260278728, 11172.0, 11173.83239251412, 42770.35844462336, 42916.0, 43114.35328470075, 43209.567904320866, 43267.350989735176, 3778.3199024175638, 3840.1551658635058, 3875.2636998970106, 4175.436316097318, 4499.842505512292, 34137.65862341395, 34477.310453790786, 34587.82706086479, 34947.650523494696, 36456.63543364559, 4550.8862278442975, 4705.505921878188, 4728.574428301469, 4805.135075686375, 4821.0, 380733.0, 380953.9999999972, 381155.0, 383358.0, 384371.0, 38247.80876095602, 39875.40186897199, 63897.0, 64505.0, 64526.677366612865, 40055.59944400577, 40360.39459408111, 40397.798011009756, 40407.1918561633, 40471.79764101161, 15684.215789210493, 15821.841781582267, 15831.920840395724, 15840.603984900239, 15855.048697078213, 11119.888801112047, 11366.033887119687, 12654.936725316498, 13023.47906083765, 13025.283609401384, 9409.059094090537, 9475.099865512902, 9478.857817132748, 9524.761880953032, 9570.377925434963, 3693.2244228711734, 3698.0754811297174, 3736.813159342022, 3748.9625103748613, 3775.0562359410146, 944.5088553951906, 1048.7692707604315, 1049.9580016799396, 1090.6128324444867, 1126.622581435212, 33876.66123338735, 34280.31439371199, 34535.654643453745, 34634.82682586571, 34701.65298347035, 1119.5130118398522, 1128.9322640641587, 1156.531604700098, 1198.610451603215, 1213.7875871722413, 17902.55243618894, 18009.909950450427, 18089.36687215941, 18381.81618183828, 18417.81582184188, 570110.0, 572445.0, 579119.0, 583099.0, 586198.0, 43014.35478467825, 43238.35142472865, 43247.35128973005, 43335.0, 43453.0, 1311.1084462565548, 1353.1272329347712, 1363.9590812275649, 1414.0455192745062, 1415.1084816565703, 29906.85046574753, 35244.823775880956, 35293.82353088218, 35403.46894796529, 35498.46752298666, 52609.0, 53467.197992029374, 53486.465135348146, 53500.46499534955, 53518.46481535135, 354156.0, 354831.0, 355938.0, 357989.0, 358026.0, 27155.72844271532, 28358.291042724097, 28936.009388737726, 31311.843440783563, 31757.523637145, 50443.0, 51287.48712512827, 51309.48690513047, 51317.7434112827, 51361.0, 45668.314975274734, 48099.0, 50969.49030509647, 52104.47895520996, 52486.737566311924, 43598.564014360716, 46393.30410043919, 47034.35379761692, 47636.52363476321, 47681.0, 46553.0, 47414.28878566755, 47507.52492475169, 47615.0, 47992.5200748002, 45569.31646025379, 45677.0, 46226.844328892046, 47647.0, 47793.28310075282, 29875.55186672245, 30518.542221866246, 30604.84697576498, 30664.233394165323, 30870.0], "value": 20361.87553471591, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.7442573965531, 410.15712710380154, 419.2893046286544, 423.79234175254123, 439.9472063352398, 19445.611087778238, 20405.48986275344, 20920.372388828342, 21006.579868402623, 21167.788322116776, 19443.805561944377, 19471.610567788637, 20415.591688166227, 20512.897435512838, 20748.066337014832, 5759.251297331341, 6010.068439391879, 6016.939830601704, 6019.7893073742425, 6024.036154215304, 4390.100029493946, 4568.748718820463, 4601.700889442175, 5888.0, 6633.668316584176, 6659.733610655592, 6667.699953502104, 6670.93329066708, 6681.66591670417, 6683.899741503881, 5763.366029736726, 6000.579959402866, 6019.337872833985, 6105.847353816146, 6658.800235992928, 5702.0, 5931.525477961753, 5939.0, 5939.4357536034, 5945.940540594625, 14603.70792584153, 14906.925465372713, 15089.320980555902, 15109.697806043818, 15182.392704291815, 2326.651002349661, 2518.8110891683195, 2643.127767836609, 2688.7042425333198, 2977.389635124794, 11244.718882027933, 11279.605213817476, 11309.208355415125, 15009.549713508612, 15327.693446131016, 1987.9105440255223, 1987.9602407951904, 2042.9182832686824, 2121.5120522279963, 2132.9253476128415, 84051.5797421009, 90589.54705226432, 90920.5453972726, 91949.5402522983, 93483.53258233733, 11610.303381797119, 11710.590129345432, 11854.762904742029, 11940.283582985048, 12007.519699211934, 16659.833401665826, 16663.25015374311, 16681.416150434678, 16691.833081669272, 16702.665946680998, 8629.568521573896, 8745.606447709868, 8753.737387878375, 8817.16236957488, 8924.821503569892, 7913.0, 7920.603969801602, 8385.874211886705, 8582.914170858336, 8680.782980425414, 4968.378952630921, 4977.65156439053, 5049.772760225798, 5137.845864624067, 5177.637565370464, 2056.7856005097246, 2077.7298951136254, 2080.0847627044054, 2113.968290475644, 2120.9257675981266, 1000.7698229407132, 1003.4230317567428, 1006.1246715357686, 1011.2769369900557, 1035.492608621785, 19983.800161998486, 20265.189392424138, 20611.278605248743, 20798.64737182332, 20823.58352832965, 1033.1579762493543, 1044.368157264859, 1071.5606601293432, 1082.285691443659, 1085.2511766880984, 11166.162537809696, 11498.770024599462, 11598.71003224926, 11621.9540241377, 11697.23967942081, 469258.0, 472182.0, 473527.0, 473825.0, 478847.0, 91951.54024229836, 92766.0, 93391.0660893396, 94293.0, 103412.0, 1052.315994603514, 1053.5575058475458, 1096.2435919215716, 1101.2236373356925, 1102.0412241350077, 17935.910320448314, 18059.54851128732, 18465.446036618923, 18602.720959185895, 18712.064396779835, 35644.10889727777, 43888.561114388445, 44070.77964610157, 44426.77786611046, 45533.31700024568, 60741.69629151826, 63568.36431635809, 64127.679361602895, 64517.67741161264, 64905.67547162423, 9050.502222377832, 9138.908610914072, 9267.907320926704, 9345.205657519187, 9584.945655977697, 9884.604615815575, 10406.843897341698, 10775.407352595683, 12849.614511564669, 14080.22558759278, 11717.296962182296, 11980.580679676517, 11992.100592455427, 12253.488034952992, 12684.429200686176, 12415.503379864704, 12683.429245683781, 12758.362081895682, 12796.942472824665, 13067.085304029008, 12161.513539458323, 12473.688157796129, 12828.734453262565, 13079.803802942773, 13210.27343496117, 9172.12864777845, 9278.860817087883, 9319.207867331354, 9424.198943089914, 9729.367591106555, 11692.88307116952, 12699.55551555691, 12813.359332033548, 12839.422225999666, 12933.611991640266], "value": 9659.239216572028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.3649579953715, 1479.4156308258239, 1494.2752764909017, 1595.4814685227298, 1762.453639371794, 7751.922480775191, 8539.615717292729, 8792.296616270683, 8797.296216302697, 9096.272298216143, 8908.688195913144, 8973.0, 8978.102189781019, 8979.326550508722, 8984.0, 2443.645671377654, 2470.6047032474808, 2473.5052989402193, 2475.10896077412, 2480.8015358771345, 2360.327306717586, 2456.91400800972, 2457.680501534798, 2459.8524088554655, 2463.0640356664444, 2410.433548116191, 2425.405775584984, 2436.4517983453757, 2438.51229754049, 2444.511097780442, 2293.346396277053, 2319.605667036608, 2325.1280769711357, 2325.8720770357622, 2326.488172602025, 2296.1159953417887, 2302.3783578433895, 2306.8269879759087, 2307.8460769615194, 2311.0293676655847, 8708.695195668184, 8833.69082082124, 8896.154865287788, 8993.820123597492, 8999.775005624846, 5412.648177868426, 5558.277423934903, 5564.8330550083565, 5568.136938774496, 5572.498475137217, 3298.323843612078, 3311.503274508819, 3346.498025296201, 3358.227607650254, 3378.864845406181, 1245.0763570283843, 1245.688577855536, 1277.1124068772208, 1277.6039427777418, 2245.797878190954, 11977.101717371144, 12431.875681243071, 12478.50085996559, 12504.3747812609, 12509.374531273492, 4618.722876627413, 4704.95295047052, 4745.928811067837, 4760.357351757469, 4770.522947705202, 9855.26085543587, 9866.0, 9866.161376282953, 9868.0, 9879.950600246953, 5329.040772660881, 5360.571154307646, 5363.329583802025, 5365.22204280385, 5368.8389348319615, 4076.490438695163, 4293.2272191005295, 4377.474703035656, 4414.955850441519, 5006.549410553068, 3773.716971227169, 3891.1633998690418, 3893.435451859521, 3894.337962546374, 3902.102516421239, 1186.7507823357018, 1192.8807119288, 1194.2237545595433, 1205.9819102713466, 1207.3178654060428, 990.1534188268927, 1006.8540061691014, 1023.6059117239917, 1027.4041056187393, 1037.527924794217, 5787.681677507693, 5875.706214689249, 6142.201513803177, 6214.906776398358, 6295.842603934938, 996.1632228927735, 1046.6755305855208, 1101.4878081692052, 1112.9554817807198, 1126.58909932744, 4122.34042553196, 4224.55642157569, 4228.450301460852, 4282.207791558571, 4285.485741710952, 11036.668899933014, 11428.542858285742, 11442.370669613085, 11462.770744585061, 11463.484143213574, 10428.739281517872, 11288.322700637988, 11324.320540767416, 11330.716732081599, 11339.886601134049, 7948.84102317962, 8384.077751447336, 8401.327893768606, 8403.285720713808, 8420.53687047206, 6334.524910631629, 6336.904946425715, 6354.777582784581, 6397.712102955285, 6442.774502892376, 9810.16613587853, 9973.152282056106, 9986.151177149733, 10108.39349639024, 10164.0, 9223.21602663781, 10195.23535734808, 10351.120154786626, 10456.32033917793, 10462.843057353994, 7562.659680314289, 8019.318357939641, 8143.714969976022, 8296.423679500875, 8301.543415111984, 8288.958555207186, 8626.611802468778, 8719.65121395137, 8845.24815390699, 8916.375853690179, 7901.0, 7985.64064617082, 8051.194880511902, 8095.797605059921, 8123.0, 7909.564973926489, 7923.3661307096445, 7950.0, 8045.07481639619, 8114.107448180814, 7157.463190260647, 7247.9637601811655, 7267.854642907007, 7284.089488813898, 7287.781366559012, 5149.401446898086, 5295.152775555893, 5319.6808191508635, 5379.811706590251, 5423.484768946943, 5172.120739474373, 5376.408595054619, 5417.214503896992, 5419.945800541944, 5443.918341224964], "value": 4760.771434632355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.9681780230877, 348.907539502032, 349.0418800392922, 353.9185987222939, 353.9663731945466, 5374.059539580572, 5431.321084864392, 5477.315335583052, 5496.835094947153, 5523.392426833045, 5322.281491998579, 5360.65155764875, 5376.623636345457, 5391.81128660497, 5421.728913554316, 4076.5311989121333, 4308.547602501739, 4318.5033721122, 4327.13457308538, 4377.08081302926, 4022.698297627675, 4130.295933574624, 4271.1671224111315, 4271.466066741657, 4276.657867370618, 4249.851255206068, 4265.44549208604, 4266.168097221043, 4267.335739061753, 4279.74321540707, 4256.255155347817, 4263.467066616673, 4267.957320426787, 4300.9139817203795, 4309.245881970643, 3633.327834350627, 3741.420079887622, 3756.34264003801, 3770.2459508098214, 3773.47171396002, 5290.55030322423, 5309.867253318659, 5319.228711836762, 5323.866903327409, 5330.987991784629, 4895.363602731658, 4908.656394052417, 4917.311576379309, 4928.8767780805765, 4936.851894443136, 5536.916946245809, 5646.971765141189, 5669.780997085605, 5681.23303354046, 5693.629914055573, 4132.442120313749, 4136.896577585554, 4149.439825623563, 4153.854615088458, 4164.8542301019625, 5627.8593035174445, 5969.283685957669, 5976.252968378953, 6000.489958353545, 6005.6487290359755, 4205.600467955539, 4208.600182982612, 4209.116085622054, 4210.989362552965, 4216.620504154641, 4264.1471705659, 4287.785610719514, 4294.162638285567, 4297.119090586422, 4307.612314891675, 4827.310441345571, 4859.927101093415, 4888.560029597354, 4926.359573255454, 4933.186024306021, 5678.858028549237, 5685.658860468302, 5707.4577915098, 5716.657000579979, 5764.279465066867, 1446.848080951485, 1461.2474575593578, 1463.1367493179075, 1472.7643577027625, 1475.4762059468735, 894.5706061090583, 947.696737044153, 949.392388871123, 950.5199874063692, 961.7643677299106, 4847.878803029882, 4907.2393778964315, 5313.203019547099, 5460.180972854104, 5468.398476167618, 5697.487226149667, 5716.685582293014, 5725.1698503716725, 5830.125481177857, 5878.676672783038, 5508.07217473881, 5517.041450285171, 5523.917141242885, 5553.916691249635, 5556.333240011225, 2982.463156631784, 3078.3843231353817, 3117.703818137273, 3122.4223518649123, 3122.8282444465317, 5998.550108741862, 6005.879882402328, 6013.609115407485, 6027.487663548647, 6049.576529642971, 5645.80239691617, 5988.700564971734, 5997.970010149921, 6009.759609615654, 6040.426159514839, 6085.300190478151, 6089.939100609025, 6092.329843717188, 6100.511959043266, 6100.725467354068, 5584.190292407659, 5886.705664716833, 5906.114082887601, 5912.733926973383, 5917.230760001173, 5756.884862302647, 5798.507126894261, 5817.476427121579, 5822.446867547576, 5834.891370639565, 6074.939250607614, 6077.453029227391, 6083.756649733961, 6092.969535152296, 6093.9390606093375, 4235.729281215561, 4289.442372491556, 4340.327249276367, 4341.438551254775, 4345.369921361448, 5841.737121829613, 5854.795082172103, 5857.765689372377, 5866.208061911588, 5870.354261031198, 5655.208270842168, 5759.840059977509, 5796.826095216981, 5801.1878337032, 5801.535877129904, 5669.165417291354, 5675.148727690879, 5688.829335119953, 5695.430456954437, 5726.484616384545, 5668.773249069991, 5685.403032681509, 5695.715214239189, 5722.971385143048, 5736.569757268138, 5344.438833922538, 5440.646357986719, 5709.429057094258, 5781.219535362672, 5788.334341550607, 5625.634333768292, 5632.408597097246, 5638.956792993309, 5639.943600563942, 5648.881669373985], "value": 4363.762716971754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.7773445700747, 773.9729109481168, 782.3232903538441, 789.0255534414993, 831.1231650608607, 15783.36866525339, 16121.838781612181, 16657.583560410996, 16692.833071669294, 16693.666126677475, 14459.710805783878, 14517.056391334583, 14815.629609259748, 14823.555293341216, 14848.183349915751, 738.5827007740636, 757.6742000939594, 851.1190917400492, 856.802935324874, 890.4256754393413, 864.1272314961902, 883.3816328569994, 883.9779005524849, 884.3146561414891, 884.4737381258141, 936.1621348892737, 939.4316438554679, 939.5161491831713, 939.8402271613808, 940.1068984464752, 765.2729906588763, 781.7303030454484, 887.8890138732659, 933.3093510802025, 935.4106912645058, 667.4426853577269, 671.516508114157, 672.0792514255453, 672.1027428383114, 672.3377473188905, 14648.194349310783, 14650.34073466686, 14674.926625366912, 14679.926600366929, 14692.48576299835, 15014.549563513112, 15294.847051529565, 15310.693786124326, 15345.386184552604, 15452.0, 13122.34388280582, 13273.535426260034, 13524.25616591087, 13540.187588744708, 13988.790168147487, 4576.679632425731, 4771.188897887368, 4790.161721698723, 4810.374651295309, 4871.488493708181, 79794.20205797926, 80158.0, 80793.0, 87399.56300218459, 87612.0, 11322.37726925027, 11329.441667457279, 11566.65300041, 11952.342621155745, 12114.636560903187, 21528.461788455414, 21885.562288754136, 21918.89040554787, 21922.0, 21922.45193870166, 8690.087540808125, 8734.737957861274, 8804.427712198687, 8887.200151986352, 8892.822143557092, 4919.803207871717, 4967.0, 5128.9230661540105, 5157.097507936096, 5209.426963034063, 3708.165662725865, 3853.344931361675, 3865.8260378283044, 3866.9226615467533, 3868.883933482, 616.442119881508, 631.5421319543294, 634.80321100459, 640.1869625575494, 651.5276424592133, 605.8303674971015, 615.4368752591419, 640.2636967487426, 666.8799616069057, 696.8919817428307, 8856.734297971072, 9143.901817691307, 9218.86171707425, 9267.119623635745, 9791.951040244754, 608.193664815506, 611.4405319133033, 623.7879121098848, 634.8730253949228, 693.5712432389194, 4740.099381117577, 4839.225723884161, 4927.992687494744, 4944.332515110414, 4947.777350019258, 72688.0, 72789.6360518194, 89812.5509372462, 126383.0, 128608.0, 65320.34679653143, 104412.0, 108178.0, 110148.4492577532, 110302.0, 58835.41164588385, 59715.402845971854, 76407.0, 97068.51465742626, 99773.50113249532, 8925.866112008196, 9244.583993720164, 9314.20829229523, 9317.11487408695, 9334.766630834012, 54735.726321368136, 56560.0, 57306.42693573011, 57529.71235143798, 57641.42358576361, 83177.58411207906, 84328.57835710782, 84748.0, 87040.56479717561, 87765.56117219628, 11788.329553741905, 12522.812157817822, 12657.746845062862, 12898.161619494704, 13104.73790524165, 14409.711805764036, 14418.711625767635, 14554.85445145535, 14628.195449250394, 15176.620584485476, 11168.38573878412, 12611.81082283748, 13405.262710551013, 13966.162030278216, 14770.926145369205, 13843.515476958259, 14424.927875360976, 14445.205513696426, 14974.101553906801, 15038.0, 12702.428390722625, 12844.357782111045, 12859.16415432994, 13017.479300827861, 13435.19388836673, 10343.689689309333, 10519.26365154432, 10731.463426828783, 10836.429100710671, 10847.945760271148, 10922.945385273022, 10927.890721092688, 10947.671569852917, 11056.391898445663, 11113.22207445471], "value": 7706.64760920496, "unit": "score"}], "name": "dromaeo_css", "value": 7404.212371955563, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 114.0, 113.0, 114.0, 114.0, 115.0, 113.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 117.0, 159.0, 118.0, 119.0, 118.0, 119.0, 143.0, 117.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 161.0, 160.0, 159.0, 159.0, 160.0, 160.0, 160.0, 161.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 111.0, 76.0, 77.0, 77.0, 76.0, 97.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 114.0, 81.0, 81.0, 81.0, 100.0, 82.0, 81.0, 105.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 78.0, 74.0, 75.0, 79.0, 73.0, 73.0, 75.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 125.0, 135.0, 133.0, 129.0, 119.0, 117.0, 169.0, 121.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 155.0, 150.0, 149.0, 152.0, 151.0, 151.0, 150.0, 149.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 64.0, 64.0, 61.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1454.9, "alertThreshold": 2.0}]} 03:59:43 INFO - Return code: 0 03:59:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:59:43 INFO - # TBPL SUCCESS # 03:59:43 INFO - Running post-action listener: _resource_record_post_action 03:59:43 INFO - [mozharness: 2016-10-26 10:59:43.239192Z] Finished run-tests step (success) 03:59:43 INFO - Running post-run listener: _resource_record_post_run 03:59:43 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 358043648; Read time: 52; Write time: 196816 03:59:43 INFO - TinderboxPrint: CPU usage
12.9% 03:59:43 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 52 03:59:43 INFO - TinderboxPrint: I/O write bytes / time
358,043,648 / 196,816 03:59:43 INFO - TinderboxPrint: CPU idle
8,257.9 (87.1%) 03:59:43 INFO - TinderboxPrint: CPU user
1,183.2 (12.5%) 03:59:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:59:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118706176; Read time: 0; Write time: 65108 03:59:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 239337472; Read time: 20; Write time: 131708 03:59:43 INFO - Running post-run listener: _upload_blobber_files 03:59:43 INFO - Blob upload gear active. 03:59:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:59:43 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 03:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:59:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:59:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:59:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:59:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:45 INFO - (blobuploader) - INFO - Done attempting. 03:59:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:59:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:48 INFO - (blobuploader) - INFO - Done attempting. 03:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:49 INFO - (blobuploader) - INFO - Done attempting. 03:59:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:59:49 INFO - Return code: 0 03:59:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:59:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:59:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d9516b623f693b08a58e5019c3e0b4360279e7793e020a55a4fc32e17b9140af8db254c48a31dbbc196dc64cb4ef9f67ec715767a2d69e194160fa3bbee0880", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4837a85c3259c521baca740ebd1acc0c1d138333081259a4f06965be6664fcd27dbd32584de166d3db3807fcf0b2ebe558384322ed64a3c3cbee6db40f3c923c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06be84283aff604118432420ade2490408a844585317647fd08f2c8b8c6ca9b417edf1c25d863f1ec2c44df3c0abaae1c27178a7fdd04f92c4f183e30bc8aa32"} 03:59:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:59:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:59:49 INFO - Contents: 03:59:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d9516b623f693b08a58e5019c3e0b4360279e7793e020a55a4fc32e17b9140af8db254c48a31dbbc196dc64cb4ef9f67ec715767a2d69e194160fa3bbee0880", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4837a85c3259c521baca740ebd1acc0c1d138333081259a4f06965be6664fcd27dbd32584de166d3db3807fcf0b2ebe558384322ed64a3c3cbee6db40f3c923c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06be84283aff604118432420ade2490408a844585317647fd08f2c8b8c6ca9b417edf1c25d863f1ec2c44df3c0abaae1c27178a7fdd04f92c4f183e30bc8aa32"} 03:59:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:59:49 INFO - Copying logs to upload dir... 03:59:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:59:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.938498 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-26 03:59:49.842084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 03:59:49.849858) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d9516b623f693b08a58e5019c3e0b4360279e7793e020a55a4fc32e17b9140af8db254c48a31dbbc196dc64cb4ef9f67ec715767a2d69e194160fa3bbee0880", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4837a85c3259c521baca740ebd1acc0c1d138333081259a4f06965be6664fcd27dbd32584de166d3db3807fcf0b2ebe558384322ed64a3c3cbee6db40f3c923c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06be84283aff604118432420ade2490408a844585317647fd08f2c8b8c6ca9b417edf1c25d863f1ec2c44df3c0abaae1c27178a7fdd04f92c4f183e30bc8aa32"} build_url:https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011794 build_url: 'https://queue.taskcluster.net/v1/task/Fv4J7S8jQ9S9GuGcQw-SCA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d9516b623f693b08a58e5019c3e0b4360279e7793e020a55a4fc32e17b9140af8db254c48a31dbbc196dc64cb4ef9f67ec715767a2d69e194160fa3bbee0880", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4837a85c3259c521baca740ebd1acc0c1d138333081259a4f06965be6664fcd27dbd32584de166d3db3807fcf0b2ebe558384322ed64a3c3cbee6db40f3c923c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06be84283aff604118432420ade2490408a844585317647fd08f2c8b8c6ca9b417edf1c25d863f1ec2c44df3c0abaae1c27178a7fdd04f92c4f183e30bc8aa32"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 03:59:49.875075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:59:49.875413) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477469348.84839-1568917923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 03:59:49.928212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 03:59:49.930817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 03:59:49.931112) ========= ========= Total master_lag: 0.47 =========