builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1467882936.79 results: success (0) buildid: 20160706232202 builduid: 420b71683ab2462a808d90c06869eea0 revision: 1052561d1faf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.791800) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.792734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.793390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.810736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.811331) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 02:15:37-- 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% 89.1M=0s 2016-07-07 02:15:37 (89.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.900885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.901559) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015060 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.954842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:36.955636) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1052561d1faf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1052561d1faf --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=8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 02:15:37,443 Setting DEBUG logging. 2016-07-07 02:15:37,443 attempt 1/10 2016-07-07 02:15:37,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1052561d1faf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 02:15:37,762 unpacking tar archive at: mozilla-inbound-1052561d1faf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:37.691380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:37.692136) ========= script_repo_revision: 1052561d1faf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:37.693072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:37.693758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 02:15:37.705544) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-07 02:15:37.706181) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:15:38 INFO - MultiFileLogger online at 20160707 02:15:38 in /builds/slave/test 02:15:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:15:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:15:38 INFO - {'append_to_log': False, 02:15:38 INFO - 'base_work_dir': '/builds/slave/test', 02:15:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:15:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:15:38 INFO - 'branch': 'Mozilla-Inbound', 02:15:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:15:38 INFO - 'config_files': ('talos/linux_config.py',), 02:15:38 INFO - 'default_actions': ('clobber', 02:15:38 INFO - 'read-buildbot-config', 02:15:38 INFO - 'download-and-extract', 02:15:38 INFO - 'populate-webroot', 02:15:38 INFO - 'create-virtualenv', 02:15:38 INFO - 'install', 02:15:38 INFO - 'run-tests'), 02:15:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:15:38 INFO - 'download_minidump_stackwalk': True, 02:15:38 INFO - 'download_symbols': 'ondemand', 02:15:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:15:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:15:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:15:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:15:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:15:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:15:38 INFO - 'installer_path': 'installer.exe', 02:15:38 INFO - 'log_level': 'info', 02:15:38 INFO - 'log_name': 'talos', 02:15:38 INFO - 'log_to_console': True, 02:15:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:15:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:15:38 INFO - 'opt_config_files': (), 02:15:38 INFO - 'pip_index': False, 02:15:38 INFO - 'sps_profile': False, 02:15:38 INFO - 'sps_profile_interval': 0, 02:15:38 INFO - 'suite': 'dromaeojs', 02:15:38 INFO - 'system_bits': '32', 02:15:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:15:38 INFO - 'title': 'talos-linux64-ix-001', 02:15:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:15:38 INFO - 'use_talos_json': True, 02:15:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:15:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:15:38 INFO - 'work_dir': 'build'} 02:15:38 INFO - ##### 02:15:38 INFO - ##### Running clobber step. 02:15:38 INFO - ##### 02:15:38 INFO - Running pre-action listener: _resource_record_pre_action 02:15:38 INFO - Running main action method: clobber 02:15:38 INFO - rmtree: /builds/slave/test/build 02:15:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:15:39 INFO - Running post-action listener: _resource_record_post_action 02:15:39 INFO - ##### 02:15:39 INFO - ##### Finished clobber step (success) 02:15:39 INFO - ##### 02:15:39 INFO - ##### 02:15:39 INFO - ##### Running read-buildbot-config step. 02:15:39 INFO - ##### 02:15:39 INFO - Running pre-action listener: _resource_record_pre_action 02:15:39 INFO - Running main action method: read_buildbot_config 02:15:39 INFO - Using buildbot properties: 02:15:39 INFO - { 02:15:39 INFO - "project": "", 02:15:39 INFO - "product": "firefox", 02:15:39 INFO - "script_repo_revision": "production", 02:15:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:15:39 INFO - "repository": "", 02:15:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:15:39 INFO - "buildid": "20160706232202", 02:15:39 INFO - "pgo_build": "True", 02:15:39 INFO - "basedir": "/builds/slave/test", 02:15:39 INFO - "buildnumber": 1295, 02:15:39 INFO - "slavename": "talos-linux64-ix-001", 02:15:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:15:39 INFO - "platform": "ubuntu64_hw", 02:15:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:15:39 INFO - "branch": "mozilla-inbound", 02:15:39 INFO - "repo_path": "integration/mozilla-inbound", 02:15:39 INFO - "revision": "1052561d1faf", 02:15:39 INFO - "stage_platform": "linux64-pgo", 02:15:39 INFO - "builduid": "420b71683ab2462a808d90c06869eea0", 02:15:39 INFO - "slavebuilddir": "test" 02:15:39 INFO - } 02:15:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:15:39 INFO - Running post-action listener: _resource_record_post_action 02:15:39 INFO - ##### 02:15:39 INFO - ##### Finished read-buildbot-config step (success) 02:15:39 INFO - ##### 02:15:39 INFO - ##### 02:15:39 INFO - ##### Running download-and-extract step. 02:15:39 INFO - ##### 02:15:39 INFO - Running pre-action listener: _resource_record_pre_action 02:15:39 INFO - Running main action method: download_and_extract 02:15:39 INFO - mkdir: /builds/slave/test/build/tests 02:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:39 INFO - https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:40 INFO - Downloaded 1361 bytes. 02:15:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:15:40 INFO - Using the following test package requirements: 02:15:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:15:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:15:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:15:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'jsshell-linux-x86_64.zip'], 02:15:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:15:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:15:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:15:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:15:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:15:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:15:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:15:40 INFO - https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:41 INFO - Downloaded 24258762 bytes. 02:15:41 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'] 02:15:41 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 02:15:42 INFO - Return code: 0 02:15:42 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 02:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:15:42 INFO - https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:43 INFO - Downloaded 24258762 bytes. 02:15:43 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'] 02:15:43 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 02:15:45 INFO - Return code: 0 02:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:15:45 INFO - https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:15:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:15:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:15:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:46 INFO - Downloaded 14403333 bytes. 02:15:46 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'] 02:15:46 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 02:15:46 INFO - Return code: 0 02:15: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')]} 02:15:46 INFO - https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:15:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:15:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:15:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JUyAWAOaTIGJUInl-pqpSw/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 02:15:47 INFO - Downloaded 59672019 bytes. 02:15:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:15:47 INFO - mkdir: /builds/slave/test/properties 02:15:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:15:47 INFO - Writing to file /builds/slave/test/properties/build_url 02:15:47 INFO - Contents: 02:15:47 INFO - build_url:https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:15:48 INFO - Running post-action listener: _resource_record_post_action 02:15:48 INFO - Running post-action listener: set_extra_try_arguments 02:15:48 INFO - ##### 02:15:48 INFO - ##### Finished download-and-extract step (success) 02:15:48 INFO - ##### 02:15:48 INFO - ##### 02:15:48 INFO - ##### Running populate-webroot step. 02:15:48 INFO - ##### 02:15:48 INFO - Running pre-action listener: _resource_record_pre_action 02:15:48 INFO - Running main action method: populate_webroot 02:15:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:15:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:15:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:15:48 INFO - '--tppagecycles', 02:15:48 INFO - '7'], 02:15:48 INFO - 'tests': ['tsvgm']}}, 02:15:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:15:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:15:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:15:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:15:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['damp', 'tps']}, 02:15:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'tests': ['damp', 'tps']}, 02:15:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['dromaeo_dom']}, 02:15:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:15:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['basic_compositor_video']}, 02:15:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:15:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['a11yr', 02:15:48 INFO - 'ts_paint', 02:15:48 INFO - 'tpaint', 02:15:48 INFO - 'sessionrestore', 02:15:48 INFO - 'sessionrestore_no_auto_restore', 02:15:48 INFO - 'tabpaint']}, 02:15:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:15:48 INFO - 'ts_paint', 02:15:48 INFO - 'tpaint', 02:15:48 INFO - 'sessionrestore', 02:15:48 INFO - 'sessionrestore_no_auto_restore', 02:15:48 INFO - 'tabpaint']}, 02:15:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:15:48 INFO - 'ts_paint', 02:15:48 INFO - 'tpaint', 02:15:48 INFO - 'sessionrestore', 02:15:48 INFO - 'sessionrestore_no_auto_restore', 02:15:48 INFO - 'tabpaint']}, 02:15:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:15:48 INFO - 'ts_paint', 02:15:48 INFO - 'tpaint', 02:15:48 INFO - 'sessionrestore', 02:15:48 INFO - 'sessionrestore_no_auto_restore', 02:15:48 INFO - 'tabpaint']}, 02:15:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['a11yr', 02:15:48 INFO - 'ts_paint', 02:15:48 INFO - 'tpaint', 02:15:48 INFO - 'sessionrestore', 02:15:48 INFO - 'sessionrestore_no_auto_restore', 02:15:48 INFO - 'tabpaint']}, 02:15:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['a11yr', 02:15:48 INFO - 'ts_paint', 02:15:48 INFO - 'tpaint', 02:15:48 INFO - 'sessionrestore', 02:15:48 INFO - 'sessionrestore_no_auto_restore', 02:15:48 INFO - 'tabpaint']}, 02:15:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['tsvgx', 02:15:48 INFO - 'tsvgr_opacity', 02:15:48 INFO - 'tart', 02:15:48 INFO - 'tscrollx', 02:15:48 INFO - 'cart']}, 02:15:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:15:48 INFO - 'tsvgr_opacity', 02:15:48 INFO - 'tart', 02:15:48 INFO - 'tscrollx', 02:15:48 INFO - 'cart']}, 02:15:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'talos_options': ['--disable-e10s'], 02:15:48 INFO - 'tests': ['tp5o']}, 02:15:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'tests': ['tp5o']}, 02:15:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'talos_options': ['--disable-e10s', 02:15:48 INFO - '--xperf_path', 02:15:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:48 INFO - 'tests': ['tp5n']}, 02:15:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:48 INFO - 'talos_options': ['--xperf_path', 02:15:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:48 INFO - 'tests': ['tp5n']}}, 02:15:48 INFO - 'talos.zip': {'path': '', 02:15:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:15:48 INFO - Running post-action listener: _resource_record_post_action 02:15:48 INFO - ##### 02:15:48 INFO - ##### Finished populate-webroot step (success) 02:15:48 INFO - ##### 02:15:48 INFO - ##### 02:15:48 INFO - ##### Running create-virtualenv step. 02:15:48 INFO - ##### 02:15:48 INFO - Running pre-action listener: _resource_record_pre_action 02:15:48 INFO - Running main action method: create_virtualenv 02:15:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:15:48 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 02:15:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:15:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:15:48 INFO - Using real prefix '/usr' 02:15:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:15:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:15:51 INFO - Installing pip.................done. 02:15:51 INFO - Return code: 0 02:15:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:51 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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:15:51 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 02:15:51 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 02:15:51 INFO - Using env: {'DISPLAY': ':0', 02:15:51 INFO - 'HOME': '/home/cltbld', 02:15:51 INFO - 'LANG': 'en_US.UTF-8', 02:15:51 INFO - 'LANGUAGE': 'en_US:en', 02:15:51 INFO - 'LOGNAME': 'cltbld', 02:15:51 INFO - 'MAIL': '/var/mail/cltbld', 02:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:51 INFO - 'MOZ_NO_REMOTE': '1', 02:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:51 INFO - 'NO_EM_RESTART': '1', 02:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:51 INFO - 'PWD': '/builds/slave/test', 02:15:51 INFO - 'SHELL': '/bin/bash', 02:15:51 INFO - 'SHLVL': '1', 02:15:51 INFO - 'TERM': 'linux', 02:15:51 INFO - 'TMOUT': '86400', 02:15:51 INFO - 'USER': 'cltbld', 02:15:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:51 INFO - '_': '/tools/buildbot/bin/python'} 02:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:51 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 02:15:51 INFO - Cleaning up... 02:15:51 INFO - Return code: 0 02:15:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:51 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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:15:51 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 02:15:51 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 02:15:51 INFO - Using env: {'DISPLAY': ':0', 02:15:51 INFO - 'HOME': '/home/cltbld', 02:15:51 INFO - 'LANG': 'en_US.UTF-8', 02:15:51 INFO - 'LANGUAGE': 'en_US:en', 02:15:51 INFO - 'LOGNAME': 'cltbld', 02:15:51 INFO - 'MAIL': '/var/mail/cltbld', 02:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:51 INFO - 'MOZ_NO_REMOTE': '1', 02:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:51 INFO - 'NO_EM_RESTART': '1', 02:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:51 INFO - 'PWD': '/builds/slave/test', 02:15:51 INFO - 'SHELL': '/bin/bash', 02:15:51 INFO - 'SHLVL': '1', 02:15:51 INFO - 'TERM': 'linux', 02:15:51 INFO - 'TMOUT': '86400', 02:15:51 INFO - 'USER': 'cltbld', 02:15:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:51 INFO - '_': '/tools/buildbot/bin/python'} 02:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:51 INFO - Downloading/unpacking psutil>=3.1.1 02:15:51 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 02:15:51 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 02:15:51 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 02:15:51 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 02:15:51 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 02:15:51 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 02:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:15:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:53 INFO - Installing collected packages: psutil 02:15:53 INFO - Running setup.py install for psutil 02:15:53 INFO - building 'psutil._psutil_linux' extension 02:15:53 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 02:15:53 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 02:15:53 INFO - building 'psutil._psutil_posix' extension 02:15:53 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 02:15:53 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 02:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:54 INFO - Successfully installed psutil 02:15:54 INFO - Cleaning up... 02:15:54 INFO - Return code: 0 02:15:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:54 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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:15:54 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 02:15:54 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 02:15:54 INFO - Using env: {'DISPLAY': ':0', 02:15:54 INFO - 'HOME': '/home/cltbld', 02:15:54 INFO - 'LANG': 'en_US.UTF-8', 02:15:54 INFO - 'LANGUAGE': 'en_US:en', 02:15:54 INFO - 'LOGNAME': 'cltbld', 02:15:54 INFO - 'MAIL': '/var/mail/cltbld', 02:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:54 INFO - 'MOZ_NO_REMOTE': '1', 02:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:54 INFO - 'NO_EM_RESTART': '1', 02:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:54 INFO - 'PWD': '/builds/slave/test', 02:15:54 INFO - 'SHELL': '/bin/bash', 02:15:54 INFO - 'SHLVL': '1', 02:15:54 INFO - 'TERM': 'linux', 02:15:54 INFO - 'TMOUT': '86400', 02:15:54 INFO - 'USER': 'cltbld', 02:15:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:54 INFO - '_': '/tools/buildbot/bin/python'} 02:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:15:54 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 02:15:54 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 02:15:54 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 02:15:54 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 02:15:54 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 02:15:54 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 02:15:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:15:56 INFO - Installing collected packages: mozsystemmonitor 02:15:56 INFO - Running setup.py install for mozsystemmonitor 02:15:56 INFO - Successfully installed mozsystemmonitor 02:15:56 INFO - Cleaning up... 02:15:56 INFO - Return code: 0 02:15:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:15:56 INFO - Using env: {'DISPLAY': ':0', 02:15:56 INFO - 'HOME': '/home/cltbld', 02:15:56 INFO - 'LANG': 'en_US.UTF-8', 02:15:56 INFO - 'LANGUAGE': 'en_US:en', 02:15:56 INFO - 'LOGNAME': 'cltbld', 02:15:56 INFO - 'MAIL': '/var/mail/cltbld', 02:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:56 INFO - 'MOZ_NO_REMOTE': '1', 02:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:56 INFO - 'NO_EM_RESTART': '1', 02:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:56 INFO - 'PWD': '/builds/slave/test', 02:15:56 INFO - 'SHELL': '/bin/bash', 02:15:56 INFO - 'SHLVL': '1', 02:15:56 INFO - 'TERM': 'linux', 02:15:56 INFO - 'TMOUT': '86400', 02:15:56 INFO - 'USER': 'cltbld', 02:15:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:56 INFO - '_': '/tools/buildbot/bin/python'} 02:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:56 INFO - Downloading/unpacking jsonschema==2.5.1 02:15:56 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 02:15:56 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 02:15:56 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 02:15:56 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 02:15:56 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 02:15:56 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 02:15:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:15:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:15:58 INFO - warning: no files found matching '*.txt' 02:15:58 INFO - no previously-included directories found matching 'build' 02:15:58 INFO - no previously-included directories found matching 'dist' 02:15:58 INFO - no previously-included directories found matching '.git*' 02:15:58 INFO - Installing collected packages: jsonschema, functools32 02:15:58 INFO - Running setup.py install for functools32 02:15:58 INFO - warning: no files found matching '*.txt' 02:15:58 INFO - no previously-included directories found matching 'build' 02:15:58 INFO - no previously-included directories found matching 'dist' 02:15:58 INFO - no previously-included directories found matching '.git*' 02:15:58 INFO - Successfully installed jsonschema functools32 02:15:58 INFO - Cleaning up... 02:15:58 INFO - Return code: 0 02:15:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:15: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')]} 02:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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', '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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:15: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 blobuploader==1.2.4 02:15:58 INFO - Using env: {'DISPLAY': ':0', 02:15:58 INFO - 'HOME': '/home/cltbld', 02:15:58 INFO - 'LANG': 'en_US.UTF-8', 02:15:58 INFO - 'LANGUAGE': 'en_US:en', 02:15:58 INFO - 'LOGNAME': 'cltbld', 02:15:58 INFO - 'MAIL': '/var/mail/cltbld', 02:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:58 INFO - 'MOZ_NO_REMOTE': '1', 02:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:58 INFO - 'NO_EM_RESTART': '1', 02:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:58 INFO - 'PWD': '/builds/slave/test', 02:15:58 INFO - 'SHELL': '/bin/bash', 02:15:58 INFO - 'SHLVL': '1', 02:15:58 INFO - 'TERM': 'linux', 02:15:58 INFO - 'TMOUT': '86400', 02:15:58 INFO - 'USER': 'cltbld', 02:15:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:58 INFO - '_': '/tools/buildbot/bin/python'} 02:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:15:59 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 02:15:59 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 02:15:59 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 02:15:59 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 02:15:59 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 02:15:59 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 02:16:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:16:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:16:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 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 02:16:01 INFO - Downloading docopt-0.6.1.tar.gz 02:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:16:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:16:01 INFO - Running setup.py install for blobuploader 02:16:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:16:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:16:01 INFO - Running setup.py install for requests 02:16:02 INFO - Running setup.py install for docopt 02:16:02 INFO - Successfully installed blobuploader requests docopt 02:16:02 INFO - Cleaning up... 02:16:02 INFO - Return code: 0 02:16:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16: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')]} 02:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16: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')]} 02:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:02 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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:16:02 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 02:16:02 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 02:16:02 INFO - Using env: {'DISPLAY': ':0', 02:16:02 INFO - 'HOME': '/home/cltbld', 02:16:02 INFO - 'LANG': 'en_US.UTF-8', 02:16:02 INFO - 'LANGUAGE': 'en_US:en', 02:16:02 INFO - 'LOGNAME': 'cltbld', 02:16:02 INFO - 'MAIL': '/var/mail/cltbld', 02:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:02 INFO - 'MOZ_NO_REMOTE': '1', 02:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:02 INFO - 'NO_EM_RESTART': '1', 02:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:02 INFO - 'PWD': '/builds/slave/test', 02:16:02 INFO - 'SHELL': '/bin/bash', 02:16:02 INFO - 'SHLVL': '1', 02:16:02 INFO - 'TERM': 'linux', 02:16:02 INFO - 'TMOUT': '86400', 02:16:02 INFO - 'USER': 'cltbld', 02:16:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:02 INFO - '_': '/tools/buildbot/bin/python'} 02:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:02 INFO - Running setup.py (path:/tmp/pip-_NHTll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:02 INFO - Running setup.py (path:/tmp/pip-Lg3TZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:02 INFO - Running setup.py (path:/tmp/pip-eUM9Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:02 INFO - Running setup.py (path:/tmp/pip-oQgOfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:02 INFO - Running setup.py (path:/tmp/pip-7bU_Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:03 INFO - Running setup.py (path:/tmp/pip-cXsdip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:03 INFO - Running setup.py (path:/tmp/pip-4QKzzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:03 INFO - Running setup.py (path:/tmp/pip-8icpv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:03 INFO - Running setup.py (path:/tmp/pip-sNXYqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:03 INFO - Running setup.py (path:/tmp/pip-uRjMwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:03 INFO - Running setup.py (path:/tmp/pip-PinYSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:03 INFO - Running setup.py (path:/tmp/pip-ZL1uss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:03 INFO - Running setup.py (path:/tmp/pip-g7xKV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:03 INFO - Running setup.py (path:/tmp/pip-t6haUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:03 INFO - Running setup.py (path:/tmp/pip-o0BRa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:03 INFO - Running setup.py (path:/tmp/pip-1PLNIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:03 INFO - Running setup.py (path:/tmp/pip-P_7KsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:16:03 INFO - Running setup.py install for manifestparser 02:16:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:16:03 INFO - Running setup.py install for mozcrash 02:16:04 INFO - Running setup.py install for mozdebug 02:16:04 INFO - Running setup.py install for mozdevice 02:16:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Running setup.py install for mozfile 02:16:04 INFO - Running setup.py install for mozhttpd 02:16:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Running setup.py install for mozinfo 02:16:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Running setup.py install for mozInstall 02:16:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Running setup.py install for mozleak 02:16:04 INFO - Running setup.py install for mozlog 02:16:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Running setup.py install for moznetwork 02:16:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:16:05 INFO - Running setup.py install for mozprocess 02:16:05 INFO - Running setup.py install for mozprofile 02:16:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:16:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:16:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:16:05 INFO - Running setup.py install for mozrunner 02:16:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:16:05 INFO - Running setup.py install for mozscreenshot 02:16:05 INFO - Running setup.py install for moztest 02:16:05 INFO - Running setup.py install for mozversion 02:16:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:16:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:16:05 INFO - Cleaning up... 02:16:05 INFO - Return code: 0 02:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:05 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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:16:05 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 02:16:05 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 02:16:05 INFO - Using env: {'DISPLAY': ':0', 02:16:05 INFO - 'HOME': '/home/cltbld', 02:16:05 INFO - 'LANG': 'en_US.UTF-8', 02:16:05 INFO - 'LANGUAGE': 'en_US:en', 02:16:05 INFO - 'LOGNAME': 'cltbld', 02:16:05 INFO - 'MAIL': '/var/mail/cltbld', 02:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:05 INFO - 'MOZ_NO_REMOTE': '1', 02:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:05 INFO - 'NO_EM_RESTART': '1', 02:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:05 INFO - 'PWD': '/builds/slave/test', 02:16:05 INFO - 'SHELL': '/bin/bash', 02:16:05 INFO - 'SHLVL': '1', 02:16:05 INFO - 'TERM': 'linux', 02:16:05 INFO - 'TMOUT': '86400', 02:16:05 INFO - 'USER': 'cltbld', 02:16:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:05 INFO - '_': '/tools/buildbot/bin/python'} 02:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:05 INFO - Running setup.py (path:/tmp/pip-lh4FUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:05 INFO - Running setup.py (path:/tmp/pip-0mQ8a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:06 INFO - Running setup.py (path:/tmp/pip-OOhONW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:06 INFO - Running setup.py (path:/tmp/pip-gsxC2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:06 INFO - Running setup.py (path:/tmp/pip-4jSgvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:06 INFO - Running setup.py (path:/tmp/pip-gL2x74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:06 INFO - Running setup.py (path:/tmp/pip-ruFKzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:06 INFO - Running setup.py (path:/tmp/pip-oF4E7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:06 INFO - Running setup.py (path:/tmp/pip-db0zp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:06 INFO - Running setup.py (path:/tmp/pip-sIidS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:06 INFO - Running setup.py (path:/tmp/pip-tSrawa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:06 INFO - Running setup.py (path:/tmp/pip-EkDeWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:06 INFO - Running setup.py (path:/tmp/pip-tQdKUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:06 INFO - Running setup.py (path:/tmp/pip-yXV_1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:06 INFO - Running setup.py (path:/tmp/pip-cjwnRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:06 INFO - Running setup.py (path:/tmp/pip-zVgtg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:07 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)) 02:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:07 INFO - Running setup.py (path:/tmp/pip-YLagDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:07 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)) 02:16:07 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)) 02:16:07 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)) 02:16:07 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)) 02:16:07 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)) 02:16:07 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)) 02:16:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:16:07 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 02:16:07 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 02:16:07 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 02:16:07 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 02:16:07 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 02:16:07 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 02:16:09 INFO - Downloading blessings-1.6.tar.gz 02:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:16:09 INFO - Installing collected packages: blessings 02:16:09 INFO - Running setup.py install for blessings 02:16:09 INFO - Successfully installed blessings 02:16:09 INFO - Cleaning up... 02:16:09 INFO - Return code: 0 02:16:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:09 INFO - Reading from file tmpfile_stdout 02:16:09 INFO - Current package versions: 02:16:09 INFO - argparse == 1.2.1 02:16:09 INFO - blessings == 1.6 02:16:09 INFO - blobuploader == 1.2.4 02:16:09 INFO - docopt == 0.6.1 02:16:09 INFO - functools32 == 3.2.3-2 02:16:09 INFO - jsonschema == 2.5.1 02:16:09 INFO - manifestparser == 1.1 02:16:09 INFO - mozInstall == 1.12 02:16:09 INFO - mozcrash == 0.17 02:16:09 INFO - mozdebug == 0.1 02:16:09 INFO - mozdevice == 0.48 02:16:09 INFO - mozfile == 1.2 02:16:09 INFO - mozhttpd == 0.7 02:16:09 INFO - mozinfo == 0.9 02:16:09 INFO - mozleak == 0.1 02:16:09 INFO - mozlog == 3.2 02:16:09 INFO - moznetwork == 0.27 02:16:09 INFO - mozprocess == 0.23 02:16:09 INFO - mozprofile == 0.28 02:16:09 INFO - mozrunner == 6.12 02:16:09 INFO - mozscreenshot == 0.1 02:16:09 INFO - mozsystemmonitor == 0.3 02:16:09 INFO - moztest == 0.7 02:16:09 INFO - mozversion == 1.4 02:16:09 INFO - psutil == 3.1.1 02:16:09 INFO - requests == 1.2.3 02:16:09 INFO - wsgiref == 0.1.2 02:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16: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')]} 02:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16: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')]} 02:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:09 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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:16:09 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 02:16:09 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 02:16:09 INFO - Using env: {'DISPLAY': ':0', 02:16:09 INFO - 'HOME': '/home/cltbld', 02:16:09 INFO - 'LANG': 'en_US.UTF-8', 02:16:09 INFO - 'LANGUAGE': 'en_US:en', 02:16:09 INFO - 'LOGNAME': 'cltbld', 02:16:09 INFO - 'MAIL': '/var/mail/cltbld', 02:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:09 INFO - 'MOZ_NO_REMOTE': '1', 02:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:09 INFO - 'NO_EM_RESTART': '1', 02:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:09 INFO - 'PWD': '/builds/slave/test', 02:16:09 INFO - 'SHELL': '/bin/bash', 02:16:09 INFO - 'SHLVL': '1', 02:16:09 INFO - 'TERM': 'linux', 02:16:09 INFO - 'TMOUT': '86400', 02:16:09 INFO - 'USER': 'cltbld', 02:16:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:09 INFO - '_': '/tools/buildbot/bin/python'} 02:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 INFO - Cleaning up... 02:16:09 INFO - Return code: 0 02:16:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:16: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')]} 02:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16: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')]} 02:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:09 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 0x258b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, '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': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', '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 02:16:09 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 02:16:09 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 02:16:09 INFO - Using env: {'DISPLAY': ':0', 02:16:09 INFO - 'HOME': '/home/cltbld', 02:16:09 INFO - 'LANG': 'en_US.UTF-8', 02:16:09 INFO - 'LANGUAGE': 'en_US:en', 02:16:09 INFO - 'LOGNAME': 'cltbld', 02:16:09 INFO - 'MAIL': '/var/mail/cltbld', 02:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:09 INFO - 'MOZ_NO_REMOTE': '1', 02:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:09 INFO - 'NO_EM_RESTART': '1', 02:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:09 INFO - 'PWD': '/builds/slave/test', 02:16:09 INFO - 'SHELL': '/bin/bash', 02:16:09 INFO - 'SHLVL': '1', 02:16:09 INFO - 'TERM': 'linux', 02:16:09 INFO - 'TMOUT': '86400', 02:16:09 INFO - 'USER': 'cltbld', 02:16:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:09 INFO - '_': '/tools/buildbot/bin/python'} 02:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:16:09 INFO - Cleaning up... 02:16:09 INFO - Return code: 0 02:16:09 INFO - Running post-action listener: _resource_record_post_action 02:16:09 INFO - Running post-action listener: _start_resource_monitoring 02:16:09 INFO - Starting resource monitoring. 02:16:09 INFO - ##### 02:16:09 INFO - ##### Finished create-virtualenv step (success) 02:16:09 INFO - ##### 02:16:09 INFO - ##### 02:16:09 INFO - ##### Running install step. 02:16:09 INFO - ##### 02:16:09 INFO - Running pre-action listener: _resource_record_pre_action 02:16:09 INFO - Running main action method: install 02:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:10 INFO - Reading from file tmpfile_stdout 02:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:16:10 INFO - Reading from file tmpfile_stdout 02:16:10 INFO - Output received: 02:16:10 INFO - Usage: mozinstall [options] installer 02:16:10 INFO - Options: 02:16:10 INFO - -h, --help show this help message and exit 02:16:10 INFO - -d DEST, --destination=DEST 02:16:10 INFO - Directory to install application into. [default: 02:16:10 INFO - "/builds/slave/test"] 02:16:10 INFO - --app=APP Application being installed. [default: firefox] 02:16:10 INFO - mkdir: /builds/slave/test/build/application 02:16:10 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'] 02:16:10 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 02:16:27 INFO - Reading from file tmpfile_stdout 02:16:27 INFO - Output received: 02:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:16:27 INFO - Running post-action listener: _resource_record_post_action 02:16:27 INFO - ##### 02:16:27 INFO - ##### Finished install step (success) 02:16:27 INFO - ##### 02:16:27 INFO - ##### 02:16:27 INFO - ##### Running run-tests step. 02:16:27 INFO - ##### 02:16:27 INFO - Running pre-action listener: _resource_record_pre_action 02:16:27 INFO - Running main action method: run_tests 02:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:16:27 INFO - Python 2.7.3 02:16:27 INFO - Return code: 0 02:16:27 INFO - grabbing minidump binary from tooltool 02:16:27 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')]} 02:16:27 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 0x284a3b0>, '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 0x284b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:16:27 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 02:16:27 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 02:16:27 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 02:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:16:27 INFO - Return code: 0 02:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 02:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 02:16:27 INFO - Using env: {'DISPLAY': ':0', 02:16:27 INFO - 'HOME': '/home/cltbld', 02:16:27 INFO - 'LANG': 'en_US.UTF-8', 02:16:27 INFO - 'LANGUAGE': 'en_US:en', 02:16:27 INFO - 'LOGNAME': 'cltbld', 02:16:27 INFO - 'MAIL': '/var/mail/cltbld', 02:16:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:16:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:27 INFO - 'MOZ_NO_REMOTE': '1', 02:16:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:27 INFO - 'NO_EM_RESTART': '1', 02:16:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:27 INFO - 'PWD': '/builds/slave/test', 02:16:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:16:27 INFO - 'SHELL': '/bin/bash', 02:16:27 INFO - 'SHLVL': '1', 02:16:27 INFO - 'TERM': 'linux', 02:16:27 INFO - 'TMOUT': '86400', 02:16:27 INFO - 'USER': 'cltbld', 02:16:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419', 02:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:27 INFO - '_': '/tools/buildbot/bin/python'} 02:16:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 02:16:27 INFO - mozversion application_buildid: 20160706232202 02:16:27 INFO - mozversion application_changeset: 1052561d1faf90af585c7b17909049d7bd960050 02:16:27 INFO - mozversion application_display_name: Nightly 02:16:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:16:27 INFO - mozversion application_name: Firefox 02:16:27 INFO - mozversion application_remotingname: firefox 02:16:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:16:27 INFO - mozversion application_vendor: Mozilla 02:16:27 INFO - mozversion application_version: 50.0a1 02:16:27 INFO - mozversion platform_buildid: 20160706232202 02:16:27 INFO - mozversion platform_changeset: 1052561d1faf90af585c7b17909049d7bd960050 02:16:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:16:27 INFO - mozversion platform_version: 50.0a1 02:16:27 INFO - using testdate: 1467882987 02:16:27 INFO - actual date: 1467882987 02:16:27 INFO - starting webserver on 'localhost:38136' 02:16:27 INFO - SUITE-START | Running 2 tests 02:16:27 INFO - TEST-START | dromaeo_css 02:16:27 INFO - operating with platform_type : linux_ 02:16:27 INFO - Initialising browser for dromaeo_css test... 02:16:27 INFO - TEST-INFO | started process 22534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoUy712/profile http://localhost:38136/getInfo.html) 02:16:31 INFO - PROCESS | 22534 | __metrics Screen width/height:1600/1200 02:16:31 INFO - PROCESS | 22534 | colorDepth:24 02:16:31 INFO - PROCESS | 22534 | Browser inner width/height: 1024/697 02:16:31 INFO - PROCESS | 22534 | __metrics 02:16:32 INFO - PROCESS | 22534 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:16:33 INFO - TEST-INFO | 22534: exit 0 02:16:33 INFO - Browser initialized. 02:16:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:16:33 INFO - TEST-INFO | started process 22616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoUy712/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:45 INFO - PROCESS | 22616 | RSS: Main: 157294592 02:16:45 INFO - PROCESS | 22616 | 02:17:36 INFO - PROCESS | 22616 | 1467883056689 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] 02:19:43 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:38136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38136/tests/dromaeo/cssquery-ext.html) 02:19:44 INFO - PROCESS | 22616 | RSS: Main: 278556672 02:19:44 INFO - PROCESS | 22616 | 02:22:47 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:38136/tests/dromaeo/cssquery-ext.html (next: http://localhost:38136/tests/dromaeo/cssquery-jquery.html) 02:22:48 INFO - PROCESS | 22616 | RSS: Main: 246255616 02:22:48 INFO - PROCESS | 22616 | 02:25:49 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:38136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38136/tests/dromaeo/cssquery-mootools.html) 02:25:50 INFO - PROCESS | 22616 | RSS: Main: 245817344 02:25:50 INFO - PROCESS | 22616 | 02:28:52 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:38136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38136/tests/dromaeo/cssquery-prototype.html) 02:28:53 INFO - PROCESS | 22616 | RSS: Main: 244219904 02:28:53 INFO - PROCESS | 22616 | 02:31:55 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:38136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38136/tests/dromaeo/cssquery-yui.html) 02:31:56 INFO - PROCESS | 22616 | RSS: Main: 223817728 02:31:56 INFO - PROCESS | 22616 | 02:34:58 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:38136/tests/dromaeo/cssquery-yui.html (next: http://localhost:38136/tests/dromaeo/cssquery-dojo.html) 02:34:59 INFO - PROCESS | 22616 | RSS: Main: 332558336 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | __start_tp_report 02:34:59 INFO - PROCESS | 22616 | _x_x_mozilla_page_load 02:34:59 INFO - PROCESS | 22616 | _x_x_mozilla_page_load_details 02:34:59 INFO - PROCESS | 22616 | |i|pagename|runs| 02:34:59 INFO - PROCESS | 22616 | |0;dojo.html;2796.902108426205;2798.2864369585755;2833.5891295762117;2834.3622684895913;2835.050258163515;4557.9088418231695;4608.746518941457;4664.2537194048955;4678.27486739555;4678.929816052762;4587.082583483309;4625.4680711718165;4630.953690463094;4663.300504924263;4671.089137618157;4189.183109293689;4209.263378908694;4211.473565804275;4289.571042895716;4290.549492303295;4220.662347012247;4272.209641216369;4317.244482215616;4351.151525452538;4351.303791393378;4180.038591124028;4216.304309788881;4228.154369126187;4260.9147817043795;4274.551172126929;4214.05183833635;4238.258304796679;4238.87283381499;4261.850835220753;4317.978410107929;4260.893477663052;4262.893427664302;4271.124419493996;4274.935875961863;4309.676774241944;4507.504174540798;4555.476120246181;4609.723416595015;4650.837220697294;4678.157931572316;4903;4917;4918.9508104919205;4921.581665558396;4929.852104436873;4902.264660300948;4929.309896614477;4929.605631549467;4938.407391113089;4954.851354459372;4564.8630541083485;4630.7453090080035;4667.299905014241;4675.672702910763;4678.204705200124;5022.924656130161;5024.095662780662;5039.244113383022;5041.470645582161;5098.59211263098;4852.344933434012;4885.877853053702;4889.119958407449;4890.828820991248;4895.902081958412;4772.379590653262;4786;4830.9371938173545;4834.20235661119;4886.193778026657;4805.3512775775525;4811.9518804812205;4821.325014497973;4842.128416884994;4859.246816743411;4797.2564252540915;4873.926891096637;4883.536064073907;4884.340614017134;4921.630877684188;3812.1803812180515;3824.8470061197795;3838.9232215355537;3847.7306588539095;3896.7661940283674;3475.9826200868833;3479.304139172176;3492.022233774547;3526.118470382404;3531.170175008871;4638.83764068256;4726.054789042205;4731.219348807477;4740.241561350167;4782.904341913212;4899.951000490021;4935.703857768545;4943.72809495474;4951.108800415887;4959.975200123977;4698.036902434993;4701.835435759732;4704.670673052853;4712.811487540528;4715.056988602293;4215.093754842724;4225.239456897726;4307.956920430818;4309.504406993173;4338.739675619473;5087.796488140433;5100.1074811907765;5114.795408183631;5118.795248190031;5147.253648220987;4896.192128298862;4900.5099490052135;4903.681260718042;4904.386951631046;4947.554720075066;5028.949710502849;5047.596192304681;5074.873128171826;5126.256692779451;5127.158305618168;4810.5670489656095;4812.302216178565;4832.782524786463;4876.341693871282;4883.951160488492;4868.050730107595;4898.951010489849;4903.681260718042;4904.11725889329;4923.113839508779;4666.78999445019;4691.202495575692;4720.952790472052;4722.480527141943;4780.832670856504;4728.219843725747;4748.525147485224;4748.691335063209;4749.05018996209;4793.304970779287;4722.881927951828;4724.055188962153;4729.645276604199;4730.574248317668;4783.186858234039;4689.882752931204;4694.9765251174895;4739.739314337745;4784.258439941815;4791.353167322367;4641.18779213643;4698.788554514987;4708.576228139484;4723.622110231105;4766.213574760126 02:34:59 INFO - PROCESS | 22616 | |1;ext.html;555.1256770586325;596.3499785234096;597.3280059932575;598.5570677698503;615.0620304036343;28828.423431531355;29326.41347173058;31278.2180445489;31350.52974205386;42388;40488.19023619526;41950.58049419505;42649;42757;42861.78569107158;8873.378863479575;8980.775480612972;8986.056464071276;8996.640134394616;9002.32482563807;7508.361789247921;8924.598393072327;9029.187373136416;10878.782424351508;11153.72115697106;10735.355878647268;11042.723931901726;11069.335839849595;11083.390413527253;11087.778244435107;11135.721606959809;11217.495212715447;11224.438778061065;11236.157288203418;11244.100471962265;10777.353358798497;10836.403997780119;10840.6205782798;10849.566017359297;10858.837117443245;42006.579934200876;42111.1577768446;42218.577814221775;42288.365674514906;42289.57710422918;3629.4737263096968;3635.8909232723063;3677.595464498903;3775.9811200944096;4090.2228576570656;33462;33843.32313353744;33927.4910876337;33990;34843;4515.119551687422;4579.313103034571;4596.126735920165;4642.976785116087;4650.906981860344;358683;358915;360897;361038;362144;61228;62803;62817.37182628207;62980;63011.369886301465;66475;66585.66707166433;66639;66646.66676666586;66685.6665716678;16573.17134143288;16910.32358705638;16978.23597938071;17029.829701702824;17079.914600426917;13089.672758181121;13157.144785588906;13165.407556659973;13178.538751143664;13190.274534900673;19168.71246931297;19772.40682779519;19787.30744423938;19815.702764458543;19855.404337869888;7076.433885289164;7227.313405226495;7267.600281984542;7281.134063344199;7287.672054757442;956.6556039825657;964.81668482988;967.327707243459;992.6128809764198;1013.133770626104;31702.207444814063;32176.839115804738;32812.67187328144;32817.3436531268;33559;1068.5992752717732;1111.6498303034518;1148.3970915269383;1156.1323558549534;1168.474186616009;16557.337706491846;16565.337386504645;16825.57936051584;16931.238094285785;17078.829211707973;509391;512844;513889;514974;515781;37853;57813.421865781645;57911.710441447525;57979.4202057974;58290.708546457;1187.0681515010847;1295.3846922711637;1309.8100775387516;1332.194022616303;1343.7648411527748;31169.376612468077;33674.49488257629;33885.3222935535;33974.49038264379;34603.826980864935;50576;50835.74582127214;51273.743631281606;51276.74361628168;51306;307001;307333;307601;308542;309183;35012.64987350094;41693.374599380426;42673.57326426696;42685.146297074505;45930.54069459263;47942.69812846316;48492.75753621209;49630;49952.50047499624;53269.733651331495;41723.37414938718;42215;42733.57266427296;42876.57123428726;43886.12227755491;41988.790056049525;42571.3614295792;42663.14673706446;42794.35808462813;43163.35254971115;41503.58496414997;42347.57652423436;42700;42709.35935961025;42982.57017429911;36844.44733329056;37577.62422375741;37851.810740946115;38194.236115278094;38761.80619096886;29051.709482905746;29086.418271634873;29271.70728292775;29590.704092958797;29594.55608165836 02:34:59 INFO - PROCESS | 22616 | |2;jquery.html;385.0969476577425;385.2987562636003;388.7240059557716;398.6969902873815;400.6794564348522;17638.735418968725;19071.14179861906;19389.806101938975;19420;19465.416037518862;17183;17543.38598149065;17672.20475078621;17749.55626109348;18799;5556.91664625031;5638.182463542784;5809.448102430262;5852.853678658025;5855.297364316288;5716.942830571704;5717.542596592283;5723.427657234285;5747.626404283729;5755;5519.116941289394;5700.800471983482;5711.400302968191;5712.514436272922;5746.683932383718;5732.484076433099;5740.138979153139;5763.106718458645;5771.855703607402;5791.681457519835;5080.542751152414;5153.896922061538;5166.121759300928;5176.948230517684;5177.974110129425;22938;23076.192333268424;23231.18690845829;23246.535069298687;23261.651075233884;2310.353101131669;2432.1609044879488;2580.3420127867275;2680.825746326502;2823.2236135062817;13957.651058723512;14432.927835360755;14602.780958285633;15194.696106077927;15216.239188040665;1925.5186203449139;1969.6257711035;1992.9601407971759;2003.7495313085865;2034.5422279987033;56603.716981415244;59696;78556.21443785547;80101.19898800996;80647;10056.34633748804;10520.684379468628;10521.316114452537;10679.199060070527;10780.946095269474;12779.552715654907;14638.707225855424;14685.265736713121;14699.632509187355;14701.92649036748;7526.661300241502;7956.7215147470715;8002.51984880909;8044.235797599219;8402.915970840213;8103.837923241502;8117.756467305991;8142.47073940192;8198.098209197104;8245.917540824636;6435.74257029723;6476.481881449473;6491.870162596816;6559.934400656028;6560.671966401661;1863.664540382717;1864.2356633780357;1886.302068234762;1904.183024771343;1943.8736482128616;881;981.293468702533;1031.2111234905303;1070.528967254421;1120.9551617935192;19504.609907801765;19806.70289945652;20186.495337616678;20241.79758202399;20363.389098327072;1005.7234260578399;1012.1801340913884;1032.8554002439664;1037.0355569320604;1038.6676263595577;10872.402017889091;11529.942350288362;11538.653840384803;11629;11636;378796;382533;384787;500777;531771;77033;90387;99260.50369748105;99284;101130;968.3366893677853;1004.6835246897058;1022.2946167144646;1028;1035.166690813902;17285.308587656353;17365.30538778435;17365.392211272545;17436.757679691982;17569.121543922498;42375.57624423839;42992.57007430011;43369.3494597575;43885.34171987359;44759.55240447684;59336.40663593309;61022.694886525285;61106;62093.68953155386;62832.37167628265;8441.451305665112;8711.47731136134;8770.693025744069;8857.911420885708;9050.049744776703;12211.498111624174;12996.805047924478;13093.738125237633;13405.329733513481;13646.590602281947;11451;11521.308721476738;11604.419779011185;11642.126840487166;11793.410329483662;10666.626668066581;11545.422728863692;11720.179587428798;11781.469833857669;11940.820887686517;11200.327980321206;11462.541498340306;11703.122265829927;11892.940535297268;12222.083343749076;8467.48021859874;8584.227419532272;8670.739877803677;8718.52048137333;8744.431611945203;10298.536565854405;11377.601783937522;11399.658010259705;11450.255733377304;11485.598004069818 02:34:59 INFO - PROCESS | 22616 | |3;mootools.html;1425.06658138919;1445.6169115184475;1529.3729570875944;1689.1216567384952;1693.136500384805;8342.74971750847;8780.165884240987;8862.91137088629;8867.866981995276;8874.068222836606;7343.963280183605;8576.785580360494;8651;8705.869411958825;8754.299656027519;2294.816414686821;2323.256557901472;2324.5699545584034;2324.6280595104786;2325.9185928492507;1914.301280032785;2313.375388645065;2322.2336628912417;2354.023080421623;2355.128602417108;2265.592193405186;2324.7094113235844;2327.441414060622;2331.8717470539113;2335.322756400642;2314.4213946513373;2318.8029017533445;2322.6864373309554;2330.9650355244685;2367.195153647768;2286.4283929017747;2308.9422764431024;2311.075569772088;2313.953720925589;2317.2353123469215;8953.149450802164;9033.683821066232;9053.185213330831;9061.093890610951;9063.229625481841;5232.136697444917;5307.177387504943;5307.973460132714;5329.573634109262;5375.43557926416;3539.610642829287;3586.3903136466865;3633.4368172933237;3682.668559829628;3699.8335074921424;1180.994095029528;1185.4843143232722;1194.6535504703625;1203.7291609387905;1220.8901198892142;12722.300273484861;12774.61676149717;12796.808047879289;12810;12821.615351539469;4748.0978614063215;4765.332853400527;4781.055180971499;4801.68789028712;4928.032933488576;10597.682069537927;10623.575056997788;10640.04239618438;10641.414722190199;10646.574137034588;5198.16829307309;5200.115980283361;5201.349831271091;5203.115470370046;5207.427183009866;4708.411448568929;4765.547273009059;4781.569658730731;4782.0435912817575;4793.952060479351;4003.8398464061693;4010.057636455431;4051.8987025324013;4121.464209652726;4217.936730949038;1126.2116518437126;1206.1617176062728;1263.753568054239;1281.9551315703904;1305.0799186573443;932.5011119051275;946.1673727120091;948.374073111743;951.743029382063;969.6945462179391;5697.706935122967;5783.508401785895;5913.142594323799;5949.2266005419015;5991.476187404805;892.3218354050967;912.762681702762;916.5142474488532;946.0823001688351;952.2001518724305;3778.4521244419407;3854.6723528500393;3855.9228815423535;3859.671927886161;3876.7673939563715;10937.945310273557;11331.660050198507;11361.602343917923;11388.829167562493;11395.487203075882;10997.725056873642;11337.716557085974;11348.659540213806;11348.773024539629;11354.829677554842;8109.918900811034;8256;8304.211099945496;8312.792180195544;8522.531260780717;5403.378611459732;5410.404855465817;5465.070937940639;5499.587530935116;5545.639533430314;10501.054905058581;10502.78994420092;10526.947365263124;10539.209559282932;10583.841242381217;10042.196624270187;10382.169426445715;10415.739606509595;10704.839427408438;10730.409827459565;7604.771856844303;7738.729144479917;7764.728234511765;7769.7669069928;7772.805679858049;8020.679172833022;8215.835683286421;8223.177682231968;8281.047679516932;8459.830803383775;7399.963000184965;7516.887246691414;7758.612069396395;7935.444518883854;7947.3244774194845;7532.811679707832;7570.507916985378;7594.8860767089645;7650.885236721565;7854.096778870503;7096.716131354894;7189.460790440842;7204.279572042754;7209.819754506179;7231.674574644048;4827.782749776339;4925.679830810986;4969.254611808257;5046.4701206374275;5080.593552515716;4934.210526315772;4954.5540901319055;4960.801567937242;5086.21163719624;5094.465081166424 02:34:59 INFO - PROCESS | 22616 | |4;prototype.html;316.3751590608547;327.5185477348298;328.3728079368407;330.18444442227695;334.04629781972466;4588.3805686232345;4689.273162659789;4704.341392205094;4728.881777955548;4773.928391074132;4663.48701642819;4674.789634466449;4692.648051396141;4703.85888423347;4734;3792.58281589025;3796.316663000666;3801.4677945087574;3801.650414102995;3809.1048603578274;3779.433085037239;3785.4889589905288;3795.5065841440573;3798.772073675588;3823.655870971612;3555.520004799345;3742.251549690073;3760.5111335526344;3761.9623803762024;3762.868299609514;3740.588535261119;3784.26206889658;3785.9053523661855;3788.8484460621544;3799.2401519696173;3353.1281866714585;3355.6979871811654;3359.3281343731105;3362.865485380582;3375;4546.318052292183;4619.422572178478;4678.929816052728;4681.976590117061;4696.812127514895;4218.050938538835;4243.130158317537;4249.787510624456;4269.914601707948;4276.102018576103;4903.975480122613;4930.852074437773;4939.703617782944;4944.505549445027;4955.653104282702;3643.344198044351;3646.179609587848;3647.4893514907935;3650.233450975298;3660.0666829958454;4845.812775869935;4912.804438142136;4917.262410638397;5062.291279220912;5070.416902056274;3687.483752274684;3703.166787472851;3711.721620878445;3721.330160571069;3734.4585035170294;3735.4396840474146;3744.251149770057;3760.7555508891833;3761.285355782393;3767.981160094182;4052.1490486997473;4177.122804211089;4214.892553723138;4220.810063547147;4238.660907127422;4878.975605121952;4924.901501969941;4935.358403407534;4936.975315123402;4945.788281870893;1289.3553223388305;1294.6310301564008;1295.9611211663664;1304.9739005219842;1310.1811367895066;872.9258013068833;876.2595606712318;878.7934835313696;884.964601415949;922.239152699026;4803.615710743132;4820.204666230103;4839.7096174228955;4842.612590992712;4859.465458799529;4979.228219625964;4995.200767877195;5036.6726162799305;5053.747312634354;5073.923891141636;4723.952760472352;4795.160846851787;4808.61531077513;4886.267059941038;4895.31465594817;2584.5735453650314;2633.2626864477975;2636.9208923732317;2643.352378667239;2646.2193652872447;5212.661177023481;5227.163653815372;5239.345081864767;5251.711155886386;5270.7101109439345;4843.128236917319;5038.848834534897;5057.342545469065;5062.924056139161;5165.9483405165465;5302.3637163540625;5306.46935306474;5311.336082989626;5311.442298558673;5332.09354409759;5024.547790698854;5053.11570475158;5056.418511871182;5080.771365288645;5090.26191202281;4798.95201047985;4995.850124496271;5011.498850114959;5033.446320904771;5049.974750126225;5290.523852853262;5317.973410132925;5320.255164277081;5327.280817089643;5327.866803329948;3730.2725968435893;3769.8680546180753;3769.8680546180753;3770.962290377061;3771.321162190722;4862.65961382714;5031.760866414556;5048.242763585345;5085.567726743268;5088.974555127201;4907.975460122677;4929.088118698052;4931.13705101613;4937.703737775745;4942.8764280893265;4933.432655244549;4936;4943.65394422387;4953.678010929278;4959.082569724613;4676.275177347517;4921.252955200852;4925.38432695913;4934.703917764946;4944.332515110414;4911.582515486224;4927.926081108714;4952.801887924443;4972.627052971114;4979.377577802775;4864.610831133572;4869.561739443467;4881.779555111222;4905.190643543918;4931.4328852181025 02:34:59 INFO - PROCESS | 22616 | |5;yui.html;700.8773464643688;740.4372676765656;750.9136449308328;788.9487183333083;820.9302209312208;15093.245337733111;15505.612359691013;15600.219989000532;15628.531144065682;15797.842021579809;14716.190609516472;14971.625709357271;14988.775168372484;15006.249687515608;15181.08913465193;614.1524695919625;745.9365953893926;754.705664790732;766.9923300767005;768.9231076892322;775.8176828445311;780.1886038519932;781.7146741439391;782.2881178127905;782.6008735544856;818.4311903227259;819.2790344496834;820.8481430935266;821.9506829590243;822.4243029879109;648.759958815239;795.5624406576388;806.4838503357855;806.8507326144623;813.353384059674;592.9229200203989;593.4569868570253;594.3729365519375;594.6342999055593;594.6848170469658;14099.295035248299;14158;14159.079659822079;14174.291285435687;14196.574102776933;13600.931995340059;13985.58043258704;14110.576682699535;14565.854341456556;14805.407783688639;12895.742085158337;13106.2136271824;13218.867811321956;13349.733005339936;13548.45806167762;4399.516053234173;4451.9777401113115;4483.39474170986;4529.773511324421;4628.305754136906;72627.63686181587;72714.63642681806;73092.6345368275;73687.63156184238;74724.62637686777;11008.779824403468;11323.263987840764;11731.530738770354;11895.940520297343;11964.521419143312;21048.579028419346;21130.366089017352;21140;21153.153873844873;21191;8102.837943241102;8221.79445513855;8435.325173986066;8492.045261612575;8508.574571271412;4127.8968025799595;4491.618212451978;4645.72125672454;4764.904701906012;4789.712617242907;3136.98431507841;3237.4496335623003;3240.7893486923276;3243.5621191139367;3245.1075954112807;542.1596525385637;582.4815913836688;587.3656451032874;615.923009623797;660.2044536333707;738.3354980517577;745.3478206569251;758.0600055930717;760.3233122520961;781.0783275734574;9950.900490995142;9989.900100999042;10083.495825208856;10391.064804167661;10411.323263987817;727.7780277015455;749.1419191165432;754.1139161485233;757.4811254290828;762.4967521435826;4567.954320456819;4733.455652599995;4742;4803.759812009385;4856.902861942742;94409.52795236117;96218;97109;110335;110417.44791275992;98161;98238.50880745551;99439;99798.01211927307;100022;88008;88204;88262.55868720743;88918.11081889228;90300.5484972571;9810.950945245228;10551.261411701415;10593.894061059598;10685.679429617125;10686;39887;45399;45568;45596.77201613971;50057.749711251214;75711.97152113853;77530.61234693791;78565.60717196377;80666;82424.58787706023;12874.485020599072;13298.667533311358;13318.467261309439;13326.800097998344;13345;15566.221688915735;15999.280032398803;16084.67830643404;16130;16167.434139805051;14881.702365952837;14944.850551494346;15065.246737663292;15144.621384465036;15167;13881.791773123614;14122.50571230002;14285.64285892861;14938.626534336729;15061.17163556015;13641.86358136406;13926.30368481592;14315.14109153454;14360.35378407995;14381.92809035948;11881.798170425747;12071.879281207426;12145;12183.512659493521;12414.751704965669;10995.945020274847;11646.592369267035;11745.17783755129;11893.345865977108;12040.277583345027 02:34:59 INFO - PROCESS | 22616 | __end_tp_report 02:34:59 INFO - PROCESS | 22616 | __start_cc_report 02:34:59 INFO - PROCESS | 22616 | _x_x_mozilla_cycle_collect,1046 02:34:59 INFO - PROCESS | 22616 | __end_cc_report 02:34:59 INFO - PROCESS | 22616 | __startTimestamp1467884099139__endTimestamp 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | ------- Summary: start ------- 02:34:59 INFO - PROCESS | 22616 | Number of tests: 6 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | [#0] dojo.html Cycles:165 Average:4588.93 Median:4724.06 stddev:471.85 (10.0%) stddev-sans-first:451.87 02:34:59 INFO - PROCESS | 22616 | Values: 2796.9 2798.3 2833.6 2834.4 2835.1 4557.9 4608.7 4664.3 4678.3 4678.9 4587.1 4625.5 4631.0 4663.3 4671.1 4189.2 4209.3 4211.5 4289.6 4290.5 4220.7 4272.2 4317.2 4351.2 4351.3 4180.0 4216.3 4228.2 4260.9 4274.6 4214.1 4238.3 4238.9 4261.9 4318.0 4260.9 4262.9 4271.1 4274.9 4309.7 4507.5 4555.5 4609.7 4650.8 4678.2 4903.0 4917.0 4919.0 4921.6 4929.9 4902.3 4929.3 4929.6 4938.4 4954.9 4564.9 4630.7 4667.3 4675.7 4678.2 5022.9 5024.1 5039.2 5041.5 5098.6 4852.3 4885.9 4889.1 4890.8 4895.9 4772.4 4786.0 4830.9 4834.2 4886.2 4805.4 4812.0 4821.3 4842.1 4859.2 4797.3 4873.9 4883.5 4884.3 4921.6 3812.2 3824.8 3838.9 3847.7 3896.8 3476.0 3479.3 3492.0 3526.1 3531.2 4638.8 4726.1 4731.2 4740.2 4782.9 4900.0 4935.7 4943.7 4951.1 4960.0 4698.0 4701.8 4704.7 4712.8 4715.1 4215.1 4225.2 4308.0 4309.5 4338.7 5087.8 5100.1 5114.8 5118.8 5147.3 4896.2 4900.5 4903.7 4904.4 4947.6 5028.9 5047.6 5074.9 5126.3 5127.2 4810.6 4812.3 4832.8 4876.3 4884.0 4868.1 4899.0 4903.7 4904.1 4923.1 4666.8 4691.2 4721.0 4722.5 4780.8 4728.2 4748.5 4748.7 4749.1 4793.3 4722.9 4724.1 4729.6 4730.6 4783.2 4689.9 4695.0 4739.7 4784.3 4791.4 4641.2 4698.8 4708.6 4723.6 4766.2 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | [#1] ext.html Cycles:180 Average:57136.67 Median:38023.62 stddev:106538.88 (280.2%) stddev-sans-first:106753.05 02:34:59 INFO - PROCESS | 22616 | Values: 555.1 596.3 597.3 598.6 615.1 28828.4 29326.4 31278.2 31350.5 42388.0 40488.2 41950.6 42649.0 42757.0 42861.8 8873.4 8980.8 8986.1 8996.6 9002.3 7508.4 8924.6 9029.2 10878.8 11153.7 10735.4 11042.7 11069.3 11083.4 11087.8 11135.7 11217.5 11224.4 11236.2 11244.1 10777.4 10836.4 10840.6 10849.6 10858.8 42006.6 42111.2 42218.6 42288.4 42289.6 3629.5 3635.9 3677.6 3776.0 4090.2 33462.0 33843.3 33927.5 33990.0 34843.0 4515.1 4579.3 4596.1 4643.0 4650.9 358683.0 358915.0 360897.0 361038.0 362144.0 61228.0 62803.0 62817.4 62980.0 63011.4 66475.0 66585.7 66639.0 66646.7 66685.7 16573.2 16910.3 16978.2 17029.8 17079.9 13089.7 13157.1 13165.4 13178.5 13190.3 19168.7 19772.4 19787.3 19815.7 19855.4 7076.4 7227.3 7267.6 7281.1 7287.7 956.7 964.8 967.3 992.6 1013.1 31702.2 32176.8 32812.7 32817.3 33559.0 1068.6 1111.6 1148.4 1156.1 1168.5 16557.3 16565.3 16825.6 16931.2 17078.8 509391.0 512844.0 513889.0 514974.0 515781.0 37853.0 57813.4 57911.7 57979.4 58290.7 1187.1 1295.4 1309.8 1332.2 1343.8 31169.4 33674.5 33885.3 33974.5 34603.8 50576.0 50835.7 51273.7 51276.7 51306.0 307001.0 307333.0 307601.0 308542.0 309183.0 35012.6 41693.4 42673.6 42685.1 45930.5 47942.7 48492.8 49630.0 49952.5 53269.7 41723.4 42215.0 42733.6 42876.6 43886.1 41988.8 42571.4 42663.1 42794.4 43163.4 41503.6 42347.6 42700.0 42709.4 42982.6 36844.4 37577.6 37851.8 38194.2 38761.8 29051.7 29086.4 29271.7 29590.7 29594.6 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | [#2] jquery.html Cycles:180 Average:27512.11 Median:12770.77 stddev:72936.61 (571.1%) stddev-sans-first:73112.78 02:34:59 INFO - PROCESS | 22616 | Values: 385.1 385.3 388.7 398.7 400.7 17638.7 19071.1 19389.8 19420.0 19465.4 17183.0 17543.4 17672.2 17749.6 18799.0 5556.9 5638.2 5809.4 5852.9 5855.3 5716.9 5717.5 5723.4 5747.6 5755.0 5519.1 5700.8 5711.4 5712.5 5746.7 5732.5 5740.1 5763.1 5771.9 5791.7 5080.5 5153.9 5166.1 5176.9 5178.0 22938.0 23076.2 23231.2 23246.5 23261.7 2310.4 2432.2 2580.3 2680.8 2823.2 13957.7 14432.9 14602.8 15194.7 15216.2 1925.5 1969.6 1993.0 2003.7 2034.5 56603.7 59696.0 78556.2 80101.2 80647.0 10056.3 10520.7 10521.3 10679.2 10780.9 12779.6 14638.7 14685.3 14699.6 14701.9 7526.7 7956.7 8002.5 8044.2 8402.9 8103.8 8117.8 8142.5 8198.1 8245.9 6435.7 6476.5 6491.9 6559.9 6560.7 1863.7 1864.2 1886.3 1904.2 1943.9 881.0 981.3 1031.2 1070.5 1121.0 19504.6 19806.7 20186.5 20241.8 20363.4 1005.7 1012.2 1032.9 1037.0 1038.7 10872.4 11529.9 11538.7 11629.0 11636.0 378796.0 382533.0 384787.0 500777.0 531771.0 77033.0 90387.0 99260.5 99284.0 101130.0 968.3 1004.7 1022.3 1028.0 1035.2 17285.3 17365.3 17365.4 17436.8 17569.1 42375.6 42992.6 43369.3 43885.3 44759.6 59336.4 61022.7 61106.0 62093.7 62832.4 8441.5 8711.5 8770.7 8857.9 9050.0 12211.5 12996.8 13093.7 13405.3 13646.6 11451.0 11521.3 11604.4 11642.1 11793.4 10666.6 11545.4 11720.2 11781.5 11940.8 11200.3 11462.5 11703.1 11892.9 12222.1 8467.5 8584.2 8670.7 8718.5 8744.4 10298.5 11377.6 11399.7 11450.3 11485.6 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | [#3] mootools.html Cycles:180 Average:5841.44 Median:4781.81 stddev:3390.82 (70.9%) stddev-sans-first:3384.09 02:34:59 INFO - PROCESS | 22616 | Values: 1425.1 1445.6 1529.4 1689.1 1693.1 8342.7 8780.2 8862.9 8867.9 8874.1 7344.0 8576.8 8651.0 8705.9 8754.3 2294.8 2323.3 2324.6 2324.6 2325.9 1914.3 2313.4 2322.2 2354.0 2355.1 2265.6 2324.7 2327.4 2331.9 2335.3 2314.4 2318.8 2322.7 2331.0 2367.2 2286.4 2308.9 2311.1 2314.0 2317.2 8953.1 9033.7 9053.2 9061.1 9063.2 5232.1 5307.2 5308.0 5329.6 5375.4 3539.6 3586.4 3633.4 3682.7 3699.8 1181.0 1185.5 1194.7 1203.7 1220.9 12722.3 12774.6 12796.8 12810.0 12821.6 4748.1 4765.3 4781.1 4801.7 4928.0 10597.7 10623.6 10640.0 10641.4 10646.6 5198.2 5200.1 5201.3 5203.1 5207.4 4708.4 4765.5 4781.6 4782.0 4794.0 4003.8 4010.1 4051.9 4121.5 4217.9 1126.2 1206.2 1263.8 1282.0 1305.1 932.5 946.2 948.4 951.7 969.7 5697.7 5783.5 5913.1 5949.2 5991.5 892.3 912.8 916.5 946.1 952.2 3778.5 3854.7 3855.9 3859.7 3876.8 10937.9 11331.7 11361.6 11388.8 11395.5 10997.7 11337.7 11348.7 11348.8 11354.8 8109.9 8256.0 8304.2 8312.8 8522.5 5403.4 5410.4 5465.1 5499.6 5545.6 10501.1 10502.8 10526.9 10539.2 10583.8 10042.2 10382.2 10415.7 10704.8 10730.4 7604.8 7738.7 7764.7 7769.8 7772.8 8020.7 8215.8 8223.2 8281.0 8459.8 7400.0 7516.9 7758.6 7935.4 7947.3 7532.8 7570.5 7594.9 7650.9 7854.1 7096.7 7189.5 7204.3 7209.8 7231.7 4827.8 4925.7 4969.3 5046.5 5080.6 4934.2 4954.6 4960.8 5086.2 5094.5 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | [#4] prototype.html Cycles:180 Average:4194.61 Median:4814.41 stddev:1205.03 (25.0%) stddev-sans-first:1172.73 02:34:59 INFO - PROCESS | 22616 | Values: 316.4 327.5 328.4 330.2 334.0 4588.4 4689.3 4704.3 4728.9 4773.9 4663.5 4674.8 4692.6 4703.9 4734.0 3792.6 3796.3 3801.5 3801.7 3809.1 3779.4 3785.5 3795.5 3798.8 3823.7 3555.5 3742.3 3760.5 3762.0 3762.9 3740.6 3784.3 3785.9 3788.8 3799.2 3353.1 3355.7 3359.3 3362.9 3375.0 4546.3 4619.4 4678.9 4682.0 4696.8 4218.1 4243.1 4249.8 4269.9 4276.1 4904.0 4930.9 4939.7 4944.5 4955.7 3643.3 3646.2 3647.5 3650.2 3660.1 4845.8 4912.8 4917.3 5062.3 5070.4 3687.5 3703.2 3711.7 3721.3 3734.5 3735.4 3744.3 3760.8 3761.3 3768.0 4052.1 4177.1 4214.9 4220.8 4238.7 4879.0 4924.9 4935.4 4937.0 4945.8 1289.4 1294.6 1296.0 1305.0 1310.2 872.9 876.3 878.8 885.0 922.2 4803.6 4820.2 4839.7 4842.6 4859.5 4979.2 4995.2 5036.7 5053.7 5073.9 4724.0 4795.2 4808.6 4886.3 4895.3 2584.6 2633.3 2636.9 2643.4 2646.2 5212.7 5227.2 5239.3 5251.7 5270.7 4843.1 5038.8 5057.3 5062.9 5165.9 5302.4 5306.5 5311.3 5311.4 5332.1 5024.5 5053.1 5056.4 5080.8 5090.3 4799.0 4995.9 5011.5 5033.4 5050.0 5290.5 5318.0 5320.3 5327.3 5327.9 3730.3 3769.9 3769.9 3771.0 3771.3 4862.7 5031.8 5048.2 5085.6 5089.0 4908.0 4929.1 4931.1 4937.7 4942.9 4933.4 4936.0 4943.7 4953.7 4959.1 4676.3 4921.3 4925.4 4934.7 4944.3 4911.6 4927.9 4952.8 4972.6 4979.4 4864.6 4869.6 4881.8 4905.2 4931.4 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - PROCESS | 22616 | [#5] yui.html Cycles:180 Average:20590.29 Median:4510.70 stddev:28879.65 (640.2%) stddev-sans-first:28922.04 02:34:59 INFO - PROCESS | 22616 | Values: 700.9 740.4 750.9 788.9 820.9 15093.2 15505.6 15600.2 15628.5 15797.8 14716.2 14971.6 14988.8 15006.2 15181.1 614.2 745.9 754.7 767.0 768.9 775.8 780.2 781.7 782.3 782.6 818.4 819.3 820.8 822.0 822.4 648.8 795.6 806.5 806.9 813.4 592.9 593.5 594.4 594.6 594.7 14099.3 14158.0 14159.1 14174.3 14196.6 13600.9 13985.6 14110.6 14565.9 14805.4 12895.7 13106.2 13218.9 13349.7 13548.5 4399.5 4452.0 4483.4 4529.8 4628.3 72627.6 72714.6 73092.6 73687.6 74724.6 11008.8 11323.3 11731.5 11895.9 11964.5 21048.6 21130.4 21140.0 21153.2 21191.0 8102.8 8221.8 8435.3 8492.0 8508.6 4127.9 4491.6 4645.7 4764.9 4789.7 3137.0 3237.4 3240.8 3243.6 3245.1 542.2 582.5 587.4 615.9 660.2 738.3 745.3 758.1 760.3 781.1 9950.9 9989.9 10083.5 10391.1 10411.3 727.8 749.1 754.1 757.5 762.5 4568.0 4733.5 4742.0 4803.8 4856.9 94409.5 96218.0 97109.0 110335.0 110417.4 98161.0 98238.5 99439.0 99798.0 100022.0 88008.0 88204.0 88262.6 88918.1 90300.5 9811.0 10551.3 10593.9 10685.7 10686.0 39887.0 45399.0 45568.0 45596.8 50057.7 75712.0 77530.6 78565.6 80666.0 82424.6 12874.5 13298.7 13318.5 13326.8 13345.0 15566.2 15999.3 16084.7 16130.0 16167.4 14881.7 14944.9 15065.2 15144.6 15167.0 13881.8 14122.5 14285.6 14938.6 15061.2 13641.9 13926.3 14315.1 14360.4 14381.9 11881.8 12071.9 12145.0 12183.5 12414.8 10995.9 11646.6 11745.2 11893.3 12040.3 02:34:59 INFO - PROCESS | 22616 | -------- Summary: end -------- 02:34:59 INFO - PROCESS | 22616 | 02:34:59 INFO - TEST-INFO | 22616: exit 0 02:34:59 INFO - TEST-OK | dromaeo_css | took 1112356ms 02:34:59 INFO - TEST-START | kraken 02:34:59 INFO - operating with platform_type : linux_ 02:34:59 INFO - Initialising browser for kraken test... 02:34:59 INFO - TEST-INFO | started process 22810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOE77SW/profile http://localhost:38136/getInfo.html) 02:35:03 INFO - PROCESS | 22810 | __metrics Screen width/height:1600/1200 02:35:03 INFO - PROCESS | 22810 | colorDepth:24 02:35:03 INFO - PROCESS | 22810 | Browser inner width/height: 1024/697 02:35:03 INFO - PROCESS | 22810 | __metrics 02:35:04 INFO - PROCESS | 22810 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:35:05 INFO - TEST-INFO | 22810: exit 0 02:35:05 INFO - Browser initialized. 02:35:05 INFO - Running cycle 1/1 for kraken test... 02:35:05 INFO - TEST-INFO | started process 22891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOE77SW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:17 INFO - PROCESS | 22891 | RSS: Main: 157401088 02:35:17 INFO - PROCESS | 22891 | 02:35:20 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38136/tests/kraken/driver.html?testName=audio-beat-detection) 02:35:20 INFO - PROCESS | 22891 | RSS: Main: 216367104 02:35:20 INFO - PROCESS | 22891 | 02:35:23 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38136/tests/kraken/driver.html?testName=audio-dft) 02:35:24 INFO - PROCESS | 22891 | RSS: Main: 204472320 02:35:24 INFO - PROCESS | 22891 | 02:35:27 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38136/tests/kraken/driver.html?testName=audio-fft) 02:35:27 INFO - PROCESS | 22891 | RSS: Main: 271056896 02:35:27 INFO - PROCESS | 22891 | 02:35:30 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38136/tests/kraken/driver.html?testName=audio-oscillator) 02:35:30 INFO - PROCESS | 22891 | RSS: Main: 181129216 02:35:30 INFO - PROCESS | 22891 | 02:35:32 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:35:33 INFO - PROCESS | 22891 | RSS: Main: 184975360 02:35:33 INFO - PROCESS | 22891 | 02:35:36 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38136/tests/kraken/driver.html?testName=imaging-darkroom) 02:35:37 INFO - PROCESS | 22891 | RSS: Main: 221114368 02:35:37 INFO - PROCESS | 22891 | 02:35:40 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38136/tests/kraken/driver.html?testName=imaging-desaturate) 02:35:41 INFO - PROCESS | 22891 | RSS: Main: 221544448 02:35:41 INFO - PROCESS | 22891 | 02:35:43 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38136/tests/kraken/driver.html?testName=json-parse-financial) 02:35:44 INFO - PROCESS | 22891 | RSS: Main: 221667328 02:35:44 INFO - PROCESS | 22891 | 02:35:46 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:35:46 INFO - PROCESS | 22891 | RSS: Main: 207532032 02:35:46 INFO - PROCESS | 22891 | 02:35:48 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:35:49 INFO - PROCESS | 22891 | RSS: Main: 212668416 02:35:49 INFO - PROCESS | 22891 | 02:35:51 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:35:51 INFO - PROCESS | 22891 | RSS: Main: 211456000 02:35:51 INFO - PROCESS | 22891 | 02:35:54 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:35:55 INFO - PROCESS | 22891 | RSS: Main: 224284672 02:35:55 INFO - PROCESS | 22891 | 02:35:57 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:35:58 INFO - PROCESS | 22891 | RSS: Main: 226168832 02:35:58 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38136/tests/kraken/driver.html?testName=ai-astar) 02:36:00 INFO - PROCESS | 22891 | RSS: Main: 268673024 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | __start_tp_report 02:36:00 INFO - PROCESS | 22891 | _x_x_mozilla_page_load 02:36:00 INFO - PROCESS | 22891 | _x_x_mozilla_page_load_details 02:36:00 INFO - PROCESS | 22891 | |i|pagename|runs| 02:36:00 INFO - PROCESS | 22891 | |0;ai-astar;104;113;112;111;111;111;110;111;110;112 02:36:00 INFO - PROCESS | 22891 | |1;audio-beat-detection;145;119;124;170;120;117;144;117;145;118 02:36:00 INFO - PROCESS | 22891 | |2;audio-dft;162;161;161;160;160;162;161;171;162;162 02:36:00 INFO - PROCESS | 22891 | |3;audio-fft;75;75;76;122;76;76;74;75;105;76 02:36:00 INFO - PROCESS | 22891 | |4;audio-oscillator;86;85;107;84;85;84;110;84;84;120 02:36:00 INFO - PROCESS | 22891 | |5;imaging-gaussian-blur;116;117;117;116;117;116;116;117;116;117 02:36:00 INFO - PROCESS | 22891 | |6;imaging-darkroom;146;146;146;146;147;146;146;147;146;146 02:36:00 INFO - PROCESS | 22891 | |7;imaging-desaturate;96;95;96;96;95;95;95;95;95;95 02:36:00 INFO - PROCESS | 22891 | |8;json-parse-financial;61;61;63;61;61;59;68;62;61;59 02:36:00 INFO - PROCESS | 22891 | |9;json-stringify-tinderbox;61;61;62;62;63;62;62;61;62;62 02:36:00 INFO - PROCESS | 22891 | |10;stanford-crypto-aes;76;76;76;77;76;76;75;84;76;83 02:36:00 INFO - PROCESS | 22891 | |11;stanford-crypto-ccm;129;122;136;133;121;131;122;138;195;140 02:36:00 INFO - PROCESS | 22891 | |12;stanford-crypto-pbkdf2;162;159;158;158;159;159;162;160;157;161 02:36:00 INFO - PROCESS | 22891 | |13;stanford-crypto-sha256-iterative;63;63;66;63;62;68;63;63;64;64 02:36:00 INFO - PROCESS | 22891 | __end_tp_report 02:36:00 INFO - PROCESS | 22891 | __start_cc_report 02:36:00 INFO - PROCESS | 22891 | _x_x_mozilla_cycle_collect,1734 02:36:00 INFO - PROCESS | 22891 | __end_cc_report 02:36:00 INFO - PROCESS | 22891 | __startTimestamp1467884160473__endTimestamp 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | ------- Summary: start ------- 02:36:00 INFO - PROCESS | 22891 | Number of tests: 14 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.46 (2.2%) stddev-sans-first:0.97 02:36:00 INFO - PROCESS | 22891 | Values: 104.0 113.0 112.0 111.0 111.0 111.0 110.0 111.0 110.0 112.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:134.00 stddev:18.10 (13.5%) stddev-sans-first:18.57 02:36:00 INFO - PROCESS | 22891 | Values: 145.0 119.0 124.0 170.0 120.0 117.0 144.0 117.0 145.0 118.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:3.19 (2.0%) stddev-sans-first:3.38 02:36:00 INFO - PROCESS | 22891 | Values: 162.0 161.0 161.0 160.0 160.0 162.0 161.0 171.0 162.0 162.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.50 stddev:16.58 (22.0%) stddev-sans-first:17.33 02:36:00 INFO - PROCESS | 22891 | Values: 75.0 75.0 76.0 122.0 76.0 76.0 74.0 75.0 105.0 76.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:84.00 stddev:13.80 (16.4%) stddev-sans-first:14.41 02:36:00 INFO - PROCESS | 22891 | Values: 86.0 85.0 107.0 84.0 85.0 84.0 110.0 84.0 84.0 120.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:36:00 INFO - PROCESS | 22891 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:36:00 INFO - PROCESS | 22891 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 02:36:00 INFO - PROCESS | 22891 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.00 stddev:2.55 (4.2%) stddev-sans-first:2.69 02:36:00 INFO - PROCESS | 22891 | Values: 61.0 61.0 63.0 61.0 61.0 59.0 68.0 62.0 61.0 59.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 02:36:00 INFO - PROCESS | 22891 | Values: 61.0 61.0 62.0 62.0 63.0 62.0 62.0 61.0 62.0 62.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.00 stddev:3.21 (4.2%) stddev-sans-first:3.35 02:36:00 INFO - PROCESS | 22891 | Values: 76.0 76.0 76.0 77.0 76.0 76.0 75.0 84.0 76.0 83.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:134.50 stddev:21.59 (16.1%) stddev-sans-first:22.72 02:36:00 INFO - PROCESS | 22891 | Values: 129.0 122.0 136.0 133.0 121.0 131.0 122.0 138.0 195.0 140.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.50 stddev:1.72 (1.1%) stddev-sans-first:1.56 02:36:00 INFO - PROCESS | 22891 | Values: 162.0 159.0 158.0 158.0 159.0 159.0 162.0 160.0 157.0 161.0 02:36:00 INFO - PROCESS | 22891 | 02:36:00 INFO - PROCESS | 22891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:1.79 (2.8%) stddev-sans-first:1.87 02:36:00 INFO - PROCESS | 22891 | Values: 63.0 63.0 66.0 63.0 62.0 68.0 63.0 63.0 64.0 64.0 02:36:00 INFO - PROCESS | 22891 | -------- Summary: end -------- 02:36:00 INFO - PROCESS | 22891 | 02:36:01 INFO - TEST-INFO | 22891: exit 0 02:36:01 INFO - TEST-OK | kraken | took 61630ms 02:36:01 INFO - SUITE-END | took 1173s 02:36:01 INFO - Completed test suite (00:19:34) 02:36:01 INFO - javascript benchmark 02:36:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2796.902108426205, 2798.2864369585755, 2833.5891295762117, 2834.3622684895913, 2835.050258163515, 4557.9088418231695, 4608.746518941457, 4664.2537194048955, 4678.27486739555, 4678.929816052762, 4587.082583483309, 4625.4680711718165, 4630.953690463094, 4663.300504924263, 4671.089137618157, 4189.183109293689, 4209.263378908694, 4211.473565804275, 4289.571042895716, 4290.549492303295, 4220.662347012247, 4272.209641216369, 4317.244482215616, 4351.151525452538, 4351.303791393378, 4180.038591124028, 4216.304309788881, 4228.154369126187, 4260.9147817043795, 4274.551172126929, 4214.05183833635, 4238.258304796679, 4238.87283381499, 4261.850835220753, 4317.978410107929, 4260.893477663052, 4262.893427664302, 4271.124419493996, 4274.935875961863, 4309.676774241944, 4507.504174540798, 4555.476120246181, 4609.723416595015, 4650.837220697294, 4678.157931572316, 4903.0, 4917.0, 4918.9508104919205, 4921.581665558396, 4929.852104436873, 4902.264660300948, 4929.309896614477, 4929.605631549467, 4938.407391113089, 4954.851354459372, 4564.8630541083485, 4630.7453090080035, 4667.299905014241, 4675.672702910763, 4678.204705200124, 5022.924656130161, 5024.095662780662, 5039.244113383022, 5041.470645582161, 5098.59211263098, 4852.344933434012, 4885.877853053702, 4889.119958407449, 4890.828820991248, 4895.902081958412, 4772.379590653262, 4786.0, 4830.9371938173545, 4834.20235661119, 4886.193778026657, 4805.3512775775525, 4811.9518804812205, 4821.325014497973, 4842.128416884994, 4859.246816743411, 4797.2564252540915, 4873.926891096637, 4883.536064073907, 4884.340614017134, 4921.630877684188, 3812.1803812180515, 3824.8470061197795, 3838.9232215355537, 3847.7306588539095, 3896.7661940283674, 3475.9826200868833, 3479.304139172176, 3492.022233774547, 3526.118470382404, 3531.170175008871, 4638.83764068256, 4726.054789042205, 4731.219348807477, 4740.241561350167, 4782.904341913212, 4899.951000490021, 4935.703857768545, 4943.72809495474, 4951.108800415887, 4959.975200123977, 4698.036902434993, 4701.835435759732, 4704.670673052853, 4712.811487540528, 4715.056988602293, 4215.093754842724, 4225.239456897726, 4307.956920430818, 4309.504406993173, 4338.739675619473, 5087.796488140433, 5100.1074811907765, 5114.795408183631, 5118.795248190031, 5147.253648220987, 4896.192128298862, 4900.5099490052135, 4903.681260718042, 4904.386951631046, 4947.554720075066, 5028.949710502849, 5047.596192304681, 5074.873128171826, 5126.256692779451, 5127.158305618168, 4810.5670489656095, 4812.302216178565, 4832.782524786463, 4876.341693871282, 4883.951160488492, 4868.050730107595, 4898.951010489849, 4903.681260718042, 4904.11725889329, 4923.113839508779, 4666.78999445019, 4691.202495575692, 4720.952790472052, 4722.480527141943, 4780.832670856504, 4728.219843725747, 4748.525147485224, 4748.691335063209, 4749.05018996209, 4793.304970779287, 4722.881927951828, 4724.055188962153, 4729.645276604199, 4730.574248317668, 4783.186858234039, 4689.882752931204, 4694.9765251174895, 4739.739314337745, 4784.258439941815, 4791.353167322367, 4641.18779213643, 4698.788554514987, 4708.576228139484, 4723.622110231105, 4766.213574760126], "value": 4560.4715562343445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1256770586325, 596.3499785234096, 597.3280059932575, 598.5570677698503, 615.0620304036343, 28828.423431531355, 29326.41347173058, 31278.2180445489, 31350.52974205386, 42388.0, 40488.19023619526, 41950.58049419505, 42649.0, 42757.0, 42861.78569107158, 8873.378863479575, 8980.775480612972, 8986.056464071276, 8996.640134394616, 9002.32482563807, 7508.361789247921, 8924.598393072327, 9029.187373136416, 10878.782424351508, 11153.72115697106, 10735.355878647268, 11042.723931901726, 11069.335839849595, 11083.390413527253, 11087.778244435107, 11135.721606959809, 11217.495212715447, 11224.438778061065, 11236.157288203418, 11244.100471962265, 10777.353358798497, 10836.403997780119, 10840.6205782798, 10849.566017359297, 10858.837117443245, 42006.579934200876, 42111.1577768446, 42218.577814221775, 42288.365674514906, 42289.57710422918, 3629.4737263096968, 3635.8909232723063, 3677.595464498903, 3775.9811200944096, 4090.2228576570656, 33462.0, 33843.32313353744, 33927.4910876337, 33990.0, 34843.0, 4515.119551687422, 4579.313103034571, 4596.126735920165, 4642.976785116087, 4650.906981860344, 358683.0, 358915.0, 360897.0, 361038.0, 362144.0, 61228.0, 62803.0, 62817.37182628207, 62980.0, 63011.369886301465, 66475.0, 66585.66707166433, 66639.0, 66646.66676666586, 66685.6665716678, 16573.17134143288, 16910.32358705638, 16978.23597938071, 17029.829701702824, 17079.914600426917, 13089.672758181121, 13157.144785588906, 13165.407556659973, 13178.538751143664, 13190.274534900673, 19168.71246931297, 19772.40682779519, 19787.30744423938, 19815.702764458543, 19855.404337869888, 7076.433885289164, 7227.313405226495, 7267.600281984542, 7281.134063344199, 7287.672054757442, 956.6556039825657, 964.81668482988, 967.327707243459, 992.6128809764198, 1013.133770626104, 31702.207444814063, 32176.839115804738, 32812.67187328144, 32817.3436531268, 33559.0, 1068.5992752717732, 1111.6498303034518, 1148.3970915269383, 1156.1323558549534, 1168.474186616009, 16557.337706491846, 16565.337386504645, 16825.57936051584, 16931.238094285785, 17078.829211707973, 509391.0, 512844.0, 513889.0, 514974.0, 515781.0, 37853.0, 57813.421865781645, 57911.710441447525, 57979.4202057974, 58290.708546457, 1187.0681515010847, 1295.3846922711637, 1309.8100775387516, 1332.194022616303, 1343.7648411527748, 31169.376612468077, 33674.49488257629, 33885.3222935535, 33974.49038264379, 34603.826980864935, 50576.0, 50835.74582127214, 51273.743631281606, 51276.74361628168, 51306.0, 307001.0, 307333.0, 307601.0, 308542.0, 309183.0, 35012.64987350094, 41693.374599380426, 42673.57326426696, 42685.146297074505, 45930.54069459263, 47942.69812846316, 48492.75753621209, 49630.0, 49952.50047499624, 53269.733651331495, 41723.37414938718, 42215.0, 42733.57266427296, 42876.57123428726, 43886.12227755491, 41988.790056049525, 42571.3614295792, 42663.14673706446, 42794.35808462813, 43163.35254971115, 41503.58496414997, 42347.57652423436, 42700.0, 42709.35935961025, 42982.57017429911, 36844.44733329056, 37577.62422375741, 37851.810740946115, 38194.236115278094, 38761.80619096886, 29051.709482905746, 29086.418271634873, 29271.70728292775, 29590.704092958797, 29594.55608165836], "value": 20665.46872406279, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.0969476577425, 385.2987562636003, 388.7240059557716, 398.6969902873815, 400.6794564348522, 17638.735418968725, 19071.14179861906, 19389.806101938975, 19420.0, 19465.416037518862, 17183.0, 17543.38598149065, 17672.20475078621, 17749.55626109348, 18799.0, 5556.91664625031, 5638.182463542784, 5809.448102430262, 5852.853678658025, 5855.297364316288, 5716.942830571704, 5717.542596592283, 5723.427657234285, 5747.626404283729, 5755.0, 5519.116941289394, 5700.800471983482, 5711.400302968191, 5712.514436272922, 5746.683932383718, 5732.484076433099, 5740.138979153139, 5763.106718458645, 5771.855703607402, 5791.681457519835, 5080.542751152414, 5153.896922061538, 5166.121759300928, 5176.948230517684, 5177.974110129425, 22938.0, 23076.192333268424, 23231.18690845829, 23246.535069298687, 23261.651075233884, 2310.353101131669, 2432.1609044879488, 2580.3420127867275, 2680.825746326502, 2823.2236135062817, 13957.651058723512, 14432.927835360755, 14602.780958285633, 15194.696106077927, 15216.239188040665, 1925.5186203449139, 1969.6257711035, 1992.9601407971759, 2003.7495313085865, 2034.5422279987033, 56603.716981415244, 59696.0, 78556.21443785547, 80101.19898800996, 80647.0, 10056.34633748804, 10520.684379468628, 10521.316114452537, 10679.199060070527, 10780.946095269474, 12779.552715654907, 14638.707225855424, 14685.265736713121, 14699.632509187355, 14701.92649036748, 7526.661300241502, 7956.7215147470715, 8002.51984880909, 8044.235797599219, 8402.915970840213, 8103.837923241502, 8117.756467305991, 8142.47073940192, 8198.098209197104, 8245.917540824636, 6435.74257029723, 6476.481881449473, 6491.870162596816, 6559.934400656028, 6560.671966401661, 1863.664540382717, 1864.2356633780357, 1886.302068234762, 1904.183024771343, 1943.8736482128616, 881.0, 981.293468702533, 1031.2111234905303, 1070.528967254421, 1120.9551617935192, 19504.609907801765, 19806.70289945652, 20186.495337616678, 20241.79758202399, 20363.389098327072, 1005.7234260578399, 1012.1801340913884, 1032.8554002439664, 1037.0355569320604, 1038.6676263595577, 10872.402017889091, 11529.942350288362, 11538.653840384803, 11629.0, 11636.0, 378796.0, 382533.0, 384787.0, 500777.0, 531771.0, 77033.0, 90387.0, 99260.50369748105, 99284.0, 101130.0, 968.3366893677853, 1004.6835246897058, 1022.2946167144646, 1028.0, 1035.166690813902, 17285.308587656353, 17365.30538778435, 17365.392211272545, 17436.757679691982, 17569.121543922498, 42375.57624423839, 42992.57007430011, 43369.3494597575, 43885.34171987359, 44759.55240447684, 59336.40663593309, 61022.694886525285, 61106.0, 62093.68953155386, 62832.37167628265, 8441.451305665112, 8711.47731136134, 8770.693025744069, 8857.911420885708, 9050.049744776703, 12211.498111624174, 12996.805047924478, 13093.738125237633, 13405.329733513481, 13646.590602281947, 11451.0, 11521.308721476738, 11604.419779011185, 11642.126840487166, 11793.410329483662, 10666.626668066581, 11545.422728863692, 11720.179587428798, 11781.469833857669, 11940.820887686517, 11200.327980321206, 11462.541498340306, 11703.122265829927, 11892.940535297268, 12222.083343749076, 8467.48021859874, 8584.227419532272, 8670.739877803677, 8718.52048137333, 8744.431611945203, 10298.536565854405, 11377.601783937522, 11399.658010259705, 11450.255733377304, 11485.598004069818], "value": 9343.422887468518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.06658138919, 1445.6169115184475, 1529.3729570875944, 1689.1216567384952, 1693.136500384805, 8342.74971750847, 8780.165884240987, 8862.91137088629, 8867.866981995276, 8874.068222836606, 7343.963280183605, 8576.785580360494, 8651.0, 8705.869411958825, 8754.299656027519, 2294.816414686821, 2323.256557901472, 2324.5699545584034, 2324.6280595104786, 2325.9185928492507, 1914.301280032785, 2313.375388645065, 2322.2336628912417, 2354.023080421623, 2355.128602417108, 2265.592193405186, 2324.7094113235844, 2327.441414060622, 2331.8717470539113, 2335.322756400642, 2314.4213946513373, 2318.8029017533445, 2322.6864373309554, 2330.9650355244685, 2367.195153647768, 2286.4283929017747, 2308.9422764431024, 2311.075569772088, 2313.953720925589, 2317.2353123469215, 8953.149450802164, 9033.683821066232, 9053.185213330831, 9061.093890610951, 9063.229625481841, 5232.136697444917, 5307.177387504943, 5307.973460132714, 5329.573634109262, 5375.43557926416, 3539.610642829287, 3586.3903136466865, 3633.4368172933237, 3682.668559829628, 3699.8335074921424, 1180.994095029528, 1185.4843143232722, 1194.6535504703625, 1203.7291609387905, 1220.8901198892142, 12722.300273484861, 12774.61676149717, 12796.808047879289, 12810.0, 12821.615351539469, 4748.0978614063215, 4765.332853400527, 4781.055180971499, 4801.68789028712, 4928.032933488576, 10597.682069537927, 10623.575056997788, 10640.04239618438, 10641.414722190199, 10646.574137034588, 5198.16829307309, 5200.115980283361, 5201.349831271091, 5203.115470370046, 5207.427183009866, 4708.411448568929, 4765.547273009059, 4781.569658730731, 4782.0435912817575, 4793.952060479351, 4003.8398464061693, 4010.057636455431, 4051.8987025324013, 4121.464209652726, 4217.936730949038, 1126.2116518437126, 1206.1617176062728, 1263.753568054239, 1281.9551315703904, 1305.0799186573443, 932.5011119051275, 946.1673727120091, 948.374073111743, 951.743029382063, 969.6945462179391, 5697.706935122967, 5783.508401785895, 5913.142594323799, 5949.2266005419015, 5991.476187404805, 892.3218354050967, 912.762681702762, 916.5142474488532, 946.0823001688351, 952.2001518724305, 3778.4521244419407, 3854.6723528500393, 3855.9228815423535, 3859.671927886161, 3876.7673939563715, 10937.945310273557, 11331.660050198507, 11361.602343917923, 11388.829167562493, 11395.487203075882, 10997.725056873642, 11337.716557085974, 11348.659540213806, 11348.773024539629, 11354.829677554842, 8109.918900811034, 8256.0, 8304.211099945496, 8312.792180195544, 8522.531260780717, 5403.378611459732, 5410.404855465817, 5465.070937940639, 5499.587530935116, 5545.639533430314, 10501.054905058581, 10502.78994420092, 10526.947365263124, 10539.209559282932, 10583.841242381217, 10042.196624270187, 10382.169426445715, 10415.739606509595, 10704.839427408438, 10730.409827459565, 7604.771856844303, 7738.729144479917, 7764.728234511765, 7769.7669069928, 7772.805679858049, 8020.679172833022, 8215.835683286421, 8223.177682231968, 8281.047679516932, 8459.830803383775, 7399.963000184965, 7516.887246691414, 7758.612069396395, 7935.444518883854, 7947.3244774194845, 7532.811679707832, 7570.507916985378, 7594.8860767089645, 7650.885236721565, 7854.096778870503, 7096.716131354894, 7189.460790440842, 7204.279572042754, 7209.819754506179, 7231.674574644048, 4827.782749776339, 4925.679830810986, 4969.254611808257, 5046.4701206374275, 5080.593552515716, 4934.210526315772, 4954.5540901319055, 4960.801567937242, 5086.21163719624, 5094.465081166424], "value": 4650.70431273578, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.3751590608547, 327.5185477348298, 328.3728079368407, 330.18444442227695, 334.04629781972466, 4588.3805686232345, 4689.273162659789, 4704.341392205094, 4728.881777955548, 4773.928391074132, 4663.48701642819, 4674.789634466449, 4692.648051396141, 4703.85888423347, 4734.0, 3792.58281589025, 3796.316663000666, 3801.4677945087574, 3801.650414102995, 3809.1048603578274, 3779.433085037239, 3785.4889589905288, 3795.5065841440573, 3798.772073675588, 3823.655870971612, 3555.520004799345, 3742.251549690073, 3760.5111335526344, 3761.9623803762024, 3762.868299609514, 3740.588535261119, 3784.26206889658, 3785.9053523661855, 3788.8484460621544, 3799.2401519696173, 3353.1281866714585, 3355.6979871811654, 3359.3281343731105, 3362.865485380582, 3375.0, 4546.318052292183, 4619.422572178478, 4678.929816052728, 4681.976590117061, 4696.812127514895, 4218.050938538835, 4243.130158317537, 4249.787510624456, 4269.914601707948, 4276.102018576103, 4903.975480122613, 4930.852074437773, 4939.703617782944, 4944.505549445027, 4955.653104282702, 3643.344198044351, 3646.179609587848, 3647.4893514907935, 3650.233450975298, 3660.0666829958454, 4845.812775869935, 4912.804438142136, 4917.262410638397, 5062.291279220912, 5070.416902056274, 3687.483752274684, 3703.166787472851, 3711.721620878445, 3721.330160571069, 3734.4585035170294, 3735.4396840474146, 3744.251149770057, 3760.7555508891833, 3761.285355782393, 3767.981160094182, 4052.1490486997473, 4177.122804211089, 4214.892553723138, 4220.810063547147, 4238.660907127422, 4878.975605121952, 4924.901501969941, 4935.358403407534, 4936.975315123402, 4945.788281870893, 1289.3553223388305, 1294.6310301564008, 1295.9611211663664, 1304.9739005219842, 1310.1811367895066, 872.9258013068833, 876.2595606712318, 878.7934835313696, 884.964601415949, 922.239152699026, 4803.615710743132, 4820.204666230103, 4839.7096174228955, 4842.612590992712, 4859.465458799529, 4979.228219625964, 4995.200767877195, 5036.6726162799305, 5053.747312634354, 5073.923891141636, 4723.952760472352, 4795.160846851787, 4808.61531077513, 4886.267059941038, 4895.31465594817, 2584.5735453650314, 2633.2626864477975, 2636.9208923732317, 2643.352378667239, 2646.2193652872447, 5212.661177023481, 5227.163653815372, 5239.345081864767, 5251.711155886386, 5270.7101109439345, 4843.128236917319, 5038.848834534897, 5057.342545469065, 5062.924056139161, 5165.9483405165465, 5302.3637163540625, 5306.46935306474, 5311.336082989626, 5311.442298558673, 5332.09354409759, 5024.547790698854, 5053.11570475158, 5056.418511871182, 5080.771365288645, 5090.26191202281, 4798.95201047985, 4995.850124496271, 5011.498850114959, 5033.446320904771, 5049.974750126225, 5290.523852853262, 5317.973410132925, 5320.255164277081, 5327.280817089643, 5327.866803329948, 3730.2725968435893, 3769.8680546180753, 3769.8680546180753, 3770.962290377061, 3771.321162190722, 4862.65961382714, 5031.760866414556, 5048.242763585345, 5085.567726743268, 5088.974555127201, 4907.975460122677, 4929.088118698052, 4931.13705101613, 4937.703737775745, 4942.8764280893265, 4933.432655244549, 4936.0, 4943.65394422387, 4953.678010929278, 4959.082569724613, 4676.275177347517, 4921.252955200852, 4925.38432695913, 4934.703917764946, 4944.332515110414, 4911.582515486224, 4927.926081108714, 4952.801887924443, 4972.627052971114, 4979.377577802775, 4864.610831133572, 4869.561739443467, 4881.779555111222, 4905.190643543918, 4931.4328852181025], "value": 3820.5763052695434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.8773464643688, 740.4372676765656, 750.9136449308328, 788.9487183333083, 820.9302209312208, 15093.245337733111, 15505.612359691013, 15600.219989000532, 15628.531144065682, 15797.842021579809, 14716.190609516472, 14971.625709357271, 14988.775168372484, 15006.249687515608, 15181.08913465193, 614.1524695919625, 745.9365953893926, 754.705664790732, 766.9923300767005, 768.9231076892322, 775.8176828445311, 780.1886038519932, 781.7146741439391, 782.2881178127905, 782.6008735544856, 818.4311903227259, 819.2790344496834, 820.8481430935266, 821.9506829590243, 822.4243029879109, 648.759958815239, 795.5624406576388, 806.4838503357855, 806.8507326144623, 813.353384059674, 592.9229200203989, 593.4569868570253, 594.3729365519375, 594.6342999055593, 594.6848170469658, 14099.295035248299, 14158.0, 14159.079659822079, 14174.291285435687, 14196.574102776933, 13600.931995340059, 13985.58043258704, 14110.576682699535, 14565.854341456556, 14805.407783688639, 12895.742085158337, 13106.2136271824, 13218.867811321956, 13349.733005339936, 13548.45806167762, 4399.516053234173, 4451.9777401113115, 4483.39474170986, 4529.773511324421, 4628.305754136906, 72627.63686181587, 72714.63642681806, 73092.6345368275, 73687.63156184238, 74724.62637686777, 11008.779824403468, 11323.263987840764, 11731.530738770354, 11895.940520297343, 11964.521419143312, 21048.579028419346, 21130.366089017352, 21140.0, 21153.153873844873, 21191.0, 8102.837943241102, 8221.79445513855, 8435.325173986066, 8492.045261612575, 8508.574571271412, 4127.8968025799595, 4491.618212451978, 4645.72125672454, 4764.904701906012, 4789.712617242907, 3136.98431507841, 3237.4496335623003, 3240.7893486923276, 3243.5621191139367, 3245.1075954112807, 542.1596525385637, 582.4815913836688, 587.3656451032874, 615.923009623797, 660.2044536333707, 738.3354980517577, 745.3478206569251, 758.0600055930717, 760.3233122520961, 781.0783275734574, 9950.900490995142, 9989.900100999042, 10083.495825208856, 10391.064804167661, 10411.323263987817, 727.7780277015455, 749.1419191165432, 754.1139161485233, 757.4811254290828, 762.4967521435826, 4567.954320456819, 4733.455652599995, 4742.0, 4803.759812009385, 4856.902861942742, 94409.52795236117, 96218.0, 97109.0, 110335.0, 110417.44791275992, 98161.0, 98238.50880745551, 99439.0, 99798.01211927307, 100022.0, 88008.0, 88204.0, 88262.55868720743, 88918.11081889228, 90300.5484972571, 9810.950945245228, 10551.261411701415, 10593.894061059598, 10685.679429617125, 10686.0, 39887.0, 45399.0, 45568.0, 45596.77201613971, 50057.749711251214, 75711.97152113853, 77530.61234693791, 78565.60717196377, 80666.0, 82424.58787706023, 12874.485020599072, 13298.667533311358, 13318.467261309439, 13326.800097998344, 13345.0, 15566.221688915735, 15999.280032398803, 16084.67830643404, 16130.0, 16167.434139805051, 14881.702365952837, 14944.850551494346, 15065.246737663292, 15144.621384465036, 15167.0, 13881.791773123614, 14122.50571230002, 14285.64285892861, 14938.626534336729, 15061.17163556015, 13641.86358136406, 13926.30368481592, 14315.14109153454, 14360.35378407995, 14381.92809035948, 11881.798170425747, 12071.879281207426, 12145.0, 12183.512659493521, 12414.751704965669, 10995.945020274847, 11646.592369267035, 11745.17783755129, 11893.345865977108, 12040.277583345027], "value": 7599.530753580848, "unit": "score"}], "name": "dromaeo_css", "value": 7012.536281285239, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 119.0, 124.0, 170.0, 120.0, 117.0, 144.0, 117.0, 145.0, 118.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 171.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 122.0, 76.0, 76.0, 74.0, 75.0, 105.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 107.0, 84.0, 85.0, 84.0, 110.0, 84.0, 84.0, 120.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 61.0, 61.0, 59.0, 68.0, 62.0, 61.0, 59.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 77.0, 76.0, 76.0, 75.0, 84.0, 76.0, 83.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 136.0, 133.0, 121.0, 131.0, 122.0, 138.0, 195.0, 140.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 158.0, 158.0, 159.0, 159.0, 162.0, 160.0, 157.0, 161.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 63.0, 62.0, 68.0, 63.0, 63.0, 64.0, 64.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1499.5000000000002, "alertThreshold": 2.0}]} 02:36:01 INFO - Return code: 0 02:36:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:36:01 INFO - # TBPL SUCCESS # 02:36:01 INFO - Running post-action listener: _resource_record_post_action 02:36:01 INFO - ##### 02:36:01 INFO - ##### Finished run-tests step (success) 02:36:01 INFO - ##### 02:36:01 INFO - Running post-run listener: _resource_record_post_run 02:36:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 566599680; Read time: 0; Write time: 396192 02:36:01 INFO - TinderboxPrint: CPU usage
12.9% 02:36:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:36:01 INFO - TinderboxPrint: I/O write bytes / time
566,599,680 / 396,192 02:36:01 INFO - TinderboxPrint: CPU idle
8,278.3 (87.1%) 02:36:01 INFO - TinderboxPrint: CPU user
1,185.1 (12.5%) 02:36:01 INFO - TinderboxPrint: Swap in / out
0 / 0 02:36:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 272928768; Read time: 0; Write time: 234188 02:36:01 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293187584; Read time: 0; Write time: 162004 02:36:02 INFO - Running post-run listener: _upload_blobber_files 02:36:02 INFO - Blob upload gear active. 02:36:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:36:02 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 02:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:36:02 INFO - (blobuploader) - INFO - Open directory for files ... 02:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:06 INFO - (blobuploader) - INFO - Done attempting. 02:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:07 INFO - (blobuploader) - INFO - Done attempting. 02:36:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:36:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:36:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:08 INFO - (blobuploader) - INFO - Done attempting. 02:36:08 INFO - (blobuploader) - INFO - Iteration through files over. 02:36:08 INFO - Return code: 0 02:36:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:36:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:36:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b3a3eb701556328ec1e8fbd28603c83c35a09ef6c9a6cb67e86c9a3735a138225ce8e1881d0eefe18fc895c8de17a54482edd4f3f32a86f19e00a9726cf3fef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d0baa0f4c532b37663623d81e34ece96c9100de78c107fe592a7ca1bdabb698757ae81705447743a63640b018dae80827b77a0b0deae9f9146d5320c95dab4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d402bc9cbe8d125e1e1313c247389ad570d55e98fe07d1abf5ea33de31ff586706cfa76affc7062065b7c9abacbf9dd0be394478b162d507042b85418cd47482"} 02:36:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:36:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:36:08 INFO - Contents: 02:36:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b3a3eb701556328ec1e8fbd28603c83c35a09ef6c9a6cb67e86c9a3735a138225ce8e1881d0eefe18fc895c8de17a54482edd4f3f32a86f19e00a9726cf3fef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d0baa0f4c532b37663623d81e34ece96c9100de78c107fe592a7ca1bdabb698757ae81705447743a63640b018dae80827b77a0b0deae9f9146d5320c95dab4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d402bc9cbe8d125e1e1313c247389ad570d55e98fe07d1abf5ea33de31ff586706cfa76affc7062065b7c9abacbf9dd0be394478b162d507042b85418cd47482"} 02:36:08 INFO - Running post-run listener: copy_logs_to_upload_dir 02:36:08 INFO - Copying logs to upload dir... 02:36:08 INFO - mkdir: /builds/slave/test/build/upload/logs 02:36:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.935519 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-07 02:36:07.663693) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 02:36:07.667825) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b3a3eb701556328ec1e8fbd28603c83c35a09ef6c9a6cb67e86c9a3735a138225ce8e1881d0eefe18fc895c8de17a54482edd4f3f32a86f19e00a9726cf3fef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d0baa0f4c532b37663623d81e34ece96c9100de78c107fe592a7ca1bdabb698757ae81705447743a63640b018dae80827b77a0b0deae9f9146d5320c95dab4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d402bc9cbe8d125e1e1313c247389ad570d55e98fe07d1abf5ea33de31ff586706cfa76affc7062065b7c9abacbf9dd0be394478b162d507042b85418cd47482"} build_url:https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/JUyAWAOaTIGJUInl-pqpSw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b3a3eb701556328ec1e8fbd28603c83c35a09ef6c9a6cb67e86c9a3735a138225ce8e1881d0eefe18fc895c8de17a54482edd4f3f32a86f19e00a9726cf3fef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d0baa0f4c532b37663623d81e34ece96c9100de78c107fe592a7ca1bdabb698757ae81705447743a63640b018dae80827b77a0b0deae9f9146d5320c95dab4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d402bc9cbe8d125e1e1313c247389ad570d55e98fe07d1abf5ea33de31ff586706cfa76affc7062065b7c9abacbf9dd0be394478b162d507042b85418cd47482"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 02:36:07.693870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:36:07.694227) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467882936.414258-613972419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:36:07.780313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 02:36:07.781056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 02:36:07.781819) ========= ========= Total master_lag: 0.20 =========