builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1470701968.26 results: success (0) buildid: 20160808133003 builduid: 642d1652843948b49674edb4a002f7d0 revision: b61757c08a5fbe9df2a1af7e462650b8c5b556ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.258866) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.259294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.259632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.325918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.326245) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 17:19:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-08-08 17:19:28 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.485095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.485709) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019352 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.539002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:28.539837) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b61757c08a5fbe9df2a1af7e462650b8c5b556ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b61757c08a5fbe9df2a1af7e462650b8c5b556ba --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=9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 17:19:28,727 truncating revision to first 12 chars 2016-08-08 17:19:28,727 Setting DEBUG logging. 2016-08-08 17:19:28,727 attempt 1/10 2016-08-08 17:19:28,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b61757c08a5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 17:19:29,044 unpacking tar archive at: mozilla-inbound-b61757c08a5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:29.252065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:29.252412) ========= script_repo_revision: b61757c08a5fbe9df2a1af7e462650b8c5b556ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:29.252854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:29.253209) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 17:19:29.263015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-08 17:19:29.263316) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:19:29 INFO - MultiFileLogger online at 20160808 17:19:29 in /builds/slave/test 17:19:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 17:19:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:19:29 INFO - {'append_to_log': False, 17:19:29 INFO - 'base_work_dir': '/builds/slave/test', 17:19:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 17:19:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:19:29 INFO - 'branch': 'Mozilla-Inbound', 17:19:29 INFO - 'buildbot_json_path': 'buildprops.json', 17:19:29 INFO - 'config_files': ('talos/linux_config.py',), 17:19:29 INFO - 'default_actions': ('clobber', 17:19:29 INFO - 'read-buildbot-config', 17:19:29 INFO - 'download-and-extract', 17:19:29 INFO - 'populate-webroot', 17:19:29 INFO - 'create-virtualenv', 17:19:29 INFO - 'install', 17:19:29 INFO - 'run-tests'), 17:19:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:19:29 INFO - 'download_minidump_stackwalk': True, 17:19:29 INFO - 'download_symbols': 'ondemand', 17:19:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:19:29 INFO - 'tooltool.py': '/tools/tooltool.py', 17:19:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:19:29 INFO - '/tools/misc-python/virtualenv.py')}, 17:19:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:19:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:19:29 INFO - 'installer_path': 'installer.exe', 17:19:29 INFO - 'log_level': 'info', 17:19:29 INFO - 'log_name': 'talos', 17:19:29 INFO - 'log_to_console': True, 17:19:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:19:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:19:29 INFO - 'opt_config_files': (), 17:19:29 INFO - 'pip_index': False, 17:19:29 INFO - 'sps_profile': False, 17:19:29 INFO - 'sps_profile_interval': 0, 17:19:29 INFO - 'suite': 'dromaeojs', 17:19:29 INFO - 'system_bits': '32', 17:19:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:19:29 INFO - 'title': 'talos-linux64-ix-022', 17:19:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:19:29 INFO - 'use_talos_json': True, 17:19:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:19:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:19:29 INFO - 'work_dir': 'build'} 17:19:29 INFO - [mozharness: 2016-08-09 00:19:29.535173Z] Running clobber step. 17:19:29 INFO - Running pre-action listener: _resource_record_pre_action 17:19:29 INFO - Running main action method: clobber 17:19:29 INFO - rmtree: /builds/slave/test/build 17:19:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:19:29 INFO - Running post-action listener: _resource_record_post_action 17:19:29 INFO - [mozharness: 2016-08-09 00:19:29.984350Z] Finished clobber step (success) 17:19:29 INFO - [mozharness: 2016-08-09 00:19:29.984452Z] Running read-buildbot-config step. 17:19:29 INFO - Running pre-action listener: _resource_record_pre_action 17:19:29 INFO - Running main action method: read_buildbot_config 17:19:29 INFO - Using buildbot properties: 17:19:29 INFO - { 17:19:29 INFO - "project": "", 17:19:29 INFO - "product": "firefox", 17:19:29 INFO - "script_repo_revision": "production", 17:19:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 17:19:29 INFO - "repository": "", 17:19:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 17:19:29 INFO - "buildid": "20160808133003", 17:19:29 INFO - "pgo_build": "True", 17:19:29 INFO - "basedir": "/builds/slave/test", 17:19:29 INFO - "buildnumber": 2217, 17:19:29 INFO - "slavename": "talos-linux64-ix-022", 17:19:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:19:29 INFO - "platform": "ubuntu64_hw", 17:19:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 17:19:29 INFO - "branch": "mozilla-inbound", 17:19:29 INFO - "repo_path": "integration/mozilla-inbound", 17:19:29 INFO - "revision": "b61757c08a5fbe9df2a1af7e462650b8c5b556ba", 17:19:29 INFO - "stage_platform": "linux64-pgo", 17:19:29 INFO - "builduid": "642d1652843948b49674edb4a002f7d0", 17:19:29 INFO - "slavebuilddir": "test" 17:19:29 INFO - } 17:19:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:19:29 INFO - Running post-action listener: _resource_record_post_action 17:19:29 INFO - [mozharness: 2016-08-09 00:19:29.986976Z] Finished read-buildbot-config step (success) 17:19:29 INFO - [mozharness: 2016-08-09 00:19:29.987066Z] Running download-and-extract step. 17:19:29 INFO - Running pre-action listener: _resource_record_pre_action 17:19:29 INFO - Running main action method: download_and_extract 17:19:29 INFO - mkdir: /builds/slave/test/build/tests 17:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:29 INFO - trying https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:19:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:19:30 INFO - Downloaded 1361 bytes. 17:19:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:19:30 INFO - Using the following test package requirements: 17:19:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:19:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:19:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:19:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'jsshell-linux-x86_64.zip'], 17:19:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:19:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:19:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:19:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:19:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:19:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:19:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:19: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')]} 17:19:30 INFO - trying https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:19:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:19:31 INFO - Downloaded 21829409 bytes. 17:19:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:19:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:19:32 INFO - Return code: 0 17:19:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:32 INFO - trying https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:19:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:19:33 INFO - Downloaded 21829409 bytes. 17:19:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:19:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:19:34 INFO - Return code: 0 17:19:34 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')]} 17:19:34 INFO - trying https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:19:35 INFO - Downloaded 14413723 bytes. 17:19:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:19:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:19:36 INFO - Return code: 0 17:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:36 INFO - trying https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:19:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:19:38 INFO - Downloaded 59364771 bytes. 17:19:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:19:38 INFO - mkdir: /builds/slave/test/properties 17:19:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:19:38 INFO - Writing to file /builds/slave/test/properties/build_url 17:19:38 INFO - Contents: 17:19:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:19:39 INFO - Running post-action listener: _resource_record_post_action 17:19:39 INFO - Running post-action listener: set_extra_try_arguments 17:19:39 INFO - [mozharness: 2016-08-09 00:19:39.346217Z] Finished download-and-extract step (success) 17:19:39 INFO - [mozharness: 2016-08-09 00:19:39.346450Z] Running populate-webroot step. 17:19:39 INFO - Running pre-action listener: _resource_record_pre_action 17:19:39 INFO - Running main action method: populate_webroot 17:19:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:19:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:19:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:19:39 INFO - '--tppagecycles', 17:19:39 INFO - '7'], 17:19:39 INFO - 'tests': ['tsvgm']}}, 17:19:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:19:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:19:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:19:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:19:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['damp', 'tps']}, 17:19:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'tests': ['damp', 'tps']}, 17:19:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['dromaeo_dom']}, 17:19:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:19:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['basic_compositor_video']}, 17:19:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:19:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['a11yr', 17:19:39 INFO - 'ts_paint', 17:19:39 INFO - 'tpaint', 17:19:39 INFO - 'sessionrestore', 17:19:39 INFO - 'sessionrestore_no_auto_restore', 17:19:39 INFO - 'tabpaint']}, 17:19:39 INFO - 'other-e10s': {'tests': ['a11yr', 17:19:39 INFO - 'ts_paint', 17:19:39 INFO - 'tpaint', 17:19:39 INFO - 'sessionrestore', 17:19:39 INFO - 'sessionrestore_no_auto_restore', 17:19:39 INFO - 'tabpaint']}, 17:19:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:19:39 INFO - 'ts_paint', 17:19:39 INFO - 'tpaint', 17:19:39 INFO - 'sessionrestore', 17:19:39 INFO - 'sessionrestore_no_auto_restore', 17:19:39 INFO - 'tabpaint']}, 17:19:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:19:39 INFO - 'ts_paint', 17:19:39 INFO - 'tpaint', 17:19:39 INFO - 'sessionrestore', 17:19:39 INFO - 'sessionrestore_no_auto_restore', 17:19:39 INFO - 'tabpaint']}, 17:19:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['a11yr', 17:19:39 INFO - 'ts_paint', 17:19:39 INFO - 'tpaint', 17:19:39 INFO - 'sessionrestore', 17:19:39 INFO - 'sessionrestore_no_auto_restore', 17:19:39 INFO - 'tabpaint']}, 17:19:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['a11yr', 17:19:39 INFO - 'ts_paint', 17:19:39 INFO - 'tpaint', 17:19:39 INFO - 'sessionrestore', 17:19:39 INFO - 'sessionrestore_no_auto_restore', 17:19:39 INFO - 'tabpaint']}, 17:19:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['tsvgx', 17:19:39 INFO - 'tsvgr_opacity', 17:19:39 INFO - 'tart', 17:19:39 INFO - 'tscrollx', 17:19:39 INFO - 'cart']}, 17:19:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:19:39 INFO - 'tsvgr_opacity', 17:19:39 INFO - 'tart', 17:19:39 INFO - 'tscrollx', 17:19:39 INFO - 'cart']}, 17:19:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'talos_options': ['--disable-e10s'], 17:19:39 INFO - 'tests': ['tp5o']}, 17:19:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'tests': ['tp5o']}, 17:19:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'talos_options': ['--disable-e10s', 17:19:39 INFO - '--xperf_path', 17:19:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:39 INFO - 'tests': ['tp5n']}, 17:19:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:39 INFO - 'talos_options': ['--xperf_path', 17:19:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:39 INFO - 'tests': ['tp5n']}}, 17:19:39 INFO - 'talos.zip': {'path': '', 17:19:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:19:39 INFO - Running post-action listener: _resource_record_post_action 17:19:39 INFO - [mozharness: 2016-08-09 00:19:39.361603Z] Finished populate-webroot step (success) 17:19:39 INFO - [mozharness: 2016-08-09 00:19:39.361692Z] Running create-virtualenv step. 17:19:39 INFO - Running pre-action listener: _resource_record_pre_action 17:19:39 INFO - Running main action method: create_virtualenv 17:19:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:19:39 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 17:19:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:19:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:19:39 INFO - Using real prefix '/usr' 17:19:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:19:39 INFO - Installing distribute.............................................................................................................................................................................................done. 17:19:41 INFO - Installing pip.................done. 17:19:41 INFO - Return code: 0 17:19:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:41 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19:41 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 17:19:41 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 17:19:41 INFO - Using env: {'DISPLAY': ':0', 17:19:41 INFO - 'HOME': '/home/cltbld', 17:19:41 INFO - 'LANG': 'en_US.UTF-8', 17:19:41 INFO - 'LANGUAGE': 'en_US:en', 17:19:41 INFO - 'LOGNAME': 'cltbld', 17:19:41 INFO - 'MAIL': '/var/mail/cltbld', 17:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:41 INFO - 'MOZ_NO_REMOTE': '1', 17:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:41 INFO - 'NO_EM_RESTART': '1', 17:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:41 INFO - 'PWD': '/builds/slave/test', 17:19:41 INFO - 'SHELL': '/bin/bash', 17:19:41 INFO - 'SHLVL': '1', 17:19:41 INFO - 'TERM': 'linux', 17:19:41 INFO - 'TMOUT': '86400', 17:19:41 INFO - 'USER': 'cltbld', 17:19:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:41 INFO - '_': '/tools/buildbot/bin/python'} 17:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:42 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 17:19:42 INFO - Cleaning up... 17:19:42 INFO - Return code: 0 17:19:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:19: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')]} 17:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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', '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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:19: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 psutil>=3.1.1 17:19:42 INFO - Using env: {'DISPLAY': ':0', 17:19:42 INFO - 'HOME': '/home/cltbld', 17:19:42 INFO - 'LANG': 'en_US.UTF-8', 17:19:42 INFO - 'LANGUAGE': 'en_US:en', 17:19:42 INFO - 'LOGNAME': 'cltbld', 17:19:42 INFO - 'MAIL': '/var/mail/cltbld', 17:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:42 INFO - 'MOZ_NO_REMOTE': '1', 17:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:42 INFO - 'NO_EM_RESTART': '1', 17:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:42 INFO - 'PWD': '/builds/slave/test', 17:19:42 INFO - 'SHELL': '/bin/bash', 17:19:42 INFO - 'SHLVL': '1', 17:19:42 INFO - 'TERM': 'linux', 17:19:42 INFO - 'TMOUT': '86400', 17:19:42 INFO - 'USER': 'cltbld', 17:19:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:42 INFO - '_': '/tools/buildbot/bin/python'} 17:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:42 INFO - Downloading/unpacking psutil>=3.1.1 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:19:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:44 INFO - Installing collected packages: psutil 17:19:44 INFO - Running setup.py install for psutil 17:19:44 INFO - building 'psutil._psutil_linux' extension 17:19:44 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 17:19:44 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 17:19:44 INFO - building 'psutil._psutil_posix' extension 17:19:44 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 17:19:44 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 17:19:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:44 INFO - Successfully installed psutil 17:19:44 INFO - Cleaning up... 17:19:44 INFO - Return code: 0 17:19:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:19: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')]} 17:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:19: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 mozsystemmonitor==0.3 17:19:44 INFO - Using env: {'DISPLAY': ':0', 17:19:44 INFO - 'HOME': '/home/cltbld', 17:19:44 INFO - 'LANG': 'en_US.UTF-8', 17:19:44 INFO - 'LANGUAGE': 'en_US:en', 17:19:44 INFO - 'LOGNAME': 'cltbld', 17:19:44 INFO - 'MAIL': '/var/mail/cltbld', 17:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:44 INFO - 'MOZ_NO_REMOTE': '1', 17:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:44 INFO - 'NO_EM_RESTART': '1', 17:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:44 INFO - 'PWD': '/builds/slave/test', 17:19:44 INFO - 'SHELL': '/bin/bash', 17:19:44 INFO - 'SHLVL': '1', 17:19:44 INFO - 'TERM': 'linux', 17:19:44 INFO - 'TMOUT': '86400', 17:19:44 INFO - 'USER': 'cltbld', 17:19:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:44 INFO - '_': '/tools/buildbot/bin/python'} 17:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:19:47 INFO - Installing collected packages: mozsystemmonitor 17:19:47 INFO - Running setup.py install for mozsystemmonitor 17:19:47 INFO - Successfully installed mozsystemmonitor 17:19:47 INFO - Cleaning up... 17:19:47 INFO - Return code: 0 17:19:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:47 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19:47 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 17:19:47 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 17:19:47 INFO - Using env: {'DISPLAY': ':0', 17:19:47 INFO - 'HOME': '/home/cltbld', 17:19:47 INFO - 'LANG': 'en_US.UTF-8', 17:19:47 INFO - 'LANGUAGE': 'en_US:en', 17:19:47 INFO - 'LOGNAME': 'cltbld', 17:19:47 INFO - 'MAIL': '/var/mail/cltbld', 17:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:47 INFO - 'MOZ_NO_REMOTE': '1', 17:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:47 INFO - 'NO_EM_RESTART': '1', 17:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:47 INFO - 'PWD': '/builds/slave/test', 17:19:47 INFO - 'SHELL': '/bin/bash', 17:19:47 INFO - 'SHLVL': '1', 17:19:47 INFO - 'TERM': 'linux', 17:19:47 INFO - 'TMOUT': '86400', 17:19:47 INFO - 'USER': 'cltbld', 17:19:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:47 INFO - '_': '/tools/buildbot/bin/python'} 17:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:47 INFO - Downloading/unpacking jsonschema==2.5.1 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:19:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:19:49 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 17:19:49 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 17:19:49 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 17:19:49 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 17:19:49 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 17:19:49 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 17:19:50 INFO - Downloading functools32-3.2.3-2.tar.gz 17:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:19:50 INFO - warning: no files found matching '*.txt' 17:19:50 INFO - no previously-included directories found matching 'build' 17:19:50 INFO - no previously-included directories found matching 'dist' 17:19:50 INFO - no previously-included directories found matching '.git*' 17:19:50 INFO - Installing collected packages: jsonschema, functools32 17:19:50 INFO - Running setup.py install for functools32 17:19:50 INFO - warning: no files found matching '*.txt' 17:19:50 INFO - no previously-included directories found matching 'build' 17:19:50 INFO - no previously-included directories found matching 'dist' 17:19:50 INFO - no previously-included directories found matching '.git*' 17:19:50 INFO - Successfully installed jsonschema functools32 17:19:50 INFO - Cleaning up... 17:19:50 INFO - Return code: 0 17:19:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:50 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19:50 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 17:19:50 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 17:19:50 INFO - Using env: {'DISPLAY': ':0', 17:19:50 INFO - 'HOME': '/home/cltbld', 17:19:50 INFO - 'LANG': 'en_US.UTF-8', 17:19:50 INFO - 'LANGUAGE': 'en_US:en', 17:19:50 INFO - 'LOGNAME': 'cltbld', 17:19:50 INFO - 'MAIL': '/var/mail/cltbld', 17:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:50 INFO - 'MOZ_NO_REMOTE': '1', 17:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:50 INFO - 'NO_EM_RESTART': '1', 17:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:50 INFO - 'PWD': '/builds/slave/test', 17:19:50 INFO - 'SHELL': '/bin/bash', 17:19:50 INFO - 'SHLVL': '1', 17:19:50 INFO - 'TERM': 'linux', 17:19:50 INFO - 'TMOUT': '86400', 17:19:50 INFO - 'USER': 'cltbld', 17:19:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:50 INFO - '_': '/tools/buildbot/bin/python'} 17:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:19:50 INFO - Cleaning up... 17:19:50 INFO - Return code: 0 17:19:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:50 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19:50 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 17:19:50 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 17:19:50 INFO - Using env: {'DISPLAY': ':0', 17:19:50 INFO - 'HOME': '/home/cltbld', 17:19:50 INFO - 'LANG': 'en_US.UTF-8', 17:19:50 INFO - 'LANGUAGE': 'en_US:en', 17:19:50 INFO - 'LOGNAME': 'cltbld', 17:19:50 INFO - 'MAIL': '/var/mail/cltbld', 17:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:50 INFO - 'MOZ_NO_REMOTE': '1', 17:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:50 INFO - 'NO_EM_RESTART': '1', 17:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:50 INFO - 'PWD': '/builds/slave/test', 17:19:50 INFO - 'SHELL': '/bin/bash', 17:19:50 INFO - 'SHLVL': '1', 17:19:50 INFO - 'TERM': 'linux', 17:19:50 INFO - 'TMOUT': '86400', 17:19:50 INFO - 'USER': 'cltbld', 17:19:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:50 INFO - '_': '/tools/buildbot/bin/python'} 17:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:19:50 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 17:19:50 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 17:19:50 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 17:19:50 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 17:19:50 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 17:19:50 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 17:19:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:19:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:19:52 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 17:19:52 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 17:19:52 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 17:19:52 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 17:19:52 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 17:19:52 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 17:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:19:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19: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 17:19:53 INFO - Downloading docopt-0.6.1.tar.gz 17:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:19:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:19:53 INFO - Running setup.py install for blobuploader 17:19:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:19:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:19:53 INFO - Running setup.py install for requests 17:19:53 INFO - Running setup.py install for docopt 17:19:53 INFO - Successfully installed blobuploader requests docopt 17:19:53 INFO - Cleaning up... 17:19:54 INFO - Return code: 0 17:19:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:54 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19:54 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 17:19:54 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 17:19:54 INFO - Using env: {'DISPLAY': ':0', 17:19:54 INFO - 'HOME': '/home/cltbld', 17:19:54 INFO - 'LANG': 'en_US.UTF-8', 17:19:54 INFO - 'LANGUAGE': 'en_US:en', 17:19:54 INFO - 'LOGNAME': 'cltbld', 17:19:54 INFO - 'MAIL': '/var/mail/cltbld', 17:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:54 INFO - 'MOZ_NO_REMOTE': '1', 17:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:54 INFO - 'NO_EM_RESTART': '1', 17:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:54 INFO - 'PWD': '/builds/slave/test', 17:19:54 INFO - 'SHELL': '/bin/bash', 17:19:54 INFO - 'SHLVL': '1', 17:19:54 INFO - 'TERM': 'linux', 17:19:54 INFO - 'TMOUT': '86400', 17:19:54 INFO - 'USER': 'cltbld', 17:19:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:54 INFO - '_': '/tools/buildbot/bin/python'} 17:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:19:54 INFO - Running setup.py (path:/tmp/pip-UeF_nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:19:54 INFO - Running setup.py (path:/tmp/pip-8OmC93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:19:54 INFO - Running setup.py (path:/tmp/pip-xoeTjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:19:54 INFO - Running setup.py (path:/tmp/pip-pZQGcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:19:54 INFO - Running setup.py (path:/tmp/pip-cCdZQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:19:54 INFO - Running setup.py (path:/tmp/pip-r61GlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:19:54 INFO - Running setup.py (path:/tmp/pip-k9R8cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:19:54 INFO - Running setup.py (path:/tmp/pip-pS4s1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:19:54 INFO - Running setup.py (path:/tmp/pip-9PqK3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:19:54 INFO - Running setup.py (path:/tmp/pip-ItGmOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:19:54 INFO - Running setup.py (path:/tmp/pip-n8mvCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:19:55 INFO - Running setup.py (path:/tmp/pip-cqREtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:19:55 INFO - Running setup.py (path:/tmp/pip-um0kGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:19:55 INFO - Running setup.py (path:/tmp/pip-MMahGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:55 INFO - Running setup.py (path:/tmp/pip-pQYtr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:19:55 INFO - Running setup.py (path:/tmp/pip-kiyzqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:19:55 INFO - Running setup.py (path:/tmp/pip-LsCoAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:19:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:19:55 INFO - Running setup.py install for manifestparser 17:19:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:19:55 INFO - Running setup.py install for mozcrash 17:19:55 INFO - Running setup.py install for mozdebug 17:19:55 INFO - Running setup.py install for mozdevice 17:19:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:19:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:19:55 INFO - Running setup.py install for mozfile 17:19:55 INFO - Running setup.py install for mozhttpd 17:19:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Running setup.py install for mozinfo 17:19:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Running setup.py install for mozInstall 17:19:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Running setup.py install for mozleak 17:19:56 INFO - Running setup.py install for mozlog 17:19:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Running setup.py install for moznetwork 17:19:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Running setup.py install for mozprocess 17:19:56 INFO - Running setup.py install for mozprofile 17:19:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Running setup.py install for mozrunner 17:19:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:19:56 INFO - Running setup.py install for mozscreenshot 17:19:57 INFO - Running setup.py install for moztest 17:19:57 INFO - Running setup.py install for mozversion 17:19:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:19:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:19:57 INFO - Cleaning up... 17:19:57 INFO - Return code: 0 17:19:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:57 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:19:57 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 17:19:57 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 17:19:57 INFO - Using env: {'DISPLAY': ':0', 17:19:57 INFO - 'HOME': '/home/cltbld', 17:19:57 INFO - 'LANG': 'en_US.UTF-8', 17:19:57 INFO - 'LANGUAGE': 'en_US:en', 17:19:57 INFO - 'LOGNAME': 'cltbld', 17:19:57 INFO - 'MAIL': '/var/mail/cltbld', 17:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:57 INFO - 'MOZ_NO_REMOTE': '1', 17:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:57 INFO - 'NO_EM_RESTART': '1', 17:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:57 INFO - 'PWD': '/builds/slave/test', 17:19:57 INFO - 'SHELL': '/bin/bash', 17:19:57 INFO - 'SHLVL': '1', 17:19:57 INFO - 'TERM': 'linux', 17:19:57 INFO - 'TMOUT': '86400', 17:19:57 INFO - 'USER': 'cltbld', 17:19:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:57 INFO - '_': '/tools/buildbot/bin/python'} 17:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:19:57 INFO - Running setup.py (path:/tmp/pip-kh0bFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:19:57 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)) 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:19:57 INFO - Running setup.py (path:/tmp/pip-pYkyxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:19:57 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)) 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:19:57 INFO - Running setup.py (path:/tmp/pip-zCO2zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:19:57 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)) 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:19:57 INFO - Running setup.py (path:/tmp/pip-mjoFFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:19:57 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)) 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:19:57 INFO - Running setup.py (path:/tmp/pip-CjXjN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:19:57 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)) 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:19:57 INFO - Running setup.py (path:/tmp/pip-Rn7YED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:19:57 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)) 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:19:57 INFO - Running setup.py (path:/tmp/pip-9fNSmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:19:57 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)) 17:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:19:57 INFO - Running setup.py (path:/tmp/pip-7XNGYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:19:58 INFO - Running setup.py (path:/tmp/pip-JvABd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:19:58 INFO - Running setup.py (path:/tmp/pip-w9t26N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:19:58 INFO - Running setup.py (path:/tmp/pip-hkdt7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:19:58 INFO - Running setup.py (path:/tmp/pip-WNfvQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:19:58 INFO - Running setup.py (path:/tmp/pip-q3X5aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:19:58 INFO - Running setup.py (path:/tmp/pip-EZJ3MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:58 INFO - Running setup.py (path:/tmp/pip-qZRSIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:19:58 INFO - Running setup.py (path:/tmp/pip-tG9vuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:19:58 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)) 17:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:19:58 INFO - Running setup.py (path:/tmp/pip-FmADp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:19:58 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)) 17:19:58 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)) 17:19:58 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)) 17:19:58 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)) 17:19:58 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)) 17:19:58 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)) 17:19:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:19:58 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 17:19:58 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 17:19:58 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 17:19:58 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 17:19:58 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 17:19:58 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 17:20:00 INFO - Downloading blessings-1.6.tar.gz 17:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:00 INFO - Installing collected packages: blessings 17:20:00 INFO - Running setup.py install for blessings 17:20:00 INFO - Successfully installed blessings 17:20:00 INFO - Cleaning up... 17:20:00 INFO - Return code: 0 17:20:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:01 INFO - Reading from file tmpfile_stdout 17:20:01 INFO - Current package versions: 17:20:01 INFO - argparse == 1.2.1 17:20:01 INFO - blessings == 1.6 17:20:01 INFO - blobuploader == 1.2.4 17:20:01 INFO - docopt == 0.6.1 17:20:01 INFO - functools32 == 3.2.3-2 17:20:01 INFO - jsonschema == 2.5.1 17:20:01 INFO - manifestparser == 1.1 17:20:01 INFO - mozInstall == 1.12 17:20:01 INFO - mozcrash == 0.17 17:20:01 INFO - mozdebug == 0.1 17:20:01 INFO - mozdevice == 0.48 17:20:01 INFO - mozfile == 1.2 17:20:01 INFO - mozhttpd == 0.7 17:20:01 INFO - mozinfo == 0.9 17:20:01 INFO - mozleak == 0.1 17:20:01 INFO - mozlog == 3.3 17:20:01 INFO - moznetwork == 0.27 17:20:01 INFO - mozprocess == 0.23 17:20:01 INFO - mozprofile == 0.28 17:20:01 INFO - mozrunner == 6.12 17:20:01 INFO - mozscreenshot == 0.1 17:20:01 INFO - mozsystemmonitor == 0.3 17:20:01 INFO - moztest == 0.7 17:20:01 INFO - mozversion == 1.4 17:20:01 INFO - psutil == 3.1.1 17:20:01 INFO - requests == 1.2.3 17:20:01 INFO - wsgiref == 0.1.2 17:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:01 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')]} 17:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:01 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')]} 17:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:01 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:20:01 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 17:20:01 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 17:20:01 INFO - Using env: {'DISPLAY': ':0', 17:20:01 INFO - 'HOME': '/home/cltbld', 17:20:01 INFO - 'LANG': 'en_US.UTF-8', 17:20:01 INFO - 'LANGUAGE': 'en_US:en', 17:20:01 INFO - 'LOGNAME': 'cltbld', 17:20:01 INFO - 'MAIL': '/var/mail/cltbld', 17:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:01 INFO - 'MOZ_NO_REMOTE': '1', 17:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:01 INFO - 'NO_EM_RESTART': '1', 17:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:01 INFO - 'PWD': '/builds/slave/test', 17:20:01 INFO - 'SHELL': '/bin/bash', 17:20:01 INFO - 'SHLVL': '1', 17:20:01 INFO - 'TERM': 'linux', 17:20:01 INFO - 'TMOUT': '86400', 17:20:01 INFO - 'USER': 'cltbld', 17:20:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:01 INFO - '_': '/tools/buildbot/bin/python'} 17:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 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)) 17:20:01 INFO - Cleaning up... 17:20:01 INFO - Return code: 0 17:20:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20:01 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')]} 17:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:01 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')]} 17:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:01 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 0x1b36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', '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 17:20:01 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 17:20:01 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 17:20:01 INFO - Using env: {'DISPLAY': ':0', 17:20:01 INFO - 'HOME': '/home/cltbld', 17:20:01 INFO - 'LANG': 'en_US.UTF-8', 17:20:01 INFO - 'LANGUAGE': 'en_US:en', 17:20:01 INFO - 'LOGNAME': 'cltbld', 17:20:01 INFO - 'MAIL': '/var/mail/cltbld', 17:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:01 INFO - 'MOZ_NO_REMOTE': '1', 17:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:01 INFO - 'NO_EM_RESTART': '1', 17:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:01 INFO - 'PWD': '/builds/slave/test', 17:20:01 INFO - 'SHELL': '/bin/bash', 17:20:01 INFO - 'SHLVL': '1', 17:20:01 INFO - 'TERM': 'linux', 17:20:01 INFO - 'TMOUT': '86400', 17:20:01 INFO - 'USER': 'cltbld', 17:20:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:01 INFO - '_': '/tools/buildbot/bin/python'} 17:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:20:01 INFO - Cleaning up... 17:20:01 INFO - Return code: 0 17:20:01 INFO - Running post-action listener: _resource_record_post_action 17:20:01 INFO - Running post-action listener: _start_resource_monitoring 17:20:01 INFO - Starting resource monitoring. 17:20:01 INFO - [mozharness: 2016-08-09 00:20:01.561487Z] Finished create-virtualenv step (success) 17:20:01 INFO - [mozharness: 2016-08-09 00:20:01.561927Z] Running install step. 17:20:01 INFO - Running pre-action listener: _resource_record_pre_action 17:20:01 INFO - Running main action method: install 17:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:01 INFO - Reading from file tmpfile_stdout 17:20:01 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:01 INFO - Reading from file tmpfile_stdout 17:20:01 INFO - Output received: 17:20:01 INFO - Usage: mozinstall [options] installer 17:20:01 INFO - Options: 17:20:01 INFO - -h, --help show this help message and exit 17:20:01 INFO - -d DEST, --destination=DEST 17:20:01 INFO - Directory to install application into. [default: 17:20:01 INFO - "/builds/slave/test"] 17:20:01 INFO - --app=APP Application being installed. [default: firefox] 17:20:01 INFO - mkdir: /builds/slave/test/build/application 17:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:20:19 INFO - Reading from file tmpfile_stdout 17:20:19 INFO - Output received: 17:20:19 INFO - /builds/slave/test/build/application/firefox/firefox 17:20:19 INFO - Running post-action listener: _resource_record_post_action 17:20:19 INFO - [mozharness: 2016-08-09 00:20:19.305370Z] Finished install step (success) 17:20:19 INFO - [mozharness: 2016-08-09 00:20:19.305626Z] Running run-tests step. 17:20:19 INFO - Running pre-action listener: _resource_record_pre_action 17:20:19 INFO - Running main action method: run_tests 17:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:20:19 INFO - Python 2.7.3 17:20:19 INFO - Return code: 0 17:20:19 INFO - grabbing minidump binary from tooltool 17:20:19 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')]} 17:20:19 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 0x1df53b0>, '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 0x1df62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:20:19 INFO - Return code: 0 17:20:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:20:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:20:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:20:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:20:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 17:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 17:20:19 INFO - Using env: {'DISPLAY': ':0', 17:20:19 INFO - 'HOME': '/home/cltbld', 17:20:19 INFO - 'LANG': 'en_US.UTF-8', 17:20:19 INFO - 'LANGUAGE': 'en_US:en', 17:20:19 INFO - 'LOGNAME': 'cltbld', 17:20:19 INFO - 'MAIL': '/var/mail/cltbld', 17:20:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:20:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:19 INFO - 'MOZ_NO_REMOTE': '1', 17:20:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:19 INFO - 'NO_EM_RESTART': '1', 17:20:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:19 INFO - 'PWD': '/builds/slave/test', 17:20:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:20:19 INFO - 'SHELL': '/bin/bash', 17:20:19 INFO - 'SHLVL': '1', 17:20:19 INFO - 'TERM': 'linux', 17:20:19 INFO - 'TMOUT': '86400', 17:20:19 INFO - 'USER': 'cltbld', 17:20:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694', 17:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:19 INFO - '_': '/tools/buildbot/bin/python'} 17:20:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 17:20:19 INFO - mozversion application_buildid: 20160808133003 17:20:19 INFO - mozversion application_changeset: b61757c08a5fbe9df2a1af7e462650b8c5b556ba 17:20:19 INFO - mozversion application_display_name: Nightly 17:20:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:20:19 INFO - mozversion application_name: Firefox 17:20:19 INFO - mozversion application_remotingname: firefox 17:20:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:20:19 INFO - mozversion application_vendor: Mozilla 17:20:19 INFO - mozversion application_version: 51.0a1 17:20:19 INFO - mozversion platform_buildid: 20160808133003 17:20:19 INFO - mozversion platform_changeset: b61757c08a5fbe9df2a1af7e462650b8c5b556ba 17:20:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:20:19 INFO - mozversion platform_version: 51.0a1 17:20:19 INFO - using testdate: 1470702019 17:20:19 INFO - actual date: 1470702019 17:20:19 INFO - starting webserver on 'localhost:60041' 17:20:19 INFO - SUITE-START | Running 2 tests 17:20:19 INFO - TEST-START | dromaeo_css 17:20:19 INFO - operating with platform_type : linux_ 17:20:19 INFO - Initialising browser for dromaeo_css test... 17:20:19 INFO - TEST-INFO | started process 8166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwhfalp/profile http://localhost:60041/getInfo.html) 17:20:23 INFO - PROCESS | 8166 | __metrics Screen width/height:1600/1200 17:20:23 INFO - PROCESS | 8166 | colorDepth:24 17:20:23 INFO - PROCESS | 8166 | Browser inner width/height: 1024/697 17:20:23 INFO - PROCESS | 8166 | __metrics 17:20:24 INFO - PROCESS | 8166 | 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" 17:20:24 INFO - PROCESS | 8166 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:20:25 INFO - PROCESS | 8166 | console.error: PushService: 17:20:25 INFO - PROCESS | 8166 | stateChangeProcessEnqueue: Error transitioning state 17:20:25 INFO - PROCESS | 8166 | UnknownError 17:20:25 INFO - TEST-INFO | 8166: exit 0 17:20:25 INFO - Browser initialized. 17:20:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:20:25 INFO - TEST-INFO | started process 8247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwhfalp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:37 INFO - PROCESS | 8247 | RSS: Main: 155959296 17:20:37 INFO - PROCESS | 8247 | 17:21:28 INFO - PROCESS | 8247 | 1470702088225 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] 17:23:38 INFO - PROCESS | 8247 | Cycle 1(1): loaded http://localhost:60041/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60041/tests/dromaeo/cssquery-ext.html) 17:23:39 INFO - PROCESS | 8247 | RSS: Main: 260866048 17:23:39 INFO - PROCESS | 8247 | 17:26:42 INFO - PROCESS | 8247 | Cycle 1(1): loaded http://localhost:60041/tests/dromaeo/cssquery-ext.html (next: http://localhost:60041/tests/dromaeo/cssquery-jquery.html) 17:26:42 INFO - PROCESS | 8247 | RSS: Main: 240865280 17:26:42 INFO - PROCESS | 8247 | 17:29:44 INFO - PROCESS | 8247 | Cycle 1(1): loaded http://localhost:60041/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60041/tests/dromaeo/cssquery-mootools.html) 17:29:45 INFO - PROCESS | 8247 | RSS: Main: 184012800 17:29:45 INFO - PROCESS | 8247 | 17:32:47 INFO - PROCESS | 8247 | Cycle 1(1): loaded http://localhost:60041/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60041/tests/dromaeo/cssquery-prototype.html) 17:32:48 INFO - PROCESS | 8247 | RSS: Main: 184172544 17:32:48 INFO - PROCESS | 8247 | 17:35:50 INFO - PROCESS | 8247 | Cycle 1(1): loaded http://localhost:60041/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60041/tests/dromaeo/cssquery-yui.html) 17:35:51 INFO - PROCESS | 8247 | RSS: Main: 183386112 17:35:51 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | Cycle 1(1): loaded http://localhost:60041/tests/dromaeo/cssquery-yui.html (next: http://localhost:60041/tests/dromaeo/cssquery-dojo.html) 17:38:54 INFO - PROCESS | 8247 | RSS: Main: 275578880 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | __start_tp_report 17:38:54 INFO - PROCESS | 8247 | _x_x_mozilla_page_load 17:38:54 INFO - PROCESS | 8247 | _x_x_mozilla_page_load_details 17:38:54 INFO - PROCESS | 8247 | |i|pagename|runs| 17:38:54 INFO - PROCESS | 8247 | |0;dojo.html;3019.7886147969625;3070.9385812283754;3093.1030001299623;3104.6429660589038;3129.5462157987095;5287.550558202557;5350.2777125088105;5352.4915133062395;5425.403205647381;5468.07042802724;5335.1997200419855;5347.893042139155;5362.785488580452;5393.406725260218;5405;4756.405449318835;4812.494688057756;4835.806567737286;4842.443119041302;4955.331030310898;4902.0931127741305;4902.436219834729;4903.730294833783;4907.1657818171;4908.484609116027;4733.100710864925;4783.665143439961;4844.32179494871;4855.732934688591;4879.634027447938;4772.498887616785;4776.522347765231;4779.3308936748535;4836;4884.951150488485;4768.928466073012;4799.088173247107;4800.495947925452;4842.588379987706;4877.1708809502115;5198.896022079575;5259.053370393328;5270.472952704698;5317.9468205317835;5383.757730902119;5671.092625179951;5671.7731290748325;5683.261176047129;5736.827895163152;5741.971290143564;5761.8559536011935;5774.0761478163295;5784.652920824764;5786;5787.681677507735;5189.506996835333;5247.370315562157;5316.46835316473;5323.707196104251;5370.812021579226;5846.035404158351;5850.736716847752;5888.116782482576;5891.145783861316;5891.49922256613;5606.859828504238;5617.185508101303;5660.320761508646;5671.744771485293;5678.119891416837;5515.338159420895;5559.33288005442;5622.072358060956;5749.1663708762;5749.453801888814;5591.077472217039;5601.719914004283;5602.411746766612;5614.214010038598;5664.2636457261115;5610.607257492018;5614.887702245932;5640.407757185519;5662.462066103713;5666.150077488327;4314.7626880521875;4340.891477713019;4341.45731783527;4342.088161486124;4346.760928148982;3899.1032062625754;3923.0388554804254;3945.2898478274187;3963.8612648557164;3985.70107241958;5433.483819037185;5443.101888188405;5446.046941785172;5446.455354464521;5491.093969495068;5576.414476479992;5681.119426488901;5765.990951583456;5769.624974376736;5770.567207459458;5359.196120581944;5383.919241211385;5411.242426060355;5431.37539182999;5435.565154787608;4885.633577481632;4896.4858689837765;4897.975510122498;4908.141075311806;4933.703977761345;5808.332041815076;5906.822795316148;5935.881282374328;5936.762529498772;5941.910871336933;5751.1373294006235;5814.73833677494;5819.418058194146;5829.504492118217;5868.559858010752;6000.969995149996;6017.669028203491;6020.4280593343565;6021.096835474714;6033.698315084141;5477.808276710296;5619.297587801525;5622.297212848394;5678.261825962599;5679.403662615531;5777.017906955912;5864.736086876015;5866.472017518444;5911.172435858897;5912.024515954991;5681.602287839812;5703.344115426779;5705.144228365778;5709.22925405065;5715.51418129447;5471.343438787371;5475.753591088331;5692.8576785579035;5695.231143795535;5704.0588302929555;5418.83743487696;5505;5507.972460137674;5521.613487055867;5559.27729395176;5582.358028826575;5592.4966752990795;5623.971880140573;5636;5640.125780504029;5360.0619891518045;5364.463553644604;5461.1808228766;5475.780968761205;5477.123660214346 17:38:54 INFO - PROCESS | 8247 | |1;ext.html;562.9163134310282;584.5644994479113;600.9639421634703;602.6203491800165;609.6342194683193;35426.46860297094;36593.81703091488;36621.450678239846;43733.34399983995;45267.54732452674;45883.77058114713;46470.30294545584;46503.30245046327;46508;46509.534904650944;8866.335024873144;9065.184133428023;9066.138716821892;9069.909300906973;9072.092790720908;8893.822123557526;8972.41679290844;8977.147171018743;8980.41627294227;8989.280857531414;9023.639054437816;9075.63697452101;9077.273818094569;9079.727608171765;9085.273178145766;9006.099390061006;9039.81920361589;9048.547572621343;9054.411463254868;9058.501782401965;8884.555772211364;8889.688860889837;8939.687110951085;8989.41568798026;8990.595423205972;43595.78202109001;43642.78178609118;43736;44025.459108931354;44150;3475.965240347615;3612.6026137124895;4135.834566617332;4198.076423186894;4285.61429471349;32977.34045319104;33564.328713425595;33890.32219355624;33893.15267118317;34718.30563388743;4248.830046798124;4399.824007039714;4490.461144662629;4514.345419914127;4545.5908968193025;350246;352695;353746;354845;355616.5534206316;58160.70919645375;58419;58432;58454;58489.41510584925;57780.422195778345;57859;57892.71053644705;57902.7104864473;57921.710391448614;15055.322510487054;15312.923435382752;15313.46402875894;15335.386584536494;15336.923315383352;11553.24903881245;11583.478743456564;11599.072074234042;11604.593839215588;11605.76788464226;15509.922450387676;17503;17504.12479376026;17512.737308940377;17545.210465529082;6257.4681152102585;6329.651869147241;6336.6831658416895;6351.174347334817;6367.071147272214;704.4186684905221;1019.9133073688671;1048.7378155461136;1156.8727439981594;1180.38030034231;33462.498062529085;33919.15202119967;34015.489767653504;34030.65969340324;34509.827450862584;1082.1775450657558;1087.217203613397;1124.0557931337717;1197.5748609243767;1209.8306237126633;17316.39392621252;17601.647967040586;17637.7354339685;17657;17661;530554;533521;534014;534142;534637;60115.398846011856;60354.396456034876;60445;60511.39488605058;60517;1209.1052621060528;1311.7048664050512;1316.6905777142365;1333.419962316376;1363.3660347938057;32113.197170070936;34459;34865.825670872495;34990.65009349874;35246.64753352536;53623.73188134035;54489.18266225931;54565.45434545604;54581.727091364286;54620.180697290365;490543;492152;496543;497413;497753;44698.3295250578;45842.02026868243;46447.53552464432;48080;49224;49632.50367496279;49891.750541247064;50572.747136264086;50681.23978140257;50980.490195097576;41770.58229417667;42190;42446.1510769789;42898.78550607227;44183;42197.789011054745;42271.7886410566;42784.57215427806;43884;44094.77952610217;41900;42110.57889421189;43151.568484314754;43349.56650433455;43358.78320608377;36084.639153609176;38052.238955220186;38442;38722.806385969016;39225.6077439222;29293.26766830846;29317.41365172642;29490.852545737132;29505.852470737507;29788 17:38:54 INFO - PROCESS | 8247 | |2;jquery.html;370.36297568182715;387.16565800699505;390.9980450097749;393.96454319111285;420.6970980893755;16965.321387144515;19401.708974365378;19453.31913383032;19642.31251906182;20610.793892061076;19392.806071939278;19580.70628940567;19730.605387892232;19869.503262418446;19912.203511859545;5457.645253058558;5772.826815195541;5860.150278209657;5927.555433342495;5989.730462129215;5810.273715785527;5890.087036509348;5895.852603684921;5899.528037756991;5906.852328691774;5614.129809879455;5850.619709718876;5865.560082993771;5875.588708790387;5878.559108066891;5693.886122277531;5874.618149820248;5910.970445147746;5916.467517923386;5921.496672782819;5238.79044838206;5259.921101183485;5278.498542638443;5285.497877701612;5285.656432331886;23797.762022379902;24342;24346.391340216458;24362.756372436404;24457.510849783084;2364.6216605343234;2582.315686343102;3077.338372249977;3135.608048993876;3196.7602429817625;10462.372257664565;10969.396683182422;10979.17656175782;10984.945075274652;11042.171837112168;1929.9903500482408;1953.345629214215;1987.920483180671;1994.7606287245624;1995.9600807983904;80896.59551702262;83185;85400.14599854047;85985;86143.56928215444;10365.948170259251;10459.215558832966;11173.553057877594;11381.487833047533;11539.942300288445;13972.231527266098;13978.182836231224;13987.510437134652;13990.650233744238;13997.020208585302;7437.739679111205;7646.770596882103;7756.340711039512;7829;8159.388045896581;7393.852122957618;7416.814579635552;7443.925560744323;7610.505317154367;7632.274933881273;4393.0994146199955;4549.567791059844;4758.666893317504;4806.399200099988;5009.0482808266315;1952.4825921130912;1970.6157299326494;2000.7499062617173;2032.7255820464343;2035.735354403918;880.1990188928173;986.1026465915982;1029.5418538750334;1029.6344797596896;1090.1660229924114;19400.905435089902;19653.41039768809;19836.70244946298;19913.203471860965;19953;954.4941181173989;974.7563109222694;1035.3477309295097;1046.3826342457987;1064.8296272596501;10394.272400931863;11040.723981900517;11145;11155.776884462266;11169.497372618252;453698;459982;465456;466180;473522;72813;88254;88581.24221925554;91016.544917275;91168.54415728012;954.7183580843667;975.5171190260725;988.4514094677523;991.9107280344804;1004.7739258666742;16641.334346626485;17155;17361;17477.650446991243;17736.645267094846;39880.401793973695;40271;40322.79838600788;41108;41357.79321103375;53075.73462132664;54231;56520;57127.71436142793;57617;8470.534120623424;8586.184312490303;8709.518280620272;8715.651373945226;8917.197452229071;10320.12278956297;12948.741025179632;13210.801837972245;13274.800877986645;13534.59396218115;10668.09321207675;10844;10932.726681833017;11305.547778088785;11602.76794464123;11242.718932026437;11398;11687.76624467523;11874.287542747463;12035.157538972539;11847;12240.449179787109;12315.568955086528;12347.259164450163;12595.24428534291;8743.91256087431;8928.776780580278;8984.191422771983;9013.18881300686;9353.11145441182;10369.481525923522;12073.69815754578;12076.154669173073;12093.818592721293;12096.576619818265 17:38:54 INFO - PROCESS | 8247 | |3;mootools.html;1337.545234620229;1430.5779794960486;1498.2808252039022;1561.4222737587095;1736.8436840684344;8308.875366869494;8644.956775216124;8655.221030107297;8765;8808.603612837422;8652.610632521535;8739.169778871013;8748;8758.08040155784;8758.562071896411;2397.3407312988893;2420.6490058941445;2420.9273721788286;2423.7939775119135;2428.86641234732;2309.0648287443614;2374.240243122193;2389.438481956739;2391.5336509380677;2391.820613453989;2301.9539609207804;2351.929442116739;2360.834741568091;2362.681038059857;2367.2779802160335;2292.071710957065;2341.262502311766;2347.0963678983544;2349.4713689419914;2360.468894498741;2250.4036430345973;2265.4223173090754;2267.682524446579;2268.5462907418582;2272.170657709924;8764.386492945496;8780.736577902673;8792.824143517159;8797.208251257418;8814.25078868297;5144.408393034774;5378.381486129067;5396.811111611075;5406.83779486616;5417.160340147244;3384.9492257616157;3435.278591495789;3456.8962931111855;3478.00876750125;3484.94772578409;1133.195431243818;1135.8828477707873;1142.714321419645;1161.3322339654733;1170.6663600873794;12292.139550231488;12344.567940122142;12356.814647780291;12368.567100151542;12390.876091239063;4327.221100201994;4609.423822022247;4693.671442999025;4808.591269742111;4817.349657796222;9631.518424078768;9651.131398174199;9670.419774813534;9680.031996800264;9684.46735429558;5242.423333433319;5263.26314315996;5263.736813159327;5272.077386457431;5275.841724748264;4278;4782.689125206851;4870.6103511718975;4936.2102063669645;4955.529224723646;3746.325661380923;3765.661090501868;3867.245887052054;3879.069023434412;3902.043999220209;1141.7088642396302;1152.9077673786244;1153.1754795321385;1154.8556430446195;1186.5609724401854;839.2698352433422;967.3325405470204;970.1705042188827;991.2530634202725;1003.5233264199593;5976.103584462366;6070.3019152798;6119.663418512025;6291.716872740738;6329.651869147241;474.78871902003965;475.94526629437365;476.6067993905042;481.7398604753464;486.6496122791584;4137.77242251673;4143.4199212110325;4224.260754367973;4240.5123410808155;4285.057287396768;10908;11178.496967636313;11237.157213209042;11242;11261.549538018551;10496.580136794595;11004.504797284142;11160.386178760245;11172.273802202832;11175.273607215506;8072.071711753106;8266.256036956582;8285.378596605278;8287.62705678246;8296.211859873303;5803.187553742564;5862.853428664147;5983.581149319506;6119.541034422525;6291.276503202007;9661.323707340418;9670.178034866834;9691.370060946016;9767.609295628095;9799.020097990144;10259.230557708053;10446.582136714447;10467.790644187226;10556.102731267929;10557.419341936267;6871.622060786704;7343.302386273509;7570.5836179010685;7677.385809135368;7832.530048197126;8454.66181352739;8602.655893764178;8621.396502244783;8621.784455388666;8624.353173511887;7233.891491627735;7349.77950661481;7466.104067511933;7511.211322811027;7654.693812247448;6851.794446166623;6961.095057642474;6997;7239.312265334785;7258.673359698932;7108.609026503592;7110.1112360954885;7175.641217938978;7179.138503379628;7195.280471952972;5277.340332458442;5371.221172929825;5428.050091234098;5428.212909128233;5428.918566221589;5340.706261155674;5355.678659280456;5413.918791218213;5464.28964234647;5544.972275138599 17:38:54 INFO - PROCESS | 8247 | |4;prototype.html;331.32740536710486;332.90308433710925;342.2248606905359;342.4862705941088;344.5004743122473;5165.431802501726;5187.6628019178725;5192.428832828391;5199.766010529521;5215.478452154783;5152.819651312205;5159.329287192669;5172.146595811696;5174.223866420039;5179.507946745062;3850.17221297421;4038.798060096998;4126.669866410687;4127.195196936598;4132.793360331986;4048.0284731664337;4048.4736984192014;4058.289799285113;4079.8368065277355;4079.8980025499304;3981.800909954505;3999.9800000999953;4008.098177909976;4011.679065674739;4033.878983630496;3793.108619474421;3892.3966785148345;3998.7000974926996;4008.478897743304;4028.0463974972263;3551.449525323553;3561.82190890457;3563.2160924596546;3568.80371579563;3579.19468119671;5053.242013697938;5059.772310246048;5065.872333619888;5073.289739436482;5081.644284900059;4349.434573505456;4373.147236288925;4562.22442184826;4566.748828814414;4602.585767280961;5347.41178470368;5355.357357117171;5355.410904800468;5361.56048997709;5363.839084827461;3900.7074469414906;3903.3754599264266;3911.335073037562;3912.0806610446807;3917.0794863207125;5389.622726409114;5556.388797232301;5579.330480342344;5587.7485513152005;5614.343768588317;3991.9201615967518;4001.09975255571;4004.0990777074926;4007.5591684914634;4007.899802504961;4038.434619153321;4045.7862641208108;4046.433499310099;4052.371882358239;4053.351463765783;4362.650987920959;4587.72473651582;4615;4618.815247390134;4621.214393553104;5413.296271484682;5422.502485896574;5424.945750542523;5429.728513574306;5433.157860531624;1380.565121986571;1390.3117956611543;1394.3028485757122;1394.316784775473;1396.0855639556107;850.7490290364358;892.4422236102436;905.9909400905907;916.6287653500343;919.5218486387041;4619.353290539327;4631.282151266559;4644.605208557243;4663.463701674283;4665.580097791215;4861.222204447342;4875.853724388274;4911.877203069952;4949.628777841676;4949.752512374367;4446.9555304447185;4644.3744689358455;4676.836310729108;4693.929591056137;4722.645801564828;2610.256077018079;2611.360216746871;2621.266045507261;2636.9208923732317;2636.986815065951;5061.164907790247;5070.619703522177;5082.974585127125;5191.766370513336;5204.71374074422;4863;5021.991203518622;5029.748512574357;5033;5046.318746969112;5031.7987280509105;5043.5965122790085;5051.292819005343;5077.527517020023;5082.542571168538;4823.2282834747675;4828.782704778223;4852.1508735971765;4930.457649658606;4988.4263309719845;4556.908861822812;4796.35249241348;4805.111054454797;4813.95186048149;4861.319415281792;4995.725235112103;5017.745563609098;5029.170186919117;5034.622403319839;5048.829003528518;3662.908427289339;3682.1899182179877;3701.27825074108;3717.219383929405;3728.9067773305883;4888.682235654671;4925.655204135676;4970.577500912463;4996.725180115129;5150.716710580954;5401;5419.160030195326;5470.753816078206;5485.314335708036;5486.067368547437;5437.728113594226;5476.151196564539;5477.808276710296;5485.6982865942755;5487.917681234864;5208.5312321891215;5412.783488660567;5428.240046393429;5457;5487.6158668894395;5234.97382513085;5328.706921119376;5432.831941132676;5465.076184241412;5505.366882808368;5342.332208473941;5348.358197016383;5353.223782551586;5367.838964831061;5370.624056316176 17:38:54 INFO - PROCESS | 8247 | |5;yui.html;747.30873941604;764.7552783109404;796.3350602247124;844.3920377328321;847.9915200847989;15667.52997410078;16251.918740406281;16266.51200463988;16269.83730162698;16294.42969496068;15193.848061519382;15354.232288385592;15414.922925385385;15424.228788560555;15445.922770386132;655.5476721062452;779.1896427715184;782.6478084861807;802.0335495727634;816.2735165702529;803.7548547692951;805.6334367862609;809.9352051835839;817.726061769308;817.8691409374501;856.8800367948493;862.0086900064913;865.1953683074738;865.2299453486371;865.6796985115516;691.1360799001224;837.9664813407456;857.7169534053747;863.1541089732035;864.9610767515445;622.2719418280623;622.9563930524865;623.2178615837141;623.3361470034399;623.8877002139614;14666.12003279796;14672.70654586913;14695.412183512646;14705.558833234913;14718.411263549446;14273.928630356886;14724.33740481681;14746.11523308605;14766.335514901855;15114.848851511455;13658.112222705493;13669.179849209078;13719.314034298246;13908.235047072407;14541.200233987127;4466.70966387187;4671.813127474897;4689.695169813951;4791.137595232856;4792.257200133985;80862;81014.18985810125;81532.59233703853;82454.58772706157;82458;11588.88411115878;11983.787928579226;12067.637970860887;12105.878941210474;12418;22736.20423285177;22841.543169136858;22900.541989160123;22949.655755163687;23006.309810705705;8377.41358104939;8552.61513231906;8555.743327700055;8647.783805404915;8765.605547750367;4587.816487340469;4656.0920620479355;4786.688865223749;4854.466008739036;5150.0472412603785;3450.0857272822723;3568.7680300780366;3573.5533058367705;3576.5886923004186;3591;585.9062549992066;590.447931184344;599.6971529377723;600.3726106219011;610.9877802443926;566.583561082604;655.7672026430644;682.6547243372861;725.5247812682701;751.3650964934731;9461.195798357217;9774.5601447935;10001.49992500372;10073.748156296151;10462.372257664565;672.1329484964439;675.1594265139834;716.6595866963255;732.901058357115;748.4237137404168;4489.685721999494;4522.88692782683;4612.3542704021465;4640.071985602893;4726.929096063562;86187;129671;130562;133968.33015835052;139576.9063464049;111978;112487.4375628133;113272.43363783293;114413.4279328598;116273;61204;63663.6816815913;89203.55398223097;90249.54875225713;93919.53040234755;8914.955425222832;8968.327375446737;8981.955090224506;9027.774305642411;9045.231155351868;57352.71323643355;58217.70891145517;58406.70796645989;58607;62472.375276246654;79519.60240198762;83048;85894.57052714696;86960.56519717361;87407;11495.712607184887;12138.514459421523;12326.137170398344;12343.382830858602;12474.06444516683;13250.933745331211;13279.468821247043;13606.251656159006;13665.180089194282;14269.215193164475;12335.259884406605;12835.101542892282;12848.614541563767;12856.614301570968;13193.274369909746;11829.585964491202;11952.58165964187;12309.93845030769;12376.876231237573;12497;12089.879101208875;12498;12508.249505029728;12908.741825163257;12936;10171;10536.15710743154;10544.26190166681;10555.472226388803;11034;9591.568379423083;9695;10406.461802987022;10408.509753646695;10742.3017503862 17:38:54 INFO - PROCESS | 8247 | __end_tp_report 17:38:54 INFO - PROCESS | 8247 | __start_cc_report 17:38:54 INFO - PROCESS | 8247 | _x_x_mozilla_cycle_collect,1017 17:38:54 INFO - PROCESS | 8247 | __end_cc_report 17:38:54 INFO - PROCESS | 8247 | __startTimestamp1470703134454__endTimestamp 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | ------- Summary: start ------- 17:38:54 INFO - PROCESS | 8247 | Number of tests: 6 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | [#0] dojo.html Cycles:165 Average:5312.82 Median:5477.81 stddev:613.50 (11.2%) stddev-sans-first:588.42 17:38:54 INFO - PROCESS | 8247 | Values: 3019.8 3070.9 3093.1 3104.6 3129.5 5287.6 5350.3 5352.5 5425.4 5468.1 5335.2 5347.9 5362.8 5393.4 5405.0 4756.4 4812.5 4835.8 4842.4 4955.3 4902.1 4902.4 4903.7 4907.2 4908.5 4733.1 4783.7 4844.3 4855.7 4879.6 4772.5 4776.5 4779.3 4836.0 4885.0 4768.9 4799.1 4800.5 4842.6 4877.2 5198.9 5259.1 5270.5 5317.9 5383.8 5671.1 5671.8 5683.3 5736.8 5742.0 5761.9 5774.1 5784.7 5786.0 5787.7 5189.5 5247.4 5316.5 5323.7 5370.8 5846.0 5850.7 5888.1 5891.1 5891.5 5606.9 5617.2 5660.3 5671.7 5678.1 5515.3 5559.3 5622.1 5749.2 5749.5 5591.1 5601.7 5602.4 5614.2 5664.3 5610.6 5614.9 5640.4 5662.5 5666.2 4314.8 4340.9 4341.5 4342.1 4346.8 3899.1 3923.0 3945.3 3963.9 3985.7 5433.5 5443.1 5446.0 5446.5 5491.1 5576.4 5681.1 5766.0 5769.6 5770.6 5359.2 5383.9 5411.2 5431.4 5435.6 4885.6 4896.5 4898.0 4908.1 4933.7 5808.3 5906.8 5935.9 5936.8 5941.9 5751.1 5814.7 5819.4 5829.5 5868.6 6001.0 6017.7 6020.4 6021.1 6033.7 5477.8 5619.3 5622.3 5678.3 5679.4 5777.0 5864.7 5866.5 5911.2 5912.0 5681.6 5703.3 5705.1 5709.2 5715.5 5471.3 5475.8 5692.9 5695.2 5704.1 5418.8 5505.0 5508.0 5521.6 5559.3 5582.4 5592.5 5624.0 5636.0 5640.1 5360.1 5364.5 5461.2 5475.8 5477.1 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | [#1] ext.html Cycles:180 Average:62868.03 Median:24212.64 stddev:123784.23 (511.2%) stddev-sans-first:124043.09 17:38:54 INFO - PROCESS | 8247 | Values: 562.9 584.6 601.0 602.6 609.6 35426.5 36593.8 36621.5 43733.3 45267.5 45883.8 46470.3 46503.3 46508.0 46509.5 8866.3 9065.2 9066.1 9069.9 9072.1 8893.8 8972.4 8977.1 8980.4 8989.3 9023.6 9075.6 9077.3 9079.7 9085.3 9006.1 9039.8 9048.5 9054.4 9058.5 8884.6 8889.7 8939.7 8989.4 8990.6 43595.8 43642.8 43736.0 44025.5 44150.0 3476.0 3612.6 4135.8 4198.1 4285.6 32977.3 33564.3 33890.3 33893.2 34718.3 4248.8 4399.8 4490.5 4514.3 4545.6 350246.0 352695.0 353746.0 354845.0 355616.6 58160.7 58419.0 58432.0 58454.0 58489.4 57780.4 57859.0 57892.7 57902.7 57921.7 15055.3 15312.9 15313.5 15335.4 15336.9 11553.2 11583.5 11599.1 11604.6 11605.8 15509.9 17503.0 17504.1 17512.7 17545.2 6257.5 6329.7 6336.7 6351.2 6367.1 704.4 1019.9 1048.7 1156.9 1180.4 33462.5 33919.2 34015.5 34030.7 34509.8 1082.2 1087.2 1124.1 1197.6 1209.8 17316.4 17601.6 17637.7 17657.0 17661.0 530554.0 533521.0 534014.0 534142.0 534637.0 60115.4 60354.4 60445.0 60511.4 60517.0 1209.1 1311.7 1316.7 1333.4 1363.4 32113.2 34459.0 34865.8 34990.7 35246.6 53623.7 54489.2 54565.5 54581.7 54620.2 490543.0 492152.0 496543.0 497413.0 497753.0 44698.3 45842.0 46447.5 48080.0 49224.0 49632.5 49891.8 50572.7 50681.2 50980.5 41770.6 42190.0 42446.2 42898.8 44183.0 42197.8 42271.8 42784.6 43884.0 44094.8 41900.0 42110.6 43151.6 43349.6 43358.8 36084.6 38052.2 38442.0 38722.8 39225.6 29293.3 29317.4 29490.9 29505.9 29788.0 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | [#2] jquery.html Cycles:180 Average:28158.44 Median:3166.18 stddev:76541.03 (2417.5%) stddev-sans-first:76727.31 17:38:54 INFO - PROCESS | 8247 | Values: 370.4 387.2 391.0 394.0 420.7 16965.3 19401.7 19453.3 19642.3 20610.8 19392.8 19580.7 19730.6 19869.5 19912.2 5457.6 5772.8 5860.2 5927.6 5989.7 5810.3 5890.1 5895.9 5899.5 5906.9 5614.1 5850.6 5865.6 5875.6 5878.6 5693.9 5874.6 5911.0 5916.5 5921.5 5238.8 5259.9 5278.5 5285.5 5285.7 23797.8 24342.0 24346.4 24362.8 24457.5 2364.6 2582.3 3077.3 3135.6 3196.8 10462.4 10969.4 10979.2 10984.9 11042.2 1930.0 1953.3 1987.9 1994.8 1996.0 80896.6 83185.0 85400.1 85985.0 86143.6 10365.9 10459.2 11173.6 11381.5 11539.9 13972.2 13978.2 13987.5 13990.7 13997.0 7437.7 7646.8 7756.3 7829.0 8159.4 7393.9 7416.8 7443.9 7610.5 7632.3 4393.1 4549.6 4758.7 4806.4 5009.0 1952.5 1970.6 2000.7 2032.7 2035.7 880.2 986.1 1029.5 1029.6 1090.2 19400.9 19653.4 19836.7 19913.2 19953.0 954.5 974.8 1035.3 1046.4 1064.8 10394.3 11040.7 11145.0 11155.8 11169.5 453698.0 459982.0 465456.0 466180.0 473522.0 72813.0 88254.0 88581.2 91016.5 91168.5 954.7 975.5 988.5 991.9 1004.8 16641.3 17155.0 17361.0 17477.7 17736.6 39880.4 40271.0 40322.8 41108.0 41357.8 53075.7 54231.0 56520.0 57127.7 57617.0 8470.5 8586.2 8709.5 8715.7 8917.2 10320.1 12948.7 13210.8 13274.8 13534.6 10668.1 10844.0 10932.7 11305.5 11602.8 11242.7 11398.0 11687.8 11874.3 12035.2 11847.0 12240.4 12315.6 12347.3 12595.2 8743.9 8928.8 8984.2 9013.2 9353.1 10369.5 12073.7 12076.2 12093.8 12096.6 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | [#3] mootools.html Cycles:180 Average:5776.32 Median:5049.97 stddev:3290.54 (65.2%) stddev-sans-first:3282.86 17:38:54 INFO - PROCESS | 8247 | Values: 1337.5 1430.6 1498.3 1561.4 1736.8 8308.9 8645.0 8655.2 8765.0 8808.6 8652.6 8739.2 8748.0 8758.1 8758.6 2397.3 2420.6 2420.9 2423.8 2428.9 2309.1 2374.2 2389.4 2391.5 2391.8 2302.0 2351.9 2360.8 2362.7 2367.3 2292.1 2341.3 2347.1 2349.5 2360.5 2250.4 2265.4 2267.7 2268.5 2272.2 8764.4 8780.7 8792.8 8797.2 8814.3 5144.4 5378.4 5396.8 5406.8 5417.2 3384.9 3435.3 3456.9 3478.0 3484.9 1133.2 1135.9 1142.7 1161.3 1170.7 12292.1 12344.6 12356.8 12368.6 12390.9 4327.2 4609.4 4693.7 4808.6 4817.3 9631.5 9651.1 9670.4 9680.0 9684.5 5242.4 5263.3 5263.7 5272.1 5275.8 4278.0 4782.7 4870.6 4936.2 4955.5 3746.3 3765.7 3867.2 3879.1 3902.0 1141.7 1152.9 1153.2 1154.9 1186.6 839.3 967.3 970.2 991.3 1003.5 5976.1 6070.3 6119.7 6291.7 6329.7 474.8 475.9 476.6 481.7 486.6 4137.8 4143.4 4224.3 4240.5 4285.1 10908.0 11178.5 11237.2 11242.0 11261.5 10496.6 11004.5 11160.4 11172.3 11175.3 8072.1 8266.3 8285.4 8287.6 8296.2 5803.2 5862.9 5983.6 6119.5 6291.3 9661.3 9670.2 9691.4 9767.6 9799.0 10259.2 10446.6 10467.8 10556.1 10557.4 6871.6 7343.3 7570.6 7677.4 7832.5 8454.7 8602.7 8621.4 8621.8 8624.4 7233.9 7349.8 7466.1 7511.2 7654.7 6851.8 6961.1 6997.0 7239.3 7258.7 7108.6 7110.1 7175.6 7179.1 7195.3 5277.3 5371.2 5428.1 5428.2 5428.9 5340.7 5355.7 5413.9 5464.3 5545.0 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | [#4] prototype.html Cycles:180 Average:4373.72 Median:4882.27 stddev:1254.01 (25.7%) stddev-sans-first:1220.27 17:38:54 INFO - PROCESS | 8247 | Values: 331.3 332.9 342.2 342.5 344.5 5165.4 5187.7 5192.4 5199.8 5215.5 5152.8 5159.3 5172.1 5174.2 5179.5 3850.2 4038.8 4126.7 4127.2 4132.8 4048.0 4048.5 4058.3 4079.8 4079.9 3981.8 4000.0 4008.1 4011.7 4033.9 3793.1 3892.4 3998.7 4008.5 4028.0 3551.4 3561.8 3563.2 3568.8 3579.2 5053.2 5059.8 5065.9 5073.3 5081.6 4349.4 4373.1 4562.2 4566.7 4602.6 5347.4 5355.4 5355.4 5361.6 5363.8 3900.7 3903.4 3911.3 3912.1 3917.1 5389.6 5556.4 5579.3 5587.7 5614.3 3991.9 4001.1 4004.1 4007.6 4007.9 4038.4 4045.8 4046.4 4052.4 4053.4 4362.7 4587.7 4615.0 4618.8 4621.2 5413.3 5422.5 5424.9 5429.7 5433.2 1380.6 1390.3 1394.3 1394.3 1396.1 850.7 892.4 906.0 916.6 919.5 4619.4 4631.3 4644.6 4663.5 4665.6 4861.2 4875.9 4911.9 4949.6 4949.8 4447.0 4644.4 4676.8 4693.9 4722.6 2610.3 2611.4 2621.3 2636.9 2637.0 5061.2 5070.6 5083.0 5191.8 5204.7 4863.0 5022.0 5029.7 5033.0 5046.3 5031.8 5043.6 5051.3 5077.5 5082.5 4823.2 4828.8 4852.2 4930.5 4988.4 4556.9 4796.4 4805.1 4814.0 4861.3 4995.7 5017.7 5029.2 5034.6 5048.8 3662.9 3682.2 3701.3 3717.2 3728.9 4888.7 4925.7 4970.6 4996.7 5150.7 5401.0 5419.2 5470.8 5485.3 5486.1 5437.7 5476.2 5477.8 5485.7 5487.9 5208.5 5412.8 5428.2 5457.0 5487.6 5235.0 5328.7 5432.8 5465.1 5505.4 5342.3 5348.4 5353.2 5367.8 5370.6 17:38:54 INFO - PROCESS | 8247 | 17:38:54 INFO - PROCESS | 8247 | [#5] yui.html Cycles:180 Average:21895.94 Median:4648.08 stddev:32759.40 (704.8%) stddev-sans-first:32812.81 17:38:54 INFO - PROCESS | 8247 | Values: 747.3 764.8 796.3 844.4 848.0 15667.5 16251.9 16266.5 16269.8 16294.4 15193.8 15354.2 15414.9 15424.2 15445.9 655.5 779.2 782.6 802.0 816.3 803.8 805.6 809.9 817.7 817.9 856.9 862.0 865.2 865.2 865.7 691.1 838.0 857.7 863.2 865.0 622.3 623.0 623.2 623.3 623.9 14666.1 14672.7 14695.4 14705.6 14718.4 14273.9 14724.3 14746.1 14766.3 15114.8 13658.1 13669.2 13719.3 13908.2 14541.2 4466.7 4671.8 4689.7 4791.1 4792.3 80862.0 81014.2 81532.6 82454.6 82458.0 11588.9 11983.8 12067.6 12105.9 12418.0 22736.2 22841.5 22900.5 22949.7 23006.3 8377.4 8552.6 8555.7 8647.8 8765.6 4587.8 4656.1 4786.7 4854.5 5150.0 3450.1 3568.8 3573.6 3576.6 3591.0 585.9 590.4 599.7 600.4 611.0 566.6 655.8 682.7 725.5 751.4 9461.2 9774.6 10001.5 10073.7 10462.4 672.1 675.2 716.7 732.9 748.4 4489.7 4522.9 4612.4 4640.1 4726.9 86187.0 129671.0 130562.0 133968.3 139576.9 111978.0 112487.4 113272.4 114413.4 116273.0 61204.0 63663.7 89203.6 90249.5 93919.5 8915.0 8968.3 8982.0 9027.8 9045.2 57352.7 58217.7 58406.7 58607.0 62472.4 79519.6 83048.0 85894.6 86960.6 87407.0 11495.7 12138.5 12326.1 12343.4 12474.1 13250.9 13279.5 13606.3 13665.2 14269.2 12335.3 12835.1 12848.6 12856.6 13193.3 11829.6 11952.6 12309.9 12376.9 12497.0 12089.9 12498.0 12508.2 12908.7 12936.0 10171.0 10536.2 10544.3 10555.5 11034.0 9591.6 9695.0 10406.5 10408.5 10742.3 17:38:54 INFO - PROCESS | 8247 | -------- Summary: end -------- 17:38:54 INFO - PROCESS | 8247 | 17:38:55 INFO - TEST-INFO | 8247: exit 0 17:38:55 INFO - TEST-OK | dromaeo_css | took 1115669ms 17:38:55 INFO - TEST-START | kraken 17:38:55 INFO - operating with platform_type : linux_ 17:38:55 INFO - Initialising browser for kraken test... 17:38:55 INFO - TEST-INFO | started process 8443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiQjz4F/profile http://localhost:60041/getInfo.html) 17:38:59 INFO - PROCESS | 8443 | __metrics Screen width/height:1600/1200 17:38:59 INFO - PROCESS | 8443 | colorDepth:24 17:38:59 INFO - PROCESS | 8443 | Browser inner width/height: 1024/697 17:38:59 INFO - PROCESS | 8443 | __metrics 17:39:00 INFO - PROCESS | 8443 | 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" 17:39:00 INFO - PROCESS | 8443 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:39:00 INFO - PROCESS | 8443 | console.error: PushService: 17:39:00 INFO - PROCESS | 8443 | stateChangeProcessEnqueue: Error transitioning state 17:39:00 INFO - PROCESS | 8443 | UnknownError 17:39:01 INFO - TEST-INFO | 8443: exit 0 17:39:01 INFO - Browser initialized. 17:39:01 INFO - Running cycle 1/1 for kraken test... 17:39:01 INFO - TEST-INFO | started process 8525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiQjz4F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:13 INFO - PROCESS | 8525 | RSS: Main: 155648000 17:39:13 INFO - PROCESS | 8525 | 17:39:15 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60041/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:16 INFO - PROCESS | 8525 | RSS: Main: 211034112 17:39:16 INFO - PROCESS | 8525 | 17:39:18 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60041/tests/kraken/driver.html?testName=audio-dft) 17:39:19 INFO - PROCESS | 8525 | RSS: Main: 190959616 17:39:19 INFO - PROCESS | 8525 | 17:39:22 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60041/tests/kraken/driver.html?testName=audio-fft) 17:39:23 INFO - PROCESS | 8525 | RSS: Main: 268967936 17:39:23 INFO - PROCESS | 8525 | 17:39:25 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60041/tests/kraken/driver.html?testName=audio-oscillator) 17:39:26 INFO - PROCESS | 8525 | RSS: Main: 178216960 17:39:26 INFO - PROCESS | 8525 | 17:39:28 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60041/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:39:28 INFO - PROCESS | 8525 | RSS: Main: 183672832 17:39:28 INFO - PROCESS | 8525 | 17:39:31 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60041/tests/kraken/driver.html?testName=imaging-darkroom) 17:39:32 INFO - PROCESS | 8525 | RSS: Main: 217903104 17:39:32 INFO - PROCESS | 8525 | 17:39:35 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60041/tests/kraken/driver.html?testName=imaging-desaturate) 17:39:36 INFO - PROCESS | 8525 | RSS: Main: 218193920 17:39:36 INFO - PROCESS | 8525 | 17:39:39 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60041/tests/kraken/driver.html?testName=json-parse-financial) 17:39:39 INFO - PROCESS | 8525 | RSS: Main: 218411008 17:39:39 INFO - PROCESS | 8525 | 17:39:41 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60041/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:39:41 INFO - PROCESS | 8525 | RSS: Main: 182779904 17:39:41 INFO - PROCESS | 8525 | 17:39:43 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:39:44 INFO - PROCESS | 8525 | RSS: Main: 187375616 17:39:44 INFO - PROCESS | 8525 | 17:39:46 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:39:46 INFO - PROCESS | 8525 | RSS: Main: 192049152 17:39:46 INFO - PROCESS | 8525 | 17:39:49 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:39:50 INFO - PROCESS | 8525 | RSS: Main: 185880576 17:39:50 INFO - PROCESS | 8525 | 17:39:52 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:39:53 INFO - PROCESS | 8525 | RSS: Main: 190808064 17:39:53 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | Cycle 1(1): loaded http://localhost:60041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60041/tests/kraken/driver.html?testName=ai-astar) 17:39:55 INFO - PROCESS | 8525 | RSS: Main: 242278400 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | __start_tp_report 17:39:55 INFO - PROCESS | 8525 | _x_x_mozilla_page_load 17:39:55 INFO - PROCESS | 8525 | _x_x_mozilla_page_load_details 17:39:55 INFO - PROCESS | 8525 | |i|pagename|runs| 17:39:55 INFO - PROCESS | 8525 | |0;ai-astar;104;111;113;110;112;111;112;113;109;112 17:39:55 INFO - PROCESS | 8525 | |1;audio-beat-detection;144;117;117;178;117;118;147;117;159;117 17:39:55 INFO - PROCESS | 8525 | |2;audio-dft;159;159;160;159;160;159;160;162;159;160 17:39:55 INFO - PROCESS | 8525 | |3;audio-fft;74;75;74;118;75;75;73;74;99;74 17:39:55 INFO - PROCESS | 8525 | |4;audio-oscillator;83;83;121;84;84;84;122;83;84;131 17:39:55 INFO - PROCESS | 8525 | |5;imaging-gaussian-blur;117;117;116;116;116;116;117;117;116;116 17:39:55 INFO - PROCESS | 8525 | |6;imaging-darkroom;146;147;147;147;147;146;146;145;146;146 17:39:55 INFO - PROCESS | 8525 | |7;imaging-desaturate;95;95;95;95;96;96;95;94;95;95 17:39:55 INFO - PROCESS | 8525 | |8;json-parse-financial;51;51;49;49;51;51;49;50;49;51 17:39:55 INFO - PROCESS | 8525 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;63;62 17:39:55 INFO - PROCESS | 8525 | |10;stanford-crypto-aes;76;77;77;76;76;79;76;76;78;75 17:39:55 INFO - PROCESS | 8525 | |11;stanford-crypto-ccm;135;125;127;130;135;118;118;124;156;121 17:39:55 INFO - PROCESS | 8525 | |12;stanford-crypto-pbkdf2;158;166;162;159;159;160;165;162;161;163 17:39:55 INFO - PROCESS | 8525 | |13;stanford-crypto-sha256-iterative;64;63;64;63;64;62;62;66;61;62 17:39:55 INFO - PROCESS | 8525 | __end_tp_report 17:39:55 INFO - PROCESS | 8525 | __start_cc_report 17:39:55 INFO - PROCESS | 8525 | _x_x_mozilla_cycle_collect,1673 17:39:55 INFO - PROCESS | 8525 | __end_cc_report 17:39:55 INFO - PROCESS | 8525 | __startTimestamp1470703195322__endTimestamp 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | ------- Summary: start ------- 17:39:55 INFO - PROCESS | 8525 | Number of tests: 14 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:1.33 17:39:55 INFO - PROCESS | 8525 | Values: 104.0 111.0 113.0 110.0 112.0 111.0 112.0 113.0 109.0 112.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:131.00 stddev:22.42 (17.1%) stddev-sans-first:23.43 17:39:55 INFO - PROCESS | 8525 | Values: 144.0 117.0 117.0 178.0 117.0 118.0 147.0 117.0 159.0 117.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 17:39:55 INFO - PROCESS | 8525 | Values: 159.0 159.0 160.0 159.0 160.0 159.0 160.0 162.0 159.0 160.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:15.13 (20.3%) stddev-sans-first:15.83 17:39:55 INFO - PROCESS | 8525 | Values: 74.0 75.0 74.0 118.0 75.0 75.0 73.0 74.0 99.0 74.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:83.50 stddev:20.02 (24.0%) stddev-sans-first:20.69 17:39:55 INFO - PROCESS | 8525 | Values: 83.0 83.0 121.0 84.0 84.0 84.0 122.0 83.0 84.0 131.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:39:55 INFO - PROCESS | 8525 | Values: 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:39:55 INFO - PROCESS | 8525 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 146.0 145.0 146.0 146.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:39:55 INFO - PROCESS | 8525 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 95.0 95.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:51.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 17:39:55 INFO - PROCESS | 8525 | Values: 51.0 51.0 49.0 49.0 51.0 51.0 49.0 50.0 49.0 51.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 17:39:55 INFO - PROCESS | 8525 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.50 stddev:1.17 (1.5%) stddev-sans-first:1.22 17:39:55 INFO - PROCESS | 8525 | Values: 76.0 77.0 77.0 76.0 76.0 79.0 76.0 76.0 78.0 75.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:128.50 stddev:11.32 (8.8%) stddev-sans-first:11.79 17:39:55 INFO - PROCESS | 8525 | Values: 135.0 125.0 127.0 130.0 135.0 118.0 118.0 124.0 156.0 121.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:2.64 (1.6%) stddev-sans-first:2.47 17:39:55 INFO - PROCESS | 8525 | Values: 158.0 166.0 162.0 159.0 159.0 160.0 165.0 162.0 161.0 163.0 17:39:55 INFO - PROCESS | 8525 | 17:39:55 INFO - PROCESS | 8525 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.45 (2.3%) stddev-sans-first:1.50 17:39:55 INFO - PROCESS | 8525 | Values: 64.0 63.0 64.0 63.0 64.0 62.0 62.0 66.0 61.0 62.0 17:39:55 INFO - PROCESS | 8525 | -------- Summary: end -------- 17:39:55 INFO - PROCESS | 8525 | 17:39:56 INFO - TEST-INFO | 8525: exit 0 17:39:56 INFO - TEST-OK | kraken | took 61112ms 17:39:56 INFO - SUITE-END | took 1176s 17:39:56 INFO - Completed test suite (00:19:36) 17:39:56 INFO - javascript benchmark 17:39:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.7886147969625, 3070.9385812283754, 3093.1030001299623, 3104.6429660589038, 3129.5462157987095, 5287.550558202557, 5350.2777125088105, 5352.4915133062395, 5425.403205647381, 5468.07042802724, 5335.1997200419855, 5347.893042139155, 5362.785488580452, 5393.406725260218, 5405.0, 4756.405449318835, 4812.494688057756, 4835.806567737286, 4842.443119041302, 4955.331030310898, 4902.0931127741305, 4902.436219834729, 4903.730294833783, 4907.1657818171, 4908.484609116027, 4733.100710864925, 4783.665143439961, 4844.32179494871, 4855.732934688591, 4879.634027447938, 4772.498887616785, 4776.522347765231, 4779.3308936748535, 4836.0, 4884.951150488485, 4768.928466073012, 4799.088173247107, 4800.495947925452, 4842.588379987706, 4877.1708809502115, 5198.896022079575, 5259.053370393328, 5270.472952704698, 5317.9468205317835, 5383.757730902119, 5671.092625179951, 5671.7731290748325, 5683.261176047129, 5736.827895163152, 5741.971290143564, 5761.8559536011935, 5774.0761478163295, 5784.652920824764, 5786.0, 5787.681677507735, 5189.506996835333, 5247.370315562157, 5316.46835316473, 5323.707196104251, 5370.812021579226, 5846.035404158351, 5850.736716847752, 5888.116782482576, 5891.145783861316, 5891.49922256613, 5606.859828504238, 5617.185508101303, 5660.320761508646, 5671.744771485293, 5678.119891416837, 5515.338159420895, 5559.33288005442, 5622.072358060956, 5749.1663708762, 5749.453801888814, 5591.077472217039, 5601.719914004283, 5602.411746766612, 5614.214010038598, 5664.2636457261115, 5610.607257492018, 5614.887702245932, 5640.407757185519, 5662.462066103713, 5666.150077488327, 4314.7626880521875, 4340.891477713019, 4341.45731783527, 4342.088161486124, 4346.760928148982, 3899.1032062625754, 3923.0388554804254, 3945.2898478274187, 3963.8612648557164, 3985.70107241958, 5433.483819037185, 5443.101888188405, 5446.046941785172, 5446.455354464521, 5491.093969495068, 5576.414476479992, 5681.119426488901, 5765.990951583456, 5769.624974376736, 5770.567207459458, 5359.196120581944, 5383.919241211385, 5411.242426060355, 5431.37539182999, 5435.565154787608, 4885.633577481632, 4896.4858689837765, 4897.975510122498, 4908.141075311806, 4933.703977761345, 5808.332041815076, 5906.822795316148, 5935.881282374328, 5936.762529498772, 5941.910871336933, 5751.1373294006235, 5814.73833677494, 5819.418058194146, 5829.504492118217, 5868.559858010752, 6000.969995149996, 6017.669028203491, 6020.4280593343565, 6021.096835474714, 6033.698315084141, 5477.808276710296, 5619.297587801525, 5622.297212848394, 5678.261825962599, 5679.403662615531, 5777.017906955912, 5864.736086876015, 5866.472017518444, 5911.172435858897, 5912.024515954991, 5681.602287839812, 5703.344115426779, 5705.144228365778, 5709.22925405065, 5715.51418129447, 5471.343438787371, 5475.753591088331, 5692.8576785579035, 5695.231143795535, 5704.0588302929555, 5418.83743487696, 5505.0, 5507.972460137674, 5521.613487055867, 5559.27729395176, 5582.358028826575, 5592.4966752990795, 5623.971880140573, 5636.0, 5640.125780504029, 5360.0619891518045, 5364.463553644604, 5461.1808228766, 5475.780968761205, 5477.123660214346], "value": 5270.8907326368535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9163134310282, 584.5644994479113, 600.9639421634703, 602.6203491800165, 609.6342194683193, 35426.46860297094, 36593.81703091488, 36621.450678239846, 43733.34399983995, 45267.54732452674, 45883.77058114713, 46470.30294545584, 46503.30245046327, 46508.0, 46509.534904650944, 8866.335024873144, 9065.184133428023, 9066.138716821892, 9069.909300906973, 9072.092790720908, 8893.822123557526, 8972.41679290844, 8977.147171018743, 8980.41627294227, 8989.280857531414, 9023.639054437816, 9075.63697452101, 9077.273818094569, 9079.727608171765, 9085.273178145766, 9006.099390061006, 9039.81920361589, 9048.547572621343, 9054.411463254868, 9058.501782401965, 8884.555772211364, 8889.688860889837, 8939.687110951085, 8989.41568798026, 8990.595423205972, 43595.78202109001, 43642.78178609118, 43736.0, 44025.459108931354, 44150.0, 3475.965240347615, 3612.6026137124895, 4135.834566617332, 4198.076423186894, 4285.61429471349, 32977.34045319104, 33564.328713425595, 33890.32219355624, 33893.15267118317, 34718.30563388743, 4248.830046798124, 4399.824007039714, 4490.461144662629, 4514.345419914127, 4545.5908968193025, 350246.0, 352695.0, 353746.0, 354845.0, 355616.5534206316, 58160.70919645375, 58419.0, 58432.0, 58454.0, 58489.41510584925, 57780.422195778345, 57859.0, 57892.71053644705, 57902.7104864473, 57921.710391448614, 15055.322510487054, 15312.923435382752, 15313.46402875894, 15335.386584536494, 15336.923315383352, 11553.24903881245, 11583.478743456564, 11599.072074234042, 11604.593839215588, 11605.76788464226, 15509.922450387676, 17503.0, 17504.12479376026, 17512.737308940377, 17545.210465529082, 6257.4681152102585, 6329.651869147241, 6336.6831658416895, 6351.174347334817, 6367.071147272214, 704.4186684905221, 1019.9133073688671, 1048.7378155461136, 1156.8727439981594, 1180.38030034231, 33462.498062529085, 33919.15202119967, 34015.489767653504, 34030.65969340324, 34509.827450862584, 1082.1775450657558, 1087.217203613397, 1124.0557931337717, 1197.5748609243767, 1209.8306237126633, 17316.39392621252, 17601.647967040586, 17637.7354339685, 17657.0, 17661.0, 530554.0, 533521.0, 534014.0, 534142.0, 534637.0, 60115.398846011856, 60354.396456034876, 60445.0, 60511.39488605058, 60517.0, 1209.1052621060528, 1311.7048664050512, 1316.6905777142365, 1333.419962316376, 1363.3660347938057, 32113.197170070936, 34459.0, 34865.825670872495, 34990.65009349874, 35246.64753352536, 53623.73188134035, 54489.18266225931, 54565.45434545604, 54581.727091364286, 54620.180697290365, 490543.0, 492152.0, 496543.0, 497413.0, 497753.0, 44698.3295250578, 45842.02026868243, 46447.53552464432, 48080.0, 49224.0, 49632.50367496279, 49891.750541247064, 50572.747136264086, 50681.23978140257, 50980.490195097576, 41770.58229417667, 42190.0, 42446.1510769789, 42898.78550607227, 44183.0, 42197.789011054745, 42271.7886410566, 42784.57215427806, 43884.0, 44094.77952610217, 41900.0, 42110.57889421189, 43151.568484314754, 43349.56650433455, 43358.78320608377, 36084.639153609176, 38052.238955220186, 38442.0, 38722.806385969016, 39225.6077439222, 29293.26766830846, 29317.41365172642, 29490.852545737132, 29505.852470737507, 29788.0], "value": 20647.849504660982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.36297568182715, 387.16565800699505, 390.9980450097749, 393.96454319111285, 420.6970980893755, 16965.321387144515, 19401.708974365378, 19453.31913383032, 19642.31251906182, 20610.793892061076, 19392.806071939278, 19580.70628940567, 19730.605387892232, 19869.503262418446, 19912.203511859545, 5457.645253058558, 5772.826815195541, 5860.150278209657, 5927.555433342495, 5989.730462129215, 5810.273715785527, 5890.087036509348, 5895.852603684921, 5899.528037756991, 5906.852328691774, 5614.129809879455, 5850.619709718876, 5865.560082993771, 5875.588708790387, 5878.559108066891, 5693.886122277531, 5874.618149820248, 5910.970445147746, 5916.467517923386, 5921.496672782819, 5238.79044838206, 5259.921101183485, 5278.498542638443, 5285.497877701612, 5285.656432331886, 23797.762022379902, 24342.0, 24346.391340216458, 24362.756372436404, 24457.510849783084, 2364.6216605343234, 2582.315686343102, 3077.338372249977, 3135.608048993876, 3196.7602429817625, 10462.372257664565, 10969.396683182422, 10979.17656175782, 10984.945075274652, 11042.171837112168, 1929.9903500482408, 1953.345629214215, 1987.920483180671, 1994.7606287245624, 1995.9600807983904, 80896.59551702262, 83185.0, 85400.14599854047, 85985.0, 86143.56928215444, 10365.948170259251, 10459.215558832966, 11173.553057877594, 11381.487833047533, 11539.942300288445, 13972.231527266098, 13978.182836231224, 13987.510437134652, 13990.650233744238, 13997.020208585302, 7437.739679111205, 7646.770596882103, 7756.340711039512, 7829.0, 8159.388045896581, 7393.852122957618, 7416.814579635552, 7443.925560744323, 7610.505317154367, 7632.274933881273, 4393.0994146199955, 4549.567791059844, 4758.666893317504, 4806.399200099988, 5009.0482808266315, 1952.4825921130912, 1970.6157299326494, 2000.7499062617173, 2032.7255820464343, 2035.735354403918, 880.1990188928173, 986.1026465915982, 1029.5418538750334, 1029.6344797596896, 1090.1660229924114, 19400.905435089902, 19653.41039768809, 19836.70244946298, 19913.203471860965, 19953.0, 954.4941181173989, 974.7563109222694, 1035.3477309295097, 1046.3826342457987, 1064.8296272596501, 10394.272400931863, 11040.723981900517, 11145.0, 11155.776884462266, 11169.497372618252, 453698.0, 459982.0, 465456.0, 466180.0, 473522.0, 72813.0, 88254.0, 88581.24221925554, 91016.544917275, 91168.54415728012, 954.7183580843667, 975.5171190260725, 988.4514094677523, 991.9107280344804, 1004.7739258666742, 16641.334346626485, 17155.0, 17361.0, 17477.650446991243, 17736.645267094846, 39880.401793973695, 40271.0, 40322.79838600788, 41108.0, 41357.79321103375, 53075.73462132664, 54231.0, 56520.0, 57127.71436142793, 57617.0, 8470.534120623424, 8586.184312490303, 8709.518280620272, 8715.651373945226, 8917.197452229071, 10320.12278956297, 12948.741025179632, 13210.801837972245, 13274.800877986645, 13534.59396218115, 10668.09321207675, 10844.0, 10932.726681833017, 11305.547778088785, 11602.76794464123, 11242.718932026437, 11398.0, 11687.76624467523, 11874.287542747463, 12035.157538972539, 11847.0, 12240.449179787109, 12315.568955086528, 12347.259164450163, 12595.24428534291, 8743.91256087431, 8928.776780580278, 8984.191422771983, 9013.18881300686, 9353.11145441182, 10369.481525923522, 12073.69815754578, 12076.154669173073, 12093.818592721293, 12096.576619818265], "value": 9251.199319807247, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.545234620229, 1430.5779794960486, 1498.2808252039022, 1561.4222737587095, 1736.8436840684344, 8308.875366869494, 8644.956775216124, 8655.221030107297, 8765.0, 8808.603612837422, 8652.610632521535, 8739.169778871013, 8748.0, 8758.08040155784, 8758.562071896411, 2397.3407312988893, 2420.6490058941445, 2420.9273721788286, 2423.7939775119135, 2428.86641234732, 2309.0648287443614, 2374.240243122193, 2389.438481956739, 2391.5336509380677, 2391.820613453989, 2301.9539609207804, 2351.929442116739, 2360.834741568091, 2362.681038059857, 2367.2779802160335, 2292.071710957065, 2341.262502311766, 2347.0963678983544, 2349.4713689419914, 2360.468894498741, 2250.4036430345973, 2265.4223173090754, 2267.682524446579, 2268.5462907418582, 2272.170657709924, 8764.386492945496, 8780.736577902673, 8792.824143517159, 8797.208251257418, 8814.25078868297, 5144.408393034774, 5378.381486129067, 5396.811111611075, 5406.83779486616, 5417.160340147244, 3384.9492257616157, 3435.278591495789, 3456.8962931111855, 3478.00876750125, 3484.94772578409, 1133.195431243818, 1135.8828477707873, 1142.714321419645, 1161.3322339654733, 1170.6663600873794, 12292.139550231488, 12344.567940122142, 12356.814647780291, 12368.567100151542, 12390.876091239063, 4327.221100201994, 4609.423822022247, 4693.671442999025, 4808.591269742111, 4817.349657796222, 9631.518424078768, 9651.131398174199, 9670.419774813534, 9680.031996800264, 9684.46735429558, 5242.423333433319, 5263.26314315996, 5263.736813159327, 5272.077386457431, 5275.841724748264, 4278.0, 4782.689125206851, 4870.6103511718975, 4936.2102063669645, 4955.529224723646, 3746.325661380923, 3765.661090501868, 3867.245887052054, 3879.069023434412, 3902.043999220209, 1141.7088642396302, 1152.9077673786244, 1153.1754795321385, 1154.8556430446195, 1186.5609724401854, 839.2698352433422, 967.3325405470204, 970.1705042188827, 991.2530634202725, 1003.5233264199593, 5976.103584462366, 6070.3019152798, 6119.663418512025, 6291.716872740738, 6329.651869147241, 474.78871902003965, 475.94526629437365, 476.6067993905042, 481.7398604753464, 486.6496122791584, 4137.77242251673, 4143.4199212110325, 4224.260754367973, 4240.5123410808155, 4285.057287396768, 10908.0, 11178.496967636313, 11237.157213209042, 11242.0, 11261.549538018551, 10496.580136794595, 11004.504797284142, 11160.386178760245, 11172.273802202832, 11175.273607215506, 8072.071711753106, 8266.256036956582, 8285.378596605278, 8287.62705678246, 8296.211859873303, 5803.187553742564, 5862.853428664147, 5983.581149319506, 6119.541034422525, 6291.276503202007, 9661.323707340418, 9670.178034866834, 9691.370060946016, 9767.609295628095, 9799.020097990144, 10259.230557708053, 10446.582136714447, 10467.790644187226, 10556.102731267929, 10557.419341936267, 6871.622060786704, 7343.302386273509, 7570.5836179010685, 7677.385809135368, 7832.530048197126, 8454.66181352739, 8602.655893764178, 8621.396502244783, 8621.784455388666, 8624.353173511887, 7233.891491627735, 7349.77950661481, 7466.104067511933, 7511.211322811027, 7654.693812247448, 6851.794446166623, 6961.095057642474, 6997.0, 7239.312265334785, 7258.673359698932, 7108.609026503592, 7110.1112360954885, 7175.641217938978, 7179.138503379628, 7195.280471952972, 5277.340332458442, 5371.221172929825, 5428.050091234098, 5428.212909128233, 5428.918566221589, 5340.706261155674, 5355.678659280456, 5413.918791218213, 5464.28964234647, 5544.972275138599], "value": 4549.0046573826885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.32740536710486, 332.90308433710925, 342.2248606905359, 342.4862705941088, 344.5004743122473, 5165.431802501726, 5187.6628019178725, 5192.428832828391, 5199.766010529521, 5215.478452154783, 5152.819651312205, 5159.329287192669, 5172.146595811696, 5174.223866420039, 5179.507946745062, 3850.17221297421, 4038.798060096998, 4126.669866410687, 4127.195196936598, 4132.793360331986, 4048.0284731664337, 4048.4736984192014, 4058.289799285113, 4079.8368065277355, 4079.8980025499304, 3981.800909954505, 3999.9800000999953, 4008.098177909976, 4011.679065674739, 4033.878983630496, 3793.108619474421, 3892.3966785148345, 3998.7000974926996, 4008.478897743304, 4028.0463974972263, 3551.449525323553, 3561.82190890457, 3563.2160924596546, 3568.80371579563, 3579.19468119671, 5053.242013697938, 5059.772310246048, 5065.872333619888, 5073.289739436482, 5081.644284900059, 4349.434573505456, 4373.147236288925, 4562.22442184826, 4566.748828814414, 4602.585767280961, 5347.41178470368, 5355.357357117171, 5355.410904800468, 5361.56048997709, 5363.839084827461, 3900.7074469414906, 3903.3754599264266, 3911.335073037562, 3912.0806610446807, 3917.0794863207125, 5389.622726409114, 5556.388797232301, 5579.330480342344, 5587.7485513152005, 5614.343768588317, 3991.9201615967518, 4001.09975255571, 4004.0990777074926, 4007.5591684914634, 4007.899802504961, 4038.434619153321, 4045.7862641208108, 4046.433499310099, 4052.371882358239, 4053.351463765783, 4362.650987920959, 4587.72473651582, 4615.0, 4618.815247390134, 4621.214393553104, 5413.296271484682, 5422.502485896574, 5424.945750542523, 5429.728513574306, 5433.157860531624, 1380.565121986571, 1390.3117956611543, 1394.3028485757122, 1394.316784775473, 1396.0855639556107, 850.7490290364358, 892.4422236102436, 905.9909400905907, 916.6287653500343, 919.5218486387041, 4619.353290539327, 4631.282151266559, 4644.605208557243, 4663.463701674283, 4665.580097791215, 4861.222204447342, 4875.853724388274, 4911.877203069952, 4949.628777841676, 4949.752512374367, 4446.9555304447185, 4644.3744689358455, 4676.836310729108, 4693.929591056137, 4722.645801564828, 2610.256077018079, 2611.360216746871, 2621.266045507261, 2636.9208923732317, 2636.986815065951, 5061.164907790247, 5070.619703522177, 5082.974585127125, 5191.766370513336, 5204.71374074422, 4863.0, 5021.991203518622, 5029.748512574357, 5033.0, 5046.318746969112, 5031.7987280509105, 5043.5965122790085, 5051.292819005343, 5077.527517020023, 5082.542571168538, 4823.2282834747675, 4828.782704778223, 4852.1508735971765, 4930.457649658606, 4988.4263309719845, 4556.908861822812, 4796.35249241348, 4805.111054454797, 4813.95186048149, 4861.319415281792, 4995.725235112103, 5017.745563609098, 5029.170186919117, 5034.622403319839, 5048.829003528518, 3662.908427289339, 3682.1899182179877, 3701.27825074108, 3717.219383929405, 3728.9067773305883, 4888.682235654671, 4925.655204135676, 4970.577500912463, 4996.725180115129, 5150.716710580954, 5401.0, 5419.160030195326, 5470.753816078206, 5485.314335708036, 5486.067368547437, 5437.728113594226, 5476.151196564539, 5477.808276710296, 5485.6982865942755, 5487.917681234864, 5208.5312321891215, 5412.783488660567, 5428.240046393429, 5457.0, 5487.6158668894395, 5234.97382513085, 5328.706921119376, 5432.831941132676, 5465.076184241412, 5505.366882808368, 5342.332208473941, 5348.358197016383, 5353.223782551586, 5367.838964831061, 5370.624056316176], "value": 3982.5306016304194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.30873941604, 764.7552783109404, 796.3350602247124, 844.3920377328321, 847.9915200847989, 15667.52997410078, 16251.918740406281, 16266.51200463988, 16269.83730162698, 16294.42969496068, 15193.848061519382, 15354.232288385592, 15414.922925385385, 15424.228788560555, 15445.922770386132, 655.5476721062452, 779.1896427715184, 782.6478084861807, 802.0335495727634, 816.2735165702529, 803.7548547692951, 805.6334367862609, 809.9352051835839, 817.726061769308, 817.8691409374501, 856.8800367948493, 862.0086900064913, 865.1953683074738, 865.2299453486371, 865.6796985115516, 691.1360799001224, 837.9664813407456, 857.7169534053747, 863.1541089732035, 864.9610767515445, 622.2719418280623, 622.9563930524865, 623.2178615837141, 623.3361470034399, 623.8877002139614, 14666.12003279796, 14672.70654586913, 14695.412183512646, 14705.558833234913, 14718.411263549446, 14273.928630356886, 14724.33740481681, 14746.11523308605, 14766.335514901855, 15114.848851511455, 13658.112222705493, 13669.179849209078, 13719.314034298246, 13908.235047072407, 14541.200233987127, 4466.70966387187, 4671.813127474897, 4689.695169813951, 4791.137595232856, 4792.257200133985, 80862.0, 81014.18985810125, 81532.59233703853, 82454.58772706157, 82458.0, 11588.88411115878, 11983.787928579226, 12067.637970860887, 12105.878941210474, 12418.0, 22736.20423285177, 22841.543169136858, 22900.541989160123, 22949.655755163687, 23006.309810705705, 8377.41358104939, 8552.61513231906, 8555.743327700055, 8647.783805404915, 8765.605547750367, 4587.816487340469, 4656.0920620479355, 4786.688865223749, 4854.466008739036, 5150.0472412603785, 3450.0857272822723, 3568.7680300780366, 3573.5533058367705, 3576.5886923004186, 3591.0, 585.9062549992066, 590.447931184344, 599.6971529377723, 600.3726106219011, 610.9877802443926, 566.583561082604, 655.7672026430644, 682.6547243372861, 725.5247812682701, 751.3650964934731, 9461.195798357217, 9774.5601447935, 10001.49992500372, 10073.748156296151, 10462.372257664565, 672.1329484964439, 675.1594265139834, 716.6595866963255, 732.901058357115, 748.4237137404168, 4489.685721999494, 4522.88692782683, 4612.3542704021465, 4640.071985602893, 4726.929096063562, 86187.0, 129671.0, 130562.0, 133968.33015835052, 139576.9063464049, 111978.0, 112487.4375628133, 113272.43363783293, 114413.4279328598, 116273.0, 61204.0, 63663.6816815913, 89203.55398223097, 90249.54875225713, 93919.53040234755, 8914.955425222832, 8968.327375446737, 8981.955090224506, 9027.774305642411, 9045.231155351868, 57352.71323643355, 58217.70891145517, 58406.70796645989, 58607.0, 62472.375276246654, 79519.60240198762, 83048.0, 85894.57052714696, 86960.56519717361, 87407.0, 11495.712607184887, 12138.514459421523, 12326.137170398344, 12343.382830858602, 12474.06444516683, 13250.933745331211, 13279.468821247043, 13606.251656159006, 13665.180089194282, 14269.215193164475, 12335.259884406605, 12835.101542892282, 12848.614541563767, 12856.614301570968, 13193.274369909746, 11829.585964491202, 11952.58165964187, 12309.93845030769, 12376.876231237573, 12497.0, 12089.879101208875, 12498.0, 12508.249505029728, 12908.741825163257, 12936.0, 10171.0, 10536.15710743154, 10544.26190166681, 10555.472226388803, 11034.0, 9591.568379423083, 9695.0, 10406.461802987022, 10408.509753646695, 10742.3017503862], "value": 7630.640334307361, "unit": "score"}], "name": "dromaeo_css", "value": 7199.0280581317065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 110.0, 112.0, 111.0, 112.0, 113.0, 109.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 117.0, 178.0, 117.0, 118.0, 147.0, 117.0, 159.0, 117.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 159.0, 160.0, 159.0, 160.0, 162.0, 159.0, 160.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 118.0, 75.0, 75.0, 73.0, 74.0, 99.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 121.0, 84.0, 84.0, 84.0, 122.0, 83.0, 84.0, 131.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 49.0, 51.0, 51.0, 49.0, 50.0, 49.0, 51.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 76.0, 76.0, 79.0, 76.0, 76.0, 78.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 125.0, 127.0, 130.0, 135.0, 118.0, 118.0, 124.0, 156.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 166.0, 162.0, 159.0, 159.0, 160.0, 165.0, 162.0, 161.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 62.0, 62.0, 66.0, 61.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1480.6, "alertThreshold": 2.0}]} 17:39:56 INFO - Return code: 0 17:39:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:39:56 INFO - # TBPL SUCCESS # 17:39:56 INFO - Running post-action listener: _resource_record_post_action 17:39:56 INFO - [mozharness: 2016-08-09 00:39:56.622820Z] Finished run-tests step (success) 17:39:56 INFO - Running post-run listener: _resource_record_post_run 17:39:56 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 196608; Write bytes: 552198144; Read time: 60; Write time: 567288 17:39:56 INFO - TinderboxPrint: CPU usage
13.1% 17:39:56 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 60 17:39:56 INFO - TinderboxPrint: I/O write bytes / time
552,198,144 / 567,288 17:39:56 INFO - TinderboxPrint: CPU idle
8,282.3 (86.9%) 17:39:56 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 17:39:56 INFO - TinderboxPrint: Swap in / out
0 / 0 17:39:56 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 261115904; Read time: 0; Write time: 311320 17:39:56 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 196608; Write bytes: 291082240; Read time: 60; Write time: 255968 17:39:57 INFO - Running post-run listener: _upload_blobber_files 17:39:57 INFO - Blob upload gear active. 17:39:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:39:57 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 17:39:57 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:39:57 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:39:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:39:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:58 INFO - (blobuploader) - INFO - Done attempting. 17:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:02 INFO - (blobuploader) - INFO - Done attempting. 17:40:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:40:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:40:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:03 INFO - (blobuploader) - INFO - Done attempting. 17:40:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:03 INFO - Return code: 0 17:40:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4180ff0993a51b1e043644940767713519bb2ad9a65535cdb13ef3faedf514992061b237679e53e04fc5bcc47924fbcb946cbb72f5f0025dfcf9a54e25fb07e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8baabb23fee9e6f9e33e5782f23f2e21dd1ff523becf89708ffd749c8501d62bb93c41fdfaf3f4050d4098ee8872967df67960dce0c74e7e7d560e16ce32cbc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/779319ced5e63e70ebe03e3771abd01a16b6b41dae714e8d656478b1107aff0177df69db6c58af55ce41a551bfd53573ab21518a89423c8f6f4fed10327a14b8"} 17:40:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:03 INFO - Contents: 17:40:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4180ff0993a51b1e043644940767713519bb2ad9a65535cdb13ef3faedf514992061b237679e53e04fc5bcc47924fbcb946cbb72f5f0025dfcf9a54e25fb07e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8baabb23fee9e6f9e33e5782f23f2e21dd1ff523becf89708ffd749c8501d62bb93c41fdfaf3f4050d4098ee8872967df67960dce0c74e7e7d560e16ce32cbc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/779319ced5e63e70ebe03e3771abd01a16b6b41dae714e8d656478b1107aff0177df69db6c58af55ce41a551bfd53573ab21518a89423c8f6f4fed10327a14b8"} 17:40:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:03 INFO - Copying logs to upload dir... 17:40:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.114946 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-08 17:40:03.394437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:40:03.397832) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694 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-Inbound/sha512/e4180ff0993a51b1e043644940767713519bb2ad9a65535cdb13ef3faedf514992061b237679e53e04fc5bcc47924fbcb946cbb72f5f0025dfcf9a54e25fb07e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8baabb23fee9e6f9e33e5782f23f2e21dd1ff523becf89708ffd749c8501d62bb93c41fdfaf3f4050d4098ee8872967df67960dce0c74e7e7d560e16ce32cbc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/779319ced5e63e70ebe03e3771abd01a16b6b41dae714e8d656478b1107aff0177df69db6c58af55ce41a551bfd53573ab21518a89423c8f6f4fed10327a14b8"} build_url:https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/Kb0lDCOzRD2JqOlG6bL97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e4180ff0993a51b1e043644940767713519bb2ad9a65535cdb13ef3faedf514992061b237679e53e04fc5bcc47924fbcb946cbb72f5f0025dfcf9a54e25fb07e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8baabb23fee9e6f9e33e5782f23f2e21dd1ff523becf89708ffd749c8501d62bb93c41fdfaf3f4050d4098ee8872967df67960dce0c74e7e7d560e16ce32cbc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/779319ced5e63e70ebe03e3771abd01a16b6b41dae714e8d656478b1107aff0177df69db6c58af55ce41a551bfd53573ab21518a89423c8f6f4fed10327a14b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:40:03.430582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:40:03.431037) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470699932.690162-1330866694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.53 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:40:03.961042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:40:03.961399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:40:03.961896) ========= ========= Total master_lag: 0.63 =========