builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1474601469.24 results: success (0) buildid: 20160922200443 builduid: 63ada531c892463baa96f613d2679f0f revision: f56a2d286cf7a13c04c6e815c3cfbc439ececf9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.242294) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.242759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.243073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.271464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.271781) ========= 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=232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 20:31:09-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-09-22 20:31:09 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140407 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.427492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.427993) ========= 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=232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:09.478539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 20:31:09.478925) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f56a2d286cf7a13c04c6e815c3cfbc439ececf9c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f56a2d286cf7a13c04c6e815c3cfbc439ececf9c --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=232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 20:31:09,953 truncating revision to first 12 chars 2016-09-22 20:31:09,953 Setting DEBUG logging. 2016-09-22 20:31:09,953 attempt 1/10 2016-09-22 20:31:09,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f56a2d286cf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 20:31:11,336 unpacking tar archive at: autoland-f56a2d286cf7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.733637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 20:31:11.226423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:11.226781) ========= script_repo_revision: f56a2d286cf7a13c04c6e815c3cfbc439ececf9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:11.227255) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:11.227568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 20:31:11.237987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-22 20:31:11.238324) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:31:11 INFO - MultiFileLogger online at 20160922 20:31:11 in /builds/slave/test 20:31:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 20:31:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:31:11 INFO - {'append_to_log': False, 20:31:11 INFO - 'base_work_dir': '/builds/slave/test', 20:31:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:31:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:31:11 INFO - 'branch': 'Autoland-Non-PGO', 20:31:11 INFO - 'buildbot_json_path': 'buildprops.json', 20:31:11 INFO - 'config_files': ('talos/linux_config.py',), 20:31:11 INFO - 'default_actions': ('clobber', 20:31:11 INFO - 'read-buildbot-config', 20:31:11 INFO - 'download-and-extract', 20:31:11 INFO - 'populate-webroot', 20:31:11 INFO - 'create-virtualenv', 20:31:11 INFO - 'install', 20:31:11 INFO - 'run-tests'), 20:31:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:31:11 INFO - 'download_minidump_stackwalk': True, 20:31:11 INFO - 'download_symbols': 'ondemand', 20:31:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:31:11 INFO - 'tooltool.py': '/tools/tooltool.py', 20:31:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:31:11 INFO - '/tools/misc-python/virtualenv.py')}, 20:31:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:31:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:31:11 INFO - 'installer_path': 'installer.exe', 20:31:11 INFO - 'log_level': 'info', 20:31:11 INFO - 'log_name': 'talos', 20:31:11 INFO - 'log_to_console': True, 20:31:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:31:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:31:11 INFO - 'opt_config_files': (), 20:31:11 INFO - 'pip_index': False, 20:31:11 INFO - 'sps_profile': False, 20:31:11 INFO - 'sps_profile_interval': 0, 20:31:11 INFO - 'suite': 'dromaeojs', 20:31:11 INFO - 'system_bits': '32', 20:31:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:31:11 INFO - 'title': 'talos-linux64-ix-025', 20:31:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:31:11 INFO - 'use_talos_json': True, 20:31:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:31:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:31:11 INFO - 'work_dir': 'build'} 20:31:11 INFO - [mozharness: 2016-09-23 03:31:11.806985Z] Running clobber step. 20:31:11 INFO - Running pre-action listener: _resource_record_pre_action 20:31:11 INFO - Running main action method: clobber 20:31:11 INFO - rmtree: /builds/slave/test/build 20:31:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:31:12 INFO - Running post-action listener: _resource_record_post_action 20:31:12 INFO - [mozharness: 2016-09-23 03:31:12.257967Z] Finished clobber step (success) 20:31:12 INFO - [mozharness: 2016-09-23 03:31:12.258078Z] Running read-buildbot-config step. 20:31:12 INFO - Running pre-action listener: _resource_record_pre_action 20:31:12 INFO - Running main action method: read_buildbot_config 20:31:12 INFO - Using buildbot properties: 20:31:12 INFO - { 20:31:12 INFO - "project": "", 20:31:12 INFO - "product": "firefox", 20:31:12 INFO - "script_repo_revision": "production", 20:31:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:31:12 INFO - "repository": "", 20:31:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 20:31:12 INFO - "buildid": "20160922200443", 20:31:12 INFO - "pgo_build": "False", 20:31:12 INFO - "basedir": "/builds/slave/test", 20:31:12 INFO - "buildnumber": 630, 20:31:12 INFO - "slavename": "talos-linux64-ix-025", 20:31:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:31:12 INFO - "platform": "ubuntu64_hw", 20:31:12 INFO - "scheduler": "tests-autoland-linux64-talos", 20:31:12 INFO - "branch": "autoland", 20:31:12 INFO - "repo_path": "integration/autoland", 20:31:12 INFO - "revision": "f56a2d286cf7a13c04c6e815c3cfbc439ececf9c", 20:31:12 INFO - "stage_platform": "linux64", 20:31:12 INFO - "builduid": "63ada531c892463baa96f613d2679f0f", 20:31:12 INFO - "slavebuilddir": "test" 20:31:12 INFO - } 20:31:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:31:12 INFO - Running post-action listener: _resource_record_post_action 20:31:12 INFO - [mozharness: 2016-09-23 03:31:12.260519Z] Finished read-buildbot-config step (success) 20:31:12 INFO - [mozharness: 2016-09-23 03:31:12.260609Z] Running download-and-extract step. 20:31:12 INFO - Running pre-action listener: _resource_record_pre_action 20:31:12 INFO - Running main action method: download_and_extract 20:31:12 INFO - mkdir: /builds/slave/test/build/tests 20:31:12 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')]} 20:31:12 INFO - trying https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:31:12 INFO - Downloading https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:31:12 INFO - Downloaded 1361 bytes. 20:31:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:31:12 INFO - Using the following test package requirements: 20:31:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:31:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:31:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:31:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'jsshell-linux-x86_64.zip'], 20:31:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:31:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:31:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:31:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:31:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:31:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:31:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:31:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:31:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:31:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:31:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:31:13 INFO - Expected file size: 20371663 20:31:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:31:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:31:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:31:17 INFO - Fetch https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:31:18 INFO - Expected file size: 20371663 20:31:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:31:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:31:23 INFO - Fetch https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:31:23 INFO - Expected file size: 14414059 20:31:25 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')]} 20:31:25 INFO - trying https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:31:25 INFO - Downloading https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:31:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:31:27 INFO - Downloaded 55700380 bytes. 20:31:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:31:27 INFO - mkdir: /builds/slave/test/properties 20:31:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:31:27 INFO - Writing to file /builds/slave/test/properties/build_url 20:31:27 INFO - Contents: 20:31:27 INFO - build_url:https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:31:27 INFO - Running post-action listener: _resource_record_post_action 20:31:27 INFO - Running post-action listener: set_extra_try_arguments 20:31:27 INFO - [mozharness: 2016-09-23 03:31:27.714941Z] Finished download-and-extract step (success) 20:31:27 INFO - [mozharness: 2016-09-23 03:31:27.715168Z] Running populate-webroot step. 20:31:27 INFO - Running pre-action listener: _resource_record_pre_action 20:31:27 INFO - Running main action method: populate_webroot 20:31:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:31:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:31:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:31:27 INFO - '--tppagecycles', 20:31:27 INFO - '7'], 20:31:27 INFO - 'tests': ['tsvgm']}}, 20:31:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:31:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:31:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:31:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:31:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:31:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:31:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['damp', 'tps']}, 20:31:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'tests': ['damp', 'tps']}, 20:31:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['dromaeo_dom']}, 20:31:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:31:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['basic_compositor_video']}, 20:31:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:31:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['a11yr', 20:31:27 INFO - 'ts_paint', 20:31:27 INFO - 'tpaint', 20:31:27 INFO - 'sessionrestore', 20:31:27 INFO - 'sessionrestore_no_auto_restore', 20:31:27 INFO - 'tabpaint']}, 20:31:27 INFO - 'other-e10s': {'tests': ['a11yr', 20:31:27 INFO - 'ts_paint', 20:31:27 INFO - 'tpaint', 20:31:27 INFO - 'sessionrestore', 20:31:27 INFO - 'sessionrestore_no_auto_restore', 20:31:27 INFO - 'tabpaint']}, 20:31:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:31:27 INFO - 'ts_paint', 20:31:27 INFO - 'tpaint', 20:31:27 INFO - 'sessionrestore', 20:31:27 INFO - 'sessionrestore_no_auto_restore', 20:31:27 INFO - 'tabpaint']}, 20:31:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:31:27 INFO - 'ts_paint', 20:31:27 INFO - 'tpaint', 20:31:27 INFO - 'sessionrestore', 20:31:27 INFO - 'sessionrestore_no_auto_restore', 20:31:27 INFO - 'tabpaint']}, 20:31:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['a11yr', 20:31:27 INFO - 'ts_paint', 20:31:27 INFO - 'tpaint', 20:31:27 INFO - 'sessionrestore', 20:31:27 INFO - 'sessionrestore_no_auto_restore', 20:31:27 INFO - 'tabpaint']}, 20:31:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['a11yr', 20:31:27 INFO - 'ts_paint', 20:31:27 INFO - 'tpaint', 20:31:27 INFO - 'sessionrestore', 20:31:27 INFO - 'sessionrestore_no_auto_restore', 20:31:27 INFO - 'tabpaint']}, 20:31:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['tsvgx', 20:31:27 INFO - 'tsvgr_opacity', 20:31:27 INFO - 'tart', 20:31:27 INFO - 'tscrollx', 20:31:27 INFO - 'cart']}, 20:31:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:31:27 INFO - 'tsvgr_opacity', 20:31:27 INFO - 'tart', 20:31:27 INFO - 'tscrollx', 20:31:27 INFO - 'cart']}, 20:31:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'talos_options': ['--disable-e10s'], 20:31:27 INFO - 'tests': ['tp5o']}, 20:31:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'tests': ['tp5o']}, 20:31:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'talos_options': ['--disable-e10s', 20:31:27 INFO - '--xperf_path', 20:31:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:31:27 INFO - 'tests': ['tp5n']}, 20:31:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:31:27 INFO - 'talos_options': ['--xperf_path', 20:31:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:31:27 INFO - 'tests': ['tp5n']}}, 20:31:27 INFO - 'talos.zip': {'path': '', 20:31:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:31:27 INFO - Running post-action listener: _resource_record_post_action 20:31:27 INFO - [mozharness: 2016-09-23 03:31:27.730419Z] Finished populate-webroot step (success) 20:31:27 INFO - [mozharness: 2016-09-23 03:31:27.730507Z] Running create-virtualenv step. 20:31:27 INFO - Running pre-action listener: _resource_record_pre_action 20:31:27 INFO - Running main action method: create_virtualenv 20:31:27 INFO - Creating virtualenv /builds/slave/test/build/venv 20:31:27 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 20:31:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:31:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:31:27 INFO - Using real prefix '/usr' 20:31:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:31:28 INFO - Installing distribute.............................................................................................................................................................................................done. 20:31:30 INFO - Installing pip.................done. 20:31:30 INFO - Return code: 0 20:31:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31: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', 'pip>=1.5'] in /builds/slave/test/build 20:31: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 pip>=1.5 20:31:30 INFO - Using env: {'DISPLAY': ':0', 20:31:30 INFO - 'HOME': '/home/cltbld', 20:31:30 INFO - 'LANG': 'en_US.UTF-8', 20:31:30 INFO - 'LANGUAGE': 'en_US:en', 20:31:30 INFO - 'LOGNAME': 'cltbld', 20:31:30 INFO - 'MAIL': '/var/mail/cltbld', 20:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:30 INFO - 'MOZ_NO_REMOTE': '1', 20:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:30 INFO - 'NO_EM_RESTART': '1', 20:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:30 INFO - 'PWD': '/builds/slave/test', 20:31:30 INFO - 'SHELL': '/bin/bash', 20:31:30 INFO - 'SHLVL': '1', 20:31:30 INFO - 'TERM': 'linux', 20:31:30 INFO - 'TMOUT': '86400', 20:31:30 INFO - 'USER': 'cltbld', 20:31:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:30 INFO - '_': '/tools/buildbot/bin/python'} 20:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:30 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 20:31:30 INFO - Cleaning up... 20:31:30 INFO - Return code: 0 20:31:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31: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', '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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:31: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 psutil>=3.1.1 20:31:30 INFO - Using env: {'DISPLAY': ':0', 20:31:30 INFO - 'HOME': '/home/cltbld', 20:31:30 INFO - 'LANG': 'en_US.UTF-8', 20:31:30 INFO - 'LANGUAGE': 'en_US:en', 20:31:30 INFO - 'LOGNAME': 'cltbld', 20:31:30 INFO - 'MAIL': '/var/mail/cltbld', 20:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:30 INFO - 'MOZ_NO_REMOTE': '1', 20:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:30 INFO - 'NO_EM_RESTART': '1', 20:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:30 INFO - 'PWD': '/builds/slave/test', 20:31:30 INFO - 'SHELL': '/bin/bash', 20:31:30 INFO - 'SHLVL': '1', 20:31:30 INFO - 'TERM': 'linux', 20:31:30 INFO - 'TMOUT': '86400', 20:31:30 INFO - 'USER': 'cltbld', 20:31:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:30 INFO - '_': '/tools/buildbot/bin/python'} 20:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:30 INFO - Downloading/unpacking psutil>=3.1.1 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:31:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:31:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:31:32 INFO - Installing collected packages: psutil 20:31:32 INFO - Running setup.py install for psutil 20:31:32 INFO - building 'psutil._psutil_linux' extension 20:31:32 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 20:31:32 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 20:31:33 INFO - building 'psutil._psutil_posix' extension 20:31:33 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 20:31:33 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 20:31:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:31:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:31:33 INFO - Successfully installed psutil 20:31:33 INFO - Cleaning up... 20:31:33 INFO - Return code: 0 20:31:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:33 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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31:33 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 20:31:33 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 20:31:33 INFO - Using env: {'DISPLAY': ':0', 20:31:33 INFO - 'HOME': '/home/cltbld', 20:31:33 INFO - 'LANG': 'en_US.UTF-8', 20:31:33 INFO - 'LANGUAGE': 'en_US:en', 20:31:33 INFO - 'LOGNAME': 'cltbld', 20:31:33 INFO - 'MAIL': '/var/mail/cltbld', 20:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:33 INFO - 'MOZ_NO_REMOTE': '1', 20:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:33 INFO - 'NO_EM_RESTART': '1', 20:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:33 INFO - 'PWD': '/builds/slave/test', 20:31:33 INFO - 'SHELL': '/bin/bash', 20:31:33 INFO - 'SHLVL': '1', 20:31:33 INFO - 'TERM': 'linux', 20:31:33 INFO - 'TMOUT': '86400', 20:31:33 INFO - 'USER': 'cltbld', 20:31:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:33 INFO - '_': '/tools/buildbot/bin/python'} 20:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:31:33 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 20:31:33 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 20:31:33 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 20:31:33 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 20:31:33 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 20:31:33 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 20:31:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:31:35 INFO - Installing collected packages: mozsystemmonitor 20:31:35 INFO - Running setup.py install for mozsystemmonitor 20:31:35 INFO - Successfully installed mozsystemmonitor 20:31:35 INFO - Cleaning up... 20:31:35 INFO - Return code: 0 20:31:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:31: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')]} 20:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31: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')]} 20:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31: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', '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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:31: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 jsonschema==2.5.1 20:31:35 INFO - Using env: {'DISPLAY': ':0', 20:31:35 INFO - 'HOME': '/home/cltbld', 20:31:35 INFO - 'LANG': 'en_US.UTF-8', 20:31:35 INFO - 'LANGUAGE': 'en_US:en', 20:31:35 INFO - 'LOGNAME': 'cltbld', 20:31:35 INFO - 'MAIL': '/var/mail/cltbld', 20:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:35 INFO - 'MOZ_NO_REMOTE': '1', 20:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:35 INFO - 'NO_EM_RESTART': '1', 20:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:35 INFO - 'PWD': '/builds/slave/test', 20:31:35 INFO - 'SHELL': '/bin/bash', 20:31:35 INFO - 'SHLVL': '1', 20:31:35 INFO - 'TERM': 'linux', 20:31:35 INFO - 'TMOUT': '86400', 20:31:35 INFO - 'USER': 'cltbld', 20:31:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:35 INFO - '_': '/tools/buildbot/bin/python'} 20:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:35 INFO - Downloading/unpacking jsonschema==2.5.1 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:31:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 20:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:31:38 INFO - warning: no files found matching '*.txt' 20:31:38 INFO - no previously-included directories found matching 'build' 20:31:38 INFO - no previously-included directories found matching 'dist' 20:31:38 INFO - no previously-included directories found matching '.git*' 20:31:38 INFO - Installing collected packages: jsonschema, functools32 20:31:38 INFO - Running setup.py install for functools32 20:31:38 INFO - warning: no files found matching '*.txt' 20:31:38 INFO - no previously-included directories found matching 'build' 20:31:38 INFO - no previously-included directories found matching 'dist' 20:31:38 INFO - no previously-included directories found matching '.git*' 20:31:38 INFO - Successfully installed jsonschema functools32 20:31:38 INFO - Cleaning up... 20:31:38 INFO - Return code: 0 20:31:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:31:38 INFO - Using env: {'DISPLAY': ':0', 20:31:38 INFO - 'HOME': '/home/cltbld', 20:31:38 INFO - 'LANG': 'en_US.UTF-8', 20:31:38 INFO - 'LANGUAGE': 'en_US:en', 20:31:38 INFO - 'LOGNAME': 'cltbld', 20:31:38 INFO - 'MAIL': '/var/mail/cltbld', 20:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:38 INFO - 'MOZ_NO_REMOTE': '1', 20:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:38 INFO - 'NO_EM_RESTART': '1', 20:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:38 INFO - 'PWD': '/builds/slave/test', 20:31:38 INFO - 'SHELL': '/bin/bash', 20:31:38 INFO - 'SHLVL': '1', 20:31:38 INFO - 'TERM': 'linux', 20:31:38 INFO - 'TMOUT': '86400', 20:31:38 INFO - 'USER': 'cltbld', 20:31:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:38 INFO - '_': '/tools/buildbot/bin/python'} 20:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:31:38 INFO - Cleaning up... 20:31:38 INFO - Return code: 0 20:31:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:31:38 INFO - Using env: {'DISPLAY': ':0', 20:31:38 INFO - 'HOME': '/home/cltbld', 20:31:38 INFO - 'LANG': 'en_US.UTF-8', 20:31:38 INFO - 'LANGUAGE': 'en_US:en', 20:31:38 INFO - 'LOGNAME': 'cltbld', 20:31:38 INFO - 'MAIL': '/var/mail/cltbld', 20:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:38 INFO - 'MOZ_NO_REMOTE': '1', 20:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:38 INFO - 'NO_EM_RESTART': '1', 20:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:38 INFO - 'PWD': '/builds/slave/test', 20:31:38 INFO - 'SHELL': '/bin/bash', 20:31:38 INFO - 'SHLVL': '1', 20:31:38 INFO - 'TERM': 'linux', 20:31:38 INFO - 'TMOUT': '86400', 20:31:38 INFO - 'USER': 'cltbld', 20:31:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:38 INFO - '_': '/tools/buildbot/bin/python'} 20:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31: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 20:31:40 INFO - Downloading blobuploader-1.2.4.tar.gz 20:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:31:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:31:40 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 20:31:40 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 20:31:40 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 20:31:40 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 20:31:40 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 20:31:40 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 20:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:31:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:41 INFO - Downloading docopt-0.6.1.tar.gz 20:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:31:41 INFO - Installing collected packages: blobuploader, requests, docopt 20:31:41 INFO - Running setup.py install for blobuploader 20:31:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:31:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:31:41 INFO - Running setup.py install for requests 20:31:41 INFO - Running setup.py install for docopt 20:31:41 INFO - Successfully installed blobuploader requests docopt 20:31:41 INFO - Cleaning up... 20:31:41 INFO - Return code: 0 20:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:31:41 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')]} 20:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:41 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')]} 20:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:41 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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31:41 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 20:31:41 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 20:31:41 INFO - Using env: {'DISPLAY': ':0', 20:31:41 INFO - 'HOME': '/home/cltbld', 20:31:41 INFO - 'LANG': 'en_US.UTF-8', 20:31:41 INFO - 'LANGUAGE': 'en_US:en', 20:31:41 INFO - 'LOGNAME': 'cltbld', 20:31:41 INFO - 'MAIL': '/var/mail/cltbld', 20:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:41 INFO - 'MOZ_NO_REMOTE': '1', 20:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:41 INFO - 'NO_EM_RESTART': '1', 20:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:41 INFO - 'PWD': '/builds/slave/test', 20:31:41 INFO - 'SHELL': '/bin/bash', 20:31:41 INFO - 'SHLVL': '1', 20:31:41 INFO - 'TERM': 'linux', 20:31:41 INFO - 'TMOUT': '86400', 20:31:41 INFO - 'USER': 'cltbld', 20:31:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:41 INFO - '_': '/tools/buildbot/bin/python'} 20:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:31:42 INFO - Running setup.py (path:/tmp/pip-C2tUbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:31:42 INFO - Running setup.py (path:/tmp/pip-_T4Zow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:31:42 INFO - Running setup.py (path:/tmp/pip-RlbVWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:31:42 INFO - Running setup.py (path:/tmp/pip-qPOhhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:31:42 INFO - Running setup.py (path:/tmp/pip-0ORsns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:31:42 INFO - Running setup.py (path:/tmp/pip-XP6jwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:31:42 INFO - Running setup.py (path:/tmp/pip-bAAeji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:31:42 INFO - Running setup.py (path:/tmp/pip-ZpCsex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:31:42 INFO - Running setup.py (path:/tmp/pip-PUaNK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:31:42 INFO - Running setup.py (path:/tmp/pip-1ahs8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:31:42 INFO - Running setup.py (path:/tmp/pip-el6sqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:31:42 INFO - Running setup.py (path:/tmp/pip-BQQwkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:31:42 INFO - Running setup.py (path:/tmp/pip-qTxk71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:31:43 INFO - Running setup.py (path:/tmp/pip-rH_nme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:43 INFO - Running setup.py (path:/tmp/pip-vil4JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:31:43 INFO - Running setup.py (path:/tmp/pip-MqihiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:31:43 INFO - Running setup.py (path:/tmp/pip-5ZT9Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:31:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:31:43 INFO - Running setup.py install for manifestparser 20:31:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:31:43 INFO - Running setup.py install for mozcrash 20:31:43 INFO - Running setup.py install for mozdebug 20:31:43 INFO - Running setup.py install for mozdevice 20:31:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:31:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:31:43 INFO - Running setup.py install for mozfile 20:31:43 INFO - Running setup.py install for mozhttpd 20:31:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:31:43 INFO - Running setup.py install for mozinfo 20:31:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Running setup.py install for mozInstall 20:31:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Running setup.py install for mozleak 20:31:44 INFO - Running setup.py install for mozlog 20:31:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Running setup.py install for moznetwork 20:31:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Running setup.py install for mozprocess 20:31:44 INFO - Running setup.py install for mozprofile 20:31:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Running setup.py install for mozrunner 20:31:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:31:44 INFO - Running setup.py install for mozscreenshot 20:31:44 INFO - Running setup.py install for moztest 20:31:45 INFO - Running setup.py install for mozversion 20:31:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:31:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:31:45 INFO - Cleaning up... 20:31:45 INFO - Return code: 0 20:31:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:31:45 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')]} 20:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:45 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')]} 20:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:45 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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31:45 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 20:31:45 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 20:31:45 INFO - Using env: {'DISPLAY': ':0', 20:31:45 INFO - 'HOME': '/home/cltbld', 20:31:45 INFO - 'LANG': 'en_US.UTF-8', 20:31:45 INFO - 'LANGUAGE': 'en_US:en', 20:31:45 INFO - 'LOGNAME': 'cltbld', 20:31:45 INFO - 'MAIL': '/var/mail/cltbld', 20:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:45 INFO - 'MOZ_NO_REMOTE': '1', 20:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:45 INFO - 'NO_EM_RESTART': '1', 20:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:45 INFO - 'PWD': '/builds/slave/test', 20:31:45 INFO - 'SHELL': '/bin/bash', 20:31:45 INFO - 'SHLVL': '1', 20:31:45 INFO - 'TERM': 'linux', 20:31:45 INFO - 'TMOUT': '86400', 20:31:45 INFO - 'USER': 'cltbld', 20:31:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:45 INFO - '_': '/tools/buildbot/bin/python'} 20:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:31:45 INFO - Running setup.py (path:/tmp/pip-cE1r09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:31:45 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)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:31:45 INFO - Running setup.py (path:/tmp/pip-Y5wAcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:31:45 INFO - Running setup.py (path:/tmp/pip-zn7qqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:31:45 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)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:31:45 INFO - Running setup.py (path:/tmp/pip-be1jY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:31:45 INFO - Running setup.py (path:/tmp/pip-sVB4Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:31:45 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)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:31:45 INFO - Running setup.py (path:/tmp/pip-PspK6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:31:45 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)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:31:45 INFO - Running setup.py (path:/tmp/pip-GanuU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:31:45 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)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:31:45 INFO - Running setup.py (path:/tmp/pip-RdGCNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:31:45 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)) 20:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:31:45 INFO - Running setup.py (path:/tmp/pip-sMjSdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:31:46 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)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:31:46 INFO - Running setup.py (path:/tmp/pip-mMH_Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:31:46 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)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:31:46 INFO - Running setup.py (path:/tmp/pip-7irsN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:31:46 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)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:31:46 INFO - Running setup.py (path:/tmp/pip-mXCrjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:31:46 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)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:31:46 INFO - Running setup.py (path:/tmp/pip-GYiTD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:31:46 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)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:31:46 INFO - Running setup.py (path:/tmp/pip-cxPrMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:46 INFO - Running setup.py (path:/tmp/pip-V_Nfyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:31:46 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)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:31:46 INFO - Running setup.py (path:/tmp/pip-HaXcj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:31:46 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)) 20:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:31:46 INFO - Running setup.py (path:/tmp/pip-reHQAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:31:46 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)) 20:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:31:46 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)) 20:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:31:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:31:48 INFO - Downloading blessings-1.6.tar.gz 20:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:31:48 INFO - Installing collected packages: blessings 20:31:48 INFO - Running setup.py install for blessings 20:31:48 INFO - Successfully installed blessings 20:31:48 INFO - Cleaning up... 20:31:48 INFO - Return code: 0 20:31:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:31:48 INFO - Reading from file tmpfile_stdout 20:31:48 INFO - Current package versions: 20:31:48 INFO - argparse == 1.2.1 20:31:48 INFO - blessings == 1.6 20:31:48 INFO - blobuploader == 1.2.4 20:31:48 INFO - docopt == 0.6.1 20:31:48 INFO - functools32 == 3.2.3-2 20:31:48 INFO - jsonschema == 2.5.1 20:31:48 INFO - manifestparser == 1.1 20:31:48 INFO - mozInstall == 1.12 20:31:48 INFO - mozcrash == 0.17 20:31:48 INFO - mozdebug == 0.1 20:31:48 INFO - mozdevice == 0.48 20:31:48 INFO - mozfile == 1.2 20:31:48 INFO - mozhttpd == 0.7 20:31:48 INFO - mozinfo == 0.9 20:31:48 INFO - mozleak == 0.1 20:31:48 INFO - mozlog == 3.4 20:31:48 INFO - moznetwork == 0.27 20:31:48 INFO - mozprocess == 0.23 20:31:48 INFO - mozprofile == 0.28 20:31:48 INFO - mozrunner == 6.12 20:31:48 INFO - mozscreenshot == 0.1 20:31:48 INFO - mozsystemmonitor == 0.3 20:31:48 INFO - moztest == 0.7 20:31:48 INFO - mozversion == 1.4 20:31:48 INFO - psutil == 3.1.1 20:31:48 INFO - requests == 1.2.3 20:31:48 INFO - wsgiref == 0.1.2 20:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:31:48 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')]} 20:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:48 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')]} 20:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:48 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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31:48 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 20:31:48 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 20:31:48 INFO - Using env: {'DISPLAY': ':0', 20:31:48 INFO - 'HOME': '/home/cltbld', 20:31:48 INFO - 'LANG': 'en_US.UTF-8', 20:31:48 INFO - 'LANGUAGE': 'en_US:en', 20:31:48 INFO - 'LOGNAME': 'cltbld', 20:31:48 INFO - 'MAIL': '/var/mail/cltbld', 20:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:48 INFO - 'MOZ_NO_REMOTE': '1', 20:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:48 INFO - 'NO_EM_RESTART': '1', 20:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:48 INFO - 'PWD': '/builds/slave/test', 20:31:48 INFO - 'SHELL': '/bin/bash', 20:31:48 INFO - 'SHLVL': '1', 20:31:48 INFO - 'TERM': 'linux', 20:31:48 INFO - 'TMOUT': '86400', 20:31:48 INFO - 'USER': 'cltbld', 20:31:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:48 INFO - '_': '/tools/buildbot/bin/python'} 20:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 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)) 20:31:49 INFO - Cleaning up... 20:31:49 INFO - Return code: 0 20:31:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:31:49 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')]} 20:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:49 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')]} 20:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:31:49 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 0x7f45c6d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, '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': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', '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 20:31:49 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 20:31:49 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 20:31:49 INFO - Using env: {'DISPLAY': ':0', 20:31:49 INFO - 'HOME': '/home/cltbld', 20:31:49 INFO - 'LANG': 'en_US.UTF-8', 20:31:49 INFO - 'LANGUAGE': 'en_US:en', 20:31:49 INFO - 'LOGNAME': 'cltbld', 20:31:49 INFO - 'MAIL': '/var/mail/cltbld', 20:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:49 INFO - 'MOZ_NO_REMOTE': '1', 20:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:49 INFO - 'NO_EM_RESTART': '1', 20:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:49 INFO - 'PWD': '/builds/slave/test', 20:31:49 INFO - 'SHELL': '/bin/bash', 20:31:49 INFO - 'SHLVL': '1', 20:31:49 INFO - 'TERM': 'linux', 20:31:49 INFO - 'TMOUT': '86400', 20:31:49 INFO - 'USER': 'cltbld', 20:31:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:49 INFO - '_': '/tools/buildbot/bin/python'} 20:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:31:49 INFO - Cleaning up... 20:31:49 INFO - Return code: 0 20:31:49 INFO - Running post-action listener: _resource_record_post_action 20:31:49 INFO - Running post-action listener: _start_resource_monitoring 20:31:49 INFO - Starting resource monitoring. 20:31:49 INFO - [mozharness: 2016-09-23 03:31:49.469370Z] Finished create-virtualenv step (success) 20:31:49 INFO - [mozharness: 2016-09-23 03:31:49.469865Z] Running install step. 20:31:49 INFO - Running pre-action listener: _resource_record_pre_action 20:31:49 INFO - Running main action method: install 20:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:31:49 INFO - Reading from file tmpfile_stdout 20:31:49 INFO - Detecting whether we're running mozinstall >=1.0... 20:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:31:49 INFO - Reading from file tmpfile_stdout 20:31:49 INFO - Output received: 20:31:49 INFO - Usage: mozinstall [options] installer 20:31:49 INFO - Options: 20:31:49 INFO - -h, --help show this help message and exit 20:31:49 INFO - -d DEST, --destination=DEST 20:31:49 INFO - Directory to install application into. [default: 20:31:49 INFO - "/builds/slave/test"] 20:31:49 INFO - --app=APP Application being installed. [default: firefox] 20:31:49 INFO - mkdir: /builds/slave/test/build/application 20:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:32:05 INFO - Reading from file tmpfile_stdout 20:32:05 INFO - Output received: 20:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 20:32:05 INFO - Running post-action listener: _resource_record_post_action 20:32:05 INFO - [mozharness: 2016-09-23 03:32:05.853945Z] Finished install step (success) 20:32:05 INFO - [mozharness: 2016-09-23 03:32:05.854245Z] Running run-tests step. 20:32:05 INFO - Running pre-action listener: _resource_record_pre_action 20:32:05 INFO - Running main action method: run_tests 20:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:32:05 INFO - Python 2.7.3 20:32:05 INFO - Return code: 0 20:32:05 INFO - grabbing minidump binary from tooltool 20:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:05 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 0x1c96f60>, '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 0x1c97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c981d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:32:05 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 20:32:05 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 20:32:05 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 20:32:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:32:05 INFO - Return code: 0 20:32:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 20:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 20:32:05 INFO - Using env: {'DISPLAY': ':0', 20:32:05 INFO - 'HOME': '/home/cltbld', 20:32:05 INFO - 'LANG': 'en_US.UTF-8', 20:32:05 INFO - 'LANGUAGE': 'en_US:en', 20:32:05 INFO - 'LOGNAME': 'cltbld', 20:32:05 INFO - 'MAIL': '/var/mail/cltbld', 20:32:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:32:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:05 INFO - 'MOZ_NO_REMOTE': '1', 20:32:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:32:05 INFO - 'NO_EM_RESTART': '1', 20:32:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:05 INFO - 'PWD': '/builds/slave/test', 20:32:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:32:05 INFO - 'SHELL': '/bin/bash', 20:32:05 INFO - 'SHLVL': '1', 20:32:05 INFO - 'TERM': 'linux', 20:32:05 INFO - 'TMOUT': '86400', 20:32:05 INFO - 'USER': 'cltbld', 20:32:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453', 20:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:05 INFO - '_': '/tools/buildbot/bin/python'} 20:32:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 20:32:06 INFO - mozversion application_buildid: 20160922200443 20:32:06 INFO - mozversion application_changeset: f56a2d286cf7a13c04c6e815c3cfbc439ececf9c 20:32:06 INFO - mozversion application_display_name: Nightly 20:32:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:32:06 INFO - mozversion application_name: Firefox 20:32:06 INFO - mozversion application_remotingname: firefox 20:32:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:32:06 INFO - mozversion application_vendor: Mozilla 20:32:06 INFO - mozversion application_version: 52.0a1 20:32:06 INFO - mozversion platform_buildid: 20160922200443 20:32:06 INFO - mozversion platform_changeset: f56a2d286cf7a13c04c6e815c3cfbc439ececf9c 20:32:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:32:06 INFO - mozversion platform_version: 52.0a1 20:32:06 INFO - using testdate: 1474601526 20:32:06 INFO - actual date: 1474601526 20:32:06 INFO - starting webserver on 'localhost:47436' 20:32:06 INFO - SUITE-START | Running 2 tests 20:32:06 INFO - TEST-START | dromaeo_css 20:32:06 INFO - operating with platform_type : linux_ 20:32:06 INFO - Initialising browser for dromaeo_css test... 20:32:06 INFO - TEST-INFO | started process 14133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjT0eS0/profile http://localhost:47436/getInfo.html) 20:32:10 INFO - PROCESS | 14133 | __metrics Screen width/height:1600/1200 20:32:10 INFO - PROCESS | 14133 | colorDepth:24 20:32:10 INFO - PROCESS | 14133 | Browser inner width/height: 1024/697 20:32:10 INFO - PROCESS | 14133 | __metrics 20:32:11 INFO - PROCESS | 14133 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:32:11 INFO - PROCESS | 14133 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:32:11 INFO - PROCESS | 14133 | console.error: PushService: 20:32:11 INFO - PROCESS | 14133 | stateChangeProcessEnqueue: Error transitioning state 20:32:11 INFO - PROCESS | 14133 | UnknownError 20:32:12 INFO - TEST-INFO | 14133: exit 0 20:32:12 INFO - Browser initialized. 20:32:12 INFO - Running cycle 1/1 for dromaeo_css test... 20:32:12 INFO - TEST-INFO | started process 14215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjT0eS0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:32:24 INFO - PROCESS | 14215 | RSS: Main: 175255552 20:32:24 INFO - PROCESS | 14215 | 20:33:15 INFO - PROCESS | 14215 | 1474601595959 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] 20:35:29 INFO - PROCESS | 14215 | Cycle 1(1): loaded http://localhost:47436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47436/tests/dromaeo/cssquery-ext.html) 20:35:30 INFO - PROCESS | 14215 | RSS: Main: 295763968 20:35:30 INFO - PROCESS | 14215 | 20:38:33 INFO - PROCESS | 14215 | Cycle 1(1): loaded http://localhost:47436/tests/dromaeo/cssquery-ext.html (next: http://localhost:47436/tests/dromaeo/cssquery-jquery.html) 20:38:33 INFO - PROCESS | 14215 | RSS: Main: 273252352 20:38:33 INFO - PROCESS | 14215 | 20:41:36 INFO - PROCESS | 14215 | Cycle 1(1): loaded http://localhost:47436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47436/tests/dromaeo/cssquery-mootools.html) 20:41:36 INFO - PROCESS | 14215 | RSS: Main: 219643904 20:41:36 INFO - PROCESS | 14215 | 20:44:38 INFO - PROCESS | 14215 | Cycle 1(1): loaded http://localhost:47436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47436/tests/dromaeo/cssquery-prototype.html) 20:44:39 INFO - PROCESS | 14215 | RSS: Main: 221130752 20:44:39 INFO - PROCESS | 14215 | 20:47:42 INFO - PROCESS | 14215 | Cycle 1(1): loaded http://localhost:47436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47436/tests/dromaeo/cssquery-yui.html) 20:47:43 INFO - PROCESS | 14215 | RSS: Main: 222007296 20:47:43 INFO - PROCESS | 14215 | 20:50:45 INFO - PROCESS | 14215 | Cycle 1(1): loaded http://localhost:47436/tests/dromaeo/cssquery-yui.html (next: http://localhost:47436/tests/dromaeo/cssquery-dojo.html) 20:50:46 INFO - PROCESS | 14215 | RSS: Main: 312848384 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | __start_tp_report 20:50:46 INFO - PROCESS | 14215 | _x_x_mozilla_page_load 20:50:46 INFO - PROCESS | 14215 | _x_x_mozilla_page_load_details 20:50:46 INFO - PROCESS | 14215 | |i|pagename|runs| 20:50:46 INFO - PROCESS | 14215 | |0;dojo.html;2586.0431640293095;2617.803664725146;2645.7354264573546;2651.3106592286;2669.012465387807;4548.113117942003;4621.699589526678;4693.3898593182885;4705.458872229695;4726.503717109706;4647.744374059425;4668.603168730662;4673.392458980336;4678.90642187156;4708.199606066968;4274.465691788519;4287.721298115628;4343.78281085946;4357.803898824544;4361.5856493633055;4324.654027677794;4346.804393802271;4350.390945267649;4353.477582690081;4373;4276.786160691969;4336.349547567858;4356.716813407134;4419.779011049451;4429.42417485728;4120.649744771698;4193.098483825962;4331.740095594275;4347.3261644445;4361.236783562896;4195.517515485728;4225.070484493437;4248.150369926027;4252.851150209728;4282.957170428318;4553.362529245908;4559.270516717343;4621.445426548836;4637.513061128567;4643.791029403685;4947.381577302837;4948.505149485023;4965.180745177042;4965.379327584052;4980.053789779967;4905.583025442842;4989.501049895018;4993.825216117419;5048.899022019576;5063.0380227756605;4693;4722.338872557844;4724.409448818863;4725.5510726480925;4776.95223047772;5176.611754118456;5190.195519694454;5192.143296356135;5202.2456743771945;5253;4748.833790817304;4793.23308270675;4852.514748525119;4889.608831293488;4906.435759887588;4974.278729584263;4980.252962055721;4981.227909674007;4982.701037937735;5048.848534543969;4949.505049495022;4952.752362381866;4963.305137280783;4994.775235114428;5015.548600625962;4799.880002999953;4862.440819305825;4862.6839255448995;4865.5864251538305;4918.5573298403315;3927.5286965563746;3949.5063117110362;3999.4800675911947;4000.5599384067727;4004.1991601679197;3490.1623610333336;3494.668006539375;3494.8776792812127;3550.7869527827897;3568.8750893718593;4237.63980061692;4282.978585107055;4333.956660433419;4352.651787856964;4404.66964977628;4954.9009019819405;4968.875778105504;4971.602271818246;4996.200607902718;5001.674891132065;4309.978450107729;4315.935260971088;4319.805608747614;4320.157569274024;4370.8033138508845;4433.069055498381;4554.134714404253;4556.088782243564;4560.156371071363;4607.6083532900075;4636.235021221461;4636.9536304637195;4707.364505791675;4710.364100846342;4746.88132796669;4975.0547395994645;4981.078500477423;4982.501749825134;4985.551300382983;5014.373203349582;4699.130660827758;4707.035057813208;4710.152172608963;4713.128071306819;4772.737499437564;4822.903541929071;4883.6093112551625;4886.804527818989;4936.03747269279;4962.702237865739;5054.140796064605;5058.342415485963;5058.443571207238;5061.063703214917;5109.9744501277255;4914.975425122994;4924.852254432372;4926.605871530197;4926.729029903247;4970.801167953386;4608.032313214128;4665.603423708887;4803.495632958489;4857.635677324285;4959.752012399438;4785.9042819144115;4791.233402655558;4798.95201047999;4850.151223535938;4861.781219845187;4769.642276829182;4850.878728031827;4896.436909755281;4897.7795999180835;4937.506249375034;4722.338872557776;4737.3130896020575;4785.569298763128;4788.497207793271;4792.329073929723 20:50:46 INFO - PROCESS | 14215 | |1;ext.html;548.0929062401725;563.385909358799;573.1660434068431;573.6816067082767;582.6882617799478;27899.860500697494;38755;39789.60210397895;39806.60193398069;42543.361849572284;40719.38920916188;41360.79319603405;41394.37908431368;41452.37821432673;41478;7648.464607477493;7794.259545343183;7799.454038217327;7801.258880406353;7801.336886364666;7611.353034992032;7689.961550192269;7693.422993275499;7694.345980591628;7695.999040249548;7721.227877212262;7777.961110194441;7780.844383112334;7784;7868.2918537331625;7691.576963267018;7696.7306144284685;7716.537007779523;7747.38020958322;7766.728164514243;7572.053493313336;7641;7670.156282808886;7680;7723.266289702469;36985;37279.25441491182;37313;37348.43977340315;37367.25265494702;2794.2315863137596;2797.6642802863585;2936.07513633207;3050.8322042287664;3210.550522926792;27166.32084197891;28214.858925705445;28422;28895.71104288972;29616.111516654535;3372.544706464645;3451.4650229214512;3467.098554375855;3483.756137070406;3565.090901820045;251170;253067;253575;254319;254821.99999999814;30487.390252194833;31363.843180784406;52860.20709689358;53228.467715323124;53265.46734532605;32890;33282.33435331328;33313;33330.500042499385;33330.66669333324;12525.749485010248;12648.367581621067;12648.747025059447;12656.557020504422;12663.430145643468;10239.180865530889;10295.588176472857;10301.278910476345;10307.74230644225;10329.586816527404;7616.504927179715;7656.578888161093;7706.306432421109;7726.7681969541;7738.922610773933;2961.318896653782;3020.562018507304;3027.41156311355;3070.109668196198;3100.6589275179713;800.1758189065272;808.1030056637128;880.5553195636163;913.7441516375426;984.8916619171886;26923.730762692514;27866.72133278682;27943;28393.858030709715;28664.283392915346;761.6610608279262;887.7685225778173;892.6741739265121;918.42598376015;936.7143021378408;12307.323097229739;14348.784768228485;14618.488352907598;14722;14773.409063637335;392401;393050;396232;396613;396717;47817.521824782;48328.5167148324;48397.516024840006;48414.27378589324;48424;1027.4503140819775;1101.3391964821044;1101.741090843635;1167.2237961755338;1174.1956759619518;27037.86481067582;28739.712602873704;29504;30688.232794180323;31839.383289423367;48254.517454825;49040.26439603337;49064.75467622639;49094.26358604695;49166.75416622894;366315;367172;368651;370651;371383;25288.620670689586;33022.83488582542;33455.83272083624;35992.28015439624;38138.80930595329;38308.42537361886;38731.80634096811;41930.95172620709;42071.7896410516;43004.13991720085;33219;35861.82069089638;36189.27621447504;36327.81836090803;36342.81828590946;35164.296714065065;36707.26585468222;36766.816165919;36988.44517332188;37194.44208336823;34951.30097397987;35157.671619108805;35731.642683573875;36027.459588105674;36522.634773651924;31380.782420043062;33433.49849752304;33491.162720932174;34351.14122146966;34362;25139;25465.236042918743;25829.3542661435;26084.869575652;26130 20:50:46 INFO - PROCESS | 14215 | |2;jquery.html;348.3642352706312;359.496704613541;360.1662152117848;379.18853653182214;382.10396619926263;15426.922865385672;16492.83507164928;16654.583635409123;16804.915975420106;16841.326346946138;15571.221438928065;16167.817344658468;16258.349666013346;16395.344186232567;16409.261583228752;4885.780139893695;5106.514881086309;5145.279660847485;5161.922571161435;5165.044466773659;3622.456631505282;3795.4686343911735;5036.496350364971;5127.2052831811125;5697.344805347397;6069.939300607004;6077.270727512705;6083.513318934474;6089.725962331706;6096.298925623566;5822.970885145568;5916.083007133901;5975.970120149372;5977.312609049972;6081.391860813927;5166.560842328407;5197;5199.7140157291715;5203.115470370046;5230.529252367305;19408.902955485275;19633.41099766995;20128.79871201284;20235.595288094304;20273.189072437086;1658.7926509186352;1812.1211212561898;1916.808319168072;2365.5387199496104;2388.1880160745254;4968.677035992685;4993.251012348141;4995.450500444948;5058.519440653132;8700.434471759316;1554.1762865681208;1554.6890621875557;1630.79615048119;1648.1512021309036;1707.3000069971376;68935.65532172358;69844;72324;73250.63374683092;73429.26570734331;9764.002532996272;9781;9892.25808064398;10077.193824494023;10176.236782241362;13350.732985340434;13411.731765364833;13473.865261347457;13481.258530780706;13510.594682159552;6658.86682266352;6795;6891.931080689229;6963.4777391695825;7012.403945664573;6271.177969913557;6310.463610593151;6368.745250189941;6613.570117942415;6675.46596272297;4116.950177704726;4133.91732165355;4171.249175148441;4249.7237679551345;4293.914121717548;1640.097946129624;1652.636419987601;1677.396137390563;1707.5389644795835;1717.3645751071933;790.8853216283607;848.3594885861136;864.2049314630555;905.8958219804675;913.0048247410355;16078;16474.341026359052;16614.086225257728;16651.50045498637;17342.826571734375;818.8034871630766;828.647824674511;850.5194565070715;860.6385318166385;881.4623079921371;8883;9520.143187113055;9522.428654280766;9615.471149086727;9719.708408747607;353232;380053.692751475;389727;393675;394726;77526;78841.60579197068;78920.8701434405;80461.19538804654;80729;861.9956900215459;871.1897934920459;889.4174315823146;889.4663202078831;926.0415469988529;15184.240787960336;15337.233138342815;15577.376904923676;16152.11163385978;16341.346346146021;37019.44470832994;37486.43770343393;37829.3798585252;38196.23607527778;38352.6164738349;50303.88544590634;51643.74178129236;52844.471555283955;52943.47056529539;54001.72999135136;7036.542624729376;7177.102862142232;7187.640617969185;7321.231270716711;7322.926770732224;7896.368290536629;10557.736056598647;11103.94448027787;11107.38909359993;11651.708707282047;7065.434765218873;10223.437710925971;10321.690349289533;10818.945905270422;11112.722181945515;10412.062914337746;10414.396400899775;10424.113950314006;10585.206109541969;10713.839292410776;10412.271141020055;10616.097631701392;10700.571977120828;10703.090237329914;10749.785004300027;7572.20491848348;7600.657970391456;7680.769576912701;7727;7756.457048006585;7837.6081195941115;10333.173346132442;10394.272400931863;10873.184511161537;10879.510422031186 20:50:46 INFO - PROCESS | 14215 | |3;mootools.html;1238.8265642810006;1274.4456161569717;1304.6562041097666;1599.5281391989363;1615.313491765999;6642.302558231377;6962.164540255177;7244.166920804109;7884.605769711513;7887.171846956073;7241.601711905843;7566.167721550625;7567.848643027136;7769.961150194241;7793.92206077939;2152.1283880028614;2170.5441857210003;2175.7171567696255;2184.8142907852853;2190.9233176838816;1767.602289484862;1837;2093.2045822587397;2117.3859580721573;2159.0392275437434;1821.4899828048167;1840.0523730278917;1847.8244566766136;1946.834519065881;2029.81731644152;2097.3603051069417;2099.2757498662936;2101.5271563898154;2105.7157283766724;2106.6629339305714;1974.6741787605029;1976.940691779249;2007.5483016321357;2046.1508473983279;2052.230413594902;7766.534007959484;7953.96023019887;7978.481398709066;7980.600969951537;7985.560794156319;4409.2283850326385;4539.818407263706;4543.1140927519145;4546.090781843612;4564.612007979325;2789.8326100434037;2876.4390943765975;2938.5298352263535;2970.970290297091;2995.4009198160456;827.5696637748397;849.5582297205418;865.4980111535357;865.8095219051798;868.5396739727954;10759.085477734401;10830.566777328897;10862;10865.945670271678;10880.619178328721;3967.4643923070016;4058.1072164123843;4114.794260286973;4242.363645453145;4263.232618128704;9067.093290671011;9084.091590840862;9102.954485227663;9107.453552786854;9115.954420227856;4564.475085365159;4565.041341318294;4569.588737013684;4572.908541829145;4577.816887324537;4051.2100140472326;4159.292920203573;4160.687948403821;4161.542230354658;4164.042270277853;3420.521127042216;3523.94714079289;3565.750397472152;3577.731670124751;3584.2652256287397;1159.2001518951897;1177.7408970026581;1190.7797057544383;1197.3354788092693;1200.3458115327167;771.3597713897452;817.6933649881295;821.256762629821;821.3880658909031;832.5504227716965;4994.400671919393;5027.396712394536;5077.23841423782;5134.589232861362;5168.689878607295;389.6279053503897;396.1720005189111;398.57949862894344;400.0858039380061;402.4607026584391;3418;3464.3244567309134;3464.6535346465657;3501.492283618861;3639.1448009717697;9256.72229833106;9780.364276322016;9791.167750741124;9801.852972205423;9813.901860981441;9740.318177727491;9744.853827192597;9753.9024609753;9757.609695612096;9759.26805489591;7131.251218622074;7177.6770045348085;7181.928180718231;7186.676599553032;7206.063211782434;5051.393832739947;5143.459936706592;5151.7166555839785;5229.483449799668;5297.602679798953;8739.25716314095;8784.385093043682;8902.59938302765;8910.287177025693;8969.416987895765;8858.11418858109;9074.228690561376;9074.319426043205;9121.726348209564;9170.816583668156;6659.900101498384;6745.156855393076;6748;6751.49363797727;6755.560888542229;7011.509194356346;7307.196208417176;7359.8224284114285;7479.513831600929;7491.026166598307;6657.40083392497;6694.661067786365;6762.6280554568;6763.5941843489545;6831.89752153728;6612.338766123349;6742.898856517058;6756.087928129639;6802.251752307341;6865.450763938773;6138.693065346804;6283.151774510383;6287.654179020198;6290.748370065146;6292.653904035322;4399.908314481232;4491.236489796807;4544.613707834871;4550.362949187051;4556.407667003401;4500.459944806644;4538.364628952016;4646.86059418218;4721.4570324413135;4787 20:50:46 INFO - PROCESS | 14215 | |4;prototype.html;288.4735357971702;293.20248922929636;297.7647658349904;302.45708952430374;302.92426893276684;4847.47304599051;4869.4887036861155;4900.117978763826;4901.828436004741;4902.240152776321;4805.61555075594;4810.97594512027;4828.251620998742;4840.298156767267;4853.733044682541;3818.8281527331196;3827.502424684787;3833.9041523961846;3835.3671644178676;3859.1895701902636;3542.9822850885707;3846.134619710571;3851.73037887348;3856.2865869814036;3861.942070868939;3717;3718.7582807117587;3721.162738383869;3727.36634772088;3733.9066523336996;3643.9635603643887;3657.195417008254;3663.6153203913736;3684.2263124743836;3710.9628903710886;3037.3925214956876;3117.734992525638;3131.3111115554543;3226.6612005739294;3235.433799085151;4620;4626.4910859805395;4647.34937108805;4665.370175026362;4673.836415725467;4217.472815898012;4218.725782824106;4220.451341325639;4224.260754367973;4226.809793559297;4687.812487500496;4736.50799998003;4947.628927830391;4979.775910084055;4985.800567977277;3528.5060091587197;3535.734819888519;3546.6985306249;3553.9644603553893;3559.1635965548076;5181.689098654093;5182.792688292464;5204.1673332266655;5214.556762675177;5232.999999999962;3536.6109727929907;3609.2781443711365;3613.512175856278;3622.710183185339;3672.6510981456718;3680.6687398134295;3689.040849379127;3694.390425579803;3696.9260614787554;3712.814359282025;4204.600562946515;4214.431051808028;4216.135692183095;4220.261454245495;4228.661707063489;4904.6321525885705;4945.67853089548;4950.232713929347;5001.274305503436;5020.824271150492;1225.2770865189582;1268.213707501355;1270;1272.4782839035952;1281.9936349965233;800.5396896784372;805.2913436176244;815.8333582976401;816.7304789419477;821.3265122599411;4004.6395824375363;4009.578994205625;4013.4983127109113;4015.6988225883174;4042.8180731867137;4561.635069194456;4570.405847239904;4585.014221942299;4586.509384450067;4590.609798167193;4013;4023.4166045923175;4035.9820089955024;4047.514298284225;4049.2913740095955;2340.8829558522007;2407.6749638798537;2446.3639453742157;2455.1161581830524;2470.110760126353;4380.386745855582;4697.815515785176;4786.497417771084;4803.663743537989;4936.975315123402;5331.946680533222;5360.571154307646;5377;5381;5394.298741163623;4977.676451030671;4981.676191047571;4986.850394488171;4990.750462476862;4994.900101998012;4969.627277954096;5188.6250143711195;5209.81765638216;5216.426193118829;5218.739063046756;5116.620771341344;5119.67221306154;5127.384713834214;5130.358705161855;5161.561267292323;4699.684088455238;4966.826161084345;4969.751512424436;4977.726225057657;4980.452150263396;3653.762505437138;3656.5612126544984;3667.3948798449023;3667.9362984735194;3672.926541469209;5128.256402821496;5156.432792392909;5243.528082472443;5246.711430871186;5266.1574148136115;5078.492150784892;5086.669366491166;5091.6181286402925;5103.464136265788;5111.795528178831;4792.568668819823;5083.407462194234;5092.115917110693;5094.821681241138;5098.923516147335;4997.125503036881;5000.77496512665;5003.149464591101;5026.908451302495;5042.302368232978;4939.937913348647;5115.590752739847;5138.24907817288;5150.253213284128;5160.045391602565;4950.430700469492;4983.352164218629;4990.276409920614;4992.525710057539;4998.4501704813165 20:50:46 INFO - PROCESS | 14215 | |5;yui.html;619.5848781316519;627.9089532017857;643.649211179907;704.718112754898;711.7686751805661;11683.883161168396;12471.68820779481;12477.438515266813;12504.437300321484;12506.187097838634;12217.694557636063;12331.19847209933;12344;12371.566995155172;12380.628581142557;587.1457030021309;600.9879802403949;697.9825504362381;705.8517711280638;714.660536245282;720.9747658831942;721.0662192460776;725.5827898958094;725.8838585826269;726.1286456252492;761.6306091545596;763.1376544504702;763.290140169642;763.4922776353718;763.6067425275987;609.3845216331492;624.8375422390211;749.385503886813;756.6027835386411;756.6708481810402;461.6606794006403;461.93301971213987;462.4242817691995;534.2520471340155;550.3203543623622;11687.415629218505;11818.822717659243;11859.52561897523;11914.46384912681;11987.400629968466;12328.445219965122;12716.936415317956;13101.279429631366;13135.474581016748;13523.459061637523;11707.882921170765;11738.941305293505;11808.232464889754;12090.697732556668;12328.32194229317;3969.0871099646956;4081.7142800004012;4089.7750623715683;4090.5091389033505;4095.0786073133604;68691.65654171698;68743.65628171877;68881;68982.65508672425;69827.3017269826;9610.615575377047;9620.326577139673;9705.708828735149;10081.949590252001;10197;17986.37047703324;18016.549586260448;18041;18074.277028918696;18113.547161321072;6320.304766475684;6326.810195694136;6731;6749.460043196533;6857.691403886737;3397.337519183785;3420.7605467617027;3453.1194545390763;3537.557805274341;3602.6397360263763;2673.893044278246;2810.761085307731;2825.39254060378;2826.3640680846647;2828.618136551539;481.8265424447196;491.5183120541889;497.57954528423426;567.5346216102838;595.1489370200654;453.39471805140505;538.284082170712;565.6464709556527;566.2695123290908;595.7884950842389;7284.162321333009;7452.590107544029;7495.625218739041;7973.800654983555;8265.049519305358;414.0291017563808;477.2626292378284;506.17493485618206;506.4707380787086;515.2451658320579;3685.7972811495624;3749.1376983293994;3779.2063666629765;3796.924061518754;3913.5890731472787;92973;107989;109708;111783;112135.43932280286;78126.21873781303;81575.59212203902;81969.59015205005;81976.59011704904;82102;56687.43312566821;68131.31868681249;69515.30484695088;71256.64371678108;74498.62750686212;7756.340711039399;7861;8114.634841432032;8402.747917562483;8989.146031127033;40327.3950890731;40905.59094409137;41674.58325416707;43175.136497270505;44558.77720611506;53506.46493535171;53754.462455374945;58947.70526147342;61640;63239;9646.565904534173;9685.370450920667;9694;9721;9764.121229089416;13011.21932684042;13086.149400289332;13122.212667239995;13163.67090822737;13227.47090116423;12176.964957978671;12380.566680166152;12491;12566.183198092094;13116.803247951097;11298.265612735146;11633;12327.383630818602;12405.813912791134;12617.990560754934;11304.604338848101;11772.941135294268;12435.75128497443;12441.564545240873;12445.315507647167;9036.231920286586;9319.534023298944;9818.408892219308;9913.851292230478;10017.198624110199;9402.95298523503;9479.383840050376;9575.96432953306;10040.736760552703;10506.527206275583 20:50:46 INFO - PROCESS | 14215 | __end_tp_report 20:50:46 INFO - PROCESS | 14215 | __start_cc_report 20:50:46 INFO - PROCESS | 14215 | _x_x_mozilla_cycle_collect,1080 20:50:46 INFO - PROCESS | 14215 | __end_cc_report 20:50:46 INFO - PROCESS | 14215 | __startTimestamp1474602646157__endTimestamp 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | ------- Summary: start ------- 20:50:46 INFO - PROCESS | 14215 | Number of tests: 6 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | [#0] dojo.html Cycles:165 Average:4602.34 Median:4724.41 stddev:496.71 (10.5%) stddev-sans-first:472.37 20:50:46 INFO - PROCESS | 14215 | Values: 2586.0 2617.8 2645.7 2651.3 2669.0 4548.1 4621.7 4693.4 4705.5 4726.5 4647.7 4668.6 4673.4 4678.9 4708.2 4274.5 4287.7 4343.8 4357.8 4361.6 4324.7 4346.8 4350.4 4353.5 4373.0 4276.8 4336.3 4356.7 4419.8 4429.4 4120.6 4193.1 4331.7 4347.3 4361.2 4195.5 4225.1 4248.2 4252.9 4283.0 4553.4 4559.3 4621.4 4637.5 4643.8 4947.4 4948.5 4965.2 4965.4 4980.1 4905.6 4989.5 4993.8 5048.9 5063.0 4693.0 4722.3 4724.4 4725.6 4777.0 5176.6 5190.2 5192.1 5202.2 5253.0 4748.8 4793.2 4852.5 4889.6 4906.4 4974.3 4980.3 4981.2 4982.7 5048.8 4949.5 4952.8 4963.3 4994.8 5015.5 4799.9 4862.4 4862.7 4865.6 4918.6 3927.5 3949.5 3999.5 4000.6 4004.2 3490.2 3494.7 3494.9 3550.8 3568.9 4237.6 4283.0 4334.0 4352.7 4404.7 4954.9 4968.9 4971.6 4996.2 5001.7 4310.0 4315.9 4319.8 4320.2 4370.8 4433.1 4554.1 4556.1 4560.2 4607.6 4636.2 4637.0 4707.4 4710.4 4746.9 4975.1 4981.1 4982.5 4985.6 5014.4 4699.1 4707.0 4710.2 4713.1 4772.7 4822.9 4883.6 4886.8 4936.0 4962.7 5054.1 5058.3 5058.4 5061.1 5110.0 4915.0 4924.9 4926.6 4926.7 4970.8 4608.0 4665.6 4803.5 4857.6 4959.8 4785.9 4791.2 4799.0 4850.2 4861.8 4769.6 4850.9 4896.4 4897.8 4937.5 4722.3 4737.3 4785.6 4788.5 4792.3 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | [#1] ext.html Cycles:180 Average:48094.84 Median:201969.41 stddev:91118.28 (45.1%) stddev-sans-first:91303.96 20:50:46 INFO - PROCESS | 14215 | Values: 548.1 563.4 573.2 573.7 582.7 27899.9 38755.0 39789.6 39806.6 42543.4 40719.4 41360.8 41394.4 41452.4 41478.0 7648.5 7794.3 7799.5 7801.3 7801.3 7611.4 7690.0 7693.4 7694.3 7696.0 7721.2 7778.0 7780.8 7784.0 7868.3 7691.6 7696.7 7716.5 7747.4 7766.7 7572.1 7641.0 7670.2 7680.0 7723.3 36985.0 37279.3 37313.0 37348.4 37367.3 2794.2 2797.7 2936.1 3050.8 3210.6 27166.3 28214.9 28422.0 28895.7 29616.1 3372.5 3451.5 3467.1 3483.8 3565.1 251170.0 253067.0 253575.0 254319.0 254822.0 30487.4 31363.8 52860.2 53228.5 53265.5 32890.0 33282.3 33313.0 33330.5 33330.7 12525.7 12648.4 12648.7 12656.6 12663.4 10239.2 10295.6 10301.3 10307.7 10329.6 7616.5 7656.6 7706.3 7726.8 7738.9 2961.3 3020.6 3027.4 3070.1 3100.7 800.2 808.1 880.6 913.7 984.9 26923.7 27866.7 27943.0 28393.9 28664.3 761.7 887.8 892.7 918.4 936.7 12307.3 14348.8 14618.5 14722.0 14773.4 392401.0 393050.0 396232.0 396613.0 396717.0 47817.5 48328.5 48397.5 48414.3 48424.0 1027.5 1101.3 1101.7 1167.2 1174.2 27037.9 28739.7 29504.0 30688.2 31839.4 48254.5 49040.3 49064.8 49094.3 49166.8 366315.0 367172.0 368651.0 370651.0 371383.0 25288.6 33022.8 33455.8 35992.3 38138.8 38308.4 38731.8 41931.0 42071.8 43004.1 33219.0 35861.8 36189.3 36327.8 36342.8 35164.3 36707.3 36766.8 36988.4 37194.4 34951.3 35157.7 35731.6 36027.5 36522.6 31380.8 33433.5 33491.2 34351.1 34362.0 25139.0 25465.2 25829.4 26084.9 26130.0 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | [#2] jquery.html Cycles:180 Average:24054.77 Median:4589.85 stddev:63400.31 (1381.3%) stddev-sans-first:63553.17 20:50:46 INFO - PROCESS | 14215 | Values: 348.4 359.5 360.2 379.2 382.1 15426.9 16492.8 16654.6 16804.9 16841.3 15571.2 16167.8 16258.3 16395.3 16409.3 4885.8 5106.5 5145.3 5161.9 5165.0 3622.5 3795.5 5036.5 5127.2 5697.3 6069.9 6077.3 6083.5 6089.7 6096.3 5823.0 5916.1 5976.0 5977.3 6081.4 5166.6 5197.0 5199.7 5203.1 5230.5 19408.9 19633.4 20128.8 20235.6 20273.2 1658.8 1812.1 1916.8 2365.5 2388.2 4968.7 4993.3 4995.5 5058.5 8700.4 1554.2 1554.7 1630.8 1648.2 1707.3 68935.7 69844.0 72324.0 73250.6 73429.3 9764.0 9781.0 9892.3 10077.2 10176.2 13350.7 13411.7 13473.9 13481.3 13510.6 6658.9 6795.0 6891.9 6963.5 7012.4 6271.2 6310.5 6368.7 6613.6 6675.5 4117.0 4133.9 4171.2 4249.7 4293.9 1640.1 1652.6 1677.4 1707.5 1717.4 790.9 848.4 864.2 905.9 913.0 16078.0 16474.3 16614.1 16651.5 17342.8 818.8 828.6 850.5 860.6 881.5 8883.0 9520.1 9522.4 9615.5 9719.7 353232.0 380053.7 389727.0 393675.0 394726.0 77526.0 78841.6 78920.9 80461.2 80729.0 862.0 871.2 889.4 889.5 926.0 15184.2 15337.2 15577.4 16152.1 16341.3 37019.4 37486.4 37829.4 38196.2 38352.6 50303.9 51643.7 52844.5 52943.5 54001.7 7036.5 7177.1 7187.6 7321.2 7322.9 7896.4 10557.7 11103.9 11107.4 11651.7 7065.4 10223.4 10321.7 10818.9 11112.7 10412.1 10414.4 10424.1 10585.2 10713.8 10412.3 10616.1 10700.6 10703.1 10749.8 7572.2 7600.7 7680.8 7727.0 7756.5 7837.6 10333.2 10394.3 10873.2 10879.5 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | [#3] mootools.html Cycles:180 Average:5074.49 Median:5010.90 stddev:2929.00 (58.5%) stddev-sans-first:2923.03 20:50:46 INFO - PROCESS | 14215 | Values: 1238.8 1274.4 1304.7 1599.5 1615.3 6642.3 6962.2 7244.2 7884.6 7887.2 7241.6 7566.2 7567.8 7770.0 7793.9 2152.1 2170.5 2175.7 2184.8 2190.9 1767.6 1837.0 2093.2 2117.4 2159.0 1821.5 1840.1 1847.8 1946.8 2029.8 2097.4 2099.3 2101.5 2105.7 2106.7 1974.7 1976.9 2007.5 2046.2 2052.2 7766.5 7954.0 7978.5 7980.6 7985.6 4409.2 4539.8 4543.1 4546.1 4564.6 2789.8 2876.4 2938.5 2971.0 2995.4 827.6 849.6 865.5 865.8 868.5 10759.1 10830.6 10862.0 10865.9 10880.6 3967.5 4058.1 4114.8 4242.4 4263.2 9067.1 9084.1 9103.0 9107.5 9116.0 4564.5 4565.0 4569.6 4572.9 4577.8 4051.2 4159.3 4160.7 4161.5 4164.0 3420.5 3523.9 3565.8 3577.7 3584.3 1159.2 1177.7 1190.8 1197.3 1200.3 771.4 817.7 821.3 821.4 832.6 4994.4 5027.4 5077.2 5134.6 5168.7 389.6 396.2 398.6 400.1 402.5 3418.0 3464.3 3464.7 3501.5 3639.1 9256.7 9780.4 9791.2 9801.9 9813.9 9740.3 9744.9 9753.9 9757.6 9759.3 7131.3 7177.7 7181.9 7186.7 7206.1 5051.4 5143.5 5151.7 5229.5 5297.6 8739.3 8784.4 8902.6 8910.3 8969.4 8858.1 9074.2 9074.3 9121.7 9170.8 6659.9 6745.2 6748.0 6751.5 6755.6 7011.5 7307.2 7359.8 7479.5 7491.0 6657.4 6694.7 6762.6 6763.6 6831.9 6612.3 6742.9 6756.1 6802.3 6865.5 6138.7 6283.2 6287.7 6290.7 6292.7 4399.9 4491.2 4544.6 4550.4 4556.4 4500.5 4538.4 4646.9 4721.5 4787.0 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | [#4] prototype.html Cycles:180 Average:4129.58 Median:4680.82 stddev:1229.64 (26.3%) stddev-sans-first:1198.82 20:50:46 INFO - PROCESS | 14215 | Values: 288.5 293.2 297.8 302.5 302.9 4847.5 4869.5 4900.1 4901.8 4902.2 4805.6 4811.0 4828.3 4840.3 4853.7 3818.8 3827.5 3833.9 3835.4 3859.2 3543.0 3846.1 3851.7 3856.3 3861.9 3717.0 3718.8 3721.2 3727.4 3733.9 3644.0 3657.2 3663.6 3684.2 3711.0 3037.4 3117.7 3131.3 3226.7 3235.4 4620.0 4626.5 4647.3 4665.4 4673.8 4217.5 4218.7 4220.5 4224.3 4226.8 4687.8 4736.5 4947.6 4979.8 4985.8 3528.5 3535.7 3546.7 3554.0 3559.2 5181.7 5182.8 5204.2 5214.6 5233.0 3536.6 3609.3 3613.5 3622.7 3672.7 3680.7 3689.0 3694.4 3696.9 3712.8 4204.6 4214.4 4216.1 4220.3 4228.7 4904.6 4945.7 4950.2 5001.3 5020.8 1225.3 1268.2 1270.0 1272.5 1282.0 800.5 805.3 815.8 816.7 821.3 4004.6 4009.6 4013.5 4015.7 4042.8 4561.6 4570.4 4585.0 4586.5 4590.6 4013.0 4023.4 4036.0 4047.5 4049.3 2340.9 2407.7 2446.4 2455.1 2470.1 4380.4 4697.8 4786.5 4803.7 4937.0 5331.9 5360.6 5377.0 5381.0 5394.3 4977.7 4981.7 4986.9 4990.8 4994.9 4969.6 5188.6 5209.8 5216.4 5218.7 5116.6 5119.7 5127.4 5130.4 5161.6 4699.7 4966.8 4969.8 4977.7 4980.5 3653.8 3656.6 3667.4 3667.9 3672.9 5128.3 5156.4 5243.5 5246.7 5266.2 5078.5 5086.7 5091.6 5103.5 5111.8 4792.6 5083.4 5092.1 5094.8 5098.9 4997.1 5000.8 5003.1 5026.9 5042.3 4939.9 5115.6 5138.2 5150.3 5160.0 4950.4 4983.4 4990.3 4992.5 4998.5 20:50:46 INFO - PROCESS | 14215 | 20:50:46 INFO - PROCESS | 14215 | [#5] yui.html Cycles:180 Average:17663.39 Median:486.67 stddev:25759.78 (5293.0%) stddev-sans-first:25800.25 20:50:46 INFO - PROCESS | 14215 | Values: 619.6 627.9 643.6 704.7 711.8 11683.9 12471.7 12477.4 12504.4 12506.2 12217.7 12331.2 12344.0 12371.6 12380.6 587.1 601.0 698.0 705.9 714.7 721.0 721.1 725.6 725.9 726.1 761.6 763.1 763.3 763.5 763.6 609.4 624.8 749.4 756.6 756.7 461.7 461.9 462.4 534.3 550.3 11687.4 11818.8 11859.5 11914.5 11987.4 12328.4 12716.9 13101.3 13135.5 13523.5 11707.9 11738.9 11808.2 12090.7 12328.3 3969.1 4081.7 4089.8 4090.5 4095.1 68691.7 68743.7 68881.0 68982.7 69827.3 9610.6 9620.3 9705.7 10081.9 10197.0 17986.4 18016.5 18041.0 18074.3 18113.5 6320.3 6326.8 6731.0 6749.5 6857.7 3397.3 3420.8 3453.1 3537.6 3602.6 2673.9 2810.8 2825.4 2826.4 2828.6 481.8 491.5 497.6 567.5 595.1 453.4 538.3 565.6 566.3 595.8 7284.2 7452.6 7495.6 7973.8 8265.0 414.0 477.3 506.2 506.5 515.2 3685.8 3749.1 3779.2 3796.9 3913.6 92973.0 107989.0 109708.0 111783.0 112135.4 78126.2 81575.6 81969.6 81976.6 82102.0 56687.4 68131.3 69515.3 71256.6 74498.6 7756.3 7861.0 8114.6 8402.7 8989.1 40327.4 40905.6 41674.6 43175.1 44558.8 53506.5 53754.5 58947.7 61640.0 63239.0 9646.6 9685.4 9694.0 9721.0 9764.1 13011.2 13086.1 13122.2 13163.7 13227.5 12177.0 12380.6 12491.0 12566.2 13116.8 11298.3 11633.0 12327.4 12405.8 12618.0 11304.6 11772.9 12435.8 12441.6 12445.3 9036.2 9319.5 9818.4 9913.9 10017.2 9403.0 9479.4 9576.0 10040.7 10506.5 20:50:46 INFO - PROCESS | 14215 | -------- Summary: end -------- 20:50:46 INFO - PROCESS | 14215 | 20:50:47 INFO - TEST-INFO | 14215: exit 0 20:50:47 INFO - TEST-OK | dromaeo_css | took 1120941ms 20:50:47 INFO - TEST-START | kraken 20:50:47 INFO - operating with platform_type : linux_ 20:50:47 INFO - Initialising browser for kraken test... 20:50:47 INFO - TEST-INFO | started process 14520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCd8b0y/profile http://localhost:47436/getInfo.html) 20:50:51 INFO - PROCESS | 14520 | __metrics Screen width/height:1600/1200 20:50:51 INFO - PROCESS | 14520 | colorDepth:24 20:50:51 INFO - PROCESS | 14520 | Browser inner width/height: 1024/697 20:50:51 INFO - PROCESS | 14520 | __metrics 20:50:52 INFO - PROCESS | 14520 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:50:52 INFO - PROCESS | 14520 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:50:52 INFO - PROCESS | 14520 | console.error: PushService: 20:50:52 INFO - PROCESS | 14520 | stateChangeProcessEnqueue: Error transitioning state 20:50:52 INFO - PROCESS | 14520 | UnknownError 20:50:53 INFO - TEST-INFO | 14520: exit 0 20:50:53 INFO - Browser initialized. 20:50:53 INFO - Running cycle 1/1 for kraken test... 20:50:53 INFO - TEST-INFO | started process 14600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCd8b0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:51:05 INFO - PROCESS | 14600 | RSS: Main: 175624192 20:51:05 INFO - PROCESS | 14600 | 20:51:08 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47436/tests/kraken/driver.html?testName=audio-beat-detection) 20:51:09 INFO - PROCESS | 14600 | RSS: Main: 234586112 20:51:09 INFO - PROCESS | 14600 | 20:51:12 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47436/tests/kraken/driver.html?testName=audio-dft) 20:51:12 INFO - PROCESS | 14600 | RSS: Main: 218845184 20:51:12 INFO - PROCESS | 14600 | 20:51:15 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47436/tests/kraken/driver.html?testName=audio-fft) 20:51:16 INFO - PROCESS | 14600 | RSS: Main: 300666880 20:51:16 INFO - PROCESS | 14600 | 20:51:18 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47436/tests/kraken/driver.html?testName=audio-oscillator) 20:51:19 INFO - PROCESS | 14600 | RSS: Main: 210579456 20:51:19 INFO - PROCESS | 14600 | 20:51:21 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:51:22 INFO - PROCESS | 14600 | RSS: Main: 213958656 20:51:22 INFO - PROCESS | 14600 | 20:51:25 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47436/tests/kraken/driver.html?testName=imaging-darkroom) 20:51:25 INFO - PROCESS | 14600 | RSS: Main: 250191872 20:51:25 INFO - PROCESS | 14600 | 20:51:29 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47436/tests/kraken/driver.html?testName=imaging-desaturate) 20:51:30 INFO - PROCESS | 14600 | RSS: Main: 245420032 20:51:30 INFO - PROCESS | 14600 | 20:51:33 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47436/tests/kraken/driver.html?testName=json-parse-financial) 20:51:33 INFO - PROCESS | 14600 | RSS: Main: 247259136 20:51:33 INFO - PROCESS | 14600 | 20:51:35 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:51:35 INFO - PROCESS | 14600 | RSS: Main: 211030016 20:51:35 INFO - PROCESS | 14600 | 20:51:37 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:51:38 INFO - PROCESS | 14600 | RSS: Main: 219164672 20:51:38 INFO - PROCESS | 14600 | 20:51:40 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:51:41 INFO - PROCESS | 14600 | RSS: Main: 222191616 20:51:41 INFO - PROCESS | 14600 | 20:51:44 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:51:44 INFO - PROCESS | 14600 | RSS: Main: 224518144 20:51:44 INFO - PROCESS | 14600 | 20:51:47 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:51:48 INFO - PROCESS | 14600 | RSS: Main: 222101504 20:51:48 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | Cycle 1(1): loaded http://localhost:47436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47436/tests/kraken/driver.html?testName=ai-astar) 20:51:50 INFO - PROCESS | 14600 | RSS: Main: 272932864 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | __start_tp_report 20:51:50 INFO - PROCESS | 14600 | _x_x_mozilla_page_load 20:51:50 INFO - PROCESS | 14600 | _x_x_mozilla_page_load_details 20:51:50 INFO - PROCESS | 14600 | |i|pagename|runs| 20:51:50 INFO - PROCESS | 14600 | |0;ai-astar;112;116;114;114;113;115;114;116;116;115 20:51:50 INFO - PROCESS | 14600 | |1;audio-beat-detection;150;130;124;162;126;126;126;123;162;127 20:51:50 INFO - PROCESS | 14600 | |2;audio-dft;163;162;163;163;164;162;161;160;161;160 20:51:50 INFO - PROCESS | 14600 | |3;audio-fft;75;77;76;105;77;77;77;76;111;76 20:51:50 INFO - PROCESS | 14600 | |4;audio-oscillator;84;84;120;83;84;84;122;83;84;123 20:51:50 INFO - PROCESS | 14600 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;116 20:51:50 INFO - PROCESS | 14600 | |6;imaging-darkroom;147;148;147;146;147;146;146;146;146;146 20:51:50 INFO - PROCESS | 14600 | |7;imaging-desaturate;96;95;95;95;96;95;96;97;96;96 20:51:50 INFO - PROCESS | 14600 | |8;json-parse-financial;66;63;62;62;63;66;64;64;64;64 20:51:50 INFO - PROCESS | 14600 | |9;json-stringify-tinderbox;67;67;66;66;66;66;80;66;66;67 20:51:50 INFO - PROCESS | 14600 | |10;stanford-crypto-aes;90;83;82;89;83;83;85;82;83;83 20:51:50 INFO - PROCESS | 14600 | |11;stanford-crypto-ccm;133;147;139;137;143;131;131;132;176;130 20:51:50 INFO - PROCESS | 14600 | |12;stanford-crypto-pbkdf2;175;175;177;179;177;174;176;171;175;176 20:51:50 INFO - PROCESS | 14600 | |13;stanford-crypto-sha256-iterative;70;71;76;69;69;69;69;69;75;68 20:51:50 INFO - PROCESS | 14600 | __end_tp_report 20:51:50 INFO - PROCESS | 14600 | __start_cc_report 20:51:50 INFO - PROCESS | 14600 | _x_x_mozilla_cycle_collect,1938 20:51:50 INFO - PROCESS | 14600 | __end_cc_report 20:51:50 INFO - PROCESS | 14600 | __startTimestamp1474602710372__endTimestamp 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | ------- Summary: start ------- 20:51:50 INFO - PROCESS | 14600 | Number of tests: 14 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:1.09 20:51:50 INFO - PROCESS | 14600 | Values: 112.0 116.0 114.0 114.0 113.0 115.0 114.0 116.0 116.0 115.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:128.50 stddev:15.90 (12.4%) stddev-sans-first:15.99 20:51:50 INFO - PROCESS | 14600 | Values: 150.0 130.0 124.0 162.0 126.0 126.0 126.0 123.0 162.0 127.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.39 20:51:50 INFO - PROCESS | 14600 | Values: 163.0 162.0 163.0 163.0 164.0 162.0 161.0 160.0 161.0 160.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:13.43 (17.5%) stddev-sans-first:13.95 20:51:50 INFO - PROCESS | 14600 | Values: 75.0 77.0 76.0 105.0 77.0 77.0 77.0 76.0 111.0 76.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:84.00 stddev:18.35 (21.8%) stddev-sans-first:19.02 20:51:50 INFO - PROCESS | 14600 | Values: 84.0 84.0 120.0 83.0 84.0 84.0 122.0 83.0 84.0 123.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 20:51:50 INFO - PROCESS | 14600 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 20:51:50 INFO - PROCESS | 14600 | Values: 147.0 148.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 20:51:50 INFO - PROCESS | 14600 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.40 (2.2%) stddev-sans-first:1.24 20:51:50 INFO - PROCESS | 14600 | Values: 66.0 63.0 62.0 62.0 63.0 66.0 64.0 64.0 64.0 64.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:66.50 stddev:4.35 (6.5%) stddev-sans-first:4.60 20:51:50 INFO - PROCESS | 14600 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 80.0 66.0 66.0 67.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:2.87 (3.5%) stddev-sans-first:2.18 20:51:50 INFO - PROCESS | 14600 | Values: 90.0 83.0 82.0 89.0 83.0 83.0 85.0 82.0 83.0 83.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:138.00 stddev:13.90 (10.1%) stddev-sans-first:14.52 20:51:50 INFO - PROCESS | 14600 | Values: 133.0 147.0 139.0 137.0 143.0 131.0 131.0 132.0 176.0 130.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.00 stddev:2.12 (1.2%) stddev-sans-first:2.24 20:51:50 INFO - PROCESS | 14600 | Values: 175.0 175.0 177.0 179.0 177.0 174.0 176.0 171.0 175.0 176.0 20:51:50 INFO - PROCESS | 14600 | 20:51:50 INFO - PROCESS | 14600 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:69.50 stddev:2.76 (4.0%) stddev-sans-first:2.92 20:51:50 INFO - PROCESS | 14600 | Values: 70.0 71.0 76.0 69.0 69.0 69.0 69.0 69.0 75.0 68.0 20:51:50 INFO - PROCESS | 14600 | -------- Summary: end -------- 20:51:50 INFO - PROCESS | 14600 | 20:51:51 INFO - TEST-INFO | 14600: exit 0 20:51:51 INFO - TEST-OK | kraken | took 64583ms 20:51:51 INFO - SUITE-END | took 1185s 20:51:52 INFO - Completed test suite (00:19:45) 20:51:52 INFO - javascript benchmark 20:51:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.0431640293095, 2617.803664725146, 2645.7354264573546, 2651.3106592286, 2669.012465387807, 4548.113117942003, 4621.699589526678, 4693.3898593182885, 4705.458872229695, 4726.503717109706, 4647.744374059425, 4668.603168730662, 4673.392458980336, 4678.90642187156, 4708.199606066968, 4274.465691788519, 4287.721298115628, 4343.78281085946, 4357.803898824544, 4361.5856493633055, 4324.654027677794, 4346.804393802271, 4350.390945267649, 4353.477582690081, 4373.0, 4276.786160691969, 4336.349547567858, 4356.716813407134, 4419.779011049451, 4429.42417485728, 4120.649744771698, 4193.098483825962, 4331.740095594275, 4347.3261644445, 4361.236783562896, 4195.517515485728, 4225.070484493437, 4248.150369926027, 4252.851150209728, 4282.957170428318, 4553.362529245908, 4559.270516717343, 4621.445426548836, 4637.513061128567, 4643.791029403685, 4947.381577302837, 4948.505149485023, 4965.180745177042, 4965.379327584052, 4980.053789779967, 4905.583025442842, 4989.501049895018, 4993.825216117419, 5048.899022019576, 5063.0380227756605, 4693.0, 4722.338872557844, 4724.409448818863, 4725.5510726480925, 4776.95223047772, 5176.611754118456, 5190.195519694454, 5192.143296356135, 5202.2456743771945, 5253.0, 4748.833790817304, 4793.23308270675, 4852.514748525119, 4889.608831293488, 4906.435759887588, 4974.278729584263, 4980.252962055721, 4981.227909674007, 4982.701037937735, 5048.848534543969, 4949.505049495022, 4952.752362381866, 4963.305137280783, 4994.775235114428, 5015.548600625962, 4799.880002999953, 4862.440819305825, 4862.6839255448995, 4865.5864251538305, 4918.5573298403315, 3927.5286965563746, 3949.5063117110362, 3999.4800675911947, 4000.5599384067727, 4004.1991601679197, 3490.1623610333336, 3494.668006539375, 3494.8776792812127, 3550.7869527827897, 3568.8750893718593, 4237.63980061692, 4282.978585107055, 4333.956660433419, 4352.651787856964, 4404.66964977628, 4954.9009019819405, 4968.875778105504, 4971.602271818246, 4996.200607902718, 5001.674891132065, 4309.978450107729, 4315.935260971088, 4319.805608747614, 4320.157569274024, 4370.8033138508845, 4433.069055498381, 4554.134714404253, 4556.088782243564, 4560.156371071363, 4607.6083532900075, 4636.235021221461, 4636.9536304637195, 4707.364505791675, 4710.364100846342, 4746.88132796669, 4975.0547395994645, 4981.078500477423, 4982.501749825134, 4985.551300382983, 5014.373203349582, 4699.130660827758, 4707.035057813208, 4710.152172608963, 4713.128071306819, 4772.737499437564, 4822.903541929071, 4883.6093112551625, 4886.804527818989, 4936.03747269279, 4962.702237865739, 5054.140796064605, 5058.342415485963, 5058.443571207238, 5061.063703214917, 5109.9744501277255, 4914.975425122994, 4924.852254432372, 4926.605871530197, 4926.729029903247, 4970.801167953386, 4608.032313214128, 4665.603423708887, 4803.495632958489, 4857.635677324285, 4959.752012399438, 4785.9042819144115, 4791.233402655558, 4798.95201047999, 4850.151223535938, 4861.781219845187, 4769.642276829182, 4850.878728031827, 4896.436909755281, 4897.7795999180835, 4937.506249375034, 4722.338872557776, 4737.3130896020575, 4785.569298763128, 4788.497207793271, 4792.329073929723], "value": 4570.019101319825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.0929062401725, 563.385909358799, 573.1660434068431, 573.6816067082767, 582.6882617799478, 27899.860500697494, 38755.0, 39789.60210397895, 39806.60193398069, 42543.361849572284, 40719.38920916188, 41360.79319603405, 41394.37908431368, 41452.37821432673, 41478.0, 7648.464607477493, 7794.259545343183, 7799.454038217327, 7801.258880406353, 7801.336886364666, 7611.353034992032, 7689.961550192269, 7693.422993275499, 7694.345980591628, 7695.999040249548, 7721.227877212262, 7777.961110194441, 7780.844383112334, 7784.0, 7868.2918537331625, 7691.576963267018, 7696.7306144284685, 7716.537007779523, 7747.38020958322, 7766.728164514243, 7572.053493313336, 7641.0, 7670.156282808886, 7680.0, 7723.266289702469, 36985.0, 37279.25441491182, 37313.0, 37348.43977340315, 37367.25265494702, 2794.2315863137596, 2797.6642802863585, 2936.07513633207, 3050.8322042287664, 3210.550522926792, 27166.32084197891, 28214.858925705445, 28422.0, 28895.71104288972, 29616.111516654535, 3372.544706464645, 3451.4650229214512, 3467.098554375855, 3483.756137070406, 3565.090901820045, 251170.0, 253067.0, 253575.0, 254319.0, 254821.99999999814, 30487.390252194833, 31363.843180784406, 52860.20709689358, 53228.467715323124, 53265.46734532605, 32890.0, 33282.33435331328, 33313.0, 33330.500042499385, 33330.66669333324, 12525.749485010248, 12648.367581621067, 12648.747025059447, 12656.557020504422, 12663.430145643468, 10239.180865530889, 10295.588176472857, 10301.278910476345, 10307.74230644225, 10329.586816527404, 7616.504927179715, 7656.578888161093, 7706.306432421109, 7726.7681969541, 7738.922610773933, 2961.318896653782, 3020.562018507304, 3027.41156311355, 3070.109668196198, 3100.6589275179713, 800.1758189065272, 808.1030056637128, 880.5553195636163, 913.7441516375426, 984.8916619171886, 26923.730762692514, 27866.72133278682, 27943.0, 28393.858030709715, 28664.283392915346, 761.6610608279262, 887.7685225778173, 892.6741739265121, 918.42598376015, 936.7143021378408, 12307.323097229739, 14348.784768228485, 14618.488352907598, 14722.0, 14773.409063637335, 392401.0, 393050.0, 396232.0, 396613.0, 396717.0, 47817.521824782, 48328.5167148324, 48397.516024840006, 48414.27378589324, 48424.0, 1027.4503140819775, 1101.3391964821044, 1101.741090843635, 1167.2237961755338, 1174.1956759619518, 27037.86481067582, 28739.712602873704, 29504.0, 30688.232794180323, 31839.383289423367, 48254.517454825, 49040.26439603337, 49064.75467622639, 49094.26358604695, 49166.75416622894, 366315.0, 367172.0, 368651.0, 370651.0, 371383.0, 25288.620670689586, 33022.83488582542, 33455.83272083624, 35992.28015439624, 38138.80930595329, 38308.42537361886, 38731.80634096811, 41930.95172620709, 42071.7896410516, 43004.13991720085, 33219.0, 35861.82069089638, 36189.27621447504, 36327.81836090803, 36342.81828590946, 35164.296714065065, 36707.26585468222, 36766.816165919, 36988.44517332188, 37194.44208336823, 34951.30097397987, 35157.671619108805, 35731.642683573875, 36027.459588105674, 36522.634773651924, 31380.782420043062, 33433.49849752304, 33491.162720932174, 34351.14122146966, 34362.0, 25139.0, 25465.236042918743, 25829.3542661435, 26084.869575652, 26130.0], "value": 16416.508171578065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.3642352706312, 359.496704613541, 360.1662152117848, 379.18853653182214, 382.10396619926263, 15426.922865385672, 16492.83507164928, 16654.583635409123, 16804.915975420106, 16841.326346946138, 15571.221438928065, 16167.817344658468, 16258.349666013346, 16395.344186232567, 16409.261583228752, 4885.780139893695, 5106.514881086309, 5145.279660847485, 5161.922571161435, 5165.044466773659, 3622.456631505282, 3795.4686343911735, 5036.496350364971, 5127.2052831811125, 5697.344805347397, 6069.939300607004, 6077.270727512705, 6083.513318934474, 6089.725962331706, 6096.298925623566, 5822.970885145568, 5916.083007133901, 5975.970120149372, 5977.312609049972, 6081.391860813927, 5166.560842328407, 5197.0, 5199.7140157291715, 5203.115470370046, 5230.529252367305, 19408.902955485275, 19633.41099766995, 20128.79871201284, 20235.595288094304, 20273.189072437086, 1658.7926509186352, 1812.1211212561898, 1916.808319168072, 2365.5387199496104, 2388.1880160745254, 4968.677035992685, 4993.251012348141, 4995.450500444948, 5058.519440653132, 8700.434471759316, 1554.1762865681208, 1554.6890621875557, 1630.79615048119, 1648.1512021309036, 1707.3000069971376, 68935.65532172358, 69844.0, 72324.0, 73250.63374683092, 73429.26570734331, 9764.002532996272, 9781.0, 9892.25808064398, 10077.193824494023, 10176.236782241362, 13350.732985340434, 13411.731765364833, 13473.865261347457, 13481.258530780706, 13510.594682159552, 6658.86682266352, 6795.0, 6891.931080689229, 6963.4777391695825, 7012.403945664573, 6271.177969913557, 6310.463610593151, 6368.745250189941, 6613.570117942415, 6675.46596272297, 4116.950177704726, 4133.91732165355, 4171.249175148441, 4249.7237679551345, 4293.914121717548, 1640.097946129624, 1652.636419987601, 1677.396137390563, 1707.5389644795835, 1717.3645751071933, 790.8853216283607, 848.3594885861136, 864.2049314630555, 905.8958219804675, 913.0048247410355, 16078.0, 16474.341026359052, 16614.086225257728, 16651.50045498637, 17342.826571734375, 818.8034871630766, 828.647824674511, 850.5194565070715, 860.6385318166385, 881.4623079921371, 8883.0, 9520.143187113055, 9522.428654280766, 9615.471149086727, 9719.708408747607, 353232.0, 380053.692751475, 389727.0, 393675.0, 394726.0, 77526.0, 78841.60579197068, 78920.8701434405, 80461.19538804654, 80729.0, 861.9956900215459, 871.1897934920459, 889.4174315823146, 889.4663202078831, 926.0415469988529, 15184.240787960336, 15337.233138342815, 15577.376904923676, 16152.11163385978, 16341.346346146021, 37019.44470832994, 37486.43770343393, 37829.3798585252, 38196.23607527778, 38352.6164738349, 50303.88544590634, 51643.74178129236, 52844.471555283955, 52943.47056529539, 54001.72999135136, 7036.542624729376, 7177.102862142232, 7187.640617969185, 7321.231270716711, 7322.926770732224, 7896.368290536629, 10557.736056598647, 11103.94448027787, 11107.38909359993, 11651.708707282047, 7065.434765218873, 10223.437710925971, 10321.690349289533, 10818.945905270422, 11112.722181945515, 10412.062914337746, 10414.396400899775, 10424.113950314006, 10585.206109541969, 10713.839292410776, 10412.271141020055, 10616.097631701392, 10700.571977120828, 10703.090237329914, 10749.785004300027, 7572.20491848348, 7600.657970391456, 7680.769576912701, 7727.0, 7756.457048006585, 7837.6081195941115, 10333.173346132442, 10394.272400931863, 10873.184511161537, 10879.510422031186], "value": 7985.666449415465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.8265642810006, 1274.4456161569717, 1304.6562041097666, 1599.5281391989363, 1615.313491765999, 6642.302558231377, 6962.164540255177, 7244.166920804109, 7884.605769711513, 7887.171846956073, 7241.601711905843, 7566.167721550625, 7567.848643027136, 7769.961150194241, 7793.92206077939, 2152.1283880028614, 2170.5441857210003, 2175.7171567696255, 2184.8142907852853, 2190.9233176838816, 1767.602289484862, 1837.0, 2093.2045822587397, 2117.3859580721573, 2159.0392275437434, 1821.4899828048167, 1840.0523730278917, 1847.8244566766136, 1946.834519065881, 2029.81731644152, 2097.3603051069417, 2099.2757498662936, 2101.5271563898154, 2105.7157283766724, 2106.6629339305714, 1974.6741787605029, 1976.940691779249, 2007.5483016321357, 2046.1508473983279, 2052.230413594902, 7766.534007959484, 7953.96023019887, 7978.481398709066, 7980.600969951537, 7985.560794156319, 4409.2283850326385, 4539.818407263706, 4543.1140927519145, 4546.090781843612, 4564.612007979325, 2789.8326100434037, 2876.4390943765975, 2938.5298352263535, 2970.970290297091, 2995.4009198160456, 827.5696637748397, 849.5582297205418, 865.4980111535357, 865.8095219051798, 868.5396739727954, 10759.085477734401, 10830.566777328897, 10862.0, 10865.945670271678, 10880.619178328721, 3967.4643923070016, 4058.1072164123843, 4114.794260286973, 4242.363645453145, 4263.232618128704, 9067.093290671011, 9084.091590840862, 9102.954485227663, 9107.453552786854, 9115.954420227856, 4564.475085365159, 4565.041341318294, 4569.588737013684, 4572.908541829145, 4577.816887324537, 4051.2100140472326, 4159.292920203573, 4160.687948403821, 4161.542230354658, 4164.042270277853, 3420.521127042216, 3523.94714079289, 3565.750397472152, 3577.731670124751, 3584.2652256287397, 1159.2001518951897, 1177.7408970026581, 1190.7797057544383, 1197.3354788092693, 1200.3458115327167, 771.3597713897452, 817.6933649881295, 821.256762629821, 821.3880658909031, 832.5504227716965, 4994.400671919393, 5027.396712394536, 5077.23841423782, 5134.589232861362, 5168.689878607295, 389.6279053503897, 396.1720005189111, 398.57949862894344, 400.0858039380061, 402.4607026584391, 3418.0, 3464.3244567309134, 3464.6535346465657, 3501.492283618861, 3639.1448009717697, 9256.72229833106, 9780.364276322016, 9791.167750741124, 9801.852972205423, 9813.901860981441, 9740.318177727491, 9744.853827192597, 9753.9024609753, 9757.609695612096, 9759.26805489591, 7131.251218622074, 7177.6770045348085, 7181.928180718231, 7186.676599553032, 7206.063211782434, 5051.393832739947, 5143.459936706592, 5151.7166555839785, 5229.483449799668, 5297.602679798953, 8739.25716314095, 8784.385093043682, 8902.59938302765, 8910.287177025693, 8969.416987895765, 8858.11418858109, 9074.228690561376, 9074.319426043205, 9121.726348209564, 9170.816583668156, 6659.900101498384, 6745.156855393076, 6748.0, 6751.49363797727, 6755.560888542229, 7011.509194356346, 7307.196208417176, 7359.8224284114285, 7479.513831600929, 7491.026166598307, 6657.40083392497, 6694.661067786365, 6762.6280554568, 6763.5941843489545, 6831.89752153728, 6612.338766123349, 6742.898856517058, 6756.087928129639, 6802.251752307341, 6865.450763938773, 6138.693065346804, 6283.151774510383, 6287.654179020198, 6290.748370065146, 6292.653904035322, 4399.908314481232, 4491.236489796807, 4544.613707834871, 4550.362949187051, 4556.407667003401, 4500.459944806644, 4538.364628952016, 4646.86059418218, 4721.4570324413135, 4787.0], "value": 3974.4038975241583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.4735357971702, 293.20248922929636, 297.7647658349904, 302.45708952430374, 302.92426893276684, 4847.47304599051, 4869.4887036861155, 4900.117978763826, 4901.828436004741, 4902.240152776321, 4805.61555075594, 4810.97594512027, 4828.251620998742, 4840.298156767267, 4853.733044682541, 3818.8281527331196, 3827.502424684787, 3833.9041523961846, 3835.3671644178676, 3859.1895701902636, 3542.9822850885707, 3846.134619710571, 3851.73037887348, 3856.2865869814036, 3861.942070868939, 3717.0, 3718.7582807117587, 3721.162738383869, 3727.36634772088, 3733.9066523336996, 3643.9635603643887, 3657.195417008254, 3663.6153203913736, 3684.2263124743836, 3710.9628903710886, 3037.3925214956876, 3117.734992525638, 3131.3111115554543, 3226.6612005739294, 3235.433799085151, 4620.0, 4626.4910859805395, 4647.34937108805, 4665.370175026362, 4673.836415725467, 4217.472815898012, 4218.725782824106, 4220.451341325639, 4224.260754367973, 4226.809793559297, 4687.812487500496, 4736.50799998003, 4947.628927830391, 4979.775910084055, 4985.800567977277, 3528.5060091587197, 3535.734819888519, 3546.6985306249, 3553.9644603553893, 3559.1635965548076, 5181.689098654093, 5182.792688292464, 5204.1673332266655, 5214.556762675177, 5232.999999999962, 3536.6109727929907, 3609.2781443711365, 3613.512175856278, 3622.710183185339, 3672.6510981456718, 3680.6687398134295, 3689.040849379127, 3694.390425579803, 3696.9260614787554, 3712.814359282025, 4204.600562946515, 4214.431051808028, 4216.135692183095, 4220.261454245495, 4228.661707063489, 4904.6321525885705, 4945.67853089548, 4950.232713929347, 5001.274305503436, 5020.824271150492, 1225.2770865189582, 1268.213707501355, 1270.0, 1272.4782839035952, 1281.9936349965233, 800.5396896784372, 805.2913436176244, 815.8333582976401, 816.7304789419477, 821.3265122599411, 4004.6395824375363, 4009.578994205625, 4013.4983127109113, 4015.6988225883174, 4042.8180731867137, 4561.635069194456, 4570.405847239904, 4585.014221942299, 4586.509384450067, 4590.609798167193, 4013.0, 4023.4166045923175, 4035.9820089955024, 4047.514298284225, 4049.2913740095955, 2340.8829558522007, 2407.6749638798537, 2446.3639453742157, 2455.1161581830524, 2470.110760126353, 4380.386745855582, 4697.815515785176, 4786.497417771084, 4803.663743537989, 4936.975315123402, 5331.946680533222, 5360.571154307646, 5377.0, 5381.0, 5394.298741163623, 4977.676451030671, 4981.676191047571, 4986.850394488171, 4990.750462476862, 4994.900101998012, 4969.627277954096, 5188.6250143711195, 5209.81765638216, 5216.426193118829, 5218.739063046756, 5116.620771341344, 5119.67221306154, 5127.384713834214, 5130.358705161855, 5161.561267292323, 4699.684088455238, 4966.826161084345, 4969.751512424436, 4977.726225057657, 4980.452150263396, 3653.762505437138, 3656.5612126544984, 3667.3948798449023, 3667.9362984735194, 3672.926541469209, 5128.256402821496, 5156.432792392909, 5243.528082472443, 5246.711430871186, 5266.1574148136115, 5078.492150784892, 5086.669366491166, 5091.6181286402925, 5103.464136265788, 5111.795528178831, 4792.568668819823, 5083.407462194234, 5092.115917110693, 5094.821681241138, 5098.923516147335, 4997.125503036881, 5000.77496512665, 5003.149464591101, 5026.908451302495, 5042.302368232978, 4939.937913348647, 5115.590752739847, 5138.24907817288, 5150.253213284128, 5160.045391602565, 4950.430700469492, 4983.352164218629, 4990.276409920614, 4992.525710057539, 4998.4501704813165], "value": 3737.449091521592, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.5848781316519, 627.9089532017857, 643.649211179907, 704.718112754898, 711.7686751805661, 11683.883161168396, 12471.68820779481, 12477.438515266813, 12504.437300321484, 12506.187097838634, 12217.694557636063, 12331.19847209933, 12344.0, 12371.566995155172, 12380.628581142557, 587.1457030021309, 600.9879802403949, 697.9825504362381, 705.8517711280638, 714.660536245282, 720.9747658831942, 721.0662192460776, 725.5827898958094, 725.8838585826269, 726.1286456252492, 761.6306091545596, 763.1376544504702, 763.290140169642, 763.4922776353718, 763.6067425275987, 609.3845216331492, 624.8375422390211, 749.385503886813, 756.6027835386411, 756.6708481810402, 461.6606794006403, 461.93301971213987, 462.4242817691995, 534.2520471340155, 550.3203543623622, 11687.415629218505, 11818.822717659243, 11859.52561897523, 11914.46384912681, 11987.400629968466, 12328.445219965122, 12716.936415317956, 13101.279429631366, 13135.474581016748, 13523.459061637523, 11707.882921170765, 11738.941305293505, 11808.232464889754, 12090.697732556668, 12328.32194229317, 3969.0871099646956, 4081.7142800004012, 4089.7750623715683, 4090.5091389033505, 4095.0786073133604, 68691.65654171698, 68743.65628171877, 68881.0, 68982.65508672425, 69827.3017269826, 9610.615575377047, 9620.326577139673, 9705.708828735149, 10081.949590252001, 10197.0, 17986.37047703324, 18016.549586260448, 18041.0, 18074.277028918696, 18113.547161321072, 6320.304766475684, 6326.810195694136, 6731.0, 6749.460043196533, 6857.691403886737, 3397.337519183785, 3420.7605467617027, 3453.1194545390763, 3537.557805274341, 3602.6397360263763, 2673.893044278246, 2810.761085307731, 2825.39254060378, 2826.3640680846647, 2828.618136551539, 481.8265424447196, 491.5183120541889, 497.57954528423426, 567.5346216102838, 595.1489370200654, 453.39471805140505, 538.284082170712, 565.6464709556527, 566.2695123290908, 595.7884950842389, 7284.162321333009, 7452.590107544029, 7495.625218739041, 7973.800654983555, 8265.049519305358, 414.0291017563808, 477.2626292378284, 506.17493485618206, 506.4707380787086, 515.2451658320579, 3685.7972811495624, 3749.1376983293994, 3779.2063666629765, 3796.924061518754, 3913.5890731472787, 92973.0, 107989.0, 109708.0, 111783.0, 112135.43932280286, 78126.21873781303, 81575.59212203902, 81969.59015205005, 81976.59011704904, 82102.0, 56687.43312566821, 68131.31868681249, 69515.30484695088, 71256.64371678108, 74498.62750686212, 7756.340711039399, 7861.0, 8114.634841432032, 8402.747917562483, 8989.146031127033, 40327.3950890731, 40905.59094409137, 41674.58325416707, 43175.136497270505, 44558.77720611506, 53506.46493535171, 53754.462455374945, 58947.70526147342, 61640.0, 63239.0, 9646.565904534173, 9685.370450920667, 9694.0, 9721.0, 9764.121229089416, 13011.21932684042, 13086.149400289332, 13122.212667239995, 13163.67090822737, 13227.47090116423, 12176.964957978671, 12380.566680166152, 12491.0, 12566.183198092094, 13116.803247951097, 11298.265612735146, 11633.0, 12327.383630818602, 12405.813912791134, 12617.990560754934, 11304.604338848101, 11772.941135294268, 12435.75128497443, 12441.564545240873, 12445.315507647167, 9036.231920286586, 9319.534023298944, 9818.408892219308, 9913.851292230478, 10017.198624110199, 9402.95298523503, 9479.383840050376, 9575.96432953306, 10040.736760552703, 10506.527206275583], "value": 6350.0435110080125, "unit": "score"}], "name": "dromaeo_css", "value": 6194.8458921707515, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 114.0, 114.0, 113.0, 115.0, 114.0, 116.0, 116.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 124.0, 162.0, 126.0, 126.0, 126.0, 123.0, 162.0, 127.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 164.0, 162.0, 161.0, 160.0, 161.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 105.0, 77.0, 77.0, 77.0, 76.0, 111.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 120.0, 83.0, 84.0, 84.0, 122.0, 83.0, 84.0, 123.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 62.0, 63.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 80.0, 66.0, 66.0, 67.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 82.0, 89.0, 83.0, 83.0, 85.0, 82.0, 83.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 147.0, 139.0, 137.0, 143.0, 131.0, 131.0, 132.0, 176.0, 130.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 177.0, 179.0, 177.0, 174.0, 176.0, 171.0, 175.0, 176.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 76.0, 69.0, 69.0, 69.0, 69.0, 69.0, 75.0, 68.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1550.7, "alertThreshold": 2.0}]} 20:51:52 INFO - Return code: 0 20:51:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:51:52 INFO - # TBPL SUCCESS # 20:51:52 INFO - Running post-action listener: _resource_record_post_action 20:51:52 INFO - [mozharness: 2016-09-23 03:51:52.159915Z] Finished run-tests step (success) 20:51:52 INFO - Running post-run listener: _resource_record_post_run 20:51:52 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 402870272; Read time: 0; Write time: 274236 20:51:52 INFO - TinderboxPrint: CPU usage
13.1% 20:51:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:51:52 INFO - TinderboxPrint: I/O write bytes / time
402,870,272 / 274,236 20:51:52 INFO - TinderboxPrint: CPU idle
8,336.2 (86.9%) 20:51:52 INFO - TinderboxPrint: CPU user
1,204.1 (12.6%) 20:51:52 INFO - TinderboxPrint: Swap in / out
0 / 0 20:51:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99856384; Read time: 0; Write time: 81748 20:51:52 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 291618816; Read time: 0; Write time: 190216 20:51:52 INFO - Running post-run listener: _upload_blobber_files 20:51:52 INFO - Blob upload gear active. 20:51:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:51:52 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 20:51:52 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:51:52 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:51:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:53 INFO - (blobuploader) - INFO - Done attempting. 20:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:58 INFO - (blobuploader) - INFO - Done attempting. 20:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:59 INFO - (blobuploader) - INFO - Done attempting. 20:51:59 INFO - (blobuploader) - INFO - Iteration through files over. 20:51:59 INFO - Return code: 0 20:51:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:51:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:51:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ca64b050e2a14849992c40b953c64d879e041158a78ac4d5617f22471014f0cb540951c6f4c18d0573beda3d405dd2f9a2d1e10ae7a10763b283f98ecea870f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b2a510cd7107348367711a99a614b452bd2a26bbf8541916822f7842556d52fb81bc7ed1b733f669678de268c034e8ee30dec8544743284dac8bb3347b932dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/284efd69649dcb0bb2c356ce551aef9f0c96a89970cff9897ace21ec7d5804e2f2d343bd775750232bbe52711773ce576a34e1c790c0db7c0a03cd14fa388c2d"} 20:51:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:51:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:51:59 INFO - Contents: 20:51:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ca64b050e2a14849992c40b953c64d879e041158a78ac4d5617f22471014f0cb540951c6f4c18d0573beda3d405dd2f9a2d1e10ae7a10763b283f98ecea870f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b2a510cd7107348367711a99a614b452bd2a26bbf8541916822f7842556d52fb81bc7ed1b733f669678de268c034e8ee30dec8544743284dac8bb3347b932dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/284efd69649dcb0bb2c356ce551aef9f0c96a89970cff9897ace21ec7d5804e2f2d343bd775750232bbe52711773ce576a34e1c790c0db7c0a03cd14fa388c2d"} 20:51:59 INFO - Running post-run listener: copy_logs_to_upload_dir 20:51:59 INFO - Copying logs to upload dir... 20:51:59 INFO - mkdir: /builds/slave/test/build/upload/logs 20:51:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.733576 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-22 20:51:58.990017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 20:51:58.993146) ========= 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=232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ca64b050e2a14849992c40b953c64d879e041158a78ac4d5617f22471014f0cb540951c6f4c18d0573beda3d405dd2f9a2d1e10ae7a10763b283f98ecea870f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b2a510cd7107348367711a99a614b452bd2a26bbf8541916822f7842556d52fb81bc7ed1b733f669678de268c034e8ee30dec8544743284dac8bb3347b932dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/284efd69649dcb0bb2c356ce551aef9f0c96a89970cff9897ace21ec7d5804e2f2d343bd775750232bbe52711773ce576a34e1c790c0db7c0a03cd14fa388c2d"} build_url:https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/eSI4007JTBeYHJNIW2IqXw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9ca64b050e2a14849992c40b953c64d879e041158a78ac4d5617f22471014f0cb540951c6f4c18d0573beda3d405dd2f9a2d1e10ae7a10763b283f98ecea870f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7b2a510cd7107348367711a99a614b452bd2a26bbf8541916822f7842556d52fb81bc7ed1b733f669678de268c034e8ee30dec8544743284dac8bb3347b932dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/284efd69649dcb0bb2c356ce551aef9f0c96a89970cff9897ace21ec7d5804e2f2d343bd775750232bbe52711773ce576a34e1c790c0db7c0a03cd14fa388c2d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 20:51:59.018739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:51:59.019160) ========= 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=232498196343f89f466a4a9a000001c8-1474598892.129941-1595929453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:51:59.072619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 20:51:59.073366) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 20:51:59.074052) ========= ========= Total master_lag: 0.14 =========