builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1482351306.89 results: success (0) buildid: 20161221103008 builduid: 339ae0b9d71a45a7b898b0178b32508e revision: 10a5e2fc24e4e24fbe115fb190bcc28df4627ee2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:06.893169) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:06.893648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:06.893959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:06.910873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:06.911282) ========= 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=3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 12:15:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.0M=0s 2016-12-21 12:15:07 (66.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:07.030872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:07.031186) ========= 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=3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:07.081099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 12:15:07.081463) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10a5e2fc24e4e24fbe115fb190bcc28df4627ee2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 10a5e2fc24e4e24fbe115fb190bcc28df4627ee2 --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=3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 12:15:07,137 truncating revision to first 12 chars 2016-12-21 12:15:07,138 Setting DEBUG logging. 2016-12-21 12:15:07,138 attempt 1/10 2016-12-21 12:15:07,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10a5e2fc24e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 12:15:07,854 unpacking tar archive at: mozilla-central-10a5e2fc24e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.995427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 12:15:08.090259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:08.090608) ========= script_repo_revision: 10a5e2fc24e4e24fbe115fb190bcc28df4627ee2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:08.090994) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:08.091259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 12:15:08.101071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-21 12:15:08.101483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:08 INFO - MultiFileLogger online at 20161221 12:15:08 in /builds/slave/test 12:15:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:15:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:08 INFO - {'append_to_log': False, 12:15:08 INFO - 'base_work_dir': '/builds/slave/test', 12:15:08 INFO - 'blob_upload_branch': 'Firefox', 12:15:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:08 INFO - 'branch': 'Firefox', 12:15:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:08 INFO - 'config_files': ('talos/linux_config.py',), 12:15:08 INFO - 'default_actions': ('clobber', 12:15:08 INFO - 'read-buildbot-config', 12:15:08 INFO - 'download-and-extract', 12:15:08 INFO - 'populate-webroot', 12:15:08 INFO - 'create-virtualenv', 12:15:08 INFO - 'install', 12:15:08 INFO - 'run-tests'), 12:15:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:08 INFO - 'download_minidump_stackwalk': True, 12:15:08 INFO - 'download_symbols': 'ondemand', 12:15:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:08 INFO - 'installer_path': 'installer.exe', 12:15:08 INFO - 'log_level': 'info', 12:15:08 INFO - 'log_name': 'talos', 12:15:08 INFO - 'log_to_console': True, 12:15:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:08 INFO - 'opt_config_files': (), 12:15:08 INFO - 'pip_index': False, 12:15:08 INFO - 'sps_profile': False, 12:15:08 INFO - 'sps_profile_interval': 0, 12:15:08 INFO - 'suite': 'dromaeojs', 12:15:08 INFO - 'system_bits': '32', 12:15:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:08 INFO - 'title': 'talos-linux64-ix-030', 12:15:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:08 INFO - 'use_talos_json': True, 12:15:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:08 INFO - 'work_dir': 'build'} 12:15:08 INFO - [mozharness: 2016-12-21 20:15:08.258779Z] Running clobber step. 12:15:08 INFO - Running pre-action listener: _resource_record_pre_action 12:15:08 INFO - Running main action method: clobber 12:15:08 INFO - rmtree: /builds/slave/test/build 12:15:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:09 INFO - Running post-action listener: _resource_record_post_action 12:15:09 INFO - [mozharness: 2016-12-21 20:15:09.304736Z] Finished clobber step (success) 12:15:09 INFO - [mozharness: 2016-12-21 20:15:09.304835Z] Running read-buildbot-config step. 12:15:09 INFO - Running pre-action listener: _resource_record_pre_action 12:15:09 INFO - Running main action method: read_buildbot_config 12:15:09 INFO - Using buildbot properties: 12:15:09 INFO - { 12:15:09 INFO - "project": "", 12:15:09 INFO - "product": "firefox", 12:15:09 INFO - "script_repo_revision": "production", 12:15:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:15:09 INFO - "repository": "", 12:15:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:15:09 INFO - "buildid": "20161221103008", 12:15:09 INFO - "pgo_build": "True", 12:15:09 INFO - "basedir": "/builds/slave/test", 12:15:09 INFO - "buildnumber": 138, 12:15:09 INFO - "slavename": "talos-linux64-ix-030", 12:15:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:15:09 INFO - "platform": "ubuntu64_hw", 12:15:09 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:15:09 INFO - "branch": "mozilla-central", 12:15:09 INFO - "repo_path": "mozilla-central", 12:15:09 INFO - "revision": "10a5e2fc24e4e24fbe115fb190bcc28df4627ee2", 12:15:09 INFO - "stage_platform": "linux64-pgo", 12:15:09 INFO - "builduid": "339ae0b9d71a45a7b898b0178b32508e", 12:15:09 INFO - "slavebuilddir": "test" 12:15:09 INFO - } 12:15:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:15:09 INFO - Running post-action listener: _resource_record_post_action 12:15:09 INFO - [mozharness: 2016-12-21 20:15:09.307353Z] Finished read-buildbot-config step (success) 12:15:09 INFO - [mozharness: 2016-12-21 20:15:09.307443Z] Running download-and-extract step. 12:15:09 INFO - Running pre-action listener: _resource_record_pre_action 12:15:09 INFO - Running main action method: download_and_extract 12:15:09 INFO - mkdir: /builds/slave/test/build/tests 12:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:09 INFO - trying https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:15:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:15:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:15:09 INFO - Downloaded 1361 bytes. 12:15:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:15:09 INFO - Using the following test package requirements: 12:15:09 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:09 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:15:09 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:15:09 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'jsshell-linux-x86_64.zip'], 12:15:09 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:15:09 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:09 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:15:09 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:15:09 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:15:09 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:15:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:15:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:15:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:15:11 INFO - Expected file size: 21843856 12:15:11 INFO - Obtained file size: 21843856 12:15:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:15:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:15:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:15:16 INFO - Expected file size: 21843856 12:15:16 INFO - Obtained file size: 21843856 12:15:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:15:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:15:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:15:22 INFO - Expected file size: 14409734 12:15:22 INFO - Obtained file size: 14409734 12:15:22 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')]} 12:15:22 INFO - trying https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:15:23 INFO - Downloaded 59855644 bytes. 12:15:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:15:23 INFO - mkdir: /builds/slave/test/properties 12:15:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:23 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:23 INFO - Contents: 12:15:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:15:24 INFO - Running post-action listener: _resource_record_post_action 12:15:24 INFO - Running post-action listener: set_extra_try_arguments 12:15:24 INFO - [mozharness: 2016-12-21 20:15:24.111649Z] Finished download-and-extract step (success) 12:15:24 INFO - [mozharness: 2016-12-21 20:15:24.111946Z] Running populate-webroot step. 12:15:24 INFO - Running pre-action listener: _resource_record_pre_action 12:15:24 INFO - Running main action method: populate_webroot 12:15:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:24 INFO - '--tppagecycles', 12:15:24 INFO - '7'], 12:15:24 INFO - 'tests': ['tsvgm']}}, 12:15:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:15:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:15:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:15:24 INFO - 'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:15:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:15:24 INFO - 'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['damp', 'tps']}, 12:15:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:15:24 INFO - 'tests': ['damp', 'tps']}, 12:15:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['dromaeo_dom']}, 12:15:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['basic_compositor_video']}, 12:15:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:15:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['a11yr', 12:15:24 INFO - 'ts_paint', 12:15:24 INFO - 'tpaint', 12:15:24 INFO - 'sessionrestore', 12:15:24 INFO - 'sessionrestore_no_auto_restore', 12:15:24 INFO - 'tabpaint']}, 12:15:24 INFO - 'other-e10s': {'tests': ['a11yr', 12:15:24 INFO - 'ts_paint', 12:15:24 INFO - 'tpaint', 12:15:24 INFO - 'sessionrestore', 12:15:24 INFO - 'sessionrestore_no_auto_restore', 12:15:24 INFO - 'tabpaint']}, 12:15:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:15:24 INFO - 'ts_paint', 12:15:24 INFO - 'tpaint', 12:15:24 INFO - 'sessionrestore', 12:15:24 INFO - 'sessionrestore_no_auto_restore', 12:15:24 INFO - 'tabpaint']}, 12:15:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:15:24 INFO - 'ts_paint', 12:15:24 INFO - 'tpaint', 12:15:24 INFO - 'sessionrestore', 12:15:24 INFO - 'sessionrestore_no_auto_restore', 12:15:24 INFO - 'tabpaint']}, 12:15:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['a11yr', 12:15:24 INFO - 'ts_paint', 12:15:24 INFO - 'tpaint', 12:15:24 INFO - 'sessionrestore', 12:15:24 INFO - 'sessionrestore_no_auto_restore', 12:15:24 INFO - 'tabpaint']}, 12:15:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['a11yr', 12:15:24 INFO - 'ts_paint', 12:15:24 INFO - 'tpaint', 12:15:24 INFO - 'sessionrestore', 12:15:24 INFO - 'sessionrestore_no_auto_restore', 12:15:24 INFO - 'tabpaint']}, 12:15:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['tsvgx', 12:15:24 INFO - 'tsvgr_opacity', 12:15:24 INFO - 'tart', 12:15:24 INFO - 'tscrollx', 12:15:24 INFO - 'cart', 12:15:24 INFO - 'tsvg_static']}, 12:15:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:15:24 INFO - 'tsvgr_opacity', 12:15:24 INFO - 'tart', 12:15:24 INFO - 'tscrollx', 12:15:24 INFO - 'cart', 12:15:24 INFO - 'tsvg_static']}, 12:15:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:15:24 INFO - 'talos_options': ['--disable-e10s'], 12:15:24 INFO - 'tests': ['tp5o']}, 12:15:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:15:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:15:24 INFO - 'talos_options': ['--disable-e10s', 12:15:24 INFO - '--xperf_path', 12:15:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:24 INFO - 'tests': ['tp5n']}, 12:15:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:15:24 INFO - 'talos_options': ['--xperf_path', 12:15:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:24 INFO - 'tests': ['tp5n']}}, 12:15:24 INFO - 'talos.zip': {'path': '', 12:15:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:24 INFO - Running post-action listener: _resource_record_post_action 12:15:24 INFO - [mozharness: 2016-12-21 20:15:24.130746Z] Finished populate-webroot step (success) 12:15:24 INFO - [mozharness: 2016-12-21 20:15:24.130840Z] Running create-virtualenv step. 12:15:24 INFO - Running pre-action listener: _resource_record_pre_action 12:15:24 INFO - Running main action method: create_virtualenv 12:15:24 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:24 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 12:15:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:24 INFO - Using real prefix '/usr' 12:15:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:24 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:26 INFO - Installing pip.................done. 12:15:26 INFO - Return code: 0 12:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:15:26 INFO - Reading from file tmpfile_stdout 12:15:26 INFO - Output received: 12:15:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:15:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:15:26 INFO - Using env: {'DISPLAY': ':0', 12:15:26 INFO - 'HOME': '/home/cltbld', 12:15:26 INFO - 'LANG': 'en_US.UTF-8', 12:15:26 INFO - 'LANGUAGE': 'en_US:en', 12:15:26 INFO - 'LOGNAME': 'cltbld', 12:15:26 INFO - 'MAIL': '/var/mail/cltbld', 12:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:26 INFO - 'MOZ_NO_REMOTE': '1', 12:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:26 INFO - 'NO_EM_RESTART': '1', 12:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:26 INFO - 'PWD': '/builds/slave/test', 12:15:26 INFO - 'SHELL': '/bin/bash', 12:15:26 INFO - 'SHLVL': '1', 12:15:26 INFO - 'TERM': 'linux', 12:15:26 INFO - 'TMOUT': '86400', 12:15:26 INFO - 'USER': 'cltbld', 12:15:26 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:26 INFO - '_': '/tools/buildbot/bin/python'} 12:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:27 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 12:15:27 INFO - Cleaning up... 12:15:27 INFO - Return code: 0 12:15:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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', '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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:15: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 psutil>=3.1.1 12:15:27 INFO - Using env: {'DISPLAY': ':0', 12:15:27 INFO - 'HOME': '/home/cltbld', 12:15:27 INFO - 'LANG': 'en_US.UTF-8', 12:15:27 INFO - 'LANGUAGE': 'en_US:en', 12:15:27 INFO - 'LOGNAME': 'cltbld', 12:15:27 INFO - 'MAIL': '/var/mail/cltbld', 12:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:27 INFO - 'MOZ_NO_REMOTE': '1', 12:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:27 INFO - 'NO_EM_RESTART': '1', 12:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:27 INFO - 'PWD': '/builds/slave/test', 12:15:27 INFO - 'SHELL': '/bin/bash', 12:15:27 INFO - 'SHLVL': '1', 12:15:27 INFO - 'TERM': 'linux', 12:15:27 INFO - 'TMOUT': '86400', 12:15:27 INFO - 'USER': 'cltbld', 12:15:27 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:27 INFO - '_': '/tools/buildbot/bin/python'} 12:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:27 INFO - Downloading/unpacking psutil>=3.1.1 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:29 INFO - Installing collected packages: psutil 12:15:29 INFO - Running setup.py install for psutil 12:15:29 INFO - building 'psutil._psutil_linux' extension 12:15:29 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 12:15:29 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 12:15:29 INFO - building 'psutil._psutil_posix' extension 12:15:29 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 12:15:29 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 12:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:29 INFO - Successfully installed psutil 12:15:29 INFO - Cleaning up... 12:15:29 INFO - Return code: 0 12:15:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:30 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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:30 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 12:15:30 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 12:15:30 INFO - Using env: {'DISPLAY': ':0', 12:15:30 INFO - 'HOME': '/home/cltbld', 12:15:30 INFO - 'LANG': 'en_US.UTF-8', 12:15:30 INFO - 'LANGUAGE': 'en_US:en', 12:15:30 INFO - 'LOGNAME': 'cltbld', 12:15:30 INFO - 'MAIL': '/var/mail/cltbld', 12:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:30 INFO - 'MOZ_NO_REMOTE': '1', 12:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:30 INFO - 'NO_EM_RESTART': '1', 12:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:30 INFO - 'PWD': '/builds/slave/test', 12:15:30 INFO - 'SHELL': '/bin/bash', 12:15:30 INFO - 'SHLVL': '1', 12:15:30 INFO - 'TERM': 'linux', 12:15:30 INFO - 'TMOUT': '86400', 12:15:30 INFO - 'USER': 'cltbld', 12:15:30 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:30 INFO - '_': '/tools/buildbot/bin/python'} 12:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:32 INFO - Installing collected packages: mozsystemmonitor 12:15:32 INFO - Running setup.py install for mozsystemmonitor 12:15:32 INFO - Successfully installed mozsystemmonitor 12:15:32 INFO - Cleaning up... 12:15:32 INFO - Return code: 0 12:15:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15:32 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')]} 12:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:32 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')]} 12:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:32 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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:32 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 12:15:32 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 12:15:32 INFO - Using env: {'DISPLAY': ':0', 12:15:32 INFO - 'HOME': '/home/cltbld', 12:15:32 INFO - 'LANG': 'en_US.UTF-8', 12:15:32 INFO - 'LANGUAGE': 'en_US:en', 12:15:32 INFO - 'LOGNAME': 'cltbld', 12:15:32 INFO - 'MAIL': '/var/mail/cltbld', 12:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:32 INFO - 'MOZ_NO_REMOTE': '1', 12:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:32 INFO - 'NO_EM_RESTART': '1', 12:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:32 INFO - 'PWD': '/builds/slave/test', 12:15:32 INFO - 'SHELL': '/bin/bash', 12:15:32 INFO - 'SHLVL': '1', 12:15:32 INFO - 'TERM': 'linux', 12:15:32 INFO - 'TMOUT': '86400', 12:15:32 INFO - 'USER': 'cltbld', 12:15:32 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:32 INFO - '_': '/tools/buildbot/bin/python'} 12:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:32 INFO - Downloading/unpacking jsonschema==2.5.1 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:34 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 12:15:34 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 12:15:34 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 12:15:34 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 12:15:34 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 12:15:34 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 12:15:34 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:34 INFO - warning: no files found matching '*.txt' 12:15:34 INFO - no previously-included directories found matching 'build' 12:15:34 INFO - no previously-included directories found matching 'dist' 12:15:34 INFO - no previously-included directories found matching '.git*' 12:15:34 INFO - Installing collected packages: jsonschema, functools32 12:15:34 INFO - Running setup.py install for functools32 12:15:35 INFO - warning: no files found matching '*.txt' 12:15:35 INFO - no previously-included directories found matching 'build' 12:15:35 INFO - no previously-included directories found matching 'dist' 12:15:35 INFO - no previously-included directories found matching '.git*' 12:15:35 INFO - Successfully installed jsonschema functools32 12:15:35 INFO - Cleaning up... 12:15:35 INFO - Return code: 0 12:15:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:15:35 INFO - Using env: {'DISPLAY': ':0', 12:15:35 INFO - 'HOME': '/home/cltbld', 12:15:35 INFO - 'LANG': 'en_US.UTF-8', 12:15:35 INFO - 'LANGUAGE': 'en_US:en', 12:15:35 INFO - 'LOGNAME': 'cltbld', 12:15:35 INFO - 'MAIL': '/var/mail/cltbld', 12:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:35 INFO - 'MOZ_NO_REMOTE': '1', 12:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:35 INFO - 'NO_EM_RESTART': '1', 12:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:35 INFO - 'PWD': '/builds/slave/test', 12:15:35 INFO - 'SHELL': '/bin/bash', 12:15:35 INFO - 'SHLVL': '1', 12:15:35 INFO - 'TERM': 'linux', 12:15:35 INFO - 'TMOUT': '86400', 12:15:35 INFO - 'USER': 'cltbld', 12:15:35 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:35 INFO - '_': '/tools/buildbot/bin/python'} 12:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:35 INFO - Cleaning up... 12:15:35 INFO - Return code: 0 12:15:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:15:35 INFO - Using env: {'DISPLAY': ':0', 12:15:35 INFO - 'HOME': '/home/cltbld', 12:15:35 INFO - 'LANG': 'en_US.UTF-8', 12:15:35 INFO - 'LANGUAGE': 'en_US:en', 12:15:35 INFO - 'LOGNAME': 'cltbld', 12:15:35 INFO - 'MAIL': '/var/mail/cltbld', 12:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:35 INFO - 'MOZ_NO_REMOTE': '1', 12:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:35 INFO - 'NO_EM_RESTART': '1', 12:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:35 INFO - 'PWD': '/builds/slave/test', 12:15:35 INFO - 'SHELL': '/bin/bash', 12:15:35 INFO - 'SHLVL': '1', 12:15:35 INFO - 'TERM': 'linux', 12:15:35 INFO - 'TMOUT': '86400', 12:15:35 INFO - 'USER': 'cltbld', 12:15:35 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:35 INFO - '_': '/tools/buildbot/bin/python'} 12:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:35 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:37 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:37 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 12:15:37 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 12:15:37 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 12:15:37 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 12:15:37 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 12:15:37 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 12:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:38 INFO - Downloading docopt-0.6.1.tar.gz 12:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:38 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:38 INFO - Running setup.py install for blobuploader 12:15:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:38 INFO - Running setup.py install for requests 12:15:38 INFO - Running setup.py install for docopt 12:15:38 INFO - Successfully installed blobuploader requests docopt 12:15:38 INFO - Cleaning up... 12:15:39 INFO - Return code: 0 12:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:39 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')]} 12:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:39 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')]} 12:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:39 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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:39 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 12:15:39 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 12:15:39 INFO - Using env: {'DISPLAY': ':0', 12:15:39 INFO - 'HOME': '/home/cltbld', 12:15:39 INFO - 'LANG': 'en_US.UTF-8', 12:15:39 INFO - 'LANGUAGE': 'en_US:en', 12:15:39 INFO - 'LOGNAME': 'cltbld', 12:15:39 INFO - 'MAIL': '/var/mail/cltbld', 12:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:39 INFO - 'MOZ_NO_REMOTE': '1', 12:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:39 INFO - 'NO_EM_RESTART': '1', 12:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:39 INFO - 'PWD': '/builds/slave/test', 12:15:39 INFO - 'SHELL': '/bin/bash', 12:15:39 INFO - 'SHLVL': '1', 12:15:39 INFO - 'TERM': 'linux', 12:15:39 INFO - 'TMOUT': '86400', 12:15:39 INFO - 'USER': 'cltbld', 12:15:39 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:39 INFO - '_': '/tools/buildbot/bin/python'} 12:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:39 INFO - Running setup.py (path:/tmp/pip-c0hsQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:39 INFO - Running setup.py (path:/tmp/pip-aBjMb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:39 INFO - Running setup.py (path:/tmp/pip-9cCxV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:39 INFO - Running setup.py (path:/tmp/pip-E9_lGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:39 INFO - Running setup.py (path:/tmp/pip-Mc57nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:39 INFO - Running setup.py (path:/tmp/pip-XTM7rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:39 INFO - Running setup.py (path:/tmp/pip-ZBpU59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:39 INFO - Running setup.py (path:/tmp/pip-YmaxEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:39 INFO - Running setup.py (path:/tmp/pip-dgTQyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:39 INFO - Running setup.py (path:/tmp/pip-gRKjQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:39 INFO - Running setup.py (path:/tmp/pip-EBXwwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:40 INFO - Running setup.py (path:/tmp/pip-VUxKgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:40 INFO - Running setup.py (path:/tmp/pip-_JuoNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:40 INFO - Running setup.py (path:/tmp/pip-jFA9xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:40 INFO - Running setup.py (path:/tmp/pip-aqu37p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:40 INFO - Running setup.py (path:/tmp/pip-ObhShO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:40 INFO - Running setup.py (path:/tmp/pip-RmupWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:40 INFO - Running setup.py install for manifestparser 12:15:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for mozcrash 12:15:40 INFO - Running setup.py install for mozdebug 12:15:40 INFO - Running setup.py install for mozdevice 12:15:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for mozfile 12:15:40 INFO - Running setup.py install for mozhttpd 12:15:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Running setup.py install for mozinfo 12:15:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Running setup.py install for mozInstall 12:15:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Running setup.py install for mozleak 12:15:41 INFO - Running setup.py install for mozlog 12:15:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Running setup.py install for moznetwork 12:15:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Running setup.py install for mozprocess 12:15:41 INFO - Running setup.py install for mozprofile 12:15:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Running setup.py install for mozrunner 12:15:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:41 INFO - Running setup.py install for mozscreenshot 12:15:42 INFO - Running setup.py install for moztest 12:15:42 INFO - Running setup.py install for mozversion 12:15:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:42 INFO - Cleaning up... 12:15:42 INFO - Return code: 0 12:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:42 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')]} 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 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')]} 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:42 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 12:15:42 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 12:15:42 INFO - Using env: {'DISPLAY': ':0', 12:15:42 INFO - 'HOME': '/home/cltbld', 12:15:42 INFO - 'LANG': 'en_US.UTF-8', 12:15:42 INFO - 'LANGUAGE': 'en_US:en', 12:15:42 INFO - 'LOGNAME': 'cltbld', 12:15:42 INFO - 'MAIL': '/var/mail/cltbld', 12:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:42 INFO - 'MOZ_NO_REMOTE': '1', 12:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:42 INFO - 'NO_EM_RESTART': '1', 12:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:42 INFO - 'PWD': '/builds/slave/test', 12:15:42 INFO - 'SHELL': '/bin/bash', 12:15:42 INFO - 'SHLVL': '1', 12:15:42 INFO - 'TERM': 'linux', 12:15:42 INFO - 'TMOUT': '86400', 12:15:42 INFO - 'USER': 'cltbld', 12:15:42 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:42 INFO - '_': '/tools/buildbot/bin/python'} 12:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:42 INFO - Running setup.py (path:/tmp/pip-gSG3GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:42 INFO - Running setup.py (path:/tmp/pip-vVlRTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:42 INFO - Running setup.py (path:/tmp/pip-POjMdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:42 INFO - Running setup.py (path:/tmp/pip-X43JjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:42 INFO - Running setup.py (path:/tmp/pip-8CXzch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:42 INFO - Running setup.py (path:/tmp/pip-flYa0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:42 INFO - Running setup.py (path:/tmp/pip-VEOugd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:42 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)) 12:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:43 INFO - Running setup.py (path:/tmp/pip-u9qqio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:43 INFO - Running setup.py (path:/tmp/pip-A_Idmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:43 INFO - Running setup.py (path:/tmp/pip-jmPqae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:43 INFO - Running setup.py (path:/tmp/pip-y3lld9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:43 INFO - Running setup.py (path:/tmp/pip-O8zryX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:43 INFO - Running setup.py (path:/tmp/pip-gY9onQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:43 INFO - Running setup.py (path:/tmp/pip-LKMRXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:43 INFO - Running setup.py (path:/tmp/pip-GjPFMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:43 INFO - Running setup.py (path:/tmp/pip-z2z1Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:43 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)) 12:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:43 INFO - Running setup.py (path:/tmp/pip-ztmv2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:43 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)) 12:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:43 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)) 12:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:45 INFO - Downloading blessings-1.6.tar.gz 12:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:45 INFO - Installing collected packages: blessings 12:15:45 INFO - Running setup.py install for blessings 12:15:45 INFO - Successfully installed blessings 12:15:45 INFO - Cleaning up... 12:15:45 INFO - Return code: 0 12:15:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:46 INFO - Reading from file tmpfile_stdout 12:15:46 INFO - Current package versions: 12:15:46 INFO - argparse == 1.2.1 12:15:46 INFO - blessings == 1.6 12:15:46 INFO - blobuploader == 1.2.4 12:15:46 INFO - docopt == 0.6.1 12:15:46 INFO - functools32 == 3.2.3-2 12:15:46 INFO - jsonschema == 2.5.1 12:15:46 INFO - manifestparser == 1.1 12:15:46 INFO - mozInstall == 1.12 12:15:46 INFO - mozcrash == 1.0 12:15:46 INFO - mozdebug == 0.1 12:15:46 INFO - mozdevice == 0.49 12:15:46 INFO - mozfile == 1.2 12:15:46 INFO - mozhttpd == 0.7 12:15:46 INFO - mozinfo == 0.9 12:15:46 INFO - mozleak == 0.1 12:15:46 INFO - mozlog == 3.4 12:15:46 INFO - moznetwork == 0.27 12:15:46 INFO - mozprocess == 0.23 12:15:46 INFO - mozprofile == 0.28 12:15:46 INFO - mozrunner == 6.13 12:15:46 INFO - mozscreenshot == 0.1 12:15:46 INFO - mozsystemmonitor == 0.3 12:15:46 INFO - moztest == 0.7 12:15:46 INFO - mozversion == 1.4 12:15:46 INFO - psutil == 3.1.1 12:15:46 INFO - requests == 1.2.3 12:15:46 INFO - wsgiref == 0.1.2 12:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:46 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')]} 12:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 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')]} 12:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:46 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 12:15:46 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 12:15:46 INFO - Using env: {'DISPLAY': ':0', 12:15:46 INFO - 'HOME': '/home/cltbld', 12:15:46 INFO - 'LANG': 'en_US.UTF-8', 12:15:46 INFO - 'LANGUAGE': 'en_US:en', 12:15:46 INFO - 'LOGNAME': 'cltbld', 12:15:46 INFO - 'MAIL': '/var/mail/cltbld', 12:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:46 INFO - 'MOZ_NO_REMOTE': '1', 12:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:46 INFO - 'NO_EM_RESTART': '1', 12:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:46 INFO - 'PWD': '/builds/slave/test', 12:15:46 INFO - 'SHELL': '/bin/bash', 12:15:46 INFO - 'SHLVL': '1', 12:15:46 INFO - 'TERM': 'linux', 12:15:46 INFO - 'TMOUT': '86400', 12:15:46 INFO - 'USER': 'cltbld', 12:15:46 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:46 INFO - '_': '/tools/buildbot/bin/python'} 12:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 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)) 12:15:46 INFO - Cleaning up... 12:15:46 INFO - Return code: 0 12:15:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:46 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')]} 12:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 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')]} 12:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:46 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 0x26451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2811a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, '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': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', '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 12:15:46 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 12:15:46 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 12:15:46 INFO - Using env: {'DISPLAY': ':0', 12:15:46 INFO - 'HOME': '/home/cltbld', 12:15:46 INFO - 'LANG': 'en_US.UTF-8', 12:15:46 INFO - 'LANGUAGE': 'en_US:en', 12:15:46 INFO - 'LOGNAME': 'cltbld', 12:15:46 INFO - 'MAIL': '/var/mail/cltbld', 12:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:46 INFO - 'MOZ_NO_REMOTE': '1', 12:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:46 INFO - 'NO_EM_RESTART': '1', 12:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:46 INFO - 'PWD': '/builds/slave/test', 12:15:46 INFO - 'SHELL': '/bin/bash', 12:15:46 INFO - 'SHLVL': '1', 12:15:46 INFO - 'TERM': 'linux', 12:15:46 INFO - 'TMOUT': '86400', 12:15:46 INFO - 'USER': 'cltbld', 12:15:46 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:46 INFO - '_': '/tools/buildbot/bin/python'} 12:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:15:46 INFO - Cleaning up... 12:15:46 INFO - Return code: 0 12:15:46 INFO - Running post-action listener: _resource_record_post_action 12:15:46 INFO - Running post-action listener: _start_resource_monitoring 12:15:46 INFO - Starting resource monitoring. 12:15:46 INFO - [mozharness: 2016-12-21 20:15:46.694157Z] Finished create-virtualenv step (success) 12:15:46 INFO - [mozharness: 2016-12-21 20:15:46.694747Z] Running install step. 12:15:46 INFO - Running pre-action listener: _resource_record_pre_action 12:15:46 INFO - Running main action method: install 12:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:46 INFO - Reading from file tmpfile_stdout 12:15:46 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:46 INFO - Reading from file tmpfile_stdout 12:15:46 INFO - Output received: 12:15:46 INFO - Usage: mozinstall [options] installer 12:15:46 INFO - Options: 12:15:46 INFO - -h, --help show this help message and exit 12:15:46 INFO - -d DEST, --destination=DEST 12:15:46 INFO - Directory to install application into. [default: 12:15:46 INFO - "/builds/slave/test"] 12:15:46 INFO - --app=APP Application being installed. [default: firefox] 12:15:46 INFO - mkdir: /builds/slave/test/build/application 12:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:16:03 INFO - Reading from file tmpfile_stdout 12:16:03 INFO - Output received: 12:16:03 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:03 INFO - Running post-action listener: _resource_record_post_action 12:16:03 INFO - [mozharness: 2016-12-21 20:16:03.974819Z] Finished install step (success) 12:16:03 INFO - [mozharness: 2016-12-21 20:16:03.975065Z] Running run-tests step. 12:16:03 INFO - Running pre-action listener: _resource_record_pre_action 12:16:03 INFO - Running main action method: run_tests 12:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:03 INFO - Python 2.7.3 12:16:03 INFO - Return code: 0 12:16:03 INFO - grabbing minidump binary from tooltool 12:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:03 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 0x29b43f0>, '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 0x29b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b51a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:03 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 12:16:03 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 12:16:03 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 12:16:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:04 INFO - Return code: 0 12:16:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 12:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 12:16:04 INFO - Using env: {'DISPLAY': ':0', 12:16:04 INFO - 'HOME': '/home/cltbld', 12:16:04 INFO - 'LANG': 'en_US.UTF-8', 12:16:04 INFO - 'LANGUAGE': 'en_US:en', 12:16:04 INFO - 'LOGNAME': 'cltbld', 12:16:04 INFO - 'MAIL': '/var/mail/cltbld', 12:16:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:04 INFO - 'MOZ_NO_REMOTE': '1', 12:16:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:04 INFO - 'NO_EM_RESTART': '1', 12:16:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:04 INFO - 'PWD': '/builds/slave/test', 12:16:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:04 INFO - 'SHELL': '/bin/bash', 12:16:04 INFO - 'SHLVL': '1', 12:16:04 INFO - 'TERM': 'linux', 12:16:04 INFO - 'TMOUT': '86400', 12:16:04 INFO - 'USER': 'cltbld', 12:16:04 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939', 12:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:04 INFO - '_': '/tools/buildbot/bin/python'} 12:16:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 12:16:04 INFO - mozversion application_buildid: 20161221103008 12:16:04 INFO - mozversion application_changeset: 10a5e2fc24e4e24fbe115fb190bcc28df4627ee2 12:16:04 INFO - mozversion application_display_name: Nightly 12:16:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:04 INFO - mozversion application_name: Firefox 12:16:04 INFO - mozversion application_remotingname: firefox 12:16:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:16:04 INFO - mozversion application_vendor: Mozilla 12:16:04 INFO - mozversion application_version: 53.0a1 12:16:04 INFO - mozversion platform_buildid: 20161221103008 12:16:04 INFO - mozversion platform_changeset: 10a5e2fc24e4e24fbe115fb190bcc28df4627ee2 12:16:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:16:04 INFO - mozversion platform_version: 53.0a1 12:16:04 INFO - using testdate: 1482351364 12:16:04 INFO - actual date: 1482351364 12:16:04 INFO - starting webserver on 'localhost:37228' 12:16:04 INFO - SUITE-START | Running 2 tests 12:16:04 INFO - TEST-START | dromaeo_css 12:16:04 INFO - operating with platform_type : linux_ 12:16:04 INFO - Initialising browser for dromaeo_css test... 12:16:04 INFO - TEST-INFO | started process 30107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrWgDD/profile http://localhost:37228/getInfo.html) 12:16:07 INFO - PROCESS | 30107 | __metrics Screen width/height:1600/1200 12:16:07 INFO - PROCESS | 30107 | colorDepth:24 12:16:07 INFO - PROCESS | 30107 | Browser inner width/height: 1024/697 12:16:07 INFO - PROCESS | 30107 | __metrics 12:16:08 INFO - PROCESS | 30107 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:16:08 INFO - PROCESS | 30107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:09 INFO - PROCESS | 30107 | console.error: PushService: 12:16:09 INFO - PROCESS | 30107 | stateChangeProcessEnqueue: Error transitioning state 12:16:09 INFO - PROCESS | 30107 | UnknownError 12:16:09 INFO - TEST-INFO | 30107: exit 0 12:16:09 INFO - Browser initialized. 12:16:09 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:09 INFO - TEST-INFO | started process 30194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrWgDD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:21 INFO - PROCESS | 30194 | RSS: Main: 153075712 12:16:21 INFO - PROCESS | 30194 | 12:17:13 INFO - PROCESS | 30194 | 1482351433332 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] 12:19:23 INFO - PROCESS | 30194 | Cycle 1(1): loaded http://localhost:37228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37228/tests/dromaeo/cssquery-ext.html) 12:19:25 INFO - PROCESS | 30194 | RSS: Main: 287600640 12:19:25 INFO - PROCESS | 30194 | 12:22:27 INFO - PROCESS | 30194 | Cycle 1(1): loaded http://localhost:37228/tests/dromaeo/cssquery-ext.html (next: http://localhost:37228/tests/dromaeo/cssquery-jquery.html) 12:22:28 INFO - PROCESS | 30194 | RSS: Main: 246472704 12:22:28 INFO - PROCESS | 30194 | 12:25:30 INFO - PROCESS | 30194 | Cycle 1(1): loaded http://localhost:37228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37228/tests/dromaeo/cssquery-mootools.html) 12:25:31 INFO - PROCESS | 30194 | RSS: Main: 187928576 12:25:31 INFO - PROCESS | 30194 | 12:28:33 INFO - PROCESS | 30194 | Cycle 1(1): loaded http://localhost:37228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37228/tests/dromaeo/cssquery-prototype.html) 12:28:33 INFO - PROCESS | 30194 | RSS: Main: 189915136 12:28:33 INFO - PROCESS | 30194 | 12:31:36 INFO - PROCESS | 30194 | Cycle 1(1): loaded http://localhost:37228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37228/tests/dromaeo/cssquery-yui.html) 12:31:37 INFO - PROCESS | 30194 | RSS: Main: 191004672 12:31:37 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | Cycle 1(1): loaded http://localhost:37228/tests/dromaeo/cssquery-yui.html (next: http://localhost:37228/tests/dromaeo/cssquery-dojo.html) 12:34:40 INFO - PROCESS | 30194 | RSS: Main: 261828608 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | __start_tp_report 12:34:40 INFO - PROCESS | 30194 | _x_x_mozilla_page_load 12:34:40 INFO - PROCESS | 30194 | _x_x_mozilla_page_load_details 12:34:40 INFO - PROCESS | 30194 | |i|pagename|runs| 12:34:40 INFO - PROCESS | 30194 | |0;dojo.html;3210.1653570071776;3243.399971005364;3260.02199340198;3280.245543524989;3287.178205448638;5110.821121260757;5144.228365745131;5218.060749065166;5265.552428043616;5287.127623942045;5193.5325820676135;5206.687598744078;5223.582113430926;5247.344081989751;5254.658447200939;4799.304100905367;4826.517348265163;4864.343313652647;4876.878078048042;4962.0324036812835;4842.806287748486;4876.146674331995;4942.703437793726;4956.008798240348;4971.577415919651;4892.315075889378;4932.358793356877;4942.283368911523;4956.851294461154;4975.0547395994645;4614.423197100363;4617.145828021827;4632.467266264389;4795.112904112751;4905.23968784839;4771.045790841846;4800.711957282574;4808.663393562452;4854.781534830941;4871.171900776876;5209.426963034063;5242.842714718565;5274.894502109936;5290.629655924087;5324.281222035014;5492.176173573996;5520.227168196456;5642.887142257173;5648.350439699446;5649.23735295734;5553.333599968029;5560.77756889724;5571.832845014656;5616.943830561683;5663.886722265573;5247.973760131213;5251.2123181523075;5252.606054545924;5254.15933450646;5259.947400526023;5714.828555143269;5715.142728590745;5716.371199168088;5727.198192253088;5781.913271300934;5340.465953404629;5343.86640333987;5378.838634840961;5401.972990135024;5403.756830942617;5457.399686034533;5509.090999984957;5521.199426083276;5524.33707955048;5556.638818476786;5479.863003424946;5480.451954804487;5481.287432633732;5488.313960754906;5528.502434780889;5435.619506634498;5457.754401051962;5479.917801232985;5512.91730624041;5567.554595632339;4300.91398172041;4301.870943871689;4302.161078589707;4304.849330273488;4307.396964424983;3899.473571067926;3901.804909754501;3942.329803933281;3950.9209815804097;3959.7228194026143;5474.698891561003;5479.671219726829;5487.972560137254;5503.229547863302;5531.446855314436;5655.858603534863;5699.629524081004;5704.401037891044;5707.971460142756;5724.25584673998;5201.6358854880555;5248.160294352885;5310.8141215057285;5467.753951072212;5521.5306698930235;4851.660383773173;4872.317875497433;4883.682560633548;4898.926516102261;4911.484294149063;5795.1017592273265;5802.158686990363;5805.796797112165;5806.82579522615;5821.417858214145;5347.919781203363;5364.490373414519;5552.805651802168;5576.0799468088935;5654.802081927113;5637.069883469182;5641.210230567642;5646.548276137817;5747.5689323300085;5766.596338256281;5480.150576660624;5483.2049352844415;5487.807926722546;5516.80691175823;5532.889342213214;5605.495505404533;5610.7194640268635;5611.579131565068;5617.775288988558;5623.409541998031;5220.112580861339;5310.601704872072;5463.344398672185;5496.422875598005;5539.58453116026;5464.098423760194;5521.972390138024;5543.362513311021;5560.332760068818;5581.469760372758;5440.347158341025;5446.591505637014;5460.153676180198;5467.808626698046;5472.398036215934;5427;5431.049566325956;5546.223528706065;5554.250176226158;5624.718764061862;5478.753456094565;5526.364468086222;5529.253550770755;5565.3599836019375;5577.3028371453565 12:34:40 INFO - PROCESS | 30194 | |1;ext.html;536.03246140716;566.0659911146607;569.9202111704362;582.2634367525084;590.203225645379;30006;32874.67125328746;32885.34229315412;32887;32921;32963.505547416746;33734.493982590284;33747.66252337476;39023.414648780294;40566;8523.829523409544;8701.434406763572;8702.521361325125;8705.434146780439;8710.12898710127;8588.785280367978;8683.34874884383;8686.782830429227;8689.695860644879;8692.956535217316;7877.881831772528;8074.9596252018955;8694.869576956351;8736.170063843925;10176.18590512761;9950.353227040256;10259.025392587691;10271.691849244535;10272.897271027268;10281.89718102817;10063.29556931015;10132.290739648228;10155.339902906288;10158.59365625374;10159.441230732307;31022.689773102433;31645.52531712026;37353.81323093394;39032.60967390318;39387.60612393868;3196.7762256642045;3230.820750426101;3278.7704860659765;3360.6975372216375;3664.9371682212127;29810.55284170739;29999.100026999226;30264.24339391511;30371.848140759375;31077.844610776803;3947.388154836005;4034.899127521806;4065.308897487434;4066.085130845566;4110.7328023678365;314321;315093;315832;316115;316614;54538.45461545413;54906.45093549093;54964;55113.44886551164;55211.44788552143;58614.4138558609;58640.7067964666;58667.4133258662;59007.40992590105;59020.40979590235;14372.496962606469;14785.186814725079;14793.704125917422;14862.108273503625;14877.18175500358;10744.570217191382;10830.945845270724;10842.674719758419;10852.72868178286;10853.186011049203;15617.687646247012;17418.47744567665;17454.214560344815;17485.12574371302;17542.140729039846;5260.868478287997;6087.208662873798;6095.817125486243;6184.783532576428;6199.845003874849;821.5892053973014;877.2543338162511;979.5591983607405;993.5181437003192;1007.5113569918584;28929.42141157207;29817.403651927274;30134.54798178029;30504.237394065327;30689;957.7222605444482;974.5030034682363;1011.9038691324313;1013.1197513523189;1030.2067408095875;13579.52471663487;14399.78400323996;14563.41746330135;14601;14633.560993170222;462627;466633;466661;467163;467768;46030.53969460329;46448.3032754509;47062;47356.763216183695;47383.5261647386;1230.563150081708;1234.8024316109559;1254.736505333872;1255.0775180242515;1263.595649392204;26819.463610728068;27380.45239095247;28096;28497.572536412386;28613.427731444837;42985.3552196711;43390.783046084565;43398.34902476402;43416.34875476934;43422.78288608663;334838;418715;437816;441982;652863;24465;24625.38436539029;24809.503809924063;24845.378865528506;24937.127200547893;39352.21295574015;39428.2114357717;39813;39817.2036559273;39869;34524.48213276752;34569.135771605914;34603.307933840675;34660.48009279913;34891.30217395689;33133.83433082916;34278;34419.827900860335;34632.65367346395;34995.825020874734;34062.31875362528;34938.12654683653;35060;35127.64872351346;35698.8215058923;28947.22370808793;30841;31464.528032079994;31680.524792127675;31706.841465793445;24508.87745561332;24578;24646.876765616056;24962.50074998526;25096.24711258665 12:34:40 INFO - PROCESS | 30194 | |2;jquery.html;356.37812018028546;377.9210354438079;379.7360834220218;388.1402693034928;407.9367698006808;13827.792583111248;14002.159870407782;15464.304106315201;17535.649287014283;18604.906975465103;17364.82635173648;17376.218070186842;18157.182926768295;18430.907845460755;18496.44510664682;5273.288106105684;5501.367342755574;5506.366767821692;5510;5535.169724541311;5325.4142044375085;5391.355636530857;5499.780008799643;5561.916571251434;5600.691961942091;5620.971895140539;5632.5212356949505;5635.63368381056;5637.013522633543;5640.633358831683;5452.6183167178315;5567.3019728982645;5599.496045355938;5610.915836262459;5611.298587676541;5425.565954723613;5429.728513574306;5432.511074003319;5433.4566543345745;5434.673919564839;12920.935395323057;13151.802722959163;13197.538086166938;13296.135751176143;13308.06843520954;2156.7088443060143;2245.6856040154394;2371.4664200554907;2505.649209110726;2619.1618682021763;9194.770130746718;9481;9494.810103797954;9850.90149098507;10088.243381746399;1849.4604503421444;1854.5085552328644;1883.9717404238947;1919.433767038727;1954.3843689237845;71116.6444167781;73562.63218683926;74980.25019749787;75155.24844751538;76110;10327;10432.947835260775;10612.522436490377;10678.57285708563;10740.838887416696;14440.350184241734;14442.494512692005;14448.277586120652;14456.421743130368;14464.13215207091;7143.92856071443;7235.167955685163;7363.060762492149;7502.362299204519;7525.510841795266;6730.293319201512;6787.524873258824;6808.455323574201;6993.230744618088;7003.404710599554;4427.535108813592;4433.8226470941445;4461.821527138878;4495.595396414338;4580.061087477059;1849.9907500462411;1856.8421684156729;1872.9906350468161;1906.761654793151;1953.091812307284;823.7075838077516;853.2960307746134;855.7261676263536;935.3265648732902;952.7808604021114;16611.41860034893;17643.73534396985;17661.205245763973;17962.5509362267;18195.363162289257;869.6173683579204;871.9258862996589;889.4929889962789;901.5492253873064;919.7010971434311;9127.132922372364;10002.299839011199;10016.198704103654;10042.799144017079;10088.596456141819;215121;215833;216479;217318.66198063374;217401;59934.70032649809;72691;73559;76470.61764691141;79441;935.5135329628555;950.021477877787;980.3137803537552;985.9309848310693;988.2686811759246;15614.192903548226;15819.367225311318;16034.198290085682;16640.916795415946;16748.246328915473;36678;37317.4402383959;38127.42808857925;38281.425778612786;39574.40638390484;50546.74726626343;51712.22431663453;53749.92500150053;53857;54894.17658735202;8025.117237104031;8040.437169398086;8082.393820463371;8244.54654993981;8325.916740832756;9158.95420522893;12015.75968480643;12178.512859485521;12389;12681.30252836103;10557.260991730505;10651.041406273163;10774.407407592344;11035.668929932115;11085.612003579836;9974.002599739968;10670.519826607977;10806.621768238074;10946.890531094905;11010.07323718362;10929.125669946545;11026.779464410827;11074.335539867634;11125.888741112809;11127.610533631285;8013.15861834499;8031.9960004999375;8114.715984940499;8146.2261085196815;8301.750947471586;8165.183011860899;10355.17158627323;10424;10439;11166.832497512707 12:34:40 INFO - PROCESS | 30194 | |3;mootools.html;1349.3118509560124;1379.613708161715;1484.6956373943342;1655.8178600353967;1689.6451745133522;7863.960680196598;8287.254147126765;8299.294559962404;8299.626516806744;8339.54132522711;6969.884818429053;7205.1714052883935;7843.137254901956;8040.356771458284;8073.354131669467;2190.1567896359857;2218.6117429449864;2222.3333000099988;2223.0552015393473;2223.94440138997;2225.7774222577696;2241.753407125223;2275.670027845961;2279.282026161762;2281.9201327953524;2224.788645078715;2232.363776323748;2247.0786977339294;2247.6853240546257;2263.649134384173;2141.2612648636195;2161.189553917281;2176.009915488457;2177.107385971744;2179.3679832848456;2208.9116435342567;2234.5866014787316;2235.966460503094;2237.865728056322;2241.383619504633;8055.476394034427;8194.180581941817;8204.8359032819;8223.753287401387;8244.628991695328;4956.851294461172;5074.543291103819;5085.771140298695;5088.4148322942965;5098.923516147261;3123.3284843758474;3162.256869635634;3358.983205083983;3372.4772660237704;3379.6620337966006;1055.488088277185;1073.1790180511914;1083.6207327435413;1086.1582273737838;1096.1121491591837;10837.67486975384;11114.444277786159;11127.221094523387;11327.830082548768;11456.541738330458;4164.312888373384;4316.589923957219;4323.697341186087;4422.823087076546;4423.314386270134;8477.74566762998;8496.787580310418;8501.107383724744;8510.617022234015;8526.74419767408;4911.68074075184;4913.606911447076;4916.950830491721;4917.7786999585105;4919.950800491949;4155.979220103941;4376.124775045004;4623.606993405599;4625.95374046262;4628.166929952574;3485.215826439031;3493.510908472816;3516.8065756383644;3566.1262990566956;3588.1209103769743;1124.1568823382463;1130.63819577736;1140.4468832616174;1143.782681290552;1149.3563604381573;746.268656716421;808.2362167751536;882.2544949517647;886.4193952960821;898.7842917699836;5182.24857395683;5281.234221038005;5309.097453432925;5363.785448582091;5455.645383050089;408.66693644680083;431.09470112763574;432.90043290042837;434.9478062632504;438.57020120281663;3530.6998905093355;3588.8743893964106;3645.8906232813056;3667.449882517644;3744.9438258426144;9890.604375824887;10101.797964040677;10186.643467478603;10251.897481025095;10260.486975651187;9468.479233642078;9997.550110245056;10107.444090574942;10115.696529104138;10125.898741012496;7637.2362763724295;7786.1435242123325;7806.843863122705;7818.452708310478;7818.765437036898;5142.5885929126325;5343.812966546152;5450.400455949922;5552.944470555404;5692.260006199168;8967.641294348414;9234.03042680509;9352.812943741223;9401.10689484498;9597.712068637673;9576.138147566753;9579.9042009579;9580.515020171884;9618.567164477756;9656.468894210886;6573.211214654272;6801.18385793708;7355.963220183865;7384.704611815468;7527.548347099191;7966.322862556516;8083.070446898682;8090.433669643068;8091.757247282591;8097.716579919675;7103.076600041962;7174.174969878322;7293.671784769805;7343.3390994810725;7385.7045718170675;7094.503384763017;7096.290370962863;7177.641117943977;7367.189609143097;7395.223501532261;5994.850128746816;6101.176341194059;6102.4507794298725;6104.298005729398;6105.084237364431;4481.977590112028;4517.412736344254;4548.545145485557;4588.88527786808;4636.559526844944;4625.560571745679;4687.531246875422;4768.737719425326;4795.088933102699;4971.751412429292 12:34:40 INFO - PROCESS | 30194 | |4;prototype.html;363.5419371591795;364.3605472395945;366.94679271505635;374.4439507331614;376.32825406649135;5074.949250507494;5156.510131537508;5238.84283471496;5264.789408423663;5309.920351194735;5115.693058416488;5227.5295223429885;5255.553277971377;5274.334337635345;5276.498732620405;3983.382575700771;4069.2268468990947;4076.9219239474305;4211.43145675333;4229.851955181553;4133.689973252003;4148.713898691401;4158.812853421588;4181.916361672765;4192.203481338551;4123.463949686537;4129.15352352767;4138.524069731974;4151.647109995654;4180.51924028736;4076.164386300801;4146.875593732193;4173.457450531427;4180.393842892794;4180.79096045198;3715.1269451678836;3723.94414083789;3731.533558305212;3733.626637336272;3745;5045.318881950926;5063.8480845574695;5079.974600127012;5094.7197904115255;5104.438511763703;4699.224627936386;4707.31743897133;4724.76376181193;4730.645201609858;4754.619630429557;5157.458466860963;5369.7583608737705;5384.957499013045;5404.4325345838515;5423.457654234585;3806.695464362844;3811.313963486571;3818.8472461101524;3838.366669499529;3840.078381188495;5622.409646987048;5649.887002259932;5655.570652173918;5656.321241451053;5659.377468478464;3811.313963486599;3908.4332771747936;3933.3903244997073;3953.683705303569;3962.881113566598;3981.6615587675374;3989.6608788252743;3999.580044095328;4005.1989602079116;4011.197760447922;4555.886102847456;4561.673546491247;4568.132054909556;4590.40324757786;4590.517995610479;5122.282880396748;5249.396319423316;5476.205950137208;5478.397376288605;5491.258680078218;1345.3407830163148;1354.0859919554262;1356.5252161743508;1356.7286542691502;1356.816829727974;888.706726780161;917.8210249001514;934.5140526926097;934.9158575728081;936.2790651198675;5134.332536770271;5160.329157209539;5173.482651734872;5198.037118842223;5199.674083108859;5333.973330133324;5383.569314454834;5391.406945236021;5395.167537043084;5422.945770542323;5061.746912654353;5147.897042059138;5166.948330516647;5170.6122040847085;5372.785088596413;2870.555063965047;2881.971180288212;2893.7395634393006;2897.4060317634835;2913.941721165565;5598.068666310117;5623.718814059281;5623.803166889139;5641.887162256814;5650.886982260332;5416.187571864252;5490.670559766427;5693.572982026281;5738.651416917021;5770.278715160605;5807.796727114531;5817.563682723812;5818.272715910512;5842.941570584239;5865.560082993792;5510;5642.6614403135945;5643.1535269709875;5646.548276137817;5660.29246344207;5561.443855614406;5576.832695019156;5578.163275508706;5589;5589.944100559105;5846.707664616667;5864.9413505864395;5866.266716660418;5867.20792692981;5900.350961394157;4039.6970227232487;4059.898502537342;4069.1658210066275;4095.6928230382246;4110.260153172458;5365.543928766098;5487.00957977895;5517.5585953124455;5546.362168350692;5605.094267948917;5344.866378340573;5355.625106242525;5369.19462080691;5369.946300536944;5405.918626382924;5411.485908838654;5430.321209848769;5449.836504904859;5455.890882182413;5464.890702186013;5258.921116183337;5412.242286079873;5418.620696551204;5442.455754424526;5451.56387488992;5510.429527584619;5533.418991005887;5533.7786488540005;5547.306586676666;5549.916751248654;5246.606504512253;5378.327709036371;5410.918836217538;5433.809816656398;5434.83695489136 12:34:40 INFO - PROCESS | 30194 | |5;yui.html;657.8454063295128;683.753848614499;691.8097523181125;740.9700516282369;823.8105235795765;14422.35099420526;15567.29947152378;15890.682186356265;16074;16086.67826643468;13820.170789752598;13890.374933128009;14235.572932812007;14243.78634320486;14257.35841887115;736.6316841579197;757.8408534207823;759.2635143910426;759.4987308376473;759.582229773625;632.4560877645245;657.5955787190867;711.1750369571298;739.5156172706886;763.0766772205637;791.2799352589145;797.3700776386647;798.9161138080476;800.1398496616132;800.3997002248313;792.8771040488733;792.9563873986929;792.9643166057571;793.1354823242665;794.2057942057942;480.96633235673517;493.91603427417425;545.8389775016379;566.4703502225433;582.6591444005262;13819.170849749047;13822.032457727963;13847.30763461833;13852.445902163901;13864.4454221831;13846.792298115537;13863.168209907337;14074.648133796634;14145.222012789292;14148.646283842987;12447.626571202878;12468;12572.057095717857;12897.742045159044;12956;4220.430241917333;4317;4344.4352234209355;4462.9107417851465;4521.186186486431;73159.63420182918;75109.62445187794;75151.62424187899;75779.11755001663;75951;10045.19638428924;10580.470976451146;10614.203934704929;10812.459377031117;10826;20171;20182.697259541117;20245.978245739647;20355.79644203539;20450.488737781674;7564.054493188351;7629.961850190713;7661;7739.1873853245725;7917.445778795544;4385.298352263686;4418.80115394808;4444.2222611042935;4531.4109165808895;4661.696989695659;3177.618685757724;3226.1128189748006;3226.757993150476;3251.3172233830687;3261.3640340133447;530.3662123762067;535.4270930104828;541.4964083402474;544.7548603128608;551.7461967494997;613.9079138129316;634.8381162803455;635.8696467224208;649.9870002599921;654.159405164371;7972.590496052459;8508.574571271412;9042.266456365876;9317.580708868118;9323.25413966881;527.8653943244448;529.2537522093829;585.844751140948;596.9850753731191;642.7332656947408;4343.655385353323;4394.670399720034;4496.235639941217;4533.365328853963;4555.658325625592;81460;81966.59016704878;82242.17757822345;82335;83903;71250.64374678198;72913.27086729064;73676.26323736801;74818.25181748222;76473.61763191149;67109.6644516784;68472.65763671149;69058.65470672614;69555.65222173856;71239.64380178066;8472.942809633241;8510.361722870686;8717.91282087171;9078.273738100805;9907.851382229417;41208.38187427251;41208.79395603123;41811;41859;42771.35842962296;54351.72824135854;57291.71354143203;57610.71194644;57909.4209057904;59257;11849.466773995018;11955;11971.880281197426;12210.475828853154;12608.306543139848;14144.929275353557;14374.496892608708;14830.258487075818;14880.702385952436;15001.699966000837;12989.28558929268;13302.800457993331;13428.865711342762;13521.661958451117;13595.932020340231;12916.806247906477;13044.804327935279;13139.14595551286;13303.46786128544;13351;12604.49582016709;12833.743325133259;13240.801387978996;13330.86669133335;13471.932640336736;10617.203709721956;11230.550777969116;11302.717432064264;11431.485583148611;11459.885401145882;11225.550977961117;11458.656240312805;11515.769684606428;11536;11683.123765717435 12:34:40 INFO - PROCESS | 30194 | __end_tp_report 12:34:40 INFO - PROCESS | 30194 | __start_cc_report 12:34:40 INFO - PROCESS | 30194 | _x_x_mozilla_cycle_collect,1351 12:34:40 INFO - PROCESS | 30194 | __end_cc_report 12:34:40 INFO - PROCESS | 30194 | __startTimestamp1482352480288__endTimestamp 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | ------- Summary: start ------- 12:34:40 INFO - PROCESS | 30194 | Number of tests: 6 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | [#0] dojo.html Cycles:165 Average:5226.35 Median:5457.40 stddev:542.50 (9.9%) stddev-sans-first:520.60 12:34:40 INFO - PROCESS | 30194 | Values: 3210.2 3243.4 3260.0 3280.2 3287.2 5110.8 5144.2 5218.1 5265.6 5287.1 5193.5 5206.7 5223.6 5247.3 5254.7 4799.3 4826.5 4864.3 4876.9 4962.0 4842.8 4876.1 4942.7 4956.0 4971.6 4892.3 4932.4 4942.3 4956.9 4975.1 4614.4 4617.1 4632.5 4795.1 4905.2 4771.0 4800.7 4808.7 4854.8 4871.2 5209.4 5242.8 5274.9 5290.6 5324.3 5492.2 5520.2 5642.9 5648.4 5649.2 5553.3 5560.8 5571.8 5616.9 5663.9 5248.0 5251.2 5252.6 5254.2 5259.9 5714.8 5715.1 5716.4 5727.2 5781.9 5340.5 5343.9 5378.8 5402.0 5403.8 5457.4 5509.1 5521.2 5524.3 5556.6 5479.9 5480.5 5481.3 5488.3 5528.5 5435.6 5457.8 5479.9 5512.9 5567.6 4300.9 4301.9 4302.2 4304.8 4307.4 3899.5 3901.8 3942.3 3950.9 3959.7 5474.7 5479.7 5488.0 5503.2 5531.4 5655.9 5699.6 5704.4 5708.0 5724.3 5201.6 5248.2 5310.8 5467.8 5521.5 4851.7 4872.3 4883.7 4898.9 4911.5 5795.1 5802.2 5805.8 5806.8 5821.4 5347.9 5364.5 5552.8 5576.1 5654.8 5637.1 5641.2 5646.5 5747.6 5766.6 5480.2 5483.2 5487.8 5516.8 5532.9 5605.5 5610.7 5611.6 5617.8 5623.4 5220.1 5310.6 5463.3 5496.4 5539.6 5464.1 5522.0 5543.4 5560.3 5581.5 5440.3 5446.6 5460.2 5467.8 5472.4 5427.0 5431.0 5546.2 5554.3 5624.7 5478.8 5526.4 5529.3 5565.4 5577.3 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | [#1] ext.html Cycles:180 Average:54990.34 Median:34170.16 stddev:112571.80 (329.4%) stddev-sans-first:112813.35 12:34:40 INFO - PROCESS | 30194 | Values: 536.0 566.1 569.9 582.3 590.2 30006.0 32874.7 32885.3 32887.0 32921.0 32963.5 33734.5 33747.7 39023.4 40566.0 8523.8 8701.4 8702.5 8705.4 8710.1 8588.8 8683.3 8686.8 8689.7 8693.0 7877.9 8075.0 8694.9 8736.2 10176.2 9950.4 10259.0 10271.7 10272.9 10281.9 10063.3 10132.3 10155.3 10158.6 10159.4 31022.7 31645.5 37353.8 39032.6 39387.6 3196.8 3230.8 3278.8 3360.7 3664.9 29810.6 29999.1 30264.2 30371.8 31077.8 3947.4 4034.9 4065.3 4066.1 4110.7 314321.0 315093.0 315832.0 316115.0 316614.0 54538.5 54906.5 54964.0 55113.4 55211.4 58614.4 58640.7 58667.4 59007.4 59020.4 14372.5 14785.2 14793.7 14862.1 14877.2 10744.6 10830.9 10842.7 10852.7 10853.2 15617.7 17418.5 17454.2 17485.1 17542.1 5260.9 6087.2 6095.8 6184.8 6199.8 821.6 877.3 979.6 993.5 1007.5 28929.4 29817.4 30134.5 30504.2 30689.0 957.7 974.5 1011.9 1013.1 1030.2 13579.5 14399.8 14563.4 14601.0 14633.6 462627.0 466633.0 466661.0 467163.0 467768.0 46030.5 46448.3 47062.0 47356.8 47383.5 1230.6 1234.8 1254.7 1255.1 1263.6 26819.5 27380.5 28096.0 28497.6 28613.4 42985.4 43390.8 43398.3 43416.3 43422.8 334838.0 418715.0 437816.0 441982.0 652863.0 24465.0 24625.4 24809.5 24845.4 24937.1 39352.2 39428.2 39813.0 39817.2 39869.0 34524.5 34569.1 34603.3 34660.5 34891.3 33133.8 34278.0 34419.8 34632.7 34995.8 34062.3 34938.1 35060.0 35127.6 35698.8 28947.2 30841.0 31464.5 31680.5 31706.8 24508.9 24578.0 24646.9 24962.5 25096.2 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | [#2] jquery.html Cycles:180 Average:19596.05 Median:19991.17 stddev:37712.82 (188.6%) stddev-sans-first:37790.95 12:34:40 INFO - PROCESS | 30194 | Values: 356.4 377.9 379.7 388.1 407.9 13827.8 14002.2 15464.3 17535.6 18604.9 17364.8 17376.2 18157.2 18430.9 18496.4 5273.3 5501.4 5506.4 5510.0 5535.2 5325.4 5391.4 5499.8 5561.9 5600.7 5621.0 5632.5 5635.6 5637.0 5640.6 5452.6 5567.3 5599.5 5610.9 5611.3 5425.6 5429.7 5432.5 5433.5 5434.7 12920.9 13151.8 13197.5 13296.1 13308.1 2156.7 2245.7 2371.5 2505.6 2619.2 9194.8 9481.0 9494.8 9850.9 10088.2 1849.5 1854.5 1884.0 1919.4 1954.4 71116.6 73562.6 74980.3 75155.2 76110.0 10327.0 10432.9 10612.5 10678.6 10740.8 14440.4 14442.5 14448.3 14456.4 14464.1 7143.9 7235.2 7363.1 7502.4 7525.5 6730.3 6787.5 6808.5 6993.2 7003.4 4427.5 4433.8 4461.8 4495.6 4580.1 1850.0 1856.8 1873.0 1906.8 1953.1 823.7 853.3 855.7 935.3 952.8 16611.4 17643.7 17661.2 17962.6 18195.4 869.6 871.9 889.5 901.5 919.7 9127.1 10002.3 10016.2 10042.8 10088.6 215121.0 215833.0 216479.0 217318.7 217401.0 59934.7 72691.0 73559.0 76470.6 79441.0 935.5 950.0 980.3 985.9 988.3 15614.2 15819.4 16034.2 16640.9 16748.2 36678.0 37317.4 38127.4 38281.4 39574.4 50546.7 51712.2 53749.9 53857.0 54894.2 8025.1 8040.4 8082.4 8244.5 8325.9 9159.0 12015.8 12178.5 12389.0 12681.3 10557.3 10651.0 10774.4 11035.7 11085.6 9974.0 10670.5 10806.6 10946.9 11010.1 10929.1 11026.8 11074.3 11125.9 11127.6 8013.2 8032.0 8114.7 8146.2 8301.8 8165.2 10355.2 10424.0 10439.0 11166.8 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | [#3] mootools.html Cycles:180 Average:5324.66 Median:4853.38 stddev:3016.63 (62.2%) stddev-sans-first:3010.30 12:34:40 INFO - PROCESS | 30194 | Values: 1349.3 1379.6 1484.7 1655.8 1689.6 7864.0 8287.3 8299.3 8299.6 8339.5 6969.9 7205.2 7843.1 8040.4 8073.4 2190.2 2218.6 2222.3 2223.1 2223.9 2225.8 2241.8 2275.7 2279.3 2281.9 2224.8 2232.4 2247.1 2247.7 2263.6 2141.3 2161.2 2176.0 2177.1 2179.4 2208.9 2234.6 2236.0 2237.9 2241.4 8055.5 8194.2 8204.8 8223.8 8244.6 4956.9 5074.5 5085.8 5088.4 5098.9 3123.3 3162.3 3359.0 3372.5 3379.7 1055.5 1073.2 1083.6 1086.2 1096.1 10837.7 11114.4 11127.2 11327.8 11456.5 4164.3 4316.6 4323.7 4422.8 4423.3 8477.7 8496.8 8501.1 8510.6 8526.7 4911.7 4913.6 4917.0 4917.8 4920.0 4156.0 4376.1 4623.6 4626.0 4628.2 3485.2 3493.5 3516.8 3566.1 3588.1 1124.2 1130.6 1140.4 1143.8 1149.4 746.3 808.2 882.3 886.4 898.8 5182.2 5281.2 5309.1 5363.8 5455.6 408.7 431.1 432.9 434.9 438.6 3530.7 3588.9 3645.9 3667.4 3744.9 9890.6 10101.8 10186.6 10251.9 10260.5 9468.5 9997.6 10107.4 10115.7 10125.9 7637.2 7786.1 7806.8 7818.5 7818.8 5142.6 5343.8 5450.4 5552.9 5692.3 8967.6 9234.0 9352.8 9401.1 9597.7 9576.1 9579.9 9580.5 9618.6 9656.5 6573.2 6801.2 7356.0 7384.7 7527.5 7966.3 8083.1 8090.4 8091.8 8097.7 7103.1 7174.2 7293.7 7343.3 7385.7 7094.5 7096.3 7177.6 7367.2 7395.2 5994.9 6101.2 6102.5 6104.3 6105.1 4482.0 4517.4 4548.5 4588.9 4636.6 4625.6 4687.5 4768.7 4795.1 4971.8 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | [#4] prototype.html Cycles:180 Average:4592.86 Median:5242.72 stddev:1340.19 (25.6%) stddev-sans-first:1305.82 12:34:40 INFO - PROCESS | 30194 | Values: 363.5 364.4 366.9 374.4 376.3 5074.9 5156.5 5238.8 5264.8 5309.9 5115.7 5227.5 5255.6 5274.3 5276.5 3983.4 4069.2 4076.9 4211.4 4229.9 4133.7 4148.7 4158.8 4181.9 4192.2 4123.5 4129.2 4138.5 4151.6 4180.5 4076.2 4146.9 4173.5 4180.4 4180.8 3715.1 3723.9 3731.5 3733.6 3745.0 5045.3 5063.8 5080.0 5094.7 5104.4 4699.2 4707.3 4724.8 4730.6 4754.6 5157.5 5369.8 5385.0 5404.4 5423.5 3806.7 3811.3 3818.8 3838.4 3840.1 5622.4 5649.9 5655.6 5656.3 5659.4 3811.3 3908.4 3933.4 3953.7 3962.9 3981.7 3989.7 3999.6 4005.2 4011.2 4555.9 4561.7 4568.1 4590.4 4590.5 5122.3 5249.4 5476.2 5478.4 5491.3 1345.3 1354.1 1356.5 1356.7 1356.8 888.7 917.8 934.5 934.9 936.3 5134.3 5160.3 5173.5 5198.0 5199.7 5334.0 5383.6 5391.4 5395.2 5422.9 5061.7 5147.9 5166.9 5170.6 5372.8 2870.6 2882.0 2893.7 2897.4 2913.9 5598.1 5623.7 5623.8 5641.9 5650.9 5416.2 5490.7 5693.6 5738.7 5770.3 5807.8 5817.6 5818.3 5842.9 5865.6 5510.0 5642.7 5643.2 5646.5 5660.3 5561.4 5576.8 5578.2 5589.0 5589.9 5846.7 5864.9 5866.3 5867.2 5900.4 4039.7 4059.9 4069.2 4095.7 4110.3 5365.5 5487.0 5517.6 5546.4 5605.1 5344.9 5355.6 5369.2 5369.9 5405.9 5411.5 5430.3 5449.8 5455.9 5464.9 5258.9 5412.2 5418.6 5442.5 5451.6 5510.4 5533.4 5533.8 5547.3 5549.9 5246.6 5378.3 5410.9 5433.8 5434.8 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - PROCESS | 30194 | [#5] yui.html Cycles:180 Average:17711.55 Median:4526.30 stddev:23237.20 (513.4%) stddev-sans-first:23267.10 12:34:40 INFO - PROCESS | 30194 | Values: 657.8 683.8 691.8 741.0 823.8 14422.4 15567.3 15890.7 16074.0 16086.7 13820.2 13890.4 14235.6 14243.8 14257.4 736.6 757.8 759.3 759.5 759.6 632.5 657.6 711.2 739.5 763.1 791.3 797.4 798.9 800.1 800.4 792.9 793.0 793.0 793.1 794.2 481.0 493.9 545.8 566.5 582.7 13819.2 13822.0 13847.3 13852.4 13864.4 13846.8 13863.2 14074.6 14145.2 14148.6 12447.6 12468.0 12572.1 12897.7 12956.0 4220.4 4317.0 4344.4 4462.9 4521.2 73159.6 75109.6 75151.6 75779.1 75951.0 10045.2 10580.5 10614.2 10812.5 10826.0 20171.0 20182.7 20246.0 20355.8 20450.5 7564.1 7630.0 7661.0 7739.2 7917.4 4385.3 4418.8 4444.2 4531.4 4661.7 3177.6 3226.1 3226.8 3251.3 3261.4 530.4 535.4 541.5 544.8 551.7 613.9 634.8 635.9 650.0 654.2 7972.6 8508.6 9042.3 9317.6 9323.3 527.9 529.3 585.8 597.0 642.7 4343.7 4394.7 4496.2 4533.4 4555.7 81460.0 81966.6 82242.2 82335.0 83903.0 71250.6 72913.3 73676.3 74818.3 76473.6 67109.7 68472.7 69058.7 69555.7 71239.6 8472.9 8510.4 8717.9 9078.3 9907.9 41208.4 41208.8 41811.0 41859.0 42771.4 54351.7 57291.7 57610.7 57909.4 59257.0 11849.5 11955.0 11971.9 12210.5 12608.3 14144.9 14374.5 14830.3 14880.7 15001.7 12989.3 13302.8 13428.9 13521.7 13595.9 12916.8 13044.8 13139.1 13303.5 13351.0 12604.5 12833.7 13240.8 13330.9 13471.9 10617.2 11230.6 11302.7 11431.5 11459.9 11225.6 11458.7 11515.8 11536.0 11683.1 12:34:40 INFO - PROCESS | 30194 | -------- Summary: end -------- 12:34:40 INFO - PROCESS | 30194 | 12:34:40 INFO - TEST-INFO | 30194: exit 0 12:34:40 INFO - TEST-OK | dromaeo_css | took 1116734ms 12:34:40 INFO - TEST-START | kraken 12:34:40 INFO - operating with platform_type : linux_ 12:34:40 INFO - Initialising browser for kraken test... 12:34:41 INFO - TEST-INFO | started process 30503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpju5Fmm/profile http://localhost:37228/getInfo.html) 12:34:45 INFO - PROCESS | 30503 | __metrics Screen width/height:1600/1200 12:34:45 INFO - PROCESS | 30503 | colorDepth:24 12:34:45 INFO - PROCESS | 30503 | Browser inner width/height: 1024/697 12:34:45 INFO - PROCESS | 30503 | __metrics 12:34:45 INFO - PROCESS | 30503 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:34:45 INFO - PROCESS | 30503 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:34:46 INFO - TEST-INFO | 30503: exit 0 12:34:46 INFO - Browser initialized. 12:34:46 INFO - Running cycle 1/1 for kraken test... 12:34:46 INFO - TEST-INFO | started process 30584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpju5Fmm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:58 INFO - PROCESS | 30584 | RSS: Main: 152952832 12:34:58 INFO - PROCESS | 30584 | 12:35:01 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37228/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:01 INFO - PROCESS | 30584 | RSS: Main: 206389248 12:35:01 INFO - PROCESS | 30584 | 12:35:04 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37228/tests/kraken/driver.html?testName=audio-dft) 12:35:05 INFO - PROCESS | 30584 | RSS: Main: 184844288 12:35:05 INFO - PROCESS | 30584 | 12:35:08 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37228/tests/kraken/driver.html?testName=audio-fft) 12:35:08 INFO - PROCESS | 30584 | RSS: Main: 267276288 12:35:08 INFO - PROCESS | 30584 | 12:35:10 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37228/tests/kraken/driver.html?testName=audio-oscillator) 12:35:11 INFO - PROCESS | 30584 | RSS: Main: 178929664 12:35:11 INFO - PROCESS | 30584 | 12:35:13 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:14 INFO - PROCESS | 30584 | RSS: Main: 182198272 12:35:14 INFO - PROCESS | 30584 | 12:35:17 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37228/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:17 INFO - PROCESS | 30584 | RSS: Main: 222195712 12:35:17 INFO - PROCESS | 30584 | 12:35:21 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37228/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:21 INFO - PROCESS | 30584 | RSS: Main: 224182272 12:35:21 INFO - PROCESS | 30584 | 12:35:24 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37228/tests/kraken/driver.html?testName=json-parse-financial) 12:35:25 INFO - PROCESS | 30584 | RSS: Main: 225083392 12:35:25 INFO - PROCESS | 30584 | 12:35:26 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:27 INFO - PROCESS | 30584 | RSS: Main: 182321152 12:35:27 INFO - PROCESS | 30584 | 12:35:28 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:29 INFO - PROCESS | 30584 | RSS: Main: 189476864 12:35:29 INFO - PROCESS | 30584 | 12:35:31 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:32 INFO - PROCESS | 30584 | RSS: Main: 198553600 12:35:32 INFO - PROCESS | 30584 | 12:35:34 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:35 INFO - PROCESS | 30584 | RSS: Main: 207114240 12:35:35 INFO - PROCESS | 30584 | 12:35:38 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:38 INFO - PROCESS | 30584 | RSS: Main: 204414976 12:35:38 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | Cycle 1(1): loaded http://localhost:37228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37228/tests/kraken/driver.html?testName=ai-astar) 12:35:40 INFO - PROCESS | 30584 | RSS: Main: 254672896 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | __start_tp_report 12:35:40 INFO - PROCESS | 30584 | _x_x_mozilla_page_load 12:35:40 INFO - PROCESS | 30584 | _x_x_mozilla_page_load_details 12:35:40 INFO - PROCESS | 30584 | |i|pagename|runs| 12:35:40 INFO - PROCESS | 30584 | |0;ai-astar;110;112;110;113;112;112;111;112;112;112 12:35:40 INFO - PROCESS | 30584 | |1;audio-beat-detection;144;125;122;168;124;125;120;121;140;128 12:35:40 INFO - PROCESS | 30584 | |2;audio-dft;159;159;159;161;160;160;159;161;161;161 12:35:40 INFO - PROCESS | 30584 | |3;audio-fft;75;76;75;109;78;75;76;75;90;77 12:35:40 INFO - PROCESS | 30584 | |4;audio-oscillator;83;86;111;84;84;84;93;84;84;106 12:35:40 INFO - PROCESS | 30584 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 12:35:40 INFO - PROCESS | 30584 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;145;146 12:35:40 INFO - PROCESS | 30584 | |7;imaging-desaturate;96;96;96;96;95;95;95;95;95;95 12:35:40 INFO - PROCESS | 30584 | |8;json-parse-financial;52;51;49;50;51;52;55;51;52;51 12:35:40 INFO - PROCESS | 30584 | |9;json-stringify-tinderbox;62;63;61;62;63;63;62;63;63;63 12:35:40 INFO - PROCESS | 30584 | |10;stanford-crypto-aes;81;80;86;80;80;80;80;79;88;79 12:35:40 INFO - PROCESS | 30584 | |11;stanford-crypto-ccm;130;124;130;128;126;133;133;123;164;145 12:35:40 INFO - PROCESS | 30584 | |12;stanford-crypto-pbkdf2;163;163;165;162;163;169;162;162;164;165 12:35:40 INFO - PROCESS | 30584 | |13;stanford-crypto-sha256-iterative;65;61;63;62;63;63;62;61;61;62 12:35:40 INFO - PROCESS | 30584 | __end_tp_report 12:35:40 INFO - PROCESS | 30584 | __start_cc_report 12:35:40 INFO - PROCESS | 30584 | _x_x_mozilla_cycle_collect,1668 12:35:40 INFO - PROCESS | 30584 | __end_cc_report 12:35:40 INFO - PROCESS | 30584 | __startTimestamp1482352540804__endTimestamp 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | ------- Summary: start ------- 12:35:40 INFO - PROCESS | 30584 | Number of tests: 14 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:0.83 12:35:40 INFO - PROCESS | 30584 | Values: 110.0 112.0 110.0 113.0 112.0 112.0 111.0 112.0 112.0 112.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:126.50 stddev:15.08 (11.9%) stddev-sans-first:15.32 12:35:40 INFO - PROCESS | 30584 | Values: 144.0 125.0 122.0 168.0 124.0 125.0 120.0 121.0 140.0 128.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 12:35:40 INFO - PROCESS | 30584 | Values: 159.0 159.0 159.0 161.0 160.0 160.0 159.0 161.0 161.0 161.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:10.97 (14.4%) stddev-sans-first:11.44 12:35:40 INFO - PROCESS | 30584 | Values: 75.0 76.0 75.0 109.0 78.0 75.0 76.0 75.0 90.0 77.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.00 stddev:10.28 (12.2%) stddev-sans-first:10.59 12:35:40 INFO - PROCESS | 30584 | Values: 83.0 86.0 111.0 84.0 84.0 84.0 93.0 84.0 84.0 106.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:35:40 INFO - PROCESS | 30584 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 12:35:40 INFO - PROCESS | 30584 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:35:40 INFO - PROCESS | 30584 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:1.58 (3.1%) stddev-sans-first:1.66 12:35:40 INFO - PROCESS | 30584 | Values: 52.0 51.0 49.0 50.0 51.0 52.0 55.0 51.0 52.0 51.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 12:35:40 INFO - PROCESS | 30584 | Values: 62.0 63.0 61.0 62.0 63.0 63.0 62.0 63.0 63.0 63.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:3.09 (3.9%) stddev-sans-first:3.28 12:35:40 INFO - PROCESS | 30584 | Values: 81.0 80.0 86.0 80.0 80.0 80.0 80.0 79.0 88.0 79.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:131.50 stddev:12.36 (9.4%) stddev-sans-first:13.04 12:35:40 INFO - PROCESS | 30584 | Values: 130.0 124.0 130.0 128.0 126.0 133.0 133.0 123.0 164.0 145.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:163.50 stddev:2.15 (1.3%) stddev-sans-first:2.26 12:35:40 INFO - PROCESS | 30584 | Values: 163.0 163.0 165.0 162.0 163.0 169.0 162.0 162.0 164.0 165.0 12:35:40 INFO - PROCESS | 30584 | 12:35:40 INFO - PROCESS | 30584 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:0.87 12:35:40 INFO - PROCESS | 30584 | Values: 65.0 61.0 63.0 62.0 63.0 63.0 62.0 61.0 61.0 62.0 12:35:40 INFO - PROCESS | 30584 | -------- Summary: end -------- 12:35:40 INFO - PROCESS | 30584 | 12:35:41 INFO - TEST-INFO | 30584: exit 0 12:35:41 INFO - TEST-OK | kraken | took 60801ms 12:35:41 INFO - SUITE-END | took 1177s 12:35:41 INFO - Completed test suite (00:19:37) 12:35:41 INFO - javascript benchmark 12:35:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.1653570071776, 3243.399971005364, 3260.02199340198, 3280.245543524989, 3287.178205448638, 5110.821121260757, 5144.228365745131, 5218.060749065166, 5265.552428043616, 5287.127623942045, 5193.5325820676135, 5206.687598744078, 5223.582113430926, 5247.344081989751, 5254.658447200939, 4799.304100905367, 4826.517348265163, 4864.343313652647, 4876.878078048042, 4962.0324036812835, 4842.806287748486, 4876.146674331995, 4942.703437793726, 4956.008798240348, 4971.577415919651, 4892.315075889378, 4932.358793356877, 4942.283368911523, 4956.851294461154, 4975.0547395994645, 4614.423197100363, 4617.145828021827, 4632.467266264389, 4795.112904112751, 4905.23968784839, 4771.045790841846, 4800.711957282574, 4808.663393562452, 4854.781534830941, 4871.171900776876, 5209.426963034063, 5242.842714718565, 5274.894502109936, 5290.629655924087, 5324.281222035014, 5492.176173573996, 5520.227168196456, 5642.887142257173, 5648.350439699446, 5649.23735295734, 5553.333599968029, 5560.77756889724, 5571.832845014656, 5616.943830561683, 5663.886722265573, 5247.973760131213, 5251.2123181523075, 5252.606054545924, 5254.15933450646, 5259.947400526023, 5714.828555143269, 5715.142728590745, 5716.371199168088, 5727.198192253088, 5781.913271300934, 5340.465953404629, 5343.86640333987, 5378.838634840961, 5401.972990135024, 5403.756830942617, 5457.399686034533, 5509.090999984957, 5521.199426083276, 5524.33707955048, 5556.638818476786, 5479.863003424946, 5480.451954804487, 5481.287432633732, 5488.313960754906, 5528.502434780889, 5435.619506634498, 5457.754401051962, 5479.917801232985, 5512.91730624041, 5567.554595632339, 4300.91398172041, 4301.870943871689, 4302.161078589707, 4304.849330273488, 4307.396964424983, 3899.473571067926, 3901.804909754501, 3942.329803933281, 3950.9209815804097, 3959.7228194026143, 5474.698891561003, 5479.671219726829, 5487.972560137254, 5503.229547863302, 5531.446855314436, 5655.858603534863, 5699.629524081004, 5704.401037891044, 5707.971460142756, 5724.25584673998, 5201.6358854880555, 5248.160294352885, 5310.8141215057285, 5467.753951072212, 5521.5306698930235, 4851.660383773173, 4872.317875497433, 4883.682560633548, 4898.926516102261, 4911.484294149063, 5795.1017592273265, 5802.158686990363, 5805.796797112165, 5806.82579522615, 5821.417858214145, 5347.919781203363, 5364.490373414519, 5552.805651802168, 5576.0799468088935, 5654.802081927113, 5637.069883469182, 5641.210230567642, 5646.548276137817, 5747.5689323300085, 5766.596338256281, 5480.150576660624, 5483.2049352844415, 5487.807926722546, 5516.80691175823, 5532.889342213214, 5605.495505404533, 5610.7194640268635, 5611.579131565068, 5617.775288988558, 5623.409541998031, 5220.112580861339, 5310.601704872072, 5463.344398672185, 5496.422875598005, 5539.58453116026, 5464.098423760194, 5521.972390138024, 5543.362513311021, 5560.332760068818, 5581.469760372758, 5440.347158341025, 5446.591505637014, 5460.153676180198, 5467.808626698046, 5472.398036215934, 5427.0, 5431.049566325956, 5546.223528706065, 5554.250176226158, 5624.718764061862, 5478.753456094565, 5526.364468086222, 5529.253550770755, 5565.3599836019375, 5577.3028371453565], "value": 5193.635605404253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.03246140716, 566.0659911146607, 569.9202111704362, 582.2634367525084, 590.203225645379, 30006.0, 32874.67125328746, 32885.34229315412, 32887.0, 32921.0, 32963.505547416746, 33734.493982590284, 33747.66252337476, 39023.414648780294, 40566.0, 8523.829523409544, 8701.434406763572, 8702.521361325125, 8705.434146780439, 8710.12898710127, 8588.785280367978, 8683.34874884383, 8686.782830429227, 8689.695860644879, 8692.956535217316, 7877.881831772528, 8074.9596252018955, 8694.869576956351, 8736.170063843925, 10176.18590512761, 9950.353227040256, 10259.025392587691, 10271.691849244535, 10272.897271027268, 10281.89718102817, 10063.29556931015, 10132.290739648228, 10155.339902906288, 10158.59365625374, 10159.441230732307, 31022.689773102433, 31645.52531712026, 37353.81323093394, 39032.60967390318, 39387.60612393868, 3196.7762256642045, 3230.820750426101, 3278.7704860659765, 3360.6975372216375, 3664.9371682212127, 29810.55284170739, 29999.100026999226, 30264.24339391511, 30371.848140759375, 31077.844610776803, 3947.388154836005, 4034.899127521806, 4065.308897487434, 4066.085130845566, 4110.7328023678365, 314321.0, 315093.0, 315832.0, 316115.0, 316614.0, 54538.45461545413, 54906.45093549093, 54964.0, 55113.44886551164, 55211.44788552143, 58614.4138558609, 58640.7067964666, 58667.4133258662, 59007.40992590105, 59020.40979590235, 14372.496962606469, 14785.186814725079, 14793.704125917422, 14862.108273503625, 14877.18175500358, 10744.570217191382, 10830.945845270724, 10842.674719758419, 10852.72868178286, 10853.186011049203, 15617.687646247012, 17418.47744567665, 17454.214560344815, 17485.12574371302, 17542.140729039846, 5260.868478287997, 6087.208662873798, 6095.817125486243, 6184.783532576428, 6199.845003874849, 821.5892053973014, 877.2543338162511, 979.5591983607405, 993.5181437003192, 1007.5113569918584, 28929.42141157207, 29817.403651927274, 30134.54798178029, 30504.237394065327, 30689.0, 957.7222605444482, 974.5030034682363, 1011.9038691324313, 1013.1197513523189, 1030.2067408095875, 13579.52471663487, 14399.78400323996, 14563.41746330135, 14601.0, 14633.560993170222, 462627.0, 466633.0, 466661.0, 467163.0, 467768.0, 46030.53969460329, 46448.3032754509, 47062.0, 47356.763216183695, 47383.5261647386, 1230.563150081708, 1234.8024316109559, 1254.736505333872, 1255.0775180242515, 1263.595649392204, 26819.463610728068, 27380.45239095247, 28096.0, 28497.572536412386, 28613.427731444837, 42985.3552196711, 43390.783046084565, 43398.34902476402, 43416.34875476934, 43422.78288608663, 334838.0, 418715.0, 437816.0, 441982.0, 652863.0, 24465.0, 24625.38436539029, 24809.503809924063, 24845.378865528506, 24937.127200547893, 39352.21295574015, 39428.2114357717, 39813.0, 39817.2036559273, 39869.0, 34524.48213276752, 34569.135771605914, 34603.307933840675, 34660.48009279913, 34891.30217395689, 33133.83433082916, 34278.0, 34419.827900860335, 34632.65367346395, 34995.825020874734, 34062.31875362528, 34938.12654683653, 35060.0, 35127.64872351346, 35698.8215058923, 28947.22370808793, 30841.0, 31464.528032079994, 31680.524792127675, 31706.841465793445, 24508.87745561332, 24578.0, 24646.876765616056, 24962.50074998526, 25096.24711258665], "value": 18145.35628850494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.37812018028546, 377.9210354438079, 379.7360834220218, 388.1402693034928, 407.9367698006808, 13827.792583111248, 14002.159870407782, 15464.304106315201, 17535.649287014283, 18604.906975465103, 17364.82635173648, 17376.218070186842, 18157.182926768295, 18430.907845460755, 18496.44510664682, 5273.288106105684, 5501.367342755574, 5506.366767821692, 5510.0, 5535.169724541311, 5325.4142044375085, 5391.355636530857, 5499.780008799643, 5561.916571251434, 5600.691961942091, 5620.971895140539, 5632.5212356949505, 5635.63368381056, 5637.013522633543, 5640.633358831683, 5452.6183167178315, 5567.3019728982645, 5599.496045355938, 5610.915836262459, 5611.298587676541, 5425.565954723613, 5429.728513574306, 5432.511074003319, 5433.4566543345745, 5434.673919564839, 12920.935395323057, 13151.802722959163, 13197.538086166938, 13296.135751176143, 13308.06843520954, 2156.7088443060143, 2245.6856040154394, 2371.4664200554907, 2505.649209110726, 2619.1618682021763, 9194.770130746718, 9481.0, 9494.810103797954, 9850.90149098507, 10088.243381746399, 1849.4604503421444, 1854.5085552328644, 1883.9717404238947, 1919.433767038727, 1954.3843689237845, 71116.6444167781, 73562.63218683926, 74980.25019749787, 75155.24844751538, 76110.0, 10327.0, 10432.947835260775, 10612.522436490377, 10678.57285708563, 10740.838887416696, 14440.350184241734, 14442.494512692005, 14448.277586120652, 14456.421743130368, 14464.13215207091, 7143.92856071443, 7235.167955685163, 7363.060762492149, 7502.362299204519, 7525.510841795266, 6730.293319201512, 6787.524873258824, 6808.455323574201, 6993.230744618088, 7003.404710599554, 4427.535108813592, 4433.8226470941445, 4461.821527138878, 4495.595396414338, 4580.061087477059, 1849.9907500462411, 1856.8421684156729, 1872.9906350468161, 1906.761654793151, 1953.091812307284, 823.7075838077516, 853.2960307746134, 855.7261676263536, 935.3265648732902, 952.7808604021114, 16611.41860034893, 17643.73534396985, 17661.205245763973, 17962.5509362267, 18195.363162289257, 869.6173683579204, 871.9258862996589, 889.4929889962789, 901.5492253873064, 919.7010971434311, 9127.132922372364, 10002.299839011199, 10016.198704103654, 10042.799144017079, 10088.596456141819, 215121.0, 215833.0, 216479.0, 217318.66198063374, 217401.0, 59934.70032649809, 72691.0, 73559.0, 76470.61764691141, 79441.0, 935.5135329628555, 950.021477877787, 980.3137803537552, 985.9309848310693, 988.2686811759246, 15614.192903548226, 15819.367225311318, 16034.198290085682, 16640.916795415946, 16748.246328915473, 36678.0, 37317.4402383959, 38127.42808857925, 38281.425778612786, 39574.40638390484, 50546.74726626343, 51712.22431663453, 53749.92500150053, 53857.0, 54894.17658735202, 8025.117237104031, 8040.437169398086, 8082.393820463371, 8244.54654993981, 8325.916740832756, 9158.95420522893, 12015.75968480643, 12178.512859485521, 12389.0, 12681.30252836103, 10557.260991730505, 10651.041406273163, 10774.407407592344, 11035.668929932115, 11085.612003579836, 9974.002599739968, 10670.519826607977, 10806.621768238074, 10946.890531094905, 11010.07323718362, 10929.125669946545, 11026.779464410827, 11074.335539867634, 11125.888741112809, 11127.610533631285, 8013.15861834499, 8031.9960004999375, 8114.715984940499, 8146.2261085196815, 8301.750947471586, 8165.183011860899, 10355.17158627323, 10424.0, 10439.0, 11166.832497512707], "value": 8262.890907622519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.3118509560124, 1379.613708161715, 1484.6956373943342, 1655.8178600353967, 1689.6451745133522, 7863.960680196598, 8287.254147126765, 8299.294559962404, 8299.626516806744, 8339.54132522711, 6969.884818429053, 7205.1714052883935, 7843.137254901956, 8040.356771458284, 8073.354131669467, 2190.1567896359857, 2218.6117429449864, 2222.3333000099988, 2223.0552015393473, 2223.94440138997, 2225.7774222577696, 2241.753407125223, 2275.670027845961, 2279.282026161762, 2281.9201327953524, 2224.788645078715, 2232.363776323748, 2247.0786977339294, 2247.6853240546257, 2263.649134384173, 2141.2612648636195, 2161.189553917281, 2176.009915488457, 2177.107385971744, 2179.3679832848456, 2208.9116435342567, 2234.5866014787316, 2235.966460503094, 2237.865728056322, 2241.383619504633, 8055.476394034427, 8194.180581941817, 8204.8359032819, 8223.753287401387, 8244.628991695328, 4956.851294461172, 5074.543291103819, 5085.771140298695, 5088.4148322942965, 5098.923516147261, 3123.3284843758474, 3162.256869635634, 3358.983205083983, 3372.4772660237704, 3379.6620337966006, 1055.488088277185, 1073.1790180511914, 1083.6207327435413, 1086.1582273737838, 1096.1121491591837, 10837.67486975384, 11114.444277786159, 11127.221094523387, 11327.830082548768, 11456.541738330458, 4164.312888373384, 4316.589923957219, 4323.697341186087, 4422.823087076546, 4423.314386270134, 8477.74566762998, 8496.787580310418, 8501.107383724744, 8510.617022234015, 8526.74419767408, 4911.68074075184, 4913.606911447076, 4916.950830491721, 4917.7786999585105, 4919.950800491949, 4155.979220103941, 4376.124775045004, 4623.606993405599, 4625.95374046262, 4628.166929952574, 3485.215826439031, 3493.510908472816, 3516.8065756383644, 3566.1262990566956, 3588.1209103769743, 1124.1568823382463, 1130.63819577736, 1140.4468832616174, 1143.782681290552, 1149.3563604381573, 746.268656716421, 808.2362167751536, 882.2544949517647, 886.4193952960821, 898.7842917699836, 5182.24857395683, 5281.234221038005, 5309.097453432925, 5363.785448582091, 5455.645383050089, 408.66693644680083, 431.09470112763574, 432.90043290042837, 434.9478062632504, 438.57020120281663, 3530.6998905093355, 3588.8743893964106, 3645.8906232813056, 3667.449882517644, 3744.9438258426144, 9890.604375824887, 10101.797964040677, 10186.643467478603, 10251.897481025095, 10260.486975651187, 9468.479233642078, 9997.550110245056, 10107.444090574942, 10115.696529104138, 10125.898741012496, 7637.2362763724295, 7786.1435242123325, 7806.843863122705, 7818.452708310478, 7818.765437036898, 5142.5885929126325, 5343.812966546152, 5450.400455949922, 5552.944470555404, 5692.260006199168, 8967.641294348414, 9234.03042680509, 9352.812943741223, 9401.10689484498, 9597.712068637673, 9576.138147566753, 9579.9042009579, 9580.515020171884, 9618.567164477756, 9656.468894210886, 6573.211214654272, 6801.18385793708, 7355.963220183865, 7384.704611815468, 7527.548347099191, 7966.322862556516, 8083.070446898682, 8090.433669643068, 8091.757247282591, 8097.716579919675, 7103.076600041962, 7174.174969878322, 7293.671784769805, 7343.3390994810725, 7385.7045718170675, 7094.503384763017, 7096.290370962863, 7177.641117943977, 7367.189609143097, 7395.223501532261, 5994.850128746816, 6101.176341194059, 6102.4507794298725, 6104.298005729398, 6105.084237364431, 4481.977590112028, 4517.412736344254, 4548.545145485557, 4588.88527786808, 4636.559526844944, 4625.560571745679, 4687.531246875422, 4768.737719425326, 4795.088933102699, 4971.751412429292], "value": 4208.403176900353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.5419371591795, 364.3605472395945, 366.94679271505635, 374.4439507331614, 376.32825406649135, 5074.949250507494, 5156.510131537508, 5238.84283471496, 5264.789408423663, 5309.920351194735, 5115.693058416488, 5227.5295223429885, 5255.553277971377, 5274.334337635345, 5276.498732620405, 3983.382575700771, 4069.2268468990947, 4076.9219239474305, 4211.43145675333, 4229.851955181553, 4133.689973252003, 4148.713898691401, 4158.812853421588, 4181.916361672765, 4192.203481338551, 4123.463949686537, 4129.15352352767, 4138.524069731974, 4151.647109995654, 4180.51924028736, 4076.164386300801, 4146.875593732193, 4173.457450531427, 4180.393842892794, 4180.79096045198, 3715.1269451678836, 3723.94414083789, 3731.533558305212, 3733.626637336272, 3745.0, 5045.318881950926, 5063.8480845574695, 5079.974600127012, 5094.7197904115255, 5104.438511763703, 4699.224627936386, 4707.31743897133, 4724.76376181193, 4730.645201609858, 4754.619630429557, 5157.458466860963, 5369.7583608737705, 5384.957499013045, 5404.4325345838515, 5423.457654234585, 3806.695464362844, 3811.313963486571, 3818.8472461101524, 3838.366669499529, 3840.078381188495, 5622.409646987048, 5649.887002259932, 5655.570652173918, 5656.321241451053, 5659.377468478464, 3811.313963486599, 3908.4332771747936, 3933.3903244997073, 3953.683705303569, 3962.881113566598, 3981.6615587675374, 3989.6608788252743, 3999.580044095328, 4005.1989602079116, 4011.197760447922, 4555.886102847456, 4561.673546491247, 4568.132054909556, 4590.40324757786, 4590.517995610479, 5122.282880396748, 5249.396319423316, 5476.205950137208, 5478.397376288605, 5491.258680078218, 1345.3407830163148, 1354.0859919554262, 1356.5252161743508, 1356.7286542691502, 1356.816829727974, 888.706726780161, 917.8210249001514, 934.5140526926097, 934.9158575728081, 936.2790651198675, 5134.332536770271, 5160.329157209539, 5173.482651734872, 5198.037118842223, 5199.674083108859, 5333.973330133324, 5383.569314454834, 5391.406945236021, 5395.167537043084, 5422.945770542323, 5061.746912654353, 5147.897042059138, 5166.948330516647, 5170.6122040847085, 5372.785088596413, 2870.555063965047, 2881.971180288212, 2893.7395634393006, 2897.4060317634835, 2913.941721165565, 5598.068666310117, 5623.718814059281, 5623.803166889139, 5641.887162256814, 5650.886982260332, 5416.187571864252, 5490.670559766427, 5693.572982026281, 5738.651416917021, 5770.278715160605, 5807.796727114531, 5817.563682723812, 5818.272715910512, 5842.941570584239, 5865.560082993792, 5510.0, 5642.6614403135945, 5643.1535269709875, 5646.548276137817, 5660.29246344207, 5561.443855614406, 5576.832695019156, 5578.163275508706, 5589.0, 5589.944100559105, 5846.707664616667, 5864.9413505864395, 5866.266716660418, 5867.20792692981, 5900.350961394157, 4039.6970227232487, 4059.898502537342, 4069.1658210066275, 4095.6928230382246, 4110.260153172458, 5365.543928766098, 5487.00957977895, 5517.5585953124455, 5546.362168350692, 5605.094267948917, 5344.866378340573, 5355.625106242525, 5369.19462080691, 5369.946300536944, 5405.918626382924, 5411.485908838654, 5430.321209848769, 5449.836504904859, 5455.890882182413, 5464.890702186013, 5258.921116183337, 5412.242286079873, 5418.620696551204, 5442.455754424526, 5451.56387488992, 5510.429527584619, 5533.418991005887, 5533.7786488540005, 5547.306586676666, 5549.916751248654, 5246.606504512253, 5378.327709036371, 5410.918836217538, 5433.809816656398, 5434.83695489136], "value": 4174.564699767828, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.8454063295128, 683.753848614499, 691.8097523181125, 740.9700516282369, 823.8105235795765, 14422.35099420526, 15567.29947152378, 15890.682186356265, 16074.0, 16086.67826643468, 13820.170789752598, 13890.374933128009, 14235.572932812007, 14243.78634320486, 14257.35841887115, 736.6316841579197, 757.8408534207823, 759.2635143910426, 759.4987308376473, 759.582229773625, 632.4560877645245, 657.5955787190867, 711.1750369571298, 739.5156172706886, 763.0766772205637, 791.2799352589145, 797.3700776386647, 798.9161138080476, 800.1398496616132, 800.3997002248313, 792.8771040488733, 792.9563873986929, 792.9643166057571, 793.1354823242665, 794.2057942057942, 480.96633235673517, 493.91603427417425, 545.8389775016379, 566.4703502225433, 582.6591444005262, 13819.170849749047, 13822.032457727963, 13847.30763461833, 13852.445902163901, 13864.4454221831, 13846.792298115537, 13863.168209907337, 14074.648133796634, 14145.222012789292, 14148.646283842987, 12447.626571202878, 12468.0, 12572.057095717857, 12897.742045159044, 12956.0, 4220.430241917333, 4317.0, 4344.4352234209355, 4462.9107417851465, 4521.186186486431, 73159.63420182918, 75109.62445187794, 75151.62424187899, 75779.11755001663, 75951.0, 10045.19638428924, 10580.470976451146, 10614.203934704929, 10812.459377031117, 10826.0, 20171.0, 20182.697259541117, 20245.978245739647, 20355.79644203539, 20450.488737781674, 7564.054493188351, 7629.961850190713, 7661.0, 7739.1873853245725, 7917.445778795544, 4385.298352263686, 4418.80115394808, 4444.2222611042935, 4531.4109165808895, 4661.696989695659, 3177.618685757724, 3226.1128189748006, 3226.757993150476, 3251.3172233830687, 3261.3640340133447, 530.3662123762067, 535.4270930104828, 541.4964083402474, 544.7548603128608, 551.7461967494997, 613.9079138129316, 634.8381162803455, 635.8696467224208, 649.9870002599921, 654.159405164371, 7972.590496052459, 8508.574571271412, 9042.266456365876, 9317.580708868118, 9323.25413966881, 527.8653943244448, 529.2537522093829, 585.844751140948, 596.9850753731191, 642.7332656947408, 4343.655385353323, 4394.670399720034, 4496.235639941217, 4533.365328853963, 4555.658325625592, 81460.0, 81966.59016704878, 82242.17757822345, 82335.0, 83903.0, 71250.64374678198, 72913.27086729064, 73676.26323736801, 74818.25181748222, 76473.61763191149, 67109.6644516784, 68472.65763671149, 69058.65470672614, 69555.65222173856, 71239.64380178066, 8472.942809633241, 8510.361722870686, 8717.91282087171, 9078.273738100805, 9907.851382229417, 41208.38187427251, 41208.79395603123, 41811.0, 41859.0, 42771.35842962296, 54351.72824135854, 57291.71354143203, 57610.71194644, 57909.4209057904, 59257.0, 11849.466773995018, 11955.0, 11971.880281197426, 12210.475828853154, 12608.306543139848, 14144.929275353557, 14374.496892608708, 14830.258487075818, 14880.702385952436, 15001.699966000837, 12989.28558929268, 13302.800457993331, 13428.865711342762, 13521.661958451117, 13595.932020340231, 12916.806247906477, 13044.804327935279, 13139.14595551286, 13303.46786128544, 13351.0, 12604.49582016709, 12833.743325133259, 13240.801387978996, 13330.86669133335, 13471.932640336736, 10617.203709721956, 11230.550777969116, 11302.717432064264, 11431.485583148611, 11459.885401145882, 11225.550977961117, 11458.656240312805, 11515.769684606428, 11536.0, 11683.123765717435], "value": 6949.670336017304, "unit": "score"}], "name": "dromaeo_css", "value": 6755.917063325759, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 110.0, 113.0, 112.0, 112.0, 111.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 122.0, 168.0, 124.0, 125.0, 120.0, 121.0, 140.0, 128.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 159.0, 161.0, 160.0, 160.0, 159.0, 161.0, 161.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 109.0, 78.0, 75.0, 76.0, 75.0, 90.0, 77.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 111.0, 84.0, 84.0, 84.0, 93.0, 84.0, 84.0, 106.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 49.0, 50.0, 51.0, 52.0, 55.0, 51.0, 52.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 86.0, 80.0, 80.0, 80.0, 80.0, 79.0, 88.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 130.0, 128.0, 126.0, 133.0, 133.0, 123.0, 164.0, 145.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 162.0, 163.0, 169.0, 162.0, 162.0, 164.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 63.0, 62.0, 63.0, 63.0, 62.0, 61.0, 61.0, 62.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1487.1999999999996, "alertThreshold": 2.0}]} 12:35:42 INFO - Return code: 0 12:35:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:35:42 INFO - # TBPL SUCCESS # 12:35:42 INFO - Running post-action listener: _resource_record_post_action 12:35:42 INFO - [mozharness: 2016-12-21 20:35:42.111318Z] Finished run-tests step (success) 12:35:42 INFO - Running post-run listener: _resource_record_post_run 12:35:42 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 40960; Write bytes: 395821056; Read time: 48; Write time: 280896 12:35:42 INFO - TinderboxPrint: CPU usage
13.1% 12:35:42 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 48 12:35:42 INFO - TinderboxPrint: I/O write bytes / time
395,821,056 / 280,896 12:35:42 INFO - TinderboxPrint: CPU idle
8,286.2 (86.9%) 12:35:42 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 12:35:42 INFO - TinderboxPrint: Swap in / out
0 / 0 12:35:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103194624; Read time: 0; Write time: 71356 12:35:42 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 36864; Write bytes: 291721216; Read time: 40; Write time: 209516 12:35:42 INFO - Running post-run listener: _upload_blobber_files 12:35:42 INFO - Blob upload gear active. 12:35:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:42 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 12:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:35:43 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:47 INFO - (blobuploader) - INFO - Done attempting. 12:35:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:35:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:35:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:48 INFO - (blobuploader) - INFO - Done attempting. 12:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:50 INFO - (blobuploader) - INFO - Done attempting. 12:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:51 INFO - (blobuploader) - INFO - Done attempting. 12:35:51 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:51 INFO - Return code: 0 12:35:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e384c74c8a1c94e237f35e46f71ffbb1be56c4498ad0215fbfc1bd8b45de8cc766051d680e06608ae22d02e260ae88f2e549fcf272c2e9d0dd042e5a8ba6e2ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e28934ce95e742063a6225147ba25aed878750b1189764eee8326fc871bff15d626b6444e621db8b2e4592bceae8d515eb6743d3a6e64103c4ad873f50f46590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c640a994658d994ff1f4635d8db9a09e6b71d8b9159c1620e4409bda11f76fa7a1c309f7998019b8076e4af201039ee6696c97bf9578eb653a40ba8b3c49dd5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d7d3e1bd14abf8938b11eecfaba26cbd0eb25052c371cf9aa45344545d15fc09b1a564962c1ca5637d198cb12413e6527c7a082644ede955b628c5f7840a24c"} 12:35:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:51 INFO - Contents: 12:35:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e384c74c8a1c94e237f35e46f71ffbb1be56c4498ad0215fbfc1bd8b45de8cc766051d680e06608ae22d02e260ae88f2e549fcf272c2e9d0dd042e5a8ba6e2ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e28934ce95e742063a6225147ba25aed878750b1189764eee8326fc871bff15d626b6444e621db8b2e4592bceae8d515eb6743d3a6e64103c4ad873f50f46590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c640a994658d994ff1f4635d8db9a09e6b71d8b9159c1620e4409bda11f76fa7a1c309f7998019b8076e4af201039ee6696c97bf9578eb653a40ba8b3c49dd5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d7d3e1bd14abf8938b11eecfaba26cbd0eb25052c371cf9aa45344545d15fc09b1a564962c1ca5637d198cb12413e6527c7a082644ede955b628c5f7840a24c"} 12:35:51 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:51 INFO - Copying logs to upload dir... 12:35:51 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.967830 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-12-21 12:35:51.096561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 12:35:51.100159) ========= 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=3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e384c74c8a1c94e237f35e46f71ffbb1be56c4498ad0215fbfc1bd8b45de8cc766051d680e06608ae22d02e260ae88f2e549fcf272c2e9d0dd042e5a8ba6e2ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e28934ce95e742063a6225147ba25aed878750b1189764eee8326fc871bff15d626b6444e621db8b2e4592bceae8d515eb6743d3a6e64103c4ad873f50f46590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c640a994658d994ff1f4635d8db9a09e6b71d8b9159c1620e4409bda11f76fa7a1c309f7998019b8076e4af201039ee6696c97bf9578eb653a40ba8b3c49dd5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d7d3e1bd14abf8938b11eecfaba26cbd0eb25052c371cf9aa45344545d15fc09b1a564962c1ca5637d198cb12413e6527c7a082644ede955b628c5f7840a24c"} build_url:https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011843 build_url: 'https://queue.taskcluster.net/v1/task/Esw5LrVfQxSyOVxLbmmNHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e384c74c8a1c94e237f35e46f71ffbb1be56c4498ad0215fbfc1bd8b45de8cc766051d680e06608ae22d02e260ae88f2e549fcf272c2e9d0dd042e5a8ba6e2ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e28934ce95e742063a6225147ba25aed878750b1189764eee8326fc871bff15d626b6444e621db8b2e4592bceae8d515eb6743d3a6e64103c4ad873f50f46590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c640a994658d994ff1f4635d8db9a09e6b71d8b9159c1620e4409bda11f76fa7a1c309f7998019b8076e4af201039ee6696c97bf9578eb653a40ba8b3c49dd5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d7d3e1bd14abf8938b11eecfaba26cbd0eb25052c371cf9aa45344545d15fc09b1a564962c1ca5637d198cb12413e6527c7a082644ede955b628c5f7840a24c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 12:35:51.131286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:35:51.131753) ========= 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=3836458cccd887f2d2de3cf1000001de-1482351306.131190-603607939 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:35:51.214334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 12:35:51.214700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 12:35:51.215004) ========= ========= Total master_lag: 0.18 =========