builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1467965238.28 results: success (0) buildid: 20160707223126 builduid: 1a1af92aa03c4d6c9213e56b55bb4ace revision: b8274835178599b7dfd55860f84406afb40bd673 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.283526) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.283954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.284232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.314224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.314665) ========= 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=cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 01:07:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.0M=0s 2016-07-08 01:07:19 (82.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098457 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.429480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.429802) ========= 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=cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015821 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.479797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:18.480163) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b8274835178599b7dfd55860f84406afb40bd673 --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 b8274835178599b7dfd55860f84406afb40bd673 --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=cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 01:07:19,321 truncating revision to first 12 chars 2016-07-08 01:07:19,321 Setting DEBUG logging. 2016-07-08 01:07:19,321 attempt 1/10 2016-07-08 01:07:19,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b82748351785?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 01:07:19,621 unpacking tar archive at: mozilla-inbound-b82748351785/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649774 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:19.145750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:19.146029) ========= script_repo_revision: b8274835178599b7dfd55860f84406afb40bd673 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:19.146429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:19.146716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 01:07:19.156768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-08 01:07:19.157031) ========= /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=cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:07:20 INFO - MultiFileLogger online at 20160708 01:07:20 in /builds/slave/test 01:07:20 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 01:07:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:07:20 INFO - {'append_to_log': False, 01:07:20 INFO - 'base_work_dir': '/builds/slave/test', 01:07:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:07:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:07:20 INFO - 'branch': 'Mozilla-Inbound', 01:07:20 INFO - 'buildbot_json_path': 'buildprops.json', 01:07:20 INFO - 'config_files': ('talos/linux_config.py',), 01:07:20 INFO - 'default_actions': ('clobber', 01:07:20 INFO - 'read-buildbot-config', 01:07:20 INFO - 'download-and-extract', 01:07:20 INFO - 'populate-webroot', 01:07:20 INFO - 'create-virtualenv', 01:07:20 INFO - 'install', 01:07:20 INFO - 'run-tests'), 01:07:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:07:20 INFO - 'download_minidump_stackwalk': True, 01:07:20 INFO - 'download_symbols': 'ondemand', 01:07:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:07:20 INFO - 'tooltool.py': '/tools/tooltool.py', 01:07:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:07:20 INFO - '/tools/misc-python/virtualenv.py')}, 01:07:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:07:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:07:20 INFO - 'installer_path': 'installer.exe', 01:07:20 INFO - 'log_level': 'info', 01:07:20 INFO - 'log_name': 'talos', 01:07:20 INFO - 'log_to_console': True, 01:07:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:07:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:07:20 INFO - 'opt_config_files': (), 01:07:20 INFO - 'pip_index': False, 01:07:20 INFO - 'sps_profile': False, 01:07:20 INFO - 'sps_profile_interval': 0, 01:07:20 INFO - 'suite': 'dromaeojs', 01:07:20 INFO - 'system_bits': '32', 01:07:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:07:20 INFO - 'title': 'talos-linux64-ix-054', 01:07:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:07:20 INFO - 'use_talos_json': True, 01:07:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:07:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:07:20 INFO - 'work_dir': 'build'} 01:07:20 INFO - ##### 01:07:20 INFO - ##### Running clobber step. 01:07:20 INFO - ##### 01:07:20 INFO - Running pre-action listener: _resource_record_pre_action 01:07:20 INFO - Running main action method: clobber 01:07:20 INFO - rmtree: /builds/slave/test/build 01:07:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:07:20 INFO - Running post-action listener: _resource_record_post_action 01:07:20 INFO - ##### 01:07:20 INFO - ##### Finished clobber step (success) 01:07:20 INFO - ##### 01:07:20 INFO - ##### 01:07:20 INFO - ##### Running read-buildbot-config step. 01:07:20 INFO - ##### 01:07:20 INFO - Running pre-action listener: _resource_record_pre_action 01:07:20 INFO - Running main action method: read_buildbot_config 01:07:20 INFO - Using buildbot properties: 01:07:20 INFO - { 01:07:20 INFO - "project": "", 01:07:20 INFO - "product": "firefox", 01:07:20 INFO - "script_repo_revision": "production", 01:07:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:07:20 INFO - "repository": "", 01:07:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:07:20 INFO - "buildid": "20160707223126", 01:07:20 INFO - "pgo_build": "True", 01:07:20 INFO - "basedir": "/builds/slave/test", 01:07:20 INFO - "buildnumber": 1301, 01:07:20 INFO - "slavename": "talos-linux64-ix-054", 01:07:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:07:20 INFO - "platform": "ubuntu64_hw", 01:07:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:07:20 INFO - "branch": "mozilla-inbound", 01:07:20 INFO - "repo_path": "integration/mozilla-inbound", 01:07:20 INFO - "revision": "b8274835178599b7dfd55860f84406afb40bd673", 01:07:20 INFO - "stage_platform": "linux64-pgo", 01:07:20 INFO - "builduid": "1a1af92aa03c4d6c9213e56b55bb4ace", 01:07:20 INFO - "slavebuilddir": "test" 01:07:20 INFO - } 01:07:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:07:20 INFO - Running post-action listener: _resource_record_post_action 01:07:20 INFO - ##### 01:07:20 INFO - ##### Finished read-buildbot-config step (success) 01:07:20 INFO - ##### 01:07:20 INFO - ##### 01:07:20 INFO - ##### Running download-and-extract step. 01:07:20 INFO - ##### 01:07:20 INFO - Running pre-action listener: _resource_record_pre_action 01:07:20 INFO - Running main action method: download_and_extract 01:07:20 INFO - mkdir: /builds/slave/test/build/tests 01:07:20 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')]} 01:07:20 INFO - https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:26 INFO - Downloaded 1361 bytes. 01:07:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:07:26 INFO - Using the following test package requirements: 01:07:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:07:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:07:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:07:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'jsshell-linux-x86_64.zip'], 01:07:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:07:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:07:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:07:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:07:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:07:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:07:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:07:26 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')]} 01:07:26 INFO - https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:32 INFO - Downloaded 24303807 bytes. 01:07:32 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'] 01:07:32 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 01:07:33 INFO - Return code: 0 01:07:33 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 01:07:33 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')]} 01:07:34 INFO - https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:35 INFO - Downloaded 24303807 bytes. 01:07:35 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'] 01:07:35 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 01:07:36 INFO - Return code: 0 01:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:07:36 INFO - https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:37 INFO - Downloaded 14403333 bytes. 01:07:37 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'] 01:07:37 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 01:07:37 INFO - Return code: 0 01:07:37 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')]} 01:07:37 INFO - https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B8LsiWaUSDSXLstvgl_fjg/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 01:07:39 INFO - Downloaded 60447401 bytes. 01:07:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:39 INFO - mkdir: /builds/slave/test/properties 01:07:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:07:39 INFO - Writing to file /builds/slave/test/properties/build_url 01:07:39 INFO - Contents: 01:07:39 INFO - build_url:https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:39 INFO - Running post-action listener: _resource_record_post_action 01:07:39 INFO - Running post-action listener: set_extra_try_arguments 01:07:39 INFO - ##### 01:07:39 INFO - ##### Finished download-and-extract step (success) 01:07:39 INFO - ##### 01:07:39 INFO - ##### 01:07:39 INFO - ##### Running populate-webroot step. 01:07:39 INFO - ##### 01:07:39 INFO - Running pre-action listener: _resource_record_pre_action 01:07:39 INFO - Running main action method: populate_webroot 01:07:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:07:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:07:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:07:39 INFO - '--tppagecycles', 01:07:39 INFO - '7'], 01:07:39 INFO - 'tests': ['tsvgm']}}, 01:07:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:07:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:07:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:07:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:07:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['damp', 'tps']}, 01:07:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'tests': ['damp', 'tps']}, 01:07:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['dromaeo_dom']}, 01:07:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:07:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['basic_compositor_video']}, 01:07:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:07:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['a11yr', 01:07:39 INFO - 'ts_paint', 01:07:39 INFO - 'tpaint', 01:07:39 INFO - 'sessionrestore', 01:07:39 INFO - 'sessionrestore_no_auto_restore', 01:07:39 INFO - 'tabpaint']}, 01:07:39 INFO - 'other-e10s': {'tests': ['a11yr', 01:07:39 INFO - 'ts_paint', 01:07:39 INFO - 'tpaint', 01:07:39 INFO - 'sessionrestore', 01:07:39 INFO - 'sessionrestore_no_auto_restore', 01:07:39 INFO - 'tabpaint']}, 01:07:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:07:39 INFO - 'ts_paint', 01:07:39 INFO - 'tpaint', 01:07:39 INFO - 'sessionrestore', 01:07:39 INFO - 'sessionrestore_no_auto_restore', 01:07:39 INFO - 'tabpaint']}, 01:07:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:07:39 INFO - 'ts_paint', 01:07:39 INFO - 'tpaint', 01:07:39 INFO - 'sessionrestore', 01:07:39 INFO - 'sessionrestore_no_auto_restore', 01:07:39 INFO - 'tabpaint']}, 01:07:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['a11yr', 01:07:39 INFO - 'ts_paint', 01:07:39 INFO - 'tpaint', 01:07:39 INFO - 'sessionrestore', 01:07:39 INFO - 'sessionrestore_no_auto_restore', 01:07:39 INFO - 'tabpaint']}, 01:07:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['a11yr', 01:07:39 INFO - 'ts_paint', 01:07:39 INFO - 'tpaint', 01:07:39 INFO - 'sessionrestore', 01:07:39 INFO - 'sessionrestore_no_auto_restore', 01:07:39 INFO - 'tabpaint']}, 01:07:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['tsvgx', 01:07:39 INFO - 'tsvgr_opacity', 01:07:39 INFO - 'tart', 01:07:39 INFO - 'tscrollx', 01:07:39 INFO - 'cart']}, 01:07:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:07:39 INFO - 'tsvgr_opacity', 01:07:39 INFO - 'tart', 01:07:39 INFO - 'tscrollx', 01:07:39 INFO - 'cart']}, 01:07:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'talos_options': ['--disable-e10s'], 01:07:39 INFO - 'tests': ['tp5o']}, 01:07:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'tests': ['tp5o']}, 01:07:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'talos_options': ['--disable-e10s', 01:07:39 INFO - '--xperf_path', 01:07:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:39 INFO - 'tests': ['tp5n']}, 01:07:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:39 INFO - 'talos_options': ['--xperf_path', 01:07:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:39 INFO - 'tests': ['tp5n']}}, 01:07:39 INFO - 'talos.zip': {'path': '', 01:07:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:07:39 INFO - Running post-action listener: _resource_record_post_action 01:07:39 INFO - ##### 01:07:39 INFO - ##### Finished populate-webroot step (success) 01:07:39 INFO - ##### 01:07:39 INFO - ##### 01:07:39 INFO - ##### Running create-virtualenv step. 01:07:39 INFO - ##### 01:07:39 INFO - Running pre-action listener: _resource_record_pre_action 01:07:39 INFO - Running main action method: create_virtualenv 01:07:39 INFO - Creating virtualenv /builds/slave/test/build/venv 01:07:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:07:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:07:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:07:39 INFO - Using real prefix '/usr' 01:07:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:07:40 INFO - Installing distribute.............................................................................................................................................................................................done. 01:07:42 INFO - Installing pip.................done. 01:07:42 INFO - Return code: 0 01:07:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:07:42 INFO - Using env: {'DISPLAY': ':0', 01:07:42 INFO - 'HOME': '/home/cltbld', 01:07:42 INFO - 'LANG': 'en_US.UTF-8', 01:07:42 INFO - 'LANGUAGE': 'en_US:en', 01:07:42 INFO - 'LOGNAME': 'cltbld', 01:07:42 INFO - 'MAIL': '/var/mail/cltbld', 01:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:42 INFO - 'MOZ_NO_REMOTE': '1', 01:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:42 INFO - 'NO_EM_RESTART': '1', 01:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:42 INFO - 'PWD': '/builds/slave/test', 01:07:42 INFO - 'SHELL': '/bin/bash', 01:07:42 INFO - 'SHLVL': '1', 01:07:42 INFO - 'TERM': 'linux', 01:07:42 INFO - 'TMOUT': '86400', 01:07:42 INFO - 'USER': 'cltbld', 01:07:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:42 INFO - '_': '/tools/buildbot/bin/python'} 01:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:07:42 INFO - Cleaning up... 01:07:42 INFO - Return code: 0 01:07:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:07:42 INFO - Using env: {'DISPLAY': ':0', 01:07:42 INFO - 'HOME': '/home/cltbld', 01:07:42 INFO - 'LANG': 'en_US.UTF-8', 01:07:42 INFO - 'LANGUAGE': 'en_US:en', 01:07:42 INFO - 'LOGNAME': 'cltbld', 01:07:42 INFO - 'MAIL': '/var/mail/cltbld', 01:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:42 INFO - 'MOZ_NO_REMOTE': '1', 01:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:42 INFO - 'NO_EM_RESTART': '1', 01:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:42 INFO - 'PWD': '/builds/slave/test', 01:07:42 INFO - 'SHELL': '/bin/bash', 01:07:42 INFO - 'SHLVL': '1', 01:07:42 INFO - 'TERM': 'linux', 01:07:42 INFO - 'TMOUT': '86400', 01:07:42 INFO - 'USER': 'cltbld', 01:07:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:42 INFO - '_': '/tools/buildbot/bin/python'} 01:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:42 INFO - Downloading/unpacking psutil>=3.1.1 01:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:07:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:44 INFO - Installing collected packages: psutil 01:07:44 INFO - Running setup.py install for psutil 01:07:44 INFO - building 'psutil._psutil_linux' extension 01:07:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:07:45 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 01:07:45 INFO - building 'psutil._psutil_posix' extension 01:07:45 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 01:07:45 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 01:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:45 INFO - Successfully installed psutil 01:07:45 INFO - Cleaning up... 01:07:45 INFO - Return code: 0 01:07:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:45 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 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:07:45 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 01:07:45 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 01:07:45 INFO - Using env: {'DISPLAY': ':0', 01:07:45 INFO - 'HOME': '/home/cltbld', 01:07:45 INFO - 'LANG': 'en_US.UTF-8', 01:07:45 INFO - 'LANGUAGE': 'en_US:en', 01:07:45 INFO - 'LOGNAME': 'cltbld', 01:07:45 INFO - 'MAIL': '/var/mail/cltbld', 01:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:45 INFO - 'MOZ_NO_REMOTE': '1', 01:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:45 INFO - 'NO_EM_RESTART': '1', 01:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:45 INFO - 'PWD': '/builds/slave/test', 01:07:45 INFO - 'SHELL': '/bin/bash', 01:07:45 INFO - 'SHLVL': '1', 01:07:45 INFO - 'TERM': 'linux', 01:07:45 INFO - 'TMOUT': '86400', 01:07:45 INFO - 'USER': 'cltbld', 01:07:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:45 INFO - '_': '/tools/buildbot/bin/python'} 01:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:07:47 INFO - Installing collected packages: mozsystemmonitor 01:07:47 INFO - Running setup.py install for mozsystemmonitor 01:07:47 INFO - Successfully installed mozsystemmonitor 01:07:47 INFO - Cleaning up... 01:07:47 INFO - Return code: 0 01:07:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:07:47 INFO - Using env: {'DISPLAY': ':0', 01:07:47 INFO - 'HOME': '/home/cltbld', 01:07:47 INFO - 'LANG': 'en_US.UTF-8', 01:07:47 INFO - 'LANGUAGE': 'en_US:en', 01:07:47 INFO - 'LOGNAME': 'cltbld', 01:07:47 INFO - 'MAIL': '/var/mail/cltbld', 01:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:47 INFO - 'MOZ_NO_REMOTE': '1', 01:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:47 INFO - 'NO_EM_RESTART': '1', 01:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:47 INFO - 'PWD': '/builds/slave/test', 01:07:47 INFO - 'SHELL': '/bin/bash', 01:07:47 INFO - 'SHLVL': '1', 01:07:47 INFO - 'TERM': 'linux', 01:07:47 INFO - 'TMOUT': '86400', 01:07:47 INFO - 'USER': 'cltbld', 01:07:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:47 INFO - '_': '/tools/buildbot/bin/python'} 01:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:47 INFO - Downloading/unpacking jsonschema==2.5.1 01:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:07:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:50 INFO - Downloading functools32-3.2.3-2.tar.gz 01:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:07:50 INFO - warning: no files found matching '*.txt' 01:07:50 INFO - no previously-included directories found matching 'build' 01:07:50 INFO - no previously-included directories found matching 'dist' 01:07:50 INFO - no previously-included directories found matching '.git*' 01:07:50 INFO - Installing collected packages: jsonschema, functools32 01:07:50 INFO - Running setup.py install for functools32 01:07:50 INFO - warning: no files found matching '*.txt' 01:07:50 INFO - no previously-included directories found matching 'build' 01:07:50 INFO - no previously-included directories found matching 'dist' 01:07:50 INFO - no previously-included directories found matching '.git*' 01:07:50 INFO - Successfully installed jsonschema functools32 01:07:50 INFO - Cleaning up... 01:07:50 INFO - Return code: 0 01:07:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:07:50 INFO - Using env: {'DISPLAY': ':0', 01:07:50 INFO - 'HOME': '/home/cltbld', 01:07:50 INFO - 'LANG': 'en_US.UTF-8', 01:07:50 INFO - 'LANGUAGE': 'en_US:en', 01:07:50 INFO - 'LOGNAME': 'cltbld', 01:07:50 INFO - 'MAIL': '/var/mail/cltbld', 01:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:50 INFO - 'MOZ_NO_REMOTE': '1', 01:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:50 INFO - 'NO_EM_RESTART': '1', 01:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:50 INFO - 'PWD': '/builds/slave/test', 01:07:50 INFO - 'SHELL': '/bin/bash', 01:07:50 INFO - 'SHLVL': '1', 01:07:50 INFO - 'TERM': 'linux', 01:07:50 INFO - 'TMOUT': '86400', 01:07:50 INFO - 'USER': 'cltbld', 01:07:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:50 INFO - '_': '/tools/buildbot/bin/python'} 01:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:07:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:07:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:53 INFO - Downloading docopt-0.6.1.tar.gz 01:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:07:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:07:53 INFO - Running setup.py install for blobuploader 01:07:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:07:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:07:53 INFO - Running setup.py install for requests 01:07:53 INFO - Running setup.py install for docopt 01:07:53 INFO - Successfully installed blobuploader requests docopt 01:07:53 INFO - Cleaning up... 01:07:53 INFO - Return code: 0 01:07:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:53 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 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:07:53 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 01:07:53 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 01:07:53 INFO - Using env: {'DISPLAY': ':0', 01:07:53 INFO - 'HOME': '/home/cltbld', 01:07:53 INFO - 'LANG': 'en_US.UTF-8', 01:07:53 INFO - 'LANGUAGE': 'en_US:en', 01:07:53 INFO - 'LOGNAME': 'cltbld', 01:07:53 INFO - 'MAIL': '/var/mail/cltbld', 01:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:53 INFO - 'MOZ_NO_REMOTE': '1', 01:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:53 INFO - 'NO_EM_RESTART': '1', 01:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:53 INFO - 'PWD': '/builds/slave/test', 01:07:53 INFO - 'SHELL': '/bin/bash', 01:07:53 INFO - 'SHLVL': '1', 01:07:53 INFO - 'TERM': 'linux', 01:07:53 INFO - 'TMOUT': '86400', 01:07:53 INFO - 'USER': 'cltbld', 01:07:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:53 INFO - '_': '/tools/buildbot/bin/python'} 01:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:54 INFO - Running setup.py (path:/tmp/pip-PoKtz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:54 INFO - Running setup.py (path:/tmp/pip-sfP7_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:54 INFO - Running setup.py (path:/tmp/pip-ZyraV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:54 INFO - Running setup.py (path:/tmp/pip-qnJpn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:54 INFO - Running setup.py (path:/tmp/pip-NMBmw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:54 INFO - Running setup.py (path:/tmp/pip-Vdfj94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:54 INFO - Running setup.py (path:/tmp/pip-Dwot26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:54 INFO - Running setup.py (path:/tmp/pip-P9RneS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:54 INFO - Running setup.py (path:/tmp/pip-VsLzbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:54 INFO - Running setup.py (path:/tmp/pip-IXwDxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:54 INFO - Running setup.py (path:/tmp/pip-eoctWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:54 INFO - Running setup.py (path:/tmp/pip-vApZLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:55 INFO - Running setup.py (path:/tmp/pip-KRGDZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:55 INFO - Running setup.py (path:/tmp/pip-BwOwsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:55 INFO - Running setup.py (path:/tmp/pip-twz965-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:55 INFO - Running setup.py (path:/tmp/pip-FJxpry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:55 INFO - Running setup.py (path:/tmp/pip-AT2ule-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:07:55 INFO - Running setup.py install for manifestparser 01:07:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:07:55 INFO - Running setup.py install for mozcrash 01:07:55 INFO - Running setup.py install for mozdebug 01:07:55 INFO - Running setup.py install for mozdevice 01:07:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:07:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:07:55 INFO - Running setup.py install for mozfile 01:07:55 INFO - Running setup.py install for mozhttpd 01:07:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:07:55 INFO - Running setup.py install for mozinfo 01:07:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Running setup.py install for mozInstall 01:07:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Running setup.py install for mozleak 01:07:56 INFO - Running setup.py install for mozlog 01:07:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Running setup.py install for moznetwork 01:07:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Running setup.py install for mozprocess 01:07:56 INFO - Running setup.py install for mozprofile 01:07:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Running setup.py install for mozrunner 01:07:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:07:56 INFO - Running setup.py install for mozscreenshot 01:07:56 INFO - Running setup.py install for moztest 01:07:57 INFO - Running setup.py install for mozversion 01:07:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:07:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:07:57 INFO - Cleaning up... 01:07:57 INFO - Return code: 0 01:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:07:57 INFO - Using env: {'DISPLAY': ':0', 01:07:57 INFO - 'HOME': '/home/cltbld', 01:07:57 INFO - 'LANG': 'en_US.UTF-8', 01:07:57 INFO - 'LANGUAGE': 'en_US:en', 01:07:57 INFO - 'LOGNAME': 'cltbld', 01:07:57 INFO - 'MAIL': '/var/mail/cltbld', 01:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:57 INFO - 'MOZ_NO_REMOTE': '1', 01:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:57 INFO - 'NO_EM_RESTART': '1', 01:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:57 INFO - 'PWD': '/builds/slave/test', 01:07:57 INFO - 'SHELL': '/bin/bash', 01:07:57 INFO - 'SHLVL': '1', 01:07:57 INFO - 'TERM': 'linux', 01:07:57 INFO - 'TMOUT': '86400', 01:07:57 INFO - 'USER': 'cltbld', 01:07:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:57 INFO - '_': '/tools/buildbot/bin/python'} 01:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:57 INFO - Running setup.py (path:/tmp/pip-PNWdyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:57 INFO - Running setup.py (path:/tmp/pip-jEtIQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:57 INFO - Running setup.py (path:/tmp/pip-sNOlt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:57 INFO - Running setup.py (path:/tmp/pip-2HtZNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:57 INFO - Running setup.py (path:/tmp/pip-UUweOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:57 INFO - Running setup.py (path:/tmp/pip-X4z6NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:57 INFO - Running setup.py (path:/tmp/pip-25I0Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:57 INFO - Running setup.py (path:/tmp/pip-fwNSVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:57 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)) 01:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:57 INFO - Running setup.py (path:/tmp/pip-KSU9jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:58 INFO - Running setup.py (path:/tmp/pip-rLXr01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:58 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)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:58 INFO - Running setup.py (path:/tmp/pip-hYPSiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:58 INFO - Running setup.py (path:/tmp/pip-DGCLGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:58 INFO - Running setup.py (path:/tmp/pip-nLW5Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:58 INFO - Running setup.py (path:/tmp/pip-38tI2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:58 INFO - Running setup.py (path:/tmp/pip-DQXvi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:58 INFO - Running setup.py (path:/tmp/pip-gVCNSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:58 INFO - Running setup.py (path:/tmp/pip-FwZhDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:07:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:08:00 INFO - Downloading blessings-1.6.tar.gz 01:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:08:00 INFO - Installing collected packages: blessings 01:08:00 INFO - Running setup.py install for blessings 01:08:00 INFO - Successfully installed blessings 01:08:00 INFO - Cleaning up... 01:08:00 INFO - Return code: 0 01:08:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:08:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:01 INFO - Reading from file tmpfile_stdout 01:08:01 INFO - Current package versions: 01:08:01 INFO - argparse == 1.2.1 01:08:01 INFO - blessings == 1.6 01:08:01 INFO - blobuploader == 1.2.4 01:08:01 INFO - docopt == 0.6.1 01:08:01 INFO - functools32 == 3.2.3-2 01:08:01 INFO - jsonschema == 2.5.1 01:08:01 INFO - manifestparser == 1.1 01:08:01 INFO - mozInstall == 1.12 01:08:01 INFO - mozcrash == 0.17 01:08:01 INFO - mozdebug == 0.1 01:08:01 INFO - mozdevice == 0.48 01:08:01 INFO - mozfile == 1.2 01:08:01 INFO - mozhttpd == 0.7 01:08:01 INFO - mozinfo == 0.9 01:08:01 INFO - mozleak == 0.1 01:08:01 INFO - mozlog == 3.2 01:08:01 INFO - moznetwork == 0.27 01:08:01 INFO - mozprocess == 0.23 01:08:01 INFO - mozprofile == 0.28 01:08:01 INFO - mozrunner == 6.12 01:08:01 INFO - mozscreenshot == 0.1 01:08:01 INFO - mozsystemmonitor == 0.3 01:08:01 INFO - moztest == 0.7 01:08:01 INFO - mozversion == 1.4 01:08:01 INFO - psutil == 3.1.1 01:08:01 INFO - requests == 1.2.3 01:08:01 INFO - wsgiref == 0.1.2 01:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:08:01 INFO - Using env: {'DISPLAY': ':0', 01:08:01 INFO - 'HOME': '/home/cltbld', 01:08:01 INFO - 'LANG': 'en_US.UTF-8', 01:08:01 INFO - 'LANGUAGE': 'en_US:en', 01:08:01 INFO - 'LOGNAME': 'cltbld', 01:08:01 INFO - 'MAIL': '/var/mail/cltbld', 01:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:01 INFO - 'MOZ_NO_REMOTE': '1', 01:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:01 INFO - 'NO_EM_RESTART': '1', 01:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:01 INFO - 'PWD': '/builds/slave/test', 01:08:01 INFO - 'SHELL': '/bin/bash', 01:08:01 INFO - 'SHLVL': '1', 01:08:01 INFO - 'TERM': 'linux', 01:08:01 INFO - 'TMOUT': '86400', 01:08:01 INFO - 'USER': 'cltbld', 01:08:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:01 INFO - '_': '/tools/buildbot/bin/python'} 01:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:08:01 INFO - Cleaning up... 01:08:01 INFO - Return code: 0 01:08:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2753030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a14180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, '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': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', '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 01:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:08:01 INFO - Using env: {'DISPLAY': ':0', 01:08:01 INFO - 'HOME': '/home/cltbld', 01:08:01 INFO - 'LANG': 'en_US.UTF-8', 01:08:01 INFO - 'LANGUAGE': 'en_US:en', 01:08:01 INFO - 'LOGNAME': 'cltbld', 01:08:01 INFO - 'MAIL': '/var/mail/cltbld', 01:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:01 INFO - 'MOZ_NO_REMOTE': '1', 01:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:01 INFO - 'NO_EM_RESTART': '1', 01:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:01 INFO - 'PWD': '/builds/slave/test', 01:08:01 INFO - 'SHELL': '/bin/bash', 01:08:01 INFO - 'SHLVL': '1', 01:08:01 INFO - 'TERM': 'linux', 01:08:01 INFO - 'TMOUT': '86400', 01:08:01 INFO - 'USER': 'cltbld', 01:08:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:01 INFO - '_': '/tools/buildbot/bin/python'} 01:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:08:01 INFO - Cleaning up... 01:08:01 INFO - Return code: 0 01:08:01 INFO - Running post-action listener: _resource_record_post_action 01:08:01 INFO - Running post-action listener: _start_resource_monitoring 01:08:01 INFO - Starting resource monitoring. 01:08:01 INFO - ##### 01:08:01 INFO - ##### Finished create-virtualenv step (success) 01:08:01 INFO - ##### 01:08:01 INFO - ##### 01:08:01 INFO - ##### Running install step. 01:08:01 INFO - ##### 01:08:01 INFO - Running pre-action listener: _resource_record_pre_action 01:08:01 INFO - Running main action method: install 01:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:01 INFO - Reading from file tmpfile_stdout 01:08:01 INFO - Detecting whether we're running mozinstall >=1.0... 01:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:08:01 INFO - Reading from file tmpfile_stdout 01:08:01 INFO - Output received: 01:08:01 INFO - Usage: mozinstall [options] installer 01:08:01 INFO - Options: 01:08:01 INFO - -h, --help show this help message and exit 01:08:01 INFO - -d DEST, --destination=DEST 01:08:01 INFO - Directory to install application into. [default: 01:08:01 INFO - "/builds/slave/test"] 01:08:01 INFO - --app=APP Application being installed. [default: firefox] 01:08:01 INFO - mkdir: /builds/slave/test/build/application 01:08:01 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'] 01:08:01 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 01:08:18 INFO - Reading from file tmpfile_stdout 01:08:18 INFO - Output received: 01:08:18 INFO - /builds/slave/test/build/application/firefox/firefox 01:08:18 INFO - Running post-action listener: _resource_record_post_action 01:08:18 INFO - ##### 01:08:18 INFO - ##### Finished install step (success) 01:08:18 INFO - ##### 01:08:18 INFO - ##### 01:08:18 INFO - ##### Running run-tests step. 01:08:18 INFO - ##### 01:08:18 INFO - Running pre-action listener: _resource_record_pre_action 01:08:18 INFO - Running main action method: run_tests 01:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:08:18 INFO - Python 2.7.3 01:08:18 INFO - Return code: 0 01:08:18 INFO - grabbing minidump binary from tooltool 01:08:18 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')]} 01:08:18 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 0x2a123b0>, '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 0x2a132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a13740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:08:18 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 01:08:18 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 01:08:18 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 01:08:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:08:19 INFO - Return code: 0 01:08:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:08:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:08:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:08:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:08:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 01:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 01:08:19 INFO - Using env: {'DISPLAY': ':0', 01:08:19 INFO - 'HOME': '/home/cltbld', 01:08:19 INFO - 'LANG': 'en_US.UTF-8', 01:08:19 INFO - 'LANGUAGE': 'en_US:en', 01:08:19 INFO - 'LOGNAME': 'cltbld', 01:08:19 INFO - 'MAIL': '/var/mail/cltbld', 01:08:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:08:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:19 INFO - 'MOZ_NO_REMOTE': '1', 01:08:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:19 INFO - 'NO_EM_RESTART': '1', 01:08:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:19 INFO - 'PWD': '/builds/slave/test', 01:08:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:08:19 INFO - 'SHELL': '/bin/bash', 01:08:19 INFO - 'SHLVL': '1', 01:08:19 INFO - 'TERM': 'linux', 01:08:19 INFO - 'TMOUT': '86400', 01:08:19 INFO - 'USER': 'cltbld', 01:08:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546', 01:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:19 INFO - '_': '/tools/buildbot/bin/python'} 01:08:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 01:08:19 INFO - mozversion application_buildid: 20160707223126 01:08:19 INFO - mozversion application_changeset: b8274835178599b7dfd55860f84406afb40bd673 01:08:19 INFO - mozversion application_display_name: Nightly 01:08:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:08:19 INFO - mozversion application_name: Firefox 01:08:19 INFO - mozversion application_remotingname: firefox 01:08:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:08:19 INFO - mozversion application_vendor: Mozilla 01:08:19 INFO - mozversion application_version: 50.0a1 01:08:19 INFO - mozversion platform_buildid: 20160707223126 01:08:19 INFO - mozversion platform_changeset: b8274835178599b7dfd55860f84406afb40bd673 01:08:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:08:19 INFO - mozversion platform_version: 50.0a1 01:08:19 INFO - using testdate: 1467965299 01:08:19 INFO - actual date: 1467965299 01:08:19 INFO - starting webserver on 'localhost:35993' 01:08:19 INFO - SUITE-START | Running 2 tests 01:08:19 INFO - TEST-START | dromaeo_css 01:08:19 INFO - operating with platform_type : linux_ 01:08:19 INFO - Initialising browser for dromaeo_css test... 01:08:19 INFO - TEST-INFO | started process 18149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvLYB7s/profile http://localhost:35993/getInfo.html) 01:08:23 INFO - PROCESS | 18149 | __metrics Screen width/height:1600/1200 01:08:23 INFO - PROCESS | 18149 | colorDepth:24 01:08:23 INFO - PROCESS | 18149 | Browser inner width/height: 1024/697 01:08:23 INFO - PROCESS | 18149 | __metrics 01:08:24 INFO - PROCESS | 18149 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:25 INFO - TEST-INFO | 18149: exit 0 01:08:25 INFO - Browser initialized. 01:08:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:08:25 INFO - TEST-INFO | started process 18230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvLYB7s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:08:36 INFO - PROCESS | 18230 | RSS: Main: 157319168 01:08:36 INFO - PROCESS | 18230 | 01:09:27 INFO - PROCESS | 18230 | 1467965367575 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] 01:11:36 INFO - PROCESS | 18230 | Cycle 1(1): loaded http://localhost:35993/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35993/tests/dromaeo/cssquery-ext.html) 01:11:37 INFO - PROCESS | 18230 | RSS: Main: 281567232 01:11:37 INFO - PROCESS | 18230 | 01:14:40 INFO - PROCESS | 18230 | Cycle 1(1): loaded http://localhost:35993/tests/dromaeo/cssquery-ext.html (next: http://localhost:35993/tests/dromaeo/cssquery-jquery.html) 01:14:40 INFO - PROCESS | 18230 | RSS: Main: 231620608 01:14:40 INFO - PROCESS | 18230 | 01:17:42 INFO - PROCESS | 18230 | Cycle 1(1): loaded http://localhost:35993/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35993/tests/dromaeo/cssquery-mootools.html) 01:17:43 INFO - PROCESS | 18230 | RSS: Main: 243261440 01:17:43 INFO - PROCESS | 18230 | 01:20:45 INFO - PROCESS | 18230 | Cycle 1(1): loaded http://localhost:35993/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35993/tests/dromaeo/cssquery-prototype.html) 01:20:45 INFO - PROCESS | 18230 | RSS: Main: 244539392 01:20:45 INFO - PROCESS | 18230 | 01:23:48 INFO - PROCESS | 18230 | Cycle 1(1): loaded http://localhost:35993/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35993/tests/dromaeo/cssquery-yui.html) 01:23:49 INFO - PROCESS | 18230 | RSS: Main: 209637376 01:23:49 INFO - PROCESS | 18230 | 01:26:51 INFO - PROCESS | 18230 | Cycle 1(1): loaded http://localhost:35993/tests/dromaeo/cssquery-yui.html (next: http://localhost:35993/tests/dromaeo/cssquery-dojo.html) 01:26:52 INFO - PROCESS | 18230 | RSS: Main: 279351296 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | __start_tp_report 01:26:52 INFO - PROCESS | 18230 | _x_x_mozilla_page_load 01:26:52 INFO - PROCESS | 18230 | _x_x_mozilla_page_load_details 01:26:52 INFO - PROCESS | 18230 | |i|pagename|runs| 01:26:52 INFO - PROCESS | 18230 | |0;dojo.html;2994.3113083990684;3010.879564817407;3042.6348838139425;3081.044876088414;3086.2747254395213;5180.197069454241;5243;5256.395514515832;5317.49483799039;5345.305110335656;5294.867628309295;5337.279467271917;5415.593830462722;5440;5500.50495455409;4849.612031037508;4875.536824001714;4907.975460122694;4913.33669954556;4984.102861484931;4900.705957642535;4979.427365852919;5036.84889453317;5040.294358789773;5053.444121146671;4764.309175169581;4941.50584941503;4959.032988567249;4983.626228032912;5018.749062546876;4790.401199850019;4834.879128021792;4853.102176097398;4872.342233798463;4874.341963834908;4795.928061079087;4817.205161148407;4871.0744958458135;4873.195922672755;4921.753912304406;5205.453427390107;5341.839744807662;5355.651882627656;5369.62412631116;5413.864653383657;5731.541476681897;5781.13283007548;5798.652080875161;5820.039693450618;5883.588148829584;5856;5858.472737453607;5864.325602555676;5906.409359064102;5915.08316210988;5278.02356564033;5376.032314183406;5469.945300546983;5486.506214440719;5493.038718224335;5927.347991720907;5968.940310596839;5973.761049557969;6029.728662210211;6032.819015429544;5736.483716465455;5785.71071446426;5788.305403351625;5795.362510123883;5796.043652797325;5494.835154945358;5686.289213848269;5747.540196784247;5815.098659707752;5879.353271140171;5741.655500669973;5755.3381361143165;5756.971215143982;5758.942410575924;5803.419658034247;5702.344230413555;5740.253767010262;5742.799002034909;5750.367459579443;5757.539396848242;4263.445752052276;4300.89247768802;4320.546342634041;4402.119576084796;4410.184115938561;3894.5521265054313;3896.12337224128;3908.5700572936953;3939.3106206413763;3946.4474973503734;5471.7264136793;5509.724513774296;5523.6409633373705;5530.225768392428;5576.9163462548095;5596.188552659842;5725.742341594639;5750.30996280449;5785.942140578624;5885.529157667376;5480.479354461319;5514.365847927459;5516.834494965157;5517.420670829585;5519.668819870821;5000.024995125988;5013.523715247045;5019.196928491424;5023.572996295356;5074.49255074497;5810.912836307459;5907.852303692442;5940.31686356066;5968.641881487038;6010.639361638316;5808.82573522795;5818.272715910512;5819.534437244925;5820.912686309794;5821.09772985188;5837.970810146092;5986.2217911671205;5997.940020599738;6001.5798894077;6004.939950600613;5592.3289205293995;5615.831525054255;5646.548276137982;5669.262995810518;5685.147227915846;5683.77264909399;5686.488216060575;5689.573282003949;5726.312842458765;5741.110127930177;5427.864303392446;5547.944520554905;5549;5598.944010560005;5610.551155907436;5531.419200984;5616.494515493625;5617.915731263953;5619.8595035124445;5675.517581005495;5491.807786727445;5528.778848846001;5541.833744987657;5588.133839254922;5590.552755779447;5491.478309560585;5633.690147041788;5635.182898479779;5682.545396368363;5723;5273.28810610578;5348.117560602613;5349;5413.702246376487;5623.3533143689 01:26:52 INFO - PROCESS | 18230 | |1;ext.html;584.0975692555002;612.3478495402393;613.2548953022078;632.7563887903159;638.0620487882817;30213.546796798037;33350.49974250385;33385.66614333856;33415.498767518446;44594;41164.79417602915;44907.32639010417;45287;45301.32048019282;45318;8954.5075020874;9108.8633670495;9109.180173784358;9114.954425227897;9118.407303525282;8283.751487455385;8953.328500362466;10452.477376131163;10669.679909602686;10713.08938740208;10966.396848173346;11001.064909482704;11008.39453830039;11017.889821101806;11025.228234023622;8237.588120594006;10772.784544309108;10824.945875270652;10836.67489975302;10850.131989440866;10420.32267902584;10745.462726863625;10751.677449676523;10778.19163562736;11086.334819910751;40393.59606403928;40758.79620601878;43985;44065.77967110176;44114.55885441136;3537.770044947096;3586.103474131467;3595.1910820065277;3623.058004918714;3845.3270677631303;33773;33853.322933541436;34213.315733685435;34346.48480272798;34756.9572912813;4156.542780294165;4283;4308.978455107705;4311.33174357975;4399.890002749925;363875;364295;364790;365440.34559654596;365691;35801.46297805535;36948.44577331342;64476.67761661162;65363.673181633785;65417.67291163609;38085.23829523394;38179.80910095432;38274.61725382766;38301.80849095793;38313.42529862055;15848.366065357488;15978.440754573767;15982.200889955455;15984.840151598568;15995.440159594591;12036.578719744766;12369.072319575887;13343.399547020408;13412.195268283935;13429.597112086652;8399.580020998925;8607.741767746978;8665.306775457948;8670.86993695095;8672.826543469095;3303.339332133583;3330.4837750148768;3368.5957685077456;3369.5619569456303;3412.2493051529123;980.9993806317659;981.2787601113176;1010.6311196413257;1028.8816786069697;1131.728385187549;31984.200394990312;33388;33627.495587566205;33721.49417758736;33887.83056084704;1056.1428514867177;1095.2278643556274;1103.5420300575172;1164.6040346282305;1202.0804084875078;17387.304967730022;17387.56531086733;17505.474835754947;17604.559886002953;17723.29106835738;577992;582419;583899;584466;585778;59353.70323148357;59947.40052599506;60014.69992650096;60050;60070;1255.4036832504669;1280.6990357266036;1337.8394592648945;1366.2280811341561;1371.5679560938272;30273.848630756704;34191;34209.48685769765;34299.65700343064;34593.82703086468;49906.75046624744;50123;50489.22309273025;50497;50516.74741626268;426757;427429;428230;429347;429352;25153.87423062873;27902;28576.714232857405;28677.85661071681;28743.281417964718;48392.27411588899;49181.50818491913;49479;49996.50003499918;50178;41440.3783943235;42411.363829541966;42610.14779704327;42933.57066429296;43191;42168.794892258826;42709.22390044637;43344;43428.78285608552;43706.34440483332;41488;42133;42526.574734253496;42584.36123458089;42689.57310426856;35323.29353412969;37242.38937127289;37527.624723752415;37588.81205593955;38287.80856095813;28438.85780571084;28468;28496.43007139804;28834.855825720737;28875.7112428873 01:26:52 INFO - PROCESS | 18230 | |2;jquery.html;401.26968916571815;403.7274839483349;407.4214615246348;408.8569000849703;418.19080080045114;13395;18772.155253013614;19686.310979115733;20323.898380508097;20332.69500957487;14217.92891035546;19045.333413330536;19163.712544311813;19425.611487770235;19773.802261977413;5801.970990145043;5977.790777322794;5985.5810093293485;5988.161657367972;6019.969900150515;5857.941420585804;5925.4963328117165;5936.257967754031;5948.732307046172;5950.613210141349;4253.319468884979;6338.461230795388;6708.262091169968;6713.731450741989;6724;6558.147440832685;6593.802185934405;6600.900986485207;7173.0675012248075;7572.167061623217;7131;7402.518836275625;7439.4792364534505;7453.664585093684;7457.776266712007;26871;27506.862465687744;27970.160895173176;28016.719832801617;28028.159155225378;2515.2202817126567;2638.2480992916926;2683.436478339551;3166.889158879428;3257.9737382724365;16022.519324420286;16246.106464144468;16401.00880209738;16448.917755411265;16480.42318518846;2059.2792522616965;2100.737407824022;2104.6211681897253;2179.3244094330807;2213.8007579317937;94085;105320;105763;107245;107469.46265268624;17497.737533937;17692;17869.213078692286;18057.367992120213;18331.81668183301;32135;32388.83805580957;32392.676073239436;32594.83702581472;32707.345853082807;10003.499825008721;10247.38515689061;10293.845592316122;10374.325668831501;10426.895731042745;8597.656093756304;8680.392372533988;8708.17272359125;8748.8687669685;8925.509096999598;7291.522131261198;8362.414630975894;8875;8934.821303573892;9191.95404022989;3194.7763656544284;3249.1227368610344;3480.269143479847;3561.732870034758;3586.372384832644;936.8313703533429;938.4510061613896;1016.1210552871713;1041.2086814021397;1054.3199636234585;17416.564585885455;19558.315458958867;20548.58902821935;20916.37250882476;21042.158313667587;1006.3358183598936;1026.820306446369;1032.1691038713907;1044.5821671331375;1073.4632683658172;10254.58981640741;10549.630762923261;10637.9468102659;10646.201534884915;10686.198535109897;512711;518045;525143;536908;537262;101783;102341;103366.48316758368;104793.47603262088;107102.46448767706;1057.9894201058046;1059.920505962056;1078.7626722121279;1085;1096.4736926275432;17360.56598584995;17468.47594572165;17735.82264177342;17788.199531020877;17945.910270448563;44961.77519112384;46826.76586617045;46885.842557317985;47073;47889.76055119702;59919;64344;66113.33886661072;66830.6658466724;67598.66200669162;6924.930750692429;8633.223009929137;8924.598393072198;9201.125893040151;9260.351775375928;10061.396316220756;13921.860781392057;13946.4421423146;14352.282385880873;14407.279636018367;11859.169858110195;11862.288262704265;12034.037277017642;12214.328211948072;12517.123801333819;11612.825807613062;11699.415029248674;11810.173287869766;11892.10809189297;12174.57388991381;11799.233049851731;12055.879441205476;12136.817947730968;12462.750744985231;12615.93692031534;8783.604737786687;8871.778205544913;9092.772680683036;9179.403338782959;9236.630534778533;11132.220744547803;11804.940975295069;11873.643790686294;12072.275663460221;12085.39573021363 01:26:52 INFO - PROCESS | 18230 | |3;mootools.html;1465.428482891672;1505.503183949297;1659.6016955930572;1753.3512600337876;1800.9639807203864;8693.869591956118;9140.908590914089;9243.907560924397;9244.16802487776;9244.768880777967;7878.133405325424;8635.69775057873;8848.380613357067;8893.73318800437;9109.316801239916;2367.6803631509742;2396.6165413533836;2400.4958958618713;2401.591729406005;2409.204962362416;2059.2792522617037;2405.0860672944254;2420.3102115896972;2438.5854404751235;2442.3771938155833;2333.0784340185614;2403.531311394279;2407.145463360508;2420.5642984262827;2421.322029831641;2369.597168481362;2384.2847145856263;2394.0543485323374;2394.652775347582;2397.496525729599;2363.5745565798147;2365.9171928982405;2368.62102063669;2379.0959435414607;2413.710354757423;9280.53597320138;9282.767930801716;9294.488803115826;9303.209227215695;9304.72085837426;5296.867578310535;5435.809746658888;5441.5102640762525;5486.286782718261;5493.890122197574;3364.62989071202;3370.275390790992;3427.5886893572683;3522.0314413536225;3531.611522732497;1125.9774804503945;1135.6195674448986;1157.375017490554;1159.930404175752;1173.653772137213;13118.409671564707;13144.474221031147;13166.802497962539;13171.60485185446;13173.736525269442;4729.148753224384;4729.810807567659;4744.327487667424;4809.326694262806;4894.730789806595;10913.945430272797;11032.44837758109;11036;11051.115910727283;11070.778584428266;5473.890522189534;5476.890462190734;5497.972510137503;5502.174673798962;5508.44915508446;4993.500649934977;5055.16589762685;5056.0140772549;5076.0863044652315;5105.668131571436;3917.9020524487114;3999.920001599952;4000.7199496035582;4057.350823868167;4063.329550624173;1178.634623266773;1267.5056727876135;1270.510853321478;1279.9040071994452;1291.1607455154226;967.9854802177973;969.5733877094056;973.0998826085984;979.177490907641;987.456898705709;5764.827055188351;6019.428154325332;6027.758889644453;6030.9747342951805;6050.6369617823075;909.3589019741066;920.7283851263893;936.4615346175976;948.2887834124407;985.7239972807625;4223.49318081826;4226.36604509326;4242.893927651833;4330.588594083557;4347.608715215582;11343;11746.823797643043;11782.52869885195;11788.823167652492;11825.763484730258;10229.897701023043;10967.287126336763;11197.72005699864;11632.476538555786;11694.415279236004;8566.443181193203;8685.478871267744;8722.694705685397;8752.299816014704;8774.429662072072;6033.849153771191;6386.297507274103;6398.296187419473;6448.097266382616;6535;10272.691819245434;10453.216008799523;10591.8940810594;10682.092022178202;10685.412302323446;10604.946975265075;10827.783444331228;10840.5121769519;10847.45762711877;10850.457477125954;7654.349380302737;7664.6550905210515;7783.143854175923;7792.103908050647;7834.216578342121;8817.382783205114;8915.73252802417;8941.195292423714;8950.060243674581;8950.955245223733;8144.267015968591;8290.875636865572;8371.079181290175;8383.790405239917;8397.034341050614;8000.5599692017495;8156.632951517077;8191.058028326819;8253.917460825314;8305.584720763816;6905.723771049303;7057.894131587927;7144.535605185646;7151.7854464366155;7155.928440715526;5381.784728610968;5520.723963801875;5574.832755017356;5576.498115169654;5662.433756624469;5421.620486565903;5491.148871924858;5597.244372009889;5612.102063669793;5694.743736531783 01:26:52 INFO - PROCESS | 18230 | |4;prototype.html;318.17592435591826;323.7490944517998;326.45319090523367;334.897856153873;337.54937158892886;5128.53843154116;5320.973395133029;5327.307450031495;5363.4368391318885;5370.838874833757;5316.229146773716;5319.255304257397;5321.467853214686;5346.198070289459;5349.786008559653;4178.352355384913;4239.788010599473;4240.936385954198;4260.552641972595;4279.572042795711;3913.8434462621462;3961.1879564689316;4212.831486740527;4260.914781704364;4268.42376279203;4183.832646694129;4203.117345357478;4211.663066954651;4215.1780402821305;4221.873343799691;4203.180379825935;4204.348326009474;4205.810738516759;4224.704270701021;4240.448741663595;3659.688926441229;3734.5705243896755;3753.343164946151;3754.8498060077563;3776.376897811885;5157.246536177718;5171.2501687255135;5223.190405487156;5230.529252367305;5283.894322113536;4806.423229212517;4817.205161148441;4821.433034263843;4855.417349918032;4870.683405578661;5360.758765855507;5567.4432556744405;5582.8325150245555;5603.299587551556;5634.549236061105;4104.692148088905;4117.3618089196225;4122.154958233555;4146.129312844307;4159.480064991876;5797.246357973479;5816.621919575214;5836.795712150097;5843.678597677126;5874.676892770896;4047.352423612208;4219.156168766259;4224.957750422518;4232.343986682069;4232.851850185229;4238.406623072772;4254;4257.042165512735;4261.31818908973;4281.143771245764;4832.767644250764;4836.516348365135;4839.733814640229;4844.563989240985;4845.370101886732;5489.176623506506;5575.414581468968;5653.547716182696;5654.208410822488;5660.009498337775;1445.2701385800103;1457.6501639606631;1459.3432955170215;1467.2150399536197;1469.2359972814077;927.939683920543;961.7018724195522;968.5786682793008;977.5112443778111;983.1643103362085;4822.493638167942;4826.710397376169;4841.685290456109;4858.416989961157;4867.464578896319;5097.541221290102;5124.923766009105;5130.640855140105;5141.820036298712;5149.433562308143;4659.788455001656;4828.927566086511;4831.710097394168;4866.416030076413;4867.707937523689;2664.3605534671537;2691.6231727558156;2691.9461610768067;2700.1629494856656;2722.7413395727376;5287.964133808511;5306.442823503554;5312.442193569619;5319.893602127936;5349.866253343697;4898.975505122452;5123.6157288202785;5178.689278643294;5218.869528261824;5254.632175747737;5095.668781529263;5180.653030212096;5232.555232805178;5245.160774276097;5281.181416880467;4978.676386035041;4994.275830004702;5036.571891389273;5136.460671629575;5151.845444636667;4663.300504924288;5010.874728131826;5015.84952451427;5029.547340739351;5100.336956195819;5214.582833373245;5234.842954711365;5247.08176069194;5250.291210686509;5251.737413129252;3939.0349364404756;4027.9597204027586;4029.49631296088;4029.697772667003;4123.587641235852;5667.291588551431;5714.971425142848;5720.8283751487525;5721.485066344049;5743.827685169452;5342.332208473941;5585.636933599303;5605.271314729059;5606.523445507178;5608.551315894637;5502.147167189092;5502.972485137549;5531.474509921551;5535.335759708861;5545.1682247663175;5467.152591348347;5484.2596249505805;5484.7806087757635;5488.588355873246;5491.643043202179;5420.496903633998;5584.525315348241;5586.692731899784;5623.88752224945;5627.424321190073;5504.4495550444635;5505.889882202414;5506.697131657797;5519.834404967857;5522.834314970557 01:26:52 INFO - PROCESS | 18230 | |5;yui.html;729.6096588325247;838.4885220015793;851.4848516647428;856.1652388920799;866.3285953386121;15539.68920621587;16709.331626734947;16742.49772506824;16751.32994680213;16834.494965151036;14628.268586570655;15203;15218.695626087472;15713.607159821011;15743.763843542356;662.4104546953215;797.0196658110542;812.273015650992;815.1970309245388;817.5952903312868;778.404520541786;805.4120492040814;810.4691427115249;810.5744484145841;811.5860910935406;855.3114742632179;855.6192494340021;858.0389963241179;858.2618947705;858.2876212743439;684.3601232847303;810.1048341582525;850.1413572291967;850.612971098152;850.6427300533791;609.4697613076607;609.890219760443;610.0818268505915;610.7709608896664;611.3580740222793;15755.97586156896;15784.763228551581;15811.68376632461;15811.762823557656;15836.970596911164;14337.139771613736;14653.853461465356;14702.411903523845;14722.043067200597;14954.476593319181;13878.236696981661;13929.930350348184;13993.580192594238;14116.294185290695;14478.276086195649;4664.953350466486;4668;4704.741239231875;4713.34013238147;4766.189747742892;88408.5579572098;89204.6335134808;89283;89520.55239723825;90240.54879725626;11656.766864662659;11894.524219031142;11899.167058305835;11952.940235298767;12146.210496317712;21108.577828443344;21125;21372.145114195257;21382.78617213808;21508.247211347527;8834.779130521789;9094;9110.681126160553;9170.541472926327;9284.72145835626;4939.90120197594;4989.847690411926;5087.771050302746;5101.438841727407;5162.819301324435;3550.1657110578994;3646.9635303646623;3676.28312479064;3679.9448008279896;3696.8706095286534;650.8600650860088;664.3655309179721;668.6255696809802;680.2483256002146;684.4661164291861;724.8876424154264;734.2547314475811;748.9251074892467;757.2427572427572;758.3213024343182;9326.90673093274;9397.71806845782;9892.55483503244;10014.899851001397;10205.38767673942;631.8294060603612;712.5688958180226;723.1141851232198;735.9549439795503;753.3671715758788;4963.60291176705;5058.595312375001;5069.264956581275;5077.644564880497;5111.626630746633;71539.6423017892;85600.57199714085;108922;115786;117245;98178;99558;100299;101259;102010;77904.61047694726;81170;83596;90524.54737726269;90983;10292.834767437154;10342.172626190037;10478.685639430829;10566.471676416302;10623.628173014216;49423.25865111954;51569.22646160235;51941.7402912983;52288;53002;50269.49730502648;51025.48974510207;57808.71095644495;76923;78042.2195778035;13336.733265334833;13408.463661453432;13647.38586763618;13986.230757308038;14037.859621404064;14809.92595037018;15227.238638068275;15423;15574.377024918876;15756.684866302381;14513.346899389764;14526.20105894186;14585.854141458874;14863.777043344575;15213.467528636887;14277.928610357298;14561.199134047729;14636.707265854837;14807.481738139113;14926;14137.646558836112;14350.856491434952;14413.279336033365;14824.888133390255;15351.923240383727;11005.65851321818;11158.163137764537;11260.38067906273;11385.772284554097;11693.88306116928;12030.458629361525;12080.697982550506;12365.690857728629;12433.12968092225;12451.073997610372 01:26:52 INFO - PROCESS | 18230 | __end_tp_report 01:26:52 INFO - PROCESS | 18230 | __start_cc_report 01:26:52 INFO - PROCESS | 18230 | _x_x_mozilla_cycle_collect,1060 01:26:52 INFO - PROCESS | 18230 | __end_cc_report 01:26:52 INFO - PROCESS | 18230 | __startTimestamp1467966412099__endTimestamp 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | ------- Summary: start ------- 01:26:52 INFO - PROCESS | 18230 | Number of tests: 6 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | [#0] dojo.html Cycles:165 Average:5350.00 Median:5530.23 stddev:623.39 (11.3%) stddev-sans-first:597.29 01:26:52 INFO - PROCESS | 18230 | Values: 2994.3 3010.9 3042.6 3081.0 3086.3 5180.2 5243.0 5256.4 5317.5 5345.3 5294.9 5337.3 5415.6 5440.0 5500.5 4849.6 4875.5 4908.0 4913.3 4984.1 4900.7 4979.4 5036.8 5040.3 5053.4 4764.3 4941.5 4959.0 4983.6 5018.7 4790.4 4834.9 4853.1 4872.3 4874.3 4795.9 4817.2 4871.1 4873.2 4921.8 5205.5 5341.8 5355.7 5369.6 5413.9 5731.5 5781.1 5798.7 5820.0 5883.6 5856.0 5858.5 5864.3 5906.4 5915.1 5278.0 5376.0 5469.9 5486.5 5493.0 5927.3 5968.9 5973.8 6029.7 6032.8 5736.5 5785.7 5788.3 5795.4 5796.0 5494.8 5686.3 5747.5 5815.1 5879.4 5741.7 5755.3 5757.0 5758.9 5803.4 5702.3 5740.3 5742.8 5750.4 5757.5 4263.4 4300.9 4320.5 4402.1 4410.2 3894.6 3896.1 3908.6 3939.3 3946.4 5471.7 5509.7 5523.6 5530.2 5576.9 5596.2 5725.7 5750.3 5785.9 5885.5 5480.5 5514.4 5516.8 5517.4 5519.7 5000.0 5013.5 5019.2 5023.6 5074.5 5810.9 5907.9 5940.3 5968.6 6010.6 5808.8 5818.3 5819.5 5820.9 5821.1 5838.0 5986.2 5997.9 6001.6 6004.9 5592.3 5615.8 5646.5 5669.3 5685.1 5683.8 5686.5 5689.6 5726.3 5741.1 5427.9 5547.9 5549.0 5598.9 5610.6 5531.4 5616.5 5617.9 5619.9 5675.5 5491.8 5528.8 5541.8 5588.1 5590.6 5491.5 5633.7 5635.2 5682.5 5723.0 5273.3 5348.1 5349.0 5413.7 5623.4 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | [#1] ext.html Cycles:180 Average:60926.01 Median:37095.42 stddev:124395.91 (335.3%) stddev-sans-first:124662.37 01:26:52 INFO - PROCESS | 18230 | Values: 584.1 612.3 613.3 632.8 638.1 30213.5 33350.5 33385.7 33415.5 44594.0 41164.8 44907.3 45287.0 45301.3 45318.0 8954.5 9108.9 9109.2 9115.0 9118.4 8283.8 8953.3 10452.5 10669.7 10713.1 10966.4 11001.1 11008.4 11017.9 11025.2 8237.6 10772.8 10824.9 10836.7 10850.1 10420.3 10745.5 10751.7 10778.2 11086.3 40393.6 40758.8 43985.0 44065.8 44114.6 3537.8 3586.1 3595.2 3623.1 3845.3 33773.0 33853.3 34213.3 34346.5 34757.0 4156.5 4283.0 4309.0 4311.3 4399.9 363875.0 364295.0 364790.0 365440.3 365691.0 35801.5 36948.4 64476.7 65363.7 65417.7 38085.2 38179.8 38274.6 38301.8 38313.4 15848.4 15978.4 15982.2 15984.8 15995.4 12036.6 12369.1 13343.4 13412.2 13429.6 8399.6 8607.7 8665.3 8670.9 8672.8 3303.3 3330.5 3368.6 3369.6 3412.2 981.0 981.3 1010.6 1028.9 1131.7 31984.2 33388.0 33627.5 33721.5 33887.8 1056.1 1095.2 1103.5 1164.6 1202.1 17387.3 17387.6 17505.5 17604.6 17723.3 577992.0 582419.0 583899.0 584466.0 585778.0 59353.7 59947.4 60014.7 60050.0 60070.0 1255.4 1280.7 1337.8 1366.2 1371.6 30273.8 34191.0 34209.5 34299.7 34593.8 49906.8 50123.0 50489.2 50497.0 50516.7 426757.0 427429.0 428230.0 429347.0 429352.0 25153.9 27902.0 28576.7 28677.9 28743.3 48392.3 49181.5 49479.0 49996.5 50178.0 41440.4 42411.4 42610.1 42933.6 43191.0 42168.8 42709.2 43344.0 43428.8 43706.3 41488.0 42133.0 42526.6 42584.4 42689.6 35323.3 37242.4 37527.6 37588.8 38287.8 28438.9 28468.0 28496.4 28834.9 28875.7 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | [#2] jquery.html Cycles:180 Average:32652.22 Median:2196.56 stddev:87128.28 (3966.6%) stddev-sans-first:87339.04 01:26:52 INFO - PROCESS | 18230 | Values: 401.3 403.7 407.4 408.9 418.2 13395.0 18772.2 19686.3 20323.9 20332.7 14217.9 19045.3 19163.7 19425.6 19773.8 5802.0 5977.8 5985.6 5988.2 6020.0 5857.9 5925.5 5936.3 5948.7 5950.6 4253.3 6338.5 6708.3 6713.7 6724.0 6558.1 6593.8 6600.9 7173.1 7572.2 7131.0 7402.5 7439.5 7453.7 7457.8 26871.0 27506.9 27970.2 28016.7 28028.2 2515.2 2638.2 2683.4 3166.9 3258.0 16022.5 16246.1 16401.0 16448.9 16480.4 2059.3 2100.7 2104.6 2179.3 2213.8 94085.0 105320.0 105763.0 107245.0 107469.5 17497.7 17692.0 17869.2 18057.4 18331.8 32135.0 32388.8 32392.7 32594.8 32707.3 10003.5 10247.4 10293.8 10374.3 10426.9 8597.7 8680.4 8708.2 8748.9 8925.5 7291.5 8362.4 8875.0 8934.8 9192.0 3194.8 3249.1 3480.3 3561.7 3586.4 936.8 938.5 1016.1 1041.2 1054.3 17416.6 19558.3 20548.6 20916.4 21042.2 1006.3 1026.8 1032.2 1044.6 1073.5 10254.6 10549.6 10637.9 10646.2 10686.2 512711.0 518045.0 525143.0 536908.0 537262.0 101783.0 102341.0 103366.5 104793.5 107102.5 1058.0 1059.9 1078.8 1085.0 1096.5 17360.6 17468.5 17735.8 17788.2 17945.9 44961.8 46826.8 46885.8 47073.0 47889.8 59919.0 64344.0 66113.3 66830.7 67598.7 6924.9 8633.2 8924.6 9201.1 9260.4 10061.4 13921.9 13946.4 14352.3 14407.3 11859.2 11862.3 12034.0 12214.3 12517.1 11612.8 11699.4 11810.2 11892.1 12174.6 11799.2 12055.9 12136.8 12462.8 12615.9 8783.6 8871.8 9092.8 9179.4 9236.6 11132.2 11804.9 11873.6 12072.3 12085.4 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | [#3] mootools.html Cycles:180 Average:6060.46 Median:5024.33 stddev:3488.35 (69.4%) stddev-sans-first:3481.04 01:26:52 INFO - PROCESS | 18230 | Values: 1465.4 1505.5 1659.6 1753.4 1801.0 8693.9 9140.9 9243.9 9244.2 9244.8 7878.1 8635.7 8848.4 8893.7 9109.3 2367.7 2396.6 2400.5 2401.6 2409.2 2059.3 2405.1 2420.3 2438.6 2442.4 2333.1 2403.5 2407.1 2420.6 2421.3 2369.6 2384.3 2394.1 2394.7 2397.5 2363.6 2365.9 2368.6 2379.1 2413.7 9280.5 9282.8 9294.5 9303.2 9304.7 5296.9 5435.8 5441.5 5486.3 5493.9 3364.6 3370.3 3427.6 3522.0 3531.6 1126.0 1135.6 1157.4 1159.9 1173.7 13118.4 13144.5 13166.8 13171.6 13173.7 4729.1 4729.8 4744.3 4809.3 4894.7 10913.9 11032.4 11036.0 11051.1 11070.8 5473.9 5476.9 5498.0 5502.2 5508.4 4993.5 5055.2 5056.0 5076.1 5105.7 3917.9 3999.9 4000.7 4057.4 4063.3 1178.6 1267.5 1270.5 1279.9 1291.2 968.0 969.6 973.1 979.2 987.5 5764.8 6019.4 6027.8 6031.0 6050.6 909.4 920.7 936.5 948.3 985.7 4223.5 4226.4 4242.9 4330.6 4347.6 11343.0 11746.8 11782.5 11788.8 11825.8 10229.9 10967.3 11197.7 11632.5 11694.4 8566.4 8685.5 8722.7 8752.3 8774.4 6033.8 6386.3 6398.3 6448.1 6535.0 10272.7 10453.2 10591.9 10682.1 10685.4 10604.9 10827.8 10840.5 10847.5 10850.5 7654.3 7664.7 7783.1 7792.1 7834.2 8817.4 8915.7 8941.2 8950.1 8951.0 8144.3 8290.9 8371.1 8383.8 8397.0 8000.6 8156.6 8191.1 8253.9 8305.6 6905.7 7057.9 7144.5 7151.8 7155.9 5381.8 5520.7 5574.8 5576.5 5662.4 5421.6 5491.1 5597.2 5612.1 5694.7 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | [#4] prototype.html Cycles:180 Average:4559.49 Median:5111.98 stddev:1295.42 (25.3%) stddev-sans-first:1259.33 01:26:52 INFO - PROCESS | 18230 | Values: 318.2 323.7 326.5 334.9 337.5 5128.5 5321.0 5327.3 5363.4 5370.8 5316.2 5319.3 5321.5 5346.2 5349.8 4178.4 4239.8 4240.9 4260.6 4279.6 3913.8 3961.2 4212.8 4260.9 4268.4 4183.8 4203.1 4211.7 4215.2 4221.9 4203.2 4204.3 4205.8 4224.7 4240.4 3659.7 3734.6 3753.3 3754.8 3776.4 5157.2 5171.3 5223.2 5230.5 5283.9 4806.4 4817.2 4821.4 4855.4 4870.7 5360.8 5567.4 5582.8 5603.3 5634.5 4104.7 4117.4 4122.2 4146.1 4159.5 5797.2 5816.6 5836.8 5843.7 5874.7 4047.4 4219.2 4225.0 4232.3 4232.9 4238.4 4254.0 4257.0 4261.3 4281.1 4832.8 4836.5 4839.7 4844.6 4845.4 5489.2 5575.4 5653.5 5654.2 5660.0 1445.3 1457.7 1459.3 1467.2 1469.2 927.9 961.7 968.6 977.5 983.2 4822.5 4826.7 4841.7 4858.4 4867.5 5097.5 5124.9 5130.6 5141.8 5149.4 4659.8 4828.9 4831.7 4866.4 4867.7 2664.4 2691.6 2691.9 2700.2 2722.7 5288.0 5306.4 5312.4 5319.9 5349.9 4899.0 5123.6 5178.7 5218.9 5254.6 5095.7 5180.7 5232.6 5245.2 5281.2 4978.7 4994.3 5036.6 5136.5 5151.8 4663.3 5010.9 5015.8 5029.5 5100.3 5214.6 5234.8 5247.1 5250.3 5251.7 3939.0 4028.0 4029.5 4029.7 4123.6 5667.3 5715.0 5720.8 5721.5 5743.8 5342.3 5585.6 5605.3 5606.5 5608.6 5502.1 5503.0 5531.5 5535.3 5545.2 5467.2 5484.3 5484.8 5488.6 5491.6 5420.5 5584.5 5586.7 5623.9 5627.4 5504.4 5505.9 5506.7 5519.8 5522.8 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - PROCESS | 18230 | [#5] yui.html Cycles:180 Average:20819.60 Median:4709.04 stddev:29046.26 (616.8%) stddev-sans-first:29088.57 01:26:52 INFO - PROCESS | 18230 | Values: 729.6 838.5 851.5 856.2 866.3 15539.7 16709.3 16742.5 16751.3 16834.5 14628.3 15203.0 15218.7 15713.6 15743.8 662.4 797.0 812.3 815.2 817.6 778.4 805.4 810.5 810.6 811.6 855.3 855.6 858.0 858.3 858.3 684.4 810.1 850.1 850.6 850.6 609.5 609.9 610.1 610.8 611.4 15756.0 15784.8 15811.7 15811.8 15837.0 14337.1 14653.9 14702.4 14722.0 14954.5 13878.2 13929.9 13993.6 14116.3 14478.3 4665.0 4668.0 4704.7 4713.3 4766.2 88408.6 89204.6 89283.0 89520.6 90240.5 11656.8 11894.5 11899.2 11952.9 12146.2 21108.6 21125.0 21372.1 21382.8 21508.2 8834.8 9094.0 9110.7 9170.5 9284.7 4939.9 4989.8 5087.8 5101.4 5162.8 3550.2 3647.0 3676.3 3679.9 3696.9 650.9 664.4 668.6 680.2 684.5 724.9 734.3 748.9 757.2 758.3 9326.9 9397.7 9892.6 10014.9 10205.4 631.8 712.6 723.1 736.0 753.4 4963.6 5058.6 5069.3 5077.6 5111.6 71539.6 85600.6 108922.0 115786.0 117245.0 98178.0 99558.0 100299.0 101259.0 102010.0 77904.6 81170.0 83596.0 90524.5 90983.0 10292.8 10342.2 10478.7 10566.5 10623.6 49423.3 51569.2 51941.7 52288.0 53002.0 50269.5 51025.5 57808.7 76923.0 78042.2 13336.7 13408.5 13647.4 13986.2 14037.9 14809.9 15227.2 15423.0 15574.4 15756.7 14513.3 14526.2 14585.9 14863.8 15213.5 14277.9 14561.2 14636.7 14807.5 14926.0 14137.6 14350.9 14413.3 14824.9 15351.9 11005.7 11158.2 11260.4 11385.8 11693.9 12030.5 12080.7 12365.7 12433.1 12451.1 01:26:52 INFO - PROCESS | 18230 | -------- Summary: end -------- 01:26:52 INFO - PROCESS | 18230 | 01:26:52 INFO - TEST-INFO | 18230: exit 0 01:26:52 INFO - TEST-OK | dromaeo_css | took 1113531ms 01:26:52 INFO - TEST-START | kraken 01:26:52 INFO - operating with platform_type : linux_ 01:26:52 INFO - Initialising browser for kraken test... 01:26:52 INFO - TEST-INFO | started process 18428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa6bkp_/profile http://localhost:35993/getInfo.html) 01:26:56 INFO - PROCESS | 18428 | __metrics Screen width/height:1600/1200 01:26:56 INFO - PROCESS | 18428 | colorDepth:24 01:26:56 INFO - PROCESS | 18428 | Browser inner width/height: 1024/697 01:26:56 INFO - PROCESS | 18428 | __metrics 01:26:57 INFO - PROCESS | 18428 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:58 INFO - TEST-INFO | 18428: exit 0 01:26:58 INFO - Browser initialized. 01:26:58 INFO - Running cycle 1/1 for kraken test... 01:26:58 INFO - TEST-INFO | started process 18512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa6bkp_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:10 INFO - PROCESS | 18512 | RSS: Main: 157024256 01:27:10 INFO - PROCESS | 18512 | 01:27:12 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35993/tests/kraken/driver.html?testName=audio-beat-detection) 01:27:13 INFO - PROCESS | 18512 | RSS: Main: 216027136 01:27:13 INFO - PROCESS | 18512 | 01:27:16 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35993/tests/kraken/driver.html?testName=audio-dft) 01:27:16 INFO - PROCESS | 18512 | RSS: Main: 202801152 01:27:16 INFO - PROCESS | 18512 | 01:27:20 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35993/tests/kraken/driver.html?testName=audio-fft) 01:27:20 INFO - PROCESS | 18512 | RSS: Main: 269959168 01:27:20 INFO - PROCESS | 18512 | 01:27:22 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35993/tests/kraken/driver.html?testName=audio-oscillator) 01:27:23 INFO - PROCESS | 18512 | RSS: Main: 180391936 01:27:23 INFO - PROCESS | 18512 | 01:27:25 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35993/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:27:26 INFO - PROCESS | 18512 | RSS: Main: 184725504 01:27:26 INFO - PROCESS | 18512 | 01:27:29 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35993/tests/kraken/driver.html?testName=imaging-darkroom) 01:27:29 INFO - PROCESS | 18512 | RSS: Main: 219119616 01:27:29 INFO - PROCESS | 18512 | 01:27:33 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35993/tests/kraken/driver.html?testName=imaging-desaturate) 01:27:33 INFO - PROCESS | 18512 | RSS: Main: 221175808 01:27:33 INFO - PROCESS | 18512 | 01:27:36 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35993/tests/kraken/driver.html?testName=json-parse-financial) 01:27:37 INFO - PROCESS | 18512 | RSS: Main: 221732864 01:27:37 INFO - PROCESS | 18512 | 01:27:38 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35993/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:27:39 INFO - PROCESS | 18512 | RSS: Main: 206807040 01:27:39 INFO - PROCESS | 18512 | 01:27:40 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:27:41 INFO - PROCESS | 18512 | RSS: Main: 212287488 01:27:41 INFO - PROCESS | 18512 | 01:27:43 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:27:44 INFO - PROCESS | 18512 | RSS: Main: 213467136 01:27:44 INFO - PROCESS | 18512 | 01:27:46 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:27:47 INFO - PROCESS | 18512 | RSS: Main: 227299328 01:27:47 INFO - PROCESS | 18512 | 01:27:50 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:27:50 INFO - PROCESS | 18512 | RSS: Main: 226291712 01:27:50 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | Cycle 1(1): loaded http://localhost:35993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35993/tests/kraken/driver.html?testName=ai-astar) 01:27:52 INFO - PROCESS | 18512 | RSS: Main: 269225984 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | __start_tp_report 01:27:52 INFO - PROCESS | 18512 | _x_x_mozilla_page_load 01:27:52 INFO - PROCESS | 18512 | _x_x_mozilla_page_load_details 01:27:52 INFO - PROCESS | 18512 | |i|pagename|runs| 01:27:52 INFO - PROCESS | 18512 | |0;ai-astar;102;109;111;111;111;111;110;109;112;110 01:27:52 INFO - PROCESS | 18512 | |1;audio-beat-detection;145;117;120;176;126;119;145;118;148;117 01:27:52 INFO - PROCESS | 18512 | |2;audio-dft;161;160;160;162;161;160;161;160;162;162 01:27:52 INFO - PROCESS | 18512 | |3;audio-fft;76;76;75;132;75;75;74;74;104;74 01:27:52 INFO - PROCESS | 18512 | |4;audio-oscillator;83;85;117;84;83;84;120;84;84;127 01:27:52 INFO - PROCESS | 18512 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 01:27:52 INFO - PROCESS | 18512 | |6;imaging-darkroom;147;145;145;146;145;145;145;146;145;145 01:27:52 INFO - PROCESS | 18512 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;95;95 01:27:52 INFO - PROCESS | 18512 | |8;json-parse-financial;53;63;54;53;53;54;52;53;53;55 01:27:52 INFO - PROCESS | 18512 | |9;json-stringify-tinderbox;61;61;61;61;62;62;62;61;62;61 01:27:52 INFO - PROCESS | 18512 | |10;stanford-crypto-aes;75;75;75;75;84;77;79;86;81;75 01:27:52 INFO - PROCESS | 18512 | |11;stanford-crypto-ccm;119;121;119;119;123;123;121;119;192;121 01:27:52 INFO - PROCESS | 18512 | |12;stanford-crypto-pbkdf2;158;153;156;153;156;155;154;157;158;156 01:27:52 INFO - PROCESS | 18512 | |13;stanford-crypto-sha256-iterative;67;63;64;64;64;64;64;71;62;63 01:27:52 INFO - PROCESS | 18512 | __end_tp_report 01:27:52 INFO - PROCESS | 18512 | __start_cc_report 01:27:52 INFO - PROCESS | 18512 | _x_x_mozilla_cycle_collect,1645 01:27:52 INFO - PROCESS | 18512 | __end_cc_report 01:27:52 INFO - PROCESS | 18512 | __startTimestamp1467966472578__endTimestamp 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | ------- Summary: start ------- 01:27:52 INFO - PROCESS | 18512 | Number of tests: 14 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:2.84 (2.6%) stddev-sans-first:1.01 01:27:52 INFO - PROCESS | 18512 | Values: 102.0 109.0 111.0 111.0 111.0 111.0 110.0 109.0 112.0 110.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:135.50 stddev:19.76 (14.6%) stddev-sans-first:20.48 01:27:52 INFO - PROCESS | 18512 | Values: 145.0 117.0 120.0 176.0 126.0 119.0 145.0 118.0 148.0 117.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 01:27:52 INFO - PROCESS | 18512 | Values: 161.0 160.0 160.0 162.0 161.0 160.0 161.0 160.0 162.0 162.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:19.36 (25.8%) stddev-sans-first:20.34 01:27:52 INFO - PROCESS | 18512 | Values: 76.0 76.0 75.0 132.0 75.0 75.0 74.0 74.0 104.0 74.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:84.00 stddev:18.27 (21.8%) stddev-sans-first:18.85 01:27:52 INFO - PROCESS | 18512 | Values: 83.0 85.0 117.0 84.0 83.0 84.0 120.0 84.0 84.0 127.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:27:52 INFO - PROCESS | 18512 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 01:27:52 INFO - PROCESS | 18512 | Values: 147.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 01:27:52 INFO - PROCESS | 18512 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:3.16 (5.9%) stddev-sans-first:3.32 01:27:52 INFO - PROCESS | 18512 | Values: 53.0 63.0 54.0 53.0 53.0 54.0 52.0 53.0 53.0 55.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:27:52 INFO - PROCESS | 18512 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 62.0 61.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:4.16 (5.3%) stddev-sans-first:4.25 01:27:52 INFO - PROCESS | 18512 | Values: 75.0 75.0 75.0 75.0 84.0 77.0 79.0 86.0 81.0 75.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:121.00 stddev:22.65 (18.7%) stddev-sans-first:23.80 01:27:52 INFO - PROCESS | 18512 | Values: 119.0 121.0 119.0 119.0 123.0 123.0 121.0 119.0 192.0 121.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.00 stddev:1.84 (1.2%) stddev-sans-first:1.73 01:27:52 INFO - PROCESS | 18512 | Values: 158.0 153.0 156.0 153.0 156.0 155.0 154.0 157.0 158.0 156.0 01:27:52 INFO - PROCESS | 18512 | 01:27:52 INFO - PROCESS | 18512 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:2.59 (4.0%) stddev-sans-first:2.60 01:27:52 INFO - PROCESS | 18512 | Values: 67.0 63.0 64.0 64.0 64.0 64.0 64.0 71.0 62.0 63.0 01:27:52 INFO - PROCESS | 18512 | -------- Summary: end -------- 01:27:52 INFO - PROCESS | 18512 | 01:27:53 INFO - TEST-INFO | 18512: exit 0 01:27:53 INFO - TEST-OK | kraken | took 60769ms 01:27:53 INFO - SUITE-END | took 1174s 01:27:53 INFO - Completed test suite (00:19:34) 01:27:53 INFO - javascript benchmark 01:27:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.3113083990684, 3010.879564817407, 3042.6348838139425, 3081.044876088414, 3086.2747254395213, 5180.197069454241, 5243.0, 5256.395514515832, 5317.49483799039, 5345.305110335656, 5294.867628309295, 5337.279467271917, 5415.593830462722, 5440.0, 5500.50495455409, 4849.612031037508, 4875.536824001714, 4907.975460122694, 4913.33669954556, 4984.102861484931, 4900.705957642535, 4979.427365852919, 5036.84889453317, 5040.294358789773, 5053.444121146671, 4764.309175169581, 4941.50584941503, 4959.032988567249, 4983.626228032912, 5018.749062546876, 4790.401199850019, 4834.879128021792, 4853.102176097398, 4872.342233798463, 4874.341963834908, 4795.928061079087, 4817.205161148407, 4871.0744958458135, 4873.195922672755, 4921.753912304406, 5205.453427390107, 5341.839744807662, 5355.651882627656, 5369.62412631116, 5413.864653383657, 5731.541476681897, 5781.13283007548, 5798.652080875161, 5820.039693450618, 5883.588148829584, 5856.0, 5858.472737453607, 5864.325602555676, 5906.409359064102, 5915.08316210988, 5278.02356564033, 5376.032314183406, 5469.945300546983, 5486.506214440719, 5493.038718224335, 5927.347991720907, 5968.940310596839, 5973.761049557969, 6029.728662210211, 6032.819015429544, 5736.483716465455, 5785.71071446426, 5788.305403351625, 5795.362510123883, 5796.043652797325, 5494.835154945358, 5686.289213848269, 5747.540196784247, 5815.098659707752, 5879.353271140171, 5741.655500669973, 5755.3381361143165, 5756.971215143982, 5758.942410575924, 5803.419658034247, 5702.344230413555, 5740.253767010262, 5742.799002034909, 5750.367459579443, 5757.539396848242, 4263.445752052276, 4300.89247768802, 4320.546342634041, 4402.119576084796, 4410.184115938561, 3894.5521265054313, 3896.12337224128, 3908.5700572936953, 3939.3106206413763, 3946.4474973503734, 5471.7264136793, 5509.724513774296, 5523.6409633373705, 5530.225768392428, 5576.9163462548095, 5596.188552659842, 5725.742341594639, 5750.30996280449, 5785.942140578624, 5885.529157667376, 5480.479354461319, 5514.365847927459, 5516.834494965157, 5517.420670829585, 5519.668819870821, 5000.024995125988, 5013.523715247045, 5019.196928491424, 5023.572996295356, 5074.49255074497, 5810.912836307459, 5907.852303692442, 5940.31686356066, 5968.641881487038, 6010.639361638316, 5808.82573522795, 5818.272715910512, 5819.534437244925, 5820.912686309794, 5821.09772985188, 5837.970810146092, 5986.2217911671205, 5997.940020599738, 6001.5798894077, 6004.939950600613, 5592.3289205293995, 5615.831525054255, 5646.548276137982, 5669.262995810518, 5685.147227915846, 5683.77264909399, 5686.488216060575, 5689.573282003949, 5726.312842458765, 5741.110127930177, 5427.864303392446, 5547.944520554905, 5549.0, 5598.944010560005, 5610.551155907436, 5531.419200984, 5616.494515493625, 5617.915731263953, 5619.8595035124445, 5675.517581005495, 5491.807786727445, 5528.778848846001, 5541.833744987657, 5588.133839254922, 5590.552755779447, 5491.478309560585, 5633.690147041788, 5635.182898479779, 5682.545396368363, 5723.0, 5273.28810610578, 5348.117560602613, 5349.0, 5413.702246376487, 5623.3533143689], "value": 5306.499818975571, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.0975692555002, 612.3478495402393, 613.2548953022078, 632.7563887903159, 638.0620487882817, 30213.546796798037, 33350.49974250385, 33385.66614333856, 33415.498767518446, 44594.0, 41164.79417602915, 44907.32639010417, 45287.0, 45301.32048019282, 45318.0, 8954.5075020874, 9108.8633670495, 9109.180173784358, 9114.954425227897, 9118.407303525282, 8283.751487455385, 8953.328500362466, 10452.477376131163, 10669.679909602686, 10713.08938740208, 10966.396848173346, 11001.064909482704, 11008.39453830039, 11017.889821101806, 11025.228234023622, 8237.588120594006, 10772.784544309108, 10824.945875270652, 10836.67489975302, 10850.131989440866, 10420.32267902584, 10745.462726863625, 10751.677449676523, 10778.19163562736, 11086.334819910751, 40393.59606403928, 40758.79620601878, 43985.0, 44065.77967110176, 44114.55885441136, 3537.770044947096, 3586.103474131467, 3595.1910820065277, 3623.058004918714, 3845.3270677631303, 33773.0, 33853.322933541436, 34213.315733685435, 34346.48480272798, 34756.9572912813, 4156.542780294165, 4283.0, 4308.978455107705, 4311.33174357975, 4399.890002749925, 363875.0, 364295.0, 364790.0, 365440.34559654596, 365691.0, 35801.46297805535, 36948.44577331342, 64476.67761661162, 65363.673181633785, 65417.67291163609, 38085.23829523394, 38179.80910095432, 38274.61725382766, 38301.80849095793, 38313.42529862055, 15848.366065357488, 15978.440754573767, 15982.200889955455, 15984.840151598568, 15995.440159594591, 12036.578719744766, 12369.072319575887, 13343.399547020408, 13412.195268283935, 13429.597112086652, 8399.580020998925, 8607.741767746978, 8665.306775457948, 8670.86993695095, 8672.826543469095, 3303.339332133583, 3330.4837750148768, 3368.5957685077456, 3369.5619569456303, 3412.2493051529123, 980.9993806317659, 981.2787601113176, 1010.6311196413257, 1028.8816786069697, 1131.728385187549, 31984.200394990312, 33388.0, 33627.495587566205, 33721.49417758736, 33887.83056084704, 1056.1428514867177, 1095.2278643556274, 1103.5420300575172, 1164.6040346282305, 1202.0804084875078, 17387.304967730022, 17387.56531086733, 17505.474835754947, 17604.559886002953, 17723.29106835738, 577992.0, 582419.0, 583899.0, 584466.0, 585778.0, 59353.70323148357, 59947.40052599506, 60014.69992650096, 60050.0, 60070.0, 1255.4036832504669, 1280.6990357266036, 1337.8394592648945, 1366.2280811341561, 1371.5679560938272, 30273.848630756704, 34191.0, 34209.48685769765, 34299.65700343064, 34593.82703086468, 49906.75046624744, 50123.0, 50489.22309273025, 50497.0, 50516.74741626268, 426757.0, 427429.0, 428230.0, 429347.0, 429352.0, 25153.87423062873, 27902.0, 28576.714232857405, 28677.85661071681, 28743.281417964718, 48392.27411588899, 49181.50818491913, 49479.0, 49996.50003499918, 50178.0, 41440.3783943235, 42411.363829541966, 42610.14779704327, 42933.57066429296, 43191.0, 42168.794892258826, 42709.22390044637, 43344.0, 43428.78285608552, 43706.34440483332, 41488.0, 42133.0, 42526.574734253496, 42584.36123458089, 42689.57310426856, 35323.29353412969, 37242.38937127289, 37527.624723752415, 37588.81205593955, 38287.80856095813, 28438.85780571084, 28468.0, 28496.43007139804, 28834.855825720737, 28875.7112428873], "value": 19487.05171918061, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.26968916571815, 403.7274839483349, 407.4214615246348, 408.8569000849703, 418.19080080045114, 13395.0, 18772.155253013614, 19686.310979115733, 20323.898380508097, 20332.69500957487, 14217.92891035546, 19045.333413330536, 19163.712544311813, 19425.611487770235, 19773.802261977413, 5801.970990145043, 5977.790777322794, 5985.5810093293485, 5988.161657367972, 6019.969900150515, 5857.941420585804, 5925.4963328117165, 5936.257967754031, 5948.732307046172, 5950.613210141349, 4253.319468884979, 6338.461230795388, 6708.262091169968, 6713.731450741989, 6724.0, 6558.147440832685, 6593.802185934405, 6600.900986485207, 7173.0675012248075, 7572.167061623217, 7131.0, 7402.518836275625, 7439.4792364534505, 7453.664585093684, 7457.776266712007, 26871.0, 27506.862465687744, 27970.160895173176, 28016.719832801617, 28028.159155225378, 2515.2202817126567, 2638.2480992916926, 2683.436478339551, 3166.889158879428, 3257.9737382724365, 16022.519324420286, 16246.106464144468, 16401.00880209738, 16448.917755411265, 16480.42318518846, 2059.2792522616965, 2100.737407824022, 2104.6211681897253, 2179.3244094330807, 2213.8007579317937, 94085.0, 105320.0, 105763.0, 107245.0, 107469.46265268624, 17497.737533937, 17692.0, 17869.213078692286, 18057.367992120213, 18331.81668183301, 32135.0, 32388.83805580957, 32392.676073239436, 32594.83702581472, 32707.345853082807, 10003.499825008721, 10247.38515689061, 10293.845592316122, 10374.325668831501, 10426.895731042745, 8597.656093756304, 8680.392372533988, 8708.17272359125, 8748.8687669685, 8925.509096999598, 7291.522131261198, 8362.414630975894, 8875.0, 8934.821303573892, 9191.95404022989, 3194.7763656544284, 3249.1227368610344, 3480.269143479847, 3561.732870034758, 3586.372384832644, 936.8313703533429, 938.4510061613896, 1016.1210552871713, 1041.2086814021397, 1054.3199636234585, 17416.564585885455, 19558.315458958867, 20548.58902821935, 20916.37250882476, 21042.158313667587, 1006.3358183598936, 1026.820306446369, 1032.1691038713907, 1044.5821671331375, 1073.4632683658172, 10254.58981640741, 10549.630762923261, 10637.9468102659, 10646.201534884915, 10686.198535109897, 512711.0, 518045.0, 525143.0, 536908.0, 537262.0, 101783.0, 102341.0, 103366.48316758368, 104793.47603262088, 107102.46448767706, 1057.9894201058046, 1059.920505962056, 1078.7626722121279, 1085.0, 1096.4736926275432, 17360.56598584995, 17468.47594572165, 17735.82264177342, 17788.199531020877, 17945.910270448563, 44961.77519112384, 46826.76586617045, 46885.842557317985, 47073.0, 47889.76055119702, 59919.0, 64344.0, 66113.33886661072, 66830.6658466724, 67598.66200669162, 6924.930750692429, 8633.223009929137, 8924.598393072198, 9201.125893040151, 9260.351775375928, 10061.396316220756, 13921.860781392057, 13946.4421423146, 14352.282385880873, 14407.279636018367, 11859.169858110195, 11862.288262704265, 12034.037277017642, 12214.328211948072, 12517.123801333819, 11612.825807613062, 11699.415029248674, 11810.173287869766, 11892.10809189297, 12174.57388991381, 11799.233049851731, 12055.879441205476, 12136.817947730968, 12462.750744985231, 12615.93692031534, 8783.604737786687, 8871.778205544913, 9092.772680683036, 9179.403338782959, 9236.630534778533, 11132.220744547803, 11804.940975295069, 11873.643790686294, 12072.275663460221, 12085.39573021363], "value": 10651.554409359764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.428482891672, 1505.503183949297, 1659.6016955930572, 1753.3512600337876, 1800.9639807203864, 8693.869591956118, 9140.908590914089, 9243.907560924397, 9244.16802487776, 9244.768880777967, 7878.133405325424, 8635.69775057873, 8848.380613357067, 8893.73318800437, 9109.316801239916, 2367.6803631509742, 2396.6165413533836, 2400.4958958618713, 2401.591729406005, 2409.204962362416, 2059.2792522617037, 2405.0860672944254, 2420.3102115896972, 2438.5854404751235, 2442.3771938155833, 2333.0784340185614, 2403.531311394279, 2407.145463360508, 2420.5642984262827, 2421.322029831641, 2369.597168481362, 2384.2847145856263, 2394.0543485323374, 2394.652775347582, 2397.496525729599, 2363.5745565798147, 2365.9171928982405, 2368.62102063669, 2379.0959435414607, 2413.710354757423, 9280.53597320138, 9282.767930801716, 9294.488803115826, 9303.209227215695, 9304.72085837426, 5296.867578310535, 5435.809746658888, 5441.5102640762525, 5486.286782718261, 5493.890122197574, 3364.62989071202, 3370.275390790992, 3427.5886893572683, 3522.0314413536225, 3531.611522732497, 1125.9774804503945, 1135.6195674448986, 1157.375017490554, 1159.930404175752, 1173.653772137213, 13118.409671564707, 13144.474221031147, 13166.802497962539, 13171.60485185446, 13173.736525269442, 4729.148753224384, 4729.810807567659, 4744.327487667424, 4809.326694262806, 4894.730789806595, 10913.945430272797, 11032.44837758109, 11036.0, 11051.115910727283, 11070.778584428266, 5473.890522189534, 5476.890462190734, 5497.972510137503, 5502.174673798962, 5508.44915508446, 4993.500649934977, 5055.16589762685, 5056.0140772549, 5076.0863044652315, 5105.668131571436, 3917.9020524487114, 3999.920001599952, 4000.7199496035582, 4057.350823868167, 4063.329550624173, 1178.634623266773, 1267.5056727876135, 1270.510853321478, 1279.9040071994452, 1291.1607455154226, 967.9854802177973, 969.5733877094056, 973.0998826085984, 979.177490907641, 987.456898705709, 5764.827055188351, 6019.428154325332, 6027.758889644453, 6030.9747342951805, 6050.6369617823075, 909.3589019741066, 920.7283851263893, 936.4615346175976, 948.2887834124407, 985.7239972807625, 4223.49318081826, 4226.36604509326, 4242.893927651833, 4330.588594083557, 4347.608715215582, 11343.0, 11746.823797643043, 11782.52869885195, 11788.823167652492, 11825.763484730258, 10229.897701023043, 10967.287126336763, 11197.72005699864, 11632.476538555786, 11694.415279236004, 8566.443181193203, 8685.478871267744, 8722.694705685397, 8752.299816014704, 8774.429662072072, 6033.849153771191, 6386.297507274103, 6398.296187419473, 6448.097266382616, 6535.0, 10272.691819245434, 10453.216008799523, 10591.8940810594, 10682.092022178202, 10685.412302323446, 10604.946975265075, 10827.783444331228, 10840.5121769519, 10847.45762711877, 10850.457477125954, 7654.349380302737, 7664.6550905210515, 7783.143854175923, 7792.103908050647, 7834.216578342121, 8817.382783205114, 8915.73252802417, 8941.195292423714, 8950.060243674581, 8950.955245223733, 8144.267015968591, 8290.875636865572, 8371.079181290175, 8383.790405239917, 8397.034341050614, 8000.5599692017495, 8156.632951517077, 8191.058028326819, 8253.917460825314, 8305.584720763816, 6905.723771049303, 7057.894131587927, 7144.535605185646, 7151.7854464366155, 7155.928440715526, 5381.784728610968, 5520.723963801875, 5574.832755017356, 5576.498115169654, 5662.433756624469, 5421.620486565903, 5491.148871924858, 5597.244372009889, 5612.102063669793, 5694.743736531783], "value": 4817.3687609518065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.17592435591826, 323.7490944517998, 326.45319090523367, 334.897856153873, 337.54937158892886, 5128.53843154116, 5320.973395133029, 5327.307450031495, 5363.4368391318885, 5370.838874833757, 5316.229146773716, 5319.255304257397, 5321.467853214686, 5346.198070289459, 5349.786008559653, 4178.352355384913, 4239.788010599473, 4240.936385954198, 4260.552641972595, 4279.572042795711, 3913.8434462621462, 3961.1879564689316, 4212.831486740527, 4260.914781704364, 4268.42376279203, 4183.832646694129, 4203.117345357478, 4211.663066954651, 4215.1780402821305, 4221.873343799691, 4203.180379825935, 4204.348326009474, 4205.810738516759, 4224.704270701021, 4240.448741663595, 3659.688926441229, 3734.5705243896755, 3753.343164946151, 3754.8498060077563, 3776.376897811885, 5157.246536177718, 5171.2501687255135, 5223.190405487156, 5230.529252367305, 5283.894322113536, 4806.423229212517, 4817.205161148441, 4821.433034263843, 4855.417349918032, 4870.683405578661, 5360.758765855507, 5567.4432556744405, 5582.8325150245555, 5603.299587551556, 5634.549236061105, 4104.692148088905, 4117.3618089196225, 4122.154958233555, 4146.129312844307, 4159.480064991876, 5797.246357973479, 5816.621919575214, 5836.795712150097, 5843.678597677126, 5874.676892770896, 4047.352423612208, 4219.156168766259, 4224.957750422518, 4232.343986682069, 4232.851850185229, 4238.406623072772, 4254.0, 4257.042165512735, 4261.31818908973, 4281.143771245764, 4832.767644250764, 4836.516348365135, 4839.733814640229, 4844.563989240985, 4845.370101886732, 5489.176623506506, 5575.414581468968, 5653.547716182696, 5654.208410822488, 5660.009498337775, 1445.2701385800103, 1457.6501639606631, 1459.3432955170215, 1467.2150399536197, 1469.2359972814077, 927.939683920543, 961.7018724195522, 968.5786682793008, 977.5112443778111, 983.1643103362085, 4822.493638167942, 4826.710397376169, 4841.685290456109, 4858.416989961157, 4867.464578896319, 5097.541221290102, 5124.923766009105, 5130.640855140105, 5141.820036298712, 5149.433562308143, 4659.788455001656, 4828.927566086511, 4831.710097394168, 4866.416030076413, 4867.707937523689, 2664.3605534671537, 2691.6231727558156, 2691.9461610768067, 2700.1629494856656, 2722.7413395727376, 5287.964133808511, 5306.442823503554, 5312.442193569619, 5319.893602127936, 5349.866253343697, 4898.975505122452, 5123.6157288202785, 5178.689278643294, 5218.869528261824, 5254.632175747737, 5095.668781529263, 5180.653030212096, 5232.555232805178, 5245.160774276097, 5281.181416880467, 4978.676386035041, 4994.275830004702, 5036.571891389273, 5136.460671629575, 5151.845444636667, 4663.300504924288, 5010.874728131826, 5015.84952451427, 5029.547340739351, 5100.336956195819, 5214.582833373245, 5234.842954711365, 5247.08176069194, 5250.291210686509, 5251.737413129252, 3939.0349364404756, 4027.9597204027586, 4029.49631296088, 4029.697772667003, 4123.587641235852, 5667.291588551431, 5714.971425142848, 5720.8283751487525, 5721.485066344049, 5743.827685169452, 5342.332208473941, 5585.636933599303, 5605.271314729059, 5606.523445507178, 5608.551315894637, 5502.147167189092, 5502.972485137549, 5531.474509921551, 5535.335759708861, 5545.1682247663175, 5467.152591348347, 5484.2596249505805, 5484.7806087757635, 5488.588355873246, 5491.643043202179, 5420.496903633998, 5584.525315348241, 5586.692731899784, 5623.88752224945, 5627.424321190073, 5504.4495550444635, 5505.889882202414, 5506.697131657797, 5519.834404967857, 5522.834314970557], "value": 4149.530252549562, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.6096588325247, 838.4885220015793, 851.4848516647428, 856.1652388920799, 866.3285953386121, 15539.68920621587, 16709.331626734947, 16742.49772506824, 16751.32994680213, 16834.494965151036, 14628.268586570655, 15203.0, 15218.695626087472, 15713.607159821011, 15743.763843542356, 662.4104546953215, 797.0196658110542, 812.273015650992, 815.1970309245388, 817.5952903312868, 778.404520541786, 805.4120492040814, 810.4691427115249, 810.5744484145841, 811.5860910935406, 855.3114742632179, 855.6192494340021, 858.0389963241179, 858.2618947705, 858.2876212743439, 684.3601232847303, 810.1048341582525, 850.1413572291967, 850.612971098152, 850.6427300533791, 609.4697613076607, 609.890219760443, 610.0818268505915, 610.7709608896664, 611.3580740222793, 15755.97586156896, 15784.763228551581, 15811.68376632461, 15811.762823557656, 15836.970596911164, 14337.139771613736, 14653.853461465356, 14702.411903523845, 14722.043067200597, 14954.476593319181, 13878.236696981661, 13929.930350348184, 13993.580192594238, 14116.294185290695, 14478.276086195649, 4664.953350466486, 4668.0, 4704.741239231875, 4713.34013238147, 4766.189747742892, 88408.5579572098, 89204.6335134808, 89283.0, 89520.55239723825, 90240.54879725626, 11656.766864662659, 11894.524219031142, 11899.167058305835, 11952.940235298767, 12146.210496317712, 21108.577828443344, 21125.0, 21372.145114195257, 21382.78617213808, 21508.247211347527, 8834.779130521789, 9094.0, 9110.681126160553, 9170.541472926327, 9284.72145835626, 4939.90120197594, 4989.847690411926, 5087.771050302746, 5101.438841727407, 5162.819301324435, 3550.1657110578994, 3646.9635303646623, 3676.28312479064, 3679.9448008279896, 3696.8706095286534, 650.8600650860088, 664.3655309179721, 668.6255696809802, 680.2483256002146, 684.4661164291861, 724.8876424154264, 734.2547314475811, 748.9251074892467, 757.2427572427572, 758.3213024343182, 9326.90673093274, 9397.71806845782, 9892.55483503244, 10014.899851001397, 10205.38767673942, 631.8294060603612, 712.5688958180226, 723.1141851232198, 735.9549439795503, 753.3671715758788, 4963.60291176705, 5058.595312375001, 5069.264956581275, 5077.644564880497, 5111.626630746633, 71539.6423017892, 85600.57199714085, 108922.0, 115786.0, 117245.0, 98178.0, 99558.0, 100299.0, 101259.0, 102010.0, 77904.61047694726, 81170.0, 83596.0, 90524.54737726269, 90983.0, 10292.834767437154, 10342.172626190037, 10478.685639430829, 10566.471676416302, 10623.628173014216, 49423.25865111954, 51569.22646160235, 51941.7402912983, 52288.0, 53002.0, 50269.49730502648, 51025.48974510207, 57808.71095644495, 76923.0, 78042.2195778035, 13336.733265334833, 13408.463661453432, 13647.38586763618, 13986.230757308038, 14037.859621404064, 14809.92595037018, 15227.238638068275, 15423.0, 15574.377024918876, 15756.684866302381, 14513.346899389764, 14526.20105894186, 14585.854141458874, 14863.777043344575, 15213.467528636887, 14277.928610357298, 14561.199134047729, 14636.707265854837, 14807.481738139113, 14926.0, 14137.646558836112, 14350.856491434952, 14413.279336033365, 14824.888133390255, 15351.923240383727, 11005.65851321818, 11158.163137764537, 11260.38067906273, 11385.772284554097, 11693.88306116928, 12030.458629361525, 12080.697982550506, 12365.690857728629, 12433.12968092225, 12451.073997610372], "value": 7833.50231981964, "unit": "score"}], "name": "dromaeo_css", "value": 7460.987789747153, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 111.0, 111.0, 111.0, 111.0, 110.0, 109.0, 112.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 120.0, 176.0, 126.0, 119.0, 145.0, 118.0, 148.0, 117.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 162.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 132.0, 75.0, 75.0, 74.0, 74.0, 104.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 117.0, 84.0, 83.0, 84.0, 120.0, 84.0, 84.0, 127.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 63.0, 54.0, 53.0, 53.0, 54.0, 52.0, 53.0, 53.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 84.0, 77.0, 79.0, 86.0, 81.0, 75.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 121.0, 119.0, 119.0, 123.0, 123.0, 121.0, 119.0, 192.0, 121.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 153.0, 156.0, 153.0, 156.0, 155.0, 154.0, 157.0, 158.0, 156.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 71.0, 62.0, 63.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1481.6, "alertThreshold": 2.0}]} 01:27:53 INFO - Return code: 0 01:27:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:27:53 INFO - # TBPL SUCCESS # 01:27:53 INFO - Running post-action listener: _resource_record_post_action 01:27:53 INFO - ##### 01:27:53 INFO - ##### Finished run-tests step (success) 01:27:53 INFO - ##### 01:27:53 INFO - Running post-run listener: _resource_record_post_run 01:27:53 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 552783872; Read time: 160; Write time: 490004 01:27:53 INFO - TinderboxPrint: CPU usage
13.0% 01:27:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 160 01:27:53 INFO - TinderboxPrint: I/O write bytes / time
552,783,872 / 490,004 01:27:53 INFO - TinderboxPrint: CPU idle
8,273.0 (87.0%) 01:27:53 INFO - TinderboxPrint: CPU user
1,196.1 (12.6%) 01:27:53 INFO - TinderboxPrint: Swap in / out
0 / 0 01:27:53 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256536576; Read time: 0; Write time: 312072 01:27:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296005632; Read time: 148; Write time: 177904 01:27:54 INFO - Running post-run listener: _upload_blobber_files 01:27:54 INFO - Blob upload gear active. 01:27:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:27:54 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 01:27:54 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'] 01:27:54 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 01:27:54 INFO - (blobuploader) - INFO - Open directory for files ... 01:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:55 INFO - (blobuploader) - INFO - Done attempting. 01:27:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:59 INFO - (blobuploader) - INFO - Done attempting. 01:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:59 INFO - (blobuploader) - INFO - Done attempting. 01:27:59 INFO - (blobuploader) - INFO - Iteration through files over. 01:27:59 INFO - Return code: 0 01:27:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:27:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:27:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e458cb0f8660cf4deb09605b55d2f232b038ce92608ad32f4b37805659a70389125120ebcae1271ea1bfa0dec27ebe5d9fa513849053617e2aba86de963a8459", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcaf36ecb54a2535577ba22f5a13b6fb5f2d3f5c9b9c144ae386c20451202d69e52a49c700f36015c264048af393d5245714ffb655a01abcb861211d3827e9e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a04fed6d3e9c2fa2fdcbd6afe05191a7ea07d0e7195e6ec1e1dcf0f3b0c575f66ef9f5912f98e24a26da81e377b5a7bbb8633087339f725d6b519a01fd2d4901"} 01:27:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:27:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:27:59 INFO - Contents: 01:27:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e458cb0f8660cf4deb09605b55d2f232b038ce92608ad32f4b37805659a70389125120ebcae1271ea1bfa0dec27ebe5d9fa513849053617e2aba86de963a8459", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcaf36ecb54a2535577ba22f5a13b6fb5f2d3f5c9b9c144ae386c20451202d69e52a49c700f36015c264048af393d5245714ffb655a01abcb861211d3827e9e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a04fed6d3e9c2fa2fdcbd6afe05191a7ea07d0e7195e6ec1e1dcf0f3b0c575f66ef9f5912f98e24a26da81e377b5a7bbb8633087339f725d6b519a01fd2d4901"} 01:27:59 INFO - Running post-run listener: copy_logs_to_upload_dir 01:27:59 INFO - Copying logs to upload dir... 01:27:59 INFO - mkdir: /builds/slave/test/build/upload/logs 01:27:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.762455 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-08 01:27:58.931883) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 01:27:58.935647) ========= 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=cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546 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/e458cb0f8660cf4deb09605b55d2f232b038ce92608ad32f4b37805659a70389125120ebcae1271ea1bfa0dec27ebe5d9fa513849053617e2aba86de963a8459", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcaf36ecb54a2535577ba22f5a13b6fb5f2d3f5c9b9c144ae386c20451202d69e52a49c700f36015c264048af393d5245714ffb655a01abcb861211d3827e9e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a04fed6d3e9c2fa2fdcbd6afe05191a7ea07d0e7195e6ec1e1dcf0f3b0c575f66ef9f5912f98e24a26da81e377b5a7bbb8633087339f725d6b519a01fd2d4901"} build_url:https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/B8LsiWaUSDSXLstvgl_fjg/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/e458cb0f8660cf4deb09605b55d2f232b038ce92608ad32f4b37805659a70389125120ebcae1271ea1bfa0dec27ebe5d9fa513849053617e2aba86de963a8459", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcaf36ecb54a2535577ba22f5a13b6fb5f2d3f5c9b9c144ae386c20451202d69e52a49c700f36015c264048af393d5245714ffb655a01abcb861211d3827e9e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a04fed6d3e9c2fa2fdcbd6afe05191a7ea07d0e7195e6ec1e1dcf0f3b0c575f66ef9f5912f98e24a26da81e377b5a7bbb8633087339f725d6b519a01fd2d4901"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 01:27:58.962401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:27:58.962710) ========= 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=cbe409c6de289db6ac707de3000001d4-1467964975.709153-386496546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 01:27:59.048083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 01:27:59.048659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 01:27:59.049191) ========= ========= Total master_lag: 0.18 =========