builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1468074452.95 results: success (0) buildid: 20160709043035 builduid: 41a410e0f81345de8424289bbf30ef86 revision: a60cf1b7124aa067e96cdd751ac526008f96ff8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:32.949506) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:32.949973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:32.950600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:32.997667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:32.998009) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 07:27:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.7M=0s 2016-07-09 07:27:33 (34.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.089327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.089645) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019719 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.140241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.140639) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a60cf1b7124aa067e96cdd751ac526008f96ff8a --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 a60cf1b7124aa067e96cdd751ac526008f96ff8a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 07:27:34,051 truncating revision to first 12 chars 2016-07-09 07:27:34,051 Setting DEBUG logging. 2016-07-09 07:27:34,051 attempt 1/10 2016-07-09 07:27:34,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a60cf1b7124a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 07:27:34,495 unpacking tar archive at: mozilla-inbound-a60cf1b7124a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.930432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.930759) ========= script_repo_revision: a60cf1b7124aa067e96cdd751ac526008f96ff8a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.931303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.931578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 07:27:33.941590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-09 07:27:33.941922) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:27:34 INFO - MultiFileLogger online at 20160709 07:27:34 in /builds/slave/test 07:27:34 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 07:27:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:34 INFO - {'append_to_log': False, 07:27:34 INFO - 'base_work_dir': '/builds/slave/test', 07:27:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:27:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:34 INFO - 'branch': 'Mozilla-Inbound', 07:27:34 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:34 INFO - 'config_files': ('talos/linux_config.py',), 07:27:34 INFO - 'default_actions': ('clobber', 07:27:34 INFO - 'read-buildbot-config', 07:27:34 INFO - 'download-and-extract', 07:27:34 INFO - 'populate-webroot', 07:27:34 INFO - 'create-virtualenv', 07:27:34 INFO - 'install', 07:27:34 INFO - 'run-tests'), 07:27:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:34 INFO - 'download_minidump_stackwalk': True, 07:27:34 INFO - 'download_symbols': 'ondemand', 07:27:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:34 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:34 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:34 INFO - 'installer_path': 'installer.exe', 07:27:34 INFO - 'log_level': 'info', 07:27:34 INFO - 'log_name': 'talos', 07:27:34 INFO - 'log_to_console': True, 07:27:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:27:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:27:34 INFO - 'opt_config_files': (), 07:27:34 INFO - 'pip_index': False, 07:27:34 INFO - 'sps_profile': False, 07:27:34 INFO - 'sps_profile_interval': 0, 07:27:34 INFO - 'suite': 'dromaeojs', 07:27:34 INFO - 'system_bits': '32', 07:27:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:34 INFO - 'title': 'talos-linux64-ix-062', 07:27:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:34 INFO - 'use_talos_json': True, 07:27:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:34 INFO - 'work_dir': 'build'} 07:27:34 INFO - ##### 07:27:34 INFO - ##### Running clobber step. 07:27:34 INFO - ##### 07:27:34 INFO - Running pre-action listener: _resource_record_pre_action 07:27:34 INFO - Running main action method: clobber 07:27:34 INFO - rmtree: /builds/slave/test/build 07:27:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:27:35 INFO - Running post-action listener: _resource_record_post_action 07:27:35 INFO - ##### 07:27:35 INFO - ##### Finished clobber step (success) 07:27:35 INFO - ##### 07:27:35 INFO - ##### 07:27:35 INFO - ##### Running read-buildbot-config step. 07:27:35 INFO - ##### 07:27:35 INFO - Running pre-action listener: _resource_record_pre_action 07:27:35 INFO - Running main action method: read_buildbot_config 07:27:35 INFO - Using buildbot properties: 07:27:35 INFO - { 07:27:35 INFO - "project": "", 07:27:35 INFO - "product": "firefox", 07:27:35 INFO - "script_repo_revision": "production", 07:27:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:27:35 INFO - "repository": "", 07:27:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:27:35 INFO - "buildid": "20160709043035", 07:27:35 INFO - "pgo_build": "True", 07:27:35 INFO - "basedir": "/builds/slave/test", 07:27:35 INFO - "buildnumber": 2042, 07:27:35 INFO - "slavename": "talos-linux64-ix-062", 07:27:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:27:35 INFO - "platform": "ubuntu64_hw", 07:27:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:27:35 INFO - "branch": "mozilla-inbound", 07:27:35 INFO - "repo_path": "integration/mozilla-inbound", 07:27:35 INFO - "revision": "a60cf1b7124aa067e96cdd751ac526008f96ff8a", 07:27:35 INFO - "stage_platform": "linux64-pgo", 07:27:35 INFO - "builduid": "41a410e0f81345de8424289bbf30ef86", 07:27:35 INFO - "slavebuilddir": "test" 07:27:35 INFO - } 07:27:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:27:35 INFO - Running post-action listener: _resource_record_post_action 07:27:35 INFO - ##### 07:27:35 INFO - ##### Finished read-buildbot-config step (success) 07:27:35 INFO - ##### 07:27:35 INFO - ##### 07:27:35 INFO - ##### Running download-and-extract step. 07:27:35 INFO - ##### 07:27:35 INFO - Running pre-action listener: _resource_record_pre_action 07:27:35 INFO - Running main action method: download_and_extract 07:27:35 INFO - mkdir: /builds/slave/test/build/tests 07:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:27:35 INFO - https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:40 INFO - Downloaded 1361 bytes. 07:27:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:27:40 INFO - Using the following test package requirements: 07:27:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:27:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:27:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'jsshell-linux-x86_64.zip'], 07:27:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:27:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:27:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:27:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:27:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:27:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:27: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')]} 07:27:40 INFO - https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:27:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:27:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:27:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:46 INFO - Downloaded 24306680 bytes. 07:27:46 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'] 07:27:46 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 07:27:47 INFO - Return code: 0 07:27:47 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 07:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:27:47 INFO - https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:27:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:27:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:27:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:51 INFO - Downloaded 24306680 bytes. 07:27:51 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'] 07:27:51 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 07:27:52 INFO - Return code: 0 07:27:52 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')]} 07:27:52 INFO - https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:27:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:53 INFO - Downloaded 14403333 bytes. 07:27:53 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'] 07:27:53 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 07:27:53 INFO - Return code: 0 07:27:53 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')]} 07:27:53 INFO - https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:27:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:27:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:27:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC000cVQTAGVwuLD26-etQ/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 07:27:55 INFO - Downloaded 60483221 bytes. 07:27:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:27:55 INFO - mkdir: /builds/slave/test/properties 07:27:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:55 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:55 INFO - Contents: 07:27:55 INFO - build_url:https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:27:55 INFO - Running post-action listener: _resource_record_post_action 07:27:55 INFO - Running post-action listener: set_extra_try_arguments 07:27:55 INFO - ##### 07:27:55 INFO - ##### Finished download-and-extract step (success) 07:27:55 INFO - ##### 07:27:55 INFO - ##### 07:27:55 INFO - ##### Running populate-webroot step. 07:27:55 INFO - ##### 07:27:55 INFO - Running pre-action listener: _resource_record_pre_action 07:27:55 INFO - Running main action method: populate_webroot 07:27:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:55 INFO - '--tppagecycles', 07:27:55 INFO - '7'], 07:27:55 INFO - 'tests': ['tsvgm']}}, 07:27:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:27:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:27:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['damp', 'tps']}, 07:27:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'tests': ['damp', 'tps']}, 07:27:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['dromaeo_dom']}, 07:27:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['basic_compositor_video']}, 07:27:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:27:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['a11yr', 07:27:55 INFO - 'ts_paint', 07:27:55 INFO - 'tpaint', 07:27:55 INFO - 'sessionrestore', 07:27:55 INFO - 'sessionrestore_no_auto_restore', 07:27:55 INFO - 'tabpaint']}, 07:27:55 INFO - 'other-e10s': {'tests': ['a11yr', 07:27:55 INFO - 'ts_paint', 07:27:55 INFO - 'tpaint', 07:27:55 INFO - 'sessionrestore', 07:27:55 INFO - 'sessionrestore_no_auto_restore', 07:27:55 INFO - 'tabpaint']}, 07:27:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:27:55 INFO - 'ts_paint', 07:27:55 INFO - 'tpaint', 07:27:55 INFO - 'sessionrestore', 07:27:55 INFO - 'sessionrestore_no_auto_restore', 07:27:55 INFO - 'tabpaint']}, 07:27:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:27:55 INFO - 'ts_paint', 07:27:55 INFO - 'tpaint', 07:27:55 INFO - 'sessionrestore', 07:27:55 INFO - 'sessionrestore_no_auto_restore', 07:27:55 INFO - 'tabpaint']}, 07:27:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['a11yr', 07:27:55 INFO - 'ts_paint', 07:27:55 INFO - 'tpaint', 07:27:55 INFO - 'sessionrestore', 07:27:55 INFO - 'sessionrestore_no_auto_restore', 07:27:55 INFO - 'tabpaint']}, 07:27:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['a11yr', 07:27:55 INFO - 'ts_paint', 07:27:55 INFO - 'tpaint', 07:27:55 INFO - 'sessionrestore', 07:27:55 INFO - 'sessionrestore_no_auto_restore', 07:27:55 INFO - 'tabpaint']}, 07:27:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['tsvgx', 07:27:55 INFO - 'tsvgr_opacity', 07:27:55 INFO - 'tart', 07:27:55 INFO - 'tscrollx', 07:27:55 INFO - 'cart']}, 07:27:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:27:55 INFO - 'tsvgr_opacity', 07:27:55 INFO - 'tart', 07:27:55 INFO - 'tscrollx', 07:27:55 INFO - 'cart']}, 07:27:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'talos_options': ['--disable-e10s'], 07:27:55 INFO - 'tests': ['tp5o']}, 07:27:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'tests': ['tp5o']}, 07:27:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'talos_options': ['--disable-e10s', 07:27:55 INFO - '--xperf_path', 07:27:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:55 INFO - 'tests': ['tp5n']}, 07:27:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:55 INFO - 'talos_options': ['--xperf_path', 07:27:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:55 INFO - 'tests': ['tp5n']}}, 07:27:55 INFO - 'talos.zip': {'path': '', 07:27:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:55 INFO - Running post-action listener: _resource_record_post_action 07:27:55 INFO - ##### 07:27:55 INFO - ##### Finished populate-webroot step (success) 07:27:55 INFO - ##### 07:27:55 INFO - ##### 07:27:55 INFO - ##### Running create-virtualenv step. 07:27:55 INFO - ##### 07:27:55 INFO - Running pre-action listener: _resource_record_pre_action 07:27:55 INFO - Running main action method: create_virtualenv 07:27:55 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:55 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 07:27:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:56 INFO - Using real prefix '/usr' 07:27:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:56 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:58 INFO - Installing pip.................done. 07:27:58 INFO - Return code: 0 07:27:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:27: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', 'pip>=1.5'] in /builds/slave/test/build 07:27: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 pip>=1.5 07:27:58 INFO - Using env: {'DISPLAY': ':0', 07:27:58 INFO - 'HOME': '/home/cltbld', 07:27:58 INFO - 'LANG': 'en_US.UTF-8', 07:27:58 INFO - 'LANGUAGE': 'en_US:en', 07:27:58 INFO - 'LOGNAME': 'cltbld', 07:27:58 INFO - 'MAIL': '/var/mail/cltbld', 07:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:58 INFO - 'MOZ_NO_REMOTE': '1', 07:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:58 INFO - 'NO_EM_RESTART': '1', 07:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:58 INFO - 'PWD': '/builds/slave/test', 07:27:58 INFO - 'SHELL': '/bin/bash', 07:27:58 INFO - 'SHLVL': '1', 07:27:58 INFO - 'TERM': 'linux', 07:27:58 INFO - 'TMOUT': '86400', 07:27:58 INFO - 'USER': 'cltbld', 07:27:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:58 INFO - '_': '/tools/buildbot/bin/python'} 07:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:58 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 07:27:58 INFO - Cleaning up... 07:27:58 INFO - Return code: 0 07:27:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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', '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 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:27: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 psutil>=3.1.1 07:27:58 INFO - Using env: {'DISPLAY': ':0', 07:27:58 INFO - 'HOME': '/home/cltbld', 07:27:58 INFO - 'LANG': 'en_US.UTF-8', 07:27:58 INFO - 'LANGUAGE': 'en_US:en', 07:27:58 INFO - 'LOGNAME': 'cltbld', 07:27:58 INFO - 'MAIL': '/var/mail/cltbld', 07:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:58 INFO - 'MOZ_NO_REMOTE': '1', 07:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:58 INFO - 'NO_EM_RESTART': '1', 07:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:58 INFO - 'PWD': '/builds/slave/test', 07:27:58 INFO - 'SHELL': '/bin/bash', 07:27:58 INFO - 'SHLVL': '1', 07:27:58 INFO - 'TERM': 'linux', 07:27:58 INFO - 'TMOUT': '86400', 07:27:58 INFO - 'USER': 'cltbld', 07:27:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:58 INFO - '_': '/tools/buildbot/bin/python'} 07:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:58 INFO - Downloading/unpacking psutil>=3.1.1 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:01 INFO - Installing collected packages: psutil 07:28:01 INFO - Running setup.py install for psutil 07:28:01 INFO - building 'psutil._psutil_linux' extension 07:28:01 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 07:28:01 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 07:28:01 INFO - building 'psutil._psutil_posix' extension 07:28:01 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 07:28:01 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 07:28:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:01 INFO - Successfully installed psutil 07:28:01 INFO - Cleaning up... 07:28:01 INFO - Return code: 0 07:28:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:28:01 INFO - Using env: {'DISPLAY': ':0', 07:28:01 INFO - 'HOME': '/home/cltbld', 07:28:01 INFO - 'LANG': 'en_US.UTF-8', 07:28:01 INFO - 'LANGUAGE': 'en_US:en', 07:28:01 INFO - 'LOGNAME': 'cltbld', 07:28:01 INFO - 'MAIL': '/var/mail/cltbld', 07:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:01 INFO - 'MOZ_NO_REMOTE': '1', 07:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:01 INFO - 'NO_EM_RESTART': '1', 07:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:01 INFO - 'PWD': '/builds/slave/test', 07:28:01 INFO - 'SHELL': '/bin/bash', 07:28:01 INFO - 'SHLVL': '1', 07:28:01 INFO - 'TERM': 'linux', 07:28:01 INFO - 'TMOUT': '86400', 07:28:01 INFO - 'USER': 'cltbld', 07:28:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:01 INFO - '_': '/tools/buildbot/bin/python'} 07:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:28:03 INFO - Installing collected packages: mozsystemmonitor 07:28:03 INFO - Running setup.py install for mozsystemmonitor 07:28:03 INFO - Successfully installed mozsystemmonitor 07:28:03 INFO - Cleaning up... 07:28:04 INFO - Return code: 0 07:28:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:28:04 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')]} 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 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')]} 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 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 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:28:04 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 07:28:04 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 07:28:04 INFO - Using env: {'DISPLAY': ':0', 07:28:04 INFO - 'HOME': '/home/cltbld', 07:28:04 INFO - 'LANG': 'en_US.UTF-8', 07:28:04 INFO - 'LANGUAGE': 'en_US:en', 07:28:04 INFO - 'LOGNAME': 'cltbld', 07:28:04 INFO - 'MAIL': '/var/mail/cltbld', 07:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:04 INFO - 'MOZ_NO_REMOTE': '1', 07:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:04 INFO - 'NO_EM_RESTART': '1', 07:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:04 INFO - 'PWD': '/builds/slave/test', 07:28:04 INFO - 'SHELL': '/bin/bash', 07:28:04 INFO - 'SHLVL': '1', 07:28:04 INFO - 'TERM': 'linux', 07:28:04 INFO - 'TMOUT': '86400', 07:28:04 INFO - 'USER': 'cltbld', 07:28:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:04 INFO - '_': '/tools/buildbot/bin/python'} 07:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:04 INFO - Downloading/unpacking jsonschema==2.5.1 07:28:04 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 07:28:04 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 07:28:04 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 07:28:04 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 07:28:04 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 07:28:04 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 07:28:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:06 INFO - warning: no files found matching '*.txt' 07:28:06 INFO - no previously-included directories found matching 'build' 07:28:06 INFO - no previously-included directories found matching 'dist' 07:28:06 INFO - no previously-included directories found matching '.git*' 07:28:06 INFO - Installing collected packages: jsonschema, functools32 07:28:06 INFO - Running setup.py install for functools32 07:28:06 INFO - warning: no files found matching '*.txt' 07:28:06 INFO - no previously-included directories found matching 'build' 07:28:06 INFO - no previously-included directories found matching 'dist' 07:28:06 INFO - no previously-included directories found matching '.git*' 07:28:06 INFO - Successfully installed jsonschema functools32 07:28:06 INFO - Cleaning up... 07:28:06 INFO - Return code: 0 07:28:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:06 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 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:28:06 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 07:28:06 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 07:28:06 INFO - Using env: {'DISPLAY': ':0', 07:28:06 INFO - 'HOME': '/home/cltbld', 07:28:06 INFO - 'LANG': 'en_US.UTF-8', 07:28:06 INFO - 'LANGUAGE': 'en_US:en', 07:28:06 INFO - 'LOGNAME': 'cltbld', 07:28:06 INFO - 'MAIL': '/var/mail/cltbld', 07:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:06 INFO - 'MOZ_NO_REMOTE': '1', 07:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:06 INFO - 'NO_EM_RESTART': '1', 07:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:06 INFO - 'PWD': '/builds/slave/test', 07:28:06 INFO - 'SHELL': '/bin/bash', 07:28:06 INFO - 'SHLVL': '1', 07:28:06 INFO - 'TERM': 'linux', 07:28:06 INFO - 'TMOUT': '86400', 07:28:06 INFO - 'USER': 'cltbld', 07:28:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:06 INFO - '_': '/tools/buildbot/bin/python'} 07:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:06 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 07:28:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:09 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 07:28:09 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 07:28:09 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 07:28:09 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 07:28:09 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 07:28:09 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 07:28:09 INFO - Downloading docopt-0.6.1.tar.gz 07:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:09 INFO - Running setup.py install for blobuploader 07:28:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:09 INFO - Running setup.py install for requests 07:28:10 INFO - Running setup.py install for docopt 07:28:10 INFO - Successfully installed blobuploader requests docopt 07:28:10 INFO - Cleaning up... 07:28:10 INFO - Return code: 0 07:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 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 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:28:10 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 07:28:10 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 07:28:10 INFO - Using env: {'DISPLAY': ':0', 07:28:10 INFO - 'HOME': '/home/cltbld', 07:28:10 INFO - 'LANG': 'en_US.UTF-8', 07:28:10 INFO - 'LANGUAGE': 'en_US:en', 07:28:10 INFO - 'LOGNAME': 'cltbld', 07:28:10 INFO - 'MAIL': '/var/mail/cltbld', 07:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:10 INFO - 'MOZ_NO_REMOTE': '1', 07:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:10 INFO - 'NO_EM_RESTART': '1', 07:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:10 INFO - 'PWD': '/builds/slave/test', 07:28:10 INFO - 'SHELL': '/bin/bash', 07:28:10 INFO - 'SHLVL': '1', 07:28:10 INFO - 'TERM': 'linux', 07:28:10 INFO - 'TMOUT': '86400', 07:28:10 INFO - 'USER': 'cltbld', 07:28:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:10 INFO - '_': '/tools/buildbot/bin/python'} 07:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:10 INFO - Running setup.py (path:/tmp/pip-KUpWf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:10 INFO - Running setup.py (path:/tmp/pip-81RTTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:10 INFO - Running setup.py (path:/tmp/pip-NYfy7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:10 INFO - Running setup.py (path:/tmp/pip-_R316_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:10 INFO - Running setup.py (path:/tmp/pip-8OBkLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:10 INFO - Running setup.py (path:/tmp/pip-aqWeS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:10 INFO - Running setup.py (path:/tmp/pip-2cjmsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:10 INFO - Running setup.py (path:/tmp/pip-x30NGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:10 INFO - Running setup.py (path:/tmp/pip-qXpSG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:11 INFO - Running setup.py (path:/tmp/pip-FhETdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:11 INFO - Running setup.py (path:/tmp/pip-ngpla7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:11 INFO - Running setup.py (path:/tmp/pip-XqnH0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:11 INFO - Running setup.py (path:/tmp/pip-puZpMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:11 INFO - Running setup.py (path:/tmp/pip-UG_1Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:11 INFO - Running setup.py (path:/tmp/pip-Ue3YW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:11 INFO - Running setup.py (path:/tmp/pip-Ft3ytv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:11 INFO - Running setup.py (path:/tmp/pip-InrA3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:11 INFO - Running setup.py install for manifestparser 07:28:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozcrash 07:28:11 INFO - Running setup.py install for mozdebug 07:28:11 INFO - Running setup.py install for mozdevice 07:28:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozfile 07:28:12 INFO - Running setup.py install for mozhttpd 07:28:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozinfo 07:28:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozInstall 07:28:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozleak 07:28:12 INFO - Running setup.py install for mozlog 07:28:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for moznetwork 07:28:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozprocess 07:28:12 INFO - Running setup.py install for mozprofile 07:28:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozrunner 07:28:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:13 INFO - Running setup.py install for mozscreenshot 07:28:13 INFO - Running setup.py install for moztest 07:28:13 INFO - Running setup.py install for mozversion 07:28:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:13 INFO - Cleaning up... 07:28:13 INFO - Return code: 0 07:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:13 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 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:28:13 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 07:28:13 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 07:28:13 INFO - Using env: {'DISPLAY': ':0', 07:28:13 INFO - 'HOME': '/home/cltbld', 07:28:13 INFO - 'LANG': 'en_US.UTF-8', 07:28:13 INFO - 'LANGUAGE': 'en_US:en', 07:28:13 INFO - 'LOGNAME': 'cltbld', 07:28:13 INFO - 'MAIL': '/var/mail/cltbld', 07:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:13 INFO - 'MOZ_NO_REMOTE': '1', 07:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:13 INFO - 'NO_EM_RESTART': '1', 07:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:13 INFO - 'PWD': '/builds/slave/test', 07:28:13 INFO - 'SHELL': '/bin/bash', 07:28:13 INFO - 'SHLVL': '1', 07:28:13 INFO - 'TERM': 'linux', 07:28:13 INFO - 'TMOUT': '86400', 07:28:13 INFO - 'USER': 'cltbld', 07:28:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:13 INFO - '_': '/tools/buildbot/bin/python'} 07:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:13 INFO - Running setup.py (path:/tmp/pip-G4VsXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:13 INFO - Running setup.py (path:/tmp/pip-PkhM33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:13 INFO - Running setup.py (path:/tmp/pip-ELS_X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:13 INFO - Running setup.py (path:/tmp/pip-kDL2Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:13 INFO - Running setup.py (path:/tmp/pip-tetbcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:14 INFO - Running setup.py (path:/tmp/pip-Yv4nBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:14 INFO - Running setup.py (path:/tmp/pip-RL2FOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:14 INFO - Running setup.py (path:/tmp/pip-U9YMUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:14 INFO - Running setup.py (path:/tmp/pip-uw0k6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:14 INFO - Running setup.py (path:/tmp/pip-7SnSh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:14 INFO - Running setup.py (path:/tmp/pip-Lt_Nmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:14 INFO - Running setup.py (path:/tmp/pip-WvqlQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:14 INFO - Running setup.py (path:/tmp/pip-SMAy0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:14 INFO - Running setup.py (path:/tmp/pip-IO_KHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:14 INFO - Running setup.py (path:/tmp/pip-6aJW61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:14 INFO - Running setup.py (path:/tmp/pip-queR_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:14 INFO - Running setup.py (path:/tmp/pip-d6OcGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:14 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 07:28:14 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 07:28:14 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 07:28:14 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 07:28:14 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 07:28:14 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 07:28:16 INFO - Downloading blessings-1.6.tar.gz 07:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:16 INFO - Installing collected packages: blessings 07:28:16 INFO - Running setup.py install for blessings 07:28:16 INFO - Successfully installed blessings 07:28:16 INFO - Cleaning up... 07:28:17 INFO - Return code: 0 07:28:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:17 INFO - Reading from file tmpfile_stdout 07:28:17 INFO - Current package versions: 07:28:17 INFO - argparse == 1.2.1 07:28:17 INFO - blessings == 1.6 07:28:17 INFO - blobuploader == 1.2.4 07:28:17 INFO - docopt == 0.6.1 07:28:17 INFO - functools32 == 3.2.3-2 07:28:17 INFO - jsonschema == 2.5.1 07:28:17 INFO - manifestparser == 1.1 07:28:17 INFO - mozInstall == 1.12 07:28:17 INFO - mozcrash == 0.17 07:28:17 INFO - mozdebug == 0.1 07:28:17 INFO - mozdevice == 0.48 07:28:17 INFO - mozfile == 1.2 07:28:17 INFO - mozhttpd == 0.7 07:28:17 INFO - mozinfo == 0.9 07:28:17 INFO - mozleak == 0.1 07:28:17 INFO - mozlog == 3.2 07:28:17 INFO - moznetwork == 0.27 07:28:17 INFO - mozprocess == 0.23 07:28:17 INFO - mozprofile == 0.28 07:28:17 INFO - mozrunner == 6.12 07:28:17 INFO - mozscreenshot == 0.1 07:28:17 INFO - mozsystemmonitor == 0.3 07:28:17 INFO - moztest == 0.7 07:28:17 INFO - mozversion == 1.4 07:28:17 INFO - psutil == 3.1.1 07:28:17 INFO - requests == 1.2.3 07:28:17 INFO - wsgiref == 0.1.2 07:28:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:17 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 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:28:17 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 07:28:17 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 07:28:17 INFO - Using env: {'DISPLAY': ':0', 07:28:17 INFO - 'HOME': '/home/cltbld', 07:28:17 INFO - 'LANG': 'en_US.UTF-8', 07:28:17 INFO - 'LANGUAGE': 'en_US:en', 07:28:17 INFO - 'LOGNAME': 'cltbld', 07:28:17 INFO - 'MAIL': '/var/mail/cltbld', 07:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:17 INFO - 'MOZ_NO_REMOTE': '1', 07:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:17 INFO - 'NO_EM_RESTART': '1', 07:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:17 INFO - 'PWD': '/builds/slave/test', 07:28:17 INFO - 'SHELL': '/bin/bash', 07:28:17 INFO - 'SHLVL': '1', 07:28:17 INFO - 'TERM': 'linux', 07:28:17 INFO - 'TMOUT': '86400', 07:28:17 INFO - 'USER': 'cltbld', 07:28:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:17 INFO - '_': '/tools/buildbot/bin/python'} 07:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 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)) 07:28:17 INFO - Cleaning up... 07:28:17 INFO - Return code: 0 07:28:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:17 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 0x152e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', '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 07:28:17 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 07:28:17 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 07:28:17 INFO - Using env: {'DISPLAY': ':0', 07:28:17 INFO - 'HOME': '/home/cltbld', 07:28:17 INFO - 'LANG': 'en_US.UTF-8', 07:28:17 INFO - 'LANGUAGE': 'en_US:en', 07:28:17 INFO - 'LOGNAME': 'cltbld', 07:28:17 INFO - 'MAIL': '/var/mail/cltbld', 07:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:17 INFO - 'MOZ_NO_REMOTE': '1', 07:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:17 INFO - 'NO_EM_RESTART': '1', 07:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:17 INFO - 'PWD': '/builds/slave/test', 07:28:17 INFO - 'SHELL': '/bin/bash', 07:28:17 INFO - 'SHLVL': '1', 07:28:17 INFO - 'TERM': 'linux', 07:28:17 INFO - 'TMOUT': '86400', 07:28:17 INFO - 'USER': 'cltbld', 07:28:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:17 INFO - '_': '/tools/buildbot/bin/python'} 07:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:28:17 INFO - Cleaning up... 07:28:17 INFO - Return code: 0 07:28:17 INFO - Running post-action listener: _resource_record_post_action 07:28:17 INFO - Running post-action listener: _start_resource_monitoring 07:28:17 INFO - Starting resource monitoring. 07:28:17 INFO - ##### 07:28:17 INFO - ##### Finished create-virtualenv step (success) 07:28:17 INFO - ##### 07:28:17 INFO - ##### 07:28:17 INFO - ##### Running install step. 07:28:17 INFO - ##### 07:28:17 INFO - Running pre-action listener: _resource_record_pre_action 07:28:17 INFO - Running main action method: install 07:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:17 INFO - Reading from file tmpfile_stdout 07:28:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:18 INFO - Reading from file tmpfile_stdout 07:28:18 INFO - Output received: 07:28:18 INFO - Usage: mozinstall [options] installer 07:28:18 INFO - Options: 07:28:18 INFO - -h, --help show this help message and exit 07:28:18 INFO - -d DEST, --destination=DEST 07:28:18 INFO - Directory to install application into. [default: 07:28:18 INFO - "/builds/slave/test"] 07:28:18 INFO - --app=APP Application being installed. [default: firefox] 07:28:18 INFO - mkdir: /builds/slave/test/build/application 07:28:18 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'] 07:28:18 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 07:28:35 INFO - Reading from file tmpfile_stdout 07:28:35 INFO - Output received: 07:28:35 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:35 INFO - Running post-action listener: _resource_record_post_action 07:28:35 INFO - ##### 07:28:35 INFO - ##### Finished install step (success) 07:28:35 INFO - ##### 07:28:35 INFO - ##### 07:28:35 INFO - ##### Running run-tests step. 07:28:35 INFO - ##### 07:28:35 INFO - Running pre-action listener: _resource_record_pre_action 07:28:35 INFO - Running main action method: run_tests 07:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:35 INFO - Python 2.7.3 07:28:35 INFO - Return code: 0 07:28:35 INFO - grabbing minidump binary from tooltool 07:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:28:35 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 0x17ed3b0>, '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 0x17ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ee740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:35 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 07:28:35 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 07:28:35 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 07:28:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:35 INFO - Return code: 0 07:28:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:35 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/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:28:35 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/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:28:35 INFO - Using env: {'DISPLAY': ':0', 07:28:35 INFO - 'HOME': '/home/cltbld', 07:28:35 INFO - 'LANG': 'en_US.UTF-8', 07:28:35 INFO - 'LANGUAGE': 'en_US:en', 07:28:35 INFO - 'LOGNAME': 'cltbld', 07:28:35 INFO - 'MAIL': '/var/mail/cltbld', 07:28:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:35 INFO - 'MOZ_NO_REMOTE': '1', 07:28:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:35 INFO - 'NO_EM_RESTART': '1', 07:28:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:35 INFO - 'PWD': '/builds/slave/test', 07:28:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:35 INFO - 'SHELL': '/bin/bash', 07:28:35 INFO - 'SHLVL': '1', 07:28:35 INFO - 'TERM': 'linux', 07:28:35 INFO - 'TMOUT': '86400', 07:28:35 INFO - 'USER': 'cltbld', 07:28:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576', 07:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:35 INFO - '_': '/tools/buildbot/bin/python'} 07:28:35 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/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:28:35 INFO - mozversion application_buildid: 20160709043035 07:28:35 INFO - mozversion application_changeset: a60cf1b7124aa067e96cdd751ac526008f96ff8a 07:28:35 INFO - mozversion application_display_name: Nightly 07:28:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:35 INFO - mozversion application_name: Firefox 07:28:35 INFO - mozversion application_remotingname: firefox 07:28:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:28:35 INFO - mozversion application_vendor: Mozilla 07:28:35 INFO - mozversion application_version: 50.0a1 07:28:35 INFO - mozversion platform_buildid: 20160709043035 07:28:35 INFO - mozversion platform_changeset: a60cf1b7124aa067e96cdd751ac526008f96ff8a 07:28:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:28:35 INFO - mozversion platform_version: 50.0a1 07:28:35 INFO - using testdate: 1468074515 07:28:35 INFO - actual date: 1468074515 07:28:35 INFO - starting webserver on 'localhost:48439' 07:28:35 INFO - SUITE-START | Running 2 tests 07:28:35 INFO - TEST-START | dromaeo_css 07:28:35 INFO - operating with platform_type : linux_ 07:28:35 INFO - Initialising browser for dromaeo_css test... 07:28:35 INFO - TEST-INFO | started process 11092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZp1cpD/profile http://localhost:48439/getInfo.html) 07:28:39 INFO - PROCESS | 11092 | __metrics Screen width/height:1600/1200 07:28:39 INFO - PROCESS | 11092 | colorDepth:24 07:28:39 INFO - PROCESS | 11092 | Browser inner width/height: 1024/697 07:28:39 INFO - PROCESS | 11092 | __metrics 07:28:39 INFO - PROCESS | 11092 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:40 INFO - TEST-INFO | 11092: exit 0 07:28:40 INFO - Browser initialized. 07:28:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:40 INFO - TEST-INFO | started process 11176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZp1cpD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:52 INFO - PROCESS | 11176 | RSS: Main: 157495296 07:28:52 INFO - PROCESS | 11176 | 07:29:43 INFO - PROCESS | 11176 | 1468074583396 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] 07:31:51 INFO - PROCESS | 11176 | Cycle 1(1): loaded http://localhost:48439/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48439/tests/dromaeo/cssquery-ext.html) 07:31:52 INFO - PROCESS | 11176 | RSS: Main: 267046912 07:31:52 INFO - PROCESS | 11176 | 07:34:54 INFO - PROCESS | 11176 | Cycle 1(1): loaded http://localhost:48439/tests/dromaeo/cssquery-ext.html (next: http://localhost:48439/tests/dromaeo/cssquery-jquery.html) 07:34:55 INFO - PROCESS | 11176 | RSS: Main: 240902144 07:34:55 INFO - PROCESS | 11176 | 07:37:57 INFO - PROCESS | 11176 | Cycle 1(1): loaded http://localhost:48439/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48439/tests/dromaeo/cssquery-mootools.html) 07:37:58 INFO - PROCESS | 11176 | RSS: Main: 240017408 07:37:58 INFO - PROCESS | 11176 | 07:40:59 INFO - PROCESS | 11176 | Cycle 1(1): loaded http://localhost:48439/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48439/tests/dromaeo/cssquery-prototype.html) 07:41:00 INFO - PROCESS | 11176 | RSS: Main: 234569728 07:41:00 INFO - PROCESS | 11176 | 07:44:03 INFO - PROCESS | 11176 | Cycle 1(1): loaded http://localhost:48439/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48439/tests/dromaeo/cssquery-yui.html) 07:44:03 INFO - PROCESS | 11176 | RSS: Main: 228114432 07:44:03 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | Cycle 1(1): loaded http://localhost:48439/tests/dromaeo/cssquery-yui.html (next: http://localhost:48439/tests/dromaeo/cssquery-dojo.html) 07:47:06 INFO - PROCESS | 11176 | RSS: Main: 286203904 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | __start_tp_report 07:47:06 INFO - PROCESS | 11176 | _x_x_mozilla_page_load 07:47:06 INFO - PROCESS | 11176 | _x_x_mozilla_page_load_details 07:47:06 INFO - PROCESS | 11176 | |i|pagename|runs| 07:47:06 INFO - PROCESS | 11176 | |0;dojo.html;2993.850307484626;3005.3388254583983;3017.834019128947;3035.514317709167;3036.6659667436584;4940.1354762916435;5003.949960500394;5140.100482415576;5226.451222621622;5306.681599104047;5145.562627176694;5172.6637768545015;5202.687838729679;5248.239005344223;5288;4658.86023419298;4677.83627573035;4702.600278976274;4708.176069187878;4762.238041913277;4769.856904292877;4772.2125849234835;4844.5155484451625;4851.27230915362;4892.608591312686;4632.513586073447;4670.509596492353;4686.953130468686;4762.309465127554;4775.212090005145;4719.693219940727;4725.196716558194;4726.645501587394;4729.9763501182615;4731.881702957419;4646.465656449518;4675.345451636774;4679.181143299943;4699.765011749433;4746.572808447257;5124.564412024983;5152.5105115014385;5182.170852663593;5187.273781670569;5191.740412979374;5460.890782184334;5504.504594586467;5513.696746678931;5524.116141417354;5533.778648854041;5340.279062326614;5474.945250547484;5503.972480137613;5514.6691198528215;5578.023845827005;5171.793128274902;5205.141151709963;5216;5221.686698798122;5223.373195216598;5464.316960379952;5626.831195064155;5671.914921276184;5678.4605462480995;5708.115242137475;5342.1185504392115;5460.290162278879;5470.288862447936;5478.972605136949;5509.311336082989;5548.500634942875;5585.385607583163;5628.099504079328;5633.4084921082695;5633.774649014075;5349.251104845324;5487.341519017744;5529.612927095145;5548.5838562108;5572.804951826666;5523.861903452445;5531.170324451365;5534.308211473566;5536.889262214814;5595.664260144405;4268.253055715238;4269.658427325807;4271.551487093872;4288;4309.547497512779;3760.3795373763023;3771.905702357463;3817.828197731109;3846.6922646188796;3874.8643797466952;5159.819406320761;5174.870628234249;5179.663321884065;5185.429602743695;5228.163493840967;5463.890722185534;5467.343918729778;5477.917831232535;5478.287822583118;5523.558115350843;5040.521150490697;5168.948310516922;5231.843044708665;5308.283381743492;5322.840314790563;4816.133096042676;4853.247746599282;4857.8299759508245;4861.440934292602;4900.607951363882;5696.458836410535;5698.373178950312;5699.800506982236;5704.11586204139;5714.371419143891;5378.327709036371;5511.145772405283;5548.195511650707;5558.055130627722;5559.610827242216;5779.757352169136;5780.537556995346;5782.826515204551;5787.2187254720075;5787.56593255516;5267.552258058108;5414.458554144554;5473;5490.313710786152;5499.862503437446;5527.391986881359;5555.861103472445;5598.300212473441;5612.410696876933;5619.100943848965;5443.346798384219;5457.235986961749;5493.038718224215;5495.120780675073;5498.615096943176;5241.50205730455;5399.244105825266;5425.186222066722;5426.4573542646995;5474.3704473986;5323.840284791462;5327.387350454747;5343.492368225013;5344.893102137858;5396.4333744957785;5422.810201642924;5438.211459338453;5446.455354464521;5479.780808767605;5566.832995010156;5137.588992880485;5309.973450132725;5337.066013447708;5375.059364611099;5380.273663055437 07:47:06 INFO - PROCESS | 11176 | |1;ext.html;594.8126340202839;609.2323672173061;615.5937081526193;617.4720613875137;634.9015902535109;30652.233694157658;43923;45047.324290135635;45047.77476112623;45082;46267.53732462674;46564;46594.30108548366;46669.06661866761;46673;9026.50354230517;9164.954175229148;9179.72460826173;9181.816363672722;9191.35660503765;9009.099090091004;9094.954525227364;9097.135772101672;9100.044495327995;9115.726528204164;9011.459312441242;9016.729498115033;9065.365424420293;9143.588538515749;9149.130832570896;9025.323100767437;9107.089291070906;9114.407563508417;9123.31575131861;9133.17801397874;8980.236679882219;9041.728748137566;9044.457332560067;9056.320775941766;9056.683016094405;43276.350854737204;43575.78212108919;43612.78193609043;43629;43646.345304820454;3602.189507360849;3649.434337677664;3666.7616604920595;3694.780722361614;4253.128108737732;32821.83589082063;32918.341633167445;33072.834635826905;33081.33837323264;33172.834135829406;4264.637505812009;4319.460067491564;4366.8908277293;4471.686981911267;4474.7986340614425;246915;247231;248033;248137;248982;60095.39904600986;60192;60362;60413.77103602706;60692.39307606867;63081.36918630755;63347.6832615834;63430.68284658547;63469.36530634634;63475.36524634787;17283.827161728474;17537.210825512884;17546.912265438845;17571.209295581728;17586.560335991446;13530.526431574848;13661.931690341484;13671.453141874412;13673.179609223478;13679.316034198251;17171.914140429217;18231.63536729258;18327.450176494727;18335.724964125548;18486.260549578135;6099.3900609938655;6237.438630523275;6277.5605707600025;6369.394907483782;6411.679416029273;1029.711680729397;1030.5105075089273;1077.3212875888296;1093.327603523827;1172.20290202663;32692.18269543233;32969.67030329666;32994;33457;33953.49069763956;949.3164921256684;1130.3500487219717;1137.9317240965568;1199.8320235167084;1265.373640048182;16861;17155.142242888054;17209.397671081704;17214.392803598203;17352;516654;530778;535781;537354;787105;60018.39981600128;60178;60634;60684.696576517716;60935.08597371043;1259.6787819106069;1340.9061365704501;1341.7920222365549;1368.6715188354922;1412.5974097382198;29946.3961899447;34119.65880341264;34521.30957380889;34612.65387346094;35073.64926350704;54120;54342.456575435324;54945.1758223635;55065;55084.72457637686;453466;464368;465070;466424;467440;38153.61846381501;44090.779546103346;44422.11155776802;44957.55042449533;44960;46829.76585117189;47554.52445475501;48406.5159348402;50933.74533127311;52126.73936630293;41432.79283603683;42441.575584244994;42491.3626295612;42755.35866961936;43729;42600.786996064824;42740.78629606832;42973.140537188454;43089.56910430855;43919.56080439155;41780.16439671129;42642.57357426386;42806.14387712291;43039;43267.78366108149;36377.45433818442;38624.42063368995;38906.61093389143;39292.41061384024;39615;28489;28534;28813.930566202944;28914.855425722737;28952.565711514766 07:47:06 INFO - PROCESS | 11176 | |2;jquery.html;378.9639984201502;393.33722677288773;394.98025098745063;395.4483495523746;407.4804624104267;17655.735163972535;19961.401157965247;20654.277100301493;21045.368638940818;21048.052837622305;11871.7625647487;12374.505019799197;12410.379481025957;12457.377131143428;12494.437750301235;5202.089634313998;5373.81191658292;5401.621886467949;5403.108487099624;5404.1083221268445;3848.9807550962205;5590.301212348457;5892.086726557391;5892.204552385416;5985.610935289193;5707.258056452676;5948.256467941507;5952.464278214959;5978;5978.760849566012;5926.259217597801;5926.585139040269;5932.7330270137945;5952.880942381128;5952.999999999978;3751.0809851586264;5385.488378604026;5661.037623603997;5684.403137670568;5768.538516918637;13690.65773355674;13727.313634318245;16404.75392869108;23455.709935953517;23951.640725389134;2553.8084643651614;2617.751313625203;2621.606758986148;2918.591397204393;2944.4258369617933;10266.076053155251;10603.098736607397;10610.46947652622;10706.46467676613;12537.623871283877;1948.9025548722507;1968.724378586999;1996.3711430899366;2033.2781862438917;2198.087793565668;70846.3322934164;74844;77875.22124778794;82980.58509707413;83757.16242837555;10861.782764344669;10863.782724345627;11122.38826864514;11220.32678039304;11223.214374993671;14429.206393648241;14528;14582.343794529272;14602.926985365006;14652.706945861022;8008.7597372078935;8217.151140993228;8306.958465207636;8310.376721745894;8367.205115514016;8054.959725201454;8092.2716955473115;8175.63209655567;8277.62750676209;8309.709160179365;4637.397138372057;4641.675082744243;4705.176594096088;4723.126221649006;4738.147133516;1767.717165253579;1798.2177752677628;1873.9437816865516;1917.88492690439;1999.9000049997442;1039.8336266197523;1067.7384040910026;1071.8177909755361;1082.4858192358724;1108.3073079325422;19142.808571914382;19271.90364048199;19767;19891.801081988993;20388.79611203869;977.4184360305607;978.8189185000798;1000.2048371544639;1020.4744556553381;1061.4957894999968;10598.841017384746;11058.502367393487;11156;11184.776304473866;11206.495707693173;479808;485306;488619.682819032;492094;494818;88768;90035;92030;92737.53631231935;96656;972.1882228339274;977.9266555008403;999.9000099989943;1016.192127258831;1025.5128813813378;17757.64484710273;18008.819911800714;18252.72620910714;18453.354132605295;18570.350037748613;45289;45311.54688453073;45447.318290226336;45728.77135614434;46412.767936160104;59131;61542.61488621394;61635;62072;63025.68487157535;8503.914960850312;8547.358948079043;8623.784405389915;8717.65129394817;8789.648414063366;9806.85289720669;12756.362181891054;13513.324333783468;14002.509912153026;14042.087264327785;11919;12077;12230.510779568718;12310.938445307716;12406.81389779172;11485.253458525169;11790.587329443428;12395.504179833066;12608.36958152107;12822.615321540368;12426.502939882303;12440.564580239648;12552.43514041852;12652.746945061232;12751.872481275439;8728.301735860989;8921.818091104178;8953.462792232487;9005.819883602422;9039.819203616022;11073.667789966314;11621.302721836717;11715.765684686428;12196.085293602839;12262.938685306517 07:47:06 INFO - PROCESS | 11176 | |3;mootools.html;1335.3790487423346;1467.3250304859766;1504.3606467251418;1615.2085478115728;1784.3754685859958;8095.757127286183;8486.660533578657;8490.405671602983;8712.346574006942;8719.084496127894;8484.490930544156;8681.95659021704;8686.609102590382;8692.826143477127;8694.73915782526;2297.9655305170436;2334.48641298914;2339.5087031723274;2345.4839935214227;2350.3771500552366;2233.2741858895843;2264.1283106004144;2285.702858628384;2297.1270917051497;2297.127091705158;2257.0407576779885;2270.96593551096;2280.8859557022165;2289.5878741826464;2293.8967746451367;2214.30249471416;2222.944426389345;2225.710657614516;2229.375774783063;2229.5095079082575;2194.6049711052005;2196.242296407737;2197.318831162329;2199.9890000550054;2202.3282898715884;8345.833083338299;8398.202170793766;8433.072362040171;8519;8580.699675511327;4946.307516947631;5021.347224860745;5062.82280120194;5077.517635824591;5089.491050894918;3139;3317.9834100829585;3361.4117529432497;3377.67912048355;3377.7635565510423;1124.8706398764166;1129.2829053550972;1152.5044230980675;1155.474259212065;1163.4415480569373;11822;11954;11999.820002699966;12008.159428839985;12014.879851201551;4133.503979522417;4191.8532851350055;4361.280388735887;4375.387445757597;4382.189294980439;9298.977112517618;9326;9369.344145909858;9378.390404623815;9390.577424015935;4997.90004199914;5004.724740139327;5035.7985680572365;5048.671836330626;5051.823186188466;4177.582241775798;4472.932906006413;4659;4660.906781864343;4718.9292160617615;3657.341678497896;3667.3215455140353;3748.568914574859;3770.6606405423645;3789.052736815796;1046.215338496128;1049.3179433368218;1065.2010991756183;1067.3062509368817;1068.1294744782977;742.6806473216461;952.852307892264;961.3078583419926;967.1634036558467;982.9066238707454;5756.937074296075;5784.971075144597;5853.443922827325;5970.283565972111;6067.848303792352;489.8897748006741;492.881708389991;495.3931433993329;498.25013354901364;643.7778966256634;3906.160175562268;4093.815778289984;4150.730202536886;4160.916781664349;4210.663146948298;10083.445410502492;10617.522211500502;10639.680809575726;10667.359958402521;10809.135269178447;10627.415492148006;10648.680539583826;10658.840117398246;10683;10696.304740191863;7512.812179695551;7865.764027079311;7898.091719452222;7898.802529936797;7925.643346049442;6011.38504750435;6113.755449781959;6180.938190618216;6193.225846769154;6344.873102537831;9975.301728878909;10059.597616095274;10091.596336146766;10100.949495252476;10107.7473063174;9793.80412391734;10027.54876030595;10223.079922806983;10325.845112323172;10340.638077667245;7021.1574611047;7580.583067931317;7591.3547348475995;7707.576083315472;7763.4953728007495;8652.610632521677;8655.0479447262;8656.91343086561;8699.739007829776;8705.695300664447;7540.811479713051;7757.3018428339465;7759.72840950564;7828.060632724109;7873.25204105609;7291.708331666886;7415.8887616684715;7559.092908850973;7678.692852285846;7695.422843286664;6937.306269373023;6961.477889158435;6994.475414344046;7008.264132266038;7017.157941047107;5053.469385714594;5111.156659151198;5221.060209162387;5248.816291429782;5287.471252874681;5104.519689290064;5177.4822517747925;5207.843764687065;5245.475452454877;5308.150695888639 07:47:06 INFO - PROCESS | 11176 | |4;prototype.html;306.6733928366288;315.1239554039769;320.42003972809215;321.16176778607814;323.09694404140424;5063.076031108174;5180.974095129523;5212.322398088243;5260.4213536511;5289.947100528993;5131.281620573122;5142.640015198937;5149.356330458692;5158.484151584839;5162.92255616166;4035.9394609080887;4044.373122166054;4046.4941882264716;4048.3320252158433;4051.366611702402;4046.433499310099;4088.8568900088503;4094.7747873866924;4096.938545921814;4105.3431450967855;3828.636279553438;4018.397240413932;4056.7565946043183;4066.4916885389325;4067.694922880781;4003.8798836034966;4045.59544045596;4049.9267694061095;4052.460065175244;4054.1283624020975;3564.59198616545;3570.892873213808;3571.964280357189;3579.266250418658;3583.3549961007006;4957.925631115536;4988.775505102243;5047.192449208146;5080.263361812554;5110.696772323071;4542.750148741818;4544.363789069533;4548.5906268435665;4585.747783871886;4596.35651008859;5333.759980800874;5340.225667278223;5370.409254981949;5383.973080134613;5421.674699518042;3818.503594532721;3863.459115723801;3867.737373636426;3885.708571857094;3908.120672848615;5288.92066619001;5349.51854333108;5532.474414930575;5591.6365436246515;5595.328560572717;3865.265599536079;3882.6311500407414;3905.1018265798457;3924.4898163238595;3924.5682974872743;3805.7145714071557;3891.3384724596885;3951.565327813938;3963.8612648557737;3965.2466031453932;4523.276275795857;4540.29738847932;4554.453465584151;4568.406107206042;4610.76946152691;5329.147336426153;5373;5378.78484860609;5414.835810300804;5427.615957930702;1340.4035204333977;1343.4961889291515;1370.3216907630588;1373.5192682561024;1377.029194417933;867.020267098175;874.4097734029505;889.666375109334;891.1355984694835;892.9374943753875;4639.582437580634;4656.208444564432;4660.650451216173;4675.906481870412;4680.578747912704;4906.846890980617;4909.828156014594;4916.164252077156;4925.743935296548;4940.604751619861;4520.932186017212;4663.347131401607;4701.835435759732;4704.435467743892;4707.223308154116;2701.986490067537;2955.926101847471;2957.275467510474;2957.9408411832073;2961.881524738986;5753.964286428483;5761.222234998306;5763.827085187451;5783.71081445926;5824.854378640568;5534.418886016991;5674.517665998354;5690.829275121753;5715.142728590661;5723.313202415737;5739.852029594014;5752.165935939349;5757.107648314434;5771.307443106854;5790.770553336995;5542.695151766691;5559.916601251065;5570.442955704397;5583.944160558505;5584.86037849057;4903.26451032348;5089.898202035864;5454.972725136349;5459.590530710133;5466.289382380265;5696.430356964271;5721.942780572141;5723.422860712055;5731.140328950524;5732.684702341411;3927.548331941749;3947.2500224957166;3970.4838371011583;3975.8409663613133;3979.2240513100824;5306.363236411656;5555.583331250092;5582.190582365615;5614.214010038516;5630.23991761107;5460.699661518495;5476.507114359727;5480.753366098455;5489.615726899079;5501.047128269567;5200.2199670049795;5449.700266485382;5456.972715136399;5518.33779946409;5526.723663816712;5345.247197693114;5356.651817631841;5366.6779993200535;5390;5402.216678581505;5460.781568737206;5463.890722185613;5472;5527.640703354269;5536.7231638418725;5241.004209200392;5344.610401295613;5357.357117145967;5373.247745315737;5378.489043540857 07:47:06 INFO - PROCESS | 11176 | |5;yui.html;741.8108382362497;742.1910117971413;802.4783890471193;825.2778818533783;865.9913400865997;15624.92187539062;16099.114548699818;16827.831721682778;16851.241694123764;16860.915695421536;14926.104433733983;14974.32615532301;15104.622384440394;15122.168280744554;15125.621859453518;664.2726214794792;792.3700657976922;805.6898094233718;819.0826274572487;825.4469505431375;819.9180081991813;829.867221244601;831.3847752663016;831.6631764135535;831.9126491718373;860.6471346747835;862.2886118951858;862.6678728689437;862.8748831419472;863.5941107679412;701.2566679319912;834.2450082675189;850.0988951711175;852.7953291210096;853.1127627267634;622.2657264427974;623.3019018699041;623.7816764132563;623.847157446424;624.3600309682612;14988.400463981428;15036.323365448472;15038.699226015528;15108.773368399483;15201.695966080617;14100;14491.855081449261;14501.564953051426;14518.709625807425;14689.118652880861;13227.933860330733;13341.599752007456;13475.326233688276;13490.123141995738;13519.256440895746;4453.53237910018;4484.955150448519;4503.752293623849;4578.061497393026;4684.718916864999;75759.24240757633;76378;76682.61658691727;77179.61410192969;79375.99999999942;10809.948025259087;10891.945540272249;10938.343699377903;10941.179411544166;11160.274582152135;20892.895535522224;20928;20931.581368372546;20937.37187884366;20943.162273509195;8463.57682115904;8662.30701543875;8743;8757.518336491426;8843.380963332633;4799.736014519165;4808.8797780055775;4812.903741925142;4935.555799978019;4952.950470495321;3435.089701229176;3546.804925729058;3549.538559987185;3552.3605750965075;3555.8755443559353;512.5745631126156;597.5100417657566;621.561798931752;626.7367705563674;645.2160624840748;646.4214527997416;660.531022973694;670.7384120193128;759.2786852490157;759.9772006839804;9965.601375945025;9970.052844979715;10018;10593.576256949636;10630.787384252271;701.421327404893;745.4297462441236;748.3601520699832;769.0809482668269;774.3495463810426;4946.752662366867;5119.692818430906;5133.974330128325;5154.587632989352;5189.532942035235;115124;121416;123816.38091809663;124385;125091.37454312852;73008;106005;106321;106776;107594;67867.66066169637;72350;93633.0636693638;93673.53163234277;93813.5309323449;9603.711888643353;9613.663521776703;9675.854862176931;9713.805723885342;9855.950720246354;54749;55977.44022559885;56497.15254271107;56847.147292789814;57883;81223.59388203258;82729;83118.58440707758;84582;85826.57086714526;13212.273324967218;13281.933590331986;13367.732645347232;13388.799168012682;13922.51271205503;14220.786688199478;14224.906500047218;14572.979433295324;14641.341139648954;14762;13498.190108593515;13754.518591849237;13799.103058301178;14036.29818509091;14370.425182992982;13366.93316533411;13703;13770.173789572658;13895.791563126359;14347.354369053626;13221.801672975105;13731.794023089862;13739.175649461064;13760.380782864595;14186.432542698176;10041.447720375449;10257.897421025695;10300.381977081399;10854.565817367216;11126.944365278121;10437.478126093816;10825.020490574108;10994.615756259504;11035.779284414106;11269.211155219056 07:47:06 INFO - PROCESS | 11176 | __end_tp_report 07:47:06 INFO - PROCESS | 11176 | __start_cc_report 07:47:06 INFO - PROCESS | 11176 | _x_x_mozilla_cycle_collect,922 07:47:06 INFO - PROCESS | 11176 | __end_cc_report 07:47:06 INFO - PROCESS | 11176 | __startTimestamp1468075626840__endTimestamp 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | ------- Summary: start ------- 07:47:06 INFO - PROCESS | 11176 | Number of tests: 6 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | [#0] dojo.html Cycles:165 Average:5149.66 Median:5340.28 stddev:573.01 (10.7%) stddev-sans-first:549.24 07:47:06 INFO - PROCESS | 11176 | Values: 2993.9 3005.3 3017.8 3035.5 3036.7 4940.1 5003.9 5140.1 5226.5 5306.7 5145.6 5172.7 5202.7 5248.2 5288.0 4658.9 4677.8 4702.6 4708.2 4762.2 4769.9 4772.2 4844.5 4851.3 4892.6 4632.5 4670.5 4687.0 4762.3 4775.2 4719.7 4725.2 4726.6 4730.0 4731.9 4646.5 4675.3 4679.2 4699.8 4746.6 5124.6 5152.5 5182.2 5187.3 5191.7 5460.9 5504.5 5513.7 5524.1 5533.8 5340.3 5474.9 5504.0 5514.7 5578.0 5171.8 5205.1 5216.0 5221.7 5223.4 5464.3 5626.8 5671.9 5678.5 5708.1 5342.1 5460.3 5470.3 5479.0 5509.3 5548.5 5585.4 5628.1 5633.4 5633.8 5349.3 5487.3 5529.6 5548.6 5572.8 5523.9 5531.2 5534.3 5536.9 5595.7 4268.3 4269.7 4271.6 4288.0 4309.5 3760.4 3771.9 3817.8 3846.7 3874.9 5159.8 5174.9 5179.7 5185.4 5228.2 5463.9 5467.3 5477.9 5478.3 5523.6 5040.5 5168.9 5231.8 5308.3 5322.8 4816.1 4853.2 4857.8 4861.4 4900.6 5696.5 5698.4 5699.8 5704.1 5714.4 5378.3 5511.1 5548.2 5558.1 5559.6 5779.8 5780.5 5782.8 5787.2 5787.6 5267.6 5414.5 5473.0 5490.3 5499.9 5527.4 5555.9 5598.3 5612.4 5619.1 5443.3 5457.2 5493.0 5495.1 5498.6 5241.5 5399.2 5425.2 5426.5 5474.4 5323.8 5327.4 5343.5 5344.9 5396.4 5422.8 5438.2 5446.5 5479.8 5566.8 5137.6 5310.0 5337.1 5375.1 5380.3 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | [#1] ext.html Cycles:180 Average:60616.65 Median:24006.62 stddev:121661.15 (506.8%) stddev-sans-first:121918.98 07:47:06 INFO - PROCESS | 11176 | Values: 594.8 609.2 615.6 617.5 634.9 30652.2 43923.0 45047.3 45047.8 45082.0 46267.5 46564.0 46594.3 46669.1 46673.0 9026.5 9165.0 9179.7 9181.8 9191.4 9009.1 9095.0 9097.1 9100.0 9115.7 9011.5 9016.7 9065.4 9143.6 9149.1 9025.3 9107.1 9114.4 9123.3 9133.2 8980.2 9041.7 9044.5 9056.3 9056.7 43276.4 43575.8 43612.8 43629.0 43646.3 3602.2 3649.4 3666.8 3694.8 4253.1 32821.8 32918.3 33072.8 33081.3 33172.8 4264.6 4319.5 4366.9 4471.7 4474.8 246915.0 247231.0 248033.0 248137.0 248982.0 60095.4 60192.0 60362.0 60413.8 60692.4 63081.4 63347.7 63430.7 63469.4 63475.4 17283.8 17537.2 17546.9 17571.2 17586.6 13530.5 13661.9 13671.5 13673.2 13679.3 17171.9 18231.6 18327.5 18335.7 18486.3 6099.4 6237.4 6277.6 6369.4 6411.7 1029.7 1030.5 1077.3 1093.3 1172.2 32692.2 32969.7 32994.0 33457.0 33953.5 949.3 1130.4 1137.9 1199.8 1265.4 16861.0 17155.1 17209.4 17214.4 17352.0 516654.0 530778.0 535781.0 537354.0 787105.0 60018.4 60178.0 60634.0 60684.7 60935.1 1259.7 1340.9 1341.8 1368.7 1412.6 29946.4 34119.7 34521.3 34612.7 35073.6 54120.0 54342.5 54945.2 55065.0 55084.7 453466.0 464368.0 465070.0 466424.0 467440.0 38153.6 44090.8 44422.1 44957.6 44960.0 46829.8 47554.5 48406.5 50933.7 52126.7 41432.8 42441.6 42491.4 42755.4 43729.0 42600.8 42740.8 42973.1 43089.6 43919.6 41780.2 42642.6 42806.1 43039.0 43267.8 36377.5 38624.4 38906.6 39292.4 39615.0 28489.0 28534.0 28813.9 28914.9 28952.6 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | [#2] jquery.html Cycles:180 Average:28882.14 Median:2619.68 stddev:80533.16 (3074.2%) stddev-sans-first:80730.64 07:47:06 INFO - PROCESS | 11176 | Values: 379.0 393.3 395.0 395.4 407.5 17655.7 19961.4 20654.3 21045.4 21048.1 11871.8 12374.5 12410.4 12457.4 12494.4 5202.1 5373.8 5401.6 5403.1 5404.1 3849.0 5590.3 5892.1 5892.2 5985.6 5707.3 5948.3 5952.5 5978.0 5978.8 5926.3 5926.6 5932.7 5952.9 5953.0 3751.1 5385.5 5661.0 5684.4 5768.5 13690.7 13727.3 16404.8 23455.7 23951.6 2553.8 2617.8 2621.6 2918.6 2944.4 10266.1 10603.1 10610.5 10706.5 12537.6 1948.9 1968.7 1996.4 2033.3 2198.1 70846.3 74844.0 77875.2 82980.6 83757.2 10861.8 10863.8 11122.4 11220.3 11223.2 14429.2 14528.0 14582.3 14602.9 14652.7 8008.8 8217.2 8307.0 8310.4 8367.2 8055.0 8092.3 8175.6 8277.6 8309.7 4637.4 4641.7 4705.2 4723.1 4738.1 1767.7 1798.2 1873.9 1917.9 1999.9 1039.8 1067.7 1071.8 1082.5 1108.3 19142.8 19271.9 19767.0 19891.8 20388.8 977.4 978.8 1000.2 1020.5 1061.5 10598.8 11058.5 11156.0 11184.8 11206.5 479808.0 485306.0 488619.7 492094.0 494818.0 88768.0 90035.0 92030.0 92737.5 96656.0 972.2 977.9 999.9 1016.2 1025.5 17757.6 18008.8 18252.7 18453.4 18570.4 45289.0 45311.5 45447.3 45728.8 46412.8 59131.0 61542.6 61635.0 62072.0 63025.7 8503.9 8547.4 8623.8 8717.7 8789.6 9806.9 12756.4 13513.3 14002.5 14042.1 11919.0 12077.0 12230.5 12310.9 12406.8 11485.3 11790.6 12395.5 12608.4 12822.6 12426.5 12440.6 12552.4 12652.7 12751.9 8728.3 8921.8 8953.5 9005.8 9039.8 11073.7 11621.3 11715.8 12196.1 12262.9 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | [#3] mootools.html Cycles:180 Average:5656.46 Median:2720.85 stddev:3238.52 (119.0%) stddev-sans-first:3231.32 07:47:06 INFO - PROCESS | 11176 | Values: 1335.4 1467.3 1504.4 1615.2 1784.4 8095.8 8486.7 8490.4 8712.3 8719.1 8484.5 8682.0 8686.6 8692.8 8694.7 2298.0 2334.5 2339.5 2345.5 2350.4 2233.3 2264.1 2285.7 2297.1 2297.1 2257.0 2271.0 2280.9 2289.6 2293.9 2214.3 2222.9 2225.7 2229.4 2229.5 2194.6 2196.2 2197.3 2200.0 2202.3 8345.8 8398.2 8433.1 8519.0 8580.7 4946.3 5021.3 5062.8 5077.5 5089.5 3139.0 3318.0 3361.4 3377.7 3377.8 1124.9 1129.3 1152.5 1155.5 1163.4 11822.0 11954.0 11999.8 12008.2 12014.9 4133.5 4191.9 4361.3 4375.4 4382.2 9299.0 9326.0 9369.3 9378.4 9390.6 4997.9 5004.7 5035.8 5048.7 5051.8 4177.6 4472.9 4659.0 4660.9 4718.9 3657.3 3667.3 3748.6 3770.7 3789.1 1046.2 1049.3 1065.2 1067.3 1068.1 742.7 952.9 961.3 967.2 982.9 5756.9 5785.0 5853.4 5970.3 6067.8 489.9 492.9 495.4 498.3 643.8 3906.2 4093.8 4150.7 4160.9 4210.7 10083.4 10617.5 10639.7 10667.4 10809.1 10627.4 10648.7 10658.8 10683.0 10696.3 7512.8 7865.8 7898.1 7898.8 7925.6 6011.4 6113.8 6180.9 6193.2 6344.9 9975.3 10059.6 10091.6 10100.9 10107.7 9793.8 10027.5 10223.1 10325.8 10340.6 7021.2 7580.6 7591.4 7707.6 7763.5 8652.6 8655.0 8656.9 8699.7 8705.7 7540.8 7757.3 7759.7 7828.1 7873.3 7291.7 7415.9 7559.1 7678.7 7695.4 6937.3 6961.5 6994.5 7008.3 7017.2 5053.5 5111.2 5221.1 5248.8 5287.5 5104.5 5177.5 5207.8 5245.5 5308.2 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | [#4] prototype.html Cycles:180 Average:4507.53 Median:5085.08 stddev:1329.70 (26.1%) stddev-sans-first:1295.50 07:47:06 INFO - PROCESS | 11176 | Values: 306.7 315.1 320.4 321.2 323.1 5063.1 5181.0 5212.3 5260.4 5289.9 5131.3 5142.6 5149.4 5158.5 5162.9 4035.9 4044.4 4046.5 4048.3 4051.4 4046.4 4088.9 4094.8 4096.9 4105.3 3828.6 4018.4 4056.8 4066.5 4067.7 4003.9 4045.6 4049.9 4052.5 4054.1 3564.6 3570.9 3572.0 3579.3 3583.4 4957.9 4988.8 5047.2 5080.3 5110.7 4542.8 4544.4 4548.6 4585.7 4596.4 5333.8 5340.2 5370.4 5384.0 5421.7 3818.5 3863.5 3867.7 3885.7 3908.1 5288.9 5349.5 5532.5 5591.6 5595.3 3865.3 3882.6 3905.1 3924.5 3924.6 3805.7 3891.3 3951.6 3963.9 3965.2 4523.3 4540.3 4554.5 4568.4 4610.8 5329.1 5373.0 5378.8 5414.8 5427.6 1340.4 1343.5 1370.3 1373.5 1377.0 867.0 874.4 889.7 891.1 892.9 4639.6 4656.2 4660.7 4675.9 4680.6 4906.8 4909.8 4916.2 4925.7 4940.6 4520.9 4663.3 4701.8 4704.4 4707.2 2702.0 2955.9 2957.3 2957.9 2961.9 5754.0 5761.2 5763.8 5783.7 5824.9 5534.4 5674.5 5690.8 5715.1 5723.3 5739.9 5752.2 5757.1 5771.3 5790.8 5542.7 5559.9 5570.4 5583.9 5584.9 4903.3 5089.9 5455.0 5459.6 5466.3 5696.4 5721.9 5723.4 5731.1 5732.7 3927.5 3947.3 3970.5 3975.8 3979.2 5306.4 5555.6 5582.2 5614.2 5630.2 5460.7 5476.5 5480.8 5489.6 5501.0 5200.2 5449.7 5457.0 5518.3 5526.7 5345.2 5356.7 5366.7 5390.0 5402.2 5460.8 5463.9 5472.0 5527.6 5536.7 5241.0 5344.6 5357.4 5373.2 5378.5 07:47:06 INFO - PROCESS | 11176 | 07:47:06 INFO - PROCESS | 11176 | [#5] yui.html Cycles:180 Average:21490.69 Median:4631.39 stddev:31264.32 (675.1%) stddev-sans-first:31313.20 07:47:06 INFO - PROCESS | 11176 | Values: 741.8 742.2 802.5 825.3 866.0 15624.9 16099.1 16827.8 16851.2 16860.9 14926.1 14974.3 15104.6 15122.2 15125.6 664.3 792.4 805.7 819.1 825.4 819.9 829.9 831.4 831.7 831.9 860.6 862.3 862.7 862.9 863.6 701.3 834.2 850.1 852.8 853.1 622.3 623.3 623.8 623.8 624.4 14988.4 15036.3 15038.7 15108.8 15201.7 14100.0 14491.9 14501.6 14518.7 14689.1 13227.9 13341.6 13475.3 13490.1 13519.3 4453.5 4485.0 4503.8 4578.1 4684.7 75759.2 76378.0 76682.6 77179.6 79376.0 10809.9 10891.9 10938.3 10941.2 11160.3 20892.9 20928.0 20931.6 20937.4 20943.2 8463.6 8662.3 8743.0 8757.5 8843.4 4799.7 4808.9 4812.9 4935.6 4953.0 3435.1 3546.8 3549.5 3552.4 3555.9 512.6 597.5 621.6 626.7 645.2 646.4 660.5 670.7 759.3 760.0 9965.6 9970.1 10018.0 10593.6 10630.8 701.4 745.4 748.4 769.1 774.3 4946.8 5119.7 5134.0 5154.6 5189.5 115124.0 121416.0 123816.4 124385.0 125091.4 73008.0 106005.0 106321.0 106776.0 107594.0 67867.7 72350.0 93633.1 93673.5 93813.5 9603.7 9613.7 9675.9 9713.8 9856.0 54749.0 55977.4 56497.2 56847.1 57883.0 81223.6 82729.0 83118.6 84582.0 85826.6 13212.3 13281.9 13367.7 13388.8 13922.5 14220.8 14224.9 14573.0 14641.3 14762.0 13498.2 13754.5 13799.1 14036.3 14370.4 13366.9 13703.0 13770.2 13895.8 14347.4 13221.8 13731.8 13739.2 13760.4 14186.4 10041.4 10257.9 10300.4 10854.6 11126.9 10437.5 10825.0 10994.6 11035.8 11269.2 07:47:06 INFO - PROCESS | 11176 | -------- Summary: end -------- 07:47:06 INFO - PROCESS | 11176 | 07:47:07 INFO - TEST-INFO | 11176: exit 0 07:47:07 INFO - TEST-OK | dromaeo_css | took 1112066ms 07:47:07 INFO - TEST-START | kraken 07:47:07 INFO - operating with platform_type : linux_ 07:47:07 INFO - Initialising browser for kraken test... 07:47:07 INFO - TEST-INFO | started process 11409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphBBbXe/profile http://localhost:48439/getInfo.html) 07:47:11 INFO - PROCESS | 11409 | __metrics Screen width/height:1600/1200 07:47:11 INFO - PROCESS | 11409 | colorDepth:24 07:47:11 INFO - PROCESS | 11409 | Browser inner width/height: 1024/697 07:47:11 INFO - PROCESS | 11409 | __metrics 07:47:11 INFO - PROCESS | 11409 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:12 INFO - TEST-INFO | 11409: exit 0 07:47:12 INFO - Browser initialized. 07:47:12 INFO - Running cycle 1/1 for kraken test... 07:47:12 INFO - TEST-INFO | started process 11490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphBBbXe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:24 INFO - PROCESS | 11490 | RSS: Main: 157237248 07:47:24 INFO - PROCESS | 11490 | 07:47:27 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48439/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:27 INFO - PROCESS | 11490 | RSS: Main: 215654400 07:47:27 INFO - PROCESS | 11490 | 07:47:30 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48439/tests/kraken/driver.html?testName=audio-dft) 07:47:31 INFO - PROCESS | 11490 | RSS: Main: 203980800 07:47:31 INFO - PROCESS | 11490 | 07:47:34 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48439/tests/kraken/driver.html?testName=audio-fft) 07:47:34 INFO - PROCESS | 11490 | RSS: Main: 269176832 07:47:34 INFO - PROCESS | 11490 | 07:47:37 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48439/tests/kraken/driver.html?testName=audio-oscillator) 07:47:37 INFO - PROCESS | 11490 | RSS: Main: 180576256 07:47:37 INFO - PROCESS | 11490 | 07:47:39 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48439/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:40 INFO - PROCESS | 11490 | RSS: Main: 184872960 07:47:40 INFO - PROCESS | 11490 | 07:47:43 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48439/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:44 INFO - PROCESS | 11490 | RSS: Main: 219086848 07:47:44 INFO - PROCESS | 11490 | 07:47:47 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48439/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:47 INFO - PROCESS | 11490 | RSS: Main: 221241344 07:47:47 INFO - PROCESS | 11490 | 07:47:50 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48439/tests/kraken/driver.html?testName=json-parse-financial) 07:47:51 INFO - PROCESS | 11490 | RSS: Main: 221163520 07:47:51 INFO - PROCESS | 11490 | 07:47:52 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48439/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:53 INFO - PROCESS | 11490 | RSS: Main: 207540224 07:47:53 INFO - PROCESS | 11490 | 07:47:55 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:55 INFO - PROCESS | 11490 | RSS: Main: 213831680 07:47:55 INFO - PROCESS | 11490 | 07:47:57 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:58 INFO - PROCESS | 11490 | RSS: Main: 211988480 07:47:58 INFO - PROCESS | 11490 | 07:48:01 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:01 INFO - PROCESS | 11490 | RSS: Main: 230752256 07:48:01 INFO - PROCESS | 11490 | 07:48:04 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:05 INFO - PROCESS | 11490 | RSS: Main: 225857536 07:48:05 INFO - PROCESS | 11490 | 07:48:06 INFO - PROCESS | 11490 | Cycle 1(1): loaded http://localhost:48439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48439/tests/kraken/driver.html?testName=ai-astar) 07:48:07 INFO - PROCESS | 11490 | RSS: Main: 267984896 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | __start_tp_report 07:48:07 INFO - PROCESS | 11490 | _x_x_mozilla_page_load 07:48:07 INFO - PROCESS | 11490 | _x_x_mozilla_page_load_details 07:48:07 INFO - PROCESS | 11490 | |i|pagename|runs| 07:48:07 INFO - PROCESS | 11490 | |0;ai-astar;106;113;112;111;112;113;110;110;110;110 07:48:07 INFO - PROCESS | 11490 | |1;audio-beat-detection;144;118;118;177;117;119;146;118;149;117 07:48:07 INFO - PROCESS | 11490 | |2;audio-dft;162;162;161;161;162;162;162;160;161;160 07:48:07 INFO - PROCESS | 11490 | |3;audio-fft;75;77;76;127;78;75;74;76;106;76 07:48:07 INFO - PROCESS | 11490 | |4;audio-oscillator;85;85;113;84;84;84;120;85;85;121 07:48:07 INFO - PROCESS | 11490 | |5;imaging-gaussian-blur;117;117;117;117;116;118;117;118;117;118 07:48:07 INFO - PROCESS | 11490 | |6;imaging-darkroom;146;148;146;146;146;146;146;147;146;148 07:48:07 INFO - PROCESS | 11490 | |7;imaging-desaturate;96;95;96;96;95;95;95;96;95;95 07:48:07 INFO - PROCESS | 11490 | |8;json-parse-financial;54;53;53;52;53;54;53;53;52;53 07:48:07 INFO - PROCESS | 11490 | |9;json-stringify-tinderbox;62;61;63;63;64;63;62;63;63;62 07:48:07 INFO - PROCESS | 11490 | |10;stanford-crypto-aes;76;76;75;80;75;75;74;85;74;82 07:48:07 INFO - PROCESS | 11490 | |11;stanford-crypto-ccm;121;121;118;119;126;120;126;120;165;118 07:48:07 INFO - PROCESS | 11490 | |12;stanford-crypto-pbkdf2;157;160;164;165;161;164;159;162;158;157 07:48:07 INFO - PROCESS | 11490 | |13;stanford-crypto-sha256-iterative;65;63;66;63;63;63;65;63;62;63 07:48:07 INFO - PROCESS | 11490 | __end_tp_report 07:48:07 INFO - PROCESS | 11490 | __start_cc_report 07:48:07 INFO - PROCESS | 11490 | _x_x_mozilla_cycle_collect,1658 07:48:07 INFO - PROCESS | 11490 | __end_cc_report 07:48:07 INFO - PROCESS | 11490 | __startTimestamp1468075687004__endTimestamp 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | ------- Summary: start ------- 07:48:07 INFO - PROCESS | 11490 | Number of tests: 14 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.06 (1.8%) stddev-sans-first:1.30 07:48:07 INFO - PROCESS | 11490 | Values: 106.0 113.0 112.0 111.0 112.0 113.0 110.0 110.0 110.0 110.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:131.50 stddev:20.71 (15.7%) stddev-sans-first:21.53 07:48:07 INFO - PROCESS | 11490 | Values: 144.0 118.0 118.0 177.0 117.0 119.0 146.0 118.0 149.0 117.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 07:48:07 INFO - PROCESS | 11490 | Values: 162.0 162.0 161.0 161.0 162.0 162.0 162.0 160.0 161.0 160.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.00 stddev:17.86 (23.5%) stddev-sans-first:18.65 07:48:07 INFO - PROCESS | 11490 | Values: 75.0 77.0 76.0 127.0 78.0 75.0 74.0 76.0 106.0 76.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.50 stddev:16.28 (19.3%) stddev-sans-first:16.90 07:48:07 INFO - PROCESS | 11490 | Values: 85.0 85.0 113.0 84.0 84.0 84.0 120.0 85.0 85.0 121.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:48:07 INFO - PROCESS | 11490 | Values: 117.0 117.0 117.0 117.0 116.0 118.0 117.0 118.0 117.0 118.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 07:48:07 INFO - PROCESS | 11490 | Values: 146.0 148.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 148.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:48:07 INFO - PROCESS | 11490 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 07:48:07 INFO - PROCESS | 11490 | Values: 54.0 53.0 53.0 52.0 53.0 54.0 53.0 53.0 52.0 53.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 07:48:07 INFO - PROCESS | 11490 | Values: 62.0 61.0 63.0 63.0 64.0 63.0 62.0 63.0 63.0 62.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.00 stddev:3.79 (5.0%) stddev-sans-first:4.00 07:48:07 INFO - PROCESS | 11490 | Values: 76.0 76.0 75.0 80.0 75.0 75.0 74.0 85.0 74.0 82.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:121.00 stddev:14.21 (11.7%) stddev-sans-first:14.98 07:48:07 INFO - PROCESS | 11490 | Values: 121.0 121.0 118.0 119.0 126.0 120.0 126.0 120.0 165.0 118.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.50 stddev:2.98 (1.8%) stddev-sans-first:2.85 07:48:07 INFO - PROCESS | 11490 | Values: 157.0 160.0 164.0 165.0 161.0 164.0 159.0 162.0 158.0 157.0 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - PROCESS | 11490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 07:48:07 INFO - PROCESS | 11490 | Values: 65.0 63.0 66.0 63.0 63.0 63.0 65.0 63.0 62.0 63.0 07:48:07 INFO - PROCESS | 11490 | -------- Summary: end -------- 07:48:07 INFO - PROCESS | 11490 | 07:48:07 INFO - TEST-INFO | 11490: exit 0 07:48:07 INFO - TEST-OK | kraken | took 60444ms 07:48:07 INFO - SUITE-END | took 1172s 07:48:08 INFO - Completed test suite (00:19:32) 07:48:08 INFO - javascript benchmark 07:48:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2993.850307484626, 3005.3388254583983, 3017.834019128947, 3035.514317709167, 3036.6659667436584, 4940.1354762916435, 5003.949960500394, 5140.100482415576, 5226.451222621622, 5306.681599104047, 5145.562627176694, 5172.6637768545015, 5202.687838729679, 5248.239005344223, 5288.0, 4658.86023419298, 4677.83627573035, 4702.600278976274, 4708.176069187878, 4762.238041913277, 4769.856904292877, 4772.2125849234835, 4844.5155484451625, 4851.27230915362, 4892.608591312686, 4632.513586073447, 4670.509596492353, 4686.953130468686, 4762.309465127554, 4775.212090005145, 4719.693219940727, 4725.196716558194, 4726.645501587394, 4729.9763501182615, 4731.881702957419, 4646.465656449518, 4675.345451636774, 4679.181143299943, 4699.765011749433, 4746.572808447257, 5124.564412024983, 5152.5105115014385, 5182.170852663593, 5187.273781670569, 5191.740412979374, 5460.890782184334, 5504.504594586467, 5513.696746678931, 5524.116141417354, 5533.778648854041, 5340.279062326614, 5474.945250547484, 5503.972480137613, 5514.6691198528215, 5578.023845827005, 5171.793128274902, 5205.141151709963, 5216.0, 5221.686698798122, 5223.373195216598, 5464.316960379952, 5626.831195064155, 5671.914921276184, 5678.4605462480995, 5708.115242137475, 5342.1185504392115, 5460.290162278879, 5470.288862447936, 5478.972605136949, 5509.311336082989, 5548.500634942875, 5585.385607583163, 5628.099504079328, 5633.4084921082695, 5633.774649014075, 5349.251104845324, 5487.341519017744, 5529.612927095145, 5548.5838562108, 5572.804951826666, 5523.861903452445, 5531.170324451365, 5534.308211473566, 5536.889262214814, 5595.664260144405, 4268.253055715238, 4269.658427325807, 4271.551487093872, 4288.0, 4309.547497512779, 3760.3795373763023, 3771.905702357463, 3817.828197731109, 3846.6922646188796, 3874.8643797466952, 5159.819406320761, 5174.870628234249, 5179.663321884065, 5185.429602743695, 5228.163493840967, 5463.890722185534, 5467.343918729778, 5477.917831232535, 5478.287822583118, 5523.558115350843, 5040.521150490697, 5168.948310516922, 5231.843044708665, 5308.283381743492, 5322.840314790563, 4816.133096042676, 4853.247746599282, 4857.8299759508245, 4861.440934292602, 4900.607951363882, 5696.458836410535, 5698.373178950312, 5699.800506982236, 5704.11586204139, 5714.371419143891, 5378.327709036371, 5511.145772405283, 5548.195511650707, 5558.055130627722, 5559.610827242216, 5779.757352169136, 5780.537556995346, 5782.826515204551, 5787.2187254720075, 5787.56593255516, 5267.552258058108, 5414.458554144554, 5473.0, 5490.313710786152, 5499.862503437446, 5527.391986881359, 5555.861103472445, 5598.300212473441, 5612.410696876933, 5619.100943848965, 5443.346798384219, 5457.235986961749, 5493.038718224215, 5495.120780675073, 5498.615096943176, 5241.50205730455, 5399.244105825266, 5425.186222066722, 5426.4573542646995, 5474.3704473986, 5323.840284791462, 5327.387350454747, 5343.492368225013, 5344.893102137858, 5396.4333744957785, 5422.810201642924, 5438.211459338453, 5446.455354464521, 5479.780808767605, 5566.832995010156, 5137.588992880485, 5309.973450132725, 5337.066013447708, 5375.059364611099, 5380.273663055437], "value": 5111.826309472031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8126340202839, 609.2323672173061, 615.5937081526193, 617.4720613875137, 634.9015902535109, 30652.233694157658, 43923.0, 45047.324290135635, 45047.77476112623, 45082.0, 46267.53732462674, 46564.0, 46594.30108548366, 46669.06661866761, 46673.0, 9026.50354230517, 9164.954175229148, 9179.72460826173, 9181.816363672722, 9191.35660503765, 9009.099090091004, 9094.954525227364, 9097.135772101672, 9100.044495327995, 9115.726528204164, 9011.459312441242, 9016.729498115033, 9065.365424420293, 9143.588538515749, 9149.130832570896, 9025.323100767437, 9107.089291070906, 9114.407563508417, 9123.31575131861, 9133.17801397874, 8980.236679882219, 9041.728748137566, 9044.457332560067, 9056.320775941766, 9056.683016094405, 43276.350854737204, 43575.78212108919, 43612.78193609043, 43629.0, 43646.345304820454, 3602.189507360849, 3649.434337677664, 3666.7616604920595, 3694.780722361614, 4253.128108737732, 32821.83589082063, 32918.341633167445, 33072.834635826905, 33081.33837323264, 33172.834135829406, 4264.637505812009, 4319.460067491564, 4366.8908277293, 4471.686981911267, 4474.7986340614425, 246915.0, 247231.0, 248033.0, 248137.0, 248982.0, 60095.39904600986, 60192.0, 60362.0, 60413.77103602706, 60692.39307606867, 63081.36918630755, 63347.6832615834, 63430.68284658547, 63469.36530634634, 63475.36524634787, 17283.827161728474, 17537.210825512884, 17546.912265438845, 17571.209295581728, 17586.560335991446, 13530.526431574848, 13661.931690341484, 13671.453141874412, 13673.179609223478, 13679.316034198251, 17171.914140429217, 18231.63536729258, 18327.450176494727, 18335.724964125548, 18486.260549578135, 6099.3900609938655, 6237.438630523275, 6277.5605707600025, 6369.394907483782, 6411.679416029273, 1029.711680729397, 1030.5105075089273, 1077.3212875888296, 1093.327603523827, 1172.20290202663, 32692.18269543233, 32969.67030329666, 32994.0, 33457.0, 33953.49069763956, 949.3164921256684, 1130.3500487219717, 1137.9317240965568, 1199.8320235167084, 1265.373640048182, 16861.0, 17155.142242888054, 17209.397671081704, 17214.392803598203, 17352.0, 516654.0, 530778.0, 535781.0, 537354.0, 787105.0, 60018.39981600128, 60178.0, 60634.0, 60684.696576517716, 60935.08597371043, 1259.6787819106069, 1340.9061365704501, 1341.7920222365549, 1368.6715188354922, 1412.5974097382198, 29946.3961899447, 34119.65880341264, 34521.30957380889, 34612.65387346094, 35073.64926350704, 54120.0, 54342.456575435324, 54945.1758223635, 55065.0, 55084.72457637686, 453466.0, 464368.0, 465070.0, 466424.0, 467440.0, 38153.61846381501, 44090.779546103346, 44422.11155776802, 44957.55042449533, 44960.0, 46829.76585117189, 47554.52445475501, 48406.5159348402, 50933.74533127311, 52126.73936630293, 41432.79283603683, 42441.575584244994, 42491.3626295612, 42755.35866961936, 43729.0, 42600.786996064824, 42740.78629606832, 42973.140537188454, 43089.56910430855, 43919.56080439155, 41780.16439671129, 42642.57357426386, 42806.14387712291, 43039.0, 43267.78366108149, 36377.45433818442, 38624.42063368995, 38906.61093389143, 39292.41061384024, 39615.0, 28489.0, 28534.0, 28813.930566202944, 28914.855425722737, 28952.565711514766], "value": 20703.779895225543, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.9639984201502, 393.33722677288773, 394.98025098745063, 395.4483495523746, 407.4804624104267, 17655.735163972535, 19961.401157965247, 20654.277100301493, 21045.368638940818, 21048.052837622305, 11871.7625647487, 12374.505019799197, 12410.379481025957, 12457.377131143428, 12494.437750301235, 5202.089634313998, 5373.81191658292, 5401.621886467949, 5403.108487099624, 5404.1083221268445, 3848.9807550962205, 5590.301212348457, 5892.086726557391, 5892.204552385416, 5985.610935289193, 5707.258056452676, 5948.256467941507, 5952.464278214959, 5978.0, 5978.760849566012, 5926.259217597801, 5926.585139040269, 5932.7330270137945, 5952.880942381128, 5952.999999999978, 3751.0809851586264, 5385.488378604026, 5661.037623603997, 5684.403137670568, 5768.538516918637, 13690.65773355674, 13727.313634318245, 16404.75392869108, 23455.709935953517, 23951.640725389134, 2553.8084643651614, 2617.751313625203, 2621.606758986148, 2918.591397204393, 2944.4258369617933, 10266.076053155251, 10603.098736607397, 10610.46947652622, 10706.46467676613, 12537.623871283877, 1948.9025548722507, 1968.724378586999, 1996.3711430899366, 2033.2781862438917, 2198.087793565668, 70846.3322934164, 74844.0, 77875.22124778794, 82980.58509707413, 83757.16242837555, 10861.782764344669, 10863.782724345627, 11122.38826864514, 11220.32678039304, 11223.214374993671, 14429.206393648241, 14528.0, 14582.343794529272, 14602.926985365006, 14652.706945861022, 8008.7597372078935, 8217.151140993228, 8306.958465207636, 8310.376721745894, 8367.205115514016, 8054.959725201454, 8092.2716955473115, 8175.63209655567, 8277.62750676209, 8309.709160179365, 4637.397138372057, 4641.675082744243, 4705.176594096088, 4723.126221649006, 4738.147133516, 1767.717165253579, 1798.2177752677628, 1873.9437816865516, 1917.88492690439, 1999.9000049997442, 1039.8336266197523, 1067.7384040910026, 1071.8177909755361, 1082.4858192358724, 1108.3073079325422, 19142.808571914382, 19271.90364048199, 19767.0, 19891.801081988993, 20388.79611203869, 977.4184360305607, 978.8189185000798, 1000.2048371544639, 1020.4744556553381, 1061.4957894999968, 10598.841017384746, 11058.502367393487, 11156.0, 11184.776304473866, 11206.495707693173, 479808.0, 485306.0, 488619.682819032, 492094.0, 494818.0, 88768.0, 90035.0, 92030.0, 92737.53631231935, 96656.0, 972.1882228339274, 977.9266555008403, 999.9000099989943, 1016.192127258831, 1025.5128813813378, 17757.64484710273, 18008.819911800714, 18252.72620910714, 18453.354132605295, 18570.350037748613, 45289.0, 45311.54688453073, 45447.318290226336, 45728.77135614434, 46412.767936160104, 59131.0, 61542.61488621394, 61635.0, 62072.0, 63025.68487157535, 8503.914960850312, 8547.358948079043, 8623.784405389915, 8717.65129394817, 8789.648414063366, 9806.85289720669, 12756.362181891054, 13513.324333783468, 14002.509912153026, 14042.087264327785, 11919.0, 12077.0, 12230.510779568718, 12310.938445307716, 12406.81389779172, 11485.253458525169, 11790.587329443428, 12395.504179833066, 12608.36958152107, 12822.615321540368, 12426.502939882303, 12440.564580239648, 12552.43514041852, 12652.746945061232, 12751.872481275439, 8728.301735860989, 8921.818091104178, 8953.462792232487, 9005.819883602422, 9039.819203616022, 11073.667789966314, 11621.302721836717, 11715.765684686428, 12196.085293602839, 12262.938685306517], "value": 9206.371045393116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.3790487423346, 1467.3250304859766, 1504.3606467251418, 1615.2085478115728, 1784.3754685859958, 8095.757127286183, 8486.660533578657, 8490.405671602983, 8712.346574006942, 8719.084496127894, 8484.490930544156, 8681.95659021704, 8686.609102590382, 8692.826143477127, 8694.73915782526, 2297.9655305170436, 2334.48641298914, 2339.5087031723274, 2345.4839935214227, 2350.3771500552366, 2233.2741858895843, 2264.1283106004144, 2285.702858628384, 2297.1270917051497, 2297.127091705158, 2257.0407576779885, 2270.96593551096, 2280.8859557022165, 2289.5878741826464, 2293.8967746451367, 2214.30249471416, 2222.944426389345, 2225.710657614516, 2229.375774783063, 2229.5095079082575, 2194.6049711052005, 2196.242296407737, 2197.318831162329, 2199.9890000550054, 2202.3282898715884, 8345.833083338299, 8398.202170793766, 8433.072362040171, 8519.0, 8580.699675511327, 4946.307516947631, 5021.347224860745, 5062.82280120194, 5077.517635824591, 5089.491050894918, 3139.0, 3317.9834100829585, 3361.4117529432497, 3377.67912048355, 3377.7635565510423, 1124.8706398764166, 1129.2829053550972, 1152.5044230980675, 1155.474259212065, 1163.4415480569373, 11822.0, 11954.0, 11999.820002699966, 12008.159428839985, 12014.879851201551, 4133.503979522417, 4191.8532851350055, 4361.280388735887, 4375.387445757597, 4382.189294980439, 9298.977112517618, 9326.0, 9369.344145909858, 9378.390404623815, 9390.577424015935, 4997.90004199914, 5004.724740139327, 5035.7985680572365, 5048.671836330626, 5051.823186188466, 4177.582241775798, 4472.932906006413, 4659.0, 4660.906781864343, 4718.9292160617615, 3657.341678497896, 3667.3215455140353, 3748.568914574859, 3770.6606405423645, 3789.052736815796, 1046.215338496128, 1049.3179433368218, 1065.2010991756183, 1067.3062509368817, 1068.1294744782977, 742.6806473216461, 952.852307892264, 961.3078583419926, 967.1634036558467, 982.9066238707454, 5756.937074296075, 5784.971075144597, 5853.443922827325, 5970.283565972111, 6067.848303792352, 489.8897748006741, 492.881708389991, 495.3931433993329, 498.25013354901364, 643.7778966256634, 3906.160175562268, 4093.815778289984, 4150.730202536886, 4160.916781664349, 4210.663146948298, 10083.445410502492, 10617.522211500502, 10639.680809575726, 10667.359958402521, 10809.135269178447, 10627.415492148006, 10648.680539583826, 10658.840117398246, 10683.0, 10696.304740191863, 7512.812179695551, 7865.764027079311, 7898.091719452222, 7898.802529936797, 7925.643346049442, 6011.38504750435, 6113.755449781959, 6180.938190618216, 6193.225846769154, 6344.873102537831, 9975.301728878909, 10059.597616095274, 10091.596336146766, 10100.949495252476, 10107.7473063174, 9793.80412391734, 10027.54876030595, 10223.079922806983, 10325.845112323172, 10340.638077667245, 7021.1574611047, 7580.583067931317, 7591.3547348475995, 7707.576083315472, 7763.4953728007495, 8652.610632521677, 8655.0479447262, 8656.91343086561, 8699.739007829776, 8705.695300664447, 7540.811479713051, 7757.3018428339465, 7759.72840950564, 7828.060632724109, 7873.25204105609, 7291.708331666886, 7415.8887616684715, 7559.092908850973, 7678.692852285846, 7695.422843286664, 6937.306269373023, 6961.477889158435, 6994.475414344046, 7008.264132266038, 7017.157941047107, 5053.469385714594, 5111.156659151198, 5221.060209162387, 5248.816291429782, 5287.471252874681, 5104.519689290064, 5177.4822517747925, 5207.843764687065, 5245.475452454877, 5308.150695888639], "value": 4449.7447571686325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.6733928366288, 315.1239554039769, 320.42003972809215, 321.16176778607814, 323.09694404140424, 5063.076031108174, 5180.974095129523, 5212.322398088243, 5260.4213536511, 5289.947100528993, 5131.281620573122, 5142.640015198937, 5149.356330458692, 5158.484151584839, 5162.92255616166, 4035.9394609080887, 4044.373122166054, 4046.4941882264716, 4048.3320252158433, 4051.366611702402, 4046.433499310099, 4088.8568900088503, 4094.7747873866924, 4096.938545921814, 4105.3431450967855, 3828.636279553438, 4018.397240413932, 4056.7565946043183, 4066.4916885389325, 4067.694922880781, 4003.8798836034966, 4045.59544045596, 4049.9267694061095, 4052.460065175244, 4054.1283624020975, 3564.59198616545, 3570.892873213808, 3571.964280357189, 3579.266250418658, 3583.3549961007006, 4957.925631115536, 4988.775505102243, 5047.192449208146, 5080.263361812554, 5110.696772323071, 4542.750148741818, 4544.363789069533, 4548.5906268435665, 4585.747783871886, 4596.35651008859, 5333.759980800874, 5340.225667278223, 5370.409254981949, 5383.973080134613, 5421.674699518042, 3818.503594532721, 3863.459115723801, 3867.737373636426, 3885.708571857094, 3908.120672848615, 5288.92066619001, 5349.51854333108, 5532.474414930575, 5591.6365436246515, 5595.328560572717, 3865.265599536079, 3882.6311500407414, 3905.1018265798457, 3924.4898163238595, 3924.5682974872743, 3805.7145714071557, 3891.3384724596885, 3951.565327813938, 3963.8612648557737, 3965.2466031453932, 4523.276275795857, 4540.29738847932, 4554.453465584151, 4568.406107206042, 4610.76946152691, 5329.147336426153, 5373.0, 5378.78484860609, 5414.835810300804, 5427.615957930702, 1340.4035204333977, 1343.4961889291515, 1370.3216907630588, 1373.5192682561024, 1377.029194417933, 867.020267098175, 874.4097734029505, 889.666375109334, 891.1355984694835, 892.9374943753875, 4639.582437580634, 4656.208444564432, 4660.650451216173, 4675.906481870412, 4680.578747912704, 4906.846890980617, 4909.828156014594, 4916.164252077156, 4925.743935296548, 4940.604751619861, 4520.932186017212, 4663.347131401607, 4701.835435759732, 4704.435467743892, 4707.223308154116, 2701.986490067537, 2955.926101847471, 2957.275467510474, 2957.9408411832073, 2961.881524738986, 5753.964286428483, 5761.222234998306, 5763.827085187451, 5783.71081445926, 5824.854378640568, 5534.418886016991, 5674.517665998354, 5690.829275121753, 5715.142728590661, 5723.313202415737, 5739.852029594014, 5752.165935939349, 5757.107648314434, 5771.307443106854, 5790.770553336995, 5542.695151766691, 5559.916601251065, 5570.442955704397, 5583.944160558505, 5584.86037849057, 4903.26451032348, 5089.898202035864, 5454.972725136349, 5459.590530710133, 5466.289382380265, 5696.430356964271, 5721.942780572141, 5723.422860712055, 5731.140328950524, 5732.684702341411, 3927.548331941749, 3947.2500224957166, 3970.4838371011583, 3975.8409663613133, 3979.2240513100824, 5306.363236411656, 5555.583331250092, 5582.190582365615, 5614.214010038516, 5630.23991761107, 5460.699661518495, 5476.507114359727, 5480.753366098455, 5489.615726899079, 5501.047128269567, 5200.2199670049795, 5449.700266485382, 5456.972715136399, 5518.33779946409, 5526.723663816712, 5345.247197693114, 5356.651817631841, 5366.6779993200535, 5390.0, 5402.216678581505, 5460.781568737206, 5463.890722185613, 5472.0, 5527.640703354269, 5536.7231638418725, 5241.004209200392, 5344.610401295613, 5357.357117145967, 5373.247745315737, 5378.489043540857], "value": 4081.1342934533563, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8108382362497, 742.1910117971413, 802.4783890471193, 825.2778818533783, 865.9913400865997, 15624.92187539062, 16099.114548699818, 16827.831721682778, 16851.241694123764, 16860.915695421536, 14926.104433733983, 14974.32615532301, 15104.622384440394, 15122.168280744554, 15125.621859453518, 664.2726214794792, 792.3700657976922, 805.6898094233718, 819.0826274572487, 825.4469505431375, 819.9180081991813, 829.867221244601, 831.3847752663016, 831.6631764135535, 831.9126491718373, 860.6471346747835, 862.2886118951858, 862.6678728689437, 862.8748831419472, 863.5941107679412, 701.2566679319912, 834.2450082675189, 850.0988951711175, 852.7953291210096, 853.1127627267634, 622.2657264427974, 623.3019018699041, 623.7816764132563, 623.847157446424, 624.3600309682612, 14988.400463981428, 15036.323365448472, 15038.699226015528, 15108.773368399483, 15201.695966080617, 14100.0, 14491.855081449261, 14501.564953051426, 14518.709625807425, 14689.118652880861, 13227.933860330733, 13341.599752007456, 13475.326233688276, 13490.123141995738, 13519.256440895746, 4453.53237910018, 4484.955150448519, 4503.752293623849, 4578.061497393026, 4684.718916864999, 75759.24240757633, 76378.0, 76682.61658691727, 77179.61410192969, 79375.99999999942, 10809.948025259087, 10891.945540272249, 10938.343699377903, 10941.179411544166, 11160.274582152135, 20892.895535522224, 20928.0, 20931.581368372546, 20937.37187884366, 20943.162273509195, 8463.57682115904, 8662.30701543875, 8743.0, 8757.518336491426, 8843.380963332633, 4799.736014519165, 4808.8797780055775, 4812.903741925142, 4935.555799978019, 4952.950470495321, 3435.089701229176, 3546.804925729058, 3549.538559987185, 3552.3605750965075, 3555.8755443559353, 512.5745631126156, 597.5100417657566, 621.561798931752, 626.7367705563674, 645.2160624840748, 646.4214527997416, 660.531022973694, 670.7384120193128, 759.2786852490157, 759.9772006839804, 9965.601375945025, 9970.052844979715, 10018.0, 10593.576256949636, 10630.787384252271, 701.421327404893, 745.4297462441236, 748.3601520699832, 769.0809482668269, 774.3495463810426, 4946.752662366867, 5119.692818430906, 5133.974330128325, 5154.587632989352, 5189.532942035235, 115124.0, 121416.0, 123816.38091809663, 124385.0, 125091.37454312852, 73008.0, 106005.0, 106321.0, 106776.0, 107594.0, 67867.66066169637, 72350.0, 93633.0636693638, 93673.53163234277, 93813.5309323449, 9603.711888643353, 9613.663521776703, 9675.854862176931, 9713.805723885342, 9855.950720246354, 54749.0, 55977.44022559885, 56497.15254271107, 56847.147292789814, 57883.0, 81223.59388203258, 82729.0, 83118.58440707758, 84582.0, 85826.57086714526, 13212.273324967218, 13281.933590331986, 13367.732645347232, 13388.799168012682, 13922.51271205503, 14220.786688199478, 14224.906500047218, 14572.979433295324, 14641.341139648954, 14762.0, 13498.190108593515, 13754.518591849237, 13799.103058301178, 14036.29818509091, 14370.425182992982, 13366.93316533411, 13703.0, 13770.173789572658, 13895.791563126359, 14347.354369053626, 13221.801672975105, 13731.794023089862, 13739.175649461064, 13760.380782864595, 14186.432542698176, 10041.447720375449, 10257.897421025695, 10300.381977081399, 10854.565817367216, 11126.944365278121, 10437.478126093816, 10825.020490574108, 10994.615756259504, 11035.779284414106, 11269.211155219056], "value": 7719.561034783142, "unit": "score"}], "name": "dromaeo_css", "value": 7176.491551800339, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 111.0, 112.0, 113.0, 110.0, 110.0, 110.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 118.0, 177.0, 117.0, 119.0, 146.0, 118.0, 149.0, 117.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 160.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 127.0, 78.0, 75.0, 74.0, 76.0, 106.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 84.0, 84.0, 84.0, 120.0, 85.0, 85.0, 121.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 148.0], "value": 146.5, "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, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 52.0, 53.0, 54.0, 53.0, 53.0, 52.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 80.0, 75.0, 75.0, 74.0, 85.0, 74.0, 82.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 118.0, 119.0, 126.0, 120.0, 126.0, 120.0, 165.0, 118.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 164.0, 165.0, 161.0, 164.0, 159.0, 162.0, 158.0, 157.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 66.0, 63.0, 63.0, 63.0, 65.0, 63.0, 62.0, 63.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1484.5, "alertThreshold": 2.0}]} 07:48:08 INFO - Return code: 0 07:48:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:48:08 INFO - # TBPL SUCCESS # 07:48:08 INFO - Running post-action listener: _resource_record_post_action 07:48:08 INFO - ##### 07:48:08 INFO - ##### Finished run-tests step (success) 07:48:08 INFO - ##### 07:48:08 INFO - Running post-run listener: _resource_record_post_run 07:48:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2732032; Write bytes: 557846528; Read time: 904; Write time: 517252 07:48:08 INFO - TinderboxPrint: CPU usage
13.0% 07:48:08 INFO - TinderboxPrint: I/O read bytes / time
2,732,032 / 904 07:48:08 INFO - TinderboxPrint: I/O write bytes / time
557,846,528 / 517,252 07:48:08 INFO - TinderboxPrint: CPU idle
8,257.5 (87.0%) 07:48:08 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 07:48:08 INFO - TinderboxPrint: Swap in / out
0 / 0 07:48:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256249856; Read time: 0; Write time: 302568 07:48:08 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 2727936; Write bytes: 300982272; Read time: 892; Write time: 214684 07:48:08 INFO - Running post-run listener: _upload_blobber_files 07:48:08 INFO - Blob upload gear active. 07:48:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:48:08 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'] 07:48:08 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 07:48:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:13 INFO - (blobuploader) - INFO - Done attempting. 07:48:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:48:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:14 INFO - (blobuploader) - INFO - Done attempting. 07:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:14 INFO - (blobuploader) - INFO - Done attempting. 07:48:14 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:14 INFO - Return code: 0 07:48:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7feec8428e9e0d36b60233e754b704db34a91ab43161e279cc892c0834d1c31aef3bf15fa88134ee679beb8e3e545670d572c5a6ea57288e94a4de3ec7979803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/741b0ce800939e47c7590da4732c7147a8af5e00a3959b16a0583804fca685647bad2815c7b125322b6cbf6f9bdbe2f5087dddcb471e5ca480bcced92aadd7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94da60ba488503c4767cfd6015ad0bb102f534c6b434c8fa9033896d0051dde543f314cce1f5aefc907f135d2c22f798da8c5ebac85c93faa791c9cc35334d0e"} 07:48:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:14 INFO - Contents: 07:48:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7feec8428e9e0d36b60233e754b704db34a91ab43161e279cc892c0834d1c31aef3bf15fa88134ee679beb8e3e545670d572c5a6ea57288e94a4de3ec7979803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/741b0ce800939e47c7590da4732c7147a8af5e00a3959b16a0583804fca685647bad2815c7b125322b6cbf6f9bdbe2f5087dddcb471e5ca480bcced92aadd7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94da60ba488503c4767cfd6015ad0bb102f534c6b434c8fa9033896d0051dde543f314cce1f5aefc907f135d2c22f798da8c5ebac85c93faa791c9cc35334d0e"} 07:48:14 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:14 INFO - Copying logs to upload dir... 07:48:14 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.954738 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-09 07:48:14.185614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 07:48:14.193561) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576 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/7feec8428e9e0d36b60233e754b704db34a91ab43161e279cc892c0834d1c31aef3bf15fa88134ee679beb8e3e545670d572c5a6ea57288e94a4de3ec7979803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/741b0ce800939e47c7590da4732c7147a8af5e00a3959b16a0583804fca685647bad2815c7b125322b6cbf6f9bdbe2f5087dddcb471e5ca480bcced92aadd7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94da60ba488503c4767cfd6015ad0bb102f534c6b434c8fa9033896d0051dde543f314cce1f5aefc907f135d2c22f798da8c5ebac85c93faa791c9cc35334d0e"} build_url:https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/ZC000cVQTAGVwuLD26-etQ/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/7feec8428e9e0d36b60233e754b704db34a91ab43161e279cc892c0834d1c31aef3bf15fa88134ee679beb8e3e545670d572c5a6ea57288e94a4de3ec7979803", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/741b0ce800939e47c7590da4732c7147a8af5e00a3959b16a0583804fca685647bad2815c7b125322b6cbf6f9bdbe2f5087dddcb471e5ca480bcced92aadd7b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94da60ba488503c4767cfd6015ad0bb102f534c6b434c8fa9033896d0051dde543f314cce1f5aefc907f135d2c22f798da8c5ebac85c93faa791c9cc35334d0e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 07:48:14.223924) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:48:14.224380) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468061052.954330-755514576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 07:48:14.279000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 07:48:14.279635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 07:48:14.283269) ========= ========= Total master_lag: 0.42 =========