builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1478875456.76 results: success (0) buildid: 20161111040720 builduid: 70ab3b11237e4afab3f30e96a30ffc3b revision: 38e66a6513746a40d38783481dca39483c908d76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:16.763869) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:16.764345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:16.764635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:16.809764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:16.810160) ========= 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=62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 06:44:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.0M=0s 2016-11-11 06:44:17 (66.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167354 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.021999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.022554) ========= 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=62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.073043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.073407) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38e66a6513746a40d38783481dca39483c908d76 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38e66a6513746a40d38783481dca39483c908d76 --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=62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 06:44:17,132 truncating revision to first 12 chars 2016-11-11 06:44:17,133 Setting DEBUG logging. 2016-11-11 06:44:17,133 attempt 1/10 2016-11-11 06:44:17,133 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/38e66a651374?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 06:44:17,501 unpacking tar archive at: mozilla-aurora-38e66a651374/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.765462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.765769) ========= script_repo_revision: 38e66a6513746a40d38783481dca39483c908d76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.766167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.766458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 06:44:17.776092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-11 06:44:17.776601) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:18 INFO - MultiFileLogger online at 20161111 06:44:18 in /builds/slave/test 06:44:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:44:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:18 INFO - {'append_to_log': False, 06:44:18 INFO - 'base_work_dir': '/builds/slave/test', 06:44:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:44:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:18 INFO - 'branch': 'Mozilla-Aurora', 06:44:18 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:18 INFO - 'config_files': ('talos/linux_config.py',), 06:44:18 INFO - 'default_actions': ('clobber', 06:44:18 INFO - 'read-buildbot-config', 06:44:18 INFO - 'download-and-extract', 06:44:18 INFO - 'populate-webroot', 06:44:18 INFO - 'create-virtualenv', 06:44:18 INFO - 'install', 06:44:18 INFO - 'run-tests'), 06:44:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:18 INFO - 'download_minidump_stackwalk': True, 06:44:18 INFO - 'download_symbols': 'ondemand', 06:44:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:44:18 INFO - 'tooltool.py': '/tools/tooltool.py', 06:44:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:44:18 INFO - '/tools/misc-python/virtualenv.py')}, 06:44:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:18 INFO - 'installer_path': 'installer.exe', 06:44:18 INFO - 'log_level': 'info', 06:44:18 INFO - 'log_name': 'talos', 06:44:18 INFO - 'log_to_console': True, 06:44:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:18 INFO - 'opt_config_files': (), 06:44:18 INFO - 'pip_index': False, 06:44:18 INFO - 'sps_profile': False, 06:44:18 INFO - 'sps_profile_interval': 0, 06:44:18 INFO - 'suite': 'dromaeojs', 06:44:18 INFO - 'system_bits': '32', 06:44:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:18 INFO - 'title': 'talos-linux64-ix-018', 06:44:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:18 INFO - 'use_talos_json': True, 06:44:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:18 INFO - 'work_dir': 'build'} 06:44:18 INFO - [mozharness: 2016-11-11 14:44:18.022141Z] Running clobber step. 06:44:18 INFO - Running pre-action listener: _resource_record_pre_action 06:44:18 INFO - Running main action method: clobber 06:44:18 INFO - rmtree: /builds/slave/test/build 06:44:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:18 INFO - Running post-action listener: _resource_record_post_action 06:44:18 INFO - [mozharness: 2016-11-11 14:44:18.443902Z] Finished clobber step (success) 06:44:18 INFO - [mozharness: 2016-11-11 14:44:18.444002Z] Running read-buildbot-config step. 06:44:18 INFO - Running pre-action listener: _resource_record_pre_action 06:44:18 INFO - Running main action method: read_buildbot_config 06:44:18 INFO - Using buildbot properties: 06:44:18 INFO - { 06:44:18 INFO - "project": "", 06:44:18 INFO - "product": "firefox", 06:44:18 INFO - "script_repo_revision": "production", 06:44:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:44:18 INFO - "repository": "", 06:44:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:44:18 INFO - "buildid": "20161111040720", 06:44:18 INFO - "pgo_build": "True", 06:44:18 INFO - "basedir": "/builds/slave/test", 06:44:18 INFO - "buildnumber": 886, 06:44:18 INFO - "slavename": "talos-linux64-ix-018", 06:44:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:44:18 INFO - "platform": "ubuntu64_hw", 06:44:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:44:18 INFO - "branch": "mozilla-aurora", 06:44:18 INFO - "repo_path": "releases/mozilla-aurora", 06:44:18 INFO - "revision": "38e66a6513746a40d38783481dca39483c908d76", 06:44:18 INFO - "stage_platform": "linux64-pgo", 06:44:18 INFO - "builduid": "70ab3b11237e4afab3f30e96a30ffc3b", 06:44:18 INFO - "slavebuilddir": "test" 06:44:18 INFO - } 06:44:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 06:44:18 INFO - Running post-action listener: _resource_record_post_action 06:44:18 INFO - [mozharness: 2016-11-11 14:44:18.446439Z] Finished read-buildbot-config step (success) 06:44:18 INFO - [mozharness: 2016-11-11 14:44:18.446528Z] Running download-and-extract step. 06:44:18 INFO - Running pre-action listener: _resource_record_pre_action 06:44:18 INFO - Running main action method: download_and_extract 06:44:18 INFO - mkdir: /builds/slave/test/build/tests 06:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:18 INFO - trying https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:44:18 INFO - Downloading https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:44:19 INFO - Downloaded 1361 bytes. 06:44:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 06:44:19 INFO - Using the following test package requirements: 06:44:19 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 06:44:19 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:44:19 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:44:19 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'jsshell-linux-x86_64.zip'], 06:44:19 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:44:19 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 06:44:19 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:44:19 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:44:19 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:44:19 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 06:44:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:44:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:44:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 06:44:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:44:19 INFO - Fetch https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 06:44:19 INFO - Expected file size: 21962218 06:44:24 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:44:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 06:44:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:44:24 INFO - Fetch https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 06:44:24 INFO - Expected file size: 21962218 06:44:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 06:44:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:44:29 INFO - Fetch https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 06:44:30 INFO - Expected file size: 14414089 06:44: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')]} 06:44:30 INFO - trying https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:44:30 INFO - Downloading https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:44:31 INFO - Downloaded 64044906 bytes. 06:44:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:44:31 INFO - mkdir: /builds/slave/test/properties 06:44:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:31 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:31 INFO - Contents: 06:44:31 INFO - build_url:https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 06:44:32 INFO - Running post-action listener: _resource_record_post_action 06:44:32 INFO - Running post-action listener: set_extra_try_arguments 06:44:32 INFO - [mozharness: 2016-11-11 14:44:32.370197Z] Finished download-and-extract step (success) 06:44:32 INFO - [mozharness: 2016-11-11 14:44:32.370427Z] Running populate-webroot step. 06:44:32 INFO - Running pre-action listener: _resource_record_pre_action 06:44:32 INFO - Running main action method: populate_webroot 06:44:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:44:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:44:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:44:32 INFO - '--tppagecycles', 06:44:32 INFO - '7'], 06:44:32 INFO - 'tests': ['tsvgm']}}, 06:44:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:44:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:44:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['damp', 'tps']}, 06:44:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'tests': ['damp', 'tps']}, 06:44:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['dromaeo_dom']}, 06:44:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['basic_compositor_video']}, 06:44:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:44:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['a11yr', 06:44:32 INFO - 'ts_paint', 06:44:32 INFO - 'tpaint', 06:44:32 INFO - 'sessionrestore', 06:44:32 INFO - 'sessionrestore_no_auto_restore', 06:44:32 INFO - 'tabpaint']}, 06:44:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tsvgx', 06:44:32 INFO - 'tsvgr_opacity', 06:44:32 INFO - 'tart', 06:44:32 INFO - 'tscrollx', 06:44:32 INFO - 'cart']}, 06:44:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:32 INFO - 'tsvgr_opacity', 06:44:32 INFO - 'tart', 06:44:32 INFO - 'tscrollx', 06:44:32 INFO - 'cart']}, 06:44:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s'], 06:44:32 INFO - 'tests': ['tp5o']}, 06:44:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'tests': ['tp5o']}, 06:44:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--disable-e10s', 06:44:32 INFO - '--xperf_path', 06:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:32 INFO - 'tests': ['tp5n']}, 06:44:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:32 INFO - 'talos_options': ['--xperf_path', 06:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:32 INFO - 'tests': ['tp5n']}}, 06:44:32 INFO - 'talos.zip': {'path': '', 06:44:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:44:32 INFO - Running post-action listener: _resource_record_post_action 06:44:32 INFO - [mozharness: 2016-11-11 14:44:32.392703Z] Finished populate-webroot step (success) 06:44:32 INFO - [mozharness: 2016-11-11 14:44:32.392801Z] Running create-virtualenv step. 06:44:32 INFO - Running pre-action listener: _resource_record_pre_action 06:44:32 INFO - Running main action method: create_virtualenv 06:44:32 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:44:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:44:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:32 INFO - Using real prefix '/usr' 06:44:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:33 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:35 INFO - Installing pip.................done. 06:44:35 INFO - Return code: 0 06:44:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:44:35 INFO - Using env: {'DISPLAY': ':0', 06:44:35 INFO - 'HOME': '/home/cltbld', 06:44:35 INFO - 'LANG': 'en_US.UTF-8', 06:44:35 INFO - 'LANGUAGE': 'en_US:en', 06:44:35 INFO - 'LOGNAME': 'cltbld', 06:44:35 INFO - 'MAIL': '/var/mail/cltbld', 06:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:35 INFO - 'MOZ_NO_REMOTE': '1', 06:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:35 INFO - 'NO_EM_RESTART': '1', 06:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:35 INFO - 'PWD': '/builds/slave/test', 06:44:35 INFO - 'SHELL': '/bin/bash', 06:44:35 INFO - 'SHLVL': '1', 06:44:35 INFO - 'TERM': 'linux', 06:44:35 INFO - 'TMOUT': '86400', 06:44:35 INFO - 'USER': 'cltbld', 06:44:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:35 INFO - '_': '/tools/buildbot/bin/python'} 06:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:44:35 INFO - Cleaning up... 06:44:35 INFO - Return code: 0 06:44:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:44:35 INFO - Using env: {'DISPLAY': ':0', 06:44:35 INFO - 'HOME': '/home/cltbld', 06:44:35 INFO - 'LANG': 'en_US.UTF-8', 06:44:35 INFO - 'LANGUAGE': 'en_US:en', 06:44:35 INFO - 'LOGNAME': 'cltbld', 06:44:35 INFO - 'MAIL': '/var/mail/cltbld', 06:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:35 INFO - 'MOZ_NO_REMOTE': '1', 06:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:35 INFO - 'NO_EM_RESTART': '1', 06:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:35 INFO - 'PWD': '/builds/slave/test', 06:44:35 INFO - 'SHELL': '/bin/bash', 06:44:35 INFO - 'SHLVL': '1', 06:44:35 INFO - 'TERM': 'linux', 06:44:35 INFO - 'TMOUT': '86400', 06:44:35 INFO - 'USER': 'cltbld', 06:44:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:35 INFO - '_': '/tools/buildbot/bin/python'} 06:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:35 INFO - Downloading/unpacking psutil>=3.1.1 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:38 INFO - Installing collected packages: psutil 06:44:38 INFO - Running setup.py install for psutil 06:44:38 INFO - building 'psutil._psutil_linux' extension 06:44:38 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 06:44:39 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 06:44:39 INFO - building 'psutil._psutil_posix' extension 06:44:39 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 06:44:39 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 06:44:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:39 INFO - Successfully installed psutil 06:44:39 INFO - Cleaning up... 06:44:40 INFO - Return code: 0 06:44:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:44:40 INFO - Using env: {'DISPLAY': ':0', 06:44:40 INFO - 'HOME': '/home/cltbld', 06:44:40 INFO - 'LANG': 'en_US.UTF-8', 06:44:40 INFO - 'LANGUAGE': 'en_US:en', 06:44:40 INFO - 'LOGNAME': 'cltbld', 06:44:40 INFO - 'MAIL': '/var/mail/cltbld', 06:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:40 INFO - 'MOZ_NO_REMOTE': '1', 06:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:40 INFO - 'NO_EM_RESTART': '1', 06:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:40 INFO - 'PWD': '/builds/slave/test', 06:44:40 INFO - 'SHELL': '/bin/bash', 06:44:40 INFO - 'SHLVL': '1', 06:44:40 INFO - 'TERM': 'linux', 06:44:40 INFO - 'TMOUT': '86400', 06:44:40 INFO - 'USER': 'cltbld', 06:44:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:40 INFO - '_': '/tools/buildbot/bin/python'} 06:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44: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 06:44:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:42 INFO - Installing collected packages: mozsystemmonitor 06:44:42 INFO - Running setup.py install for mozsystemmonitor 06:44:42 INFO - Successfully installed mozsystemmonitor 06:44:42 INFO - Cleaning up... 06:44:42 INFO - Return code: 0 06:44:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:42 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 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:42 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 06:44:42 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 06:44:42 INFO - Using env: {'DISPLAY': ':0', 06:44:42 INFO - 'HOME': '/home/cltbld', 06:44:42 INFO - 'LANG': 'en_US.UTF-8', 06:44:42 INFO - 'LANGUAGE': 'en_US:en', 06:44:42 INFO - 'LOGNAME': 'cltbld', 06:44:42 INFO - 'MAIL': '/var/mail/cltbld', 06:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:42 INFO - 'MOZ_NO_REMOTE': '1', 06:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:42 INFO - 'NO_EM_RESTART': '1', 06:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:42 INFO - 'PWD': '/builds/slave/test', 06:44:42 INFO - 'SHELL': '/bin/bash', 06:44:42 INFO - 'SHLVL': '1', 06:44:42 INFO - 'TERM': 'linux', 06:44:42 INFO - 'TMOUT': '86400', 06:44:42 INFO - 'USER': 'cltbld', 06:44:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:42 INFO - '_': '/tools/buildbot/bin/python'} 06:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:42 INFO - Downloading/unpacking jsonschema==2.5.1 06:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:44:44 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 06:44:44 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 06:44:44 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 06:44:44 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 06:44:44 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 06:44:44 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 06:44:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:44 INFO - warning: no files found matching '*.txt' 06:44:44 INFO - no previously-included directories found matching 'build' 06:44:44 INFO - no previously-included directories found matching 'dist' 06:44:44 INFO - no previously-included directories found matching '.git*' 06:44:44 INFO - Installing collected packages: jsonschema, functools32 06:44:44 INFO - Running setup.py install for functools32 06:44:44 INFO - warning: no files found matching '*.txt' 06:44:44 INFO - no previously-included directories found matching 'build' 06:44:44 INFO - no previously-included directories found matching 'dist' 06:44:44 INFO - no previously-included directories found matching '.git*' 06:44:44 INFO - Successfully installed jsonschema functools32 06:44:44 INFO - Cleaning up... 06:44:44 INFO - Return code: 0 06:44:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:44:44 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')]} 06:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:44 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')]} 06:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:44 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 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:44 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 06:44:44 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 06:44:44 INFO - Using env: {'DISPLAY': ':0', 06:44:44 INFO - 'HOME': '/home/cltbld', 06:44:44 INFO - 'LANG': 'en_US.UTF-8', 06:44:44 INFO - 'LANGUAGE': 'en_US:en', 06:44:44 INFO - 'LOGNAME': 'cltbld', 06:44:44 INFO - 'MAIL': '/var/mail/cltbld', 06:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:44 INFO - 'MOZ_NO_REMOTE': '1', 06:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:44 INFO - 'NO_EM_RESTART': '1', 06:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:44 INFO - 'PWD': '/builds/slave/test', 06:44:44 INFO - 'SHELL': '/bin/bash', 06:44:44 INFO - 'SHLVL': '1', 06:44:44 INFO - 'TERM': 'linux', 06:44:44 INFO - 'TMOUT': '86400', 06:44:44 INFO - 'USER': 'cltbld', 06:44:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:44 INFO - '_': '/tools/buildbot/bin/python'} 06:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:44:45 INFO - Cleaning up... 06:44:45 INFO - Return code: 0 06:44:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:45 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 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:45 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 06:44:45 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 06:44:45 INFO - Using env: {'DISPLAY': ':0', 06:44:45 INFO - 'HOME': '/home/cltbld', 06:44:45 INFO - 'LANG': 'en_US.UTF-8', 06:44:45 INFO - 'LANGUAGE': 'en_US:en', 06:44:45 INFO - 'LOGNAME': 'cltbld', 06:44:45 INFO - 'MAIL': '/var/mail/cltbld', 06:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:45 INFO - 'MOZ_NO_REMOTE': '1', 06:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:45 INFO - 'NO_EM_RESTART': '1', 06:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:45 INFO - 'PWD': '/builds/slave/test', 06:44:45 INFO - 'SHELL': '/bin/bash', 06:44:45 INFO - 'SHLVL': '1', 06:44:45 INFO - 'TERM': 'linux', 06:44:45 INFO - 'TMOUT': '86400', 06:44:45 INFO - 'USER': 'cltbld', 06:44:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:45 INFO - '_': '/tools/buildbot/bin/python'} 06:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:44:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:44:47 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 06:44:47 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 06:44:47 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 06:44:47 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 06:44:47 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 06:44:47 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 06:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:44:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:44:47 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 06:44:47 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 06:44:47 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 06:44:47 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 06:44:47 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 06:44:47 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 06:44:48 INFO - Downloading docopt-0.6.1.tar.gz 06:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:44:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:44:48 INFO - Running setup.py install for blobuploader 06:44:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:44:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:44:48 INFO - Running setup.py install for requests 06:44:48 INFO - Running setup.py install for docopt 06:44:48 INFO - Successfully installed blobuploader requests docopt 06:44:48 INFO - Cleaning up... 06:44:48 INFO - Return code: 0 06:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:48 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 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:48 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 06:44:48 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 06:44:48 INFO - Using env: {'DISPLAY': ':0', 06:44:48 INFO - 'HOME': '/home/cltbld', 06:44:48 INFO - 'LANG': 'en_US.UTF-8', 06:44:48 INFO - 'LANGUAGE': 'en_US:en', 06:44:48 INFO - 'LOGNAME': 'cltbld', 06:44:48 INFO - 'MAIL': '/var/mail/cltbld', 06:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:48 INFO - 'MOZ_NO_REMOTE': '1', 06:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:48 INFO - 'NO_EM_RESTART': '1', 06:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:48 INFO - 'PWD': '/builds/slave/test', 06:44:48 INFO - 'SHELL': '/bin/bash', 06:44:48 INFO - 'SHLVL': '1', 06:44:48 INFO - 'TERM': 'linux', 06:44:48 INFO - 'TMOUT': '86400', 06:44:48 INFO - 'USER': 'cltbld', 06:44:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:48 INFO - '_': '/tools/buildbot/bin/python'} 06:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:48 INFO - Running setup.py (path:/tmp/pip-hxLBzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:48 INFO - Running setup.py (path:/tmp/pip-XRhOpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:49 INFO - Running setup.py (path:/tmp/pip-VglKq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:49 INFO - Running setup.py (path:/tmp/pip-MEG3OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:49 INFO - Running setup.py (path:/tmp/pip-ukinXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:49 INFO - Running setup.py (path:/tmp/pip-994Fra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:49 INFO - Running setup.py (path:/tmp/pip-bDf1Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:49 INFO - Running setup.py (path:/tmp/pip-UGte1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:49 INFO - Running setup.py (path:/tmp/pip-dUAXvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:49 INFO - Running setup.py (path:/tmp/pip-c_Agi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:49 INFO - Running setup.py (path:/tmp/pip-pzs66X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:49 INFO - Running setup.py (path:/tmp/pip-2Per20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:49 INFO - Running setup.py (path:/tmp/pip-1GeAlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:49 INFO - Running setup.py (path:/tmp/pip-OVwGGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:49 INFO - Running setup.py (path:/tmp/pip-EkCdBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:50 INFO - Running setup.py (path:/tmp/pip-xUMgP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:50 INFO - Running setup.py (path:/tmp/pip-m8sVLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:44:50 INFO - Running setup.py install for manifestparser 06:44:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Running setup.py install for mozcrash 06:44:50 INFO - Running setup.py install for mozdebug 06:44:50 INFO - Running setup.py install for mozdevice 06:44:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Running setup.py install for mozfile 06:44:50 INFO - Running setup.py install for mozhttpd 06:44:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Running setup.py install for mozinfo 06:44:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Running setup.py install for mozInstall 06:44:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:44:50 INFO - Running setup.py install for mozleak 06:44:51 INFO - Running setup.py install for mozlog 06:44:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Running setup.py install for moznetwork 06:44:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Running setup.py install for mozprocess 06:44:51 INFO - Running setup.py install for mozprofile 06:44:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Running setup.py install for mozrunner 06:44:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Running setup.py install for mozscreenshot 06:44:51 INFO - Running setup.py install for moztest 06:44:51 INFO - Running setup.py install for mozversion 06:44:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:44:51 INFO - Cleaning up... 06:44:51 INFO - Return code: 0 06:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:51 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')]} 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:51 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')]} 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:51 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 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:51 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 06:44:51 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 06:44:51 INFO - Using env: {'DISPLAY': ':0', 06:44:51 INFO - 'HOME': '/home/cltbld', 06:44:51 INFO - 'LANG': 'en_US.UTF-8', 06:44:51 INFO - 'LANGUAGE': 'en_US:en', 06:44:51 INFO - 'LOGNAME': 'cltbld', 06:44:51 INFO - 'MAIL': '/var/mail/cltbld', 06:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:51 INFO - 'MOZ_NO_REMOTE': '1', 06:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:51 INFO - 'NO_EM_RESTART': '1', 06:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:51 INFO - 'PWD': '/builds/slave/test', 06:44:51 INFO - 'SHELL': '/bin/bash', 06:44:51 INFO - 'SHLVL': '1', 06:44:51 INFO - 'TERM': 'linux', 06:44:51 INFO - 'TMOUT': '86400', 06:44:51 INFO - 'USER': 'cltbld', 06:44:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:51 INFO - '_': '/tools/buildbot/bin/python'} 06:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:52 INFO - Running setup.py (path:/tmp/pip-TNZ3P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:52 INFO - Running setup.py (path:/tmp/pip-zdkZxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:52 INFO - Running setup.py (path:/tmp/pip-HOy8wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:52 INFO - Running setup.py (path:/tmp/pip-mXijqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:52 INFO - Running setup.py (path:/tmp/pip-bRHlIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:52 INFO - Running setup.py (path:/tmp/pip-NcncFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:52 INFO - Running setup.py (path:/tmp/pip-zJaQHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:52 INFO - Running setup.py (path:/tmp/pip-j3_E7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:52 INFO - Running setup.py (path:/tmp/pip-vcX13S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:52 INFO - Running setup.py (path:/tmp/pip-CE7AFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:52 INFO - Running setup.py (path:/tmp/pip-kCnVjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:52 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)) 06:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:52 INFO - Running setup.py (path:/tmp/pip-9mtJAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:53 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)) 06:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:53 INFO - Running setup.py (path:/tmp/pip-fvuffM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:53 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)) 06:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:53 INFO - Running setup.py (path:/tmp/pip-1Qf_ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:53 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)) 06:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:53 INFO - Running setup.py (path:/tmp/pip-RPcLkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:53 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)) 06:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:53 INFO - Running setup.py (path:/tmp/pip-h2GZIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:53 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)) 06:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:53 INFO - Running setup.py (path:/tmp/pip-N2Yn9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:53 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)) 06:44:53 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)) 06:44:53 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)) 06:44:53 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)) 06:44:53 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)) 06:44:53 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)) 06:44:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:44:53 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 06:44:53 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 06:44:53 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 06:44:53 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 06:44:53 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 06:44:53 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 06:44:55 INFO - Downloading blessings-1.6.tar.gz 06:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:44:55 INFO - Installing collected packages: blessings 06:44:55 INFO - Running setup.py install for blessings 06:44:55 INFO - Successfully installed blessings 06:44:55 INFO - Cleaning up... 06:44:55 INFO - Return code: 0 06:44:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:55 INFO - Reading from file tmpfile_stdout 06:44:55 INFO - Current package versions: 06:44:55 INFO - argparse == 1.2.1 06:44:55 INFO - blessings == 1.6 06:44:55 INFO - blobuploader == 1.2.4 06:44:55 INFO - docopt == 0.6.1 06:44:55 INFO - functools32 == 3.2.3-2 06:44:55 INFO - jsonschema == 2.5.1 06:44:55 INFO - manifestparser == 1.1 06:44:55 INFO - mozInstall == 1.12 06:44:55 INFO - mozcrash == 0.17 06:44:55 INFO - mozdebug == 0.1 06:44:55 INFO - mozdevice == 0.48 06:44:55 INFO - mozfile == 1.2 06:44:55 INFO - mozhttpd == 0.7 06:44:55 INFO - mozinfo == 0.9 06:44:55 INFO - mozleak == 0.1 06:44:55 INFO - mozlog == 3.4 06:44:55 INFO - moznetwork == 0.27 06:44:55 INFO - mozprocess == 0.23 06:44:55 INFO - mozprofile == 0.28 06:44:55 INFO - mozrunner == 6.12 06:44:55 INFO - mozscreenshot == 0.1 06:44:55 INFO - mozsystemmonitor == 0.3 06:44:55 INFO - moztest == 0.7 06:44:55 INFO - mozversion == 1.4 06:44:55 INFO - psutil == 3.1.1 06:44:55 INFO - requests == 1.2.3 06:44:55 INFO - wsgiref == 0.1.2 06:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:55 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')]} 06:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:55 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')]} 06:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:55 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 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:55 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 06:44:55 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 06:44:55 INFO - Using env: {'DISPLAY': ':0', 06:44:55 INFO - 'HOME': '/home/cltbld', 06:44:55 INFO - 'LANG': 'en_US.UTF-8', 06:44:55 INFO - 'LANGUAGE': 'en_US:en', 06:44:55 INFO - 'LOGNAME': 'cltbld', 06:44:55 INFO - 'MAIL': '/var/mail/cltbld', 06:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:55 INFO - 'MOZ_NO_REMOTE': '1', 06:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:55 INFO - 'NO_EM_RESTART': '1', 06:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:55 INFO - 'PWD': '/builds/slave/test', 06:44:55 INFO - 'SHELL': '/bin/bash', 06:44:55 INFO - 'SHLVL': '1', 06:44:55 INFO - 'TERM': 'linux', 06:44:55 INFO - 'TMOUT': '86400', 06:44:55 INFO - 'USER': 'cltbld', 06:44:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:55 INFO - '_': '/tools/buildbot/bin/python'} 06:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 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)) 06:44:55 INFO - Cleaning up... 06:44:56 INFO - Return code: 0 06:44:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:44:56 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')]} 06:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:56 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')]} 06:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:56 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 0x7f0840da3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, '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': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', '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 06:44:56 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 06:44:56 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 06:44:56 INFO - Using env: {'DISPLAY': ':0', 06:44:56 INFO - 'HOME': '/home/cltbld', 06:44:56 INFO - 'LANG': 'en_US.UTF-8', 06:44:56 INFO - 'LANGUAGE': 'en_US:en', 06:44:56 INFO - 'LOGNAME': 'cltbld', 06:44:56 INFO - 'MAIL': '/var/mail/cltbld', 06:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:56 INFO - 'MOZ_NO_REMOTE': '1', 06:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:56 INFO - 'NO_EM_RESTART': '1', 06:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:56 INFO - 'PWD': '/builds/slave/test', 06:44:56 INFO - 'SHELL': '/bin/bash', 06:44:56 INFO - 'SHLVL': '1', 06:44:56 INFO - 'TERM': 'linux', 06:44:56 INFO - 'TMOUT': '86400', 06:44:56 INFO - 'USER': 'cltbld', 06:44:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:56 INFO - '_': '/tools/buildbot/bin/python'} 06:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:44:56 INFO - Cleaning up... 06:44:56 INFO - Return code: 0 06:44:56 INFO - Running post-action listener: _resource_record_post_action 06:44:56 INFO - Running post-action listener: _start_resource_monitoring 06:44:56 INFO - Starting resource monitoring. 06:44:56 INFO - [mozharness: 2016-11-11 14:44:56.262374Z] Finished create-virtualenv step (success) 06:44:56 INFO - [mozharness: 2016-11-11 14:44:56.263343Z] Running install step. 06:44:56 INFO - Running pre-action listener: _resource_record_pre_action 06:44:56 INFO - Running main action method: install 06:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:56 INFO - Reading from file tmpfile_stdout 06:44:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:44:56 INFO - Reading from file tmpfile_stdout 06:44:56 INFO - Output received: 06:44:56 INFO - Usage: mozinstall [options] installer 06:44:56 INFO - Options: 06:44:56 INFO - -h, --help show this help message and exit 06:44:56 INFO - -d DEST, --destination=DEST 06:44:56 INFO - Directory to install application into. [default: 06:44:56 INFO - "/builds/slave/test"] 06:44:56 INFO - --app=APP Application being installed. [default: firefox] 06:44:56 INFO - mkdir: /builds/slave/test/build/application 06:44:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:45:12 INFO - Reading from file tmpfile_stdout 06:45:12 INFO - Output received: 06:45:12 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:12 INFO - Running post-action listener: _resource_record_post_action 06:45:12 INFO - [mozharness: 2016-11-11 14:45:12.532109Z] Finished install step (success) 06:45:12 INFO - [mozharness: 2016-11-11 14:45:12.532356Z] Running run-tests step. 06:45:12 INFO - Running pre-action listener: _resource_record_pre_action 06:45:12 INFO - Running main action method: run_tests 06:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:12 INFO - Python 2.7.3 06:45:12 INFO - Return code: 0 06:45:12 INFO - grabbing minidump binary from tooltool 06:45: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')]} 06:45:12 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 0x1033f60>, '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 0x1034d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10351d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:12 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 06:45:12 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 06:45:12 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 06:45:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:12 INFO - Return code: 0 06:45:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 06:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 06:45:12 INFO - Using env: {'DISPLAY': ':0', 06:45:12 INFO - 'HOME': '/home/cltbld', 06:45:12 INFO - 'LANG': 'en_US.UTF-8', 06:45:12 INFO - 'LANGUAGE': 'en_US:en', 06:45:12 INFO - 'LOGNAME': 'cltbld', 06:45:12 INFO - 'MAIL': '/var/mail/cltbld', 06:45:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:12 INFO - 'MOZ_NO_REMOTE': '1', 06:45:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:12 INFO - 'NO_EM_RESTART': '1', 06:45:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:12 INFO - 'PWD': '/builds/slave/test', 06:45:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:12 INFO - 'SHELL': '/bin/bash', 06:45:12 INFO - 'SHLVL': '1', 06:45:12 INFO - 'TERM': 'linux', 06:45:12 INFO - 'TMOUT': '86400', 06:45:12 INFO - 'USER': 'cltbld', 06:45:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442', 06:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:12 INFO - '_': '/tools/buildbot/bin/python'} 06:45:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 06:45:13 INFO - mozversion application_buildid: 20161111040720 06:45:13 INFO - mozversion application_changeset: 38e66a6513746a40d38783481dca39483c908d76 06:45:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:45:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:13 INFO - mozversion application_name: Firefox 06:45:13 INFO - mozversion application_remotingname: firefox-dev 06:45:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:45:13 INFO - mozversion application_vendor: Mozilla 06:45:13 INFO - mozversion application_version: 51.0a2 06:45:13 INFO - mozversion platform_buildid: 20161111040720 06:45:13 INFO - mozversion platform_changeset: 38e66a6513746a40d38783481dca39483c908d76 06:45:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:45:13 INFO - mozversion platform_version: 51.0a2 06:45:13 INFO - using testdate: 1478875513 06:45:13 INFO - actual date: 1478875513 06:45:13 INFO - starting webserver on 'localhost:37638' 06:45:13 INFO - SUITE-START | Running 2 tests 06:45:13 INFO - TEST-START | dromaeo_css 06:45:13 INFO - operating with platform_type : linux_ 06:45:13 INFO - Initialising browser for dromaeo_css test... 06:45:13 INFO - TEST-INFO | started process 3365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7NsOEz/profile http://localhost:37638/getInfo.html) 06:45:18 INFO - PROCESS | 3365 | __metrics Screen width/height:1600/1200 06:45:18 INFO - PROCESS | 3365 | colorDepth:24 06:45:18 INFO - PROCESS | 3365 | Browser inner width/height: 1024/697 06:45:18 INFO - PROCESS | 3365 | __metrics 06:45:19 INFO - PROCESS | 3365 | 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" 06:45:19 INFO - PROCESS | 3365 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:45:19 INFO - PROCESS | 3365 | console.error: PushService: 06:45:19 INFO - PROCESS | 3365 | stateChangeProcessEnqueue: Error transitioning state 06:45:19 INFO - PROCESS | 3365 | UnknownError 06:45:20 INFO - TEST-INFO | 3365: exit 0 06:45:20 INFO - Browser initialized. 06:45:20 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:20 INFO - TEST-INFO | started process 3456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7NsOEz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:32 INFO - PROCESS | 3456 | RSS: Main: 144629760 06:45:32 INFO - PROCESS | 3456 | 06:46:23 INFO - PROCESS | 3456 | 1478875583598 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] 06:48:32 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:37638/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37638/tests/dromaeo/cssquery-ext.html) 06:48:34 INFO - PROCESS | 3456 | RSS: Main: 245542912 06:48:34 INFO - PROCESS | 3456 | 06:51:36 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:37638/tests/dromaeo/cssquery-ext.html (next: http://localhost:37638/tests/dromaeo/cssquery-jquery.html) 06:51:36 INFO - PROCESS | 3456 | RSS: Main: 231772160 06:51:36 INFO - PROCESS | 3456 | 06:54:38 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:37638/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37638/tests/dromaeo/cssquery-mootools.html) 06:54:39 INFO - PROCESS | 3456 | RSS: Main: 173490176 06:54:39 INFO - PROCESS | 3456 | 06:57:41 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:37638/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37638/tests/dromaeo/cssquery-prototype.html) 06:57:42 INFO - PROCESS | 3456 | RSS: Main: 175443968 06:57:42 INFO - PROCESS | 3456 | 07:00:44 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:37638/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37638/tests/dromaeo/cssquery-yui.html) 07:00:45 INFO - PROCESS | 3456 | RSS: Main: 175149056 07:00:45 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:37638/tests/dromaeo/cssquery-yui.html (next: http://localhost:37638/tests/dromaeo/cssquery-dojo.html) 07:03:48 INFO - PROCESS | 3456 | RSS: Main: 259657728 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | __start_tp_report 07:03:48 INFO - PROCESS | 3456 | _x_x_mozilla_page_load 07:03:48 INFO - PROCESS | 3456 | _x_x_mozilla_page_load_details 07:03:48 INFO - PROCESS | 3456 | |i|pagename|runs| 07:03:48 INFO - PROCESS | 3456 | |0;dojo.html;3176.841157942103;3217.5334576486403;3228.2252259457723;3240.2547414094743;3264.869405223791;5634.408387119355;5717.885642287151;5728.255326807509;5738.7991420300295;5749.59752817303;5739.139129130633;5803.651780893149;5804.796832110877;5808.099744539592;5808.941910580893;5249.396319423277;5254.21186821976;5264.184051472019;5287.365516138068;5337.546308563777;5109.923351149736;5313.814016509423;5321.148616221405;5338.119210330291;5344.893102137955;5085.923711144335;5152.6650767699975;5232.16285394337;5245;5256.369235691723;5161.76772045257;5191.636585439021;5205.375354957429;5268.973655131738;5274.657147285414;5112.539871411591;5134.486551344873;5217.634765566412;5221.660592061504;5295.285136506561;5517.972410137923;5579.553635709133;5581.972090139523;5663.575231857627;5712.285964254468;6019.548533859978;6036.758529658809;6167.259928808527;6171.413715697002;6173.938260617426;5832.475077243069;6195.4114359136265;6196.132541444202;6217.937820621781;6218.533609979225;5476.780928762884;5688.11834165705;5705.372409035002;5723.399043100456;5799.449052340021;6334.651594162273;6346.2384513857705;6366.490680745529;6369.617822930639;6378.617282963037;5796.420357964254;6080.787172448943;6086;6086.208792856989;6112.541559383064;5944.940550594525;6026.6986650667295;6086.147939288503;6089.878202435926;6172.753089876444;6132.816015519542;6136.78521251763;6139.324674285825;6144.815655530341;6148;6089.526690816381;6152.138700581922;6162.784302549389;6169.598976066631;6178.135061091451;4576.679632425698;4612.192866248393;4619.815207391734;4631.1895418301665;4632.513586073481;4151.418801367811;4152.5432202457705;4152.875413737593;4155;4183.790810459464;5715.971420142956;5721.771129154788;5722.885542289131;5723.599348045597;5725.570582206268;5862.413758624103;5943.049112142036;6141.907871381933;6153.353897840751;6215;5854.941450585525;5874.118882167709;5890.8821823563285;5891.175235467038;5903.173555702205;5344.385395679469;5347.251384806053;5353.0899747043095;5355.0896347621;5367.892642147135;6075.2405949256345;6097.146399503984;6339.492840572743;6359.777407790705;6426.196725409324;6059;6110.953680641605;6143.754249829957;6190.442860142609;6213.782517611862;6389.041643753474;6395.808125756234;6399.232092148972;6405.551611387158;6408.455281301141;5806.854828629149;5999.760009599741;6065.059915713072;6073.0283154695035;6083.543734219863;5935.762569497172;6094.878102438015;6119.143319935301;6122.6938653068055;6247.344028877084;6091.42131497507;6111.682900513496;6114.784027539347;6114.847128821637;6117.1632890357305;6049.122877182872;6124.54065945047;6124.6325220486915;6128.66292353907;6131.509479241561;5758.827235182951;5797.739101740347;5941.673207973603;5963.224780778644;5995;6068;6129.35641757609;6129.3564175762685;6135.907961380493;6138.877222455437;5676.091825308096;5975.312839023394;5980.820575382745;5985.820425387245;6011.969940150271 07:03:48 INFO - PROCESS | 3456 | |1;ext.html;592.298126719837;607.7720854679495;637.7034678874326;644.0468107201342;656.1896058367918;35820.10449738755;36437.271254574924;46437.76781116098;47653;47664.28503572449;49061.75469122658;49570.256446153246;49623;49641;49734;8403.453775504604;9362.438253704799;9511.762205944837;9519.381240219363;9539.666111686092;8423.95788021059;8734.694285700001;10992.670219893416;11279.49242284095;11282.323060616389;11365.545378184863;11371.829422558669;11429.371384573846;11436.656900293005;11474.196806223568;8545.10276420973;11018.669439916815;11048.337099774039;11086.833697494543;11088.944555277212;8486.915130848674;10677.466126693635;11059.447027648666;11064.834027489595;11443.084553235805;45820.7708961453;46204.306935395995;46237.768811156064;46255.30617040747;46292.07415851664;4085.44846445729;4125.009997600584;4483.641308695296;4499.6850220484575;4607.631389488866;34620.307593848236;34825;34829.47755783665;35103.4734478983;35495.112622184395;4602.401687780567;4724;4749.810007599692;4772.16487114757;4772.6897751646375;262422;263377;265752;266382;266623;66098;66464;66526;66547;66657;40566;41788;41795.7910210447;44120.779396102815;44211.11577768427;17814;17957.910210448863;17959.910200448914;17962.64074718498;17964.101794910202;11920.821187682192;12326.137170398166;13517.729645407037;13616.251106189255;13618.863811361958;19085.141168647446;19204.903975480032;19937.800621993883;21663.566728665653;21810.34568962902;7526.698932042657;7568.5458872466725;7717.151113377524;7753.92246077532;7844.686212551548;1014.4724743133529;1098.5331234225423;1132.0547342968548;1148.242160174281;1186.2289511817387;34744.82627586846;35299.82350088233;35444.82277588596;35486.64513354885;35609;1152.7809716153904;1155.9942200289113;1180.6103985684704;1182.526989204308;1215.0340479318963;18325.63348733018;18536.629267414577;18548;18692.81307186938;18712.625747484974;560222;566129;567442;568525;568885;65479;65903.67048164824;66012.66993665001;66016.33983660102;66024.66987665127;1341.5103487227286;1396.043710058613;1438.101186758276;1464.7583148780332;1484.5620541940154;33559.83220083884;35982;36366;36574.085647859014;36677.08307292339;54574.727126364116;55034.17448738352;55134;55351.723241385145;55453;420653;421933;421941;422221;543309;45366.31950520679;47257.52742472531;47566.76216619033;48370.5162948366;49022.26466603075;53866.192007120706;53914;54271.45728542822;54362.45637543574;54939.72530137324;44238.918309183675;44726.77636611796;45991.540084598724;46500.534994650974;48001.03997920092;44181.55818441774;44879.551204488846;48312.51687483221;50298.22763292841;50354.244686329;44627.33059004183;46015.76992115018;46033.079338412375;46062.07875842531;46137.30794038025;37977.24045519129;40739;40898.791728022436;40921.59078409178;40939.7953010233;30570.847145764128;30812.08570222768;30819.383612328078;30842.691573084878;31071.689283107782 07:03:48 INFO - PROCESS | 3456 | |2;jquery.html;383.5668850734131;441.2168401088068;441.84016955491836;441.9116176764647;454.4274214489744;19007.52481187971;20365.49086272844;21156.153753849827;21245.681314780253;21336;19949.700754488695;19999.999999999978;20014.49963750907;20162.395128146178;20433.795662043376;5428.83713488594;6017.458428741424;6264.718087686042;6269.968650156743;6270.843228919268;6788;7006.633706427248;7047.6476176191245;7049.577025378468;7065.046218760453;6786.287439818822;6917.7578784742545;6967.547109437895;6969.721211151548;7010.5443146195585;6689.397954184098;6856.52004359695;6908.7236510539515;6923.342282483156;6928.896066559006;6185.288691800455;6186.9381306186815;6189.535784816112;6189.907151392733;6193.225846769154;24460.633090503477;24659.50680986388;24851.25446236616;25003.249902502954;25148.371290717696;2433.1605596069326;2464.08828733368;2474.7772700457044;2563.4104156044027;2613.229097416248;15354.385824567116;15556.844431555654;15639.139847308394;15925.009373828272;16125.354985800554;2044.826189773871;2153.1172219389973;2174.086883508914;2202.5925203837182;2206.316042026977;87621;88264.55867720685;89553.55223223908;90385;90653;10158.339707919109;10316.329438586468;10317.48412579368;10749.62376316825;10929.617463388744;14370.856291437161;14974.625634359229;15073.246337683073;15082.924585377003;15101.169435681142;8293.377996650275;8434.451760635538;8535.018472875574;8628.015556421933;8796.560171991503;8050.919490805134;8364.079951205362;8384.664613415394;8386.87419688705;8555.957220213859;6873.175218973755;7083.6458177090935;7176.569405835667;7187.27505398711;7208.459365547605;2007.4078146946686;2116.798904104108;2126.7022616833656;2126.968095478569;2135.58356120555;993.8906720260766;1100.928439651436;1115.8326251062406;1137.4710759496709;1179.2511755035614;20803.68794468084;21304.467388315104;21378.893105534684;21417.78582214158;21615.891920540296;1042.1298215989582;1050.0549505445008;1081.691717860406;1097.8298363753631;1104.6630777612745;11136.944315278533;12041.217320874115;12046.819297710541;12191.146619736533;12210.450529726184;404644;408268;493286;494457.2217111347;500838;63753.681231593546;88454;101199.49400252952;107513.46243268733;108949;1053.5943661690305;1078.7303174206606;1115.2416356877402;1131.9830202546968;1133.54091592905;18833.71749423787;18938;19164.904175479034;19313.324033658755;19323.13045912909;36235;43769.343459848766;44723.77638111789;45925.77037114793;46628.06743865171;66207;66569.33430665631;67538.32461675517;67761;68068.3193168062;8428.283595894418;9233.538323083952;9302.581383837878;9561.187299079656;9739.805203895741;14027.929860350632;14163.504277350243;14523.636909077357;14542.345594448063;14720;6610.768623098168;10596.463512790448;10607.628732994308;12559.120861539604;12916.22502649844;12098.879011209776;12271.386430678253;12512.812307815208;12910.741785164431;13071.934640326737;12078.637640870787;12498.687532811753;12624.431900564314;12729.236245825281;12985.415656295301;8307.584620769057;8575.828483430421;8813.250873675554;8906.376553641183;8994.685186018458;11534.59628912984;12414.255144691348;12620.873791261969;12697.174683645533;12725.363731813557 07:03:48 INFO - PROCESS | 3456 | |3;mootools.html;1482.9777553336698;1520.4754359745887;1682.9061110278317;1816.9091545422734;1832.8167183281664;9043.321750868687;9806.460644664541;9811.607535698564;9825.508724563779;9832.803343933127;8419.66321347147;8785.956070219656;8833.20501154896;9025.954870225656;9054.502002389883;2523.394385347517;2553.3361326055174;2553.9872300638563;2558.5522533556646;2559.4241295708503;2184.9016794244217;2548.694156701189;2587.8188526803133;2591.5983022631426;2592.948141037178;2258.367657056027;2501.837380570257;2592.4037471381594;2592.5074235895117;2607.439400528886;2449.252977841749;2456.7174774900936;2465.593177125781;2522.6342180383926;2522.848629082261;2508.397984483729;2524.684414448194;2524.7475252474787;2528.3679080229945;2530.607755797854;9527.952360238154;9731.756706082333;9748.415095094246;9752.268579856469;9759.65841195562;5424.05079111154;5537.086380747212;5559.471850174227;5566.638168519034;5568.52667523261;3509.4209455439823;3644.362236608583;3703.2593481303848;3721.79530125843;3725.3480640887738;1215.9421303465954;1294.5598496511138;1297.5328881602616;2196.3081629286885;2240.596692595332;13238.536651217257;13264.801027984588;13269.402876870565;13287.73424531504;13311.933440332736;4789.377380940456;4843.8304659337455;4889.731064791471;4902.828401005948;5019.3976722793495;10404.58381664725;10430.16558675304;10433.739156521147;10437.2693911427;10442.321249118935;5550.972245138829;5555.055640541118;5556.083246264402;5556.944430555724;5568.025595520849;5120.385553733576;5219;5220.295260139908;5249.947500525022;5284.81503147388;4053.310937140693;4091.1204091120553;4143.91712165755;4187.644050255702;4269.658427325869;1111.1055600241882;1143.5082914346744;1216.5802798034663;1224.3755684600917;1226;895.632790555869;902.6299217320867;918.4581097152578;991.177322822056;1012.099231683802;6083.391660833881;6153.938460615426;6197.349278325711;6408.871822563616;6490.8052758417325;480.92305231162845;492.88663607370506;530.941596424393;540.0980362794144;669.8411747676547;4140.710150289451;4239.59723826236;4248.553901840262;4270.722403043792;4284.036091879302;11575.189736718348;12102.213356131822;12170.57402990891;12178.086643501772;12193.634190974284;11968.82046769299;11971.52113915451;11977.760444791229;11987.460564274628;11989.22070065443;8307;8704.608292626846;8705.608247628872;8910.019897811235;8911.37620366581;6530.249021362604;6543.443807276435;6559.967200163968;6721.395074443323;6797.25230224665;11154.498047587716;11156.721081972692;11169.944150279196;11214.66356009321;11321.207515473838;11056.834147487954;11085.334879907232;11354.602588909349;11358.488868000795;11469.31184128955;8319.792005199677;8467.153284671484;8469.830603388022;8470.788230294293;8486.363522735695;8817.382783205114;9082.318826088202;9159.313051521029;9380.437173769596;9382.202512786489;8087.63605637736;8143.51138931666;8183.181681831769;8242.464239824392;8455.365847561581;7762.379009679099;7967.2431119043595;8087.433879628369;8088.393370497119;8297.792555186168;7341.192468828318;7426.702931882664;7438.628068596657;7441.255874412515;7449.180590135189;5343.919841202307;5350.090484617702;5385.75764090609;5412.188171774265;5474.686075341969;5540.944590554042;5591.832245032656;5613.438656134517;5619.550435965195;5637.774489020558 07:03:48 INFO - PROCESS | 3456 | |4;prototype.html;360.49890651993735;364.54796052894403;365.72936027339745;366.3972764801901;370.3629756818273;5419.4799418270495;5540.529055030327;5561.499465048145;5618.381977982423;5624.3531993820725;5445.319335083114;5572.972135139329;5594.24477695511;5596.524295434882;5661.886762264752;4207;4301.978490107545;4345.435093437849;4389.670774691895;4428.6014258716705;4399;4405.889852753675;4420.806382276784;4423.225935461298;4443.955560444387;4389.4513185851765;4406.664467832038;4418.182636212311;4431.493292280624;4439.644828413735;4360.171567402215;4375.474943006828;4431.113777244564;4453.821847126111;4459.464864216298;3913.2173565287057;3919.412088186766;3929.76421414716;3942.5663177050787;3944.309745794503;5385.838424847261;5387.24578559002;5425.701586412746;5444.210589464506;5450.91823622646;4860.198067318888;5014.84955451337;5018.84943451697;5040.6471546991725;5089.872753181163;5714;5801.82594522165;5807.709614519257;5807.970960145214;5821.3596504384905;4283.957160428387;4289.828406863721;4297.39836422901;4309.396684464146;4323.913521729579;5860.677662728591;6030.7889223876955;6040.305364883051;6049.823842482688;6078.422549857756;4351.782410879443;4357.324614684729;4364.192624364503;4377.789216445674;4397.73613583186;4454;4455.019895623022;4456.821727130943;4465.866024019285;4466.4640243171025;4831.371921650163;4975.577075948585;4986;4996.725180115056;5014.52362025607;5581.5255703265675;5678.4037676044245;5742.942570574324;5870.5010074144175;5875.148103524965;1506.6986602679508;1525.3441020361129;1526.2979029646265;1526.7557190849411;1529.694061187767;943.9192125016817;972.9416235025922;975.9024097590184;981.6907674082642;988.5057471264367;5018.787975695558;5023.111710766324;5025.748712564357;5027.832465546682;5029.421616514074;5250.7374631268285;5266.473352664703;5276.15581506957;5289;5293.523582877559;4979.580819466507;5004.149294619923;5008.273800298936;5285.524302812689;5720.399358067426;3192.972462486338;3197.7122059014337;3220.9194770130935;3222.146131275214;3225.822579758136;6038.460192650846;6202.906956395657;6214.40963108504;6231.906521402183;6243.719032643542;6086.813071451024;6109.480694141048;6119.479844213202;6131.570790044654;6136.8772624547255;6151.753929842756;6187.876242475125;6189.1954045974635;6193.102000209944;6279.780207692709;5833.649981001154;5987.5808693391045;6011.158437818796;6037.728302226323;6098.469135308797;5924.822255332347;5934.3175534814045;5946.940530594638;5947.256592925884;5953.642781433128;5951.196588460675;6193.721282542387;6215.595986260879;6222.439980401786;6232.407921247474;4294.463192100988;4314.741115533078;4340.327249276367;4344.4352234209355;4344.892052526586;5774.82675519735;5961.642301461753;6028.944934636509;6080.939190608037;6098.902197604474;5732.971335143465;5854.121881717776;5872.677002764889;5881.147233651182;5962.850928726816;5861.677607731445;5864.595515838486;5875.6474611523445;5891.617044892068;5898.3484624305265;5576.996140694714;5811.331696854916;5826.41735826414;5837.357890631942;5845.941540584709;5807.8548036299435;5886.323072846678;5895.29256489224;5896.764129434775;5924.31870334917;5458.61789674719;5706.172604972173;5755.1942728017275;5775.653460792366;5835.824925252249 07:03:48 INFO - PROCESS | 3456 | |5;yui.html;871.4335681806825;880.8722735203396;899.518757464756;911.1708345405682;923.7044145873323;15973.281202345894;17515.64968700625;17600.91199544002;17648.205830737646;17650.735238971425;14255.429782808675;14280.285985700726;15949;16421.42525011625;16498.34006639736;737.59800908505;750.1036261667283;871.2855458524012;886.3131073418089;891.6477991193507;860.8235311761106;872.5157537566648;879.0681877210178;880.5729221327651;880.7225723896984;929.6188562689299;929.9256059515222;929.9767505812341;932.4498545857942;932.6362718539775;768.9231076892322;927.9860802087941;930.999175885922;931.4178638350996;932.8087742012871;581.2647001543052;663.3929954092048;678.5453745990199;682.0553533356288;683.2381894187994;15707.764383534257;15744;15747.527574172793;15780.842191578167;15795.052296862224;14431;14886.330115144845;14918.17950012749;15126.394944202219;15165.545033649008;12882.355882205946;12900.290484023375;12926.030547708959;12980.026498012592;13155.210687358693;4562.840300589497;4592.1045396147765;4600.907981840344;4673.191349050547;4675.742834144121;88282.5585872073;88366.5581672094;88563.55718221432;88583.11416885878;88981.11018889793;11254.43727813606;11903.40482975865;11971.221870578385;11978.64064078079;12323.014158867269;22503.437414064778;22537.88731056367;22581.887090564443;22584.322470325915;22586.322410327717;8896.334076190238;9002.774930626787;9043.050479699537;9057.456552606733;9177.357584968988;4802.399700037496;4926.433460152129;4946;5101.464346243665;5123.231515272664;3710.9443358349645;3783;3831.750936189139;3835.4822099016833;3839.6928245740273;675;675.709444938681;683.2108914204102;686.1012074182836;697.5709938387855;670.5641333133502;692.6052150274295;700.6251655364356;727.1928159742681;742.6843591473602;8956.845468001613;9467.100625440573;9833.262505311986;9866.161376282953;9892.25808064398;637.8628594852129;644.2880616918331;688.9276625954203;712;757.9729466572825;4678.6491013174145;4760.880977975578;4764.4282686077195;4800.807967681254;4802.183628783116;105017.47491262648;105607.4719626397;110765;116499;133842;96573;100819;101984.49007755062;102203.4889825561;104626;82445.3510929778;84631;86516.13483865207;92556;104594;10469.738256543342;10773.116024686178;11060.668179954615;11090.778184436427;11094.944525277322;57313.71343143425;57814;58858;59518.10722839074;61024.38975610187;75973;78100;87266;89118;90318;15349.616259593153;15474.922625386802;15750.527484175493;15770.211489425254;15787.447439339569;16810;16887.493375198763;17103.57241068983;17718.73421898647;18305.633887322445;15147.242637868283;15231.543053707963;15655.921720391325;16145.75781363304;16153.919230403773;15028.474003409829;15089.245537723289;15582.766258506359;15758.290876910796;16742.1628918556;13981;13992.580222593338;14759.92620036893;15198.924005379902;15428.614284642974;11596.768064638829;11672.824907626222;11815.645530634094;11934.70218091515;12440.875591243972;11947;12301.384930753606;12325;12348.629541113782;12867.163634363736 07:03:48 INFO - PROCESS | 3456 | __end_tp_report 07:03:48 INFO - PROCESS | 3456 | __start_cc_report 07:03:48 INFO - PROCESS | 3456 | _x_x_mozilla_cycle_collect,951 07:03:48 INFO - PROCESS | 3456 | __end_cc_report 07:03:48 INFO - PROCESS | 3456 | __startTimestamp1478876628273__endTimestamp 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | ------- Summary: start ------- 07:03:48 INFO - PROCESS | 3456 | Number of tests: 6 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | [#0] dojo.html Cycles:165 Average:5698.68 Median:5935.76 stddev:665.69 (11.2%) stddev-sans-first:637.66 07:03:48 INFO - PROCESS | 3456 | Values: 3176.8 3217.5 3228.2 3240.3 3264.9 5634.4 5717.9 5728.3 5738.8 5749.6 5739.1 5803.7 5804.8 5808.1 5808.9 5249.4 5254.2 5264.2 5287.4 5337.5 5109.9 5313.8 5321.1 5338.1 5344.9 5085.9 5152.7 5232.2 5245.0 5256.4 5161.8 5191.6 5205.4 5269.0 5274.7 5112.5 5134.5 5217.6 5221.7 5295.3 5518.0 5579.6 5582.0 5663.6 5712.3 6019.5 6036.8 6167.3 6171.4 6173.9 5832.5 6195.4 6196.1 6217.9 6218.5 5476.8 5688.1 5705.4 5723.4 5799.4 6334.7 6346.2 6366.5 6369.6 6378.6 5796.4 6080.8 6086.0 6086.2 6112.5 5944.9 6026.7 6086.1 6089.9 6172.8 6132.8 6136.8 6139.3 6144.8 6148.0 6089.5 6152.1 6162.8 6169.6 6178.1 4576.7 4612.2 4619.8 4631.2 4632.5 4151.4 4152.5 4152.9 4155.0 4183.8 5716.0 5721.8 5722.9 5723.6 5725.6 5862.4 5943.0 6141.9 6153.4 6215.0 5854.9 5874.1 5890.9 5891.2 5903.2 5344.4 5347.3 5353.1 5355.1 5367.9 6075.2 6097.1 6339.5 6359.8 6426.2 6059.0 6111.0 6143.8 6190.4 6213.8 6389.0 6395.8 6399.2 6405.6 6408.5 5806.9 5999.8 6065.1 6073.0 6083.5 5935.8 6094.9 6119.1 6122.7 6247.3 6091.4 6111.7 6114.8 6114.8 6117.2 6049.1 6124.5 6124.6 6128.7 6131.5 5758.8 5797.7 5941.7 5963.2 5995.0 6068.0 6129.4 6129.4 6135.9 6138.9 5676.1 5975.3 5980.8 5985.8 6012.0 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | [#1] ext.html Cycles:180 Average:61299.56 Median:422081.00 stddev:117801.21 (27.9%) stddev-sans-first:118043.49 07:03:48 INFO - PROCESS | 3456 | Values: 592.3 607.8 637.7 644.0 656.2 35820.1 36437.3 46437.8 47653.0 47664.3 49061.8 49570.3 49623.0 49641.0 49734.0 8403.5 9362.4 9511.8 9519.4 9539.7 8424.0 8734.7 10992.7 11279.5 11282.3 11365.5 11371.8 11429.4 11436.7 11474.2 8545.1 11018.7 11048.3 11086.8 11088.9 8486.9 10677.5 11059.4 11064.8 11443.1 45820.8 46204.3 46237.8 46255.3 46292.1 4085.4 4125.0 4483.6 4499.7 4607.6 34620.3 34825.0 34829.5 35103.5 35495.1 4602.4 4724.0 4749.8 4772.2 4772.7 262422.0 263377.0 265752.0 266382.0 266623.0 66098.0 66464.0 66526.0 66547.0 66657.0 40566.0 41788.0 41795.8 44120.8 44211.1 17814.0 17957.9 17959.9 17962.6 17964.1 11920.8 12326.1 13517.7 13616.3 13618.9 19085.1 19204.9 19937.8 21663.6 21810.3 7526.7 7568.5 7717.2 7753.9 7844.7 1014.5 1098.5 1132.1 1148.2 1186.2 34744.8 35299.8 35444.8 35486.6 35609.0 1152.8 1156.0 1180.6 1182.5 1215.0 18325.6 18536.6 18548.0 18692.8 18712.6 560222.0 566129.0 567442.0 568525.0 568885.0 65479.0 65903.7 66012.7 66016.3 66024.7 1341.5 1396.0 1438.1 1464.8 1484.6 33559.8 35982.0 36366.0 36574.1 36677.1 54574.7 55034.2 55134.0 55351.7 55453.0 420653.0 421933.0 421941.0 422221.0 543309.0 45366.3 47257.5 47566.8 48370.5 49022.3 53866.2 53914.0 54271.5 54362.5 54939.7 44238.9 44726.8 45991.5 46500.5 48001.0 44181.6 44879.6 48312.5 50298.2 50354.2 44627.3 46015.8 46033.1 46062.1 46137.3 37977.2 40739.0 40898.8 40921.6 40939.8 30570.8 30812.1 30819.4 30842.7 31071.7 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | [#2] jquery.html Cycles:180 Average:29482.53 Median:2319.74 stddev:76664.32 (3304.9%) stddev-sans-first:76848.25 07:03:48 INFO - PROCESS | 3456 | Values: 383.6 441.2 441.8 441.9 454.4 19007.5 20365.5 21156.2 21245.7 21336.0 19949.7 20000.0 20014.5 20162.4 20433.8 5428.8 6017.5 6264.7 6270.0 6270.8 6788.0 7006.6 7047.6 7049.6 7065.0 6786.3 6917.8 6967.5 6969.7 7010.5 6689.4 6856.5 6908.7 6923.3 6928.9 6185.3 6186.9 6189.5 6189.9 6193.2 24460.6 24659.5 24851.3 25003.2 25148.4 2433.2 2464.1 2474.8 2563.4 2613.2 15354.4 15556.8 15639.1 15925.0 16125.4 2044.8 2153.1 2174.1 2202.6 2206.3 87621.0 88264.6 89553.6 90385.0 90653.0 10158.3 10316.3 10317.5 10749.6 10929.6 14370.9 14974.6 15073.2 15082.9 15101.2 8293.4 8434.5 8535.0 8628.0 8796.6 8050.9 8364.1 8384.7 8386.9 8556.0 6873.2 7083.6 7176.6 7187.3 7208.5 2007.4 2116.8 2126.7 2127.0 2135.6 993.9 1100.9 1115.8 1137.5 1179.3 20803.7 21304.5 21378.9 21417.8 21615.9 1042.1 1050.1 1081.7 1097.8 1104.7 11136.9 12041.2 12046.8 12191.1 12210.5 404644.0 408268.0 493286.0 494457.2 500838.0 63753.7 88454.0 101199.5 107513.5 108949.0 1053.6 1078.7 1115.2 1132.0 1133.5 18833.7 18938.0 19164.9 19313.3 19323.1 36235.0 43769.3 44723.8 45925.8 46628.1 66207.0 66569.3 67538.3 67761.0 68068.3 8428.3 9233.5 9302.6 9561.2 9739.8 14027.9 14163.5 14523.6 14542.3 14720.0 6610.8 10596.5 10607.6 12559.1 12916.2 12098.9 12271.4 12512.8 12910.7 13071.9 12078.6 12498.7 12624.4 12729.2 12985.4 8307.6 8575.8 8813.3 8906.4 8994.7 11534.6 12414.3 12620.9 12697.2 12725.4 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | [#3] mootools.html Cycles:180 Average:6224.30 Median:2697.86 stddev:3586.02 (132.9%) stddev-sans-first:3578.38 07:03:48 INFO - PROCESS | 3456 | Values: 1483.0 1520.5 1682.9 1816.9 1832.8 9043.3 9806.5 9811.6 9825.5 9832.8 8419.7 8786.0 8833.2 9026.0 9054.5 2523.4 2553.3 2554.0 2558.6 2559.4 2184.9 2548.7 2587.8 2591.6 2592.9 2258.4 2501.8 2592.4 2592.5 2607.4 2449.3 2456.7 2465.6 2522.6 2522.8 2508.4 2524.7 2524.7 2528.4 2530.6 9528.0 9731.8 9748.4 9752.3 9759.7 5424.1 5537.1 5559.5 5566.6 5568.5 3509.4 3644.4 3703.3 3721.8 3725.3 1215.9 1294.6 1297.5 2196.3 2240.6 13238.5 13264.8 13269.4 13287.7 13311.9 4789.4 4843.8 4889.7 4902.8 5019.4 10404.6 10430.2 10433.7 10437.3 10442.3 5551.0 5555.1 5556.1 5556.9 5568.0 5120.4 5219.0 5220.3 5249.9 5284.8 4053.3 4091.1 4143.9 4187.6 4269.7 1111.1 1143.5 1216.6 1224.4 1226.0 895.6 902.6 918.5 991.2 1012.1 6083.4 6153.9 6197.3 6408.9 6490.8 480.9 492.9 530.9 540.1 669.8 4140.7 4239.6 4248.6 4270.7 4284.0 11575.2 12102.2 12170.6 12178.1 12193.6 11968.8 11971.5 11977.8 11987.5 11989.2 8307.0 8704.6 8705.6 8910.0 8911.4 6530.2 6543.4 6560.0 6721.4 6797.3 11154.5 11156.7 11169.9 11214.7 11321.2 11056.8 11085.3 11354.6 11358.5 11469.3 8319.8 8467.2 8469.8 8470.8 8486.4 8817.4 9082.3 9159.3 9380.4 9382.2 8087.6 8143.5 8183.2 8242.5 8455.4 7762.4 7967.2 8087.4 8088.4 8297.8 7341.2 7426.7 7438.6 7441.3 7449.2 5343.9 5350.1 5385.8 5412.2 5474.7 5540.9 5591.8 5613.4 5619.6 5637.8 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | [#4] prototype.html Cycles:180 Average:4897.46 Median:5454.77 stddev:1417.06 (26.0%) stddev-sans-first:1379.51 07:03:48 INFO - PROCESS | 3456 | Values: 360.5 364.5 365.7 366.4 370.4 5419.5 5540.5 5561.5 5618.4 5624.4 5445.3 5573.0 5594.2 5596.5 5661.9 4207.0 4302.0 4345.4 4389.7 4428.6 4399.0 4405.9 4420.8 4423.2 4444.0 4389.5 4406.7 4418.2 4431.5 4439.6 4360.2 4375.5 4431.1 4453.8 4459.5 3913.2 3919.4 3929.8 3942.6 3944.3 5385.8 5387.2 5425.7 5444.2 5450.9 4860.2 5014.8 5018.8 5040.6 5089.9 5714.0 5801.8 5807.7 5808.0 5821.4 4284.0 4289.8 4297.4 4309.4 4323.9 5860.7 6030.8 6040.3 6049.8 6078.4 4351.8 4357.3 4364.2 4377.8 4397.7 4454.0 4455.0 4456.8 4465.9 4466.5 4831.4 4975.6 4986.0 4996.7 5014.5 5581.5 5678.4 5742.9 5870.5 5875.1 1506.7 1525.3 1526.3 1526.8 1529.7 943.9 972.9 975.9 981.7 988.5 5018.8 5023.1 5025.7 5027.8 5029.4 5250.7 5266.5 5276.2 5289.0 5293.5 4979.6 5004.1 5008.3 5285.5 5720.4 3193.0 3197.7 3220.9 3222.1 3225.8 6038.5 6202.9 6214.4 6231.9 6243.7 6086.8 6109.5 6119.5 6131.6 6136.9 6151.8 6187.9 6189.2 6193.1 6279.8 5833.6 5987.6 6011.2 6037.7 6098.5 5924.8 5934.3 5946.9 5947.3 5953.6 5951.2 6193.7 6215.6 6222.4 6232.4 4294.5 4314.7 4340.3 4344.4 4344.9 5774.8 5961.6 6028.9 6080.9 6098.9 5733.0 5854.1 5872.7 5881.1 5962.9 5861.7 5864.6 5875.6 5891.6 5898.3 5577.0 5811.3 5826.4 5837.4 5845.9 5807.9 5886.3 5895.3 5896.8 5924.3 5458.6 5706.2 5755.2 5775.7 5835.8 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - PROCESS | 3456 | [#5] yui.html Cycles:180 Average:22396.37 Median:4577.47 stddev:31607.25 (690.5%) stddev-sans-first:31654.59 07:03:48 INFO - PROCESS | 3456 | Values: 871.4 880.9 899.5 911.2 923.7 15973.3 17515.6 17600.9 17648.2 17650.7 14255.4 14280.3 15949.0 16421.4 16498.3 737.6 750.1 871.3 886.3 891.6 860.8 872.5 879.1 880.6 880.7 929.6 929.9 930.0 932.4 932.6 768.9 928.0 931.0 931.4 932.8 581.3 663.4 678.5 682.1 683.2 15707.8 15744.0 15747.5 15780.8 15795.1 14431.0 14886.3 14918.2 15126.4 15165.5 12882.4 12900.3 12926.0 12980.0 13155.2 4562.8 4592.1 4600.9 4673.2 4675.7 88282.6 88366.6 88563.6 88583.1 88981.1 11254.4 11903.4 11971.2 11978.6 12323.0 22503.4 22537.9 22581.9 22584.3 22586.3 8896.3 9002.8 9043.1 9057.5 9177.4 4802.4 4926.4 4946.0 5101.5 5123.2 3710.9 3783.0 3831.8 3835.5 3839.7 675.0 675.7 683.2 686.1 697.6 670.6 692.6 700.6 727.2 742.7 8956.8 9467.1 9833.3 9866.2 9892.3 637.9 644.3 688.9 712.0 758.0 4678.6 4760.9 4764.4 4800.8 4802.2 105017.5 105607.5 110765.0 116499.0 133842.0 96573.0 100819.0 101984.5 102203.5 104626.0 82445.4 84631.0 86516.1 92556.0 104594.0 10469.7 10773.1 11060.7 11090.8 11094.9 57313.7 57814.0 58858.0 59518.1 61024.4 75973.0 78100.0 87266.0 89118.0 90318.0 15349.6 15474.9 15750.5 15770.2 15787.4 16810.0 16887.5 17103.6 17718.7 18305.6 15147.2 15231.5 15655.9 16145.8 16153.9 15028.5 15089.2 15582.8 15758.3 16742.2 13981.0 13992.6 14759.9 15198.9 15428.6 11596.8 11672.8 11815.6 11934.7 12440.9 11947.0 12301.4 12325.0 12348.6 12867.2 07:03:48 INFO - PROCESS | 3456 | -------- Summary: end -------- 07:03:48 INFO - PROCESS | 3456 | 07:03:48 INFO - TEST-INFO | 3456: exit 0 07:03:48 INFO - TEST-OK | dromaeo_css | took 1115844ms 07:03:48 INFO - TEST-START | kraken 07:03:48 INFO - operating with platform_type : linux_ 07:03:48 INFO - Initialising browser for kraken test... 07:03:48 INFO - TEST-INFO | started process 3776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMFeaRg/profile http://localhost:37638/getInfo.html) 07:03:52 INFO - PROCESS | 3776 | __metrics Screen width/height:1600/1200 07:03:52 INFO - PROCESS | 3776 | colorDepth:24 07:03:52 INFO - PROCESS | 3776 | Browser inner width/height: 1024/697 07:03:52 INFO - PROCESS | 3776 | __metrics 07:03:53 INFO - PROCESS | 3776 | 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" 07:03:53 INFO - PROCESS | 3776 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:03:53 INFO - PROCESS | 3776 | console.error: PushService: 07:03:53 INFO - PROCESS | 3776 | stateChangeProcessEnqueue: Error transitioning state 07:03:53 INFO - PROCESS | 3776 | UnknownError 07:03:54 INFO - TEST-INFO | 3776: exit 0 07:03:54 INFO - Browser initialized. 07:03:54 INFO - Running cycle 1/1 for kraken test... 07:03:54 INFO - TEST-INFO | started process 3868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMFeaRg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:06 INFO - PROCESS | 3868 | RSS: Main: 144404480 07:04:06 INFO - PROCESS | 3868 | 07:04:08 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37638/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:09 INFO - PROCESS | 3868 | RSS: Main: 186138624 07:04:09 INFO - PROCESS | 3868 | 07:04:12 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37638/tests/kraken/driver.html?testName=audio-dft) 07:04:12 INFO - PROCESS | 3868 | RSS: Main: 175878144 07:04:12 INFO - PROCESS | 3868 | 07:04:15 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37638/tests/kraken/driver.html?testName=audio-fft) 07:04:16 INFO - PROCESS | 3868 | RSS: Main: 267857920 07:04:16 INFO - PROCESS | 3868 | 07:04:18 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37638/tests/kraken/driver.html?testName=audio-oscillator) 07:04:18 INFO - PROCESS | 3868 | RSS: Main: 174084096 07:04:18 INFO - PROCESS | 3868 | 07:04:20 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37638/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:21 INFO - PROCESS | 3868 | RSS: Main: 175677440 07:04:21 INFO - PROCESS | 3868 | 07:04:24 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37638/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:24 INFO - PROCESS | 3868 | RSS: Main: 211066880 07:04:24 INFO - PROCESS | 3868 | 07:04:28 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37638/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:28 INFO - PROCESS | 3868 | RSS: Main: 209866752 07:04:28 INFO - PROCESS | 3868 | 07:04:31 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37638/tests/kraken/driver.html?testName=json-parse-financial) 07:04:32 INFO - PROCESS | 3868 | RSS: Main: 209858560 07:04:32 INFO - PROCESS | 3868 | 07:04:33 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37638/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:34 INFO - PROCESS | 3868 | RSS: Main: 171565056 07:04:34 INFO - PROCESS | 3868 | 07:04:36 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:36 INFO - PROCESS | 3868 | RSS: Main: 178393088 07:04:36 INFO - PROCESS | 3868 | 07:04:38 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:39 INFO - PROCESS | 3868 | RSS: Main: 188821504 07:04:39 INFO - PROCESS | 3868 | 07:04:41 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:42 INFO - PROCESS | 3868 | RSS: Main: 197533696 07:04:42 INFO - PROCESS | 3868 | 07:04:45 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:45 INFO - PROCESS | 3868 | RSS: Main: 193712128 07:04:45 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:37638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37638/tests/kraken/driver.html?testName=ai-astar) 07:04:47 INFO - PROCESS | 3868 | RSS: Main: 244932608 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | __start_tp_report 07:04:47 INFO - PROCESS | 3868 | _x_x_mozilla_page_load 07:04:47 INFO - PROCESS | 3868 | _x_x_mozilla_page_load_details 07:04:47 INFO - PROCESS | 3868 | |i|pagename|runs| 07:04:47 INFO - PROCESS | 3868 | |0;ai-astar;106;109;109;109;110;109;109;111;108;109 07:04:47 INFO - PROCESS | 3868 | |1;audio-beat-detection;142;117;117;164;119;116;116;115;150;121 07:04:47 INFO - PROCESS | 3868 | |2;audio-dft;159;158;160;159;160;161;159;161;158;159 07:04:47 INFO - PROCESS | 3868 | |3;audio-fft;74;75;76;108;75;75;76;74;100;74 07:04:47 INFO - PROCESS | 3868 | |4;audio-oscillator;82;80;110;81;81;80;118;81;81;113 07:04:47 INFO - PROCESS | 3868 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 07:04:47 INFO - PROCESS | 3868 | |6;imaging-darkroom;146;146;146;146;146;146;145;145;145;146 07:04:47 INFO - PROCESS | 3868 | |7;imaging-desaturate;95;94;95;95;95;94;95;94;95;95 07:04:47 INFO - PROCESS | 3868 | |8;json-parse-financial;50;50;48;49;48;49;50;48;49;51 07:04:47 INFO - PROCESS | 3868 | |9;json-stringify-tinderbox;59;69;59;59;60;59;59;60;58;59 07:04:47 INFO - PROCESS | 3868 | |10;stanford-crypto-aes;73;73;73;73;73;73;73;74;72;73 07:04:47 INFO - PROCESS | 3868 | |11;stanford-crypto-ccm;133;121;125;120;130;122;129;125;168;117 07:04:47 INFO - PROCESS | 3868 | |12;stanford-crypto-pbkdf2;154;155;150;153;153;149;151;155;155;150 07:04:47 INFO - PROCESS | 3868 | |13;stanford-crypto-sha256-iterative;63;62;62;61;62;60;63;61;60;61 07:04:47 INFO - PROCESS | 3868 | __end_tp_report 07:04:47 INFO - PROCESS | 3868 | __start_cc_report 07:04:47 INFO - PROCESS | 3868 | _x_x_mozilla_cycle_collect,1554 07:04:47 INFO - PROCESS | 3868 | __end_cc_report 07:04:47 INFO - PROCESS | 3868 | __startTimestamp1478876687474__endTimestamp 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | ------- Summary: start ------- 07:04:47 INFO - PROCESS | 3868 | Number of tests: 14 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:1.29 (1.2%) stddev-sans-first:0.83 07:04:47 INFO - PROCESS | 3868 | Values: 106.0 109.0 109.0 109.0 110.0 109.0 109.0 111.0 108.0 109.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:120.00 stddev:17.65 (14.7%) stddev-sans-first:17.95 07:04:47 INFO - PROCESS | 3868 | Values: 142.0 117.0 117.0 164.0 119.0 116.0 116.0 115.0 150.0 121.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#2] audio-dft Cycles:10 Average:159.40 Median:159.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 07:04:47 INFO - PROCESS | 3868 | Values: 159.0 158.0 160.0 159.0 160.0 161.0 159.0 161.0 158.0 159.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.45 (16.6%) stddev-sans-first:12.96 07:04:47 INFO - PROCESS | 3868 | Values: 74.0 75.0 76.0 108.0 75.0 75.0 76.0 74.0 100.0 74.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:81.00 stddev:15.97 (19.7%) stddev-sans-first:16.63 07:04:47 INFO - PROCESS | 3868 | Values: 82.0 80.0 110.0 81.0 81.0 80.0 118.0 81.0 81.0 113.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:04:47 INFO - PROCESS | 3868 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:04:47 INFO - PROCESS | 3868 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:04:47 INFO - PROCESS | 3868 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.50 stddev:1.03 (2.1%) stddev-sans-first:1.05 07:04:47 INFO - PROCESS | 3868 | Values: 50.0 50.0 48.0 49.0 48.0 49.0 50.0 48.0 49.0 51.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:59.00 stddev:3.18 (5.4%) stddev-sans-first:3.35 07:04:47 INFO - PROCESS | 3868 | Values: 59.0 69.0 59.0 59.0 60.0 59.0 59.0 60.0 58.0 59.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 07:04:47 INFO - PROCESS | 3868 | Values: 73.0 73.0 73.0 73.0 73.0 73.0 73.0 74.0 72.0 73.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:127.00 stddev:14.56 (11.5%) stddev-sans-first:15.37 07:04:47 INFO - PROCESS | 3868 | Values: 133.0 121.0 125.0 120.0 130.0 122.0 129.0 125.0 168.0 117.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:153.50 stddev:2.32 (1.5%) stddev-sans-first:2.40 07:04:47 INFO - PROCESS | 3868 | Values: 154.0 155.0 150.0 153.0 153.0 149.0 151.0 155.0 155.0 150.0 07:04:47 INFO - PROCESS | 3868 | 07:04:47 INFO - PROCESS | 3868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 07:04:47 INFO - PROCESS | 3868 | Values: 63.0 62.0 62.0 61.0 62.0 60.0 63.0 61.0 60.0 61.0 07:04:47 INFO - PROCESS | 3868 | -------- Summary: end -------- 07:04:47 INFO - PROCESS | 3868 | 07:04:48 INFO - TEST-INFO | 3868: exit 0 07:04:48 INFO - TEST-OK | kraken | took 59517ms 07:04:48 INFO - SUITE-END | took 1175s 07:04:48 INFO - Completed test suite (00:19:35) 07:04:48 INFO - javascript benchmark 07:04:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3176.841157942103, 3217.5334576486403, 3228.2252259457723, 3240.2547414094743, 3264.869405223791, 5634.408387119355, 5717.885642287151, 5728.255326807509, 5738.7991420300295, 5749.59752817303, 5739.139129130633, 5803.651780893149, 5804.796832110877, 5808.099744539592, 5808.941910580893, 5249.396319423277, 5254.21186821976, 5264.184051472019, 5287.365516138068, 5337.546308563777, 5109.923351149736, 5313.814016509423, 5321.148616221405, 5338.119210330291, 5344.893102137955, 5085.923711144335, 5152.6650767699975, 5232.16285394337, 5245.0, 5256.369235691723, 5161.76772045257, 5191.636585439021, 5205.375354957429, 5268.973655131738, 5274.657147285414, 5112.539871411591, 5134.486551344873, 5217.634765566412, 5221.660592061504, 5295.285136506561, 5517.972410137923, 5579.553635709133, 5581.972090139523, 5663.575231857627, 5712.285964254468, 6019.548533859978, 6036.758529658809, 6167.259928808527, 6171.413715697002, 6173.938260617426, 5832.475077243069, 6195.4114359136265, 6196.132541444202, 6217.937820621781, 6218.533609979225, 5476.780928762884, 5688.11834165705, 5705.372409035002, 5723.399043100456, 5799.449052340021, 6334.651594162273, 6346.2384513857705, 6366.490680745529, 6369.617822930639, 6378.617282963037, 5796.420357964254, 6080.787172448943, 6086.0, 6086.208792856989, 6112.541559383064, 5944.940550594525, 6026.6986650667295, 6086.147939288503, 6089.878202435926, 6172.753089876444, 6132.816015519542, 6136.78521251763, 6139.324674285825, 6144.815655530341, 6148.0, 6089.526690816381, 6152.138700581922, 6162.784302549389, 6169.598976066631, 6178.135061091451, 4576.679632425698, 4612.192866248393, 4619.815207391734, 4631.1895418301665, 4632.513586073481, 4151.418801367811, 4152.5432202457705, 4152.875413737593, 4155.0, 4183.790810459464, 5715.971420142956, 5721.771129154788, 5722.885542289131, 5723.599348045597, 5725.570582206268, 5862.413758624103, 5943.049112142036, 6141.907871381933, 6153.353897840751, 6215.0, 5854.941450585525, 5874.118882167709, 5890.8821823563285, 5891.175235467038, 5903.173555702205, 5344.385395679469, 5347.251384806053, 5353.0899747043095, 5355.0896347621, 5367.892642147135, 6075.2405949256345, 6097.146399503984, 6339.492840572743, 6359.777407790705, 6426.196725409324, 6059.0, 6110.953680641605, 6143.754249829957, 6190.442860142609, 6213.782517611862, 6389.041643753474, 6395.808125756234, 6399.232092148972, 6405.551611387158, 6408.455281301141, 5806.854828629149, 5999.760009599741, 6065.059915713072, 6073.0283154695035, 6083.543734219863, 5935.762569497172, 6094.878102438015, 6119.143319935301, 6122.6938653068055, 6247.344028877084, 6091.42131497507, 6111.682900513496, 6114.784027539347, 6114.847128821637, 6117.1632890357305, 6049.122877182872, 6124.54065945047, 6124.6325220486915, 6128.66292353907, 6131.509479241561, 5758.827235182951, 5797.739101740347, 5941.673207973603, 5963.224780778644, 5995.0, 6068.0, 6129.35641757609, 6129.3564175762685, 6135.907961380493, 6138.877222455437, 5676.091825308096, 5975.312839023394, 5980.820575382745, 5985.820425387245, 6011.969940150271], "value": 5652.049704590193, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.298126719837, 607.7720854679495, 637.7034678874326, 644.0468107201342, 656.1896058367918, 35820.10449738755, 36437.271254574924, 46437.76781116098, 47653.0, 47664.28503572449, 49061.75469122658, 49570.256446153246, 49623.0, 49641.0, 49734.0, 8403.453775504604, 9362.438253704799, 9511.762205944837, 9519.381240219363, 9539.666111686092, 8423.95788021059, 8734.694285700001, 10992.670219893416, 11279.49242284095, 11282.323060616389, 11365.545378184863, 11371.829422558669, 11429.371384573846, 11436.656900293005, 11474.196806223568, 8545.10276420973, 11018.669439916815, 11048.337099774039, 11086.833697494543, 11088.944555277212, 8486.915130848674, 10677.466126693635, 11059.447027648666, 11064.834027489595, 11443.084553235805, 45820.7708961453, 46204.306935395995, 46237.768811156064, 46255.30617040747, 46292.07415851664, 4085.44846445729, 4125.009997600584, 4483.641308695296, 4499.6850220484575, 4607.631389488866, 34620.307593848236, 34825.0, 34829.47755783665, 35103.4734478983, 35495.112622184395, 4602.401687780567, 4724.0, 4749.810007599692, 4772.16487114757, 4772.6897751646375, 262422.0, 263377.0, 265752.0, 266382.0, 266623.0, 66098.0, 66464.0, 66526.0, 66547.0, 66657.0, 40566.0, 41788.0, 41795.7910210447, 44120.779396102815, 44211.11577768427, 17814.0, 17957.910210448863, 17959.910200448914, 17962.64074718498, 17964.101794910202, 11920.821187682192, 12326.137170398166, 13517.729645407037, 13616.251106189255, 13618.863811361958, 19085.141168647446, 19204.903975480032, 19937.800621993883, 21663.566728665653, 21810.34568962902, 7526.698932042657, 7568.5458872466725, 7717.151113377524, 7753.92246077532, 7844.686212551548, 1014.4724743133529, 1098.5331234225423, 1132.0547342968548, 1148.242160174281, 1186.2289511817387, 34744.82627586846, 35299.82350088233, 35444.82277588596, 35486.64513354885, 35609.0, 1152.7809716153904, 1155.9942200289113, 1180.6103985684704, 1182.526989204308, 1215.0340479318963, 18325.63348733018, 18536.629267414577, 18548.0, 18692.81307186938, 18712.625747484974, 560222.0, 566129.0, 567442.0, 568525.0, 568885.0, 65479.0, 65903.67048164824, 66012.66993665001, 66016.33983660102, 66024.66987665127, 1341.5103487227286, 1396.043710058613, 1438.101186758276, 1464.7583148780332, 1484.5620541940154, 33559.83220083884, 35982.0, 36366.0, 36574.085647859014, 36677.08307292339, 54574.727126364116, 55034.17448738352, 55134.0, 55351.723241385145, 55453.0, 420653.0, 421933.0, 421941.0, 422221.0, 543309.0, 45366.31950520679, 47257.52742472531, 47566.76216619033, 48370.5162948366, 49022.26466603075, 53866.192007120706, 53914.0, 54271.45728542822, 54362.45637543574, 54939.72530137324, 44238.918309183675, 44726.77636611796, 45991.540084598724, 46500.534994650974, 48001.03997920092, 44181.55818441774, 44879.551204488846, 48312.51687483221, 50298.22763292841, 50354.244686329, 44627.33059004183, 46015.76992115018, 46033.079338412375, 46062.07875842531, 46137.30794038025, 37977.24045519129, 40739.0, 40898.791728022436, 40921.59078409178, 40939.7953010233, 30570.847145764128, 30812.08570222768, 30819.383612328078, 30842.691573084878, 31071.689283107782], "value": 21921.771054700188, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.5668850734131, 441.2168401088068, 441.84016955491836, 441.9116176764647, 454.4274214489744, 19007.52481187971, 20365.49086272844, 21156.153753849827, 21245.681314780253, 21336.0, 19949.700754488695, 19999.999999999978, 20014.49963750907, 20162.395128146178, 20433.795662043376, 5428.83713488594, 6017.458428741424, 6264.718087686042, 6269.968650156743, 6270.843228919268, 6788.0, 7006.633706427248, 7047.6476176191245, 7049.577025378468, 7065.046218760453, 6786.287439818822, 6917.7578784742545, 6967.547109437895, 6969.721211151548, 7010.5443146195585, 6689.397954184098, 6856.52004359695, 6908.7236510539515, 6923.342282483156, 6928.896066559006, 6185.288691800455, 6186.9381306186815, 6189.535784816112, 6189.907151392733, 6193.225846769154, 24460.633090503477, 24659.50680986388, 24851.25446236616, 25003.249902502954, 25148.371290717696, 2433.1605596069326, 2464.08828733368, 2474.7772700457044, 2563.4104156044027, 2613.229097416248, 15354.385824567116, 15556.844431555654, 15639.139847308394, 15925.009373828272, 16125.354985800554, 2044.826189773871, 2153.1172219389973, 2174.086883508914, 2202.5925203837182, 2206.316042026977, 87621.0, 88264.55867720685, 89553.55223223908, 90385.0, 90653.0, 10158.339707919109, 10316.329438586468, 10317.48412579368, 10749.62376316825, 10929.617463388744, 14370.856291437161, 14974.625634359229, 15073.246337683073, 15082.924585377003, 15101.169435681142, 8293.377996650275, 8434.451760635538, 8535.018472875574, 8628.015556421933, 8796.560171991503, 8050.919490805134, 8364.079951205362, 8384.664613415394, 8386.87419688705, 8555.957220213859, 6873.175218973755, 7083.6458177090935, 7176.569405835667, 7187.27505398711, 7208.459365547605, 2007.4078146946686, 2116.798904104108, 2126.7022616833656, 2126.968095478569, 2135.58356120555, 993.8906720260766, 1100.928439651436, 1115.8326251062406, 1137.4710759496709, 1179.2511755035614, 20803.68794468084, 21304.467388315104, 21378.893105534684, 21417.78582214158, 21615.891920540296, 1042.1298215989582, 1050.0549505445008, 1081.691717860406, 1097.8298363753631, 1104.6630777612745, 11136.944315278533, 12041.217320874115, 12046.819297710541, 12191.146619736533, 12210.450529726184, 404644.0, 408268.0, 493286.0, 494457.2217111347, 500838.0, 63753.681231593546, 88454.0, 101199.49400252952, 107513.46243268733, 108949.0, 1053.5943661690305, 1078.7303174206606, 1115.2416356877402, 1131.9830202546968, 1133.54091592905, 18833.71749423787, 18938.0, 19164.904175479034, 19313.324033658755, 19323.13045912909, 36235.0, 43769.343459848766, 44723.77638111789, 45925.77037114793, 46628.06743865171, 66207.0, 66569.33430665631, 67538.32461675517, 67761.0, 68068.3193168062, 8428.283595894418, 9233.538323083952, 9302.581383837878, 9561.187299079656, 9739.805203895741, 14027.929860350632, 14163.504277350243, 14523.636909077357, 14542.345594448063, 14720.0, 6610.768623098168, 10596.463512790448, 10607.628732994308, 12559.120861539604, 12916.22502649844, 12098.879011209776, 12271.386430678253, 12512.812307815208, 12910.741785164431, 13071.934640326737, 12078.637640870787, 12498.687532811753, 12624.431900564314, 12729.236245825281, 12985.415656295301, 8307.584620769057, 8575.828483430421, 8813.250873675554, 8906.376553641183, 8994.685186018458, 11534.59628912984, 12414.255144691348, 12620.873791261969, 12697.174683645533, 12725.363731813557], "value": 10089.6521134639, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.9777553336698, 1520.4754359745887, 1682.9061110278317, 1816.9091545422734, 1832.8167183281664, 9043.321750868687, 9806.460644664541, 9811.607535698564, 9825.508724563779, 9832.803343933127, 8419.66321347147, 8785.956070219656, 8833.20501154896, 9025.954870225656, 9054.502002389883, 2523.394385347517, 2553.3361326055174, 2553.9872300638563, 2558.5522533556646, 2559.4241295708503, 2184.9016794244217, 2548.694156701189, 2587.8188526803133, 2591.5983022631426, 2592.948141037178, 2258.367657056027, 2501.837380570257, 2592.4037471381594, 2592.5074235895117, 2607.439400528886, 2449.252977841749, 2456.7174774900936, 2465.593177125781, 2522.6342180383926, 2522.848629082261, 2508.397984483729, 2524.684414448194, 2524.7475252474787, 2528.3679080229945, 2530.607755797854, 9527.952360238154, 9731.756706082333, 9748.415095094246, 9752.268579856469, 9759.65841195562, 5424.05079111154, 5537.086380747212, 5559.471850174227, 5566.638168519034, 5568.52667523261, 3509.4209455439823, 3644.362236608583, 3703.2593481303848, 3721.79530125843, 3725.3480640887738, 1215.9421303465954, 1294.5598496511138, 1297.5328881602616, 2196.3081629286885, 2240.596692595332, 13238.536651217257, 13264.801027984588, 13269.402876870565, 13287.73424531504, 13311.933440332736, 4789.377380940456, 4843.8304659337455, 4889.731064791471, 4902.828401005948, 5019.3976722793495, 10404.58381664725, 10430.16558675304, 10433.739156521147, 10437.2693911427, 10442.321249118935, 5550.972245138829, 5555.055640541118, 5556.083246264402, 5556.944430555724, 5568.025595520849, 5120.385553733576, 5219.0, 5220.295260139908, 5249.947500525022, 5284.81503147388, 4053.310937140693, 4091.1204091120553, 4143.91712165755, 4187.644050255702, 4269.658427325869, 1111.1055600241882, 1143.5082914346744, 1216.5802798034663, 1224.3755684600917, 1226.0, 895.632790555869, 902.6299217320867, 918.4581097152578, 991.177322822056, 1012.099231683802, 6083.391660833881, 6153.938460615426, 6197.349278325711, 6408.871822563616, 6490.8052758417325, 480.92305231162845, 492.88663607370506, 530.941596424393, 540.0980362794144, 669.8411747676547, 4140.710150289451, 4239.59723826236, 4248.553901840262, 4270.722403043792, 4284.036091879302, 11575.189736718348, 12102.213356131822, 12170.57402990891, 12178.086643501772, 12193.634190974284, 11968.82046769299, 11971.52113915451, 11977.760444791229, 11987.460564274628, 11989.22070065443, 8307.0, 8704.608292626846, 8705.608247628872, 8910.019897811235, 8911.37620366581, 6530.249021362604, 6543.443807276435, 6559.967200163968, 6721.395074443323, 6797.25230224665, 11154.498047587716, 11156.721081972692, 11169.944150279196, 11214.66356009321, 11321.207515473838, 11056.834147487954, 11085.334879907232, 11354.602588909349, 11358.488868000795, 11469.31184128955, 8319.792005199677, 8467.153284671484, 8469.830603388022, 8470.788230294293, 8486.363522735695, 8817.382783205114, 9082.318826088202, 9159.313051521029, 9380.437173769596, 9382.202512786489, 8087.63605637736, 8143.51138931666, 8183.181681831769, 8242.464239824392, 8455.365847561581, 7762.379009679099, 7967.2431119043595, 8087.433879628369, 8088.393370497119, 8297.792555186168, 7341.192468828318, 7426.702931882664, 7438.628068596657, 7441.255874412515, 7449.180590135189, 5343.919841202307, 5350.090484617702, 5385.75764090609, 5412.188171774265, 5474.686075341969, 5540.944590554042, 5591.832245032656, 5613.438656134517, 5619.550435965195, 5637.774489020558], "value": 4905.782864324146, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.49890651993735, 364.54796052894403, 365.72936027339745, 366.3972764801901, 370.3629756818273, 5419.4799418270495, 5540.529055030327, 5561.499465048145, 5618.381977982423, 5624.3531993820725, 5445.319335083114, 5572.972135139329, 5594.24477695511, 5596.524295434882, 5661.886762264752, 4207.0, 4301.978490107545, 4345.435093437849, 4389.670774691895, 4428.6014258716705, 4399.0, 4405.889852753675, 4420.806382276784, 4423.225935461298, 4443.955560444387, 4389.4513185851765, 4406.664467832038, 4418.182636212311, 4431.493292280624, 4439.644828413735, 4360.171567402215, 4375.474943006828, 4431.113777244564, 4453.821847126111, 4459.464864216298, 3913.2173565287057, 3919.412088186766, 3929.76421414716, 3942.5663177050787, 3944.309745794503, 5385.838424847261, 5387.24578559002, 5425.701586412746, 5444.210589464506, 5450.91823622646, 4860.198067318888, 5014.84955451337, 5018.84943451697, 5040.6471546991725, 5089.872753181163, 5714.0, 5801.82594522165, 5807.709614519257, 5807.970960145214, 5821.3596504384905, 4283.957160428387, 4289.828406863721, 4297.39836422901, 4309.396684464146, 4323.913521729579, 5860.677662728591, 6030.7889223876955, 6040.305364883051, 6049.823842482688, 6078.422549857756, 4351.782410879443, 4357.324614684729, 4364.192624364503, 4377.789216445674, 4397.73613583186, 4454.0, 4455.019895623022, 4456.821727130943, 4465.866024019285, 4466.4640243171025, 4831.371921650163, 4975.577075948585, 4986.0, 4996.725180115056, 5014.52362025607, 5581.5255703265675, 5678.4037676044245, 5742.942570574324, 5870.5010074144175, 5875.148103524965, 1506.6986602679508, 1525.3441020361129, 1526.2979029646265, 1526.7557190849411, 1529.694061187767, 943.9192125016817, 972.9416235025922, 975.9024097590184, 981.6907674082642, 988.5057471264367, 5018.787975695558, 5023.111710766324, 5025.748712564357, 5027.832465546682, 5029.421616514074, 5250.7374631268285, 5266.473352664703, 5276.15581506957, 5289.0, 5293.523582877559, 4979.580819466507, 5004.149294619923, 5008.273800298936, 5285.524302812689, 5720.399358067426, 3192.972462486338, 3197.7122059014337, 3220.9194770130935, 3222.146131275214, 3225.822579758136, 6038.460192650846, 6202.906956395657, 6214.40963108504, 6231.906521402183, 6243.719032643542, 6086.813071451024, 6109.480694141048, 6119.479844213202, 6131.570790044654, 6136.8772624547255, 6151.753929842756, 6187.876242475125, 6189.1954045974635, 6193.102000209944, 6279.780207692709, 5833.649981001154, 5987.5808693391045, 6011.158437818796, 6037.728302226323, 6098.469135308797, 5924.822255332347, 5934.3175534814045, 5946.940530594638, 5947.256592925884, 5953.642781433128, 5951.196588460675, 6193.721282542387, 6215.595986260879, 6222.439980401786, 6232.407921247474, 4294.463192100988, 4314.741115533078, 4340.327249276367, 4344.4352234209355, 4344.892052526586, 5774.82675519735, 5961.642301461753, 6028.944934636509, 6080.939190608037, 6098.902197604474, 5732.971335143465, 5854.121881717776, 5872.677002764889, 5881.147233651182, 5962.850928726816, 5861.677607731445, 5864.595515838486, 5875.6474611523445, 5891.617044892068, 5898.3484624305265, 5576.996140694714, 5811.331696854916, 5826.41735826414, 5837.357890631942, 5845.941540584709, 5807.8548036299435, 5886.323072846678, 5895.29256489224, 5896.764129434775, 5924.31870334917, 5458.61789674719, 5706.172604972173, 5755.1942728017275, 5775.653460792366, 5835.824925252249], "value": 4450.356723936045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.4335681806825, 880.8722735203396, 899.518757464756, 911.1708345405682, 923.7044145873323, 15973.281202345894, 17515.64968700625, 17600.91199544002, 17648.205830737646, 17650.735238971425, 14255.429782808675, 14280.285985700726, 15949.0, 16421.42525011625, 16498.34006639736, 737.59800908505, 750.1036261667283, 871.2855458524012, 886.3131073418089, 891.6477991193507, 860.8235311761106, 872.5157537566648, 879.0681877210178, 880.5729221327651, 880.7225723896984, 929.6188562689299, 929.9256059515222, 929.9767505812341, 932.4498545857942, 932.6362718539775, 768.9231076892322, 927.9860802087941, 930.999175885922, 931.4178638350996, 932.8087742012871, 581.2647001543052, 663.3929954092048, 678.5453745990199, 682.0553533356288, 683.2381894187994, 15707.764383534257, 15744.0, 15747.527574172793, 15780.842191578167, 15795.052296862224, 14431.0, 14886.330115144845, 14918.17950012749, 15126.394944202219, 15165.545033649008, 12882.355882205946, 12900.290484023375, 12926.030547708959, 12980.026498012592, 13155.210687358693, 4562.840300589497, 4592.1045396147765, 4600.907981840344, 4673.191349050547, 4675.742834144121, 88282.5585872073, 88366.5581672094, 88563.55718221432, 88583.11416885878, 88981.11018889793, 11254.43727813606, 11903.40482975865, 11971.221870578385, 11978.64064078079, 12323.014158867269, 22503.437414064778, 22537.88731056367, 22581.887090564443, 22584.322470325915, 22586.322410327717, 8896.334076190238, 9002.774930626787, 9043.050479699537, 9057.456552606733, 9177.357584968988, 4802.399700037496, 4926.433460152129, 4946.0, 5101.464346243665, 5123.231515272664, 3710.9443358349645, 3783.0, 3831.750936189139, 3835.4822099016833, 3839.6928245740273, 675.0, 675.709444938681, 683.2108914204102, 686.1012074182836, 697.5709938387855, 670.5641333133502, 692.6052150274295, 700.6251655364356, 727.1928159742681, 742.6843591473602, 8956.845468001613, 9467.100625440573, 9833.262505311986, 9866.161376282953, 9892.25808064398, 637.8628594852129, 644.2880616918331, 688.9276625954203, 712.0, 757.9729466572825, 4678.6491013174145, 4760.880977975578, 4764.4282686077195, 4800.807967681254, 4802.183628783116, 105017.47491262648, 105607.4719626397, 110765.0, 116499.0, 133842.0, 96573.0, 100819.0, 101984.49007755062, 102203.4889825561, 104626.0, 82445.3510929778, 84631.0, 86516.13483865207, 92556.0, 104594.0, 10469.738256543342, 10773.116024686178, 11060.668179954615, 11090.778184436427, 11094.944525277322, 57313.71343143425, 57814.0, 58858.0, 59518.10722839074, 61024.38975610187, 75973.0, 78100.0, 87266.0, 89118.0, 90318.0, 15349.616259593153, 15474.922625386802, 15750.527484175493, 15770.211489425254, 15787.447439339569, 16810.0, 16887.493375198763, 17103.57241068983, 17718.73421898647, 18305.633887322445, 15147.242637868283, 15231.543053707963, 15655.921720391325, 16145.75781363304, 16153.919230403773, 15028.474003409829, 15089.245537723289, 15582.766258506359, 15758.290876910796, 16742.1628918556, 13981.0, 13992.580222593338, 14759.92620036893, 15198.924005379902, 15428.614284642974, 11596.768064638829, 11672.824907626222, 11815.645530634094, 11934.70218091515, 12440.875591243972, 11947.0, 12301.384930753606, 12325.0, 12348.629541113782, 12867.163634363736], "value": 8165.135701289395, "unit": "score"}], "name": "dromaeo_css", "value": 7786.544708668328, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 111.0, 108.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 117.0, 164.0, 119.0, 116.0, 116.0, 115.0, 150.0, 121.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 160.0, 159.0, 160.0, 161.0, 159.0, 161.0, 158.0, 159.0], "value": 159.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 108.0, 75.0, 75.0, 76.0, 74.0, 100.0, 74.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 110.0, 81.0, 81.0, 80.0, 118.0, 81.0, 81.0, 113.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 48.0, 49.0, 48.0, 49.0, 50.0, 48.0, 49.0, 51.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 69.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 58.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0, 74.0, 72.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 121.0, 125.0, 120.0, 130.0, 122.0, 129.0, 125.0, 168.0, 117.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 150.0, 153.0, 153.0, 149.0, 151.0, 155.0, 155.0, 150.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 62.0, 60.0, 63.0, 61.0, 60.0, 61.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1449.8999999999999, "alertThreshold": 2.0}]} 07:04:48 INFO - Return code: 0 07:04:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:04:48 INFO - # TBPL SUCCESS # 07:04:48 INFO - Running post-action listener: _resource_record_post_action 07:04:48 INFO - [mozharness: 2016-11-11 15:04:48.806340Z] Finished run-tests step (success) 07:04:48 INFO - Running post-run listener: _resource_record_post_run 07:04:48 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7733248; Write bytes: 394309632; Read time: 1528; Write time: 374988 07:04:48 INFO - TinderboxPrint: CPU usage
13.0% 07:04:48 INFO - TinderboxPrint: I/O read bytes / time
7,733,248 / 1,528 07:04:48 INFO - TinderboxPrint: I/O write bytes / time
394,309,632 / 374,988 07:04:48 INFO - TinderboxPrint: CPU idle
8,279.2 (87.0%) 07:04:48 INFO - TinderboxPrint: CPU user
1,188.1 (12.5%) 07:04:48 INFO - TinderboxPrint: Swap in / out
0 / 0 07:04:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17682432; Read time: 0; Write time: 10648 07:04:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5566464; Write bytes: 328970240; Read time: 884; Write time: 331980 07:04:49 INFO - Running post-run listener: _upload_blobber_files 07:04:49 INFO - Blob upload gear active. 07:04:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:04:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:04:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:04:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:04:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:50 INFO - (blobuploader) - INFO - Done attempting. 07:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:04:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:51 INFO - (blobuploader) - INFO - Done attempting. 07:04:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:04:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:04:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:54 INFO - (blobuploader) - INFO - Done attempting. 07:04:54 INFO - (blobuploader) - INFO - Iteration through files over. 07:04:54 INFO - Return code: 0 07:04:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:04:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:04:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17be24daec908d99883f470adedf3d5818c1c66d4f55b6a31300c46a46c66ef73633690038a60734843b5a4e3a0504f33a186dd8a6d66a1dbd3f6a72b1917f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/daad6895578ea99041c8546c5fc60a7ac8850f2ff77bdb21c142e232de3d9dc50670320ace5c9f956cae2e082d1e914242375fe10cada13a585892c0d3579c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a43bc88b03fbd4b1d5b7927e8a3074bfd32a39f10125404ad20efe29ffc7e7cead05270a4ceb01a0c9b9e28d887bf52c02bffae34c9e4dc4459531ea65abf99"} 07:04:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:04:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:04:54 INFO - Contents: 07:04:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17be24daec908d99883f470adedf3d5818c1c66d4f55b6a31300c46a46c66ef73633690038a60734843b5a4e3a0504f33a186dd8a6d66a1dbd3f6a72b1917f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/daad6895578ea99041c8546c5fc60a7ac8850f2ff77bdb21c142e232de3d9dc50670320ace5c9f956cae2e082d1e914242375fe10cada13a585892c0d3579c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a43bc88b03fbd4b1d5b7927e8a3074bfd32a39f10125404ad20efe29ffc7e7cead05270a4ceb01a0c9b9e28d887bf52c02bffae34c9e4dc4459531ea65abf99"} 07:04:54 INFO - Running post-run listener: copy_logs_to_upload_dir 07:04:54 INFO - Copying logs to upload dir... 07:04:54 INFO - mkdir: /builds/slave/test/build/upload/logs 07:04:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.064575 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-11 07:04:54.860566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 07:04:54.863620) ========= 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=62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17be24daec908d99883f470adedf3d5818c1c66d4f55b6a31300c46a46c66ef73633690038a60734843b5a4e3a0504f33a186dd8a6d66a1dbd3f6a72b1917f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/daad6895578ea99041c8546c5fc60a7ac8850f2ff77bdb21c142e232de3d9dc50670320ace5c9f956cae2e082d1e914242375fe10cada13a585892c0d3579c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a43bc88b03fbd4b1d5b7927e8a3074bfd32a39f10125404ad20efe29ffc7e7cead05270a4ceb01a0c9b9e28d887bf52c02bffae34c9e4dc4459531ea65abf99"} build_url:https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/fLF84hHEQKSZU18Gdi-sLw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17be24daec908d99883f470adedf3d5818c1c66d4f55b6a31300c46a46c66ef73633690038a60734843b5a4e3a0504f33a186dd8a6d66a1dbd3f6a72b1917f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/daad6895578ea99041c8546c5fc60a7ac8850f2ff77bdb21c142e232de3d9dc50670320ace5c9f956cae2e082d1e914242375fe10cada13a585892c0d3579c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a43bc88b03fbd4b1d5b7927e8a3074bfd32a39f10125404ad20efe29ffc7e7cead05270a4ceb01a0c9b9e28d887bf52c02bffae34c9e4dc4459531ea65abf99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 07:04:54.889594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:04:54.889923) ========= 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=62c568580acbfdaac3eec7be000001dc-1478874572.47005-1712151442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:04:54.974200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 07:04:54.974559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 07:04:54.974867) ========= ========= Total master_lag: 0.20 =========