builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1467750588.43 results: success (0) buildid: 20160705103119 builduid: 7c8826a29dec4692b83d39fcfd1c9805 revision: 6172a55a6ae8611317b89f18ca47f785df4ab877 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.431905) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.432376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.432653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.447964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.448312) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 13:29:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.1M=0s 2016-07-05 13:29:49 (96.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.272838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.735942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.736346) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015851 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.786004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:48.786370) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6172a55a6ae8611317b89f18ca47f785df4ab877 --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 6172a55a6ae8611317b89f18ca47f785df4ab877 --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=a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 13:29:49,926 truncating revision to first 12 chars 2016-07-05 13:29:49,926 Setting DEBUG logging. 2016-07-05 13:29:49,927 attempt 1/10 2016-07-05 13:29:49,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6172a55a6ae8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 13:29:50,223 unpacking tar archive at: mozilla-inbound-6172a55a6ae8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:49.450743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:49.451062) ========= script_repo_revision: 6172a55a6ae8611317b89f18ca47f785df4ab877 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:49.451455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:49.451720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 13:29:49.461702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-05 13:29:49.462120) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:29:50 INFO - MultiFileLogger online at 20160705 13:29:50 in /builds/slave/test 13:29:50 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 13:29:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:29:50 INFO - {'append_to_log': False, 13:29:50 INFO - 'base_work_dir': '/builds/slave/test', 13:29:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:29:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:29:50 INFO - 'branch': 'Mozilla-Inbound', 13:29:50 INFO - 'buildbot_json_path': 'buildprops.json', 13:29:50 INFO - 'config_files': ('talos/linux_config.py',), 13:29:50 INFO - 'default_actions': ('clobber', 13:29:50 INFO - 'read-buildbot-config', 13:29:50 INFO - 'download-and-extract', 13:29:50 INFO - 'populate-webroot', 13:29:50 INFO - 'create-virtualenv', 13:29:50 INFO - 'install', 13:29:50 INFO - 'run-tests'), 13:29:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:29:50 INFO - 'download_minidump_stackwalk': True, 13:29:50 INFO - 'download_symbols': 'ondemand', 13:29:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:29:50 INFO - 'tooltool.py': '/tools/tooltool.py', 13:29:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:29:50 INFO - '/tools/misc-python/virtualenv.py')}, 13:29:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:29:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:29:50 INFO - 'installer_path': 'installer.exe', 13:29:50 INFO - 'log_level': 'info', 13:29:50 INFO - 'log_name': 'talos', 13:29:50 INFO - 'log_to_console': True, 13:29:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:29:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:29:50 INFO - 'opt_config_files': (), 13:29:50 INFO - 'pip_index': False, 13:29:50 INFO - 'sps_profile': False, 13:29:50 INFO - 'sps_profile_interval': 0, 13:29:50 INFO - 'suite': 'dromaeojs', 13:29:50 INFO - 'system_bits': '32', 13:29:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:29:50 INFO - 'title': 'talos-linux64-ix-062', 13:29:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:29:50 INFO - 'use_talos_json': True, 13:29:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:29:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:29:50 INFO - 'work_dir': 'build'} 13:29:50 INFO - ##### 13:29:50 INFO - ##### Running clobber step. 13:29:50 INFO - ##### 13:29:50 INFO - Running pre-action listener: _resource_record_pre_action 13:29:50 INFO - Running main action method: clobber 13:29:50 INFO - rmtree: /builds/slave/test/build 13:29:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:29:51 INFO - Running post-action listener: _resource_record_post_action 13:29:51 INFO - ##### 13:29:51 INFO - ##### Finished clobber step (success) 13:29:51 INFO - ##### 13:29:51 INFO - ##### 13:29:51 INFO - ##### Running read-buildbot-config step. 13:29:51 INFO - ##### 13:29:51 INFO - Running pre-action listener: _resource_record_pre_action 13:29:51 INFO - Running main action method: read_buildbot_config 13:29:51 INFO - Using buildbot properties: 13:29:51 INFO - { 13:29:51 INFO - "project": "", 13:29:51 INFO - "product": "firefox", 13:29:51 INFO - "script_repo_revision": "production", 13:29:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:29:51 INFO - "repository": "", 13:29:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:29:51 INFO - "buildid": "20160705103119", 13:29:51 INFO - "pgo_build": "True", 13:29:51 INFO - "basedir": "/builds/slave/test", 13:29:51 INFO - "buildnumber": 2023, 13:29:51 INFO - "slavename": "talos-linux64-ix-062", 13:29:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:29:51 INFO - "platform": "ubuntu64_hw", 13:29:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:29:51 INFO - "branch": "mozilla-inbound", 13:29:51 INFO - "repo_path": "integration/mozilla-inbound", 13:29:51 INFO - "revision": "6172a55a6ae8611317b89f18ca47f785df4ab877", 13:29:51 INFO - "stage_platform": "linux64-pgo", 13:29:51 INFO - "builduid": "7c8826a29dec4692b83d39fcfd1c9805", 13:29:51 INFO - "slavebuilddir": "test" 13:29:51 INFO - } 13:29:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:29:51 INFO - Running post-action listener: _resource_record_post_action 13:29:51 INFO - ##### 13:29:51 INFO - ##### Finished read-buildbot-config step (success) 13:29:51 INFO - ##### 13:29:51 INFO - ##### 13:29:51 INFO - ##### Running download-and-extract step. 13:29:51 INFO - ##### 13:29:51 INFO - Running pre-action listener: _resource_record_pre_action 13:29:51 INFO - Running main action method: download_and_extract 13:29:51 INFO - mkdir: /builds/slave/test/build/tests 13:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:51 INFO - https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:29:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:29:51 INFO - Downloaded 1361 bytes. 13:29:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:51 INFO - Using the following test package requirements: 13:29:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:29:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:29:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:29:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'jsshell-linux-x86_64.zip'], 13:29:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:29:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:29:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:29:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:29:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:29:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:29:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:51 INFO - https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:29:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:29:52 INFO - Downloaded 24299713 bytes. 13:29:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:29:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:29:54 INFO - Return code: 0 13:29:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:54 INFO - https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:29:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:29:55 INFO - Downloaded 24299713 bytes. 13:29:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:29:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:29:56 INFO - Return code: 0 13:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:56 INFO - https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:29:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:29:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:29:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:29:57 INFO - Downloaded 14403333 bytes. 13:29:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:29:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:29:57 INFO - Return code: 0 13:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:57 INFO - https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:29:59 INFO - Downloaded 60379170 bytes. 13:29:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:59 INFO - mkdir: /builds/slave/test/properties 13:29:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:29:59 INFO - Writing to file /builds/slave/test/properties/build_url 13:29:59 INFO - Contents: 13:29:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:30:00 INFO - Running post-action listener: _resource_record_post_action 13:30:00 INFO - Running post-action listener: set_extra_try_arguments 13:30:00 INFO - ##### 13:30:00 INFO - ##### Finished download-and-extract step (success) 13:30:00 INFO - ##### 13:30:00 INFO - ##### 13:30:00 INFO - ##### Running populate-webroot step. 13:30:00 INFO - ##### 13:30:00 INFO - Running pre-action listener: _resource_record_pre_action 13:30:00 INFO - Running main action method: populate_webroot 13:30:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:30:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:30:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:30:00 INFO - '--tppagecycles', 13:30:00 INFO - '7'], 13:30:00 INFO - 'tests': ['tsvgm']}}, 13:30:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:30:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:30:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:30:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:30:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['damp', 'tps']}, 13:30:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'tests': ['damp', 'tps']}, 13:30:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['dromaeo_dom']}, 13:30:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:30:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['basic_compositor_video']}, 13:30:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:30:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['a11yr', 13:30:00 INFO - 'ts_paint', 13:30:00 INFO - 'tpaint', 13:30:00 INFO - 'sessionrestore', 13:30:00 INFO - 'sessionrestore_no_auto_restore', 13:30:00 INFO - 'tabpaint']}, 13:30:00 INFO - 'other-e10s': {'tests': ['a11yr', 13:30:00 INFO - 'ts_paint', 13:30:00 INFO - 'tpaint', 13:30:00 INFO - 'sessionrestore', 13:30:00 INFO - 'sessionrestore_no_auto_restore', 13:30:00 INFO - 'tabpaint']}, 13:30:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:30:00 INFO - 'ts_paint', 13:30:00 INFO - 'tpaint', 13:30:00 INFO - 'sessionrestore', 13:30:00 INFO - 'sessionrestore_no_auto_restore', 13:30:00 INFO - 'tabpaint']}, 13:30:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:30:00 INFO - 'ts_paint', 13:30:00 INFO - 'tpaint', 13:30:00 INFO - 'sessionrestore', 13:30:00 INFO - 'sessionrestore_no_auto_restore', 13:30:00 INFO - 'tabpaint']}, 13:30:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['a11yr', 13:30:00 INFO - 'ts_paint', 13:30:00 INFO - 'tpaint', 13:30:00 INFO - 'sessionrestore', 13:30:00 INFO - 'sessionrestore_no_auto_restore', 13:30:00 INFO - 'tabpaint']}, 13:30:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['a11yr', 13:30:00 INFO - 'ts_paint', 13:30:00 INFO - 'tpaint', 13:30:00 INFO - 'sessionrestore', 13:30:00 INFO - 'sessionrestore_no_auto_restore', 13:30:00 INFO - 'tabpaint']}, 13:30:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['tsvgx', 13:30:00 INFO - 'tsvgr_opacity', 13:30:00 INFO - 'tart', 13:30:00 INFO - 'tscrollx', 13:30:00 INFO - 'cart']}, 13:30:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:30:00 INFO - 'tsvgr_opacity', 13:30:00 INFO - 'tart', 13:30:00 INFO - 'tscrollx', 13:30:00 INFO - 'cart']}, 13:30:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'talos_options': ['--disable-e10s'], 13:30:00 INFO - 'tests': ['tp5o']}, 13:30:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'tests': ['tp5o']}, 13:30:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'talos_options': ['--disable-e10s', 13:30:00 INFO - '--xperf_path', 13:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:00 INFO - 'tests': ['tp5n']}, 13:30:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:00 INFO - 'talos_options': ['--xperf_path', 13:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:00 INFO - 'tests': ['tp5n']}}, 13:30:00 INFO - 'talos.zip': {'path': '', 13:30:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:30:00 INFO - Running post-action listener: _resource_record_post_action 13:30:00 INFO - ##### 13:30:00 INFO - ##### Finished populate-webroot step (success) 13:30:00 INFO - ##### 13:30:00 INFO - ##### 13:30:00 INFO - ##### Running create-virtualenv step. 13:30:00 INFO - ##### 13:30:00 INFO - Running pre-action listener: _resource_record_pre_action 13:30:00 INFO - Running main action method: create_virtualenv 13:30:00 INFO - Creating virtualenv /builds/slave/test/build/venv 13:30:00 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 13:30:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:30:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:30:00 INFO - Using real prefix '/usr' 13:30:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:30:00 INFO - Installing distribute.............................................................................................................................................................................................done. 13:30:02 INFO - Installing pip.................done. 13:30:02 INFO - Return code: 0 13:30:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:02 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:02 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 13:30:02 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 13:30:02 INFO - Using env: {'DISPLAY': ':0', 13:30:02 INFO - 'HOME': '/home/cltbld', 13:30:02 INFO - 'LANG': 'en_US.UTF-8', 13:30:02 INFO - 'LANGUAGE': 'en_US:en', 13:30:02 INFO - 'LOGNAME': 'cltbld', 13:30:02 INFO - 'MAIL': '/var/mail/cltbld', 13:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:02 INFO - 'MOZ_NO_REMOTE': '1', 13:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:02 INFO - 'NO_EM_RESTART': '1', 13:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:02 INFO - 'PWD': '/builds/slave/test', 13:30:02 INFO - 'SHELL': '/bin/bash', 13:30:02 INFO - 'SHLVL': '1', 13:30:02 INFO - 'TERM': 'linux', 13:30:02 INFO - 'TMOUT': '86400', 13:30:02 INFO - 'USER': 'cltbld', 13:30:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:02 INFO - '_': '/tools/buildbot/bin/python'} 13:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:02 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 13:30:02 INFO - Cleaning up... 13:30:02 INFO - Return code: 0 13:30:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:02 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:02 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 13:30:02 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 13:30:02 INFO - Using env: {'DISPLAY': ':0', 13:30:02 INFO - 'HOME': '/home/cltbld', 13:30:02 INFO - 'LANG': 'en_US.UTF-8', 13:30:02 INFO - 'LANGUAGE': 'en_US:en', 13:30:02 INFO - 'LOGNAME': 'cltbld', 13:30:02 INFO - 'MAIL': '/var/mail/cltbld', 13:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:02 INFO - 'MOZ_NO_REMOTE': '1', 13:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:02 INFO - 'NO_EM_RESTART': '1', 13:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:02 INFO - 'PWD': '/builds/slave/test', 13:30:02 INFO - 'SHELL': '/bin/bash', 13:30:02 INFO - 'SHLVL': '1', 13:30:02 INFO - 'TERM': 'linux', 13:30:02 INFO - 'TMOUT': '86400', 13:30:02 INFO - 'USER': 'cltbld', 13:30:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:02 INFO - '_': '/tools/buildbot/bin/python'} 13:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:03 INFO - Downloading/unpacking psutil>=3.1.1 13:30:03 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 13:30:03 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 13:30:03 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 13:30:03 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 13:30:03 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 13:30:03 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 13:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:30:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:05 INFO - Installing collected packages: psutil 13:30:05 INFO - Running setup.py install for psutil 13:30:05 INFO - building 'psutil._psutil_linux' extension 13:30:05 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 13:30:05 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 13:30:05 INFO - building 'psutil._psutil_posix' extension 13:30:05 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 13:30:05 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 13:30:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:05 INFO - Successfully installed psutil 13:30:05 INFO - Cleaning up... 13:30:05 INFO - Return code: 0 13:30:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:05 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:05 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 13:30:05 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 13:30:05 INFO - Using env: {'DISPLAY': ':0', 13:30:05 INFO - 'HOME': '/home/cltbld', 13:30:05 INFO - 'LANG': 'en_US.UTF-8', 13:30:05 INFO - 'LANGUAGE': 'en_US:en', 13:30:05 INFO - 'LOGNAME': 'cltbld', 13:30:05 INFO - 'MAIL': '/var/mail/cltbld', 13:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:05 INFO - 'MOZ_NO_REMOTE': '1', 13:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:05 INFO - 'NO_EM_RESTART': '1', 13:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:05 INFO - 'PWD': '/builds/slave/test', 13:30:05 INFO - 'SHELL': '/bin/bash', 13:30:05 INFO - 'SHLVL': '1', 13:30:05 INFO - 'TERM': 'linux', 13:30:05 INFO - 'TMOUT': '86400', 13:30:05 INFO - 'USER': 'cltbld', 13:30:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:05 INFO - '_': '/tools/buildbot/bin/python'} 13:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:30:05 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 13:30:05 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 13:30:05 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 13:30:05 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 13:30:05 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 13:30:05 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 13:30:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:30:07 INFO - Installing collected packages: mozsystemmonitor 13:30:07 INFO - Running setup.py install for mozsystemmonitor 13:30:08 INFO - Successfully installed mozsystemmonitor 13:30:08 INFO - Cleaning up... 13:30:08 INFO - Return code: 0 13:30:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:30:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:08 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:08 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 13:30:08 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 13:30:08 INFO - Using env: {'DISPLAY': ':0', 13:30:08 INFO - 'HOME': '/home/cltbld', 13:30:08 INFO - 'LANG': 'en_US.UTF-8', 13:30:08 INFO - 'LANGUAGE': 'en_US:en', 13:30:08 INFO - 'LOGNAME': 'cltbld', 13:30:08 INFO - 'MAIL': '/var/mail/cltbld', 13:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:08 INFO - 'MOZ_NO_REMOTE': '1', 13:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:08 INFO - 'NO_EM_RESTART': '1', 13:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:08 INFO - 'PWD': '/builds/slave/test', 13:30:08 INFO - 'SHELL': '/bin/bash', 13:30:08 INFO - 'SHLVL': '1', 13:30:08 INFO - 'TERM': 'linux', 13:30:08 INFO - 'TMOUT': '86400', 13:30:08 INFO - 'USER': 'cltbld', 13:30:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:08 INFO - '_': '/tools/buildbot/bin/python'} 13:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:08 INFO - Downloading/unpacking jsonschema==2.5.1 13:30:08 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 13:30:08 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 13:30:08 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 13:30:08 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 13:30:08 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 13:30:08 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 13:30:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:30:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 INFO - Downloading functools32-3.2.3-2.tar.gz 13:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:30:10 INFO - warning: no files found matching '*.txt' 13:30:10 INFO - no previously-included directories found matching 'build' 13:30:10 INFO - no previously-included directories found matching 'dist' 13:30:10 INFO - no previously-included directories found matching '.git*' 13:30:10 INFO - Installing collected packages: jsonschema, functools32 13:30:10 INFO - Running setup.py install for functools32 13:30:10 INFO - warning: no files found matching '*.txt' 13:30:10 INFO - no previously-included directories found matching 'build' 13:30:10 INFO - no previously-included directories found matching 'dist' 13:30:10 INFO - no previously-included directories found matching '.git*' 13:30:10 INFO - Successfully installed jsonschema functools32 13:30:10 INFO - Cleaning up... 13:30:10 INFO - Return code: 0 13:30:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:30:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:10 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:10 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 13:30:10 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 13:30:10 INFO - Using env: {'DISPLAY': ':0', 13:30:10 INFO - 'HOME': '/home/cltbld', 13:30:10 INFO - 'LANG': 'en_US.UTF-8', 13:30:10 INFO - 'LANGUAGE': 'en_US:en', 13:30:10 INFO - 'LOGNAME': 'cltbld', 13:30:10 INFO - 'MAIL': '/var/mail/cltbld', 13:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:10 INFO - 'MOZ_NO_REMOTE': '1', 13:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:10 INFO - 'NO_EM_RESTART': '1', 13:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:10 INFO - 'PWD': '/builds/slave/test', 13:30:10 INFO - 'SHELL': '/bin/bash', 13:30:10 INFO - 'SHLVL': '1', 13:30:10 INFO - 'TERM': 'linux', 13:30:10 INFO - 'TMOUT': '86400', 13:30:10 INFO - 'USER': 'cltbld', 13:30:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:10 INFO - '_': '/tools/buildbot/bin/python'} 13:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:10 INFO - Downloading/unpacking blobuploader==1.2.4 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 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 13:30:12 INFO - Downloading blobuploader-1.2.4.tar.gz 13:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:30:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:30:12 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 13:30:12 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 13:30:12 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 13:30:12 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 13:30:12 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 13:30:12 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 13:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:30:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:30:13 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 13:30:13 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 13:30:13 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 13:30:13 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 13:30:13 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 13:30:13 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 13:30:13 INFO - Downloading docopt-0.6.1.tar.gz 13:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:30:13 INFO - Installing collected packages: blobuploader, requests, docopt 13:30:13 INFO - Running setup.py install for blobuploader 13:30:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:30:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:30:13 INFO - Running setup.py install for requests 13:30:14 INFO - Running setup.py install for docopt 13:30:14 INFO - Successfully installed blobuploader requests docopt 13:30:14 INFO - Cleaning up... 13:30:14 INFO - Return code: 0 13:30:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:14 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:14 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 13:30:14 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 13:30:14 INFO - Using env: {'DISPLAY': ':0', 13:30:14 INFO - 'HOME': '/home/cltbld', 13:30:14 INFO - 'LANG': 'en_US.UTF-8', 13:30:14 INFO - 'LANGUAGE': 'en_US:en', 13:30:14 INFO - 'LOGNAME': 'cltbld', 13:30:14 INFO - 'MAIL': '/var/mail/cltbld', 13:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:14 INFO - 'MOZ_NO_REMOTE': '1', 13:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:14 INFO - 'NO_EM_RESTART': '1', 13:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:14 INFO - 'PWD': '/builds/slave/test', 13:30:14 INFO - 'SHELL': '/bin/bash', 13:30:14 INFO - 'SHLVL': '1', 13:30:14 INFO - 'TERM': 'linux', 13:30:14 INFO - 'TMOUT': '86400', 13:30:14 INFO - 'USER': 'cltbld', 13:30:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:14 INFO - '_': '/tools/buildbot/bin/python'} 13:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:14 INFO - Running setup.py (path:/tmp/pip-kcZVwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:14 INFO - Running setup.py (path:/tmp/pip-T8k71m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:14 INFO - Running setup.py (path:/tmp/pip-yERkn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:14 INFO - Running setup.py (path:/tmp/pip-gukUWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:14 INFO - Running setup.py (path:/tmp/pip-wv5ocx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:14 INFO - Running setup.py (path:/tmp/pip-PjajLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:14 INFO - Running setup.py (path:/tmp/pip-ZJBasD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:14 INFO - Running setup.py (path:/tmp/pip-bqPW9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:15 INFO - Running setup.py (path:/tmp/pip-DxOc0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:15 INFO - Running setup.py (path:/tmp/pip-luQQwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:15 INFO - Running setup.py (path:/tmp/pip-ud_JbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:15 INFO - Running setup.py (path:/tmp/pip-CRlEGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:15 INFO - Running setup.py (path:/tmp/pip-XCe2SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:15 INFO - Running setup.py (path:/tmp/pip-CJH6FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:15 INFO - Running setup.py (path:/tmp/pip-zjgIv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:15 INFO - Running setup.py (path:/tmp/pip-OYFQ1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:15 INFO - Running setup.py (path:/tmp/pip-_8HB1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:30:15 INFO - Running setup.py install for manifestparser 13:30:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:30:15 INFO - Running setup.py install for mozcrash 13:30:15 INFO - Running setup.py install for mozdebug 13:30:16 INFO - Running setup.py install for mozdevice 13:30:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Running setup.py install for mozfile 13:30:16 INFO - Running setup.py install for mozhttpd 13:30:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Running setup.py install for mozinfo 13:30:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Running setup.py install for mozInstall 13:30:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Running setup.py install for mozleak 13:30:16 INFO - Running setup.py install for mozlog 13:30:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Running setup.py install for moznetwork 13:30:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:30:16 INFO - Running setup.py install for mozprocess 13:30:16 INFO - Running setup.py install for mozprofile 13:30:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:30:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:30:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:30:17 INFO - Running setup.py install for mozrunner 13:30:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:30:17 INFO - Running setup.py install for mozscreenshot 13:30:17 INFO - Running setup.py install for moztest 13:30:17 INFO - Running setup.py install for mozversion 13:30:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:30:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:30:17 INFO - Cleaning up... 13:30:17 INFO - Return code: 0 13:30:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:17 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:17 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 13:30:17 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 13:30:17 INFO - Using env: {'DISPLAY': ':0', 13:30:17 INFO - 'HOME': '/home/cltbld', 13:30:17 INFO - 'LANG': 'en_US.UTF-8', 13:30:17 INFO - 'LANGUAGE': 'en_US:en', 13:30:17 INFO - 'LOGNAME': 'cltbld', 13:30:17 INFO - 'MAIL': '/var/mail/cltbld', 13:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:17 INFO - 'MOZ_NO_REMOTE': '1', 13:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:17 INFO - 'NO_EM_RESTART': '1', 13:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:17 INFO - 'PWD': '/builds/slave/test', 13:30:17 INFO - 'SHELL': '/bin/bash', 13:30:17 INFO - 'SHLVL': '1', 13:30:17 INFO - 'TERM': 'linux', 13:30:17 INFO - 'TMOUT': '86400', 13:30:17 INFO - 'USER': 'cltbld', 13:30:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:17 INFO - '_': '/tools/buildbot/bin/python'} 13:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:17 INFO - Running setup.py (path:/tmp/pip-e0Fvn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:17 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)) 13:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:17 INFO - Running setup.py (path:/tmp/pip-QzXjBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:17 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)) 13:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:17 INFO - Running setup.py (path:/tmp/pip-mIPz_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:17 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)) 13:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:17 INFO - Running setup.py (path:/tmp/pip-w_esjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:18 INFO - Running setup.py (path:/tmp/pip-e7RtS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:18 INFO - Running setup.py (path:/tmp/pip-tZSaqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:18 INFO - Running setup.py (path:/tmp/pip-G1jT3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:18 INFO - Running setup.py (path:/tmp/pip-n4Vt3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:18 INFO - Running setup.py (path:/tmp/pip-DNpiAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:18 INFO - Running setup.py (path:/tmp/pip-7xfVSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:18 INFO - Running setup.py (path:/tmp/pip-jYfUdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:18 INFO - Running setup.py (path:/tmp/pip-gXYSEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:18 INFO - Running setup.py (path:/tmp/pip-VjKaih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:18 INFO - Running setup.py (path:/tmp/pip-Ag4NqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:18 INFO - Running setup.py (path:/tmp/pip-QP3myk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:18 INFO - Running setup.py (path:/tmp/pip-grky5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:18 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)) 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:18 INFO - Running setup.py (path:/tmp/pip-XHjSu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:19 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)) 13:30:19 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)) 13:30:19 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)) 13:30:19 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)) 13:30:19 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)) 13:30:19 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)) 13:30:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:30:19 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 13:30:19 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 13:30:19 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 13:30:19 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 13:30:19 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 13:30:19 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 13:30:20 INFO - Downloading blessings-1.6.tar.gz 13:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:30:20 INFO - Installing collected packages: blessings 13:30:20 INFO - Running setup.py install for blessings 13:30:21 INFO - Successfully installed blessings 13:30:21 INFO - Cleaning up... 13:30:21 INFO - Return code: 0 13:30:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:21 INFO - Reading from file tmpfile_stdout 13:30:21 INFO - Current package versions: 13:30:21 INFO - argparse == 1.2.1 13:30:21 INFO - blessings == 1.6 13:30:21 INFO - blobuploader == 1.2.4 13:30:21 INFO - docopt == 0.6.1 13:30:21 INFO - functools32 == 3.2.3-2 13:30:21 INFO - jsonschema == 2.5.1 13:30:21 INFO - manifestparser == 1.1 13:30:21 INFO - mozInstall == 1.12 13:30:21 INFO - mozcrash == 0.17 13:30:21 INFO - mozdebug == 0.1 13:30:21 INFO - mozdevice == 0.48 13:30:21 INFO - mozfile == 1.2 13:30:21 INFO - mozhttpd == 0.7 13:30:21 INFO - mozinfo == 0.9 13:30:21 INFO - mozleak == 0.1 13:30:21 INFO - mozlog == 3.2 13:30:21 INFO - moznetwork == 0.27 13:30:21 INFO - mozprocess == 0.22 13:30:21 INFO - mozprofile == 0.28 13:30:21 INFO - mozrunner == 6.11 13:30:21 INFO - mozscreenshot == 0.1 13:30:21 INFO - mozsystemmonitor == 0.3 13:30:21 INFO - moztest == 0.7 13:30:21 INFO - mozversion == 1.4 13:30:21 INFO - psutil == 3.1.1 13:30:21 INFO - requests == 1.2.3 13:30:21 INFO - wsgiref == 0.1.2 13:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:21 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 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:21 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 13:30:21 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 13:30:21 INFO - Using env: {'DISPLAY': ':0', 13:30:21 INFO - 'HOME': '/home/cltbld', 13:30:21 INFO - 'LANG': 'en_US.UTF-8', 13:30:21 INFO - 'LANGUAGE': 'en_US:en', 13:30:21 INFO - 'LOGNAME': 'cltbld', 13:30:21 INFO - 'MAIL': '/var/mail/cltbld', 13:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:21 INFO - 'MOZ_NO_REMOTE': '1', 13:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:21 INFO - 'NO_EM_RESTART': '1', 13:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:21 INFO - 'PWD': '/builds/slave/test', 13:30:21 INFO - 'SHELL': '/bin/bash', 13:30:21 INFO - 'SHLVL': '1', 13:30:21 INFO - 'TERM': 'linux', 13:30:21 INFO - 'TMOUT': '86400', 13:30:21 INFO - 'USER': 'cltbld', 13:30:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:21 INFO - '_': '/tools/buildbot/bin/python'} 13:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 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)) 13:30:21 INFO - Cleaning up... 13:30:21 INFO - Return code: 0 13:30:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1def8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', '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 13:30:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:30:21 INFO - Using env: {'DISPLAY': ':0', 13:30:21 INFO - 'HOME': '/home/cltbld', 13:30:21 INFO - 'LANG': 'en_US.UTF-8', 13:30:21 INFO - 'LANGUAGE': 'en_US:en', 13:30:21 INFO - 'LOGNAME': 'cltbld', 13:30:21 INFO - 'MAIL': '/var/mail/cltbld', 13:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:21 INFO - 'MOZ_NO_REMOTE': '1', 13:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:21 INFO - 'NO_EM_RESTART': '1', 13:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:21 INFO - 'PWD': '/builds/slave/test', 13:30:21 INFO - 'SHELL': '/bin/bash', 13:30:21 INFO - 'SHLVL': '1', 13:30:21 INFO - 'TERM': 'linux', 13:30:21 INFO - 'TMOUT': '86400', 13:30:21 INFO - 'USER': 'cltbld', 13:30:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:21 INFO - '_': '/tools/buildbot/bin/python'} 13:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:30:21 INFO - Cleaning up... 13:30:21 INFO - Return code: 0 13:30:21 INFO - Running post-action listener: _resource_record_post_action 13:30:21 INFO - Running post-action listener: _start_resource_monitoring 13:30:21 INFO - Starting resource monitoring. 13:30:21 INFO - ##### 13:30:21 INFO - ##### Finished create-virtualenv step (success) 13:30:21 INFO - ##### 13:30:21 INFO - ##### 13:30:21 INFO - ##### Running install step. 13:30:21 INFO - ##### 13:30:21 INFO - Running pre-action listener: _resource_record_pre_action 13:30:21 INFO - Running main action method: install 13:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:22 INFO - Reading from file tmpfile_stdout 13:30:22 INFO - Detecting whether we're running mozinstall >=1.0... 13:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:30:22 INFO - Reading from file tmpfile_stdout 13:30:22 INFO - Output received: 13:30:22 INFO - Usage: mozinstall [options] installer 13:30:22 INFO - Options: 13:30:22 INFO - -h, --help show this help message and exit 13:30:22 INFO - -d DEST, --destination=DEST 13:30:22 INFO - Directory to install application into. [default: 13:30:22 INFO - "/builds/slave/test"] 13:30:22 INFO - --app=APP Application being installed. [default: firefox] 13:30:22 INFO - mkdir: /builds/slave/test/build/application 13:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:30:39 INFO - Reading from file tmpfile_stdout 13:30:39 INFO - Output received: 13:30:39 INFO - /builds/slave/test/build/application/firefox/firefox 13:30:39 INFO - Running post-action listener: _resource_record_post_action 13:30:39 INFO - ##### 13:30:39 INFO - ##### Finished install step (success) 13:30:39 INFO - ##### 13:30:39 INFO - ##### 13:30:39 INFO - ##### Running run-tests step. 13:30:39 INFO - ##### 13:30:39 INFO - Running pre-action listener: _resource_record_pre_action 13:30:39 INFO - Running main action method: run_tests 13:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:30:39 INFO - Python 2.7.3 13:30:39 INFO - Return code: 0 13:30:39 INFO - grabbing minidump binary from tooltool 13:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:39 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 0x1f4b3b0>, '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 0x1f4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:30:39 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 13:30:39 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 13:30:39 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 13:30:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:30:39 INFO - Return code: 0 13:30:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:30:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:30:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:30:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:30:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:30:39 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/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 13:30:39 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/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 13:30:39 INFO - Using env: {'DISPLAY': ':0', 13:30:39 INFO - 'HOME': '/home/cltbld', 13:30:39 INFO - 'LANG': 'en_US.UTF-8', 13:30:39 INFO - 'LANGUAGE': 'en_US:en', 13:30:39 INFO - 'LOGNAME': 'cltbld', 13:30:39 INFO - 'MAIL': '/var/mail/cltbld', 13:30:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:30:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:39 INFO - 'MOZ_NO_REMOTE': '1', 13:30:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:39 INFO - 'NO_EM_RESTART': '1', 13:30:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:39 INFO - 'PWD': '/builds/slave/test', 13:30:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:30:39 INFO - 'SHELL': '/bin/bash', 13:30:39 INFO - 'SHLVL': '1', 13:30:39 INFO - 'TERM': 'linux', 13:30:39 INFO - 'TMOUT': '86400', 13:30:39 INFO - 'USER': 'cltbld', 13:30:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724', 13:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:39 INFO - '_': '/tools/buildbot/bin/python'} 13:30:39 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/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 13:30:39 INFO - mozversion application_buildid: 20160705103119 13:30:39 INFO - mozversion application_changeset: 6172a55a6ae8611317b89f18ca47f785df4ab877 13:30:39 INFO - mozversion application_display_name: Nightly 13:30:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:30:39 INFO - mozversion application_name: Firefox 13:30:39 INFO - mozversion application_remotingname: firefox 13:30:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:30:39 INFO - mozversion application_vendor: Mozilla 13:30:39 INFO - mozversion application_version: 50.0a1 13:30:39 INFO - mozversion platform_buildid: 20160705103119 13:30:39 INFO - mozversion platform_changeset: 6172a55a6ae8611317b89f18ca47f785df4ab877 13:30:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:30:39 INFO - mozversion platform_version: 50.0a1 13:30:39 INFO - using testdate: 1467750639 13:30:39 INFO - actual date: 1467750639 13:30:39 INFO - starting webserver on 'localhost:59611' 13:30:39 INFO - SUITE-START | Running 2 tests 13:30:39 INFO - TEST-START | dromaeo_css 13:30:39 INFO - operating with platform_type : linux_ 13:30:39 INFO - Initialising browser for dromaeo_css test... 13:30:39 INFO - TEST-INFO | started process 28252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA_5iK/profile http://localhost:59611/getInfo.html) 13:30:43 INFO - PROCESS | 28252 | __metrics Screen width/height:1600/1200 13:30:43 INFO - PROCESS | 28252 | colorDepth:24 13:30:43 INFO - PROCESS | 28252 | Browser inner width/height: 1024/697 13:30:43 INFO - PROCESS | 28252 | __metrics 13:30:44 INFO - PROCESS | 28252 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:45 INFO - TEST-INFO | 28252: exit 0 13:30:45 INFO - Browser initialized. 13:30:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:30:45 INFO - TEST-INFO | started process 28333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA_5iK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:56 INFO - PROCESS | 28333 | RSS: Main: 157503488 13:30:56 INFO - PROCESS | 28333 | 13:31:48 INFO - PROCESS | 28333 | 1467750708396 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] 13:33:56 INFO - PROCESS | 28333 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59611/tests/dromaeo/cssquery-ext.html) 13:33:57 INFO - PROCESS | 28333 | RSS: Main: 246415360 13:33:57 INFO - PROCESS | 28333 | 13:36:59 INFO - PROCESS | 28333 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-ext.html (next: http://localhost:59611/tests/dromaeo/cssquery-jquery.html) 13:37:00 INFO - PROCESS | 28333 | RSS: Main: 245637120 13:37:00 INFO - PROCESS | 28333 | 13:40:02 INFO - PROCESS | 28333 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59611/tests/dromaeo/cssquery-mootools.html) 13:40:02 INFO - PROCESS | 28333 | RSS: Main: 245219328 13:40:02 INFO - PROCESS | 28333 | 13:43:04 INFO - PROCESS | 28333 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59611/tests/dromaeo/cssquery-prototype.html) 13:43:05 INFO - PROCESS | 28333 | RSS: Main: 235573248 13:43:05 INFO - PROCESS | 28333 | 13:46:08 INFO - PROCESS | 28333 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59611/tests/dromaeo/cssquery-yui.html) 13:46:08 INFO - PROCESS | 28333 | RSS: Main: 210604032 13:46:08 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-yui.html (next: http://localhost:59611/tests/dromaeo/cssquery-dojo.html) 13:49:11 INFO - PROCESS | 28333 | RSS: Main: 293359616 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | __start_tp_report 13:49:11 INFO - PROCESS | 28333 | _x_x_mozilla_page_load 13:49:11 INFO - PROCESS | 28333 | _x_x_mozilla_page_load_details 13:49:11 INFO - PROCESS | 28333 | |i|pagename|runs| 13:49:11 INFO - PROCESS | 28333 | |0;dojo.html;3034.4689679306116;3073.9846300768495;3095.4428202923473;3114.7508199344056;3118.844057797111;5081.237814327853;5143.511366420194;5219.92170117448;5289.391719952207;5326.733663316833;5283.8150664726645;5303.416624171338;5339.813106541272;5379.38137114232;5393.541548968343;4781;4861;4875.609951203895;4910;5054.368203974504;4954.355933728611;4979.203327467606;5005.274235235888;5019.749012549358;5054.418741844698;4794.736289504076;4845.975770121162;4872.123017856784;4906.264060390934;4910.48439913811;4907.779149938261;4909.815645241654;4911.975440122812;4925.039617274633;4967.7019378837385;4885.555296325174;4888.2178851383605;4893.804247830082;4911.926321105187;4948.554630083309;5152.92270615941;5291.047611429941;5321.308229930084;5326.227696983916;5405.648632838892;5860.267466566679;5861;5867.237259156283;5868.2371291732225;5871.588988770788;5593;5837.066069428871;5897.852553686149;5900.527957763368;5901.586888917777;5372.194170874361;5439.836804895859;5440.755166017539;5477.315335583052;5491.176323551459;5956.642601443928;5989.520838332923;6002.699865006733;6023.608465449732;6025.698715064229;5434.429384914606;5568.582356323292;5773.3072031356505;5778.855528611734;5780.624259423124;5726.4273572642405;5788.739506722208;5789.334226563999;5834.445727655866;5838.328592211865;5684.8863022739315;5734.971325143431;5747.879163563149;5761.366249712612;5779.104238842986;5511.807086751945;5656.462636049569;5707.942920570824;5759.366469688331;5772.942270577324;4389;4397.780110994501;4401.427814384109;4442.933695913022;4445.155420470101;3902.043999220209;3917.1578110706337;3931.8623848165175;3954.9209015820097;3968.206358728266;5244.6328756987405;5279.47205279469;5345.118055520796;5417.702026388586;5425.810096646598;5777.653340799566;5791.362950075489;5795.623284486495;5796.797112101141;5830.591858569859;5439.347278326547;5442.428545002796;5444.618876678674;5449.536789372948;5450.5639548836;4851.902961940812;4932.8766780830765;4974.726390048582;4985.152524070917;5028.899422011539;5988.221531200916;5994.1608174855555;5994.490468310242;5995.52035837132;6026.397360263939;5831.970840145772;5843.181954526454;5845.327787304344;5851.297844258716;5852.414758524284;5718;5856.209411729362;5906.911396329145;5937.881242375215;6049.758009679739;5531.529819965348;5608.4111168326735;5628.493435590816;5631.774729010957;5708.971455142864;5625.493705566519;5648.322201335866;5673.517750991047;5680.2047713321;5687.77248910039;5472.2065300531995;5519.31008623922;5573.080441727069;5576.275084239185;5598.916016259678;5594.496495315441;5605.635633683961;5610.186522954067;5611.971940140274;5617.129344951539;5329.20061990689;5526.115821468546;5538.972305138448;5548.334199896039;5579.8884022320135;5592.7762889483965;5641.435856414326;5666.320041595035;5721.685307308138;5757.596968212185;5575.888482230252;5582.27430434041;5586.720663966867;5586.832395028156;5591.664500130005 13:49:11 INFO - PROCESS | 28333 | |1;ext.html;611.6024584020386;631.5642206877254;639.6545865232774;647.2879832184594;650.4503694378249;31057.223569410777;34752.30495390091;34779.47830782537;34905.3018939621;42962.57037429625;45008.54991450084;45907.54092459074;46475;46504.767476162655;46684.53315466845;8869.379143459977;9072.455652660861;9074.001859795417;9079.137481939206;9089.272858171364;8929.687460938836;9039.32205084618;9043.728688139367;9047.411918225327;9059.139381758723;9110;9114.544272786366;9158.816823663523;9159.404638698497;9160.954195229015;9056.637734490612;9060.501672408014;9086.81826363469;9119.544022798833;9128.45229286245;9015.459072455673;9051.049639787794;9073.09269073094;9087.182153606207;9087.863682044775;42667.786661066806;42724.78637606823;42826.143477130594;42835.57164428347;42904.57095429037;3752.061984503874;3760.0975765816006;3821.847126114952;3914.921701565953;4156.480439945007;32757.83621081903;33266.6673333266;34065.318693626235;34237.486437703454;34886;3771.7548359356556;3778.3954567269107;3809.7523660961947;3835.9616403835885;3889.4749208856724;352946;353057;353503;355109;355994;55132.724336378866;55745;55815.44184558102;55879;55914.72042639761;55579.94310312971;57089;58257.70871145617;58287.46269104428;64556.677216613614;14495.275236238145;14578.708425831424;14633.487827926185;14653.853461465249;14730.852691472948;10137.64518241858;11776.52893884252;11855.703607409883;11882.643520694393;11884.346360950058;15375.61560960985;15390.769138462932;15764.369425222863;15912.52262432129;15938.123403212934;5816.749398879261;5947.345791962881;5999.970000149971;6032.185654936615;6049.516038716892;955.5604421965835;1008.3395376028712;1019.0879163149089;1041.7812259425605;1066.088494337346;32358;32519;32739.508907365933;33009.83495082557;33139;1071.935683858971;1074.6722249713755;1091.8034753744403;1124.5108377855495;1142.8114361130486;16753.497395078168;16973.830261697225;17119.14404279781;17144;17164.39924602633;479104;481019;481092;481940;482843;57738.13392799111;57994.42005579975;58158;58165.8925812792;58203.70898145482;1211.1219365959785;1321.3261236769317;1351.5337208662995;1353.086666500128;1381.730562540295;32629.836850815595;33805.3238935215;33821.32357352888;34046.48930266098;34169;49074.509254906996;49822.75088624534;49855;49890.50109499004;49947;375857;379585;380471;382717;383601;33630.831845841596;38866.80566597262;39643;40827;43757;48667;48923.51076489189;49039.50960490349;49306;49774;40443;41255;41567.37648935208;42600.78699606606;43356.56643433651;42095.36856947209;42101;42205.78897105495;42209;43379.78310108555;40695;41617;41889.16221675611;41895.7905210472;42005.36991945184;35626.64373356337;36200.07592255937;36359.81820090883;37188.25623487569;37441.251174975805;27622.585661214696;28071.0175143869;28262.43475130527;28286;28437.43125137527 13:49:11 INFO - PROCESS | 28333 | |2;jquery.html;374.48134333947473;390.56842189380734;397.31463225935266;398.2671883733929;419.86774166137667;14529.56411307661;17899.73150402745;20192;20258.392248232558;20276.391708248775;19488.415347539598;19583;19691.409257722255;19754.308599198994;19861.3048543301;5585.609007369486;5684.147377893329;5782.855428614297;5790.189373487715;5844;5757.366689664133;5800.129980502916;5826.15520749491;5864.23764910561;5864.354920958691;5582.385937546886;5762.193292938992;5781.595288329819;5796.710164491779;5798.2172406725185;5750.741216645261;5771.595988280822;5775.335836378828;5777.508911742507;5816.709164541756;4968.751562421864;5163.974180129113;5165.199394093884;5168.715720635363;5176.0683077046115;19632.312869049514;19795.109220084985;21502;23263;23280.534389312117;2355.9057637694473;2415.927522174338;2906.258903979493;2973.5391014392803;3092.3351479431803;14201.78697319541;14434.639134021629;14473.78289325661;14930.178840163895;15159.317830697644;1976.7331410259574;2007.076744697441;2007.1068374573322;2009.2967461388544;2048.897555122253;78476;80676;80761.59619201925;81606.59196703979;81927.5903620484;10421.635242766466;10428.634997775192;10484;10599.099076578577;10760.19298552596;14993.925030374778;15070.472533461276;15086.698266034618;15114.017588856688;15120.092794432368;7716.845663086707;7860.371170306362;7872.881906771403;7913.723019694283;8020.518768873886;7531.887021694679;7588.430867684946;7689.692412303557;7706.499077560053;7758.030246219223;6597.769078082244;6622.715163268665;6701.932980670131;6726.428253598499;6785.423239024738;1872.9906350468434;1879.9812001879807;1882.002538654488;1910.3549012667534;1918.5587314917648;958.7075941837807;985.0346660272829;1033.7312298802365;1044.5456226541478;1096.9945150274357;20049.899750501154;20330.49173770638;20598.485037874172;20643.4839129023;20723;947.9478628675352;979.9853002204973;1001.5042553935848;1008.505832142245;1037.123630532199;10917.781644367227;11539.596114135966;11824.349660768741;11869.525218991317;11982.58060967862;465244;469142;471446;472203;474484;80218;90112.5494372524;91344.54327728318;100304;103754;1010.2877471382805;1014.1633152648947;1023.3143793658267;1026.8870424253325;1029.624187171692;18838.811611883706;18867.528311792314;19323.130459129654;19355.225790968205;19364.70952935735;45831.54168458273;46445.6066318011;46716.53283467122;46859.76570117127;48148.5185148144;65278;65874;67031.3296867025;67583.66208168928;67672;7743.45795794289;8081.959590202011;8083;8270.917290827014;8756.211940925346;10395.94802025985;13915.721685566434;13987;14180.55631184772;14495.565133046026;11406.86308769028;12306.753864922472;12327.876721232673;12418;12448.128630995743;12158.331291779037;12251.632451026484;12301.507939682671;12360.25838449696;12492.25046497213;12423.813642795185;12526.935210507208;12580.433880475584;12616.936915315364;13153.473861045451;8957.820843583222;9072.546372681472;9180.081991800767;9215.49314787693;9251.121143491358;9425.267887833355;12490.625281241577;12706.745865082461;12800.87199128034;12804.679883003 13:49:11 INFO - PROCESS | 28333 | |3;mootools.html;1440.5390275111965;1486.0860570748987;1550.527089237782;1726.3439892840718;1746.8427841494272;8052.959735201323;8513.659453621864;8589.613467393967;8605.827883442327;8606.74179774607;7468.813279668011;7983.720569780059;8171.2237337453;8197.467164634294;8423.326133909288;2270.42104263413;2287.439577303563;2291.9656205156934;2296.5062511560013;2305.9538809223804;2006.1273346094422;2240.1263507232193;2259.186692790594;2286.2683941138757;2312.3063081075693;2191.780821917803;2240.19353032908;2259.9435014124615;2266.1162146762777;2271.0234599122373;2230.152542034033;2245.2141750387477;2247.4830788918475;2302.044651469638;2305.2738387407912;2253.3577930289953;2258.164479142711;2270.7729227077325;2278.1798552521077;2282.9200977965693;8443.113473085361;8529.786755331104;8534.18925202111;8623.223909848144;8631.43895646781;4971.801127954877;5156.226566015091;5192.870178245536;5203.427622961472;5222.268882356473;3040.3159289159985;3089.567460555524;3157.921051973696;3166.208447888028;3234.3854667613314;999.6751055906786;1006.5369929832286;1023.1916785739257;1034.534459493231;1041.3803786746873;11406.201565890391;11459.484323205475;11520.94239528797;11525.654230373102;11545.826812597817;4412.602865742035;4430.401895744098;4513.255312873404;4523.0275490769645;4661.766911654404;9749.025097490194;9848.113669769611;9852.704418867446;9862.654807081717;9877.555510002067;5136.332276803992;5187.403448603383;5192.5586325162785;5199.038177937094;5207.609429292818;4688.57802797743;4737.952620473751;4793.736344501086;4797.520247975174;4798.976005119952;3856.710746693953;3875.9806200968815;3901.4147877817986;3919.1573811630064;4029.738067025634;1160.431388619587;1234.623439850854;1239.0546841459004;1284.794432890733;1293.5537239652306;746.2798399544465;936.4240991790136;939.8167357365248;976.545906153642;980.6616717232544;5731.684757338387;5782;5808.854778630568;5817.185594016841;5908.379620139909;985.5959056786683;995.6515219673201;999.6604549903165;1002.8395456726888;1007.8538611901233;4009.258287216874;4012.4583181270154;4020.8190631421658;4046.959530404717;4055.7160998730396;10151.086402223835;10364.481775911174;10390.688279351632;10446.164306855433;10460.738481538023;9206.723798286062;10247.180225581935;10384.961503849554;10390.948045259876;10396;7544.962275188699;7832.373410127176;7853.528788272608;8027.799305017421;8060.476069055492;5565.916511252415;5773.769049238152;5803.100519419497;5816.680082595498;5877.617954832922;9710.07754263372;9726.465044422624;9749.268804839523;9749.80500389974;9789.804203916025;9684.56419461112;9784.315097943076;9855.507224638883;9997.650082247086;10018.098371146632;7503;7516.210797866145;7565.508241964255;7574.772756817304;7587.924120758722;8213.3429325655;8218.835623287381;8274.503529788231;8283.08886022525;8323.542205178774;7451.701931922662;7473.43949203801;7560.470767046254;7600.695972161273;7615.352695020985;7326.450516211199;7441.479096463412;7505.962470187614;7543.170251272465;7604.391648668204;6461.513851814015;6491.805245842632;6503.187101612299;6504.577202481823;6523.24982627004;4997.9500204997485;5028.195488721787;5112.9744351278005;5123.359580052494;5180.9740951295;5154.278401023785;5255.421903590525;5263.605229607718;5313.920291195713;5390.245365648734 13:49:11 INFO - PROCESS | 28333 | |4;prototype.html;327.6494151258153;333.2202645808808;342.07127648434505;345.7458767805664;348.79944032181504;5179.378474583051;5250.264962905197;5251.448597897223;5253.264542963988;5323.121684921984;5227.477252274771;5239.1093514102595;5239.266502689627;5253.4221235664045;5258.868528286795;3854.691624670034;4121.5672354402805;4180.47744031996;4190.539040705536;4193.496780386358;4048.412980117896;4076.001379661987;4140.130572579762;4141.834326626931;4157.129291818678;4040.939385909214;4045.5145382554133;4047.4738284023038;4049.493813273341;4066.369712694537;3871.6709079728116;3948.8815335539834;4071.7964101795087;4076;4080.755154690728;3580.3197392495345;3585.64143585642;3590.7127429805814;3602.3155600435834;3609.2961872434885;4878.975605121987;5049.873753156164;5082.847514574569;5085.74571271435;5088.185890257578;4540;4620.214563524209;4624.745638989854;4647.60495357895;4661.417322834645;5400.702961337125;5403.7027963462;5420.34955805302;5431.972840135813;5465.262189604392;3769.8492060317553;3920.7843568603716;3921.784301863396;3924.6271604197555;3943.881683549498;5634.690092044936;5660.773569057233;5678.261825962599;5695.914561281584;5713.971430142864;3969.761814291152;3970.4838371011583;3975.2447035063246;3995.180987897474;3997.400389941532;4024.959750402517;4027.275090483741;4030.6372426481757;4037.5962403759977;4044.9191016180102;4448.644108471314;4598.838545883429;4603.125406172817;4623.237165867661;4636.884077898079;5440.3471583409455;5446.264754258124;5461.836144915659;5462.7268636568015;5489.835304940858;1345.4080204710092;1350.5340657473157;1355.4984655677463;1355.7188456908325;1357.172125003747;883.6995421556702;896.1844721303582;907.8184363127269;913.4245425381966;914.1224424552504;4657.767111644404;4677.228257337501;4678.274867395559;4742.86571043032;4746;4904.926426103611;4967.09424986387;4987.376577927759;5000.874978125576;5025.437027116197;4718.834840780556;5026.4973502649445;5060.493950604984;5254.92117618236;5299.5230429261555;2931.4283714675435;2962.5704272880744;2968.807027543246;2972.836493992808;2973.241823335079;5585.58108141891;5699.943000570024;5714.314282286152;5725.942740572625;5730.484256416942;5677.545796336283;5685.630434021776;5700.486956173964;5710.314762228559;5721.914171287434;5684.488396044293;5695.117256825281;5698.629589076697;5707.514861236758;5734.394369576526;5351.224072509543;5569.805056822992;5576.804811831566;5603.2155498231095;5604.943950560442;5462.661647896291;5497.175423686479;5505.752241149238;5519.862003449946;5533.2253484513;5502.669839809624;5725.513331366714;5732.331307962991;5742.306019724275;5757.97121014409;3942.250972315251;3948.7828169450954;3962.5443074046852;3966.5240171179644;3975.6223158799867;5545.805896793593;5550.861228469321;5563.221149039056;5570.6657600544095;5582.86042848932;5182.585393168612;5425.945740542544;5446.673199608036;5448.4006759257245;5467.316585426822;5485.588580856532;5485.820548582074;5506.531944784738;5514.310711161105;5520.447955204608;5416.160495123262;5442.428545002717;5459.672419654833;5473.974629386993;5476.7535460903555;5364.195370694427;5545.195946587803;5564.19319198722;5570.5265052470995;5573.164025396223;5407.675539467487;5426.67439953604;5429.782808687766;5431.321084864392;5435.972820135874 13:49:11 INFO - PROCESS | 28333 | |5;yui.html;695.5096656856916;748.4872862089469;756.648158606248;769.2653515892322;811.8822770698247;15293.08241505509;16593.668126637476;16611.169441527934;16612.335506579722;16642.58393540162;14905.850941490582;15068;15101.471448499306;15110.924445377785;15151.712104471106;666.110742159218;684.5481981891952;784.52928243054;811.7118422959853;817.1501638296165;805.3034125481475;810.9026916769966;812.995935020327;814.4136221920209;814.5601375257384;861.2248975921658;874.1302404107921;874.1695389380114;874.7026011156206;876.701921346742;701.7263267325746;834.7120243516008;862.633380813155;864.3430992445724;866.9133086691344;601.2604496469323;602.4276936909953;602.4668168670757;603.2790814976105;608.2883026858586;13917.443302267897;14045.367958441895;14061;14163.78754318686;14213.076150050214;13953.511627093105;14167.14997100167;14221;14237.145771253758;14381.280935953266;11007.889921100767;11324.6036388726;11327.037201837853;12410.317432541207;12679.492820287178;4365.672574556889;4373.518912919576;4485.102979404132;4498.167838949772;4529.84145554904;78446;81174.59412702957;81899;82596.17403825944;84705.57647211786;10198.286119971532;10385.740356490996;10395.16838652906;10552.15582753378;10672.039516443558;19512.12195451208;19519.31682391138;19551.511212219808;19558.80441195598;19563;8158.224968627971;8262.297704695047;8265.132161122996;8283.17168283179;8467.237948584658;4521.59305662492;4532.116237333754;4540.455145382575;4609.792559334838;4614.653900957442;3246.935061298761;3352.0781785009317;3352.2792599591203;3353.228757385815;3360.5295258663805;560.3276068717555;576.9336526299445;580.451473357673;585.3268740947944;591.8875413671389;621.4686443091182;630.9400606942334;699.8235487633456;705.5096707788038;716.9032180655649;9650.662226822027;9902.356346837432;9903.356281841658;10122.190224782;10249.282550221562;598.374698440131;641.2337256977867;667.4827009068011;687.3126873126873;724.2033762860812;4707.964247865464;4780.641451891052;4844.176489996709;4851.151048566487;4899.804007839718;112977.4351128239;114991;116316;119767;120707;98395.50802246087;99883.50058249808;100915.49542252242;101815.49092254639;104361;90089.09910900806;90099;91552;91756.54121729483;95358.5232073849;8914.242289405473;8944.463332200088;8970.026594149276;9293.117153870371;9320.860187097334;51307.2303915449;52362.21456678229;53323.733381332844;53364;54521.72739136279;74673.62663186649;77732.61133694295;78248;79793;80925.59537202277;11256.549738010388;11352.886471135183;11444.256123351955;11567.190296679151;11898.22661526998;12860.742785144057;13007.284599346749;13032.804507932198;13267.535636252685;13566.457341706222;12431.37843107859;12458.127931044739;13029.674258143623;13046;13110.475580976654;12243.449044793184;12307.446164922421;12356.3821808911;13011.479540818262;13045.804312935124;11431.485583148944;11539.942300288445;11761.47073381717;11836.230645008047;11887.82168267494;9787.434010558276;9812.950935245279;10015.849762253427;10366.948165259126;10438;10283.897161028293;10446.52990615409;10462.947685261524;10504.159667226451;10517.9474102629 13:49:11 INFO - PROCESS | 28333 | __end_tp_report 13:49:11 INFO - PROCESS | 28333 | __start_cc_report 13:49:11 INFO - PROCESS | 28333 | _x_x_mozilla_cycle_collect,788 13:49:11 INFO - PROCESS | 28333 | __end_cc_report 13:49:11 INFO - PROCESS | 28333 | __startTimestamp1467751751869__endTimestamp 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | ------- Summary: start ------- 13:49:11 INFO - PROCESS | 28333 | Number of tests: 6 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | [#0] dojo.html Cycles:165 Average:5345.18 Median:5538.97 stddev:613.64 (11.1%) stddev-sans-first:588.14 13:49:11 INFO - PROCESS | 28333 | Values: 3034.5 3074.0 3095.4 3114.8 3118.8 5081.2 5143.5 5219.9 5289.4 5326.7 5283.8 5303.4 5339.8 5379.4 5393.5 4781.0 4861.0 4875.6 4910.0 5054.4 4954.4 4979.2 5005.3 5019.7 5054.4 4794.7 4846.0 4872.1 4906.3 4910.5 4907.8 4909.8 4912.0 4925.0 4967.7 4885.6 4888.2 4893.8 4911.9 4948.6 5152.9 5291.0 5321.3 5326.2 5405.6 5860.3 5861.0 5867.2 5868.2 5871.6 5593.0 5837.1 5897.9 5900.5 5901.6 5372.2 5439.8 5440.8 5477.3 5491.2 5956.6 5989.5 6002.7 6023.6 6025.7 5434.4 5568.6 5773.3 5778.9 5780.6 5726.4 5788.7 5789.3 5834.4 5838.3 5684.9 5735.0 5747.9 5761.4 5779.1 5511.8 5656.5 5707.9 5759.4 5772.9 4389.0 4397.8 4401.4 4442.9 4445.2 3902.0 3917.2 3931.9 3954.9 3968.2 5244.6 5279.5 5345.1 5417.7 5425.8 5777.7 5791.4 5795.6 5796.8 5830.6 5439.3 5442.4 5444.6 5449.5 5450.6 4851.9 4932.9 4974.7 4985.2 5028.9 5988.2 5994.2 5994.5 5995.5 6026.4 5832.0 5843.2 5845.3 5851.3 5852.4 5718.0 5856.2 5906.9 5937.9 6049.8 5531.5 5608.4 5628.5 5631.8 5709.0 5625.5 5648.3 5673.5 5680.2 5687.8 5472.2 5519.3 5573.1 5576.3 5598.9 5594.5 5605.6 5610.2 5612.0 5617.1 5329.2 5526.1 5539.0 5548.3 5579.9 5592.8 5641.4 5666.3 5721.7 5757.6 5575.9 5582.3 5586.7 5586.8 5591.7 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | [#1] ext.html Cycles:180 Average:57329.50 Median:41592.19 stddev:107944.40 (259.5%) stddev-sans-first:108163.22 13:49:11 INFO - PROCESS | 28333 | Values: 611.6 631.6 639.7 647.3 650.5 31057.2 34752.3 34779.5 34905.3 42962.6 45008.5 45907.5 46475.0 46504.8 46684.5 8869.4 9072.5 9074.0 9079.1 9089.3 8929.7 9039.3 9043.7 9047.4 9059.1 9110.0 9114.5 9158.8 9159.4 9161.0 9056.6 9060.5 9086.8 9119.5 9128.5 9015.5 9051.0 9073.1 9087.2 9087.9 42667.8 42724.8 42826.1 42835.6 42904.6 3752.1 3760.1 3821.8 3914.9 4156.5 32757.8 33266.7 34065.3 34237.5 34886.0 3771.8 3778.4 3809.8 3836.0 3889.5 352946.0 353057.0 353503.0 355109.0 355994.0 55132.7 55745.0 55815.4 55879.0 55914.7 55579.9 57089.0 58257.7 58287.5 64556.7 14495.3 14578.7 14633.5 14653.9 14730.9 10137.6 11776.5 11855.7 11882.6 11884.3 15375.6 15390.8 15764.4 15912.5 15938.1 5816.7 5947.3 6000.0 6032.2 6049.5 955.6 1008.3 1019.1 1041.8 1066.1 32358.0 32519.0 32739.5 33009.8 33139.0 1071.9 1074.7 1091.8 1124.5 1142.8 16753.5 16973.8 17119.1 17144.0 17164.4 479104.0 481019.0 481092.0 481940.0 482843.0 57738.1 57994.4 58158.0 58165.9 58203.7 1211.1 1321.3 1351.5 1353.1 1381.7 32629.8 33805.3 33821.3 34046.5 34169.0 49074.5 49822.8 49855.0 49890.5 49947.0 375857.0 379585.0 380471.0 382717.0 383601.0 33630.8 38866.8 39643.0 40827.0 43757.0 48667.0 48923.5 49039.5 49306.0 49774.0 40443.0 41255.0 41567.4 42600.8 43356.6 42095.4 42101.0 42205.8 42209.0 43379.8 40695.0 41617.0 41889.2 41895.8 42005.4 35626.6 36200.1 36359.8 37188.3 37441.3 27622.6 28071.0 28262.4 28286.0 28437.4 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | [#2] jquery.html Cycles:180 Average:29154.60 Median:23271.77 stddev:77790.93 (334.3%) stddev-sans-first:77979.14 13:49:11 INFO - PROCESS | 28333 | Values: 374.5 390.6 397.3 398.3 419.9 14529.6 17899.7 20192.0 20258.4 20276.4 19488.4 19583.0 19691.4 19754.3 19861.3 5585.6 5684.1 5782.9 5790.2 5844.0 5757.4 5800.1 5826.2 5864.2 5864.4 5582.4 5762.2 5781.6 5796.7 5798.2 5750.7 5771.6 5775.3 5777.5 5816.7 4968.8 5164.0 5165.2 5168.7 5176.1 19632.3 19795.1 21502.0 23263.0 23280.5 2355.9 2415.9 2906.3 2973.5 3092.3 14201.8 14434.6 14473.8 14930.2 15159.3 1976.7 2007.1 2007.1 2009.3 2048.9 78476.0 80676.0 80761.6 81606.6 81927.6 10421.6 10428.6 10484.0 10599.1 10760.2 14993.9 15070.5 15086.7 15114.0 15120.1 7716.8 7860.4 7872.9 7913.7 8020.5 7531.9 7588.4 7689.7 7706.5 7758.0 6597.8 6622.7 6701.9 6726.4 6785.4 1873.0 1880.0 1882.0 1910.4 1918.6 958.7 985.0 1033.7 1044.5 1097.0 20049.9 20330.5 20598.5 20643.5 20723.0 947.9 980.0 1001.5 1008.5 1037.1 10917.8 11539.6 11824.3 11869.5 11982.6 465244.0 469142.0 471446.0 472203.0 474484.0 80218.0 90112.5 91344.5 100304.0 103754.0 1010.3 1014.2 1023.3 1026.9 1029.6 18838.8 18867.5 19323.1 19355.2 19364.7 45831.5 46445.6 46716.5 46859.8 48148.5 65278.0 65874.0 67031.3 67583.7 67672.0 7743.5 8082.0 8083.0 8270.9 8756.2 10395.9 13915.7 13987.0 14180.6 14495.6 11406.9 12306.8 12327.9 12418.0 12448.1 12158.3 12251.6 12301.5 12360.3 12492.3 12423.8 12526.9 12580.4 12616.9 13153.5 8957.8 9072.5 9180.1 9215.5 9251.1 9425.3 12490.6 12706.7 12800.9 12804.7 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | [#3] mootools.html Cycles:180 Average:5594.24 Median:5189.98 stddev:3117.51 (60.1%) stddev-sans-first:3110.63 13:49:11 INFO - PROCESS | 28333 | Values: 1440.5 1486.1 1550.5 1726.3 1746.8 8053.0 8513.7 8589.6 8605.8 8606.7 7468.8 7983.7 8171.2 8197.5 8423.3 2270.4 2287.4 2292.0 2296.5 2306.0 2006.1 2240.1 2259.2 2286.3 2312.3 2191.8 2240.2 2259.9 2266.1 2271.0 2230.2 2245.2 2247.5 2302.0 2305.3 2253.4 2258.2 2270.8 2278.2 2282.9 8443.1 8529.8 8534.2 8623.2 8631.4 4971.8 5156.2 5192.9 5203.4 5222.3 3040.3 3089.6 3157.9 3166.2 3234.4 999.7 1006.5 1023.2 1034.5 1041.4 11406.2 11459.5 11520.9 11525.7 11545.8 4412.6 4430.4 4513.3 4523.0 4661.8 9749.0 9848.1 9852.7 9862.7 9877.6 5136.3 5187.4 5192.6 5199.0 5207.6 4688.6 4738.0 4793.7 4797.5 4799.0 3856.7 3876.0 3901.4 3919.2 4029.7 1160.4 1234.6 1239.1 1284.8 1293.6 746.3 936.4 939.8 976.5 980.7 5731.7 5782.0 5808.9 5817.2 5908.4 985.6 995.7 999.7 1002.8 1007.9 4009.3 4012.5 4020.8 4047.0 4055.7 10151.1 10364.5 10390.7 10446.2 10460.7 9206.7 10247.2 10385.0 10390.9 10396.0 7545.0 7832.4 7853.5 8027.8 8060.5 5565.9 5773.8 5803.1 5816.7 5877.6 9710.1 9726.5 9749.3 9749.8 9789.8 9684.6 9784.3 9855.5 9997.7 10018.1 7503.0 7516.2 7565.5 7574.8 7587.9 8213.3 8218.8 8274.5 8283.1 8323.5 7451.7 7473.4 7560.5 7600.7 7615.4 7326.5 7441.5 7506.0 7543.2 7604.4 6461.5 6491.8 6503.2 6504.6 6523.2 4998.0 5028.2 5113.0 5123.4 5181.0 5154.3 5255.4 5263.6 5313.9 5390.2 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | [#4] prototype.html Cycles:180 Average:4556.67 Median:5233.29 stddev:1337.06 (25.5%) stddev-sans-first:1302.59 13:49:11 INFO - PROCESS | 28333 | Values: 327.6 333.2 342.1 345.7 348.8 5179.4 5250.3 5251.4 5253.3 5323.1 5227.5 5239.1 5239.3 5253.4 5258.9 3854.7 4121.6 4180.5 4190.5 4193.5 4048.4 4076.0 4140.1 4141.8 4157.1 4040.9 4045.5 4047.5 4049.5 4066.4 3871.7 3948.9 4071.8 4076.0 4080.8 3580.3 3585.6 3590.7 3602.3 3609.3 4879.0 5049.9 5082.8 5085.7 5088.2 4540.0 4620.2 4624.7 4647.6 4661.4 5400.7 5403.7 5420.3 5432.0 5465.3 3769.8 3920.8 3921.8 3924.6 3943.9 5634.7 5660.8 5678.3 5695.9 5714.0 3969.8 3970.5 3975.2 3995.2 3997.4 4025.0 4027.3 4030.6 4037.6 4044.9 4448.6 4598.8 4603.1 4623.2 4636.9 5440.3 5446.3 5461.8 5462.7 5489.8 1345.4 1350.5 1355.5 1355.7 1357.2 883.7 896.2 907.8 913.4 914.1 4657.8 4677.2 4678.3 4742.9 4746.0 4904.9 4967.1 4987.4 5000.9 5025.4 4718.8 5026.5 5060.5 5254.9 5299.5 2931.4 2962.6 2968.8 2972.8 2973.2 5585.6 5699.9 5714.3 5725.9 5730.5 5677.5 5685.6 5700.5 5710.3 5721.9 5684.5 5695.1 5698.6 5707.5 5734.4 5351.2 5569.8 5576.8 5603.2 5604.9 5462.7 5497.2 5505.8 5519.9 5533.2 5502.7 5725.5 5732.3 5742.3 5758.0 3942.3 3948.8 3962.5 3966.5 3975.6 5545.8 5550.9 5563.2 5570.7 5582.9 5182.6 5425.9 5446.7 5448.4 5467.3 5485.6 5485.8 5506.5 5514.3 5520.4 5416.2 5442.4 5459.7 5474.0 5476.8 5364.2 5545.2 5564.2 5570.5 5573.2 5407.7 5426.7 5429.8 5431.3 5436.0 13:49:11 INFO - PROCESS | 28333 | 13:49:11 INFO - PROCESS | 28333 | [#5] yui.html Cycles:180 Average:21043.23 Median:4575.12 stddev:31199.91 (681.9%) stddev-sans-first:31250.03 13:49:11 INFO - PROCESS | 28333 | Values: 695.5 748.5 756.6 769.3 811.9 15293.1 16593.7 16611.2 16612.3 16642.6 14905.9 15068.0 15101.5 15110.9 15151.7 666.1 684.5 784.5 811.7 817.2 805.3 810.9 813.0 814.4 814.6 861.2 874.1 874.2 874.7 876.7 701.7 834.7 862.6 864.3 866.9 601.3 602.4 602.5 603.3 608.3 13917.4 14045.4 14061.0 14163.8 14213.1 13953.5 14167.1 14221.0 14237.1 14381.3 11007.9 11324.6 11327.0 12410.3 12679.5 4365.7 4373.5 4485.1 4498.2 4529.8 78446.0 81174.6 81899.0 82596.2 84705.6 10198.3 10385.7 10395.2 10552.2 10672.0 19512.1 19519.3 19551.5 19558.8 19563.0 8158.2 8262.3 8265.1 8283.2 8467.2 4521.6 4532.1 4540.5 4609.8 4614.7 3246.9 3352.1 3352.3 3353.2 3360.5 560.3 576.9 580.5 585.3 591.9 621.5 630.9 699.8 705.5 716.9 9650.7 9902.4 9903.4 10122.2 10249.3 598.4 641.2 667.5 687.3 724.2 4708.0 4780.6 4844.2 4851.2 4899.8 112977.4 114991.0 116316.0 119767.0 120707.0 98395.5 99883.5 100915.5 101815.5 104361.0 90089.1 90099.0 91552.0 91756.5 95358.5 8914.2 8944.5 8970.0 9293.1 9320.9 51307.2 52362.2 53323.7 53364.0 54521.7 74673.6 77732.6 78248.0 79793.0 80925.6 11256.5 11352.9 11444.3 11567.2 11898.2 12860.7 13007.3 13032.8 13267.5 13566.5 12431.4 12458.1 13029.7 13046.0 13110.5 12243.4 12307.4 12356.4 13011.5 13045.8 11431.5 11539.9 11761.5 11836.2 11887.8 9787.4 9813.0 10015.8 10366.9 10438.0 10283.9 10446.5 10462.9 10504.2 10517.9 13:49:11 INFO - PROCESS | 28333 | -------- Summary: end -------- 13:49:11 INFO - PROCESS | 28333 | 13:49:12 INFO - TEST-INFO | 28333: exit 0 13:49:12 INFO - TEST-OK | dromaeo_css | took 1112996ms 13:49:12 INFO - TEST-START | kraken 13:49:12 INFO - operating with platform_type : linux_ 13:49:12 INFO - Initialising browser for kraken test... 13:49:12 INFO - TEST-INFO | started process 28531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6PQlcz/profile http://localhost:59611/getInfo.html) 13:49:16 INFO - PROCESS | 28531 | __metrics Screen width/height:1600/1200 13:49:16 INFO - PROCESS | 28531 | colorDepth:24 13:49:16 INFO - PROCESS | 28531 | Browser inner width/height: 1024/697 13:49:16 INFO - PROCESS | 28531 | __metrics 13:49:16 INFO - PROCESS | 28531 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:49:17 INFO - TEST-INFO | 28531: exit 0 13:49:17 INFO - Browser initialized. 13:49:17 INFO - Running cycle 1/1 for kraken test... 13:49:17 INFO - TEST-INFO | started process 28613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6PQlcz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:29 INFO - PROCESS | 28613 | RSS: Main: 156712960 13:49:29 INFO - PROCESS | 28613 | 13:49:32 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-beat-detection) 13:49:32 INFO - PROCESS | 28613 | RSS: Main: 215195648 13:49:32 INFO - PROCESS | 28613 | 13:49:35 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-dft) 13:49:36 INFO - PROCESS | 28613 | RSS: Main: 203464704 13:49:36 INFO - PROCESS | 28613 | 13:49:39 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-fft) 13:49:39 INFO - PROCESS | 28613 | RSS: Main: 269545472 13:49:39 INFO - PROCESS | 28613 | 13:49:42 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-oscillator) 13:49:42 INFO - PROCESS | 28613 | RSS: Main: 179695616 13:49:42 INFO - PROCESS | 28613 | 13:49:44 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:49:45 INFO - PROCESS | 28613 | RSS: Main: 183730176 13:49:45 INFO - PROCESS | 28613 | 13:49:48 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59611/tests/kraken/driver.html?testName=imaging-darkroom) 13:49:49 INFO - PROCESS | 28613 | RSS: Main: 219955200 13:49:49 INFO - PROCESS | 28613 | 13:49:52 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59611/tests/kraken/driver.html?testName=imaging-desaturate) 13:49:53 INFO - PROCESS | 28613 | RSS: Main: 220954624 13:49:53 INFO - PROCESS | 28613 | 13:49:55 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59611/tests/kraken/driver.html?testName=json-parse-financial) 13:49:56 INFO - PROCESS | 28613 | RSS: Main: 221454336 13:49:56 INFO - PROCESS | 28613 | 13:49:57 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:49:58 INFO - PROCESS | 28613 | RSS: Main: 208498688 13:49:58 INFO - PROCESS | 28613 | 13:50:00 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:50:00 INFO - PROCESS | 28613 | RSS: Main: 211705856 13:50:00 INFO - PROCESS | 28613 | 13:50:02 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:50:03 INFO - PROCESS | 28613 | RSS: Main: 211296256 13:50:03 INFO - PROCESS | 28613 | 13:50:06 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:50:06 INFO - PROCESS | 28613 | RSS: Main: 223997952 13:50:06 INFO - PROCESS | 28613 | 13:50:09 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:50:10 INFO - PROCESS | 28613 | RSS: Main: 224337920 13:50:10 INFO - PROCESS | 28613 | 13:50:11 INFO - PROCESS | 28613 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59611/tests/kraken/driver.html?testName=ai-astar) 13:50:12 INFO - PROCESS | 28613 | RSS: Main: 267034624 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | __start_tp_report 13:50:12 INFO - PROCESS | 28613 | _x_x_mozilla_page_load 13:50:12 INFO - PROCESS | 28613 | _x_x_mozilla_page_load_details 13:50:12 INFO - PROCESS | 28613 | |i|pagename|runs| 13:50:12 INFO - PROCESS | 28613 | |0;ai-astar;102;114;112;110;116;112;113;112;111;112 13:50:12 INFO - PROCESS | 28613 | |1;audio-beat-detection;160;118;119;178;118;121;138;117;154;120 13:50:12 INFO - PROCESS | 28613 | |2;audio-dft;161;160;161;160;161;161;162;162;163;162 13:50:12 INFO - PROCESS | 28613 | |3;audio-fft;76;75;77;130;76;76;75;75;106;75 13:50:12 INFO - PROCESS | 28613 | |4;audio-oscillator;83;83;110;84;84;86;127;84;85;120 13:50:12 INFO - PROCESS | 28613 | |5;imaging-gaussian-blur;119;119;118;116;118;117;118;118;117;117 13:50:12 INFO - PROCESS | 28613 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;146 13:50:12 INFO - PROCESS | 28613 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;98;95 13:50:12 INFO - PROCESS | 28613 | |8;json-parse-financial;52;54;52;53;53;52;52;54;53;53 13:50:12 INFO - PROCESS | 28613 | |9;json-stringify-tinderbox;62;64;63;64;63;63;63;63;64;63 13:50:12 INFO - PROCESS | 28613 | |10;stanford-crypto-aes;81;79;90;75;84;77;75;75;81;80 13:50:12 INFO - PROCESS | 28613 | |11;stanford-crypto-ccm;122;122;128;119;130;119;123;120;171;121 13:50:12 INFO - PROCESS | 28613 | |12;stanford-crypto-pbkdf2;161;160;157;159;159;157;159;164;167;160 13:50:12 INFO - PROCESS | 28613 | |13;stanford-crypto-sha256-iterative;63;63;70;62;65;62;62;62;63;61 13:50:12 INFO - PROCESS | 28613 | __end_tp_report 13:50:12 INFO - PROCESS | 28613 | __start_cc_report 13:50:12 INFO - PROCESS | 28613 | _x_x_mozilla_cycle_collect,1613 13:50:12 INFO - PROCESS | 28613 | __end_cc_report 13:50:12 INFO - PROCESS | 28613 | __startTimestamp1467751812027__endTimestamp 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | ------- Summary: start ------- 13:50:12 INFO - PROCESS | 28613 | Number of tests: 14 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:3.69 (3.3%) stddev-sans-first:1.74 13:50:12 INFO - PROCESS | 28613 | Values: 102.0 114.0 112.0 110.0 116.0 112.0 113.0 112.0 111.0 112.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:129.50 stddev:22.16 (17.1%) stddev-sans-first:21.46 13:50:12 INFO - PROCESS | 28613 | Values: 160.0 118.0 119.0 178.0 118.0 121.0 138.0 117.0 154.0 120.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 13:50:12 INFO - PROCESS | 28613 | Values: 161.0 160.0 161.0 160.0 161.0 161.0 162.0 162.0 163.0 162.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#3] audio-fft Cycles:10 Average:84.10 Median:75.50 stddev:18.75 (24.8%) stddev-sans-first:19.66 13:50:12 INFO - PROCESS | 28613 | Values: 76.0 75.0 77.0 130.0 76.0 76.0 75.0 75.0 106.0 75.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:17.33 (20.6%) stddev-sans-first:17.87 13:50:12 INFO - PROCESS | 28613 | Values: 83.0 83.0 110.0 84.0 84.0 86.0 127.0 84.0 85.0 120.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.88 13:50:12 INFO - PROCESS | 28613 | Values: 119.0 119.0 118.0 116.0 118.0 117.0 118.0 118.0 117.0 117.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 13:50:12 INFO - PROCESS | 28613 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 13:50:12 INFO - PROCESS | 28613 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 98.0 95.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 13:50:12 INFO - PROCESS | 28613 | Values: 52.0 54.0 52.0 53.0 53.0 52.0 52.0 54.0 53.0 53.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 13:50:12 INFO - PROCESS | 28613 | Values: 62.0 64.0 63.0 64.0 63.0 63.0 63.0 63.0 64.0 63.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.50 stddev:4.74 (5.9%) stddev-sans-first:5.00 13:50:12 INFO - PROCESS | 28613 | Values: 81.0 79.0 90.0 75.0 84.0 77.0 75.0 75.0 81.0 80.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:122.50 stddev:15.71 (12.8%) stddev-sans-first:16.54 13:50:12 INFO - PROCESS | 28613 | Values: 122.0 122.0 128.0 119.0 130.0 119.0 123.0 120.0 171.0 121.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.00 stddev:3.09 (1.9%) stddev-sans-first:3.27 13:50:12 INFO - PROCESS | 28613 | Values: 161.0 160.0 157.0 159.0 159.0 157.0 159.0 164.0 167.0 160.0 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - PROCESS | 28613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:2.58 (4.1%) stddev-sans-first:2.74 13:50:12 INFO - PROCESS | 28613 | Values: 63.0 63.0 70.0 62.0 65.0 62.0 62.0 62.0 63.0 61.0 13:50:12 INFO - PROCESS | 28613 | -------- Summary: end -------- 13:50:12 INFO - PROCESS | 28613 | 13:50:12 INFO - TEST-INFO | 28613: exit 0 13:50:12 INFO - TEST-OK | kraken | took 60371ms 13:50:12 INFO - SUITE-END | took 1173s 13:50:13 INFO - Completed test suite (00:19:33) 13:50:13 INFO - javascript benchmark 13:50:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.4689679306116, 3073.9846300768495, 3095.4428202923473, 3114.7508199344056, 3118.844057797111, 5081.237814327853, 5143.511366420194, 5219.92170117448, 5289.391719952207, 5326.733663316833, 5283.8150664726645, 5303.416624171338, 5339.813106541272, 5379.38137114232, 5393.541548968343, 4781.0, 4861.0, 4875.609951203895, 4910.0, 5054.368203974504, 4954.355933728611, 4979.203327467606, 5005.274235235888, 5019.749012549358, 5054.418741844698, 4794.736289504076, 4845.975770121162, 4872.123017856784, 4906.264060390934, 4910.48439913811, 4907.779149938261, 4909.815645241654, 4911.975440122812, 4925.039617274633, 4967.7019378837385, 4885.555296325174, 4888.2178851383605, 4893.804247830082, 4911.926321105187, 4948.554630083309, 5152.92270615941, 5291.047611429941, 5321.308229930084, 5326.227696983916, 5405.648632838892, 5860.267466566679, 5861.0, 5867.237259156283, 5868.2371291732225, 5871.588988770788, 5593.0, 5837.066069428871, 5897.852553686149, 5900.527957763368, 5901.586888917777, 5372.194170874361, 5439.836804895859, 5440.755166017539, 5477.315335583052, 5491.176323551459, 5956.642601443928, 5989.520838332923, 6002.699865006733, 6023.608465449732, 6025.698715064229, 5434.429384914606, 5568.582356323292, 5773.3072031356505, 5778.855528611734, 5780.624259423124, 5726.4273572642405, 5788.739506722208, 5789.334226563999, 5834.445727655866, 5838.328592211865, 5684.8863022739315, 5734.971325143431, 5747.879163563149, 5761.366249712612, 5779.104238842986, 5511.807086751945, 5656.462636049569, 5707.942920570824, 5759.366469688331, 5772.942270577324, 4389.0, 4397.780110994501, 4401.427814384109, 4442.933695913022, 4445.155420470101, 3902.043999220209, 3917.1578110706337, 3931.8623848165175, 3954.9209015820097, 3968.206358728266, 5244.6328756987405, 5279.47205279469, 5345.118055520796, 5417.702026388586, 5425.810096646598, 5777.653340799566, 5791.362950075489, 5795.623284486495, 5796.797112101141, 5830.591858569859, 5439.347278326547, 5442.428545002796, 5444.618876678674, 5449.536789372948, 5450.5639548836, 4851.902961940812, 4932.8766780830765, 4974.726390048582, 4985.152524070917, 5028.899422011539, 5988.221531200916, 5994.1608174855555, 5994.490468310242, 5995.52035837132, 6026.397360263939, 5831.970840145772, 5843.181954526454, 5845.327787304344, 5851.297844258716, 5852.414758524284, 5718.0, 5856.209411729362, 5906.911396329145, 5937.881242375215, 6049.758009679739, 5531.529819965348, 5608.4111168326735, 5628.493435590816, 5631.774729010957, 5708.971455142864, 5625.493705566519, 5648.322201335866, 5673.517750991047, 5680.2047713321, 5687.77248910039, 5472.2065300531995, 5519.31008623922, 5573.080441727069, 5576.275084239185, 5598.916016259678, 5594.496495315441, 5605.635633683961, 5610.186522954067, 5611.971940140274, 5617.129344951539, 5329.20061990689, 5526.115821468546, 5538.972305138448, 5548.334199896039, 5579.8884022320135, 5592.7762889483965, 5641.435856414326, 5666.320041595035, 5721.685307308138, 5757.596968212185, 5575.888482230252, 5582.27430434041, 5586.720663966867, 5586.832395028156, 5591.664500130005], "value": 5303.411035225856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.6024584020386, 631.5642206877254, 639.6545865232774, 647.2879832184594, 650.4503694378249, 31057.223569410777, 34752.30495390091, 34779.47830782537, 34905.3018939621, 42962.57037429625, 45008.54991450084, 45907.54092459074, 46475.0, 46504.767476162655, 46684.53315466845, 8869.379143459977, 9072.455652660861, 9074.001859795417, 9079.137481939206, 9089.272858171364, 8929.687460938836, 9039.32205084618, 9043.728688139367, 9047.411918225327, 9059.139381758723, 9110.0, 9114.544272786366, 9158.816823663523, 9159.404638698497, 9160.954195229015, 9056.637734490612, 9060.501672408014, 9086.81826363469, 9119.544022798833, 9128.45229286245, 9015.459072455673, 9051.049639787794, 9073.09269073094, 9087.182153606207, 9087.863682044775, 42667.786661066806, 42724.78637606823, 42826.143477130594, 42835.57164428347, 42904.57095429037, 3752.061984503874, 3760.0975765816006, 3821.847126114952, 3914.921701565953, 4156.480439945007, 32757.83621081903, 33266.6673333266, 34065.318693626235, 34237.486437703454, 34886.0, 3771.7548359356556, 3778.3954567269107, 3809.7523660961947, 3835.9616403835885, 3889.4749208856724, 352946.0, 353057.0, 353503.0, 355109.0, 355994.0, 55132.724336378866, 55745.0, 55815.44184558102, 55879.0, 55914.72042639761, 55579.94310312971, 57089.0, 58257.70871145617, 58287.46269104428, 64556.677216613614, 14495.275236238145, 14578.708425831424, 14633.487827926185, 14653.853461465249, 14730.852691472948, 10137.64518241858, 11776.52893884252, 11855.703607409883, 11882.643520694393, 11884.346360950058, 15375.61560960985, 15390.769138462932, 15764.369425222863, 15912.52262432129, 15938.123403212934, 5816.749398879261, 5947.345791962881, 5999.970000149971, 6032.185654936615, 6049.516038716892, 955.5604421965835, 1008.3395376028712, 1019.0879163149089, 1041.7812259425605, 1066.088494337346, 32358.0, 32519.0, 32739.508907365933, 33009.83495082557, 33139.0, 1071.935683858971, 1074.6722249713755, 1091.8034753744403, 1124.5108377855495, 1142.8114361130486, 16753.497395078168, 16973.830261697225, 17119.14404279781, 17144.0, 17164.39924602633, 479104.0, 481019.0, 481092.0, 481940.0, 482843.0, 57738.13392799111, 57994.42005579975, 58158.0, 58165.8925812792, 58203.70898145482, 1211.1219365959785, 1321.3261236769317, 1351.5337208662995, 1353.086666500128, 1381.730562540295, 32629.836850815595, 33805.3238935215, 33821.32357352888, 34046.48930266098, 34169.0, 49074.509254906996, 49822.75088624534, 49855.0, 49890.50109499004, 49947.0, 375857.0, 379585.0, 380471.0, 382717.0, 383601.0, 33630.831845841596, 38866.80566597262, 39643.0, 40827.0, 43757.0, 48667.0, 48923.51076489189, 49039.50960490349, 49306.0, 49774.0, 40443.0, 41255.0, 41567.37648935208, 42600.78699606606, 43356.56643433651, 42095.36856947209, 42101.0, 42205.78897105495, 42209.0, 43379.78310108555, 40695.0, 41617.0, 41889.16221675611, 41895.7905210472, 42005.36991945184, 35626.64373356337, 36200.07592255937, 36359.81820090883, 37188.25623487569, 37441.251174975805, 27622.585661214696, 28071.0175143869, 28262.43475130527, 28286.0, 28437.43125137527], "value": 19873.728841454602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.48134333947473, 390.56842189380734, 397.31463225935266, 398.2671883733929, 419.86774166137667, 14529.56411307661, 17899.73150402745, 20192.0, 20258.392248232558, 20276.391708248775, 19488.415347539598, 19583.0, 19691.409257722255, 19754.308599198994, 19861.3048543301, 5585.609007369486, 5684.147377893329, 5782.855428614297, 5790.189373487715, 5844.0, 5757.366689664133, 5800.129980502916, 5826.15520749491, 5864.23764910561, 5864.354920958691, 5582.385937546886, 5762.193292938992, 5781.595288329819, 5796.710164491779, 5798.2172406725185, 5750.741216645261, 5771.595988280822, 5775.335836378828, 5777.508911742507, 5816.709164541756, 4968.751562421864, 5163.974180129113, 5165.199394093884, 5168.715720635363, 5176.0683077046115, 19632.312869049514, 19795.109220084985, 21502.0, 23263.0, 23280.534389312117, 2355.9057637694473, 2415.927522174338, 2906.258903979493, 2973.5391014392803, 3092.3351479431803, 14201.78697319541, 14434.639134021629, 14473.78289325661, 14930.178840163895, 15159.317830697644, 1976.7331410259574, 2007.076744697441, 2007.1068374573322, 2009.2967461388544, 2048.897555122253, 78476.0, 80676.0, 80761.59619201925, 81606.59196703979, 81927.5903620484, 10421.635242766466, 10428.634997775192, 10484.0, 10599.099076578577, 10760.19298552596, 14993.925030374778, 15070.472533461276, 15086.698266034618, 15114.017588856688, 15120.092794432368, 7716.845663086707, 7860.371170306362, 7872.881906771403, 7913.723019694283, 8020.518768873886, 7531.887021694679, 7588.430867684946, 7689.692412303557, 7706.499077560053, 7758.030246219223, 6597.769078082244, 6622.715163268665, 6701.932980670131, 6726.428253598499, 6785.423239024738, 1872.9906350468434, 1879.9812001879807, 1882.002538654488, 1910.3549012667534, 1918.5587314917648, 958.7075941837807, 985.0346660272829, 1033.7312298802365, 1044.5456226541478, 1096.9945150274357, 20049.899750501154, 20330.49173770638, 20598.485037874172, 20643.4839129023, 20723.0, 947.9478628675352, 979.9853002204973, 1001.5042553935848, 1008.505832142245, 1037.123630532199, 10917.781644367227, 11539.596114135966, 11824.349660768741, 11869.525218991317, 11982.58060967862, 465244.0, 469142.0, 471446.0, 472203.0, 474484.0, 80218.0, 90112.5494372524, 91344.54327728318, 100304.0, 103754.0, 1010.2877471382805, 1014.1633152648947, 1023.3143793658267, 1026.8870424253325, 1029.624187171692, 18838.811611883706, 18867.528311792314, 19323.130459129654, 19355.225790968205, 19364.70952935735, 45831.54168458273, 46445.6066318011, 46716.53283467122, 46859.76570117127, 48148.5185148144, 65278.0, 65874.0, 67031.3296867025, 67583.66208168928, 67672.0, 7743.45795794289, 8081.959590202011, 8083.0, 8270.917290827014, 8756.211940925346, 10395.94802025985, 13915.721685566434, 13987.0, 14180.55631184772, 14495.565133046026, 11406.86308769028, 12306.753864922472, 12327.876721232673, 12418.0, 12448.128630995743, 12158.331291779037, 12251.632451026484, 12301.507939682671, 12360.25838449696, 12492.25046497213, 12423.813642795185, 12526.935210507208, 12580.433880475584, 12616.936915315364, 13153.473861045451, 8957.820843583222, 9072.546372681472, 9180.081991800767, 9215.49314787693, 9251.121143491358, 9425.267887833355, 12490.625281241577, 12706.745865082461, 12800.87199128034, 12804.679883003], "value": 9575.542301615165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.5390275111965, 1486.0860570748987, 1550.527089237782, 1726.3439892840718, 1746.8427841494272, 8052.959735201323, 8513.659453621864, 8589.613467393967, 8605.827883442327, 8606.74179774607, 7468.813279668011, 7983.720569780059, 8171.2237337453, 8197.467164634294, 8423.326133909288, 2270.42104263413, 2287.439577303563, 2291.9656205156934, 2296.5062511560013, 2305.9538809223804, 2006.1273346094422, 2240.1263507232193, 2259.186692790594, 2286.2683941138757, 2312.3063081075693, 2191.780821917803, 2240.19353032908, 2259.9435014124615, 2266.1162146762777, 2271.0234599122373, 2230.152542034033, 2245.2141750387477, 2247.4830788918475, 2302.044651469638, 2305.2738387407912, 2253.3577930289953, 2258.164479142711, 2270.7729227077325, 2278.1798552521077, 2282.9200977965693, 8443.113473085361, 8529.786755331104, 8534.18925202111, 8623.223909848144, 8631.43895646781, 4971.801127954877, 5156.226566015091, 5192.870178245536, 5203.427622961472, 5222.268882356473, 3040.3159289159985, 3089.567460555524, 3157.921051973696, 3166.208447888028, 3234.3854667613314, 999.6751055906786, 1006.5369929832286, 1023.1916785739257, 1034.534459493231, 1041.3803786746873, 11406.201565890391, 11459.484323205475, 11520.94239528797, 11525.654230373102, 11545.826812597817, 4412.602865742035, 4430.401895744098, 4513.255312873404, 4523.0275490769645, 4661.766911654404, 9749.025097490194, 9848.113669769611, 9852.704418867446, 9862.654807081717, 9877.555510002067, 5136.332276803992, 5187.403448603383, 5192.5586325162785, 5199.038177937094, 5207.609429292818, 4688.57802797743, 4737.952620473751, 4793.736344501086, 4797.520247975174, 4798.976005119952, 3856.710746693953, 3875.9806200968815, 3901.4147877817986, 3919.1573811630064, 4029.738067025634, 1160.431388619587, 1234.623439850854, 1239.0546841459004, 1284.794432890733, 1293.5537239652306, 746.2798399544465, 936.4240991790136, 939.8167357365248, 976.545906153642, 980.6616717232544, 5731.684757338387, 5782.0, 5808.854778630568, 5817.185594016841, 5908.379620139909, 985.5959056786683, 995.6515219673201, 999.6604549903165, 1002.8395456726888, 1007.8538611901233, 4009.258287216874, 4012.4583181270154, 4020.8190631421658, 4046.959530404717, 4055.7160998730396, 10151.086402223835, 10364.481775911174, 10390.688279351632, 10446.164306855433, 10460.738481538023, 9206.723798286062, 10247.180225581935, 10384.961503849554, 10390.948045259876, 10396.0, 7544.962275188699, 7832.373410127176, 7853.528788272608, 8027.799305017421, 8060.476069055492, 5565.916511252415, 5773.769049238152, 5803.100519419497, 5816.680082595498, 5877.617954832922, 9710.07754263372, 9726.465044422624, 9749.268804839523, 9749.80500389974, 9789.804203916025, 9684.56419461112, 9784.315097943076, 9855.507224638883, 9997.650082247086, 10018.098371146632, 7503.0, 7516.210797866145, 7565.508241964255, 7574.772756817304, 7587.924120758722, 8213.3429325655, 8218.835623287381, 8274.503529788231, 8283.08886022525, 8323.542205178774, 7451.701931922662, 7473.43949203801, 7560.470767046254, 7600.695972161273, 7615.352695020985, 7326.450516211199, 7441.479096463412, 7505.962470187614, 7543.170251272465, 7604.391648668204, 6461.513851814015, 6491.805245842632, 6503.187101612299, 6504.577202481823, 6523.24982627004, 4997.9500204997485, 5028.195488721787, 5112.9744351278005, 5123.359580052494, 5180.9740951295, 5154.278401023785, 5255.421903590525, 5263.605229607718, 5313.920291195713, 5390.245365648734], "value": 4501.560560516508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6494151258153, 333.2202645808808, 342.07127648434505, 345.7458767805664, 348.79944032181504, 5179.378474583051, 5250.264962905197, 5251.448597897223, 5253.264542963988, 5323.121684921984, 5227.477252274771, 5239.1093514102595, 5239.266502689627, 5253.4221235664045, 5258.868528286795, 3854.691624670034, 4121.5672354402805, 4180.47744031996, 4190.539040705536, 4193.496780386358, 4048.412980117896, 4076.001379661987, 4140.130572579762, 4141.834326626931, 4157.129291818678, 4040.939385909214, 4045.5145382554133, 4047.4738284023038, 4049.493813273341, 4066.369712694537, 3871.6709079728116, 3948.8815335539834, 4071.7964101795087, 4076.0, 4080.755154690728, 3580.3197392495345, 3585.64143585642, 3590.7127429805814, 3602.3155600435834, 3609.2961872434885, 4878.975605121987, 5049.873753156164, 5082.847514574569, 5085.74571271435, 5088.185890257578, 4540.0, 4620.214563524209, 4624.745638989854, 4647.60495357895, 4661.417322834645, 5400.702961337125, 5403.7027963462, 5420.34955805302, 5431.972840135813, 5465.262189604392, 3769.8492060317553, 3920.7843568603716, 3921.784301863396, 3924.6271604197555, 3943.881683549498, 5634.690092044936, 5660.773569057233, 5678.261825962599, 5695.914561281584, 5713.971430142864, 3969.761814291152, 3970.4838371011583, 3975.2447035063246, 3995.180987897474, 3997.400389941532, 4024.959750402517, 4027.275090483741, 4030.6372426481757, 4037.5962403759977, 4044.9191016180102, 4448.644108471314, 4598.838545883429, 4603.125406172817, 4623.237165867661, 4636.884077898079, 5440.3471583409455, 5446.264754258124, 5461.836144915659, 5462.7268636568015, 5489.835304940858, 1345.4080204710092, 1350.5340657473157, 1355.4984655677463, 1355.7188456908325, 1357.172125003747, 883.6995421556702, 896.1844721303582, 907.8184363127269, 913.4245425381966, 914.1224424552504, 4657.767111644404, 4677.228257337501, 4678.274867395559, 4742.86571043032, 4746.0, 4904.926426103611, 4967.09424986387, 4987.376577927759, 5000.874978125576, 5025.437027116197, 4718.834840780556, 5026.4973502649445, 5060.493950604984, 5254.92117618236, 5299.5230429261555, 2931.4283714675435, 2962.5704272880744, 2968.807027543246, 2972.836493992808, 2973.241823335079, 5585.58108141891, 5699.943000570024, 5714.314282286152, 5725.942740572625, 5730.484256416942, 5677.545796336283, 5685.630434021776, 5700.486956173964, 5710.314762228559, 5721.914171287434, 5684.488396044293, 5695.117256825281, 5698.629589076697, 5707.514861236758, 5734.394369576526, 5351.224072509543, 5569.805056822992, 5576.804811831566, 5603.2155498231095, 5604.943950560442, 5462.661647896291, 5497.175423686479, 5505.752241149238, 5519.862003449946, 5533.2253484513, 5502.669839809624, 5725.513331366714, 5732.331307962991, 5742.306019724275, 5757.97121014409, 3942.250972315251, 3948.7828169450954, 3962.5443074046852, 3966.5240171179644, 3975.6223158799867, 5545.805896793593, 5550.861228469321, 5563.221149039056, 5570.6657600544095, 5582.86042848932, 5182.585393168612, 5425.945740542544, 5446.673199608036, 5448.4006759257245, 5467.316585426822, 5485.588580856532, 5485.820548582074, 5506.531944784738, 5514.310711161105, 5520.447955204608, 5416.160495123262, 5442.428545002717, 5459.672419654833, 5473.974629386993, 5476.7535460903555, 5364.195370694427, 5545.195946587803, 5564.19319198722, 5570.5265052470995, 5573.164025396223, 5407.675539467487, 5426.67439953604, 5429.782808687766, 5431.321084864392, 5435.972820135874], "value": 4132.606676349523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.5096656856916, 748.4872862089469, 756.648158606248, 769.2653515892322, 811.8822770698247, 15293.08241505509, 16593.668126637476, 16611.169441527934, 16612.335506579722, 16642.58393540162, 14905.850941490582, 15068.0, 15101.471448499306, 15110.924445377785, 15151.712104471106, 666.110742159218, 684.5481981891952, 784.52928243054, 811.7118422959853, 817.1501638296165, 805.3034125481475, 810.9026916769966, 812.995935020327, 814.4136221920209, 814.5601375257384, 861.2248975921658, 874.1302404107921, 874.1695389380114, 874.7026011156206, 876.701921346742, 701.7263267325746, 834.7120243516008, 862.633380813155, 864.3430992445724, 866.9133086691344, 601.2604496469323, 602.4276936909953, 602.4668168670757, 603.2790814976105, 608.2883026858586, 13917.443302267897, 14045.367958441895, 14061.0, 14163.78754318686, 14213.076150050214, 13953.511627093105, 14167.14997100167, 14221.0, 14237.145771253758, 14381.280935953266, 11007.889921100767, 11324.6036388726, 11327.037201837853, 12410.317432541207, 12679.492820287178, 4365.672574556889, 4373.518912919576, 4485.102979404132, 4498.167838949772, 4529.84145554904, 78446.0, 81174.59412702957, 81899.0, 82596.17403825944, 84705.57647211786, 10198.286119971532, 10385.740356490996, 10395.16838652906, 10552.15582753378, 10672.039516443558, 19512.12195451208, 19519.31682391138, 19551.511212219808, 19558.80441195598, 19563.0, 8158.224968627971, 8262.297704695047, 8265.132161122996, 8283.17168283179, 8467.237948584658, 4521.59305662492, 4532.116237333754, 4540.455145382575, 4609.792559334838, 4614.653900957442, 3246.935061298761, 3352.0781785009317, 3352.2792599591203, 3353.228757385815, 3360.5295258663805, 560.3276068717555, 576.9336526299445, 580.451473357673, 585.3268740947944, 591.8875413671389, 621.4686443091182, 630.9400606942334, 699.8235487633456, 705.5096707788038, 716.9032180655649, 9650.662226822027, 9902.356346837432, 9903.356281841658, 10122.190224782, 10249.282550221562, 598.374698440131, 641.2337256977867, 667.4827009068011, 687.3126873126873, 724.2033762860812, 4707.964247865464, 4780.641451891052, 4844.176489996709, 4851.151048566487, 4899.804007839718, 112977.4351128239, 114991.0, 116316.0, 119767.0, 120707.0, 98395.50802246087, 99883.50058249808, 100915.49542252242, 101815.49092254639, 104361.0, 90089.09910900806, 90099.0, 91552.0, 91756.54121729483, 95358.5232073849, 8914.242289405473, 8944.463332200088, 8970.026594149276, 9293.117153870371, 9320.860187097334, 51307.2303915449, 52362.21456678229, 53323.733381332844, 53364.0, 54521.72739136279, 74673.62663186649, 77732.61133694295, 78248.0, 79793.0, 80925.59537202277, 11256.549738010388, 11352.886471135183, 11444.256123351955, 11567.190296679151, 11898.22661526998, 12860.742785144057, 13007.284599346749, 13032.804507932198, 13267.535636252685, 13566.457341706222, 12431.37843107859, 12458.127931044739, 13029.674258143623, 13046.0, 13110.475580976654, 12243.449044793184, 12307.446164922421, 12356.3821808911, 13011.479540818262, 13045.804312935124, 11431.485583148944, 11539.942300288445, 11761.47073381717, 11836.230645008047, 11887.82168267494, 9787.434010558276, 9812.950935245279, 10015.849762253427, 10366.948165259126, 10438.0, 10283.897161028293, 10446.52990615409, 10462.947685261524, 10504.159667226451, 10517.9474102629], "value": 7368.459563805774, "unit": "score"}], "name": "dromaeo_css", "value": 7191.754616157836, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 112.0, 110.0, 116.0, 112.0, 113.0, 112.0, 111.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 118.0, 119.0, 178.0, 118.0, 121.0, 138.0, 117.0, 154.0, 120.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 130.0, 76.0, 76.0, 75.0, 75.0, 106.0, 75.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 84.0, 84.0, 86.0, 127.0, 84.0, 85.0, 120.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 116.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 53.0, 53.0, 52.0, 52.0, 54.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 90.0, 75.0, 84.0, 77.0, 75.0, 75.0, 81.0, 80.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 128.0, 119.0, 130.0, 119.0, 123.0, 120.0, 171.0, 121.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 157.0, 159.0, 159.0, 157.0, 159.0, 164.0, 167.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 70.0, 62.0, 65.0, 62.0, 62.0, 62.0, 63.0, 61.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1491.6, "alertThreshold": 2.0}]} 13:50:13 INFO - Return code: 0 13:50:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:50:13 INFO - # TBPL SUCCESS # 13:50:13 INFO - Running post-action listener: _resource_record_post_action 13:50:13 INFO - ##### 13:50:13 INFO - ##### Finished run-tests step (success) 13:50:13 INFO - ##### 13:50:13 INFO - Running post-run listener: _resource_record_post_run 13:50:13 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559730688; Read time: 12; Write time: 516440 13:50:13 INFO - TinderboxPrint: CPU usage
13.0% 13:50:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:50:13 INFO - TinderboxPrint: I/O write bytes / time
559,730,688 / 516,440 13:50:13 INFO - TinderboxPrint: CPU idle
8,269.4 (87.0%) 13:50:13 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 13:50:13 INFO - TinderboxPrint: Swap in / out
0 / 0 13:50:13 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260616192; Read time: 0; Write time: 307596 13:50:13 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298627072; Read time: 0; Write time: 208844 13:50:13 INFO - Running post-run listener: _upload_blobber_files 13:50:13 INFO - Blob upload gear active. 13:50:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:50:13 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 13:50:13 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'] 13:50:13 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 13:50:14 INFO - (blobuploader) - INFO - Open directory for files ... 13:50:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:50:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:17 INFO - (blobuploader) - INFO - Done attempting. 13:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:18 INFO - (blobuploader) - INFO - Done attempting. 13:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:19 INFO - (blobuploader) - INFO - Done attempting. 13:50:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:50:19 INFO - Return code: 0 13:50:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:50:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:50:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1fb3cebf9c6608b7c9caed2e3fdf362dffc3a6ef2e5ba90cb696267fc28d743a0f31fb913cecd40167a1d468e5a06ae76b966ee179b2c8c2191a9c9d88fa93f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0ef2ead58376937b94f14adc7f607726223c4fdc215e599e1de272b00ff72ec1980003d57ce4af09f41c331ed573256d80ade72410de94e01d3f9c8a342ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcae5dc5447a9f9e51ca0f988cc04b37ca453f88efa61e2a0a5cb5d9a4a1096e2602c1658782a85233cb239d82e6d1b7dd133338ab852bc2cf3c820b2323bc42"} 13:50:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:50:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:50:19 INFO - Contents: 13:50:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1fb3cebf9c6608b7c9caed2e3fdf362dffc3a6ef2e5ba90cb696267fc28d743a0f31fb913cecd40167a1d468e5a06ae76b966ee179b2c8c2191a9c9d88fa93f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0ef2ead58376937b94f14adc7f607726223c4fdc215e599e1de272b00ff72ec1980003d57ce4af09f41c331ed573256d80ade72410de94e01d3f9c8a342ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcae5dc5447a9f9e51ca0f988cc04b37ca453f88efa61e2a0a5cb5d9a4a1096e2602c1658782a85233cb239d82e6d1b7dd133338ab852bc2cf3c820b2323bc42"} 13:50:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:50:19 INFO - Copying logs to upload dir... 13:50:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:50:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.759554 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-05 13:50:18.233435) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 13:50:18.236505) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724 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/1fb3cebf9c6608b7c9caed2e3fdf362dffc3a6ef2e5ba90cb696267fc28d743a0f31fb913cecd40167a1d468e5a06ae76b966ee179b2c8c2191a9c9d88fa93f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0ef2ead58376937b94f14adc7f607726223c4fdc215e599e1de272b00ff72ec1980003d57ce4af09f41c331ed573256d80ade72410de94e01d3f9c8a342ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcae5dc5447a9f9e51ca0f988cc04b37ca453f88efa61e2a0a5cb5d9a4a1096e2602c1658782a85233cb239d82e6d1b7dd133338ab852bc2cf3c820b2323bc42"} build_url:https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/ZparE9BCTUa3ba-nG8n_aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1fb3cebf9c6608b7c9caed2e3fdf362dffc3a6ef2e5ba90cb696267fc28d743a0f31fb913cecd40167a1d468e5a06ae76b966ee179b2c8c2191a9c9d88fa93f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0ef2ead58376937b94f14adc7f607726223c4fdc215e599e1de272b00ff72ec1980003d57ce4af09f41c331ed573256d80ade72410de94e01d3f9c8a342ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcae5dc5447a9f9e51ca0f988cc04b37ca453f88efa61e2a0a5cb5d9a4a1096e2602c1658782a85233cb239d82e6d1b7dd133338ab852bc2cf3c820b2323bc42"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 13:50:18.261825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:50:18.262128) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467750588.607632-718571724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 13:50:18.348252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 13:50:18.348566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 13:50:18.348862) ========= ========= Total master_lag: 0.17 =========