builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1468348481.83 results: success (0) buildid: 20160712083048 builduid: 878112a755694e2b9f71f526d192d5c8 revision: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:41.833104) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:41.834297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:41.835006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:41.851122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:41.851772) ========= 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=41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 11:34:42-- 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% 90.9M=0s 2016-07-12 11:34:42 (90.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.004587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.005361) ========= 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=41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.055207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.055629) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7ebc6c9a418eeafa7fbb22fce71707e99615db33 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7ebc6c9a418eeafa7fbb22fce71707e99615db33 --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=41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 11:34:42,405 truncating revision to first 12 chars 2016-07-12 11:34:42,405 Setting DEBUG logging. 2016-07-12 11:34:42,405 attempt 1/10 2016-07-12 11:34:42,405 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7ebc6c9a418e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 11:34:42,704 unpacking tar archive at: fx-team-7ebc6c9a418e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.689438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.689803) ========= script_repo_revision: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.690279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.690595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 11:34:42.700800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-12 11:34:42.701115) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:34:43 INFO - MultiFileLogger online at 20160712 11:34:43 in /builds/slave/test 11:34:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:34:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:34:43 INFO - {'append_to_log': False, 11:34:43 INFO - 'base_work_dir': '/builds/slave/test', 11:34:43 INFO - 'blob_upload_branch': 'Fx-Team', 11:34:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:34:43 INFO - 'branch': 'Fx-Team', 11:34:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:34:43 INFO - 'config_files': ('talos/linux_config.py',), 11:34:43 INFO - 'default_actions': ('clobber', 11:34:43 INFO - 'read-buildbot-config', 11:34:43 INFO - 'download-and-extract', 11:34:43 INFO - 'populate-webroot', 11:34:43 INFO - 'create-virtualenv', 11:34:43 INFO - 'install', 11:34:43 INFO - 'run-tests'), 11:34:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:34:43 INFO - 'download_minidump_stackwalk': True, 11:34:43 INFO - 'download_symbols': 'ondemand', 11:34:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:34:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:34:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:34:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:34:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:34:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:34:43 INFO - 'installer_path': 'installer.exe', 11:34:43 INFO - 'log_level': 'info', 11:34:43 INFO - 'log_name': 'talos', 11:34:43 INFO - 'log_to_console': True, 11:34:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:34:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:34:43 INFO - 'opt_config_files': (), 11:34:43 INFO - 'pip_index': False, 11:34:43 INFO - 'sps_profile': False, 11:34:43 INFO - 'sps_profile_interval': 0, 11:34:43 INFO - 'suite': 'dromaeojs', 11:34:43 INFO - 'system_bits': '32', 11:34:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:34:43 INFO - 'title': 'talos-linux64-ix-026', 11:34:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:34:43 INFO - 'use_talos_json': True, 11:34:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:34:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:34:43 INFO - 'work_dir': 'build'} 11:34:43 INFO - ##### 11:34:43 INFO - ##### Running clobber step. 11:34:43 INFO - ##### 11:34:43 INFO - Running pre-action listener: _resource_record_pre_action 11:34:43 INFO - Running main action method: clobber 11:34:43 INFO - rmtree: /builds/slave/test/build 11:34:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:34:43 INFO - Running post-action listener: _resource_record_post_action 11:34:43 INFO - ##### 11:34:43 INFO - ##### Finished clobber step (success) 11:34:43 INFO - ##### 11:34:43 INFO - ##### 11:34:43 INFO - ##### Running read-buildbot-config step. 11:34:43 INFO - ##### 11:34:43 INFO - Running pre-action listener: _resource_record_pre_action 11:34:43 INFO - Running main action method: read_buildbot_config 11:34:43 INFO - Using buildbot properties: 11:34:43 INFO - { 11:34:43 INFO - "project": "", 11:34:43 INFO - "product": "firefox", 11:34:43 INFO - "script_repo_revision": "production", 11:34:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:34:43 INFO - "repository": "", 11:34:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:34:43 INFO - "buildid": "20160712083048", 11:34:43 INFO - "pgo_build": "True", 11:34:43 INFO - "basedir": "/builds/slave/test", 11:34:43 INFO - "buildnumber": 895, 11:34:43 INFO - "slavename": "talos-linux64-ix-026", 11:34:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:34:43 INFO - "platform": "ubuntu64_hw", 11:34:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:34:43 INFO - "branch": "fx-team", 11:34:43 INFO - "repo_path": "integration/fx-team", 11:34:43 INFO - "revision": "7ebc6c9a418eeafa7fbb22fce71707e99615db33", 11:34:43 INFO - "stage_platform": "linux64-pgo", 11:34:43 INFO - "builduid": "878112a755694e2b9f71f526d192d5c8", 11:34:43 INFO - "slavebuilddir": "test" 11:34:43 INFO - } 11:34:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:34:43 INFO - Running post-action listener: _resource_record_post_action 11:34:43 INFO - ##### 11:34:43 INFO - ##### Finished read-buildbot-config step (success) 11:34:43 INFO - ##### 11:34:43 INFO - ##### 11:34:43 INFO - ##### Running download-and-extract step. 11:34:43 INFO - ##### 11:34:43 INFO - Running pre-action listener: _resource_record_pre_action 11:34:43 INFO - Running main action method: download_and_extract 11:34:43 INFO - mkdir: /builds/slave/test/build/tests 11:34:43 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')]} 11:34:43 INFO - https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:34:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:34:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:34:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:44 INFO - Downloaded 1361 bytes. 11:34:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:34:44 INFO - Using the following test package requirements: 11:34:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:34:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:34:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:34:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'jsshell-linux-x86_64.zip'], 11:34:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:34:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:34:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:34:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:34:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:34:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:34:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:34:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:44 INFO - https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:45 INFO - Downloaded 24320892 bytes. 11:34:45 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'] 11:34:45 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 11:34:46 INFO - Return code: 0 11:34:46 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 11:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:46 INFO - https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:34:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:34:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:34:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:47 INFO - Downloaded 24320892 bytes. 11:34:47 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'] 11:34:47 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 11:34:49 INFO - Return code: 0 11:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:49 INFO - https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:34:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:34:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:34:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:50 INFO - Downloaded 14403317 bytes. 11:34:50 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'] 11:34:50 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 11:34:50 INFO - Return code: 0 11:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:50 INFO - https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:34:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:34:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:34:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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 11:34:51 INFO - Downloaded 60509373 bytes. 11:34:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:34:51 INFO - mkdir: /builds/slave/test/properties 11:34:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:34:51 INFO - Writing to file /builds/slave/test/properties/build_url 11:34:51 INFO - Contents: 11:34:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:34:52 INFO - Running post-action listener: _resource_record_post_action 11:34:52 INFO - Running post-action listener: set_extra_try_arguments 11:34:52 INFO - ##### 11:34:52 INFO - ##### Finished download-and-extract step (success) 11:34:52 INFO - ##### 11:34:52 INFO - ##### 11:34:52 INFO - ##### Running populate-webroot step. 11:34:52 INFO - ##### 11:34:52 INFO - Running pre-action listener: _resource_record_pre_action 11:34:52 INFO - Running main action method: populate_webroot 11:34:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:34:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:34:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:34:52 INFO - '--tppagecycles', 11:34:52 INFO - '7'], 11:34:52 INFO - 'tests': ['tsvgm']}}, 11:34:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:34:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:34:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:34:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:34:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['damp', 'tps']}, 11:34:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'tests': ['damp', 'tps']}, 11:34:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['dromaeo_dom']}, 11:34:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:34:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['basic_compositor_video']}, 11:34:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:34:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['a11yr', 11:34:52 INFO - 'ts_paint', 11:34:52 INFO - 'tpaint', 11:34:52 INFO - 'sessionrestore', 11:34:52 INFO - 'sessionrestore_no_auto_restore', 11:34:52 INFO - 'tabpaint']}, 11:34:52 INFO - 'other-e10s': {'tests': ['a11yr', 11:34:52 INFO - 'ts_paint', 11:34:52 INFO - 'tpaint', 11:34:52 INFO - 'sessionrestore', 11:34:52 INFO - 'sessionrestore_no_auto_restore', 11:34:52 INFO - 'tabpaint']}, 11:34:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:34:52 INFO - 'ts_paint', 11:34:52 INFO - 'tpaint', 11:34:52 INFO - 'sessionrestore', 11:34:52 INFO - 'sessionrestore_no_auto_restore', 11:34:52 INFO - 'tabpaint']}, 11:34:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:34:52 INFO - 'ts_paint', 11:34:52 INFO - 'tpaint', 11:34:52 INFO - 'sessionrestore', 11:34:52 INFO - 'sessionrestore_no_auto_restore', 11:34:52 INFO - 'tabpaint']}, 11:34:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['a11yr', 11:34:52 INFO - 'ts_paint', 11:34:52 INFO - 'tpaint', 11:34:52 INFO - 'sessionrestore', 11:34:52 INFO - 'sessionrestore_no_auto_restore', 11:34:52 INFO - 'tabpaint']}, 11:34:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['a11yr', 11:34:52 INFO - 'ts_paint', 11:34:52 INFO - 'tpaint', 11:34:52 INFO - 'sessionrestore', 11:34:52 INFO - 'sessionrestore_no_auto_restore', 11:34:52 INFO - 'tabpaint']}, 11:34:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['tsvgx', 11:34:52 INFO - 'tsvgr_opacity', 11:34:52 INFO - 'tart', 11:34:52 INFO - 'tscrollx', 11:34:52 INFO - 'cart']}, 11:34:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:34:52 INFO - 'tsvgr_opacity', 11:34:52 INFO - 'tart', 11:34:52 INFO - 'tscrollx', 11:34:52 INFO - 'cart']}, 11:34:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'talos_options': ['--disable-e10s'], 11:34:52 INFO - 'tests': ['tp5o']}, 11:34:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'tests': ['tp5o']}, 11:34:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'talos_options': ['--disable-e10s', 11:34:52 INFO - '--xperf_path', 11:34:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:52 INFO - 'tests': ['tp5n']}, 11:34:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:34:52 INFO - 'talos_options': ['--xperf_path', 11:34:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:52 INFO - 'tests': ['tp5n']}}, 11:34:52 INFO - 'talos.zip': {'path': '', 11:34:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:34:52 INFO - Running post-action listener: _resource_record_post_action 11:34:52 INFO - ##### 11:34:52 INFO - ##### Finished populate-webroot step (success) 11:34:52 INFO - ##### 11:34:52 INFO - ##### 11:34:52 INFO - ##### Running create-virtualenv step. 11:34:52 INFO - ##### 11:34:52 INFO - Running pre-action listener: _resource_record_pre_action 11:34:52 INFO - Running main action method: create_virtualenv 11:34:52 INFO - Creating virtualenv /builds/slave/test/build/venv 11:34:52 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 11:34:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:34:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:34:52 INFO - Using real prefix '/usr' 11:34:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:34:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:34:55 INFO - Installing pip.................done. 11:34:55 INFO - Return code: 0 11:34:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:55 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:34:55 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 11:34:55 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 11:34:55 INFO - Using env: {'DISPLAY': ':0', 11:34:55 INFO - 'HOME': '/home/cltbld', 11:34:55 INFO - 'LANG': 'en_US.UTF-8', 11:34:55 INFO - 'LANGUAGE': 'en_US:en', 11:34:55 INFO - 'LOGNAME': 'cltbld', 11:34:55 INFO - 'MAIL': '/var/mail/cltbld', 11:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:55 INFO - 'MOZ_NO_REMOTE': '1', 11:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:55 INFO - 'NO_EM_RESTART': '1', 11:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:55 INFO - 'PWD': '/builds/slave/test', 11:34:55 INFO - 'SHELL': '/bin/bash', 11:34:55 INFO - 'SHLVL': '1', 11:34:55 INFO - 'TERM': 'linux', 11:34:55 INFO - 'TMOUT': '86400', 11:34:55 INFO - 'USER': 'cltbld', 11:34:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:55 INFO - '_': '/tools/buildbot/bin/python'} 11:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:55 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 11:34:55 INFO - Cleaning up... 11:34:55 INFO - Return code: 0 11:34:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:55 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:34:55 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 11:34:55 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 11:34:55 INFO - Using env: {'DISPLAY': ':0', 11:34:55 INFO - 'HOME': '/home/cltbld', 11:34:55 INFO - 'LANG': 'en_US.UTF-8', 11:34:55 INFO - 'LANGUAGE': 'en_US:en', 11:34:55 INFO - 'LOGNAME': 'cltbld', 11:34:55 INFO - 'MAIL': '/var/mail/cltbld', 11:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:55 INFO - 'MOZ_NO_REMOTE': '1', 11:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:55 INFO - 'NO_EM_RESTART': '1', 11:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:55 INFO - 'PWD': '/builds/slave/test', 11:34:55 INFO - 'SHELL': '/bin/bash', 11:34:55 INFO - 'SHLVL': '1', 11:34:55 INFO - 'TERM': 'linux', 11:34:55 INFO - 'TMOUT': '86400', 11:34:55 INFO - 'USER': 'cltbld', 11:34:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:55 INFO - '_': '/tools/buildbot/bin/python'} 11:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:55 INFO - Downloading/unpacking psutil>=3.1.1 11:34:55 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 11:34:55 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 11:34:55 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 11:34:55 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 11:34:55 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 11:34:55 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 11:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:34:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:57 INFO - Installing collected packages: psutil 11:34:57 INFO - Running setup.py install for psutil 11:34:57 INFO - building 'psutil._psutil_linux' extension 11:34:57 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 11:34:57 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 11:34:57 INFO - building 'psutil._psutil_posix' extension 11:34:57 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 11:34:57 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 11:34:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:58 INFO - Successfully installed psutil 11:34:58 INFO - Cleaning up... 11:34:58 INFO - Return code: 0 11:34:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:34:58 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')]} 11:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:58 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')]} 11:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:34:58 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:34:58 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 11:34:58 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 11:34:58 INFO - Using env: {'DISPLAY': ':0', 11:34:58 INFO - 'HOME': '/home/cltbld', 11:34:58 INFO - 'LANG': 'en_US.UTF-8', 11:34:58 INFO - 'LANGUAGE': 'en_US:en', 11:34:58 INFO - 'LOGNAME': 'cltbld', 11:34:58 INFO - 'MAIL': '/var/mail/cltbld', 11:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:58 INFO - 'MOZ_NO_REMOTE': '1', 11:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:58 INFO - 'NO_EM_RESTART': '1', 11:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:58 INFO - 'PWD': '/builds/slave/test', 11:34:58 INFO - 'SHELL': '/bin/bash', 11:34:58 INFO - 'SHLVL': '1', 11:34:58 INFO - 'TERM': 'linux', 11:34:58 INFO - 'TMOUT': '86400', 11:34:58 INFO - 'USER': 'cltbld', 11:34:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:58 INFO - '_': '/tools/buildbot/bin/python'} 11:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:35:00 INFO - Installing collected packages: mozsystemmonitor 11:35:00 INFO - Running setup.py install for mozsystemmonitor 11:35:00 INFO - Successfully installed mozsystemmonitor 11:35:00 INFO - Cleaning up... 11:35:00 INFO - Return code: 0 11:35:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:35:00 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')]} 11:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:00 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')]} 11:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:00 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:35:00 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 11:35:00 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 11:35:00 INFO - Using env: {'DISPLAY': ':0', 11:35:00 INFO - 'HOME': '/home/cltbld', 11:35:00 INFO - 'LANG': 'en_US.UTF-8', 11:35:00 INFO - 'LANGUAGE': 'en_US:en', 11:35:00 INFO - 'LOGNAME': 'cltbld', 11:35:00 INFO - 'MAIL': '/var/mail/cltbld', 11:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:00 INFO - 'MOZ_NO_REMOTE': '1', 11:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:00 INFO - 'NO_EM_RESTART': '1', 11:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:00 INFO - 'PWD': '/builds/slave/test', 11:35:00 INFO - 'SHELL': '/bin/bash', 11:35:00 INFO - 'SHLVL': '1', 11:35:00 INFO - 'TERM': 'linux', 11:35:00 INFO - 'TMOUT': '86400', 11:35:00 INFO - 'USER': 'cltbld', 11:35:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:00 INFO - '_': '/tools/buildbot/bin/python'} 11:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:00 INFO - Downloading/unpacking jsonschema==2.5.1 11:35:00 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 11:35:00 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 11:35:00 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 11:35:00 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 11:35:00 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 11:35:00 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 11:35:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:35:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:35:02 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 11:35:02 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 11:35:02 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 11:35:02 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 11:35:02 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 11:35:02 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 11:35:02 INFO - Downloading functools32-3.2.3-2.tar.gz 11:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:35:02 INFO - warning: no files found matching '*.txt' 11:35:02 INFO - no previously-included directories found matching 'build' 11:35:02 INFO - no previously-included directories found matching 'dist' 11:35:02 INFO - no previously-included directories found matching '.git*' 11:35:02 INFO - Installing collected packages: jsonschema, functools32 11:35:02 INFO - Running setup.py install for functools32 11:35:02 INFO - warning: no files found matching '*.txt' 11:35:02 INFO - no previously-included directories found matching 'build' 11:35:02 INFO - no previously-included directories found matching 'dist' 11:35:02 INFO - no previously-included directories found matching '.git*' 11:35:02 INFO - Successfully installed jsonschema functools32 11:35:02 INFO - Cleaning up... 11:35:02 INFO - Return code: 0 11:35:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:35: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')]} 11:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35: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')]} 11:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35: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', '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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:35: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 blobuploader==1.2.4 11:35:02 INFO - Using env: {'DISPLAY': ':0', 11:35:02 INFO - 'HOME': '/home/cltbld', 11:35:02 INFO - 'LANG': 'en_US.UTF-8', 11:35:02 INFO - 'LANGUAGE': 'en_US:en', 11:35:02 INFO - 'LOGNAME': 'cltbld', 11:35:02 INFO - 'MAIL': '/var/mail/cltbld', 11:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:02 INFO - 'MOZ_NO_REMOTE': '1', 11:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:02 INFO - 'NO_EM_RESTART': '1', 11:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:02 INFO - 'PWD': '/builds/slave/test', 11:35:02 INFO - 'SHELL': '/bin/bash', 11:35:02 INFO - 'SHLVL': '1', 11:35:02 INFO - 'TERM': 'linux', 11:35:02 INFO - 'TMOUT': '86400', 11:35:02 INFO - 'USER': 'cltbld', 11:35:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:02 INFO - '_': '/tools/buildbot/bin/python'} 11:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:35:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:35:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35: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 11:35:05 INFO - Downloading docopt-0.6.1.tar.gz 11:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:35:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:35:05 INFO - Running setup.py install for blobuploader 11:35:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:35:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:35:05 INFO - Running setup.py install for requests 11:35:06 INFO - Running setup.py install for docopt 11:35:06 INFO - Successfully installed blobuploader requests docopt 11:35:06 INFO - Cleaning up... 11:35:06 INFO - Return code: 0 11:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35:06 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')]} 11:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:06 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')]} 11:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:06 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:35:06 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 11:35:06 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 11:35:06 INFO - Using env: {'DISPLAY': ':0', 11:35:06 INFO - 'HOME': '/home/cltbld', 11:35:06 INFO - 'LANG': 'en_US.UTF-8', 11:35:06 INFO - 'LANGUAGE': 'en_US:en', 11:35:06 INFO - 'LOGNAME': 'cltbld', 11:35:06 INFO - 'MAIL': '/var/mail/cltbld', 11:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:06 INFO - 'MOZ_NO_REMOTE': '1', 11:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:06 INFO - 'NO_EM_RESTART': '1', 11:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:06 INFO - 'PWD': '/builds/slave/test', 11:35:06 INFO - 'SHELL': '/bin/bash', 11:35:06 INFO - 'SHLVL': '1', 11:35:06 INFO - 'TERM': 'linux', 11:35:06 INFO - 'TMOUT': '86400', 11:35:06 INFO - 'USER': 'cltbld', 11:35:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:06 INFO - '_': '/tools/buildbot/bin/python'} 11:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:35:06 INFO - Running setup.py (path:/tmp/pip-WfAxHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:35:06 INFO - Running setup.py (path:/tmp/pip-G5eIK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:35:06 INFO - Running setup.py (path:/tmp/pip-FYmbP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:35:06 INFO - Running setup.py (path:/tmp/pip-22faqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:35:06 INFO - Running setup.py (path:/tmp/pip-6NihgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:35:06 INFO - Running setup.py (path:/tmp/pip-O_hdap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:35:07 INFO - Running setup.py (path:/tmp/pip-vxgjE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:35:07 INFO - Running setup.py (path:/tmp/pip-TN_k49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:35:07 INFO - Running setup.py (path:/tmp/pip-4lafdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:35:07 INFO - Running setup.py (path:/tmp/pip-lpwZfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:35:07 INFO - Running setup.py (path:/tmp/pip-ZGUW6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:35:07 INFO - Running setup.py (path:/tmp/pip-PPKG3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:35:07 INFO - Running setup.py (path:/tmp/pip-UTnvtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:35:07 INFO - Running setup.py (path:/tmp/pip-Z4CnVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:07 INFO - Running setup.py (path:/tmp/pip-YUjpBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:35:07 INFO - Running setup.py (path:/tmp/pip-srZtid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:35:07 INFO - Running setup.py (path:/tmp/pip-tOdhrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:35:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:35:07 INFO - Running setup.py install for manifestparser 11:35:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:35:07 INFO - Running setup.py install for mozcrash 11:35:08 INFO - Running setup.py install for mozdebug 11:35:08 INFO - Running setup.py install for mozdevice 11:35:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Running setup.py install for mozfile 11:35:08 INFO - Running setup.py install for mozhttpd 11:35:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Running setup.py install for mozinfo 11:35:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Running setup.py install for mozInstall 11:35:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Running setup.py install for mozleak 11:35:08 INFO - Running setup.py install for mozlog 11:35:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:35:08 INFO - Running setup.py install for moznetwork 11:35:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:35:09 INFO - Running setup.py install for mozprocess 11:35:09 INFO - Running setup.py install for mozprofile 11:35:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:35:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:35:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:35:09 INFO - Running setup.py install for mozrunner 11:35:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:35:09 INFO - Running setup.py install for mozscreenshot 11:35:09 INFO - Running setup.py install for moztest 11:35:09 INFO - Running setup.py install for mozversion 11:35:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:35:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:35:09 INFO - Cleaning up... 11:35:09 INFO - Return code: 0 11:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:09 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:35:09 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 11:35:09 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 11:35:09 INFO - Using env: {'DISPLAY': ':0', 11:35:09 INFO - 'HOME': '/home/cltbld', 11:35:09 INFO - 'LANG': 'en_US.UTF-8', 11:35:09 INFO - 'LANGUAGE': 'en_US:en', 11:35:09 INFO - 'LOGNAME': 'cltbld', 11:35:09 INFO - 'MAIL': '/var/mail/cltbld', 11:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:09 INFO - 'MOZ_NO_REMOTE': '1', 11:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:09 INFO - 'NO_EM_RESTART': '1', 11:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:09 INFO - 'PWD': '/builds/slave/test', 11:35:09 INFO - 'SHELL': '/bin/bash', 11:35:09 INFO - 'SHLVL': '1', 11:35:09 INFO - 'TERM': 'linux', 11:35:09 INFO - 'TMOUT': '86400', 11:35:09 INFO - 'USER': 'cltbld', 11:35:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:09 INFO - '_': '/tools/buildbot/bin/python'} 11:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:35:09 INFO - Running setup.py (path:/tmp/pip-8r7Gf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:35:09 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)) 11:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:35:09 INFO - Running setup.py (path:/tmp/pip-hxu02m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:35:10 INFO - Running setup.py (path:/tmp/pip-CVWwQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:35:10 INFO - Running setup.py (path:/tmp/pip-Ox7ivR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:35:10 INFO - Running setup.py (path:/tmp/pip-SueaKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:35:10 INFO - Running setup.py (path:/tmp/pip-qLanJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:35:10 INFO - Running setup.py (path:/tmp/pip-XMdatf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:35:10 INFO - Running setup.py (path:/tmp/pip-JkcPaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:35:10 INFO - Running setup.py (path:/tmp/pip-85Srhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:35:10 INFO - Running setup.py (path:/tmp/pip-rHLQvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:35:10 INFO - Running setup.py (path:/tmp/pip-Bur1La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:35:10 INFO - Running setup.py (path:/tmp/pip-YVw7ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:35:10 INFO - Running setup.py (path:/tmp/pip-vowY8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:35:10 INFO - Running setup.py (path:/tmp/pip-U0tXvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:10 INFO - Running setup.py (path:/tmp/pip-EkI0m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:35:10 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)) 11:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:35:10 INFO - Running setup.py (path:/tmp/pip-T8btfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:35:11 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)) 11:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:35:11 INFO - Running setup.py (path:/tmp/pip-JplcWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:35:11 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)) 11:35:11 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)) 11:35:11 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)) 11:35:11 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)) 11:35:11 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)) 11:35:11 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)) 11:35:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:35:11 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 11:35:11 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 11:35:11 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 11:35:11 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 11:35:11 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 11:35:11 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 11:35:12 INFO - Downloading blessings-1.6.tar.gz 11:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:35:13 INFO - Installing collected packages: blessings 11:35:13 INFO - Running setup.py install for blessings 11:35:13 INFO - Successfully installed blessings 11:35:13 INFO - Cleaning up... 11:35:13 INFO - Return code: 0 11:35:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:35:13 INFO - Reading from file tmpfile_stdout 11:35:13 INFO - Current package versions: 11:35:13 INFO - argparse == 1.2.1 11:35:13 INFO - blessings == 1.6 11:35:13 INFO - blobuploader == 1.2.4 11:35:13 INFO - docopt == 0.6.1 11:35:13 INFO - functools32 == 3.2.3-2 11:35:13 INFO - jsonschema == 2.5.1 11:35:13 INFO - manifestparser == 1.1 11:35:13 INFO - mozInstall == 1.12 11:35:13 INFO - mozcrash == 0.17 11:35:13 INFO - mozdebug == 0.1 11:35:13 INFO - mozdevice == 0.48 11:35:13 INFO - mozfile == 1.2 11:35:13 INFO - mozhttpd == 0.7 11:35:13 INFO - mozinfo == 0.9 11:35:13 INFO - mozleak == 0.1 11:35:13 INFO - mozlog == 3.2 11:35:13 INFO - moznetwork == 0.27 11:35:13 INFO - mozprocess == 0.23 11:35:13 INFO - mozprofile == 0.28 11:35:13 INFO - mozrunner == 6.12 11:35:13 INFO - mozscreenshot == 0.1 11:35:13 INFO - mozsystemmonitor == 0.3 11:35:13 INFO - moztest == 0.7 11:35:13 INFO - mozversion == 1.4 11:35:13 INFO - psutil == 3.1.1 11:35:13 INFO - requests == 1.2.3 11:35:13 INFO - wsgiref == 0.1.2 11:35:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:35:13 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')]} 11:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:13 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')]} 11:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:13 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:35:13 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 11:35:13 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 11:35:13 INFO - Using env: {'DISPLAY': ':0', 11:35:13 INFO - 'HOME': '/home/cltbld', 11:35:13 INFO - 'LANG': 'en_US.UTF-8', 11:35:13 INFO - 'LANGUAGE': 'en_US:en', 11:35:13 INFO - 'LOGNAME': 'cltbld', 11:35:13 INFO - 'MAIL': '/var/mail/cltbld', 11:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:13 INFO - 'MOZ_NO_REMOTE': '1', 11:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:13 INFO - 'NO_EM_RESTART': '1', 11:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:13 INFO - 'PWD': '/builds/slave/test', 11:35:13 INFO - 'SHELL': '/bin/bash', 11:35:13 INFO - 'SHLVL': '1', 11:35:13 INFO - 'TERM': 'linux', 11:35:13 INFO - 'TMOUT': '86400', 11:35:13 INFO - 'USER': 'cltbld', 11:35:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:13 INFO - '_': '/tools/buildbot/bin/python'} 11:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 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)) 11:35:13 INFO - Cleaning up... 11:35:13 INFO - Return code: 0 11:35:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:35:13 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')]} 11:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:13 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')]} 11:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:13 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 0x21a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2467180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, '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': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', '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 11:35:13 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 11:35:13 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 11:35:13 INFO - Using env: {'DISPLAY': ':0', 11:35:13 INFO - 'HOME': '/home/cltbld', 11:35:13 INFO - 'LANG': 'en_US.UTF-8', 11:35:13 INFO - 'LANGUAGE': 'en_US:en', 11:35:13 INFO - 'LOGNAME': 'cltbld', 11:35:13 INFO - 'MAIL': '/var/mail/cltbld', 11:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:13 INFO - 'MOZ_NO_REMOTE': '1', 11:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:13 INFO - 'NO_EM_RESTART': '1', 11:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:13 INFO - 'PWD': '/builds/slave/test', 11:35:13 INFO - 'SHELL': '/bin/bash', 11:35:13 INFO - 'SHLVL': '1', 11:35:13 INFO - 'TERM': 'linux', 11:35:13 INFO - 'TMOUT': '86400', 11:35:13 INFO - 'USER': 'cltbld', 11:35:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:13 INFO - '_': '/tools/buildbot/bin/python'} 11:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:35:13 INFO - Cleaning up... 11:35:13 INFO - Return code: 0 11:35:13 INFO - Running post-action listener: _resource_record_post_action 11:35:13 INFO - Running post-action listener: _start_resource_monitoring 11:35:13 INFO - Starting resource monitoring. 11:35:13 INFO - ##### 11:35:13 INFO - ##### Finished create-virtualenv step (success) 11:35:13 INFO - ##### 11:35:13 INFO - ##### 11:35:13 INFO - ##### Running install step. 11:35:13 INFO - ##### 11:35:13 INFO - Running pre-action listener: _resource_record_pre_action 11:35:13 INFO - Running main action method: install 11:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:35:14 INFO - Reading from file tmpfile_stdout 11:35:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:35:14 INFO - Reading from file tmpfile_stdout 11:35:14 INFO - Output received: 11:35:14 INFO - Usage: mozinstall [options] installer 11:35:14 INFO - Options: 11:35:14 INFO - -h, --help show this help message and exit 11:35:14 INFO - -d DEST, --destination=DEST 11:35:14 INFO - Directory to install application into. [default: 11:35:14 INFO - "/builds/slave/test"] 11:35:14 INFO - --app=APP Application being installed. [default: firefox] 11:35:14 INFO - mkdir: /builds/slave/test/build/application 11:35:14 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'] 11:35:14 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 11:35:31 INFO - Reading from file tmpfile_stdout 11:35:31 INFO - Output received: 11:35:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:35:31 INFO - Running post-action listener: _resource_record_post_action 11:35:31 INFO - ##### 11:35:31 INFO - ##### Finished install step (success) 11:35:31 INFO - ##### 11:35:31 INFO - ##### 11:35:31 INFO - ##### Running run-tests step. 11:35:31 INFO - ##### 11:35:31 INFO - Running pre-action listener: _resource_record_pre_action 11:35:31 INFO - Running main action method: run_tests 11:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:35:31 INFO - Python 2.7.3 11:35:31 INFO - Return code: 0 11:35:31 INFO - grabbing minidump binary from tooltool 11:35:31 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')]} 11:35:31 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 0x24653b0>, '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 0x24662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:35:31 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 11:35:31 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 11:35:31 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 11:35:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:35:31 INFO - Return code: 0 11:35:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:35:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:35:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:35:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:35:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 11:35:31 INFO - Using env: {'DISPLAY': ':0', 11:35:31 INFO - 'HOME': '/home/cltbld', 11:35:31 INFO - 'LANG': 'en_US.UTF-8', 11:35:31 INFO - 'LANGUAGE': 'en_US:en', 11:35:31 INFO - 'LOGNAME': 'cltbld', 11:35:31 INFO - 'MAIL': '/var/mail/cltbld', 11:35:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:31 INFO - 'MOZ_NO_REMOTE': '1', 11:35:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:31 INFO - 'NO_EM_RESTART': '1', 11:35:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:31 INFO - 'PWD': '/builds/slave/test', 11:35:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:31 INFO - 'SHELL': '/bin/bash', 11:35:31 INFO - 'SHLVL': '1', 11:35:31 INFO - 'TERM': 'linux', 11:35:31 INFO - 'TMOUT': '86400', 11:35:31 INFO - 'USER': 'cltbld', 11:35:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850', 11:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:31 INFO - '_': '/tools/buildbot/bin/python'} 11:35:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:35:31 INFO - mozversion application_buildid: 20160712083048 11:35:31 INFO - mozversion application_changeset: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 11:35:31 INFO - mozversion application_display_name: Nightly 11:35:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:35:31 INFO - mozversion application_name: Firefox 11:35:31 INFO - mozversion application_remotingname: firefox 11:35:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:35:31 INFO - mozversion application_vendor: Mozilla 11:35:31 INFO - mozversion application_version: 50.0a1 11:35:31 INFO - mozversion platform_buildid: 20160712083048 11:35:31 INFO - mozversion platform_changeset: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 11:35:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:35:31 INFO - mozversion platform_version: 50.0a1 11:35:31 INFO - using testdate: 1468348531 11:35:31 INFO - actual date: 1468348531 11:35:31 INFO - starting webserver on 'localhost:58399' 11:35:31 INFO - SUITE-START | Running 2 tests 11:35:31 INFO - TEST-START | dromaeo_css 11:35:31 INFO - operating with platform_type : linux_ 11:35:31 INFO - Initialising browser for dromaeo_css test... 11:35:31 INFO - TEST-INFO | started process 17783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIopsSd/profile http://localhost:58399/getInfo.html) 11:35:35 INFO - PROCESS | 17783 | __metrics Screen width/height:1600/1200 11:35:35 INFO - PROCESS | 17783 | colorDepth:24 11:35:35 INFO - PROCESS | 17783 | Browser inner width/height: 1024/697 11:35:35 INFO - PROCESS | 17783 | __metrics 11:35:36 INFO - PROCESS | 17783 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:35:36 INFO - PROCESS | 17783 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:35:37 INFO - PROCESS | 17783 | console.error: PushService: 11:35:37 INFO - PROCESS | 17783 | stateChangeProcessEnqueue: Error transitioning state 11:35:37 INFO - PROCESS | 17783 | UnknownError 11:35:37 INFO - TEST-INFO | 17783: exit 0 11:35:37 INFO - Browser initialized. 11:35:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:35:37 INFO - TEST-INFO | started process 17868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIopsSd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:49 INFO - PROCESS | 17868 | RSS: Main: 157179904 11:35:49 INFO - PROCESS | 17868 | 11:36:40 INFO - PROCESS | 17868 | 1468348600896 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] 11:38:48 INFO - PROCESS | 17868 | Cycle 1(1): loaded http://localhost:58399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58399/tests/dromaeo/cssquery-ext.html) 11:38:49 INFO - PROCESS | 17868 | RSS: Main: 229109760 11:38:49 INFO - PROCESS | 17868 | 11:41:52 INFO - PROCESS | 17868 | Cycle 1(1): loaded http://localhost:58399/tests/dromaeo/cssquery-ext.html (next: http://localhost:58399/tests/dromaeo/cssquery-jquery.html) 11:41:52 INFO - PROCESS | 17868 | RSS: Main: 233455616 11:41:52 INFO - PROCESS | 17868 | 11:44:54 INFO - PROCESS | 17868 | Cycle 1(1): loaded http://localhost:58399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58399/tests/dromaeo/cssquery-mootools.html) 11:44:55 INFO - PROCESS | 17868 | RSS: Main: 242372608 11:44:55 INFO - PROCESS | 17868 | 11:47:57 INFO - PROCESS | 17868 | Cycle 1(1): loaded http://localhost:58399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58399/tests/dromaeo/cssquery-prototype.html) 11:47:57 INFO - PROCESS | 17868 | RSS: Main: 243662848 11:47:57 INFO - PROCESS | 17868 | 11:51:00 INFO - PROCESS | 17868 | Cycle 1(1): loaded http://localhost:58399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58399/tests/dromaeo/cssquery-yui.html) 11:51:01 INFO - PROCESS | 17868 | RSS: Main: 223178752 11:51:01 INFO - PROCESS | 17868 | 11:54:03 INFO - PROCESS | 17868 | Cycle 1(1): loaded http://localhost:58399/tests/dromaeo/cssquery-yui.html (next: http://localhost:58399/tests/dromaeo/cssquery-dojo.html) 11:54:04 INFO - PROCESS | 17868 | RSS: Main: 271998976 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | __start_tp_report 11:54:04 INFO - PROCESS | 17868 | _x_x_mozilla_page_load 11:54:04 INFO - PROCESS | 17868 | _x_x_mozilla_page_load_details 11:54:04 INFO - PROCESS | 17868 | |i|pagename|runs| 11:54:04 INFO - PROCESS | 17868 | |0;dojo.html;2963.9259018524535;2970.9257268568294;2993.3414648777275;3005.0834495478884;3008.428398604264;5033.496650334974;5047.84856454306;5113.74431278436;5136.512031357024;5201.479852014797;5067.366579177603;5090.338256026721;5099.235114732792;5135.486451354863;5213.139831927737;4598.954010459895;4644.326572646964;4659.697119687226;4662.114198302329;4836;4790.640701947351;4792.089502994438;4800.039992001596;4805;4822;4619.0530941156985;4646.140464014168;4675.509071547473;4704;4744.14605371033;4593.63250939924;4645.721256724607;4647.442306923157;4656.8602941911795;4657.115148121846;4662.650301227388;4666.440027196724;4672;4676.859694209179;4701.882452938704;5015.398152221756;5033.874153146164;5059.696418214882;5151.639385243035;5188.9740551297;5434.266374039494;5445.019896418643;5445.37378201504;5446.965076635426;5447.373552041527;5359.14253719403;5448.536874365644;5470.699111548864;5472.315960504937;5473.343198816167;5038.445770965191;5125.564327032207;5128.282040514331;5160.225966105039;5162.92255616166;5606.635568688022;5707.286589176353;5710.628809127476;5711.029125048752;5733.939221244;5450.781968721286;5462.235287059815;5489.64317319373;5494.862628434241;5497.257870187554;5329.9467005330225;5369.275147855068;5437.728113594305;5495.505404513533;5557.472040156179;5487.4238204987905;5515.034868898007;5515.503604675599;5518.310211223597;5521.613487055867;5292.682439053592;5520.199571062173;5528.391876893538;5531.197976293415;5554.166874968787;4147.3778933160265;4198.3702444633545;4201;4235.851745188904;4248.766317852548;3808.961910380861;3820.369639009588;3823.0251285921913;3844.9038774030314;3846.3076646203394;5099.770510327045;5169.71566563835;5240.9475905241225;5260;5303.36359636846;5485.314335708036;5537.778488860481;5550.639208451437;5566.053770858964;5584.748686309126;5202.895942081137;5203.479652034766;5213.452587478336;5228.55557277628;5253.212018197224;4581.129585378834;4718.245080787126;4746.95253047472;4774.880627984258;4780.450248221499;5597.720113994284;5618.381977982419;5632.211490391349;5636.520895723827;5651;5479.178123281539;5483.835484935458;5490.313710786152;5491.670499770026;5518.530924871431;5486.423925487767;5542.196381524737;5578.748956296895;5619.269494965628;5678.3753787084215;5407.188921661782;5423.376311724044;5435.048866448276;5437.102878025082;5445.264889239902;5501.862453438696;5512.944870551243;5521.116621340566;5521.1442226454965;5570.6657600544095;5240.2663627093;5331.040412725747;5361.142217245222;5396.3524377075;5412.56699464034;5383.950129724823;5392.164214546751;5393;5396.730163491889;5406.107992181246;5243.5542978847225;5391.379991300893;5403.540699040625;5405.108157154025;5458.072127738374;5271.077561426811;5306.575473962151;5308.442613525524;5325.041492531382;5362.195670649434;5290.021346050839;5323.760430780547;5343.7862485500145;5350.598705097055;5372.62391632582 11:54:04 INFO - PROCESS | 17868 | |1;ext.html;587.632729544035;599.4724642314764;610.5725991805734;617.6596784976599;633.04410340386;30415.69584304156;30998.53502197466;43562.910927226796;44499.77750111245;44508;41681.166376672445;46312.536874631245;46411.30383044257;46476;46485;9015.86476202856;9177.678781242657;9183.403078799856;9185.173334399902;9185.908140918573;9036.77408064797;9095.818083638324;9106.86339704905;9114.316426268024;9122.22461090808;9072.63709451621;9111.362204645677;9131.68039118631;9189.310801689866;9196.448213107202;9071.501067441288;9076.77308067297;9113.407628504126;9119.133682300171;9119.635214591375;9003.234725048313;9046.547672616343;9070.455772653662;9088.18206361424;9090.545472726337;42777.78611106925;43258.78370608158;43264.35103473451;43269.56730432687;43301.783491082344;3322.302316513535;3357.9664203357897;3454.896353109411;3710.5732840723394;3999.460072890181;31994.200144996328;32180.195495112574;32529.51205731916;32687.509687354708;33177.33645327104;4475.440569928759;4518.954810451919;4536.410266665345;4563.931541026854;4605.240135377659;370143;371342.9999999973;372043.13978430204;372146;372279;51026.74486627543;61262.69368653128;61717;61817;61853.381466184765;61698;62500.374996249455;62963.6851815738;69159;69190.30809691838;14957.775633365509;15021.399144034334;15035.473758418402;15037.849621503863;15039.774403383957;12369.134160608672;13253.072284940154;13507.864921350661;13692.246926419142;13699.45202191921;18843.43469695884;19439.042781173142;19459.389831851804;19540.60820043277;19545.120469578902;6931.202911665122;6985.79042628722;6986.196587392414;6986.476014298948;7033.753818616324;965.1362030982232;1097.9341239525654;1111.5164903267105;1186.95845645402;1198.7003249187703;33317.66682333194;33502.3299534008;33778.66221337755;33839;33972.716983379956;1130.8699499557656;1136.3749937534324;1151.3207207747469;1170.1925671286956;1226.3868065967017;17429;17567.385141519986;17607.207675654627;17737.556561085818;17788.644227115645;561469;564439;570189;570497;571676;58424.415755841896;58941.41058589445;59031.70484147552;59049.70475147597;59087;1237.8452693413324;1350.7095974365361;1364.6315494816542;1383.6471699716508;1387.5975966969465;33040.1739956503;33875.15312117217;34034.65965340315;34328.656713432545;34413.48379774355;50873;51671.741641291555;51790.741046294526;51809.740951295;51810.74094629503;421146;430980;431002;432270;434333;24494.75505244996;25112.874435627706;25134.24597262085;26565.60151597766;27133;43482.56517434785;47468.52531474641;48685.756571216916;49141;49493.752531237114;40769.388459172544;41316.79341603273;41565.37651935284;42105.36841947435;42579.7871010643;40782;40872.59127408688;41333.58666413418;41588.58411415847;41818.79090604527;40905;41374;42277.61779057729;42292.577074228866;42444.57555424406;36551.26897461983;36574.085647859014;37760.811195944945;38170;38389.80805095957;28465;28645.856770716015;28770.71229287764;28854.711452885203;28872.566911495924 11:54:04 INFO - PROCESS | 17868 | |2;jquery.html;380.08589342630967;386.4030073536386;388.9066624010238;395.9960400395995;415.1965945894692;14285.357158927847;17761.20074596643;18608.720869186956;20271;20284.89857550712;18393.63212735748;19547.902260488714;20277.69583456249;20288.797112028875;20300.18799248032;5512.779488820443;5743.253377060987;5823.3012038555435;5830.737616807254;5904.822855314347;4145.461090058288;4319.69762116652;5814.273215848019;5815.796447124351;5824.446677565625;4784.5693887550115;5746.798862039829;5753.626014309078;5819.272590926134;5825.883482330372;5582.274304340451;5784.855378615526;5787.768489260425;5791.739371728282;5795.072788353864;5628.26832511775;5631.127175287796;5636.464535869127;5645.15322701594;5654.519365853907;13138.868611313956;13722.862771372358;22543.887280563493;23691.278846680965;23976.28071157868;2307.2847417300522;2347.788699017097;2482.466269752012;2531.7594828491265;2914.2131624461276;9492.430454172772;9548.809023819485;9835.950820245924;10014.749631259205;10049.69850904474;1885.820847019531;1952.6192392483472;1995.122146255643;2020.8484363672637;2031.7460317460318;77086.6145669268;84770;86370.56814715886;88237.55881220553;89575.55212223897;10467;10613.416262105504;10720.839187412195;10742.409167495864;10849.566017359375;13134.540291089957;13486.190828550318;14369.78445323321;14751.631209219855;14777;7896.644650990719;7951.204879512003;7952.409518096404;7961.323287520509;8104.918950810535;7697.846043079107;7771.611419429006;7839.451238413257;7859.056913170456;7957.920420795834;4523.434570678665;4537.909241815145;4583.679142460062;4588.678792484494;4645.349651048856;1841.5672317005492;1861.8510519158435;1879.4455635587535;1905.6474552207885;1935.8741681790639;954.7326748510428;965.1844191658038;1028.6605420211313;1034.250168627739;1035.7565971996576;19835.801641983686;20795.376138715863;20817.167313307298;20870;20894.791052089284;1023.7491814505494;1052.3317693264678;1059.7032830807386;1068.326954018963;1101.7245688577855;11108.777824443467;11427.48576314068;11436;11542.769144617061;11620.186586939002;242406;246869;515813;517713;521279;75616.62191689006;81100;106937;108526.45736771423;109203;1023.4575674892319;1049.9632512862013;1056.3767377247461;1058.4707646176912;1062.8352605346183;18794.15426305792;19055.714164287823;19480.123394447568;19523.414297571097;19554;31445;41147.70818334586;43088.569114308455;44348.556514434444;47425;58860.411395885494;59867;61777.073343900774;62377.06434403578;62769.37230627635;7641.885371719318;8542.316614670935;8601.13988601135;8788.077251888715;8790.033096359522;13774.311284435938;14325.64185895361;14680.853191467948;14693.853061469248;14976.550703478913;12385.442655080362;12427.44076516541;12757.74484510286;12801.551945681857;12875.678108047374;12351.75296494083;12649.494020239455;12650;12762.48950042025;12873.485060597846;12641.431135598736;12830.550930717753;12882.871171288167;13009.089363744448;13418.664533386744;7842.529448233125;7903.288704016666;7983.760487185394;7995.480293780885;8204.179582041748;10552;12712.6821829455;12846.67883302925;12892.871071289166;12927.676808079874 11:54:04 INFO - PROCESS | 17868 | |3;mootools.html;1436.738603370349;1460.5837336359136;1565.4755656854961;1727.50766031681;1756.0341812003394;8109.513429194252;8509.276711479517;8526.829463410728;8581.184787445183;8582.05597384288;7377.18850926399;7920;8162.755117346474;8178.4683995540245;8446.408751387406;2133.519958009451;2144.6461333879893;2154.7737487563813;2158.1583182558816;2160.0603737374295;2135.839812014105;2148.205164089289;2181.836362272828;2183.061283648031;2185.2460900989213;1841.2634946021565;1886.4340697790676;1901.1634880652468;1906.5996140810378;2091.9267825626107;2172.142003908455;2212.281008672188;2212.8340374471977;2213.236433430464;2214.5128071824174;2185.2460900989136;2192.561487702466;2203.7575866654656;2208.6355751301176;2211.701420308254;8436.578171091422;8552.914470855274;8556.101609331055;8574.399792014561;8575.27110195628;4835.443923948756;4983.07813054586;4984.526469985346;4989.052080104769;4989.950100498985;3211.1329940916057;3288.112209703391;3357.6810203030673;3366.6801653842845;3369.02298333483;1001.3791449301407;1029.428667089765;1053.6126353772581;1054.947252637365;1061.814182518064;11684.47419866108;11725.648230553097;11727.53089876404;11731.648050558497;11734.295942243407;3938.940915886264;4073.816678249486;4159.688023398257;4164.3961625564125;4181.895452613649;9730.075642814063;9799.559019844124;9838.311318207656;9854.408735475894;9855.55649995752;4831.710097394168;4839.830605928775;4843.297721830315;4844.498205556289;4846.36997190363;4377.781110944504;4456.955430445719;4460.397846290709;4466.151431228056;4470.396496472935;3741.8690345837763;3807.7144214183495;3829.3681542545723;3879.7284190106984;3951;1192.1535709646248;1196.3180986837592;1197.952081916731;1213.5267245774155;1216.8783121687939;949.8290307744534;1014.497823577334;1016.8560369584218;1019.9439030853226;1020.6070662794878;5802.593818432753;5894.557908156819;5946.005355501399;6138.416850399205;6171.413715697002;982.9066238707311;996.461910568285;999.7000899730198;1024.3904876598413;1035.7669524356959;3918.49059622253;4052.169305292408;4138.420621113047;4192.937105943413;4220.240356735817;10287.691369258935;10573.101286390744;10658.413787241621;10670.466476676134;10686.946565267279;10325.948370258251;10466.476676166161;10501.684949451528;10539.156867450585;10571.682849514527;7936.484128531627;7983.600819959095;8024.037115546172;8093.3929955252415;8097.716579919675;5873.236479257669;5883.411658834254;5923.289205295392;5970.223870896755;5975.731092100953;9429.57566909477;9452.291078169028;9677.9032209677;9680.903190968;9700;9637.036296370306;9824.852627210455;9830.5084745761;9843;9844.60621575129;7535.510191837513;7667.11828139771;7670;7672.846543069219;7679.347255483346;8062.879056814035;8090.0696419912465;8093.150219226896;8145.877811832946;8192.713255036046;6464.321246269074;6841.315868413318;7162.355388015104;7316.8536629266055;7572.924270757222;7307.3058059484265;7362.595057271687;7413.406927445899;7451.627418629156;7538.547687138789;6676.399124078856;6748.932510675027;6796.456283497209;6807.9319206807295;6812.761553345609;5216.37403511581;5225.686458812484;5312.601554883322;5374.140137577969;5461.672299662033;5278.551323137576;5317.175837745156;5431.918521222264;5472.808451704172;5520.309961254843 11:54:04 INFO - PROCESS | 17868 | |4;prototype.html;301.6576186028858;303.9802412843164;307.27176591478195;307.9799813012154;312.20232306456995;5344.625876188668;5347.251384806125;5349.465053494649;5376.623636345457;5378.838634840956;5289.180177072551;5297.523222909937;5302.867428314294;5303.920441193375;5311.57507399408;3884.4755957945667;3957.307471192544;4084.5711200323985;4106.7125301228925;4108.630223279904;4060.512738471373;4079.9184016319805;4097.098638299584;4100.712950093494;4112.157007813391;3859.4403811447464;4042.5148982122187;4042.7978601069976;4044.373122166069;4062.248484030449;3930.2139572085553;4047.615476529725;4055.71609987301;4056.574059723716;4072.2669919414348;3517.542719446481;3530.1527633368064;3533.381658209803;3540.5574303212097;3548.4854696069183;5124.565831230173;5169.224616307546;5179.456157103526;5194.662346947436;5197.428282888879;4475.910481790378;4592.5177856324935;4643.210654188796;4645.372874661945;4661.86014419568;5457.672539647634;5481.972590137024;5499.780008799643;5500.614956953015;5501.752421141058;3907.7069219808345;3909.648131668135;3917.157811070605;3919.568847426781;3924.7841368724708;5435.592330575183;5748;5748.367679555246;5749.338826034976;5788.552861784554;3858.2476417098396;3874.9225015499533;3883.514560679915;3896.844126234919;3897.7271590988926;3920.2159568086495;3939.9606003940166;3951.0912490126857;3956.841726330972;3959.544652364957;4489.19194544985;4568.451785785661;4592.954070459319;4613.2388155953895;4614.607758340511;5574.665520068809;5599.944000560024;5601.439856014366;5606.7384838411035;5610.186522954149;1377.5936098850864;1389.8262717160355;1395.7138786548733;1395.8325000999946;1398.1680899864564;868.8566386546149;872.5855218771032;903.846346121161;925.9583318750672;929.6420877961898;5387.218853266333;5392.245085688007;5395.491096640081;5396.91904621431;5397.865053373697;5599.524040456526;5641.323041235078;5656;5667.716614169275;5669.773209071591;5130.846074617767;5334.812726782001;5344.251804747339;5382.111951527954;5402.1638639714465;3007.173027417434;3012.29211135383;3017;3029.7879148459397;3043;5667.291588551431;5799.2312344735265;5817.156512305776;5817.88364232713;5847.678377689268;5787.797427090031;5803.303603567514;5811.767529298865;5815.709214539256;5828.329742079715;5833.854153646193;5845.415458454206;5848.824535263949;5851.795187168514;5869.7945571904775;5464.398916119303;5689.431056894277;5695.686737229492;5700.800471983461;5726.599138060295;5630.5214056805635;5646.632968857011;5648.519875810603;5658.122990936411;5660.15097735343;5601.60788744784;5731.5701322400155;5790.044642634087;5850.23946886902;5865.442782935615;3947.388154836005;3949.8222579984545;3964.405339199028;3972.6226008529143;3977.42327362525;5782.913256301074;5789.56578256624;5805.593608447537;5807.593468457168;5814.592978491634;5384.273123128328;5650.406707295675;5659.603827732019;5661.518770904519;5674.148877668383;5630;5630.887382252414;5643.858903527281;5646.0683987141665;5650.26546548946;5360.571154307568;5367;5575.2473416088305;5604.607677462538;5614.382417934105;5631.436856314336;5649.604527683187;5663.631863928831;5665.716714164193;5677.716114194356;5519.868426972541;5528.336599608073;5531.644747036841;5532.2254884317035;5544.7227638618715 11:54:04 INFO - PROCESS | 17868 | |5;yui.html;731.9304666056722;756.0398294166408;768.6541056524566;770.4106358635644;843.966241350346;16067.919660401696;16439.91780041101;17269.30922763091;17287.48137555874;17302.826971730265;15660.530184094467;15846.603834904105;15938.601534961632;15942.601434964132;15947.84052159478;649.3993056422813;775.0776575874719;786.9645865936046;795.399473397584;806.762005208462;805.3637626275236;805.9677612895478;808.3654331349892;808.3654331349892;808.7654580171743;850.8936382952131;852.9402941794077;853.0786750309682;853.7524118005801;853.7950891785957;681.0805412692874;827.9461834980707;849.9235068843802;856.6530555125184;857.6998050682212;623.3641685480784;623.9095331176999;624.0234033737232;624.0327492386782;625.5152257000815;15348.616284592863;15406.768898466533;15408.922955385151;15429.22853857314;15429.537113886601;14496.855031449655;14632.853671463256;14704.558863234013;14787.852121478754;14836.777448338284;12830.230186188859;13182.53861114866;13433.66415839602;13485.797713034312;13615.863841361559;4550.203714349976;4569.29175977724;4589.518100599423;4712.740799256039;4798.47216806151;75775;76486.23513764903;77081;77372.22627773763;78612;11881.762364752829;11963.342016189194;11988.760224795455;12041.277523348626;12090.27458352484;21746.673799893015;21764.238251661114;21768.78231217699;22215.44461388478;22702.659460108112;9142.497162656118;9197.974267454212;9198.632054717737;9201.63193472267;9281.58232879522;5002.874928126753;5009.398872135367;5091.669041512364;5167.844964651066;5194.065068287745;3350.0619826448633;3467.029231815096;3472.079898826813;3473.600535938349;3475.165960169541;558.8686658635218;562.5415286541455;594.6907608043794;594.8839976204686;596.0998891673518;472.94561125470324;671.2280876991401;733.0946281342538;799.8761739755653;819.7827575692446;10372.948135259427;10989.670309890716;11377.772444551229;11537.117118916503;11800.70498237551;636.6656121480519;697.5744795674634;762.8398036412416;773.2422226218225;784.3842583571869;5015.398152221756;5097.350053118069;5143.537081662668;5159.380874295109;5279.128943724242;72537.6373118131;114739.42630286796;115884.84115158909;117139;123027.38486307512;71625;76877.61561192159;104808.47595761972;104819.47590262152;105598;57282;81098;85257.14742852616;86190;87535.56232218798;9900.851487227841;10260.846087308846;10327.896721032694;10441.373517588969;10597.311174773615;50982.23526647029;51797.96404071822;53140;53268.46731532635;54117;66453;74418.62790686228;74567;75034;77504.61247693725;13654.385552650354;14227.622018677572;14248.430062797372;14480;14632.414703411745;15863.920680396524;16218.67562648764;16254.837451625805;16584.66830663404;16646.583835404213;15128.39486420531;15363.769543457081;15464.304106315469;15480.5355839325;16034;14486.203258820866;14779.261036947895;15185.468508602145;15343.539693809204;15448.613784655025;13092.80360794608;13426;14214.212214152669;14363.138211707332;14956.17741024254;11909.285442873455;11916.702082448008;12405.255684658949;12753.553625623059;12977.545785897448;11814.409279536161;12207.511699531919;12235.32705701195;12436.19164754288;12506.874931250935 11:54:04 INFO - PROCESS | 17868 | __end_tp_report 11:54:04 INFO - PROCESS | 17868 | __start_cc_report 11:54:04 INFO - PROCESS | 17868 | _x_x_mozilla_cycle_collect,967 11:54:04 INFO - PROCESS | 17868 | __end_cc_report 11:54:04 INFO - PROCESS | 17868 | __startTimestamp1468349644057__endTimestamp 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | ------- Summary: start ------- 11:54:04 INFO - PROCESS | 17868 | Number of tests: 6 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | [#0] dojo.html Cycles:165 Average:5108.08 Median:5323.76 stddev:568.42 (10.7%) stddev-sans-first:544.71 11:54:04 INFO - PROCESS | 17868 | Values: 2963.9 2970.9 2993.3 3005.1 3008.4 5033.5 5047.8 5113.7 5136.5 5201.5 5067.4 5090.3 5099.2 5135.5 5213.1 4599.0 4644.3 4659.7 4662.1 4836.0 4790.6 4792.1 4800.0 4805.0 4822.0 4619.1 4646.1 4675.5 4704.0 4744.1 4593.6 4645.7 4647.4 4656.9 4657.1 4662.7 4666.4 4672.0 4676.9 4701.9 5015.4 5033.9 5059.7 5151.6 5189.0 5434.3 5445.0 5445.4 5447.0 5447.4 5359.1 5448.5 5470.7 5472.3 5473.3 5038.4 5125.6 5128.3 5160.2 5162.9 5606.6 5707.3 5710.6 5711.0 5733.9 5450.8 5462.2 5489.6 5494.9 5497.3 5329.9 5369.3 5437.7 5495.5 5557.5 5487.4 5515.0 5515.5 5518.3 5521.6 5292.7 5520.2 5528.4 5531.2 5554.2 4147.4 4198.4 4201.0 4235.9 4248.8 3809.0 3820.4 3823.0 3844.9 3846.3 5099.8 5169.7 5240.9 5260.0 5303.4 5485.3 5537.8 5550.6 5566.1 5584.7 5202.9 5203.5 5213.5 5228.6 5253.2 4581.1 4718.2 4747.0 4774.9 4780.5 5597.7 5618.4 5632.2 5636.5 5651.0 5479.2 5483.8 5490.3 5491.7 5518.5 5486.4 5542.2 5578.7 5619.3 5678.4 5407.2 5423.4 5435.0 5437.1 5445.3 5501.9 5512.9 5521.1 5521.1 5570.7 5240.3 5331.0 5361.1 5396.4 5412.6 5384.0 5392.2 5393.0 5396.7 5406.1 5243.6 5391.4 5403.5 5405.1 5458.1 5271.1 5306.6 5308.4 5325.0 5362.2 5290.0 5323.8 5343.8 5350.6 5372.6 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | [#1] ext.html Cycles:180 Average:61845.74 Median:42368.58 stddev:123069.37 (290.5%) stddev-sans-first:123328.67 11:54:04 INFO - PROCESS | 17868 | Values: 587.6 599.5 610.6 617.7 633.0 30415.7 30998.5 43562.9 44499.8 44508.0 41681.2 46312.5 46411.3 46476.0 46485.0 9015.9 9177.7 9183.4 9185.2 9185.9 9036.8 9095.8 9106.9 9114.3 9122.2 9072.6 9111.4 9131.7 9189.3 9196.4 9071.5 9076.8 9113.4 9119.1 9119.6 9003.2 9046.5 9070.5 9088.2 9090.5 42777.8 43258.8 43264.4 43269.6 43301.8 3322.3 3358.0 3454.9 3710.6 3999.5 31994.2 32180.2 32529.5 32687.5 33177.3 4475.4 4519.0 4536.4 4563.9 4605.2 370143.0 371343.0 372043.1 372146.0 372279.0 51026.7 61262.7 61717.0 61817.0 61853.4 61698.0 62500.4 62963.7 69159.0 69190.3 14957.8 15021.4 15035.5 15037.8 15039.8 12369.1 13253.1 13507.9 13692.2 13699.5 18843.4 19439.0 19459.4 19540.6 19545.1 6931.2 6985.8 6986.2 6986.5 7033.8 965.1 1097.9 1111.5 1187.0 1198.7 33317.7 33502.3 33778.7 33839.0 33972.7 1130.9 1136.4 1151.3 1170.2 1226.4 17429.0 17567.4 17607.2 17737.6 17788.6 561469.0 564439.0 570189.0 570497.0 571676.0 58424.4 58941.4 59031.7 59049.7 59087.0 1237.8 1350.7 1364.6 1383.6 1387.6 33040.2 33875.2 34034.7 34328.7 34413.5 50873.0 51671.7 51790.7 51809.7 51810.7 421146.0 430980.0 431002.0 432270.0 434333.0 24494.8 25112.9 25134.2 26565.6 27133.0 43482.6 47468.5 48685.8 49141.0 49493.8 40769.4 41316.8 41565.4 42105.4 42579.8 40782.0 40872.6 41333.6 41588.6 41818.8 40905.0 41374.0 42277.6 42292.6 42444.6 36551.3 36574.1 37760.8 38170.0 38389.8 28465.0 28645.9 28770.7 28854.7 28872.6 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | [#2] jquery.html Cycles:180 Average:27112.30 Median:12425.59 stddev:71822.85 (578.0%) stddev-sans-first:71996.29 11:54:04 INFO - PROCESS | 17868 | Values: 380.1 386.4 388.9 396.0 415.2 14285.4 17761.2 18608.7 20271.0 20284.9 18393.6 19547.9 20277.7 20288.8 20300.2 5512.8 5743.3 5823.3 5830.7 5904.8 4145.5 4319.7 5814.3 5815.8 5824.4 4784.6 5746.8 5753.6 5819.3 5825.9 5582.3 5784.9 5787.8 5791.7 5795.1 5628.3 5631.1 5636.5 5645.2 5654.5 13138.9 13722.9 22543.9 23691.3 23976.3 2307.3 2347.8 2482.5 2531.8 2914.2 9492.4 9548.8 9836.0 10014.7 10049.7 1885.8 1952.6 1995.1 2020.8 2031.7 77086.6 84770.0 86370.6 88237.6 89575.6 10467.0 10613.4 10720.8 10742.4 10849.6 13134.5 13486.2 14369.8 14751.6 14777.0 7896.6 7951.2 7952.4 7961.3 8104.9 7697.8 7771.6 7839.5 7859.1 7957.9 4523.4 4537.9 4583.7 4588.7 4645.3 1841.6 1861.9 1879.4 1905.6 1935.9 954.7 965.2 1028.7 1034.3 1035.8 19835.8 20795.4 20817.2 20870.0 20894.8 1023.7 1052.3 1059.7 1068.3 1101.7 11108.8 11427.5 11436.0 11542.8 11620.2 242406.0 246869.0 515813.0 517713.0 521279.0 75616.6 81100.0 106937.0 108526.5 109203.0 1023.5 1050.0 1056.4 1058.5 1062.8 18794.2 19055.7 19480.1 19523.4 19554.0 31445.0 41147.7 43088.6 44348.6 47425.0 58860.4 59867.0 61777.1 62377.1 62769.4 7641.9 8542.3 8601.1 8788.1 8790.0 13774.3 14325.6 14680.9 14693.9 14976.6 12385.4 12427.4 12757.7 12801.6 12875.7 12351.8 12649.5 12650.0 12762.5 12873.5 12641.4 12830.6 12882.9 13009.1 13418.7 7842.5 7903.3 7983.8 7995.5 8204.2 10552.0 12712.7 12846.7 12892.9 12927.7 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | [#3] mootools.html Cycles:180 Average:5577.27 Median:4845.43 stddev:3161.60 (65.2%) stddev-sans-first:3155.16 11:54:04 INFO - PROCESS | 17868 | Values: 1436.7 1460.6 1565.5 1727.5 1756.0 8109.5 8509.3 8526.8 8581.2 8582.1 7377.2 7920.0 8162.8 8178.5 8446.4 2133.5 2144.6 2154.8 2158.2 2160.1 2135.8 2148.2 2181.8 2183.1 2185.2 1841.3 1886.4 1901.2 1906.6 2091.9 2172.1 2212.3 2212.8 2213.2 2214.5 2185.2 2192.6 2203.8 2208.6 2211.7 8436.6 8552.9 8556.1 8574.4 8575.3 4835.4 4983.1 4984.5 4989.1 4990.0 3211.1 3288.1 3357.7 3366.7 3369.0 1001.4 1029.4 1053.6 1054.9 1061.8 11684.5 11725.6 11727.5 11731.6 11734.3 3938.9 4073.8 4159.7 4164.4 4181.9 9730.1 9799.6 9838.3 9854.4 9855.6 4831.7 4839.8 4843.3 4844.5 4846.4 4377.8 4457.0 4460.4 4466.2 4470.4 3741.9 3807.7 3829.4 3879.7 3951.0 1192.2 1196.3 1198.0 1213.5 1216.9 949.8 1014.5 1016.9 1019.9 1020.6 5802.6 5894.6 5946.0 6138.4 6171.4 982.9 996.5 999.7 1024.4 1035.8 3918.5 4052.2 4138.4 4192.9 4220.2 10287.7 10573.1 10658.4 10670.5 10686.9 10325.9 10466.5 10501.7 10539.2 10571.7 7936.5 7983.6 8024.0 8093.4 8097.7 5873.2 5883.4 5923.3 5970.2 5975.7 9429.6 9452.3 9677.9 9680.9 9700.0 9637.0 9824.9 9830.5 9843.0 9844.6 7535.5 7667.1 7670.0 7672.8 7679.3 8062.9 8090.1 8093.2 8145.9 8192.7 6464.3 6841.3 7162.4 7316.9 7572.9 7307.3 7362.6 7413.4 7451.6 7538.5 6676.4 6748.9 6796.5 6807.9 6812.8 5216.4 5225.7 5312.6 5374.1 5461.7 5278.6 5317.2 5431.9 5472.8 5520.3 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | [#4] prototype.html Cycles:180 Average:4650.98 Median:5383.19 stddev:1399.40 (26.0%) stddev-sans-first:1364.71 11:54:04 INFO - PROCESS | 17868 | Values: 301.7 304.0 307.3 308.0 312.2 5344.6 5347.3 5349.5 5376.6 5378.8 5289.2 5297.5 5302.9 5303.9 5311.6 3884.5 3957.3 4084.6 4106.7 4108.6 4060.5 4079.9 4097.1 4100.7 4112.2 3859.4 4042.5 4042.8 4044.4 4062.2 3930.2 4047.6 4055.7 4056.6 4072.3 3517.5 3530.2 3533.4 3540.6 3548.5 5124.6 5169.2 5179.5 5194.7 5197.4 4475.9 4592.5 4643.2 4645.4 4661.9 5457.7 5482.0 5499.8 5500.6 5501.8 3907.7 3909.6 3917.2 3919.6 3924.8 5435.6 5748.0 5748.4 5749.3 5788.6 3858.2 3874.9 3883.5 3896.8 3897.7 3920.2 3940.0 3951.1 3956.8 3959.5 4489.2 4568.5 4593.0 4613.2 4614.6 5574.7 5599.9 5601.4 5606.7 5610.2 1377.6 1389.8 1395.7 1395.8 1398.2 868.9 872.6 903.8 926.0 929.6 5387.2 5392.2 5395.5 5396.9 5397.9 5599.5 5641.3 5656.0 5667.7 5669.8 5130.8 5334.8 5344.3 5382.1 5402.2 3007.2 3012.3 3017.0 3029.8 3043.0 5667.3 5799.2 5817.2 5817.9 5847.7 5787.8 5803.3 5811.8 5815.7 5828.3 5833.9 5845.4 5848.8 5851.8 5869.8 5464.4 5689.4 5695.7 5700.8 5726.6 5630.5 5646.6 5648.5 5658.1 5660.2 5601.6 5731.6 5790.0 5850.2 5865.4 3947.4 3949.8 3964.4 3972.6 3977.4 5782.9 5789.6 5805.6 5807.6 5814.6 5384.3 5650.4 5659.6 5661.5 5674.1 5630.0 5630.9 5643.9 5646.1 5650.3 5360.6 5367.0 5575.2 5604.6 5614.4 5631.4 5649.6 5663.6 5665.7 5677.7 5519.9 5528.3 5531.6 5532.2 5544.7 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - PROCESS | 17868 | [#5] yui.html Cycles:180 Average:20828.63 Median:4012.68 stddev:28748.04 (716.4%) stddev-sans-first:28789.08 11:54:04 INFO - PROCESS | 17868 | Values: 731.9 756.0 768.7 770.4 844.0 16067.9 16439.9 17269.3 17287.5 17302.8 15660.5 15846.6 15938.6 15942.6 15947.8 649.4 775.1 787.0 795.4 806.8 805.4 806.0 808.4 808.4 808.8 850.9 852.9 853.1 853.8 853.8 681.1 827.9 849.9 856.7 857.7 623.4 623.9 624.0 624.0 625.5 15348.6 15406.8 15408.9 15429.2 15429.5 14496.9 14632.9 14704.6 14787.9 14836.8 12830.2 13182.5 13433.7 13485.8 13615.9 4550.2 4569.3 4589.5 4712.7 4798.5 75775.0 76486.2 77081.0 77372.2 78612.0 11881.8 11963.3 11988.8 12041.3 12090.3 21746.7 21764.2 21768.8 22215.4 22702.7 9142.5 9198.0 9198.6 9201.6 9281.6 5002.9 5009.4 5091.7 5167.8 5194.1 3350.1 3467.0 3472.1 3473.6 3475.2 558.9 562.5 594.7 594.9 596.1 472.9 671.2 733.1 799.9 819.8 10372.9 10989.7 11377.8 11537.1 11800.7 636.7 697.6 762.8 773.2 784.4 5015.4 5097.4 5143.5 5159.4 5279.1 72537.6 114739.4 115884.8 117139.0 123027.4 71625.0 76877.6 104808.5 104819.5 105598.0 57282.0 81098.0 85257.1 86190.0 87535.6 9900.9 10260.8 10327.9 10441.4 10597.3 50982.2 51798.0 53140.0 53268.5 54117.0 66453.0 74418.6 74567.0 75034.0 77504.6 13654.4 14227.6 14248.4 14480.0 14632.4 15863.9 16218.7 16254.8 16584.7 16646.6 15128.4 15363.8 15464.3 15480.5 16034.0 14486.2 14779.3 15185.5 15343.5 15448.6 13092.8 13426.0 14214.2 14363.1 14956.2 11909.3 11916.7 12405.3 12753.6 12977.5 11814.4 12207.5 12235.3 12436.2 12506.9 11:54:04 INFO - PROCESS | 17868 | -------- Summary: end -------- 11:54:04 INFO - PROCESS | 17868 | 11:54:04 INFO - TEST-INFO | 17868: exit 0 11:54:04 INFO - TEST-OK | dromaeo_css | took 1113112ms 11:54:04 INFO - TEST-START | kraken 11:54:04 INFO - operating with platform_type : linux_ 11:54:04 INFO - Initialising browser for kraken test... 11:54:04 INFO - TEST-INFO | started process 18056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg4enAm/profile http://localhost:58399/getInfo.html) 11:54:08 INFO - PROCESS | 18056 | __metrics Screen width/height:1600/1200 11:54:08 INFO - PROCESS | 18056 | colorDepth:24 11:54:08 INFO - PROCESS | 18056 | Browser inner width/height: 1024/697 11:54:08 INFO - PROCESS | 18056 | __metrics 11:54:09 INFO - PROCESS | 18056 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:54:09 INFO - PROCESS | 18056 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:54:10 INFO - TEST-INFO | 18056: exit 0 11:54:10 INFO - Browser initialized. 11:54:10 INFO - Running cycle 1/1 for kraken test... 11:54:10 INFO - TEST-INFO | started process 18138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg4enAm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:22 INFO - PROCESS | 18138 | RSS: Main: 157069312 11:54:22 INFO - PROCESS | 18138 | 11:54:24 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58399/tests/kraken/driver.html?testName=audio-beat-detection) 11:54:25 INFO - PROCESS | 18138 | RSS: Main: 215134208 11:54:25 INFO - PROCESS | 18138 | 11:54:28 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58399/tests/kraken/driver.html?testName=audio-dft) 11:54:28 INFO - PROCESS | 18138 | RSS: Main: 203239424 11:54:28 INFO - PROCESS | 18138 | 11:54:31 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58399/tests/kraken/driver.html?testName=audio-fft) 11:54:32 INFO - PROCESS | 18138 | RSS: Main: 269271040 11:54:32 INFO - PROCESS | 18138 | 11:54:34 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58399/tests/kraken/driver.html?testName=audio-oscillator) 11:54:35 INFO - PROCESS | 18138 | RSS: Main: 180441088 11:54:35 INFO - PROCESS | 18138 | 11:54:37 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:54:38 INFO - PROCESS | 18138 | RSS: Main: 184520704 11:54:38 INFO - PROCESS | 18138 | 11:54:41 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58399/tests/kraken/driver.html?testName=imaging-darkroom) 11:54:41 INFO - PROCESS | 18138 | RSS: Main: 219111424 11:54:41 INFO - PROCESS | 18138 | 11:54:45 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58399/tests/kraken/driver.html?testName=imaging-desaturate) 11:54:45 INFO - PROCESS | 18138 | RSS: Main: 221061120 11:54:45 INFO - PROCESS | 18138 | 11:54:48 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58399/tests/kraken/driver.html?testName=json-parse-financial) 11:54:49 INFO - PROCESS | 18138 | RSS: Main: 221126656 11:54:49 INFO - PROCESS | 18138 | 11:54:50 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:54:51 INFO - PROCESS | 18138 | RSS: Main: 209207296 11:54:51 INFO - PROCESS | 18138 | 11:54:52 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:54:53 INFO - PROCESS | 18138 | RSS: Main: 213745664 11:54:53 INFO - PROCESS | 18138 | 11:54:55 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:54:56 INFO - PROCESS | 18138 | RSS: Main: 211202048 11:54:56 INFO - PROCESS | 18138 | 11:54:58 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:54:59 INFO - PROCESS | 18138 | RSS: Main: 224804864 11:54:59 INFO - PROCESS | 18138 | 11:55:02 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:55:02 INFO - PROCESS | 18138 | RSS: Main: 226443264 11:55:02 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | Cycle 1(1): loaded http://localhost:58399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58399/tests/kraken/driver.html?testName=ai-astar) 11:55:04 INFO - PROCESS | 18138 | RSS: Main: 269246464 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | __start_tp_report 11:55:04 INFO - PROCESS | 18138 | _x_x_mozilla_page_load 11:55:04 INFO - PROCESS | 18138 | _x_x_mozilla_page_load_details 11:55:04 INFO - PROCESS | 18138 | |i|pagename|runs| 11:55:04 INFO - PROCESS | 18138 | |0;ai-astar;102;112;110;109;112;110;109;109;110;108 11:55:04 INFO - PROCESS | 18138 | |1;audio-beat-detection;143;117;118;170;121;118;148;116;164;117 11:55:04 INFO - PROCESS | 18138 | |2;audio-dft;161;160;162;160;160;160;160;161;161;160 11:55:04 INFO - PROCESS | 18138 | |3;audio-fft;75;74;76;126;76;76;75;73;102;75 11:55:04 INFO - PROCESS | 18138 | |4;audio-oscillator;84;84;116;84;85;84;115;84;84;121 11:55:04 INFO - PROCESS | 18138 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 11:55:04 INFO - PROCESS | 18138 | |6;imaging-darkroom;145;146;146;145;145;145;146;145;146;145 11:55:04 INFO - PROCESS | 18138 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 11:55:04 INFO - PROCESS | 18138 | |8;json-parse-financial;54;54;52;54;55;52;54;54;53;55 11:55:04 INFO - PROCESS | 18138 | |9;json-stringify-tinderbox;61;62;61;61;61;61;62;61;62;61 11:55:04 INFO - PROCESS | 18138 | |10;stanford-crypto-aes;78;81;74;75;84;75;75;75;74;84 11:55:04 INFO - PROCESS | 18138 | |11;stanford-crypto-ccm;127;123;122;134;138;137;118;118;156;125 11:55:04 INFO - PROCESS | 18138 | |12;stanford-crypto-pbkdf2;161;159;158;158;156;158;160;161;159;160 11:55:04 INFO - PROCESS | 18138 | |13;stanford-crypto-sha256-iterative;64;62;64;63;62;66;68;61;61;62 11:55:04 INFO - PROCESS | 18138 | __end_tp_report 11:55:04 INFO - PROCESS | 18138 | __start_cc_report 11:55:04 INFO - PROCESS | 18138 | _x_x_mozilla_cycle_collect,1695 11:55:04 INFO - PROCESS | 18138 | __end_cc_report 11:55:04 INFO - PROCESS | 18138 | __startTimestamp1468349704624__endTimestamp 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | ------- Summary: start ------- 11:55:04 INFO - PROCESS | 18138 | Number of tests: 14 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.81 (2.6%) stddev-sans-first:1.36 11:55:04 INFO - PROCESS | 18138 | Values: 102.0 112.0 110.0 109.0 112.0 110.0 109.0 109.0 110.0 108.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:132.00 stddev:21.21 (16.1%) stddev-sans-first:22.20 11:55:04 INFO - PROCESS | 18138 | Values: 143.0 117.0 118.0 170.0 121.0 118.0 148.0 116.0 164.0 117.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 11:55:04 INFO - PROCESS | 18138 | Values: 161.0 160.0 162.0 160.0 160.0 160.0 160.0 161.0 161.0 160.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:17.42 (23.2%) stddev-sans-first:18.24 11:55:04 INFO - PROCESS | 18138 | Values: 75.0 74.0 76.0 126.0 76.0 76.0 75.0 73.0 102.0 75.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.00 stddev:16.11 (19.2%) stddev-sans-first:16.66 11:55:04 INFO - PROCESS | 18138 | Values: 84.0 84.0 116.0 84.0 85.0 84.0 115.0 84.0 84.0 121.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:55:04 INFO - PROCESS | 18138 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:55:04 INFO - PROCESS | 18138 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:55:04 INFO - PROCESS | 18138 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 11:55:04 INFO - PROCESS | 18138 | Values: 54.0 54.0 52.0 54.0 55.0 52.0 54.0 54.0 53.0 55.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 11:55:04 INFO - PROCESS | 18138 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 62.0 61.0 62.0 61.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:4.03 (5.3%) stddev-sans-first:4.28 11:55:04 INFO - PROCESS | 18138 | Values: 78.0 81.0 74.0 75.0 84.0 75.0 75.0 75.0 74.0 84.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:130.50 stddev:11.74 (9.0%) stddev-sans-first:12.40 11:55:04 INFO - PROCESS | 18138 | Values: 127.0 123.0 122.0 134.0 138.0 137.0 118.0 118.0 156.0 125.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:159.50 stddev:1.56 (1.0%) stddev-sans-first:1.48 11:55:04 INFO - PROCESS | 18138 | Values: 161.0 159.0 158.0 158.0 156.0 158.0 160.0 161.0 159.0 160.0 11:55:04 INFO - PROCESS | 18138 | 11:55:04 INFO - PROCESS | 18138 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:2.26 (3.6%) stddev-sans-first:2.39 11:55:04 INFO - PROCESS | 18138 | Values: 64.0 62.0 64.0 63.0 62.0 66.0 68.0 61.0 61.0 62.0 11:55:04 INFO - PROCESS | 18138 | -------- Summary: end -------- 11:55:04 INFO - PROCESS | 18138 | 11:55:05 INFO - TEST-INFO | 18138: exit 0 11:55:05 INFO - TEST-OK | kraken | took 60802ms 11:55:05 INFO - SUITE-END | took 1173s 11:55:05 INFO - Completed test suite (00:19:34) 11:55:05 INFO - javascript benchmark 11:55:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2963.9259018524535, 2970.9257268568294, 2993.3414648777275, 3005.0834495478884, 3008.428398604264, 5033.496650334974, 5047.84856454306, 5113.74431278436, 5136.512031357024, 5201.479852014797, 5067.366579177603, 5090.338256026721, 5099.235114732792, 5135.486451354863, 5213.139831927737, 4598.954010459895, 4644.326572646964, 4659.697119687226, 4662.114198302329, 4836.0, 4790.640701947351, 4792.089502994438, 4800.039992001596, 4805.0, 4822.0, 4619.0530941156985, 4646.140464014168, 4675.509071547473, 4704.0, 4744.14605371033, 4593.63250939924, 4645.721256724607, 4647.442306923157, 4656.8602941911795, 4657.115148121846, 4662.650301227388, 4666.440027196724, 4672.0, 4676.859694209179, 4701.882452938704, 5015.398152221756, 5033.874153146164, 5059.696418214882, 5151.639385243035, 5188.9740551297, 5434.266374039494, 5445.019896418643, 5445.37378201504, 5446.965076635426, 5447.373552041527, 5359.14253719403, 5448.536874365644, 5470.699111548864, 5472.315960504937, 5473.343198816167, 5038.445770965191, 5125.564327032207, 5128.282040514331, 5160.225966105039, 5162.92255616166, 5606.635568688022, 5707.286589176353, 5710.628809127476, 5711.029125048752, 5733.939221244, 5450.781968721286, 5462.235287059815, 5489.64317319373, 5494.862628434241, 5497.257870187554, 5329.9467005330225, 5369.275147855068, 5437.728113594305, 5495.505404513533, 5557.472040156179, 5487.4238204987905, 5515.034868898007, 5515.503604675599, 5518.310211223597, 5521.613487055867, 5292.682439053592, 5520.199571062173, 5528.391876893538, 5531.197976293415, 5554.166874968787, 4147.3778933160265, 4198.3702444633545, 4201.0, 4235.851745188904, 4248.766317852548, 3808.961910380861, 3820.369639009588, 3823.0251285921913, 3844.9038774030314, 3846.3076646203394, 5099.770510327045, 5169.71566563835, 5240.9475905241225, 5260.0, 5303.36359636846, 5485.314335708036, 5537.778488860481, 5550.639208451437, 5566.053770858964, 5584.748686309126, 5202.895942081137, 5203.479652034766, 5213.452587478336, 5228.55557277628, 5253.212018197224, 4581.129585378834, 4718.245080787126, 4746.95253047472, 4774.880627984258, 4780.450248221499, 5597.720113994284, 5618.381977982419, 5632.211490391349, 5636.520895723827, 5651.0, 5479.178123281539, 5483.835484935458, 5490.313710786152, 5491.670499770026, 5518.530924871431, 5486.423925487767, 5542.196381524737, 5578.748956296895, 5619.269494965628, 5678.3753787084215, 5407.188921661782, 5423.376311724044, 5435.048866448276, 5437.102878025082, 5445.264889239902, 5501.862453438696, 5512.944870551243, 5521.116621340566, 5521.1442226454965, 5570.6657600544095, 5240.2663627093, 5331.040412725747, 5361.142217245222, 5396.3524377075, 5412.56699464034, 5383.950129724823, 5392.164214546751, 5393.0, 5396.730163491889, 5406.107992181246, 5243.5542978847225, 5391.379991300893, 5403.540699040625, 5405.108157154025, 5458.072127738374, 5271.077561426811, 5306.575473962151, 5308.442613525524, 5325.041492531382, 5362.195670649434, 5290.021346050839, 5323.760430780547, 5343.7862485500145, 5350.598705097055, 5372.62391632582], "value": 5070.466543831954, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.632729544035, 599.4724642314764, 610.5725991805734, 617.6596784976599, 633.04410340386, 30415.69584304156, 30998.53502197466, 43562.910927226796, 44499.77750111245, 44508.0, 41681.166376672445, 46312.536874631245, 46411.30383044257, 46476.0, 46485.0, 9015.86476202856, 9177.678781242657, 9183.403078799856, 9185.173334399902, 9185.908140918573, 9036.77408064797, 9095.818083638324, 9106.86339704905, 9114.316426268024, 9122.22461090808, 9072.63709451621, 9111.362204645677, 9131.68039118631, 9189.310801689866, 9196.448213107202, 9071.501067441288, 9076.77308067297, 9113.407628504126, 9119.133682300171, 9119.635214591375, 9003.234725048313, 9046.547672616343, 9070.455772653662, 9088.18206361424, 9090.545472726337, 42777.78611106925, 43258.78370608158, 43264.35103473451, 43269.56730432687, 43301.783491082344, 3322.302316513535, 3357.9664203357897, 3454.896353109411, 3710.5732840723394, 3999.460072890181, 31994.200144996328, 32180.195495112574, 32529.51205731916, 32687.509687354708, 33177.33645327104, 4475.440569928759, 4518.954810451919, 4536.410266665345, 4563.931541026854, 4605.240135377659, 370143.0, 371342.9999999973, 372043.13978430204, 372146.0, 372279.0, 51026.74486627543, 61262.69368653128, 61717.0, 61817.0, 61853.381466184765, 61698.0, 62500.374996249455, 62963.6851815738, 69159.0, 69190.30809691838, 14957.775633365509, 15021.399144034334, 15035.473758418402, 15037.849621503863, 15039.774403383957, 12369.134160608672, 13253.072284940154, 13507.864921350661, 13692.246926419142, 13699.45202191921, 18843.43469695884, 19439.042781173142, 19459.389831851804, 19540.60820043277, 19545.120469578902, 6931.202911665122, 6985.79042628722, 6986.196587392414, 6986.476014298948, 7033.753818616324, 965.1362030982232, 1097.9341239525654, 1111.5164903267105, 1186.95845645402, 1198.7003249187703, 33317.66682333194, 33502.3299534008, 33778.66221337755, 33839.0, 33972.716983379956, 1130.8699499557656, 1136.3749937534324, 1151.3207207747469, 1170.1925671286956, 1226.3868065967017, 17429.0, 17567.385141519986, 17607.207675654627, 17737.556561085818, 17788.644227115645, 561469.0, 564439.0, 570189.0, 570497.0, 571676.0, 58424.415755841896, 58941.41058589445, 59031.70484147552, 59049.70475147597, 59087.0, 1237.8452693413324, 1350.7095974365361, 1364.6315494816542, 1383.6471699716508, 1387.5975966969465, 33040.1739956503, 33875.15312117217, 34034.65965340315, 34328.656713432545, 34413.48379774355, 50873.0, 51671.741641291555, 51790.741046294526, 51809.740951295, 51810.74094629503, 421146.0, 430980.0, 431002.0, 432270.0, 434333.0, 24494.75505244996, 25112.874435627706, 25134.24597262085, 26565.60151597766, 27133.0, 43482.56517434785, 47468.52531474641, 48685.756571216916, 49141.0, 49493.752531237114, 40769.388459172544, 41316.79341603273, 41565.37651935284, 42105.36841947435, 42579.7871010643, 40782.0, 40872.59127408688, 41333.58666413418, 41588.58411415847, 41818.79090604527, 40905.0, 41374.0, 42277.61779057729, 42292.577074228866, 42444.57555424406, 36551.26897461983, 36574.085647859014, 37760.811195944945, 38170.0, 38389.80805095957, 28465.0, 28645.856770716015, 28770.71229287764, 28854.711452885203, 28872.566911495924], "value": 20430.593695280648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.08589342630967, 386.4030073536386, 388.9066624010238, 395.9960400395995, 415.1965945894692, 14285.357158927847, 17761.20074596643, 18608.720869186956, 20271.0, 20284.89857550712, 18393.63212735748, 19547.902260488714, 20277.69583456249, 20288.797112028875, 20300.18799248032, 5512.779488820443, 5743.253377060987, 5823.3012038555435, 5830.737616807254, 5904.822855314347, 4145.461090058288, 4319.69762116652, 5814.273215848019, 5815.796447124351, 5824.446677565625, 4784.5693887550115, 5746.798862039829, 5753.626014309078, 5819.272590926134, 5825.883482330372, 5582.274304340451, 5784.855378615526, 5787.768489260425, 5791.739371728282, 5795.072788353864, 5628.26832511775, 5631.127175287796, 5636.464535869127, 5645.15322701594, 5654.519365853907, 13138.868611313956, 13722.862771372358, 22543.887280563493, 23691.278846680965, 23976.28071157868, 2307.2847417300522, 2347.788699017097, 2482.466269752012, 2531.7594828491265, 2914.2131624461276, 9492.430454172772, 9548.809023819485, 9835.950820245924, 10014.749631259205, 10049.69850904474, 1885.820847019531, 1952.6192392483472, 1995.122146255643, 2020.8484363672637, 2031.7460317460318, 77086.6145669268, 84770.0, 86370.56814715886, 88237.55881220553, 89575.55212223897, 10467.0, 10613.416262105504, 10720.839187412195, 10742.409167495864, 10849.566017359375, 13134.540291089957, 13486.190828550318, 14369.78445323321, 14751.631209219855, 14777.0, 7896.644650990719, 7951.204879512003, 7952.409518096404, 7961.323287520509, 8104.918950810535, 7697.846043079107, 7771.611419429006, 7839.451238413257, 7859.056913170456, 7957.920420795834, 4523.434570678665, 4537.909241815145, 4583.679142460062, 4588.678792484494, 4645.349651048856, 1841.5672317005492, 1861.8510519158435, 1879.4455635587535, 1905.6474552207885, 1935.8741681790639, 954.7326748510428, 965.1844191658038, 1028.6605420211313, 1034.250168627739, 1035.7565971996576, 19835.801641983686, 20795.376138715863, 20817.167313307298, 20870.0, 20894.791052089284, 1023.7491814505494, 1052.3317693264678, 1059.7032830807386, 1068.326954018963, 1101.7245688577855, 11108.777824443467, 11427.48576314068, 11436.0, 11542.769144617061, 11620.186586939002, 242406.0, 246869.0, 515813.0, 517713.0, 521279.0, 75616.62191689006, 81100.0, 106937.0, 108526.45736771423, 109203.0, 1023.4575674892319, 1049.9632512862013, 1056.3767377247461, 1058.4707646176912, 1062.8352605346183, 18794.15426305792, 19055.714164287823, 19480.123394447568, 19523.414297571097, 19554.0, 31445.0, 41147.70818334586, 43088.569114308455, 44348.556514434444, 47425.0, 58860.411395885494, 59867.0, 61777.073343900774, 62377.06434403578, 62769.37230627635, 7641.885371719318, 8542.316614670935, 8601.13988601135, 8788.077251888715, 8790.033096359522, 13774.311284435938, 14325.64185895361, 14680.853191467948, 14693.853061469248, 14976.550703478913, 12385.442655080362, 12427.44076516541, 12757.74484510286, 12801.551945681857, 12875.678108047374, 12351.75296494083, 12649.494020239455, 12650.0, 12762.48950042025, 12873.485060597846, 12641.431135598736, 12830.550930717753, 12882.871171288167, 13009.089363744448, 13418.664533386744, 7842.529448233125, 7903.288704016666, 7983.760487185394, 7995.480293780885, 8204.179582041748, 10552.0, 12712.6821829455, 12846.67883302925, 12892.871071289166, 12927.676808079874], "value": 9266.668815824385, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.738603370349, 1460.5837336359136, 1565.4755656854961, 1727.50766031681, 1756.0341812003394, 8109.513429194252, 8509.276711479517, 8526.829463410728, 8581.184787445183, 8582.05597384288, 7377.18850926399, 7920.0, 8162.755117346474, 8178.4683995540245, 8446.408751387406, 2133.519958009451, 2144.6461333879893, 2154.7737487563813, 2158.1583182558816, 2160.0603737374295, 2135.839812014105, 2148.205164089289, 2181.836362272828, 2183.061283648031, 2185.2460900989213, 1841.2634946021565, 1886.4340697790676, 1901.1634880652468, 1906.5996140810378, 2091.9267825626107, 2172.142003908455, 2212.281008672188, 2212.8340374471977, 2213.236433430464, 2214.5128071824174, 2185.2460900989136, 2192.561487702466, 2203.7575866654656, 2208.6355751301176, 2211.701420308254, 8436.578171091422, 8552.914470855274, 8556.101609331055, 8574.399792014561, 8575.27110195628, 4835.443923948756, 4983.07813054586, 4984.526469985346, 4989.052080104769, 4989.950100498985, 3211.1329940916057, 3288.112209703391, 3357.6810203030673, 3366.6801653842845, 3369.02298333483, 1001.3791449301407, 1029.428667089765, 1053.6126353772581, 1054.947252637365, 1061.814182518064, 11684.47419866108, 11725.648230553097, 11727.53089876404, 11731.648050558497, 11734.295942243407, 3938.940915886264, 4073.816678249486, 4159.688023398257, 4164.3961625564125, 4181.895452613649, 9730.075642814063, 9799.559019844124, 9838.311318207656, 9854.408735475894, 9855.55649995752, 4831.710097394168, 4839.830605928775, 4843.297721830315, 4844.498205556289, 4846.36997190363, 4377.781110944504, 4456.955430445719, 4460.397846290709, 4466.151431228056, 4470.396496472935, 3741.8690345837763, 3807.7144214183495, 3829.3681542545723, 3879.7284190106984, 3951.0, 1192.1535709646248, 1196.3180986837592, 1197.952081916731, 1213.5267245774155, 1216.8783121687939, 949.8290307744534, 1014.497823577334, 1016.8560369584218, 1019.9439030853226, 1020.6070662794878, 5802.593818432753, 5894.557908156819, 5946.005355501399, 6138.416850399205, 6171.413715697002, 982.9066238707311, 996.461910568285, 999.7000899730198, 1024.3904876598413, 1035.7669524356959, 3918.49059622253, 4052.169305292408, 4138.420621113047, 4192.937105943413, 4220.240356735817, 10287.691369258935, 10573.101286390744, 10658.413787241621, 10670.466476676134, 10686.946565267279, 10325.948370258251, 10466.476676166161, 10501.684949451528, 10539.156867450585, 10571.682849514527, 7936.484128531627, 7983.600819959095, 8024.037115546172, 8093.3929955252415, 8097.716579919675, 5873.236479257669, 5883.411658834254, 5923.289205295392, 5970.223870896755, 5975.731092100953, 9429.57566909477, 9452.291078169028, 9677.9032209677, 9680.903190968, 9700.0, 9637.036296370306, 9824.852627210455, 9830.5084745761, 9843.0, 9844.60621575129, 7535.510191837513, 7667.11828139771, 7670.0, 7672.846543069219, 7679.347255483346, 8062.879056814035, 8090.0696419912465, 8093.150219226896, 8145.877811832946, 8192.713255036046, 6464.321246269074, 6841.315868413318, 7162.355388015104, 7316.8536629266055, 7572.924270757222, 7307.3058059484265, 7362.595057271687, 7413.406927445899, 7451.627418629156, 7538.547687138789, 6676.399124078856, 6748.932510675027, 6796.456283497209, 6807.9319206807295, 6812.761553345609, 5216.37403511581, 5225.686458812484, 5312.601554883322, 5374.140137577969, 5461.672299662033, 5278.551323137576, 5317.175837745156, 5431.918521222264, 5472.808451704172, 5520.309961254843], "value": 4467.222257744176, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.6576186028858, 303.9802412843164, 307.27176591478195, 307.9799813012154, 312.20232306456995, 5344.625876188668, 5347.251384806125, 5349.465053494649, 5376.623636345457, 5378.838634840956, 5289.180177072551, 5297.523222909937, 5302.867428314294, 5303.920441193375, 5311.57507399408, 3884.4755957945667, 3957.307471192544, 4084.5711200323985, 4106.7125301228925, 4108.630223279904, 4060.512738471373, 4079.9184016319805, 4097.098638299584, 4100.712950093494, 4112.157007813391, 3859.4403811447464, 4042.5148982122187, 4042.7978601069976, 4044.373122166069, 4062.248484030449, 3930.2139572085553, 4047.615476529725, 4055.71609987301, 4056.574059723716, 4072.2669919414348, 3517.542719446481, 3530.1527633368064, 3533.381658209803, 3540.5574303212097, 3548.4854696069183, 5124.565831230173, 5169.224616307546, 5179.456157103526, 5194.662346947436, 5197.428282888879, 4475.910481790378, 4592.5177856324935, 4643.210654188796, 4645.372874661945, 4661.86014419568, 5457.672539647634, 5481.972590137024, 5499.780008799643, 5500.614956953015, 5501.752421141058, 3907.7069219808345, 3909.648131668135, 3917.157811070605, 3919.568847426781, 3924.7841368724708, 5435.592330575183, 5748.0, 5748.367679555246, 5749.338826034976, 5788.552861784554, 3858.2476417098396, 3874.9225015499533, 3883.514560679915, 3896.844126234919, 3897.7271590988926, 3920.2159568086495, 3939.9606003940166, 3951.0912490126857, 3956.841726330972, 3959.544652364957, 4489.19194544985, 4568.451785785661, 4592.954070459319, 4613.2388155953895, 4614.607758340511, 5574.665520068809, 5599.944000560024, 5601.439856014366, 5606.7384838411035, 5610.186522954149, 1377.5936098850864, 1389.8262717160355, 1395.7138786548733, 1395.8325000999946, 1398.1680899864564, 868.8566386546149, 872.5855218771032, 903.846346121161, 925.9583318750672, 929.6420877961898, 5387.218853266333, 5392.245085688007, 5395.491096640081, 5396.91904621431, 5397.865053373697, 5599.524040456526, 5641.323041235078, 5656.0, 5667.716614169275, 5669.773209071591, 5130.846074617767, 5334.812726782001, 5344.251804747339, 5382.111951527954, 5402.1638639714465, 3007.173027417434, 3012.29211135383, 3017.0, 3029.7879148459397, 3043.0, 5667.291588551431, 5799.2312344735265, 5817.156512305776, 5817.88364232713, 5847.678377689268, 5787.797427090031, 5803.303603567514, 5811.767529298865, 5815.709214539256, 5828.329742079715, 5833.854153646193, 5845.415458454206, 5848.824535263949, 5851.795187168514, 5869.7945571904775, 5464.398916119303, 5689.431056894277, 5695.686737229492, 5700.800471983461, 5726.599138060295, 5630.5214056805635, 5646.632968857011, 5648.519875810603, 5658.122990936411, 5660.15097735343, 5601.60788744784, 5731.5701322400155, 5790.044642634087, 5850.23946886902, 5865.442782935615, 3947.388154836005, 3949.8222579984545, 3964.405339199028, 3972.6226008529143, 3977.42327362525, 5782.913256301074, 5789.56578256624, 5805.593608447537, 5807.593468457168, 5814.592978491634, 5384.273123128328, 5650.406707295675, 5659.603827732019, 5661.518770904519, 5674.148877668383, 5630.0, 5630.887382252414, 5643.858903527281, 5646.0683987141665, 5650.26546548946, 5360.571154307568, 5367.0, 5575.2473416088305, 5604.607677462538, 5614.382417934105, 5631.436856314336, 5649.604527683187, 5663.631863928831, 5665.716714164193, 5677.716114194356, 5519.868426972541, 5528.336599608073, 5531.644747036841, 5532.2254884317035, 5544.7227638618715], "value": 4194.938462597511, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.9304666056722, 756.0398294166408, 768.6541056524566, 770.4106358635644, 843.966241350346, 16067.919660401696, 16439.91780041101, 17269.30922763091, 17287.48137555874, 17302.826971730265, 15660.530184094467, 15846.603834904105, 15938.601534961632, 15942.601434964132, 15947.84052159478, 649.3993056422813, 775.0776575874719, 786.9645865936046, 795.399473397584, 806.762005208462, 805.3637626275236, 805.9677612895478, 808.3654331349892, 808.3654331349892, 808.7654580171743, 850.8936382952131, 852.9402941794077, 853.0786750309682, 853.7524118005801, 853.7950891785957, 681.0805412692874, 827.9461834980707, 849.9235068843802, 856.6530555125184, 857.6998050682212, 623.3641685480784, 623.9095331176999, 624.0234033737232, 624.0327492386782, 625.5152257000815, 15348.616284592863, 15406.768898466533, 15408.922955385151, 15429.22853857314, 15429.537113886601, 14496.855031449655, 14632.853671463256, 14704.558863234013, 14787.852121478754, 14836.777448338284, 12830.230186188859, 13182.53861114866, 13433.66415839602, 13485.797713034312, 13615.863841361559, 4550.203714349976, 4569.29175977724, 4589.518100599423, 4712.740799256039, 4798.47216806151, 75775.0, 76486.23513764903, 77081.0, 77372.22627773763, 78612.0, 11881.762364752829, 11963.342016189194, 11988.760224795455, 12041.277523348626, 12090.27458352484, 21746.673799893015, 21764.238251661114, 21768.78231217699, 22215.44461388478, 22702.659460108112, 9142.497162656118, 9197.974267454212, 9198.632054717737, 9201.63193472267, 9281.58232879522, 5002.874928126753, 5009.398872135367, 5091.669041512364, 5167.844964651066, 5194.065068287745, 3350.0619826448633, 3467.029231815096, 3472.079898826813, 3473.600535938349, 3475.165960169541, 558.8686658635218, 562.5415286541455, 594.6907608043794, 594.8839976204686, 596.0998891673518, 472.94561125470324, 671.2280876991401, 733.0946281342538, 799.8761739755653, 819.7827575692446, 10372.948135259427, 10989.670309890716, 11377.772444551229, 11537.117118916503, 11800.70498237551, 636.6656121480519, 697.5744795674634, 762.8398036412416, 773.2422226218225, 784.3842583571869, 5015.398152221756, 5097.350053118069, 5143.537081662668, 5159.380874295109, 5279.128943724242, 72537.6373118131, 114739.42630286796, 115884.84115158909, 117139.0, 123027.38486307512, 71625.0, 76877.61561192159, 104808.47595761972, 104819.47590262152, 105598.0, 57282.0, 81098.0, 85257.14742852616, 86190.0, 87535.56232218798, 9900.851487227841, 10260.846087308846, 10327.896721032694, 10441.373517588969, 10597.311174773615, 50982.23526647029, 51797.96404071822, 53140.0, 53268.46731532635, 54117.0, 66453.0, 74418.62790686228, 74567.0, 75034.0, 77504.61247693725, 13654.385552650354, 14227.622018677572, 14248.430062797372, 14480.0, 14632.414703411745, 15863.920680396524, 16218.67562648764, 16254.837451625805, 16584.66830663404, 16646.583835404213, 15128.39486420531, 15363.769543457081, 15464.304106315469, 15480.5355839325, 16034.0, 14486.203258820866, 14779.261036947895, 15185.468508602145, 15343.539693809204, 15448.613784655025, 13092.80360794608, 13426.0, 14214.212214152669, 14363.138211707332, 14956.17741024254, 11909.285442873455, 11916.702082448008, 12405.255684658949, 12753.553625623059, 12977.545785897448, 11814.409279536161, 12207.511699531919, 12235.32705701195, 12436.19164754288, 12506.874931250935], "value": 7847.827220409164, "unit": "score"}], "name": "dromaeo_css", "value": 7216.09618702215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 109.0, 112.0, 110.0, 109.0, 109.0, 110.0, 108.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 118.0, 170.0, 121.0, 118.0, 148.0, 116.0, 164.0, 117.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 126.0, 76.0, 76.0, 75.0, 73.0, 102.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 84.0, 85.0, 84.0, 115.0, 84.0, 84.0, 121.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "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, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 54.0, 55.0, 52.0, 54.0, 54.0, 53.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 74.0, 75.0, 84.0, 75.0, 75.0, 75.0, 74.0, 84.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 122.0, 134.0, 138.0, 137.0, 118.0, 118.0, 156.0, 125.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 158.0, 158.0, 156.0, 158.0, 160.0, 161.0, 159.0, 160.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 62.0, 66.0, 68.0, 61.0, 61.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1481.4999999999998, "alertThreshold": 2.0}]} 11:55:05 INFO - Return code: 0 11:55:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:55:05 INFO - # TBPL SUCCESS # 11:55:05 INFO - Running post-action listener: _resource_record_post_action 11:55:05 INFO - ##### 11:55:05 INFO - ##### Finished run-tests step (success) 11:55:05 INFO - ##### 11:55:05 INFO - Running post-run listener: _resource_record_post_run 11:55:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 569192448; Read time: 0; Write time: 414564 11:55:06 INFO - TinderboxPrint: CPU usage
13.0% 11:55:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:55:06 INFO - TinderboxPrint: I/O write bytes / time
569,192,448 / 414,564 11:55:06 INFO - TinderboxPrint: CPU idle
8,271.8 (87.0%) 11:55:06 INFO - TinderboxPrint: CPU user
1,192.5 (12.5%) 11:55:06 INFO - TinderboxPrint: Swap in / out
0 / 0 11:55:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 273010688; Read time: 0; Write time: 252212 11:55:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296181760; Read time: 0; Write time: 162352 11:55:06 INFO - Running post-run listener: _upload_blobber_files 11:55:06 INFO - Blob upload gear active. 11:55:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:55:06 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 11:55:06 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:55:06 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:55:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:07 INFO - (blobuploader) - INFO - Done attempting. 11:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:08 INFO - (blobuploader) - INFO - Done attempting. 11:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:55:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:55:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:55:11 INFO - (blobuploader) - INFO - Done attempting. 11:55:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:55:11 INFO - Return code: 0 11:55:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:55:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:55:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b70ee39b934f0a033bed183a7d6f915d2ca90a1f71be3193aeba9dd06e5fb9043a8b02b2215c39161f744a150afeecf87231663e3cf3b47c2517dd20623277ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26e50b5d19184dc33254f8cd5dbe1cbb99c6f9c4eb887392ffa73217053abbd7e3ee10425be9b125f719fe912c2b1d36b82a16029e8cc6c32f57cabf03932aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac42add2d5396d7739804552cb81317af78fa411d9e1ca6bbe33968d8d60ce5d698c55c4b7c3ae68ed7cfb4a8f2589ea13fd365793740118f503db599b453f1"} 11:55:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:55:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:55:11 INFO - Contents: 11:55:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b70ee39b934f0a033bed183a7d6f915d2ca90a1f71be3193aeba9dd06e5fb9043a8b02b2215c39161f744a150afeecf87231663e3cf3b47c2517dd20623277ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26e50b5d19184dc33254f8cd5dbe1cbb99c6f9c4eb887392ffa73217053abbd7e3ee10425be9b125f719fe912c2b1d36b82a16029e8cc6c32f57cabf03932aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac42add2d5396d7739804552cb81317af78fa411d9e1ca6bbe33968d8d60ce5d698c55c4b7c3ae68ed7cfb4a8f2589ea13fd365793740118f503db599b453f1"} 11:55:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:55:11 INFO - Copying logs to upload dir... 11:55:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:55:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.935774 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-12 11:55:11.652579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 11:55:11.655691) ========= 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=41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b70ee39b934f0a033bed183a7d6f915d2ca90a1f71be3193aeba9dd06e5fb9043a8b02b2215c39161f744a150afeecf87231663e3cf3b47c2517dd20623277ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26e50b5d19184dc33254f8cd5dbe1cbb99c6f9c4eb887392ffa73217053abbd7e3ee10425be9b125f719fe912c2b1d36b82a16029e8cc6c32f57cabf03932aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac42add2d5396d7739804552cb81317af78fa411d9e1ca6bbe33968d8d60ce5d698c55c4b7c3ae68ed7cfb4a8f2589ea13fd365793740118f503db599b453f1"} build_url:https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/HSfXXgxfTneZuQ6I2UlqdA/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/Fx-Team/sha512/b70ee39b934f0a033bed183a7d6f915d2ca90a1f71be3193aeba9dd06e5fb9043a8b02b2215c39161f744a150afeecf87231663e3cf3b47c2517dd20623277ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26e50b5d19184dc33254f8cd5dbe1cbb99c6f9c4eb887392ffa73217053abbd7e3ee10425be9b125f719fe912c2b1d36b82a16029e8cc6c32f57cabf03932aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac42add2d5396d7739804552cb81317af78fa411d9e1ca6bbe33968d8d60ce5d698c55c4b7c3ae68ed7cfb4a8f2589ea13fd365793740118f503db599b453f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 11:55:11.680571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:55:11.680886) ========= 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=41bf3e9aed84707956354da8000001c5-1468348481.94869-530461850 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:55:11.763469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 11:55:11.763818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 11:55:11.764112) ========= ========= Total master_lag: 0.17 =========