builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1477392601.51 results: success (0) buildid: 20161025004017 builduid: c91ef638278c4026ad4bdafdce3b715d revision: 96b6a1a83bd74da807a67bb9449bc7158f6ee2cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.505889) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.506380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.506668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.521763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.522143) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 03:50:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-10-25 03:50:03 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.626336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.626667) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013166 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:01.676544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:50:01.676909) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96b6a1a83bd74da807a67bb9449bc7158f6ee2cb --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 96b6a1a83bd74da807a67bb9449bc7158f6ee2cb --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=3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 03:50:03,199 truncating revision to first 12 chars 2016-10-25 03:50:03,199 Setting DEBUG logging. 2016-10-25 03:50:03,199 attempt 1/10 2016-10-25 03:50:03,199 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/96b6a1a83bd7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 03:50:04,245 unpacking tar archive at: mozilla-aurora-96b6a1a83bd7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.354469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:50:03.044524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:03.044846) ========= script_repo_revision: 96b6a1a83bd74da807a67bb9449bc7158f6ee2cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:03.045232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:03.045512) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:50:03.054595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-25 03:50:03.054974) ========= /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=3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:04 INFO - MultiFileLogger online at 20161025 03:50:04 in /builds/slave/test 03:50:04 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:50:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:04 INFO - {'append_to_log': False, 03:50:04 INFO - 'base_work_dir': '/builds/slave/test', 03:50:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:50:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:04 INFO - 'branch': 'Mozilla-Aurora', 03:50:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:04 INFO - 'config_files': ('talos/linux_config.py',), 03:50:04 INFO - 'default_actions': ('clobber', 03:50:04 INFO - 'read-buildbot-config', 03:50:04 INFO - 'download-and-extract', 03:50:04 INFO - 'populate-webroot', 03:50:04 INFO - 'create-virtualenv', 03:50:04 INFO - 'install', 03:50:04 INFO - 'run-tests'), 03:50:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:04 INFO - 'download_minidump_stackwalk': True, 03:50:04 INFO - 'download_symbols': 'ondemand', 03:50:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:04 INFO - 'installer_path': 'installer.exe', 03:50:04 INFO - 'log_level': 'info', 03:50:04 INFO - 'log_name': 'talos', 03:50:04 INFO - 'log_to_console': True, 03:50:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:04 INFO - 'opt_config_files': (), 03:50:04 INFO - 'pip_index': False, 03:50:04 INFO - 'sps_profile': False, 03:50:04 INFO - 'sps_profile_interval': 0, 03:50:04 INFO - 'suite': 'dromaeojs', 03:50:04 INFO - 'system_bits': '32', 03:50:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:04 INFO - 'title': 'talos-linux64-ix-059', 03:50:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:04 INFO - 'use_talos_json': True, 03:50:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:04 INFO - 'work_dir': 'build'} 03:50:04 INFO - [mozharness: 2016-10-25 10:50:04.673219Z] Running clobber step. 03:50:04 INFO - Running pre-action listener: _resource_record_pre_action 03:50:04 INFO - Running main action method: clobber 03:50:04 INFO - rmtree: /builds/slave/test/build 03:50:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:05 INFO - Running post-action listener: _resource_record_post_action 03:50:05 INFO - [mozharness: 2016-10-25 10:50:05.144835Z] Finished clobber step (success) 03:50:05 INFO - [mozharness: 2016-10-25 10:50:05.144937Z] Running read-buildbot-config step. 03:50:05 INFO - Running pre-action listener: _resource_record_pre_action 03:50:05 INFO - Running main action method: read_buildbot_config 03:50:05 INFO - Using buildbot properties: 03:50:05 INFO - { 03:50:05 INFO - "project": "", 03:50:05 INFO - "product": "firefox", 03:50:05 INFO - "script_repo_revision": "production", 03:50:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:50:05 INFO - "repository": "", 03:50:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:50:05 INFO - "buildid": "20161025004017", 03:50:05 INFO - "stage_platform": "linux64-pgo", 03:50:05 INFO - "basedir": "/builds/slave/test", 03:50:05 INFO - "nightly_build": "True", 03:50:05 INFO - "buildnumber": 834, 03:50:05 INFO - "slavename": "talos-linux64-ix-059", 03:50:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:50:05 INFO - "platform": "ubuntu64_hw", 03:50:05 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:50:05 INFO - "branch": "mozilla-aurora", 03:50:05 INFO - "repo_path": "releases/mozilla-aurora", 03:50:05 INFO - "revision": "96b6a1a83bd74da807a67bb9449bc7158f6ee2cb", 03:50:05 INFO - "pgo_build": "True", 03:50:05 INFO - "builduid": "c91ef638278c4026ad4bdafdce3b715d", 03:50:05 INFO - "slavebuilddir": "test" 03:50:05 INFO - } 03:50:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:50:05 INFO - Running post-action listener: _resource_record_post_action 03:50:05 INFO - [mozharness: 2016-10-25 10:50:05.147481Z] Finished read-buildbot-config step (success) 03:50:05 INFO - [mozharness: 2016-10-25 10:50:05.147571Z] Running download-and-extract step. 03:50:05 INFO - Running pre-action listener: _resource_record_pre_action 03:50:05 INFO - Running main action method: download_and_extract 03:50:05 INFO - mkdir: /builds/slave/test/build/tests 03:50:05 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:50:05 INFO - trying https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:50:05 INFO - Downloading https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/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:50:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/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:50:05 INFO - Downloaded 1361 bytes. 03:50:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:50:05 INFO - Using the following test package requirements: 03:50:05 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:05 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:05 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:50:05 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'jsshell-linux-x86_64.zip'], 03:50:05 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:05 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:50:05 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:50:05 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:50:05 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:05 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:50:05 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:05 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:50:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:50:05 INFO - Fetch https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:50:06 INFO - Expected file size: 21908967 03:50:10 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:50:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:50:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:50:10 INFO - Fetch https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:50:11 INFO - Expected file size: 21908967 03:50:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:50:15 INFO - Fetch https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:50:16 INFO - Expected file size: 14414081 03:50:17 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:50:17 INFO - trying https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:50:17 INFO - Downloading https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/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:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/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:50:18 INFO - Downloaded 64013245 bytes. 03:50:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:50:18 INFO - mkdir: /builds/slave/test/properties 03:50:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:18 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:18 INFO - Contents: 03:50:18 INFO - build_url:https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:50:19 INFO - Running post-action listener: _resource_record_post_action 03:50:19 INFO - Running post-action listener: set_extra_try_arguments 03:50:19 INFO - [mozharness: 2016-10-25 10:50:19.003249Z] Finished download-and-extract step (success) 03:50:19 INFO - [mozharness: 2016-10-25 10:50:19.003477Z] Running populate-webroot step. 03:50:19 INFO - Running pre-action listener: _resource_record_pre_action 03:50:19 INFO - Running main action method: populate_webroot 03:50:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:19 INFO - '--tppagecycles', 03:50:19 INFO - '7'], 03:50:19 INFO - 'tests': ['tsvgm']}}, 03:50:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:50:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:50:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:50:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['damp', 'tps']}, 03:50:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'tests': ['damp', 'tps']}, 03:50:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['dromaeo_dom']}, 03:50:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['basic_compositor_video']}, 03:50:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:50:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['a11yr', 03:50:19 INFO - 'ts_paint', 03:50:19 INFO - 'tpaint', 03:50:19 INFO - 'sessionrestore', 03:50:19 INFO - 'sessionrestore_no_auto_restore', 03:50:19 INFO - 'tabpaint']}, 03:50:19 INFO - 'other-e10s': {'tests': ['a11yr', 03:50:19 INFO - 'ts_paint', 03:50:19 INFO - 'tpaint', 03:50:19 INFO - 'sessionrestore', 03:50:19 INFO - 'sessionrestore_no_auto_restore', 03:50:19 INFO - 'tabpaint']}, 03:50:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:50:19 INFO - 'ts_paint', 03:50:19 INFO - 'tpaint', 03:50:19 INFO - 'sessionrestore', 03:50:19 INFO - 'sessionrestore_no_auto_restore', 03:50:19 INFO - 'tabpaint']}, 03:50:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:50:19 INFO - 'ts_paint', 03:50:19 INFO - 'tpaint', 03:50:19 INFO - 'sessionrestore', 03:50:19 INFO - 'sessionrestore_no_auto_restore', 03:50:19 INFO - 'tabpaint']}, 03:50:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['a11yr', 03:50:19 INFO - 'ts_paint', 03:50:19 INFO - 'tpaint', 03:50:19 INFO - 'sessionrestore', 03:50:19 INFO - 'sessionrestore_no_auto_restore', 03:50:19 INFO - 'tabpaint']}, 03:50:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['a11yr', 03:50:19 INFO - 'ts_paint', 03:50:19 INFO - 'tpaint', 03:50:19 INFO - 'sessionrestore', 03:50:19 INFO - 'sessionrestore_no_auto_restore', 03:50:19 INFO - 'tabpaint']}, 03:50:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['tsvgx', 03:50:19 INFO - 'tsvgr_opacity', 03:50:19 INFO - 'tart', 03:50:19 INFO - 'tscrollx', 03:50:19 INFO - 'cart']}, 03:50:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:50:19 INFO - 'tsvgr_opacity', 03:50:19 INFO - 'tart', 03:50:19 INFO - 'tscrollx', 03:50:19 INFO - 'cart']}, 03:50:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'talos_options': ['--disable-e10s'], 03:50:19 INFO - 'tests': ['tp5o']}, 03:50:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'tests': ['tp5o']}, 03:50:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'talos_options': ['--disable-e10s', 03:50:19 INFO - '--xperf_path', 03:50:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:19 INFO - 'tests': ['tp5n']}, 03:50:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:19 INFO - 'talos_options': ['--xperf_path', 03:50:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:19 INFO - 'tests': ['tp5n']}}, 03:50:19 INFO - 'talos.zip': {'path': '', 03:50:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:19 INFO - Running post-action listener: _resource_record_post_action 03:50:19 INFO - [mozharness: 2016-10-25 10:50:19.022300Z] Finished populate-webroot step (success) 03:50:19 INFO - [mozharness: 2016-10-25 10:50:19.022390Z] Running create-virtualenv step. 03:50:19 INFO - Running pre-action listener: _resource_record_pre_action 03:50:19 INFO - Running main action method: create_virtualenv 03:50:19 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:19 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:50:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:19 INFO - Using real prefix '/usr' 03:50:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:21 INFO - Installing pip.................done. 03:50:21 INFO - Return code: 0 03:50:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:50:21 INFO - Using env: {'DISPLAY': ':0', 03:50:21 INFO - 'HOME': '/home/cltbld', 03:50:21 INFO - 'LANG': 'en_US.UTF-8', 03:50:21 INFO - 'LANGUAGE': 'en_US:en', 03:50:21 INFO - 'LOGNAME': 'cltbld', 03:50:21 INFO - 'MAIL': '/var/mail/cltbld', 03:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:21 INFO - 'MOZ_NO_REMOTE': '1', 03:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:21 INFO - 'NO_EM_RESTART': '1', 03:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:21 INFO - 'PWD': '/builds/slave/test', 03:50:21 INFO - 'SHELL': '/bin/bash', 03:50:21 INFO - 'SHLVL': '1', 03:50:21 INFO - 'TERM': 'linux', 03:50:21 INFO - 'TMOUT': '86400', 03:50:21 INFO - 'USER': 'cltbld', 03:50:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:21 INFO - '_': '/tools/buildbot/bin/python'} 03:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:50:21 INFO - Cleaning up... 03:50:21 INFO - Return code: 0 03:50:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:50:21 INFO - Using env: {'DISPLAY': ':0', 03:50:21 INFO - 'HOME': '/home/cltbld', 03:50:21 INFO - 'LANG': 'en_US.UTF-8', 03:50:21 INFO - 'LANGUAGE': 'en_US:en', 03:50:21 INFO - 'LOGNAME': 'cltbld', 03:50:21 INFO - 'MAIL': '/var/mail/cltbld', 03:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:21 INFO - 'MOZ_NO_REMOTE': '1', 03:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:21 INFO - 'NO_EM_RESTART': '1', 03:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:21 INFO - 'PWD': '/builds/slave/test', 03:50:21 INFO - 'SHELL': '/bin/bash', 03:50:21 INFO - 'SHLVL': '1', 03:50:21 INFO - 'TERM': 'linux', 03:50:21 INFO - 'TMOUT': '86400', 03:50:21 INFO - 'USER': 'cltbld', 03:50:21 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:21 INFO - '_': '/tools/buildbot/bin/python'} 03:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:22 INFO - Downloading/unpacking psutil>=3.1.1 03:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:24 INFO - Installing collected packages: psutil 03:50:24 INFO - Running setup.py install for psutil 03:50:24 INFO - building 'psutil._psutil_linux' extension 03:50:24 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:50:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:50:24 INFO - building 'psutil._psutil_posix' extension 03:50:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:50:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:50:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:24 INFO - Successfully installed psutil 03:50:24 INFO - Cleaning up... 03:50:24 INFO - Return code: 0 03:50:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:50:24 INFO - Using env: {'DISPLAY': ':0', 03:50:24 INFO - 'HOME': '/home/cltbld', 03:50:24 INFO - 'LANG': 'en_US.UTF-8', 03:50:24 INFO - 'LANGUAGE': 'en_US:en', 03:50:24 INFO - 'LOGNAME': 'cltbld', 03:50:24 INFO - 'MAIL': '/var/mail/cltbld', 03:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:24 INFO - 'MOZ_NO_REMOTE': '1', 03:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:24 INFO - 'NO_EM_RESTART': '1', 03:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:24 INFO - 'PWD': '/builds/slave/test', 03:50:24 INFO - 'SHELL': '/bin/bash', 03:50:24 INFO - 'SHLVL': '1', 03:50:24 INFO - 'TERM': 'linux', 03:50:24 INFO - 'TMOUT': '86400', 03:50:24 INFO - 'USER': 'cltbld', 03:50:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:24 INFO - '_': '/tools/buildbot/bin/python'} 03:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:50:26 INFO - Installing collected packages: mozsystemmonitor 03:50:26 INFO - Running setup.py install for mozsystemmonitor 03:50:26 INFO - Successfully installed mozsystemmonitor 03:50:26 INFO - Cleaning up... 03:50:27 INFO - Return code: 0 03:50:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:50:27 INFO - Using env: {'DISPLAY': ':0', 03:50:27 INFO - 'HOME': '/home/cltbld', 03:50:27 INFO - 'LANG': 'en_US.UTF-8', 03:50:27 INFO - 'LANGUAGE': 'en_US:en', 03:50:27 INFO - 'LOGNAME': 'cltbld', 03:50:27 INFO - 'MAIL': '/var/mail/cltbld', 03:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:27 INFO - 'MOZ_NO_REMOTE': '1', 03:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:27 INFO - 'NO_EM_RESTART': '1', 03:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:27 INFO - 'PWD': '/builds/slave/test', 03:50:27 INFO - 'SHELL': '/bin/bash', 03:50:27 INFO - 'SHLVL': '1', 03:50:27 INFO - 'TERM': 'linux', 03:50:27 INFO - 'TMOUT': '86400', 03:50:27 INFO - 'USER': 'cltbld', 03:50:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:27 INFO - '_': '/tools/buildbot/bin/python'} 03:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:27 INFO - Downloading/unpacking jsonschema==2.5.1 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:50:29 INFO - warning: no files found matching '*.txt' 03:50:29 INFO - no previously-included directories found matching 'build' 03:50:29 INFO - no previously-included directories found matching 'dist' 03:50:29 INFO - no previously-included directories found matching '.git*' 03:50:29 INFO - Installing collected packages: jsonschema, functools32 03:50:29 INFO - Running setup.py install for functools32 03:50:29 INFO - warning: no files found matching '*.txt' 03:50:29 INFO - no previously-included directories found matching 'build' 03:50:29 INFO - no previously-included directories found matching 'dist' 03:50:29 INFO - no previously-included directories found matching '.git*' 03:50:29 INFO - Successfully installed jsonschema functools32 03:50:29 INFO - Cleaning up... 03:50:29 INFO - Return code: 0 03:50:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:50:29 INFO - Using env: {'DISPLAY': ':0', 03:50:29 INFO - 'HOME': '/home/cltbld', 03:50:29 INFO - 'LANG': 'en_US.UTF-8', 03:50:29 INFO - 'LANGUAGE': 'en_US:en', 03:50:29 INFO - 'LOGNAME': 'cltbld', 03:50:29 INFO - 'MAIL': '/var/mail/cltbld', 03:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:29 INFO - 'MOZ_NO_REMOTE': '1', 03:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:29 INFO - 'NO_EM_RESTART': '1', 03:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:29 INFO - 'PWD': '/builds/slave/test', 03:50:29 INFO - 'SHELL': '/bin/bash', 03:50:29 INFO - 'SHLVL': '1', 03:50:29 INFO - 'TERM': 'linux', 03:50:29 INFO - 'TMOUT': '86400', 03:50:29 INFO - 'USER': 'cltbld', 03:50:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:29 INFO - '_': '/tools/buildbot/bin/python'} 03:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:50:29 INFO - Cleaning up... 03:50:29 INFO - Return code: 0 03:50:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:50:29 INFO - Using env: {'DISPLAY': ':0', 03:50:29 INFO - 'HOME': '/home/cltbld', 03:50:29 INFO - 'LANG': 'en_US.UTF-8', 03:50:29 INFO - 'LANGUAGE': 'en_US:en', 03:50:29 INFO - 'LOGNAME': 'cltbld', 03:50:29 INFO - 'MAIL': '/var/mail/cltbld', 03:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:29 INFO - 'MOZ_NO_REMOTE': '1', 03:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:29 INFO - 'NO_EM_RESTART': '1', 03:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:29 INFO - 'PWD': '/builds/slave/test', 03:50:29 INFO - 'SHELL': '/bin/bash', 03:50:29 INFO - 'SHLVL': '1', 03:50:29 INFO - 'TERM': 'linux', 03:50:29 INFO - 'TMOUT': '86400', 03:50:29 INFO - 'USER': 'cltbld', 03:50:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:29 INFO - '_': '/tools/buildbot/bin/python'} 03:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:50:30 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:50:30 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:50:30 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:50:30 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:50:30 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:50:30 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:50:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:50:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - Downloading docopt-0.6.1.tar.gz 03:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:32 INFO - Running setup.py install for blobuploader 03:50:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:50:32 INFO - Running setup.py install for requests 03:50:33 INFO - Running setup.py install for docopt 03:50:33 INFO - Successfully installed blobuploader requests docopt 03:50:33 INFO - Cleaning up... 03:50:33 INFO - Return code: 0 03:50:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:33 INFO - Using env: {'DISPLAY': ':0', 03:50:33 INFO - 'HOME': '/home/cltbld', 03:50:33 INFO - 'LANG': 'en_US.UTF-8', 03:50:33 INFO - 'LANGUAGE': 'en_US:en', 03:50:33 INFO - 'LOGNAME': 'cltbld', 03:50:33 INFO - 'MAIL': '/var/mail/cltbld', 03:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:33 INFO - 'MOZ_NO_REMOTE': '1', 03:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:33 INFO - 'NO_EM_RESTART': '1', 03:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:33 INFO - 'PWD': '/builds/slave/test', 03:50:33 INFO - 'SHELL': '/bin/bash', 03:50:33 INFO - 'SHLVL': '1', 03:50:33 INFO - 'TERM': 'linux', 03:50:33 INFO - 'TMOUT': '86400', 03:50:33 INFO - 'USER': 'cltbld', 03:50:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:33 INFO - '_': '/tools/buildbot/bin/python'} 03:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:33 INFO - Running setup.py (path:/tmp/pip-VdMQrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:33 INFO - Running setup.py (path:/tmp/pip-KRNw3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:33 INFO - Running setup.py (path:/tmp/pip-Q74rao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:33 INFO - Running setup.py (path:/tmp/pip-R1jVlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:33 INFO - Running setup.py (path:/tmp/pip-HwL0MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:33 INFO - Running setup.py (path:/tmp/pip-BvliId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:34 INFO - Running setup.py (path:/tmp/pip-Nxcion-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:34 INFO - Running setup.py (path:/tmp/pip-Q8UDgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:34 INFO - Running setup.py (path:/tmp/pip-27gkhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:34 INFO - Running setup.py (path:/tmp/pip-6jq7Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:34 INFO - Running setup.py (path:/tmp/pip-e6Bxxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:34 INFO - Running setup.py (path:/tmp/pip-5IAtL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:34 INFO - Running setup.py (path:/tmp/pip-1ZtDFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:34 INFO - Running setup.py (path:/tmp/pip-1I8r2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:34 INFO - Running setup.py (path:/tmp/pip-LahPb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:34 INFO - Running setup.py (path:/tmp/pip-Iwees7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:34 INFO - Running setup.py (path:/tmp/pip-l2ESiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:34 INFO - Running setup.py install for manifestparser 03:50:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:34 INFO - Running setup.py install for mozcrash 03:50:35 INFO - Running setup.py install for mozdebug 03:50:35 INFO - Running setup.py install for mozdevice 03:50:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozfile 03:50:35 INFO - Running setup.py install for mozhttpd 03:50:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozinfo 03:50:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozInstall 03:50:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozleak 03:50:35 INFO - Running setup.py install for mozlog 03:50:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for moznetwork 03:50:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozprocess 03:50:36 INFO - Running setup.py install for mozprofile 03:50:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Running setup.py install for mozrunner 03:50:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Running setup.py install for mozscreenshot 03:50:36 INFO - Running setup.py install for moztest 03:50:36 INFO - Running setup.py install for mozversion 03:50:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:36 INFO - Cleaning up... 03:50:36 INFO - Return code: 0 03:50:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:36 INFO - Using env: {'DISPLAY': ':0', 03:50:36 INFO - 'HOME': '/home/cltbld', 03:50:36 INFO - 'LANG': 'en_US.UTF-8', 03:50:36 INFO - 'LANGUAGE': 'en_US:en', 03:50:36 INFO - 'LOGNAME': 'cltbld', 03:50:36 INFO - 'MAIL': '/var/mail/cltbld', 03:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:36 INFO - 'MOZ_NO_REMOTE': '1', 03:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:36 INFO - 'NO_EM_RESTART': '1', 03:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:36 INFO - 'PWD': '/builds/slave/test', 03:50:36 INFO - 'SHELL': '/bin/bash', 03:50:36 INFO - 'SHLVL': '1', 03:50:36 INFO - 'TERM': 'linux', 03:50:36 INFO - 'TMOUT': '86400', 03:50:36 INFO - 'USER': 'cltbld', 03:50:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:36 INFO - '_': '/tools/buildbot/bin/python'} 03:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:36 INFO - Running setup.py (path:/tmp/pip-6kuQ5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:36 INFO - Running setup.py (path:/tmp/pip-jcdLCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:36 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:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:36 INFO - Running setup.py (path:/tmp/pip-N2gTKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:37 INFO - Running setup.py (path:/tmp/pip-4tw7WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:37 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:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:37 INFO - Running setup.py (path:/tmp/pip-1FiD6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:37 INFO - Running setup.py (path:/tmp/pip-poPDyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:37 INFO - Running setup.py (path:/tmp/pip-Zks3pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:37 INFO - Running setup.py (path:/tmp/pip-pbYMiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:37 INFO - Running setup.py (path:/tmp/pip-XOFXNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:37 INFO - Running setup.py (path:/tmp/pip-URKoj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:37 INFO - Running setup.py (path:/tmp/pip-HQlAa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:37 INFO - Running setup.py (path:/tmp/pip-ROwkZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:37 INFO - Running setup.py (path:/tmp/pip-pTNYhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:37 INFO - Running setup.py (path:/tmp/pip-xLFTJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:37 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:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:37 INFO - Running setup.py (path:/tmp/pip-WlhjEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:37 INFO - Running setup.py (path:/tmp/pip-YbfnBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:37 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:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:37 INFO - Running setup.py (path:/tmp/pip-YIarwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50: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:50: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:50: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:50: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:50: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:50: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:50:39 INFO - Downloading blessings-1.6.tar.gz 03:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:40 INFO - Installing collected packages: blessings 03:50:40 INFO - Running setup.py install for blessings 03:50:40 INFO - Successfully installed blessings 03:50:40 INFO - Cleaning up... 03:50:40 INFO - Return code: 0 03:50:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:40 INFO - Reading from file tmpfile_stdout 03:50:40 INFO - Current package versions: 03:50:40 INFO - argparse == 1.2.1 03:50:40 INFO - blessings == 1.6 03:50:40 INFO - blobuploader == 1.2.4 03:50:40 INFO - docopt == 0.6.1 03:50:40 INFO - functools32 == 3.2.3-2 03:50:40 INFO - jsonschema == 2.5.1 03:50:40 INFO - manifestparser == 1.1 03:50:40 INFO - mozInstall == 1.12 03:50:40 INFO - mozcrash == 0.17 03:50:40 INFO - mozdebug == 0.1 03:50:40 INFO - mozdevice == 0.48 03:50:40 INFO - mozfile == 1.2 03:50:40 INFO - mozhttpd == 0.7 03:50:40 INFO - mozinfo == 0.9 03:50:40 INFO - mozleak == 0.1 03:50:40 INFO - mozlog == 3.4 03:50:40 INFO - moznetwork == 0.27 03:50:40 INFO - mozprocess == 0.23 03:50:40 INFO - mozprofile == 0.28 03:50:40 INFO - mozrunner == 6.12 03:50:40 INFO - mozscreenshot == 0.1 03:50:40 INFO - mozsystemmonitor == 0.3 03:50:40 INFO - moztest == 0.7 03:50:40 INFO - mozversion == 1.4 03:50:40 INFO - psutil == 3.1.1 03:50:40 INFO - requests == 1.2.3 03:50:40 INFO - wsgiref == 0.1.2 03:50:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50: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:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:40 INFO - Using env: {'DISPLAY': ':0', 03:50:40 INFO - 'HOME': '/home/cltbld', 03:50:40 INFO - 'LANG': 'en_US.UTF-8', 03:50:40 INFO - 'LANGUAGE': 'en_US:en', 03:50:40 INFO - 'LOGNAME': 'cltbld', 03:50:40 INFO - 'MAIL': '/var/mail/cltbld', 03:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:40 INFO - 'MOZ_NO_REMOTE': '1', 03:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:40 INFO - 'NO_EM_RESTART': '1', 03:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:40 INFO - 'PWD': '/builds/slave/test', 03:50:40 INFO - 'SHELL': '/bin/bash', 03:50:40 INFO - 'SHLVL': '1', 03:50:40 INFO - 'TERM': 'linux', 03:50:40 INFO - 'TMOUT': '86400', 03:50:40 INFO - 'USER': 'cltbld', 03:50:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:40 INFO - '_': '/tools/buildbot/bin/python'} 03:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:50:40 INFO - Cleaning up... 03:50:40 INFO - Return code: 0 03:50:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50: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:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e9728f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1362ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', '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:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:50: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 03:50:40 INFO - Using env: {'DISPLAY': ':0', 03:50:40 INFO - 'HOME': '/home/cltbld', 03:50:40 INFO - 'LANG': 'en_US.UTF-8', 03:50:40 INFO - 'LANGUAGE': 'en_US:en', 03:50:40 INFO - 'LOGNAME': 'cltbld', 03:50:40 INFO - 'MAIL': '/var/mail/cltbld', 03:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:40 INFO - 'MOZ_NO_REMOTE': '1', 03:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:40 INFO - 'NO_EM_RESTART': '1', 03:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:40 INFO - 'PWD': '/builds/slave/test', 03:50:40 INFO - 'SHELL': '/bin/bash', 03:50:40 INFO - 'SHLVL': '1', 03:50:40 INFO - 'TERM': 'linux', 03:50:40 INFO - 'TMOUT': '86400', 03:50:40 INFO - 'USER': 'cltbld', 03:50:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:40 INFO - '_': '/tools/buildbot/bin/python'} 03:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:50:40 INFO - Cleaning up... 03:50:40 INFO - Return code: 0 03:50:40 INFO - Running post-action listener: _resource_record_post_action 03:50:40 INFO - Running post-action listener: _start_resource_monitoring 03:50:40 INFO - Starting resource monitoring. 03:50:40 INFO - [mozharness: 2016-10-25 10:50:40.904086Z] Finished create-virtualenv step (success) 03:50:40 INFO - [mozharness: 2016-10-25 10:50:40.904588Z] Running install step. 03:50:40 INFO - Running pre-action listener: _resource_record_pre_action 03:50:40 INFO - Running main action method: install 03:50:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:41 INFO - Reading from file tmpfile_stdout 03:50:41 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:50:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:50:41 INFO - Reading from file tmpfile_stdout 03:50:41 INFO - Output received: 03:50:41 INFO - Usage: mozinstall [options] installer 03:50:41 INFO - Options: 03:50:41 INFO - -h, --help show this help message and exit 03:50:41 INFO - -d DEST, --destination=DEST 03:50:41 INFO - Directory to install application into. [default: 03:50:41 INFO - "/builds/slave/test"] 03:50:41 INFO - --app=APP Application being installed. [default: firefox] 03:50:41 INFO - mkdir: /builds/slave/test/build/application 03:50:41 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:50:41 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:50:57 INFO - Reading from file tmpfile_stdout 03:50:57 INFO - Output received: 03:50:57 INFO - /builds/slave/test/build/application/firefox/firefox 03:50:57 INFO - Running post-action listener: _resource_record_post_action 03:50:57 INFO - [mozharness: 2016-10-25 10:50:57.582625Z] Finished install step (success) 03:50:57 INFO - [mozharness: 2016-10-25 10:50:57.582868Z] Running run-tests step. 03:50:57 INFO - Running pre-action listener: _resource_record_pre_action 03:50:57 INFO - Running main action method: run_tests 03:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:50:57 INFO - Python 2.7.3 03:50:57 INFO - Return code: 0 03:50:57 INFO - grabbing minidump binary from tooltool 03:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135ff60>, '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 0x1360d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13611d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:50:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:50:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:50:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:50:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:50:57 INFO - Return code: 0 03:50:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:50:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:50:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:50:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:50:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:50:57 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/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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:50:57 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/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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:50:57 INFO - Using env: {'DISPLAY': ':0', 03:50:57 INFO - 'HOME': '/home/cltbld', 03:50:57 INFO - 'LANG': 'en_US.UTF-8', 03:50:57 INFO - 'LANGUAGE': 'en_US:en', 03:50:57 INFO - 'LOGNAME': 'cltbld', 03:50:57 INFO - 'MAIL': '/var/mail/cltbld', 03:50:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:57 INFO - 'MOZ_NO_REMOTE': '1', 03:50:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:57 INFO - 'NO_EM_RESTART': '1', 03:50:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:57 INFO - 'PWD': '/builds/slave/test', 03:50:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:57 INFO - 'SHELL': '/bin/bash', 03:50:57 INFO - 'SHLVL': '1', 03:50:57 INFO - 'TERM': 'linux', 03:50:57 INFO - 'TMOUT': '86400', 03:50:57 INFO - 'USER': 'cltbld', 03:50:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146', 03:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:57 INFO - '_': '/tools/buildbot/bin/python'} 03:50:57 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/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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:50:57 INFO - mozversion application_buildid: 20161025004017 03:50:57 INFO - mozversion application_changeset: 96b6a1a83bd74da807a67bb9449bc7158f6ee2cb 03:50:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:50:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:50:57 INFO - mozversion application_name: Firefox 03:50:57 INFO - mozversion application_remotingname: firefox-dev 03:50:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:50:57 INFO - mozversion application_vendor: Mozilla 03:50:57 INFO - mozversion application_version: 51.0a2 03:50:57 INFO - mozversion platform_buildid: 20161025004017 03:50:57 INFO - mozversion platform_changeset: 96b6a1a83bd74da807a67bb9449bc7158f6ee2cb 03:50:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:50:57 INFO - mozversion platform_version: 51.0a2 03:50:57 INFO - using testdate: 1477392657 03:50:57 INFO - actual date: 1477392657 03:50:57 INFO - starting webserver on 'localhost:44260' 03:50:57 INFO - SUITE-START | Running 2 tests 03:50:57 INFO - TEST-START | dromaeo_css 03:50:57 INFO - operating with platform_type : linux_ 03:50:57 INFO - Initialising browser for dromaeo_css test... 03:50:57 INFO - TEST-INFO | started process 18530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppkLC6/profile http://localhost:44260/getInfo.html) 03:51:01 INFO - PROCESS | 18530 | __metrics Screen width/height:1600/1200 03:51:01 INFO - PROCESS | 18530 | colorDepth:24 03:51:01 INFO - PROCESS | 18530 | Browser inner width/height: 1024/697 03:51:01 INFO - PROCESS | 18530 | __metrics 03:51:01 INFO - PROCESS | 18530 | 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:51:01 INFO - PROCESS | 18530 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:51:02 INFO - PROCESS | 18530 | console.error: PushService: 03:51:02 INFO - PROCESS | 18530 | stateChangeProcessEnqueue: Error transitioning state 03:51:02 INFO - PROCESS | 18530 | UnknownError 03:51:02 INFO - TEST-INFO | 18530: exit 0 03:51:02 INFO - Browser initialized. 03:51:02 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:02 INFO - TEST-INFO | started process 18624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppkLC6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:14 INFO - PROCESS | 18624 | RSS: Main: 145338368 03:51:14 INFO - PROCESS | 18624 | 03:52:05 INFO - PROCESS | 18624 | 1477392725803 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:54:14 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:44260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44260/tests/dromaeo/cssquery-ext.html) 03:54:16 INFO - PROCESS | 18624 | RSS: Main: 245764096 03:54:16 INFO - PROCESS | 18624 | 03:57:18 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:44260/tests/dromaeo/cssquery-ext.html (next: http://localhost:44260/tests/dromaeo/cssquery-jquery.html) 03:57:18 INFO - PROCESS | 18624 | RSS: Main: 232636416 03:57:18 INFO - PROCESS | 18624 | 04:00:20 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:44260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44260/tests/dromaeo/cssquery-mootools.html) 04:00:21 INFO - PROCESS | 18624 | RSS: Main: 174432256 04:00:21 INFO - PROCESS | 18624 | 04:03:23 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:44260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44260/tests/dromaeo/cssquery-prototype.html) 04:03:24 INFO - PROCESS | 18624 | RSS: Main: 185348096 04:03:24 INFO - PROCESS | 18624 | 04:06:26 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:44260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44260/tests/dromaeo/cssquery-yui.html) 04:06:27 INFO - PROCESS | 18624 | RSS: Main: 176898048 04:06:27 INFO - PROCESS | 18624 | 04:09:29 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:44260/tests/dromaeo/cssquery-yui.html (next: http://localhost:44260/tests/dromaeo/cssquery-dojo.html) 04:09:30 INFO - PROCESS | 18624 | RSS: Main: 262078464 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | __start_tp_report 04:09:30 INFO - PROCESS | 18624 | _x_x_mozilla_page_load 04:09:30 INFO - PROCESS | 18624 | _x_x_mozilla_page_load_details 04:09:30 INFO - PROCESS | 18624 | |i|pagename|runs| 04:09:30 INFO - PROCESS | 18624 | |0;dojo.html;3119.4385010698074;3160.0677800048975;3170.1757543038816;3193.6486986431505;3216.372807302577;5488.615796894214;5550.528205102566;5598.664080155194;5607.971960140204;5618.77524899004;5615.578831587627;5633.126865335869;5662.094064949599;5672.886542269152;5684.118961560955;5098.745062746866;5118.769655365499;5139.306193663863;5197.948020519803;5216.087184742674;4994.650374473788;5160.612954028444;5203.791848326063;5211.557017653485;5212.5308722214995;4965.28003439501;5061.569766569827;5065.062963351773;5092.8472145835685;5109.437961824215;5083.669561478492;5115.335006449138;5121.334226550562;5183.740812959337;5204.089284375257;5000.649954503187;5082.6188035897085;5143.948560514385;5151.150060240056;5157.7936882524655;5383.730813459311;5413.02565538203;5464.644798088111;5482.0406428874785;5486.1222204447095;5880.852978675524;5893.528517718572;5902.085176797603;5999.460048595603;6001.129836173774;6021.458068773832;6029.939700602981;6031.095335699636;6038.154658347835;6038.426349496791;5466.316710411159;5496.258005169331;5528.530074943675;5561.860953476114;5574.86062848432;6133.6319820810895;6171.321154672983;6171.814845554641;6173.32093469718;6180.165677633552;5905.763769449174;5913.201717768132;5913.586048976616;5915.526757859361;5916.023856063702;5734.369219385864;5767.88464230713;5925.585209035326;5955.67243801595;5964.612300200473;5956.910646340309;5958.314793798769;5963.4334738199805;6030.517558595302;6050.213472248667;5913.940860591425;5970.671613061237;5973.641581505037;5974.312954010257;5996.2504686914135;4459.910801783946;4486.641068714495;4491.281394976788;4543.318502224693;4595.494495605481;4049.2913740095364;4072.9185416291507;4074.837006519706;4093.5497095319492;4095.017195872969;5678.687672177987;5683.346415162227;5692.089265717548;5701.572382071278;5726.656400615976;5822.534197264209;5854.619449735754;5928.703564821742;5954.374790647006;5989.670568118708;5718.485336319668;5735.512481439125;5735.827925162252;5737.942620573825;5750.88498230033;5228.2680424740565;5235.345581802275;5236.738163091906;5236.842894713165;5239.835882133532;6022.879542409128;6035.366286539938;6149.262088549223;6237.064440333896;6249.375062493805;6014.097885317237;6123.404636889863;6129.450483693955;6131.621347939075;6134.191681014119;6256.468200203034;6295.18162638854;6299.905501417391;6302.275238347649;6304.306526282197;5714.485696287354;5772.884542309214;5950.821475355746;5997.220361352996;6007.068904319837;5928.822135335947;5945.732442040032;5961.672108034099;6035.939640603538;6068.605540639845;5893.70531473416;5895.263092113486;5899.056151015817;5899.764009439575;5905.43898329658;5654.180143879197;5885.205497257815;5897.174395584536;5898.941010590011;5901.734421951109;5654.236678048411;5749.482546570829;5753.424657534213;5760.913586296293;5889.587728858939;5895.970520147372;5928.614640048383;5944.048952167633;5948.405159484017;5950.375210602998;5600.551955843442;5649.7740090397565;5780.364159942319;5788.247527821356;5788.507976822018 04:09:30 INFO - PROCESS | 18624 | |1;ext.html;584.0625795598065;625.8967270400384;652.5269179844611;661.75515059428;669.9866002679944;34789.47815782762;45437.545624543745;45650.771746141225;45754.084918301654;46052.53947460524;47654.761726191406;48195;48262.27606585904;48298.61909666325;48302;8388.706395276167;9359.01730318317;9515.714528564155;9518.095780900803;9519.619215231418;8341.582920853964;11048.502817373197;11259.943700281528;11294.661160165208;11656.475458604384;11320.037796787283;11366.488508017117;11389.772204555904;11403.14476414268;11406.657800265964;11154.386508742016;11188.272762270426;11211.215214934999;11243.156763242789;11246.325220486715;11036;11080.556777728882;11093.223474356799;11096.11231101518;11128.666140015812;44329.55670443319;44628.55371446277;44628.77685611584;44716;44719.776401117786;3902.5267511914417;3975.9006024849323;4015.8795236142964;4103.281925662997;4664.883377915546;34159.65840341614;34245.486317705254;34529.13677158091;34813.30373392543;36770.632293677256;4423.491298500681;4525.162844873676;4557.082989080105;4595.103954728829;4599.172149013176;365075;365909;366453.9999999973;366486;367548;65605;65638.67180664066;65987.67006164939;66208.33791662118;66273.33726662768;40940.79529602393;41582;68802.31197688059;68926.65536672284;69003.65498172578;19383.903080484506;19554.70667939982;19559.706604400944;19567.510812229808;19570.70643940342;13418.127821691558;13770.242636654879;14154.36305366261;14805.851941480663;15002.774958375632;19822.405327840188;20967;21120.894395527925;21238.89380553087;21315.147394104373;7611.733589324458;7633.809154771176;7641.3886889048745;7728.26581474759;7775.183605721431;1048.984265236022;1069.989300106989;1099.5931505342915;1132.4281237974935;1165.4871856383165;34290.82854585711;34644.82677586596;35110.64889351125;35122.82438587791;35125.824370877985;1136.1933027550367;1165.0854079547514;1232.143660156183;1243.900487960979;1245.265293476853;17427;18244;18345.908270458563;18397.448076557725;18434.170462329228;620786;622730;625285;627256;628002;64372.678136609014;65262;65427;65561.34438655648;65568;1350.8716671916152;1399.2094466626324;1423.4448565059636;1464.8754855837374;1468.8824894008667;30073.699263007966;34179.31641367109;34883.47674784931;35093.47359789554;35247.647523524436;54861.725691371284;55456.168157476866;55514.44485555093;55543.166852498056;55553.16670249869;442677;445056;445248;445663.315050281;445982;30364.24089397783;31044.53433198549;31327.53008704917;33165.34173291278;33453.498197527544;52352.73823630858;52507.47492525179;52814.47185528249;52955.735221323645;53616.463835361144;43686.126277474905;44808.77595612001;44843;44989.32516012328;46707.76646116748;43378;44976.32535511904;45397.773011134734;45764.54235457603;46207.76896115498;43887;44317.55682443134;44362.778186108866;44779.776101119285;44991;36636.45045324269;38977.6102238974;39927.80036099801;40589.39115913323;43952.78023609862;29155.916143433547;29722.702772971992;29964.550531742476;30061;30095.849520752257 04:09:30 INFO - PROCESS | 18624 | |2;jquery.html;396.39945482593856;411.91555731075135;427.55747801025933;433.6985794872564;440.6276696191717;14947.402103915843;19196.520086997833;19363.70954435683;20354.59290814183;20500.69248961267;18789.34237301695;18999.810001899976;19047;20313;21150.89424552879;5825.155352473878;6070.939290607082;6073.058675905242;6079.939200608003;6085.813266413052;5727.684977326246;5930.288365396159;5947.345791962881;5950.166976623276;5952.4047595240345;5775.480206781389;5909.025010873201;5914.88170236595;5917.142014407908;5952.55355848311;5895;5962.731677074542;5979.372165922581;5986.28164620244;6001.909971350433;5259.737013149365;5389.865253368658;5394.757235924393;5397.109476936301;5517.227588137664;13394.799078013837;13520.391582378816;13597.252151131685;13626.523071692542;21737.2391966282;2361.350628577155;2389.940251493709;2449.3141920262356;2881.27968007998;2986.9396364290583;9940.90059099407;10053.597856085747;10233.89766102337;10262.7434314142;10492.79014419715;1962.2837664252445;1971.7338159348449;1997.8113022751586;2023.5244717491378;2033.146078646957;85810.57094714549;86214.56892715496;88760.55619721925;88822.55588722015;88954.55522722345;10128.645497407555;10628;10705.839412408664;11833.526658933719;11979.520819167135;15510.224488775517;15865.286062127232;16704.74942875858;16745.413910513074;17382;8461;8509.914900851036;8512.914870851213;8708.651653933899;8730.126987301219;7512.173660897297;7970.123286438487;8308.169183081643;8468.153184681483;8546.35902307317;4985.725785081783;5058.9494105058475;5071.822486212965;5135.430875541463;5270.420253772082;2098.5068508900395;2099.632564301241;2101.3905967269625;2131.232756207795;2164.3466546924237;981.6956743409565;989.2531138990016;1005.5123265216511;1022.4172221833633;1040.193849766437;19459.610807784047;20282.492937676678;20375;20402.89798550998;20544.38366848967;1005.6681295172575;1010.6917390196061;1020.3112898793285;1037.2946396450486;1043.0925095167254;10531.894681053245;11256.549738010552;11381.146414018982;11385.772284554429;11409.14431417647;488643;496853;497230;524443;538156;59547;95277;98726;99526;99764.5011774951;1076.580133747839;1090.4929207918196;1118.072000239799;1122.629532254354;1132.7111586545377;18062.458126256235;18405.263789448272;18554.25782968666;18609.162587683317;18756.155972980974;43174.136517270104;44310.778446107564;44345.11309773851;44873.55126448694;45506;60488;62473;62644.76110980536;63121;63648.68175659092;9083;9141.405808622418;9164.450132992042;9245.953770231106;9346.672866449642;10888;14000.299985000913;14007.439702412197;14382.208978505863;14590.92704536513;10820.350778953289;11564.884351156381;11857.822132667845;12413.75172496563;12460.750784984068;11792.23350482216;11962;12099.637010889688;12127;12526.436310366238;11930.463129159381;12214.26714397139;12281.44733487013;12358.691032724253;12492.188007779465;8930.330225233003;8988.370814043215;9149.63401463934;9171.541422928693;9242.168204861595;11333.206675532634;12377.51469823627;12451.128421010804;12565.057620678303;12636.368181591068 04:09:30 INFO - PROCESS | 18624 | |3;mootools.html;1392.4291040673327;1516.3100789140942;1549.6280892585778;1678.303504045821;1839.8804077734947;8287.46131501452;9027.954860225698;9359.157675809176;9365.625374984993;9669;9391.765205869857;9425.71722848314;9440.669576564822;9446.952765236165;9457.952710236439;2544.796416286702;2559.603261494462;2562.4362640219215;2563.436044070311;2567.550678631241;2460.1758410932357;2547.0448581781834;2548.0826902315152;2548.7706106450414;2549.247971848309;2431.902723891042;2438.1344622658967;2523.3187039499326;2532.8100392470546;2533.328667903007;2471.0733474946896;2483.987580062088;2494.8627825469594;2499.7000359956924;2503.236512863576;2458.8032957363366;2469.061756532524;2512.196097248881;2515.207709571479;2521.810864185175;9504.144626983536;9643.035696430372;9662.227021838236;9682.56428460721;9698.078682525149;5566.4990150886615;5778.971105144489;5797.275340582427;5849.649021058707;5877.9412205877825;3833.5016447861876;3854.3062248795204;3862.4978752761963;3931.2137572485617;3938.6061393860673;1203.8615559210716;1206.4510647655384;1210.703377672467;1240.962771116868;1248.36333469931;13163.736725265537;13328.400221990034;13449.529266475723;13455.125416847874;13529.458821647122;4853.320535125085;4870.26945958102;4899.657024008286;4971.850844474671;5003.574696150868;10480.371177729361;10506.947465262625;10517.158627309796;10525.26323157387;10553.208509361675;5723.828285151369;5731.426857314235;5732.369439361667;5734.168545560954;5734.627249228787;4678.438587369537;4680.251159814414;5319.042572337016;5343.812966546152;5361.678299302054;4185.811638476215;4192.888804867538;4223.450951376363;4223.535411104776;4267.76527291002;1280.6286177008562;1284.543986884661;1295.6242689620094;1315.3883444198493;1316.6839958409912;905.2486436258022;941.6892425499568;1003.372891942536;1054.855481802253;1072.292287090532;6349.333320001426;6371.171747672865;6484.578502397329;6639.834004149839;6717.56335838169;471.68632859148966;484.60020483101584;496.2506615011359;496.6597880451902;501.1255359397874;4301.956980430218;4376.081022985145;4467.1586241665655;4470.128324976598;4501.144782491317;11549.13381496391;11819.172657913863;11947.581834635746;11981.820272695917;12028.939855300667;11860.110491713156;11884;11884.762304753856;11900.88099119015;12015.579454719043;8503.65985360591;8890.511021893728;8910.153535414125;8921.330900182382;9139.90860091404;6068.908966365596;6227.50179985591;6485.28661847187;6541.411272985454;6563.818512667574;11089.944550277198;11130;11189.328640281608;11315.264507806965;11476.713082173012;11235.71910702239;11295.2658077228;11320.943395282971;11615.535378584762;11618.244814087057;7519.43604229674;7760.262775036363;8294.29498492635;8370.204830541088;8660.39377243587;9229.446233226028;9515.286353523376;9533.23734101284;9535.141837234682;9603.135717785433;8320.292775114183;8355.289800367036;8452.492850428995;8453.66185352579;8456.534890581077;8315.12691167443;8385.664573416994;8390;8414.747557573282;8672.913270867211;7706;7775.261350171724;7849.254320839511;7853.214678532101;7881;5226.869328266672;5254.290670759398;5388.4879597251565;5427.294451721251;5673.716314184357;5457.426970168075;5473.616846820684;5524.944750552604;5625.240592519957;5640.266765320482 04:09:30 INFO - PROCESS | 18624 | |4;prototype.html;343.9415299399102;344.3904289407748;347.418074724836;354.03172323694696;360.44491483115996;5261.631685781997;5455.208994695777;5535.806246781363;5590.692511911843;5639.182318563811;5263.921041184376;5365.436629153932;5407.3781515125775;5417.160340147274;5434.456554344573;4268.658507319423;4332.220200363933;4336.327869180266;4338.631216346615;4372.628326592244;4145.481814773153;4291.806868690901;4315.913681726363;4324.589164029428;4374.365716971038;4275.444192255002;4286.314189729644;4303.053328267792;4309.525952145262;4321.222180007613;4278.507971583276;4291.206126866539;4300.6774491913075;4310.956890431118;4320.373545835836;3788.5264341957254;3856.3636999894984;3859.1509867829313;3882.864099756495;3892.6691231245377;5297.020051290524;5297.788088476456;5305.867353316159;5306.7611957462;5308.23030660552;4950.2822090796635;4950.554450099472;4951.257311403282;4961.677490963112;4966.826161084345;5460.863478413032;5659.830205093854;5695.515881150107;5698.800541981011;5708.942910570924;4229.577042295777;4229.97885010573;4233.195692818385;4236.894077648052;4255.27660297747;5853.239078919756;5897.764089436418;5904.439078287599;5913.290405151366;5920.230370051909;4132.710710250253;4291.935620965688;4323.178596066738;4331.242032644274;4332.090261045153;4357.302831546937;4361.127774445124;4376.102898905717;4377.314733827499;4384.94761257296;4910.705357678551;4916.582090522345;4925.374626373288;4927.507249275115;4936.185529387611;5556.333240011225;5643.80246691372;5721.656700597978;5741.88516229673;5742.827715168468;1498.3407300787837;1507.125866997139;1507.4648499782638;1517.1958861803262;1519.156867938305;936.6663373184549;963.4315753705207;973.7127547373542;978.5449765858909;978.8727465429448;4875.293082503017;4895.412550493964;4900.897298107969;4914.002458500312;4948;5090.618203634742;5119.977608844486;5141.203113517411;5152.433232344439;5161.458046905096;4591.334256532784;4854.034116182952;4856.198727210041;4911.22515778584;4923.236898280772;2723.482538317713;2726.304792277996;2728.5497892847457;2737.534619114755;2737.617503160931;5268.394134674485;5280.973595132076;5293.444188360244;5327.813526526553;5371.884307101872;5265.289185959847;5315.309009828775;5651.011073062197;6061.757529698851;6081.5134789217645;6154.476869466056;6157.953147964857;6164.630122192682;6166.568340216142;6173.413525715139;5648.378678345461;5967.283925928743;5967.671778052249;6009;6029.397060293935;5855.677937713466;5875.236219291465;5885.264341957255;5900.43945825146;5906.940930590639;6117.828170999409;6154.415330543591;6156.753729850756;6158.692065396802;6164.4760195382105;4007.9779656187484;4068.6948478864797;4204.831806727697;4240.957590424056;4248.383984322318;5853.268341457318;5865.853353666022;5870.090136028923;5871.178035075179;5877.706114694162;5617.915731264116;5675.772969081356;5706.714664266853;5746.511546518593;5766.481016708516;5682.914756278742;5713.9428605715075;5718.885622287614;5723.599348045597;5723.8569035774435;5652.378238393856;5660.518855897295;5671.858203544944;5687.800926967537;5689.8862022758485;5518.365387980273;5687.289088863892;5713.200151978809;5752.913706294493;5755.165501002415;5559.16612508127;5586.916196257141;5596.076647353141;5603.439656034364;5628.943710562842 04:09:30 INFO - PROCESS | 18624 | |5;yui.html;814.9470284431511;849.6813694864426;852.7186028610558;865.1651156633847;906.809569990302;16836.57908552287;18148.546286342847;18265.634687306247;18416.81583184168;18434.44696659099;15445.922770386132;15543.06741595505;15544.68910621787;16590.25343859526;17101.0594417307;856.9614367353469;857.348415204446;857.4640849469082;857.939944203906;858.7895965488464;711.6904146696178;727.8798998165296;852.0840096895831;866.1684782608671;880.7533890510667;928.8420968435382;930.7486978515797;933.9906600934006;934.8083642853233;935.1163150822475;919.1038737231213;919.462114662923;921.1985572551889;921.3688623293032;921.5162039929024;557.7629507459313;567.3050513121434;654.6661202786613;666.2637785247281;681.8465845184843;16519.174041297887;16538.338466461326;16565.751513727184;16570.751438728308;16572.419965301156;14850.777238341434;15258.771118433233;15453;15511;15920.76118858218;13696.93151534236;14130.788038179435;14386.424543018267;14480.203588802611;14499.275036248251;4800.615950723934;4831.492693267227;4874.756262186912;4896.387951506062;5013.924791128136;83263;87322;87819.56090219508;87954.1204587946;88444.55777721135;12566.81149782754;12676.80984785229;13109.868901311056;13232;13754.243516606683;24209.878950605133;24227.878860605935;24276;24376.512469750505;24628.876855615606;8643.222110010129;8665.826683466295;8676.175763302475;8698.086700896441;8877.42296750722;4849.9030019399415;4863.683860549053;4910.165271903785;4942.728149951715;5117.283580298761;3673.430618254175;3796.449514820391;3796.5823759386444;3810.504634397566;3810.5617853946596;649.9252585952581;671.2716702377877;686.9381755641916;688.2704333406505;698.6995591895433;743.3087228877088;779.839843633133;797.3860127701753;810.9310708589836;828.341468532506;10537.157027437786;10629.9468502657;10946.39794811293;11305.208635395444;11355.772884542428;662.0268205737558;679.0832376291967;711.8042538301905;761.1133030020076;790.7825348029338;4590.42619672541;5049.368828896388;5338.626296159232;5371.382291036581;5387.542058924957;85754.14245857587;114647.42676286565;127020;128540;129420.58766180168;108018;109611.45194273978;110882;111524.44237778759;111773;93276.0672393281;94824;96778;97133.5143324293;98895.50552247193;9801.11789938909;9908.504574771378;9955.20358371343;10040.548175331982;10128.746781330527;52980.73509632427;54265.3720388389;54448.45551544592;54655.180172296656;56299;48274.517254827006;48549.27176092432;54354.72822635862;82962.58518707368;84198.57900710458;12747.61757147287;13111.344432778133;13648.522301719393;13695;13967.4413023482;15666.37334506607;15767.975081619657;16522.917385412995;16726.330946761995;16737.33050677959;14599;14852.405903763729;15359.308831102404;15792.76310855361;15957.44148954781;12875.227486350848;13433.395497202844;14809.33357998871;15130.621734456727;15562.455314063953;14526.346314415665;14549.490767823076;14645.853541464876;14900.0314979526;15402.922985385001;12058.698532536757;12591.748165036464;12818.871811281768;13332.733345332845;13386.598402047954;12471.563495277622;12644;12783.80824287655;12832.165909215872;13085.0840441172 04:09:30 INFO - PROCESS | 18624 | __end_tp_report 04:09:30 INFO - PROCESS | 18624 | __start_cc_report 04:09:30 INFO - PROCESS | 18624 | _x_x_mozilla_cycle_collect,904 04:09:30 INFO - PROCESS | 18624 | __end_cc_report 04:09:30 INFO - PROCESS | 18624 | __startTimestamp1477393770117__endTimestamp 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | ------- Summary: start ------- 04:09:30 INFO - PROCESS | 18624 | Number of tests: 6 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | [#0] dojo.html Cycles:165 Average:5563.88 Median:5753.42 stddev:641.91 (11.2%) stddev-sans-first:614.57 04:09:30 INFO - PROCESS | 18624 | Values: 3119.4 3160.1 3170.2 3193.6 3216.4 5488.6 5550.5 5598.7 5608.0 5618.8 5615.6 5633.1 5662.1 5672.9 5684.1 5098.7 5118.8 5139.3 5197.9 5216.1 4994.7 5160.6 5203.8 5211.6 5212.5 4965.3 5061.6 5065.1 5092.8 5109.4 5083.7 5115.3 5121.3 5183.7 5204.1 5000.6 5082.6 5143.9 5151.2 5157.8 5383.7 5413.0 5464.6 5482.0 5486.1 5880.9 5893.5 5902.1 5999.5 6001.1 6021.5 6029.9 6031.1 6038.2 6038.4 5466.3 5496.3 5528.5 5561.9 5574.9 6133.6 6171.3 6171.8 6173.3 6180.2 5905.8 5913.2 5913.6 5915.5 5916.0 5734.4 5767.9 5925.6 5955.7 5964.6 5956.9 5958.3 5963.4 6030.5 6050.2 5913.9 5970.7 5973.6 5974.3 5996.3 4459.9 4486.6 4491.3 4543.3 4595.5 4049.3 4072.9 4074.8 4093.5 4095.0 5678.7 5683.3 5692.1 5701.6 5726.7 5822.5 5854.6 5928.7 5954.4 5989.7 5718.5 5735.5 5735.8 5737.9 5750.9 5228.3 5235.3 5236.7 5236.8 5239.8 6022.9 6035.4 6149.3 6237.1 6249.4 6014.1 6123.4 6129.5 6131.6 6134.2 6256.5 6295.2 6299.9 6302.3 6304.3 5714.5 5772.9 5950.8 5997.2 6007.1 5928.8 5945.7 5961.7 6035.9 6068.6 5893.7 5895.3 5899.1 5899.8 5905.4 5654.2 5885.2 5897.2 5898.9 5901.7 5654.2 5749.5 5753.4 5760.9 5889.6 5896.0 5928.6 5944.0 5948.4 5950.4 5600.6 5649.8 5780.4 5788.2 5788.5 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | [#1] ext.html Cycles:180 Average:65465.00 Median:22302.64 stddev:130281.09 (584.2%) stddev-sans-first:130555.49 04:09:30 INFO - PROCESS | 18624 | Values: 584.1 625.9 652.5 661.8 670.0 34789.5 45437.5 45650.8 45754.1 46052.5 47654.8 48195.0 48262.3 48298.6 48302.0 8388.7 9359.0 9515.7 9518.1 9519.6 8341.6 11048.5 11259.9 11294.7 11656.5 11320.0 11366.5 11389.8 11403.1 11406.7 11154.4 11188.3 11211.2 11243.2 11246.3 11036.0 11080.6 11093.2 11096.1 11128.7 44329.6 44628.6 44628.8 44716.0 44719.8 3902.5 3975.9 4015.9 4103.3 4664.9 34159.7 34245.5 34529.1 34813.3 36770.6 4423.5 4525.2 4557.1 4595.1 4599.2 365075.0 365909.0 366454.0 366486.0 367548.0 65605.0 65638.7 65987.7 66208.3 66273.3 40940.8 41582.0 68802.3 68926.7 69003.7 19383.9 19554.7 19559.7 19567.5 19570.7 13418.1 13770.2 14154.4 14805.9 15002.8 19822.4 20967.0 21120.9 21238.9 21315.1 7611.7 7633.8 7641.4 7728.3 7775.2 1049.0 1070.0 1099.6 1132.4 1165.5 34290.8 34644.8 35110.6 35122.8 35125.8 1136.2 1165.1 1232.1 1243.9 1245.3 17427.0 18244.0 18345.9 18397.4 18434.2 620786.0 622730.0 625285.0 627256.0 628002.0 64372.7 65262.0 65427.0 65561.3 65568.0 1350.9 1399.2 1423.4 1464.9 1468.9 30073.7 34179.3 34883.5 35093.5 35247.6 54861.7 55456.2 55514.4 55543.2 55553.2 442677.0 445056.0 445248.0 445663.3 445982.0 30364.2 31044.5 31327.5 33165.3 33453.5 52352.7 52507.5 52814.5 52955.7 53616.5 43686.1 44808.8 44843.0 44989.3 46707.8 43378.0 44976.3 45397.8 45764.5 46207.8 43887.0 44317.6 44362.8 44779.8 44991.0 36636.5 38977.6 39927.8 40589.4 43952.8 29155.9 29722.7 29964.6 30061.0 30095.8 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | [#2] jquery.html Cycles:180 Average:29921.88 Median:11950.79 stddev:84057.97 (703.4%) stddev-sans-first:84264.54 04:09:30 INFO - PROCESS | 18624 | Values: 396.4 411.9 427.6 433.7 440.6 14947.4 19196.5 19363.7 20354.6 20500.7 18789.3 18999.8 19047.0 20313.0 21150.9 5825.2 6070.9 6073.1 6079.9 6085.8 5727.7 5930.3 5947.3 5950.2 5952.4 5775.5 5909.0 5914.9 5917.1 5952.6 5895.0 5962.7 5979.4 5986.3 6001.9 5259.7 5389.9 5394.8 5397.1 5517.2 13394.8 13520.4 13597.3 13626.5 21737.2 2361.4 2389.9 2449.3 2881.3 2986.9 9940.9 10053.6 10233.9 10262.7 10492.8 1962.3 1971.7 1997.8 2023.5 2033.1 85810.6 86214.6 88760.6 88822.6 88954.6 10128.6 10628.0 10705.8 11833.5 11979.5 15510.2 15865.3 16704.7 16745.4 17382.0 8461.0 8509.9 8512.9 8708.7 8730.1 7512.2 7970.1 8308.2 8468.2 8546.4 4985.7 5058.9 5071.8 5135.4 5270.4 2098.5 2099.6 2101.4 2131.2 2164.3 981.7 989.3 1005.5 1022.4 1040.2 19459.6 20282.5 20375.0 20402.9 20544.4 1005.7 1010.7 1020.3 1037.3 1043.1 10531.9 11256.5 11381.1 11385.8 11409.1 488643.0 496853.0 497230.0 524443.0 538156.0 59547.0 95277.0 98726.0 99526.0 99764.5 1076.6 1090.5 1118.1 1122.6 1132.7 18062.5 18405.3 18554.3 18609.2 18756.2 43174.1 44310.8 44345.1 44873.6 45506.0 60488.0 62473.0 62644.8 63121.0 63648.7 9083.0 9141.4 9164.5 9246.0 9346.7 10888.0 14000.3 14007.4 14382.2 14590.9 10820.4 11564.9 11857.8 12413.8 12460.8 11792.2 11962.0 12099.6 12127.0 12526.4 11930.5 12214.3 12281.4 12358.7 12492.2 8930.3 8988.4 9149.6 9171.5 9242.2 11333.2 12377.5 12451.1 12565.1 12636.4 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | [#3] mootools.html Cycles:180 Average:6269.59 Median:478.14 stddev:3615.03 (756.1%) stddev-sans-first:3606.59 04:09:30 INFO - PROCESS | 18624 | Values: 1392.4 1516.3 1549.6 1678.3 1839.9 8287.5 9028.0 9359.2 9365.6 9669.0 9391.8 9425.7 9440.7 9447.0 9458.0 2544.8 2559.6 2562.4 2563.4 2567.6 2460.2 2547.0 2548.1 2548.8 2549.2 2431.9 2438.1 2523.3 2532.8 2533.3 2471.1 2484.0 2494.9 2499.7 2503.2 2458.8 2469.1 2512.2 2515.2 2521.8 9504.1 9643.0 9662.2 9682.6 9698.1 5566.5 5779.0 5797.3 5849.6 5877.9 3833.5 3854.3 3862.5 3931.2 3938.6 1203.9 1206.5 1210.7 1241.0 1248.4 13163.7 13328.4 13449.5 13455.1 13529.5 4853.3 4870.3 4899.7 4971.9 5003.6 10480.4 10506.9 10517.2 10525.3 10553.2 5723.8 5731.4 5732.4 5734.2 5734.6 4678.4 4680.3 5319.0 5343.8 5361.7 4185.8 4192.9 4223.5 4223.5 4267.8 1280.6 1284.5 1295.6 1315.4 1316.7 905.2 941.7 1003.4 1054.9 1072.3 6349.3 6371.2 6484.6 6639.8 6717.6 471.7 484.6 496.3 496.7 501.1 4302.0 4376.1 4467.2 4470.1 4501.1 11549.1 11819.2 11947.6 11981.8 12028.9 11860.1 11884.0 11884.8 11900.9 12015.6 8503.7 8890.5 8910.2 8921.3 9139.9 6068.9 6227.5 6485.3 6541.4 6563.8 11089.9 11130.0 11189.3 11315.3 11476.7 11235.7 11295.3 11320.9 11615.5 11618.2 7519.4 7760.3 8294.3 8370.2 8660.4 9229.4 9515.3 9533.2 9535.1 9603.1 8320.3 8355.3 8452.5 8453.7 8456.5 8315.1 8385.7 8390.0 8414.7 8672.9 7706.0 7775.3 7849.3 7853.2 7881.0 5226.9 5254.3 5388.5 5427.3 5673.7 5457.4 5473.6 5524.9 5625.2 5640.3 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | [#4] prototype.html Cycles:180 Average:4754.63 Median:5295.23 stddev:1386.95 (26.2%) stddev-sans-first:1350.75 04:09:30 INFO - PROCESS | 18624 | Values: 343.9 344.4 347.4 354.0 360.4 5261.6 5455.2 5535.8 5590.7 5639.2 5263.9 5365.4 5407.4 5417.2 5434.5 4268.7 4332.2 4336.3 4338.6 4372.6 4145.5 4291.8 4315.9 4324.6 4374.4 4275.4 4286.3 4303.1 4309.5 4321.2 4278.5 4291.2 4300.7 4311.0 4320.4 3788.5 3856.4 3859.2 3882.9 3892.7 5297.0 5297.8 5305.9 5306.8 5308.2 4950.3 4950.6 4951.3 4961.7 4966.8 5460.9 5659.8 5695.5 5698.8 5708.9 4229.6 4230.0 4233.2 4236.9 4255.3 5853.2 5897.8 5904.4 5913.3 5920.2 4132.7 4291.9 4323.2 4331.2 4332.1 4357.3 4361.1 4376.1 4377.3 4384.9 4910.7 4916.6 4925.4 4927.5 4936.2 5556.3 5643.8 5721.7 5741.9 5742.8 1498.3 1507.1 1507.5 1517.2 1519.2 936.7 963.4 973.7 978.5 978.9 4875.3 4895.4 4900.9 4914.0 4948.0 5090.6 5120.0 5141.2 5152.4 5161.5 4591.3 4854.0 4856.2 4911.2 4923.2 2723.5 2726.3 2728.5 2737.5 2737.6 5268.4 5281.0 5293.4 5327.8 5371.9 5265.3 5315.3 5651.0 6061.8 6081.5 6154.5 6158.0 6164.6 6166.6 6173.4 5648.4 5967.3 5967.7 6009.0 6029.4 5855.7 5875.2 5885.3 5900.4 5906.9 6117.8 6154.4 6156.8 6158.7 6164.5 4008.0 4068.7 4204.8 4241.0 4248.4 5853.3 5865.9 5870.1 5871.2 5877.7 5617.9 5675.8 5706.7 5746.5 5766.5 5682.9 5713.9 5718.9 5723.6 5723.9 5652.4 5660.5 5671.9 5687.8 5689.9 5518.4 5687.3 5713.2 5752.9 5755.2 5559.2 5586.9 5596.1 5603.4 5628.9 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - PROCESS | 18624 | [#5] yui.html Cycles:180 Average:22272.71 Median:4200.49 stddev:31846.37 (758.2%) stddev-sans-first:31894.95 04:09:30 INFO - PROCESS | 18624 | Values: 814.9 849.7 852.7 865.2 906.8 16836.6 18148.5 18265.6 18416.8 18434.4 15445.9 15543.1 15544.7 16590.3 17101.1 857.0 857.3 857.5 857.9 858.8 711.7 727.9 852.1 866.2 880.8 928.8 930.7 934.0 934.8 935.1 919.1 919.5 921.2 921.4 921.5 557.8 567.3 654.7 666.3 681.8 16519.2 16538.3 16565.8 16570.8 16572.4 14850.8 15258.8 15453.0 15511.0 15920.8 13696.9 14130.8 14386.4 14480.2 14499.3 4800.6 4831.5 4874.8 4896.4 5013.9 83263.0 87322.0 87819.6 87954.1 88444.6 12566.8 12676.8 13109.9 13232.0 13754.2 24209.9 24227.9 24276.0 24376.5 24628.9 8643.2 8665.8 8676.2 8698.1 8877.4 4849.9 4863.7 4910.2 4942.7 5117.3 3673.4 3796.4 3796.6 3810.5 3810.6 649.9 671.3 686.9 688.3 698.7 743.3 779.8 797.4 810.9 828.3 10537.2 10629.9 10946.4 11305.2 11355.8 662.0 679.1 711.8 761.1 790.8 4590.4 5049.4 5338.6 5371.4 5387.5 85754.1 114647.4 127020.0 128540.0 129420.6 108018.0 109611.5 110882.0 111524.4 111773.0 93276.1 94824.0 96778.0 97133.5 98895.5 9801.1 9908.5 9955.2 10040.5 10128.7 52980.7 54265.4 54448.5 54655.2 56299.0 48274.5 48549.3 54354.7 82962.6 84198.6 12747.6 13111.3 13648.5 13695.0 13967.4 15666.4 15768.0 16522.9 16726.3 16737.3 14599.0 14852.4 15359.3 15792.8 15957.4 12875.2 13433.4 14809.3 15130.6 15562.5 14526.3 14549.5 14645.9 14900.0 15402.9 12058.7 12591.7 12818.9 13332.7 13386.6 12471.6 12644.0 12783.8 12832.2 13085.1 04:09:30 INFO - PROCESS | 18624 | -------- Summary: end -------- 04:09:30 INFO - PROCESS | 18624 | 04:09:30 INFO - TEST-INFO | 18624: exit 0 04:09:30 INFO - TEST-OK | dromaeo_css | took 1113076ms 04:09:30 INFO - TEST-START | kraken 04:09:30 INFO - operating with platform_type : linux_ 04:09:30 INFO - Initialising browser for kraken test... 04:09:30 INFO - TEST-INFO | started process 18942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnjJcw/profile http://localhost:44260/getInfo.html) 04:09:34 INFO - PROCESS | 18942 | __metrics Screen width/height:1600/1200 04:09:34 INFO - PROCESS | 18942 | colorDepth:24 04:09:34 INFO - PROCESS | 18942 | Browser inner width/height: 1024/697 04:09:34 INFO - PROCESS | 18942 | __metrics 04:09:35 INFO - PROCESS | 18942 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:09:35 INFO - PROCESS | 18942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:09:35 INFO - PROCESS | 18942 | console.error: PushService: 04:09:35 INFO - PROCESS | 18942 | stateChangeProcessEnqueue: Error transitioning state 04:09:35 INFO - PROCESS | 18942 | UnknownError 04:09:36 INFO - TEST-INFO | 18942: exit 0 04:09:36 INFO - Browser initialized. 04:09:36 INFO - Running cycle 1/1 for kraken test... 04:09:36 INFO - TEST-INFO | started process 19037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnjJcw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:47 INFO - PROCESS | 19037 | RSS: Main: 144957440 04:09:47 INFO - PROCESS | 19037 | 04:09:50 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44260/tests/kraken/driver.html?testName=audio-beat-detection) 04:09:51 INFO - PROCESS | 19037 | RSS: Main: 186544128 04:09:51 INFO - PROCESS | 19037 | 04:09:53 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44260/tests/kraken/driver.html?testName=audio-dft) 04:09:54 INFO - PROCESS | 19037 | RSS: Main: 175804416 04:09:54 INFO - PROCESS | 19037 | 04:09:57 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44260/tests/kraken/driver.html?testName=audio-fft) 04:09:57 INFO - PROCESS | 19037 | RSS: Main: 267096064 04:09:57 INFO - PROCESS | 19037 | 04:09:59 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44260/tests/kraken/driver.html?testName=audio-oscillator) 04:10:00 INFO - PROCESS | 19037 | RSS: Main: 173056000 04:10:00 INFO - PROCESS | 19037 | 04:10:02 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:03 INFO - PROCESS | 19037 | RSS: Main: 176017408 04:10:03 INFO - PROCESS | 19037 | 04:10:05 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44260/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:06 INFO - PROCESS | 19037 | RSS: Main: 211095552 04:10:06 INFO - PROCESS | 19037 | 04:10:09 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44260/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:10 INFO - PROCESS | 19037 | RSS: Main: 210329600 04:10:10 INFO - PROCESS | 19037 | 04:10:13 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44260/tests/kraken/driver.html?testName=json-parse-financial) 04:10:13 INFO - PROCESS | 19037 | RSS: Main: 209969152 04:10:13 INFO - PROCESS | 19037 | 04:10:15 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:15 INFO - PROCESS | 19037 | RSS: Main: 171356160 04:10:15 INFO - PROCESS | 19037 | 04:10:17 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:18 INFO - PROCESS | 19037 | RSS: Main: 180015104 04:10:18 INFO - PROCESS | 19037 | 04:10:20 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:20 INFO - PROCESS | 19037 | RSS: Main: 188383232 04:10:20 INFO - PROCESS | 19037 | 04:10:23 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:23 INFO - PROCESS | 19037 | RSS: Main: 196759552 04:10:23 INFO - PROCESS | 19037 | 04:10:26 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:27 INFO - PROCESS | 19037 | RSS: Main: 193187840 04:10:27 INFO - PROCESS | 19037 | 04:10:28 INFO - PROCESS | 19037 | Cycle 1(1): loaded http://localhost:44260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44260/tests/kraken/driver.html?testName=ai-astar) 04:10:29 INFO - PROCESS | 19037 | RSS: Main: 246071296 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | __start_tp_report 04:10:29 INFO - PROCESS | 19037 | _x_x_mozilla_page_load 04:10:29 INFO - PROCESS | 19037 | _x_x_mozilla_page_load_details 04:10:29 INFO - PROCESS | 19037 | |i|pagename|runs| 04:10:29 INFO - PROCESS | 19037 | |0;ai-astar;110;113;112;111;113;111;112;111;111;112 04:10:29 INFO - PROCESS | 19037 | |1;audio-beat-detection;141;123;123;159;118;122;116;122;143;116 04:10:29 INFO - PROCESS | 19037 | |2;audio-dft;160;162;161;160;161;160;159;161;161;160 04:10:29 INFO - PROCESS | 19037 | |3;audio-fft;75;77;77;117;75;75;75;75;98;75 04:10:29 INFO - PROCESS | 19037 | |4;audio-oscillator;82;82;110;81;81;82;100;80;81;103 04:10:29 INFO - PROCESS | 19037 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 04:10:29 INFO - PROCESS | 19037 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;145;147 04:10:29 INFO - PROCESS | 19037 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 04:10:29 INFO - PROCESS | 19037 | |8;json-parse-financial;50;49;49;50;48;48;49;50;49;49 04:10:29 INFO - PROCESS | 19037 | |9;json-stringify-tinderbox;58;59;59;59;59;59;59;59;59;58 04:10:29 INFO - PROCESS | 19037 | |10;stanford-crypto-aes;73;73;81;74;73;74;76;74;74;73 04:10:29 INFO - PROCESS | 19037 | |11;stanford-crypto-ccm;126;125;127;128;122;124;120;120;165;121 04:10:29 INFO - PROCESS | 19037 | |12;stanford-crypto-pbkdf2;150;154;154;151;155;154;155;157;156;152 04:10:29 INFO - PROCESS | 19037 | |13;stanford-crypto-sha256-iterative;67;62;61;63;60;65;60;62;61;64 04:10:29 INFO - PROCESS | 19037 | __end_tp_report 04:10:29 INFO - PROCESS | 19037 | __start_cc_report 04:10:29 INFO - PROCESS | 19037 | _x_x_mozilla_cycle_collect,1654 04:10:29 INFO - PROCESS | 19037 | __end_cc_report 04:10:29 INFO - PROCESS | 19037 | __startTimestamp1477393829148__endTimestamp 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | ------- Summary: start ------- 04:10:29 INFO - PROCESS | 19037 | Number of tests: 14 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:0.83 04:10:29 INFO - PROCESS | 19037 | Values: 110.0 113.0 112.0 111.0 113.0 111.0 112.0 111.0 111.0 112.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:123.00 stddev:14.39 (11.7%) stddev-sans-first:14.51 04:10:29 INFO - PROCESS | 19037 | Values: 141.0 123.0 123.0 159.0 118.0 122.0 116.0 122.0 143.0 116.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 04:10:29 INFO - PROCESS | 19037 | Values: 160.0 162.0 161.0 160.0 161.0 160.0 159.0 161.0 161.0 160.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.24 (19.0%) stddev-sans-first:14.88 04:10:29 INFO - PROCESS | 19037 | Values: 75.0 77.0 77.0 117.0 75.0 75.0 75.0 75.0 98.0 75.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:81.00 stddev:11.41 (14.1%) stddev-sans-first:11.88 04:10:29 INFO - PROCESS | 19037 | Values: 82.0 82.0 110.0 81.0 81.0 82.0 100.0 80.0 81.0 103.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:10:29 INFO - PROCESS | 19037 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:10:29 INFO - PROCESS | 19037 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:10:29 INFO - PROCESS | 19037 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:0.74 (1.5%) stddev-sans-first:0.71 04:10:29 INFO - PROCESS | 19037 | Values: 50.0 49.0 49.0 50.0 48.0 48.0 49.0 50.0 49.0 49.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 04:10:29 INFO - PROCESS | 19037 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.46 (3.3%) stddev-sans-first:2.55 04:10:29 INFO - PROCESS | 19037 | Values: 73.0 73.0 81.0 74.0 73.0 74.0 76.0 74.0 74.0 73.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:125.50 stddev:13.38 (10.7%) stddev-sans-first:14.18 04:10:29 INFO - PROCESS | 19037 | Values: 126.0 125.0 127.0 128.0 122.0 124.0 120.0 120.0 165.0 121.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:154.50 stddev:2.20 (1.4%) stddev-sans-first:1.86 04:10:29 INFO - PROCESS | 19037 | Values: 150.0 154.0 154.0 151.0 155.0 154.0 155.0 157.0 156.0 152.0 04:10:29 INFO - PROCESS | 19037 | 04:10:29 INFO - PROCESS | 19037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:2.27 (3.6%) stddev-sans-first:1.73 04:10:29 INFO - PROCESS | 19037 | Values: 67.0 62.0 61.0 63.0 60.0 65.0 60.0 62.0 61.0 64.0 04:10:29 INFO - PROCESS | 19037 | -------- Summary: end -------- 04:10:29 INFO - PROCESS | 19037 | 04:10:30 INFO - TEST-INFO | 19037: exit 0 04:10:30 INFO - TEST-OK | kraken | took 59181ms 04:10:30 INFO - SUITE-END | took 1172s 04:10:30 INFO - Completed test suite (00:19:32) 04:10:30 INFO - javascript benchmark 04:10:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.4385010698074, 3160.0677800048975, 3170.1757543038816, 3193.6486986431505, 3216.372807302577, 5488.615796894214, 5550.528205102566, 5598.664080155194, 5607.971960140204, 5618.77524899004, 5615.578831587627, 5633.126865335869, 5662.094064949599, 5672.886542269152, 5684.118961560955, 5098.745062746866, 5118.769655365499, 5139.306193663863, 5197.948020519803, 5216.087184742674, 4994.650374473788, 5160.612954028444, 5203.791848326063, 5211.557017653485, 5212.5308722214995, 4965.28003439501, 5061.569766569827, 5065.062963351773, 5092.8472145835685, 5109.437961824215, 5083.669561478492, 5115.335006449138, 5121.334226550562, 5183.740812959337, 5204.089284375257, 5000.649954503187, 5082.6188035897085, 5143.948560514385, 5151.150060240056, 5157.7936882524655, 5383.730813459311, 5413.02565538203, 5464.644798088111, 5482.0406428874785, 5486.1222204447095, 5880.852978675524, 5893.528517718572, 5902.085176797603, 5999.460048595603, 6001.129836173774, 6021.458068773832, 6029.939700602981, 6031.095335699636, 6038.154658347835, 6038.426349496791, 5466.316710411159, 5496.258005169331, 5528.530074943675, 5561.860953476114, 5574.86062848432, 6133.6319820810895, 6171.321154672983, 6171.814845554641, 6173.32093469718, 6180.165677633552, 5905.763769449174, 5913.201717768132, 5913.586048976616, 5915.526757859361, 5916.023856063702, 5734.369219385864, 5767.88464230713, 5925.585209035326, 5955.67243801595, 5964.612300200473, 5956.910646340309, 5958.314793798769, 5963.4334738199805, 6030.517558595302, 6050.213472248667, 5913.940860591425, 5970.671613061237, 5973.641581505037, 5974.312954010257, 5996.2504686914135, 4459.910801783946, 4486.641068714495, 4491.281394976788, 4543.318502224693, 4595.494495605481, 4049.2913740095364, 4072.9185416291507, 4074.837006519706, 4093.5497095319492, 4095.017195872969, 5678.687672177987, 5683.346415162227, 5692.089265717548, 5701.572382071278, 5726.656400615976, 5822.534197264209, 5854.619449735754, 5928.703564821742, 5954.374790647006, 5989.670568118708, 5718.485336319668, 5735.512481439125, 5735.827925162252, 5737.942620573825, 5750.88498230033, 5228.2680424740565, 5235.345581802275, 5236.738163091906, 5236.842894713165, 5239.835882133532, 6022.879542409128, 6035.366286539938, 6149.262088549223, 6237.064440333896, 6249.375062493805, 6014.097885317237, 6123.404636889863, 6129.450483693955, 6131.621347939075, 6134.191681014119, 6256.468200203034, 6295.18162638854, 6299.905501417391, 6302.275238347649, 6304.306526282197, 5714.485696287354, 5772.884542309214, 5950.821475355746, 5997.220361352996, 6007.068904319837, 5928.822135335947, 5945.732442040032, 5961.672108034099, 6035.939640603538, 6068.605540639845, 5893.70531473416, 5895.263092113486, 5899.056151015817, 5899.764009439575, 5905.43898329658, 5654.180143879197, 5885.205497257815, 5897.174395584536, 5898.941010590011, 5901.734421951109, 5654.236678048411, 5749.482546570829, 5753.424657534213, 5760.913586296293, 5889.587728858939, 5895.970520147372, 5928.614640048383, 5944.048952167633, 5948.405159484017, 5950.375210602998, 5600.551955843442, 5649.7740090397565, 5780.364159942319, 5788.247527821356, 5788.507976822018], "value": 5519.385396335228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.0625795598065, 625.8967270400384, 652.5269179844611, 661.75515059428, 669.9866002679944, 34789.47815782762, 45437.545624543745, 45650.771746141225, 45754.084918301654, 46052.53947460524, 47654.761726191406, 48195.0, 48262.27606585904, 48298.61909666325, 48302.0, 8388.706395276167, 9359.01730318317, 9515.714528564155, 9518.095780900803, 9519.619215231418, 8341.582920853964, 11048.502817373197, 11259.943700281528, 11294.661160165208, 11656.475458604384, 11320.037796787283, 11366.488508017117, 11389.772204555904, 11403.14476414268, 11406.657800265964, 11154.386508742016, 11188.272762270426, 11211.215214934999, 11243.156763242789, 11246.325220486715, 11036.0, 11080.556777728882, 11093.223474356799, 11096.11231101518, 11128.666140015812, 44329.55670443319, 44628.55371446277, 44628.77685611584, 44716.0, 44719.776401117786, 3902.5267511914417, 3975.9006024849323, 4015.8795236142964, 4103.281925662997, 4664.883377915546, 34159.65840341614, 34245.486317705254, 34529.13677158091, 34813.30373392543, 36770.632293677256, 4423.491298500681, 4525.162844873676, 4557.082989080105, 4595.103954728829, 4599.172149013176, 365075.0, 365909.0, 366453.9999999973, 366486.0, 367548.0, 65605.0, 65638.67180664066, 65987.67006164939, 66208.33791662118, 66273.33726662768, 40940.79529602393, 41582.0, 68802.31197688059, 68926.65536672284, 69003.65498172578, 19383.903080484506, 19554.70667939982, 19559.706604400944, 19567.510812229808, 19570.70643940342, 13418.127821691558, 13770.242636654879, 14154.36305366261, 14805.851941480663, 15002.774958375632, 19822.405327840188, 20967.0, 21120.894395527925, 21238.89380553087, 21315.147394104373, 7611.733589324458, 7633.809154771176, 7641.3886889048745, 7728.26581474759, 7775.183605721431, 1048.984265236022, 1069.989300106989, 1099.5931505342915, 1132.4281237974935, 1165.4871856383165, 34290.82854585711, 34644.82677586596, 35110.64889351125, 35122.82438587791, 35125.824370877985, 1136.1933027550367, 1165.0854079547514, 1232.143660156183, 1243.900487960979, 1245.265293476853, 17427.0, 18244.0, 18345.908270458563, 18397.448076557725, 18434.170462329228, 620786.0, 622730.0, 625285.0, 627256.0, 628002.0, 64372.678136609014, 65262.0, 65427.0, 65561.34438655648, 65568.0, 1350.8716671916152, 1399.2094466626324, 1423.4448565059636, 1464.8754855837374, 1468.8824894008667, 30073.699263007966, 34179.31641367109, 34883.47674784931, 35093.47359789554, 35247.647523524436, 54861.725691371284, 55456.168157476866, 55514.44485555093, 55543.166852498056, 55553.16670249869, 442677.0, 445056.0, 445248.0, 445663.315050281, 445982.0, 30364.24089397783, 31044.53433198549, 31327.53008704917, 33165.34173291278, 33453.498197527544, 52352.73823630858, 52507.47492525179, 52814.47185528249, 52955.735221323645, 53616.463835361144, 43686.126277474905, 44808.77595612001, 44843.0, 44989.32516012328, 46707.76646116748, 43378.0, 44976.32535511904, 45397.773011134734, 45764.54235457603, 46207.76896115498, 43887.0, 44317.55682443134, 44362.778186108866, 44779.776101119285, 44991.0, 36636.45045324269, 38977.6102238974, 39927.80036099801, 40589.39115913323, 43952.78023609862, 29155.916143433547, 29722.702772971992, 29964.550531742476, 30061.0, 30095.849520752257], "value": 22109.035119504984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.39945482593856, 411.91555731075135, 427.55747801025933, 433.6985794872564, 440.6276696191717, 14947.402103915843, 19196.520086997833, 19363.70954435683, 20354.59290814183, 20500.69248961267, 18789.34237301695, 18999.810001899976, 19047.0, 20313.0, 21150.89424552879, 5825.155352473878, 6070.939290607082, 6073.058675905242, 6079.939200608003, 6085.813266413052, 5727.684977326246, 5930.288365396159, 5947.345791962881, 5950.166976623276, 5952.4047595240345, 5775.480206781389, 5909.025010873201, 5914.88170236595, 5917.142014407908, 5952.55355848311, 5895.0, 5962.731677074542, 5979.372165922581, 5986.28164620244, 6001.909971350433, 5259.737013149365, 5389.865253368658, 5394.757235924393, 5397.109476936301, 5517.227588137664, 13394.799078013837, 13520.391582378816, 13597.252151131685, 13626.523071692542, 21737.2391966282, 2361.350628577155, 2389.940251493709, 2449.3141920262356, 2881.27968007998, 2986.9396364290583, 9940.90059099407, 10053.597856085747, 10233.89766102337, 10262.7434314142, 10492.79014419715, 1962.2837664252445, 1971.7338159348449, 1997.8113022751586, 2023.5244717491378, 2033.146078646957, 85810.57094714549, 86214.56892715496, 88760.55619721925, 88822.55588722015, 88954.55522722345, 10128.645497407555, 10628.0, 10705.839412408664, 11833.526658933719, 11979.520819167135, 15510.224488775517, 15865.286062127232, 16704.74942875858, 16745.413910513074, 17382.0, 8461.0, 8509.914900851036, 8512.914870851213, 8708.651653933899, 8730.126987301219, 7512.173660897297, 7970.123286438487, 8308.169183081643, 8468.153184681483, 8546.35902307317, 4985.725785081783, 5058.9494105058475, 5071.822486212965, 5135.430875541463, 5270.420253772082, 2098.5068508900395, 2099.632564301241, 2101.3905967269625, 2131.232756207795, 2164.3466546924237, 981.6956743409565, 989.2531138990016, 1005.5123265216511, 1022.4172221833633, 1040.193849766437, 19459.610807784047, 20282.492937676678, 20375.0, 20402.89798550998, 20544.38366848967, 1005.6681295172575, 1010.6917390196061, 1020.3112898793285, 1037.2946396450486, 1043.0925095167254, 10531.894681053245, 11256.549738010552, 11381.146414018982, 11385.772284554429, 11409.14431417647, 488643.0, 496853.0, 497230.0, 524443.0, 538156.0, 59547.0, 95277.0, 98726.0, 99526.0, 99764.5011774951, 1076.580133747839, 1090.4929207918196, 1118.072000239799, 1122.629532254354, 1132.7111586545377, 18062.458126256235, 18405.263789448272, 18554.25782968666, 18609.162587683317, 18756.155972980974, 43174.136517270104, 44310.778446107564, 44345.11309773851, 44873.55126448694, 45506.0, 60488.0, 62473.0, 62644.76110980536, 63121.0, 63648.68175659092, 9083.0, 9141.405808622418, 9164.450132992042, 9245.953770231106, 9346.672866449642, 10888.0, 14000.299985000913, 14007.439702412197, 14382.208978505863, 14590.92704536513, 10820.350778953289, 11564.884351156381, 11857.822132667845, 12413.75172496563, 12460.750784984068, 11792.23350482216, 11962.0, 12099.637010889688, 12127.0, 12526.436310366238, 11930.463129159381, 12214.26714397139, 12281.44733487013, 12358.691032724253, 12492.188007779465, 8930.330225233003, 8988.370814043215, 9149.63401463934, 9171.541422928693, 9242.168204861595, 11333.206675532634, 12377.51469823627, 12451.128421010804, 12565.057620678303, 12636.368181591068], "value": 9495.06772534716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.4291040673327, 1516.3100789140942, 1549.6280892585778, 1678.303504045821, 1839.8804077734947, 8287.46131501452, 9027.954860225698, 9359.157675809176, 9365.625374984993, 9669.0, 9391.765205869857, 9425.71722848314, 9440.669576564822, 9446.952765236165, 9457.952710236439, 2544.796416286702, 2559.603261494462, 2562.4362640219215, 2563.436044070311, 2567.550678631241, 2460.1758410932357, 2547.0448581781834, 2548.0826902315152, 2548.7706106450414, 2549.247971848309, 2431.902723891042, 2438.1344622658967, 2523.3187039499326, 2532.8100392470546, 2533.328667903007, 2471.0733474946896, 2483.987580062088, 2494.8627825469594, 2499.7000359956924, 2503.236512863576, 2458.8032957363366, 2469.061756532524, 2512.196097248881, 2515.207709571479, 2521.810864185175, 9504.144626983536, 9643.035696430372, 9662.227021838236, 9682.56428460721, 9698.078682525149, 5566.4990150886615, 5778.971105144489, 5797.275340582427, 5849.649021058707, 5877.9412205877825, 3833.5016447861876, 3854.3062248795204, 3862.4978752761963, 3931.2137572485617, 3938.6061393860673, 1203.8615559210716, 1206.4510647655384, 1210.703377672467, 1240.962771116868, 1248.36333469931, 13163.736725265537, 13328.400221990034, 13449.529266475723, 13455.125416847874, 13529.458821647122, 4853.320535125085, 4870.26945958102, 4899.657024008286, 4971.850844474671, 5003.574696150868, 10480.371177729361, 10506.947465262625, 10517.158627309796, 10525.26323157387, 10553.208509361675, 5723.828285151369, 5731.426857314235, 5732.369439361667, 5734.168545560954, 5734.627249228787, 4678.438587369537, 4680.251159814414, 5319.042572337016, 5343.812966546152, 5361.678299302054, 4185.811638476215, 4192.888804867538, 4223.450951376363, 4223.535411104776, 4267.76527291002, 1280.6286177008562, 1284.543986884661, 1295.6242689620094, 1315.3883444198493, 1316.6839958409912, 905.2486436258022, 941.6892425499568, 1003.372891942536, 1054.855481802253, 1072.292287090532, 6349.333320001426, 6371.171747672865, 6484.578502397329, 6639.834004149839, 6717.56335838169, 471.68632859148966, 484.60020483101584, 496.2506615011359, 496.6597880451902, 501.1255359397874, 4301.956980430218, 4376.081022985145, 4467.1586241665655, 4470.128324976598, 4501.144782491317, 11549.13381496391, 11819.172657913863, 11947.581834635746, 11981.820272695917, 12028.939855300667, 11860.110491713156, 11884.0, 11884.762304753856, 11900.88099119015, 12015.579454719043, 8503.65985360591, 8890.511021893728, 8910.153535414125, 8921.330900182382, 9139.90860091404, 6068.908966365596, 6227.50179985591, 6485.28661847187, 6541.411272985454, 6563.818512667574, 11089.944550277198, 11130.0, 11189.328640281608, 11315.264507806965, 11476.713082173012, 11235.71910702239, 11295.2658077228, 11320.943395282971, 11615.535378584762, 11618.244814087057, 7519.43604229674, 7760.262775036363, 8294.29498492635, 8370.204830541088, 8660.39377243587, 9229.446233226028, 9515.286353523376, 9533.23734101284, 9535.141837234682, 9603.135717785433, 8320.292775114183, 8355.289800367036, 8452.492850428995, 8453.66185352579, 8456.534890581077, 8315.12691167443, 8385.664573416994, 8390.0, 8414.747557573282, 8672.913270867211, 7706.0, 7775.261350171724, 7849.254320839511, 7853.214678532101, 7881.0, 5226.869328266672, 5254.290670759398, 5388.4879597251565, 5427.294451721251, 5673.716314184357, 5457.426970168075, 5473.616846820684, 5524.944750552604, 5625.240592519957, 5640.266765320482], "value": 4907.55393425448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9415299399102, 344.3904289407748, 347.418074724836, 354.03172323694696, 360.44491483115996, 5261.631685781997, 5455.208994695777, 5535.806246781363, 5590.692511911843, 5639.182318563811, 5263.921041184376, 5365.436629153932, 5407.3781515125775, 5417.160340147274, 5434.456554344573, 4268.658507319423, 4332.220200363933, 4336.327869180266, 4338.631216346615, 4372.628326592244, 4145.481814773153, 4291.806868690901, 4315.913681726363, 4324.589164029428, 4374.365716971038, 4275.444192255002, 4286.314189729644, 4303.053328267792, 4309.525952145262, 4321.222180007613, 4278.507971583276, 4291.206126866539, 4300.6774491913075, 4310.956890431118, 4320.373545835836, 3788.5264341957254, 3856.3636999894984, 3859.1509867829313, 3882.864099756495, 3892.6691231245377, 5297.020051290524, 5297.788088476456, 5305.867353316159, 5306.7611957462, 5308.23030660552, 4950.2822090796635, 4950.554450099472, 4951.257311403282, 4961.677490963112, 4966.826161084345, 5460.863478413032, 5659.830205093854, 5695.515881150107, 5698.800541981011, 5708.942910570924, 4229.577042295777, 4229.97885010573, 4233.195692818385, 4236.894077648052, 4255.27660297747, 5853.239078919756, 5897.764089436418, 5904.439078287599, 5913.290405151366, 5920.230370051909, 4132.710710250253, 4291.935620965688, 4323.178596066738, 4331.242032644274, 4332.090261045153, 4357.302831546937, 4361.127774445124, 4376.102898905717, 4377.314733827499, 4384.94761257296, 4910.705357678551, 4916.582090522345, 4925.374626373288, 4927.507249275115, 4936.185529387611, 5556.333240011225, 5643.80246691372, 5721.656700597978, 5741.88516229673, 5742.827715168468, 1498.3407300787837, 1507.125866997139, 1507.4648499782638, 1517.1958861803262, 1519.156867938305, 936.6663373184549, 963.4315753705207, 973.7127547373542, 978.5449765858909, 978.8727465429448, 4875.293082503017, 4895.412550493964, 4900.897298107969, 4914.002458500312, 4948.0, 5090.618203634742, 5119.977608844486, 5141.203113517411, 5152.433232344439, 5161.458046905096, 4591.334256532784, 4854.034116182952, 4856.198727210041, 4911.22515778584, 4923.236898280772, 2723.482538317713, 2726.304792277996, 2728.5497892847457, 2737.534619114755, 2737.617503160931, 5268.394134674485, 5280.973595132076, 5293.444188360244, 5327.813526526553, 5371.884307101872, 5265.289185959847, 5315.309009828775, 5651.011073062197, 6061.757529698851, 6081.5134789217645, 6154.476869466056, 6157.953147964857, 6164.630122192682, 6166.568340216142, 6173.413525715139, 5648.378678345461, 5967.283925928743, 5967.671778052249, 6009.0, 6029.397060293935, 5855.677937713466, 5875.236219291465, 5885.264341957255, 5900.43945825146, 5906.940930590639, 6117.828170999409, 6154.415330543591, 6156.753729850756, 6158.692065396802, 6164.4760195382105, 4007.9779656187484, 4068.6948478864797, 4204.831806727697, 4240.957590424056, 4248.383984322318, 5853.268341457318, 5865.853353666022, 5870.090136028923, 5871.178035075179, 5877.706114694162, 5617.915731264116, 5675.772969081356, 5706.714664266853, 5746.511546518593, 5766.481016708516, 5682.914756278742, 5713.9428605715075, 5718.885622287614, 5723.599348045597, 5723.8569035774435, 5652.378238393856, 5660.518855897295, 5671.858203544944, 5687.800926967537, 5689.8862022758485, 5518.365387980273, 5687.289088863892, 5713.200151978809, 5752.913706294493, 5755.165501002415, 5559.16612508127, 5586.916196257141, 5596.076647353141, 5603.439656034364, 5628.943710562842], "value": 4317.250655717036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.9470284431511, 849.6813694864426, 852.7186028610558, 865.1651156633847, 906.809569990302, 16836.57908552287, 18148.546286342847, 18265.634687306247, 18416.81583184168, 18434.44696659099, 15445.922770386132, 15543.06741595505, 15544.68910621787, 16590.25343859526, 17101.0594417307, 856.9614367353469, 857.348415204446, 857.4640849469082, 857.939944203906, 858.7895965488464, 711.6904146696178, 727.8798998165296, 852.0840096895831, 866.1684782608671, 880.7533890510667, 928.8420968435382, 930.7486978515797, 933.9906600934006, 934.8083642853233, 935.1163150822475, 919.1038737231213, 919.462114662923, 921.1985572551889, 921.3688623293032, 921.5162039929024, 557.7629507459313, 567.3050513121434, 654.6661202786613, 666.2637785247281, 681.8465845184843, 16519.174041297887, 16538.338466461326, 16565.751513727184, 16570.751438728308, 16572.419965301156, 14850.777238341434, 15258.771118433233, 15453.0, 15511.0, 15920.76118858218, 13696.93151534236, 14130.788038179435, 14386.424543018267, 14480.203588802611, 14499.275036248251, 4800.615950723934, 4831.492693267227, 4874.756262186912, 4896.387951506062, 5013.924791128136, 83263.0, 87322.0, 87819.56090219508, 87954.1204587946, 88444.55777721135, 12566.81149782754, 12676.80984785229, 13109.868901311056, 13232.0, 13754.243516606683, 24209.878950605133, 24227.878860605935, 24276.0, 24376.512469750505, 24628.876855615606, 8643.222110010129, 8665.826683466295, 8676.175763302475, 8698.086700896441, 8877.42296750722, 4849.9030019399415, 4863.683860549053, 4910.165271903785, 4942.728149951715, 5117.283580298761, 3673.430618254175, 3796.449514820391, 3796.5823759386444, 3810.504634397566, 3810.5617853946596, 649.9252585952581, 671.2716702377877, 686.9381755641916, 688.2704333406505, 698.6995591895433, 743.3087228877088, 779.839843633133, 797.3860127701753, 810.9310708589836, 828.341468532506, 10537.157027437786, 10629.9468502657, 10946.39794811293, 11305.208635395444, 11355.772884542428, 662.0268205737558, 679.0832376291967, 711.8042538301905, 761.1133030020076, 790.7825348029338, 4590.42619672541, 5049.368828896388, 5338.626296159232, 5371.382291036581, 5387.542058924957, 85754.14245857587, 114647.42676286565, 127020.0, 128540.0, 129420.58766180168, 108018.0, 109611.45194273978, 110882.0, 111524.44237778759, 111773.0, 93276.0672393281, 94824.0, 96778.0, 97133.5143324293, 98895.50552247193, 9801.11789938909, 9908.504574771378, 9955.20358371343, 10040.548175331982, 10128.746781330527, 52980.73509632427, 54265.3720388389, 54448.45551544592, 54655.180172296656, 56299.0, 48274.517254827006, 48549.27176092432, 54354.72822635862, 82962.58518707368, 84198.57900710458, 12747.61757147287, 13111.344432778133, 13648.522301719393, 13695.0, 13967.4413023482, 15666.37334506607, 15767.975081619657, 16522.917385412995, 16726.330946761995, 16737.33050677959, 14599.0, 14852.405903763729, 15359.308831102404, 15792.76310855361, 15957.44148954781, 12875.227486350848, 13433.395497202844, 14809.33357998871, 15130.621734456727, 15562.455314063953, 14526.346314415665, 14549.490767823076, 14645.853541464876, 14900.0314979526, 15402.922985385001, 12058.698532536757, 12591.748165036464, 12818.871811281768, 13332.733345332845, 13386.598402047954, 12471.563495277622, 12644.0, 12783.80824287655, 12832.165909215872, 13085.0840441172], "value": 8207.041997037742, "unit": "score"}], "name": "dromaeo_css", "value": 7656.739758404501, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 112.0, 111.0, 113.0, 111.0, 112.0, 111.0, 111.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 123.0, 123.0, 159.0, 118.0, 122.0, 116.0, 122.0, 143.0, 116.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 159.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 117.0, 75.0, 75.0, 75.0, 75.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 81.0, 81.0, 82.0, 100.0, 80.0, 81.0, 103.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 50.0, 48.0, 48.0, 49.0, 50.0, 49.0, 49.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 81.0, 74.0, 73.0, 74.0, 76.0, 74.0, 74.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 127.0, 128.0, 122.0, 124.0, 120.0, 120.0, 165.0, 121.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 154.0, 151.0, 155.0, 154.0, 155.0, 157.0, 156.0, 152.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 61.0, 63.0, 60.0, 65.0, 60.0, 62.0, 61.0, 64.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1454.8999999999999, "alertThreshold": 2.0}]} 04:10:30 INFO - Return code: 0 04:10:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:10:30 INFO - # TBPL SUCCESS # 04:10:30 INFO - Running post-action listener: _resource_record_post_action 04:10:30 INFO - [mozharness: 2016-10-25 11:10:30.440000Z] Finished run-tests step (success) 04:10:30 INFO - Running post-run listener: _resource_record_post_run 04:10:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355770368; Read time: 16; Write time: 203588 04:10:30 INFO - TinderboxPrint: CPU usage
13.0% 04:10:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:10:30 INFO - TinderboxPrint: I/O write bytes / time
355,770,368 / 203,588 04:10:30 INFO - TinderboxPrint: CPU idle
8,259.4 (87.0%) 04:10:30 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 04:10:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:10:30 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107352064; Read time: 0; Write time: 92572 04:10:30 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 247525376; Read time: 0; Write time: 110996 04:10:31 INFO - Running post-run listener: _upload_blobber_files 04:10:31 INFO - Blob upload gear active. 04:10:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:10:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:10:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:10:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:34 INFO - (blobuploader) - INFO - Done attempting. 04:10:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:10:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:10:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:36 INFO - (blobuploader) - INFO - Done attempting. 04:10:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:10:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:10:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:37 INFO - (blobuploader) - INFO - Done attempting. 04:10:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:10:37 INFO - Return code: 0 04:10:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:10:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:10:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8176113fbbe7373bfdf986e5345bbb3e5a49df6eaa9ee739f400da80b4389fc52cd58d6df3917d3def45632ee199f098666e7b6e77fab9a8685392843f087915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e88d0e41d5de64de89783f176f4ee70e3c68d9fd42b0753df085d84b4fb07487d9ef24c477a34e3ca012c1ed8674126e3f9fad075caf749b088f782580c9760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fefe756bb5cc77fa96fed02d96b4a420654151f4507e18c30d03e74b3add20d2de85fe2f2b73d6cb37cbdcaf49a633fa4ee5ed49f81cbf961be8e53a4b31e84"} 04:10:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:10:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:10:37 INFO - Contents: 04:10:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8176113fbbe7373bfdf986e5345bbb3e5a49df6eaa9ee739f400da80b4389fc52cd58d6df3917d3def45632ee199f098666e7b6e77fab9a8685392843f087915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e88d0e41d5de64de89783f176f4ee70e3c68d9fd42b0753df085d84b4fb07487d9ef24c477a34e3ca012c1ed8674126e3f9fad075caf749b088f782580c9760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fefe756bb5cc77fa96fed02d96b4a420654151f4507e18c30d03e74b3add20d2de85fe2f2b73d6cb37cbdcaf49a633fa4ee5ed49f81cbf961be8e53a4b31e84"} 04:10:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:10:37 INFO - Copying logs to upload dir... 04:10:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:10:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.250777 ========= master_lag: 1.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-25 04:10:37.816074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 04:10:37.824934) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146 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/8176113fbbe7373bfdf986e5345bbb3e5a49df6eaa9ee739f400da80b4389fc52cd58d6df3917d3def45632ee199f098666e7b6e77fab9a8685392843f087915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e88d0e41d5de64de89783f176f4ee70e3c68d9fd42b0753df085d84b4fb07487d9ef24c477a34e3ca012c1ed8674126e3f9fad075caf749b088f782580c9760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fefe756bb5cc77fa96fed02d96b4a420654151f4507e18c30d03e74b3add20d2de85fe2f2b73d6cb37cbdcaf49a633fa4ee5ed49f81cbf961be8e53a4b31e84"} build_url:https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/RQc0RxagRqem0RK8MuZoZg/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/8176113fbbe7373bfdf986e5345bbb3e5a49df6eaa9ee739f400da80b4389fc52cd58d6df3917d3def45632ee199f098666e7b6e77fab9a8685392843f087915", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e88d0e41d5de64de89783f176f4ee70e3c68d9fd42b0753df085d84b4fb07487d9ef24c477a34e3ca012c1ed8674126e3f9fad075caf749b088f782580c9760", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fefe756bb5cc77fa96fed02d96b4a420654151f4507e18c30d03e74b3add20d2de85fe2f2b73d6cb37cbdcaf49a633fa4ee5ed49f81cbf961be8e53a4b31e84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 04:10:37.852031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 04:10:37.852401) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477392602.304970-478162146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 04:10:38.139960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 04:10:38.143328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 04:10:38.143682) ========= ========= Total master_lag: 1.87 =========