builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1467912991.14 results: success (0) buildid: 20160707073127 builduid: 56727a95bf1a4cc29f16a2b7f1026d03 revision: c465467931d3806df0a28d3351d6eb15351b561a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.144615) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.145102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.145377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.161436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.161826) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 10:36:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.9M=0s 2016-07-07 10:36:31 (96.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.297852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.298176) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016397 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.348102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:31.348457) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c465467931d3806df0a28d3351d6eb15351b561a --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 c465467931d3806df0a28d3351d6eb15351b561a --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=9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 10:36:31,812 truncating revision to first 12 chars 2016-07-07 10:36:31,812 Setting DEBUG logging. 2016-07-07 10:36:31,812 attempt 1/10 2016-07-07 10:36:31,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c465467931d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 10:36:32,140 unpacking tar archive at: mozilla-inbound-c465467931d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663764 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:32.026008) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:32.026341) ========= script_repo_revision: c465467931d3806df0a28d3351d6eb15351b561a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:32.026714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:32.026984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 10:36:32.036391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-07 10:36:32.036698) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:36:32 INFO - MultiFileLogger online at 20160707 10:36:32 in /builds/slave/test 10:36:32 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 10:36:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:36:32 INFO - {'append_to_log': False, 10:36:32 INFO - 'base_work_dir': '/builds/slave/test', 10:36:32 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:36:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:36:32 INFO - 'branch': 'Mozilla-Inbound', 10:36:32 INFO - 'buildbot_json_path': 'buildprops.json', 10:36:32 INFO - 'config_files': ('talos/linux_config.py',), 10:36:32 INFO - 'default_actions': ('clobber', 10:36:32 INFO - 'read-buildbot-config', 10:36:32 INFO - 'download-and-extract', 10:36:32 INFO - 'populate-webroot', 10:36:32 INFO - 'create-virtualenv', 10:36:32 INFO - 'install', 10:36:32 INFO - 'run-tests'), 10:36:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:36:32 INFO - 'download_minidump_stackwalk': True, 10:36:32 INFO - 'download_symbols': 'ondemand', 10:36:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:36:32 INFO - 'tooltool.py': '/tools/tooltool.py', 10:36:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:36:32 INFO - '/tools/misc-python/virtualenv.py')}, 10:36:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:36:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:36:32 INFO - 'installer_path': 'installer.exe', 10:36:32 INFO - 'log_level': 'info', 10:36:32 INFO - 'log_name': 'talos', 10:36:32 INFO - 'log_to_console': True, 10:36:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:36:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:36:32 INFO - 'opt_config_files': (), 10:36:32 INFO - 'pip_index': False, 10:36:32 INFO - 'sps_profile': False, 10:36:32 INFO - 'sps_profile_interval': 0, 10:36:32 INFO - 'suite': 'dromaeojs', 10:36:32 INFO - 'system_bits': '32', 10:36:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:36:32 INFO - 'title': 'talos-linux64-ix-022', 10:36:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:36:32 INFO - 'use_talos_json': True, 10:36:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:36:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:36:32 INFO - 'work_dir': 'build'} 10:36:32 INFO - ##### 10:36:32 INFO - ##### Running clobber step. 10:36:32 INFO - ##### 10:36:32 INFO - Running pre-action listener: _resource_record_pre_action 10:36:32 INFO - Running main action method: clobber 10:36:32 INFO - rmtree: /builds/slave/test/build 10:36:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:36:33 INFO - Running post-action listener: _resource_record_post_action 10:36:33 INFO - ##### 10:36:33 INFO - ##### Finished clobber step (success) 10:36:33 INFO - ##### 10:36:33 INFO - ##### 10:36:33 INFO - ##### Running read-buildbot-config step. 10:36:33 INFO - ##### 10:36:33 INFO - Running pre-action listener: _resource_record_pre_action 10:36:33 INFO - Running main action method: read_buildbot_config 10:36:33 INFO - Using buildbot properties: 10:36:33 INFO - { 10:36:33 INFO - "project": "", 10:36:33 INFO - "product": "firefox", 10:36:33 INFO - "script_repo_revision": "production", 10:36:33 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:36:33 INFO - "repository": "", 10:36:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:36:33 INFO - "buildid": "20160707073127", 10:36:33 INFO - "pgo_build": "True", 10:36:33 INFO - "basedir": "/builds/slave/test", 10:36:33 INFO - "buildnumber": 2036, 10:36:33 INFO - "slavename": "talos-linux64-ix-022", 10:36:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:36:33 INFO - "platform": "ubuntu64_hw", 10:36:33 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:36:33 INFO - "branch": "mozilla-inbound", 10:36:33 INFO - "repo_path": "integration/mozilla-inbound", 10:36:33 INFO - "revision": "c465467931d3806df0a28d3351d6eb15351b561a", 10:36:33 INFO - "stage_platform": "linux64-pgo", 10:36:33 INFO - "builduid": "56727a95bf1a4cc29f16a2b7f1026d03", 10:36:33 INFO - "slavebuilddir": "test" 10:36:33 INFO - } 10:36:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:36:33 INFO - Running post-action listener: _resource_record_post_action 10:36:33 INFO - ##### 10:36:33 INFO - ##### Finished read-buildbot-config step (success) 10:36:33 INFO - ##### 10:36:33 INFO - ##### 10:36:33 INFO - ##### Running download-and-extract step. 10:36:33 INFO - ##### 10:36:33 INFO - Running pre-action listener: _resource_record_pre_action 10:36:33 INFO - Running main action method: download_and_extract 10:36:33 INFO - mkdir: /builds/slave/test/build/tests 10:36: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')]} 10:36:33 INFO - https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:36:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:36:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:36:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:33 INFO - Downloaded 1361 bytes. 10:36:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:36:33 INFO - Using the following test package requirements: 10:36:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:36:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:36:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:36:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'jsshell-linux-x86_64.zip'], 10:36:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:36:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:36:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:36:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:36:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:36:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:36:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:36: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')]} 10:36:33 INFO - https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:36:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:36:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:36:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:34 INFO - Downloaded 24304474 bytes. 10:36:34 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'] 10:36:34 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 10:36:36 INFO - Return code: 0 10:36:36 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 10:36: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')]} 10:36:36 INFO - https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:36:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:36:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:36:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:37 INFO - Downloaded 24304474 bytes. 10:36:37 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'] 10:36:37 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 10:36:38 INFO - Return code: 0 10:36:38 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')]} 10:36:38 INFO - https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:36:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:39 INFO - Downloaded 14403333 bytes. 10:36:39 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'] 10:36:39 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 10:36:39 INFO - Return code: 0 10:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:39 INFO - https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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 10:36:41 INFO - Downloaded 60449990 bytes. 10:36:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:36:41 INFO - mkdir: /builds/slave/test/properties 10:36:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:36:41 INFO - Writing to file /builds/slave/test/properties/build_url 10:36:41 INFO - Contents: 10:36:41 INFO - build_url:https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:36:41 INFO - Running post-action listener: _resource_record_post_action 10:36:41 INFO - Running post-action listener: set_extra_try_arguments 10:36:41 INFO - ##### 10:36:41 INFO - ##### Finished download-and-extract step (success) 10:36:41 INFO - ##### 10:36:41 INFO - ##### 10:36:41 INFO - ##### Running populate-webroot step. 10:36:41 INFO - ##### 10:36:41 INFO - Running pre-action listener: _resource_record_pre_action 10:36:41 INFO - Running main action method: populate_webroot 10:36:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:36:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:36:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:36:42 INFO - '--tppagecycles', 10:36:42 INFO - '7'], 10:36:42 INFO - 'tests': ['tsvgm']}}, 10:36:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:36:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:36:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:36:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:36:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['damp', 'tps']}, 10:36:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'tests': ['damp', 'tps']}, 10:36:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['dromaeo_dom']}, 10:36:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:36:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['basic_compositor_video']}, 10:36:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:36:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['a11yr', 10:36:42 INFO - 'ts_paint', 10:36:42 INFO - 'tpaint', 10:36:42 INFO - 'sessionrestore', 10:36:42 INFO - 'sessionrestore_no_auto_restore', 10:36:42 INFO - 'tabpaint']}, 10:36:42 INFO - 'other-e10s': {'tests': ['a11yr', 10:36:42 INFO - 'ts_paint', 10:36:42 INFO - 'tpaint', 10:36:42 INFO - 'sessionrestore', 10:36:42 INFO - 'sessionrestore_no_auto_restore', 10:36:42 INFO - 'tabpaint']}, 10:36:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:36:42 INFO - 'ts_paint', 10:36:42 INFO - 'tpaint', 10:36:42 INFO - 'sessionrestore', 10:36:42 INFO - 'sessionrestore_no_auto_restore', 10:36:42 INFO - 'tabpaint']}, 10:36:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:36:42 INFO - 'ts_paint', 10:36:42 INFO - 'tpaint', 10:36:42 INFO - 'sessionrestore', 10:36:42 INFO - 'sessionrestore_no_auto_restore', 10:36:42 INFO - 'tabpaint']}, 10:36:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['a11yr', 10:36:42 INFO - 'ts_paint', 10:36:42 INFO - 'tpaint', 10:36:42 INFO - 'sessionrestore', 10:36:42 INFO - 'sessionrestore_no_auto_restore', 10:36:42 INFO - 'tabpaint']}, 10:36:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['a11yr', 10:36:42 INFO - 'ts_paint', 10:36:42 INFO - 'tpaint', 10:36:42 INFO - 'sessionrestore', 10:36:42 INFO - 'sessionrestore_no_auto_restore', 10:36:42 INFO - 'tabpaint']}, 10:36:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['tsvgx', 10:36:42 INFO - 'tsvgr_opacity', 10:36:42 INFO - 'tart', 10:36:42 INFO - 'tscrollx', 10:36:42 INFO - 'cart']}, 10:36:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:36:42 INFO - 'tsvgr_opacity', 10:36:42 INFO - 'tart', 10:36:42 INFO - 'tscrollx', 10:36:42 INFO - 'cart']}, 10:36:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'talos_options': ['--disable-e10s'], 10:36:42 INFO - 'tests': ['tp5o']}, 10:36:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'tests': ['tp5o']}, 10:36:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'talos_options': ['--disable-e10s', 10:36:42 INFO - '--xperf_path', 10:36:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:42 INFO - 'tests': ['tp5n']}, 10:36:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:42 INFO - 'talos_options': ['--xperf_path', 10:36:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:42 INFO - 'tests': ['tp5n']}}, 10:36:42 INFO - 'talos.zip': {'path': '', 10:36:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:36:42 INFO - Running post-action listener: _resource_record_post_action 10:36:42 INFO - ##### 10:36:42 INFO - ##### Finished populate-webroot step (success) 10:36:42 INFO - ##### 10:36:42 INFO - ##### 10:36:42 INFO - ##### Running create-virtualenv step. 10:36:42 INFO - ##### 10:36:42 INFO - Running pre-action listener: _resource_record_pre_action 10:36:42 INFO - Running main action method: create_virtualenv 10:36:42 INFO - Creating virtualenv /builds/slave/test/build/venv 10:36:42 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 10:36:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:36:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:36:42 INFO - Using real prefix '/usr' 10:36:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:36:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:36:44 INFO - Installing pip.................done. 10:36:44 INFO - Return code: 0 10:36:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:36:44 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 10:36:44 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 10:36:44 INFO - Using env: {'DISPLAY': ':0', 10:36:44 INFO - 'HOME': '/home/cltbld', 10:36:44 INFO - 'LANG': 'en_US.UTF-8', 10:36:44 INFO - 'LANGUAGE': 'en_US:en', 10:36:44 INFO - 'LOGNAME': 'cltbld', 10:36:44 INFO - 'MAIL': '/var/mail/cltbld', 10:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:44 INFO - 'MOZ_NO_REMOTE': '1', 10:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:44 INFO - 'NO_EM_RESTART': '1', 10:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:44 INFO - 'PWD': '/builds/slave/test', 10:36:44 INFO - 'SHELL': '/bin/bash', 10:36:44 INFO - 'SHLVL': '1', 10:36:44 INFO - 'TERM': 'linux', 10:36:44 INFO - 'TMOUT': '86400', 10:36:44 INFO - 'USER': 'cltbld', 10:36:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:44 INFO - '_': '/tools/buildbot/bin/python'} 10:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:44 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 10:36:44 INFO - Cleaning up... 10:36:44 INFO - Return code: 0 10:36:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:36:44 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 10:36:44 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 10:36:44 INFO - Using env: {'DISPLAY': ':0', 10:36:44 INFO - 'HOME': '/home/cltbld', 10:36:44 INFO - 'LANG': 'en_US.UTF-8', 10:36:44 INFO - 'LANGUAGE': 'en_US:en', 10:36:44 INFO - 'LOGNAME': 'cltbld', 10:36:44 INFO - 'MAIL': '/var/mail/cltbld', 10:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:44 INFO - 'MOZ_NO_REMOTE': '1', 10:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:44 INFO - 'NO_EM_RESTART': '1', 10:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:44 INFO - 'PWD': '/builds/slave/test', 10:36:44 INFO - 'SHELL': '/bin/bash', 10:36:44 INFO - 'SHLVL': '1', 10:36:44 INFO - 'TERM': 'linux', 10:36:44 INFO - 'TMOUT': '86400', 10:36:44 INFO - 'USER': 'cltbld', 10:36:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:44 INFO - '_': '/tools/buildbot/bin/python'} 10:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:45 INFO - Downloading/unpacking psutil>=3.1.1 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:47 INFO - Installing collected packages: psutil 10:36:47 INFO - Running setup.py install for psutil 10:36:47 INFO - building 'psutil._psutil_linux' extension 10:36:47 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 10:36:47 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 10:36:47 INFO - building 'psutil._psutil_posix' extension 10:36:47 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 10:36:47 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 10:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:47 INFO - Successfully installed psutil 10:36:47 INFO - Cleaning up... 10:36:47 INFO - Return code: 0 10:36:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:36: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')]} 10:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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')]} 10:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:36: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 mozsystemmonitor==0.3 10:36:47 INFO - Using env: {'DISPLAY': ':0', 10:36:47 INFO - 'HOME': '/home/cltbld', 10:36:47 INFO - 'LANG': 'en_US.UTF-8', 10:36:47 INFO - 'LANGUAGE': 'en_US:en', 10:36:47 INFO - 'LOGNAME': 'cltbld', 10:36:47 INFO - 'MAIL': '/var/mail/cltbld', 10:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:47 INFO - 'MOZ_NO_REMOTE': '1', 10:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:47 INFO - 'NO_EM_RESTART': '1', 10:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:47 INFO - 'PWD': '/builds/slave/test', 10:36:47 INFO - 'SHELL': '/bin/bash', 10:36:47 INFO - 'SHLVL': '1', 10:36:47 INFO - 'TERM': 'linux', 10:36:47 INFO - 'TMOUT': '86400', 10:36:47 INFO - 'USER': 'cltbld', 10:36:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:47 INFO - '_': '/tools/buildbot/bin/python'} 10:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:36:49 INFO - Installing collected packages: mozsystemmonitor 10:36:49 INFO - Running setup.py install for mozsystemmonitor 10:36:49 INFO - Successfully installed mozsystemmonitor 10:36:49 INFO - Cleaning up... 10:36:49 INFO - Return code: 0 10:36:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:49 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:36:49 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 10:36:49 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 10:36:49 INFO - Using env: {'DISPLAY': ':0', 10:36:49 INFO - 'HOME': '/home/cltbld', 10:36:49 INFO - 'LANG': 'en_US.UTF-8', 10:36:49 INFO - 'LANGUAGE': 'en_US:en', 10:36:49 INFO - 'LOGNAME': 'cltbld', 10:36:49 INFO - 'MAIL': '/var/mail/cltbld', 10:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:49 INFO - 'MOZ_NO_REMOTE': '1', 10:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:49 INFO - 'NO_EM_RESTART': '1', 10:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:49 INFO - 'PWD': '/builds/slave/test', 10:36:49 INFO - 'SHELL': '/bin/bash', 10:36:49 INFO - 'SHLVL': '1', 10:36:49 INFO - 'TERM': 'linux', 10:36:49 INFO - 'TMOUT': '86400', 10:36:49 INFO - 'USER': 'cltbld', 10:36:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:49 INFO - '_': '/tools/buildbot/bin/python'} 10:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:50 INFO - Downloading/unpacking jsonschema==2.5.1 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:36:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:52 INFO - Downloading functools32-3.2.3-2.tar.gz 10:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:36:52 INFO - warning: no files found matching '*.txt' 10:36:52 INFO - no previously-included directories found matching 'build' 10:36:52 INFO - no previously-included directories found matching 'dist' 10:36:52 INFO - no previously-included directories found matching '.git*' 10:36:52 INFO - Installing collected packages: jsonschema, functools32 10:36:52 INFO - Running setup.py install for functools32 10:36:52 INFO - warning: no files found matching '*.txt' 10:36:52 INFO - no previously-included directories found matching 'build' 10:36:52 INFO - no previously-included directories found matching 'dist' 10:36:52 INFO - no previously-included directories found matching '.git*' 10:36:52 INFO - Successfully installed jsonschema functools32 10:36:52 INFO - Cleaning up... 10:36:52 INFO - Return code: 0 10:36:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:52 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:36:52 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 10:36:52 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 10:36:52 INFO - Using env: {'DISPLAY': ':0', 10:36:52 INFO - 'HOME': '/home/cltbld', 10:36:52 INFO - 'LANG': 'en_US.UTF-8', 10:36:52 INFO - 'LANGUAGE': 'en_US:en', 10:36:52 INFO - 'LOGNAME': 'cltbld', 10:36:52 INFO - 'MAIL': '/var/mail/cltbld', 10:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:52 INFO - 'MOZ_NO_REMOTE': '1', 10:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:52 INFO - 'NO_EM_RESTART': '1', 10:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:52 INFO - 'PWD': '/builds/slave/test', 10:36:52 INFO - 'SHELL': '/bin/bash', 10:36:52 INFO - 'SHLVL': '1', 10:36:52 INFO - 'TERM': 'linux', 10:36:52 INFO - 'TMOUT': '86400', 10:36:52 INFO - 'USER': 'cltbld', 10:36:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:52 INFO - '_': '/tools/buildbot/bin/python'} 10:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:36:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:36:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:55 INFO - Downloading docopt-0.6.1.tar.gz 10:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:36:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:36:55 INFO - Running setup.py install for blobuploader 10:36:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:36:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:36:55 INFO - Running setup.py install for requests 10:36:55 INFO - Running setup.py install for docopt 10:36:55 INFO - Successfully installed blobuploader requests docopt 10:36:55 INFO - Cleaning up... 10:36:55 INFO - Return code: 0 10:36:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:55 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:36:55 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 10:36:55 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 10:36:55 INFO - Using env: {'DISPLAY': ':0', 10:36:55 INFO - 'HOME': '/home/cltbld', 10:36:55 INFO - 'LANG': 'en_US.UTF-8', 10:36:55 INFO - 'LANGUAGE': 'en_US:en', 10:36:55 INFO - 'LOGNAME': 'cltbld', 10:36:55 INFO - 'MAIL': '/var/mail/cltbld', 10:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:55 INFO - 'MOZ_NO_REMOTE': '1', 10:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:55 INFO - 'NO_EM_RESTART': '1', 10:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:55 INFO - 'PWD': '/builds/slave/test', 10:36:55 INFO - 'SHELL': '/bin/bash', 10:36:55 INFO - 'SHLVL': '1', 10:36:55 INFO - 'TERM': 'linux', 10:36:55 INFO - 'TMOUT': '86400', 10:36:55 INFO - 'USER': 'cltbld', 10:36:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:55 INFO - '_': '/tools/buildbot/bin/python'} 10:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:56 INFO - Running setup.py (path:/tmp/pip-RMsPie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:56 INFO - Running setup.py (path:/tmp/pip-D4h81J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:56 INFO - Running setup.py (path:/tmp/pip-XFMBMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:56 INFO - Running setup.py (path:/tmp/pip-kBvH9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:56 INFO - Running setup.py (path:/tmp/pip-YQ9EBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:56 INFO - Running setup.py (path:/tmp/pip-huvmb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:56 INFO - Running setup.py (path:/tmp/pip-m6ln4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:56 INFO - Running setup.py (path:/tmp/pip-l4HKAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:56 INFO - Running setup.py (path:/tmp/pip-moO33i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:56 INFO - Running setup.py (path:/tmp/pip-gavRXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:56 INFO - Running setup.py (path:/tmp/pip-VJBoE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:56 INFO - Running setup.py (path:/tmp/pip-O9v2Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:57 INFO - Running setup.py (path:/tmp/pip-5BQw8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:57 INFO - Running setup.py (path:/tmp/pip-CJs5eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:57 INFO - Running setup.py (path:/tmp/pip-5xW9J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:57 INFO - Running setup.py (path:/tmp/pip-q6F44j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:57 INFO - Running setup.py (path:/tmp/pip-YBz9Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:36:57 INFO - Running setup.py install for manifestparser 10:36:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:36:57 INFO - Running setup.py install for mozcrash 10:36:57 INFO - Running setup.py install for mozdebug 10:36:57 INFO - Running setup.py install for mozdevice 10:36:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:36:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:36:57 INFO - Running setup.py install for mozfile 10:36:57 INFO - Running setup.py install for mozhttpd 10:36:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Running setup.py install for mozinfo 10:36:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Running setup.py install for mozInstall 10:36:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Running setup.py install for mozleak 10:36:58 INFO - Running setup.py install for mozlog 10:36:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Running setup.py install for moznetwork 10:36:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Running setup.py install for mozprocess 10:36:58 INFO - Running setup.py install for mozprofile 10:36:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Running setup.py install for mozrunner 10:36:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:36:58 INFO - Running setup.py install for mozscreenshot 10:36:58 INFO - Running setup.py install for moztest 10:36:59 INFO - Running setup.py install for mozversion 10:36:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:36:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:36:59 INFO - Cleaning up... 10:36:59 INFO - Return code: 0 10:36:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:59 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')]} 10:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:59 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')]} 10:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:59 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:36:59 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 10:36:59 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 10:36:59 INFO - Using env: {'DISPLAY': ':0', 10:36:59 INFO - 'HOME': '/home/cltbld', 10:36:59 INFO - 'LANG': 'en_US.UTF-8', 10:36:59 INFO - 'LANGUAGE': 'en_US:en', 10:36:59 INFO - 'LOGNAME': 'cltbld', 10:36:59 INFO - 'MAIL': '/var/mail/cltbld', 10:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:59 INFO - 'MOZ_NO_REMOTE': '1', 10:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:59 INFO - 'NO_EM_RESTART': '1', 10:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:59 INFO - 'PWD': '/builds/slave/test', 10:36:59 INFO - 'SHELL': '/bin/bash', 10:36:59 INFO - 'SHLVL': '1', 10:36:59 INFO - 'TERM': 'linux', 10:36:59 INFO - 'TMOUT': '86400', 10:36:59 INFO - 'USER': 'cltbld', 10:36:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:59 INFO - '_': '/tools/buildbot/bin/python'} 10:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:59 INFO - Running setup.py (path:/tmp/pip-78zI7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:59 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)) 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:59 INFO - Running setup.py (path:/tmp/pip-T9RJYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:59 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)) 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:59 INFO - Running setup.py (path:/tmp/pip-F9mivA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:59 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)) 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:59 INFO - Running setup.py (path:/tmp/pip-3c6Umr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:59 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)) 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:59 INFO - Running setup.py (path:/tmp/pip-bh5kzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:59 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)) 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:59 INFO - Running setup.py (path:/tmp/pip-opLupM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:59 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)) 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:59 INFO - Running setup.py (path:/tmp/pip-621_Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:59 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)) 10:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:59 INFO - Running setup.py (path:/tmp/pip-Ow31Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:00 INFO - Running setup.py (path:/tmp/pip-WSd8Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:00 INFO - Running setup.py (path:/tmp/pip-NPd54y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:00 INFO - Running setup.py (path:/tmp/pip-tWkhIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:00 INFO - Running setup.py (path:/tmp/pip-AnHJrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:00 INFO - Running setup.py (path:/tmp/pip-f97KaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:00 INFO - Running setup.py (path:/tmp/pip-aKrx3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:00 INFO - Running setup.py (path:/tmp/pip-S4v8FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:00 INFO - Running setup.py (path:/tmp/pip-TQs3tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:00 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)) 10:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:00 INFO - Running setup.py (path:/tmp/pip-1GPiI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:00 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)) 10:37:00 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)) 10:37:00 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)) 10:37:00 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)) 10:37:00 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)) 10:37:00 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)) 10:37:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:02 INFO - Downloading blessings-1.6.tar.gz 10:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:37:02 INFO - Installing collected packages: blessings 10:37:02 INFO - Running setup.py install for blessings 10:37:02 INFO - Successfully installed blessings 10:37:02 INFO - Cleaning up... 10:37:02 INFO - Return code: 0 10:37:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:03 INFO - Reading from file tmpfile_stdout 10:37:03 INFO - Current package versions: 10:37:03 INFO - argparse == 1.2.1 10:37:03 INFO - blessings == 1.6 10:37:03 INFO - blobuploader == 1.2.4 10:37:03 INFO - docopt == 0.6.1 10:37:03 INFO - functools32 == 3.2.3-2 10:37:03 INFO - jsonschema == 2.5.1 10:37:03 INFO - manifestparser == 1.1 10:37:03 INFO - mozInstall == 1.12 10:37:03 INFO - mozcrash == 0.17 10:37:03 INFO - mozdebug == 0.1 10:37:03 INFO - mozdevice == 0.48 10:37:03 INFO - mozfile == 1.2 10:37:03 INFO - mozhttpd == 0.7 10:37:03 INFO - mozinfo == 0.9 10:37:03 INFO - mozleak == 0.1 10:37:03 INFO - mozlog == 3.2 10:37:03 INFO - moznetwork == 0.27 10:37:03 INFO - mozprocess == 0.23 10:37:03 INFO - mozprofile == 0.28 10:37:03 INFO - mozrunner == 6.12 10:37:03 INFO - mozscreenshot == 0.1 10:37:03 INFO - mozsystemmonitor == 0.3 10:37:03 INFO - moztest == 0.7 10:37:03 INFO - mozversion == 1.4 10:37:03 INFO - psutil == 3.1.1 10:37:03 INFO - requests == 1.2.3 10:37:03 INFO - wsgiref == 0.1.2 10:37:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:03 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')]} 10:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:03 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')]} 10:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:03 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:37:03 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 10:37:03 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 10:37:03 INFO - Using env: {'DISPLAY': ':0', 10:37:03 INFO - 'HOME': '/home/cltbld', 10:37:03 INFO - 'LANG': 'en_US.UTF-8', 10:37:03 INFO - 'LANGUAGE': 'en_US:en', 10:37:03 INFO - 'LOGNAME': 'cltbld', 10:37:03 INFO - 'MAIL': '/var/mail/cltbld', 10:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:03 INFO - 'MOZ_NO_REMOTE': '1', 10:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:03 INFO - 'NO_EM_RESTART': '1', 10:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:03 INFO - 'PWD': '/builds/slave/test', 10:37:03 INFO - 'SHELL': '/bin/bash', 10:37:03 INFO - 'SHLVL': '1', 10:37:03 INFO - 'TERM': 'linux', 10:37:03 INFO - 'TMOUT': '86400', 10:37:03 INFO - 'USER': 'cltbld', 10:37:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:03 INFO - '_': '/tools/buildbot/bin/python'} 10:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 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)) 10:37:03 INFO - Cleaning up... 10:37:03 INFO - Return code: 0 10:37:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:37:03 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')]} 10:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:03 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')]} 10:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:03 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 0x208b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', '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 10:37:03 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 10:37:03 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 10:37:03 INFO - Using env: {'DISPLAY': ':0', 10:37:03 INFO - 'HOME': '/home/cltbld', 10:37:03 INFO - 'LANG': 'en_US.UTF-8', 10:37:03 INFO - 'LANGUAGE': 'en_US:en', 10:37:03 INFO - 'LOGNAME': 'cltbld', 10:37:03 INFO - 'MAIL': '/var/mail/cltbld', 10:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:03 INFO - 'MOZ_NO_REMOTE': '1', 10:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:03 INFO - 'NO_EM_RESTART': '1', 10:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:03 INFO - 'PWD': '/builds/slave/test', 10:37:03 INFO - 'SHELL': '/bin/bash', 10:37:03 INFO - 'SHLVL': '1', 10:37:03 INFO - 'TERM': 'linux', 10:37:03 INFO - 'TMOUT': '86400', 10:37:03 INFO - 'USER': 'cltbld', 10:37:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:03 INFO - '_': '/tools/buildbot/bin/python'} 10:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:37:03 INFO - Cleaning up... 10:37:03 INFO - Return code: 0 10:37:03 INFO - Running post-action listener: _resource_record_post_action 10:37:03 INFO - Running post-action listener: _start_resource_monitoring 10:37:03 INFO - Starting resource monitoring. 10:37:03 INFO - ##### 10:37:03 INFO - ##### Finished create-virtualenv step (success) 10:37:03 INFO - ##### 10:37:03 INFO - ##### 10:37:03 INFO - ##### Running install step. 10:37:03 INFO - ##### 10:37:03 INFO - Running pre-action listener: _resource_record_pre_action 10:37:03 INFO - Running main action method: install 10:37:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:03 INFO - Reading from file tmpfile_stdout 10:37:03 INFO - Detecting whether we're running mozinstall >=1.0... 10:37:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:37:03 INFO - Reading from file tmpfile_stdout 10:37:03 INFO - Output received: 10:37:03 INFO - Usage: mozinstall [options] installer 10:37:03 INFO - Options: 10:37:03 INFO - -h, --help show this help message and exit 10:37:03 INFO - -d DEST, --destination=DEST 10:37:03 INFO - Directory to install application into. [default: 10:37:03 INFO - "/builds/slave/test"] 10:37:03 INFO - --app=APP Application being installed. [default: firefox] 10:37:03 INFO - mkdir: /builds/slave/test/build/application 10:37:03 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'] 10:37:03 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 10:37:20 INFO - Reading from file tmpfile_stdout 10:37:20 INFO - Output received: 10:37:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:37:20 INFO - Running post-action listener: _resource_record_post_action 10:37:20 INFO - ##### 10:37:20 INFO - ##### Finished install step (success) 10:37:20 INFO - ##### 10:37:20 INFO - ##### 10:37:20 INFO - ##### Running run-tests step. 10:37:20 INFO - ##### 10:37:20 INFO - Running pre-action listener: _resource_record_pre_action 10:37:20 INFO - Running main action method: run_tests 10:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:37:20 INFO - Python 2.7.3 10:37:20 INFO - Return code: 0 10:37:20 INFO - grabbing minidump binary from tooltool 10:37: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')]} 10:37:20 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 0x234a3b0>, '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 0x234b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x234b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:37:20 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 10:37:20 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 10:37:20 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 10:37:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:37:21 INFO - Return code: 0 10:37:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:37:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:37:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:37:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:37:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:37:21 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/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:37:21 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/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 10:37:21 INFO - Using env: {'DISPLAY': ':0', 10:37:21 INFO - 'HOME': '/home/cltbld', 10:37:21 INFO - 'LANG': 'en_US.UTF-8', 10:37:21 INFO - 'LANGUAGE': 'en_US:en', 10:37:21 INFO - 'LOGNAME': 'cltbld', 10:37:21 INFO - 'MAIL': '/var/mail/cltbld', 10:37:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:37:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:21 INFO - 'MOZ_NO_REMOTE': '1', 10:37:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:21 INFO - 'NO_EM_RESTART': '1', 10:37:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:21 INFO - 'PWD': '/builds/slave/test', 10:37:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:37:21 INFO - 'SHELL': '/bin/bash', 10:37:21 INFO - 'SHLVL': '1', 10:37:21 INFO - 'TERM': 'linux', 10:37:21 INFO - 'TMOUT': '86400', 10:37:21 INFO - 'USER': 'cltbld', 10:37:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548', 10:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:21 INFO - '_': '/tools/buildbot/bin/python'} 10:37:21 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/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:37:21 INFO - mozversion application_buildid: 20160707073127 10:37:21 INFO - mozversion application_changeset: c465467931d3806df0a28d3351d6eb15351b561a 10:37:21 INFO - mozversion application_display_name: Nightly 10:37:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:21 INFO - mozversion application_name: Firefox 10:37:21 INFO - mozversion application_remotingname: firefox 10:37:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:37:21 INFO - mozversion application_vendor: Mozilla 10:37:21 INFO - mozversion application_version: 50.0a1 10:37:21 INFO - mozversion platform_buildid: 20160707073127 10:37:21 INFO - mozversion platform_changeset: c465467931d3806df0a28d3351d6eb15351b561a 10:37:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:37:21 INFO - mozversion platform_version: 50.0a1 10:37:21 INFO - using testdate: 1467913041 10:37:21 INFO - actual date: 1467913041 10:37:21 INFO - starting webserver on 'localhost:56083' 10:37:21 INFO - SUITE-START | Running 2 tests 10:37:21 INFO - TEST-START | dromaeo_css 10:37:21 INFO - operating with platform_type : linux_ 10:37:21 INFO - Initialising browser for dromaeo_css test... 10:37:21 INFO - TEST-INFO | started process 21582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdwPl1K/profile http://localhost:56083/getInfo.html) 10:37:25 INFO - PROCESS | 21582 | __metrics Screen width/height:1600/1200 10:37:25 INFO - PROCESS | 21582 | colorDepth:24 10:37:25 INFO - PROCESS | 21582 | Browser inner width/height: 1024/697 10:37:25 INFO - PROCESS | 21582 | __metrics 10:37:26 INFO - PROCESS | 21582 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:27 INFO - TEST-INFO | 21582: exit 0 10:37:27 INFO - Browser initialized. 10:37:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:37:27 INFO - TEST-INFO | started process 21663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdwPl1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:39 INFO - PROCESS | 21663 | RSS: Main: 157417472 10:37:39 INFO - PROCESS | 21663 | 10:38:30 INFO - PROCESS | 21663 | 1467913110005 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] 10:40:39 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:56083/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56083/tests/dromaeo/cssquery-ext.html) 10:40:40 INFO - PROCESS | 21663 | RSS: Main: 258039808 10:40:40 INFO - PROCESS | 21663 | 10:43:42 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:56083/tests/dromaeo/cssquery-ext.html (next: http://localhost:56083/tests/dromaeo/cssquery-jquery.html) 10:43:43 INFO - PROCESS | 21663 | RSS: Main: 240742400 10:43:43 INFO - PROCESS | 21663 | 10:46:44 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:56083/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56083/tests/dromaeo/cssquery-mootools.html) 10:46:45 INFO - PROCESS | 21663 | RSS: Main: 234549248 10:46:45 INFO - PROCESS | 21663 | 10:49:47 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:56083/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56083/tests/dromaeo/cssquery-prototype.html) 10:49:48 INFO - PROCESS | 21663 | RSS: Main: 230957056 10:49:48 INFO - PROCESS | 21663 | 10:52:50 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:56083/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56083/tests/dromaeo/cssquery-yui.html) 10:52:51 INFO - PROCESS | 21663 | RSS: Main: 202530816 10:52:51 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | Cycle 1(1): loaded http://localhost:56083/tests/dromaeo/cssquery-yui.html (next: http://localhost:56083/tests/dromaeo/cssquery-dojo.html) 10:55:54 INFO - PROCESS | 21663 | RSS: Main: 269520896 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | __start_tp_report 10:55:54 INFO - PROCESS | 21663 | _x_x_mozilla_page_load 10:55:54 INFO - PROCESS | 21663 | _x_x_mozilla_page_load_details 10:55:54 INFO - PROCESS | 21663 | |i|pagename|runs| 10:55:54 INFO - PROCESS | 21663 | |0;dojo.html;3055.7860949733517;3085.3212293295496;3128.85920133594;3133.561301417802;3152.9527057094133;5185;5254.710990895499;5371.462853714626;5486.561075113991;5509.00837849187;5347.25138480613;5364.302640656719;5380.650257733245;5390.245365648812;5425.159100339453;4861.927071093936;4898.461169271395;4949.480304568023;4957.553820156185;5095.898082038357;4990.675606085593;4997.150484417658;5044.092063428581;5049.823256186034;5057.898842023157;4847.054824309261;4880.17037103695;4921.827736029221;4922.680025798348;4932.630052746058;4895.853124406238;4923.852284431473;4925.679830810986;4959.280904268897;5009.599232061426;4920.680155789898;4944.505549445063;4953.281774142765;4962.404511458648;4998;5273.393559740641;5275.4460781618145;5344.839654810362;5377.247185394009;5431.864203394907;5798.884022319572;5805.680687562182;5840.649561026309;5842.591018628697;5847;5631.099024156157;5770.2210201622665;5851.736671849777;5902.527797776168;5919.408059194089;5403.324584426947;5442.673439593637;5458.590605704588;5462.562994960394;5464.371597266365;6006.519478441714;6017.969910150508;6019.067044608093;6022.5784195105925;6023;5562.721863906789;5582.441755824466;5646.096624540136;5753.712314384264;5756.30924289088;5751.22358481608;5758.3665796762325;5791.5656325775735;5804.593678442468;5809.535237181015;5734.541236701054;5737.340205876294;5740.712964351766;5742.885142297131;5746.166805813217;5570.136628822539;5729.914051289234;5746.712664366765;5786.2477877876445;5802.796902108406;4413.073254616503;4427.203103441347;4432.13573353193;4433.889152771142;4475.283954567253;3931.8230679619487;3942.15243722601;3951.585083566184;3998.7600743955454;4000.5599384067727;5285.392179899284;5296;5449.128139497661;5451.291332126798;5494.36814766299;5828.358880523139;5832.766689332464;5834.649921004753;5838.182654428383;5854.18041474194;5370.167624018205;5500.779968801203;5504.614676972574;5507.972460137674;5516.862078448071;5024.371953505812;5060.291559181717;5065.442801291855;5107.795688172506;5116.769745361467;6060.2424696912885;6063.575549711478;6064.969675151684;6065.363136870565;6079.422454866781;5644.604877658525;5742.569307301886;5853.560982926212;5869.4717475427415;5870.55970802183;5999.100134979788;6043.244594425697;6052.061930400795;6052.425019623129;6122.908156377569;5680.9147862781265;5735.254416925773;5739.540836732968;5744.540436765133;5755.395683453345;5646.689432081275;5761.942380576141;5798.652080875161;5846.970765146147;5864.882702345843;5668.801591944262;5690.174924635988;5691.23168372281;5697.829065128053;5737.225474560881;5638.5489160867855;5677.602567820213;5690.374058853606;5694.772209111589;5698.373178950395;5464.781408743605;5519.558435325084;5537.169424586184;5559.0827513461445;5623.2127502148915;5682.062459694104;5683.77264909399;5685.403032681675;5746.166805813217;5748.022836117786;5522.641028333145;5562.415946325739;5567.359753628384;5572.331320241597;5575.637583557218 10:55:54 INFO - PROCESS | 21663 | |1;ext.html;585.4175095779697;596.0790578556131;626.1265534579259;626.7461678020401;637.5027478566719;31579;43617.56382436175;44341;44406.55593444064;44411;46896.062078758405;47292.29061564079;47322.0535589288;47359.76320118403;47494.762526187405;8742.256908162813;8865.601047952825;8873.51195684237;8884.156005179497;8884.911150888505;8794.73615791524;8823.602937867812;8884.822303553925;8891.377603567753;8892.244159246471;8900.821983560325;8931.196192342688;8932.687355942544;8946.821063578724;8976.46141231525;8919.687810926618;8945.418547794372;8961.865572016424;8966.820663586757;8967.641294348217;8687.6524939003;8744.956275218583;8767;8774.692885749031;8776;44720;44953.325700114525;45125.54874451246;45182;45183.77408112971;3597.244578638463;3679.025058359537;3755.868544600926;3834.2331533693373;4111.671066314688;33320;33443;33881.15297117592;34209;34581.308373832384;4317.740935543878;4367.301231802896;4383.452068491439;4398.8020539075815;4477.104579084164;262818;262865;264777;265194;265374;34483.655163448544;60843.69578152081;61056.38943610596;61138;61152;35389.8230508851;36836;36926.63073369286;37056.25887482235;37106.257874842355;15354.925155239025;15643.765343519857;15656.765148522782;15680.215989200495;15680.607984800472;12984.740305193844;13039.739205215843;13109.475620975054;13119.606411807661;13123.343832808321;8296.917030829734;8337;8354.58227088643;8411.70559030431;8426.620802063922;3248.6751324867323;3273.918152046218;3277.6886195811358;3285.375778602058;3295.6374798772117;1008.3848852200299;1054.8892366301582;1058.714147180257;1136.0797753819434;1140.6635042662435;33290.66709332924;33417.66582334146;33487.497687534706;33491.83254083714;34075.82962085223;1093.6609651008214;1099.6810924831868;1101.752105776194;1125.7016890524017;1165.5104855960517;17342.826571734375;17523.649527009387;17546.824531754773;17721.556961075818;17854.28582856697;589609;592546;597822;598405;600000;59623;60305;60339.39660603426;60357.698211508665;60667.39332606706;1201.9963330619032;1273.57335292678;1276.2852802430668;1278.1308710077237;1354.6274774437109;30845.537316939815;34203.65796342104;34263.31473370569;34530.136746581535;34926.650733493356;54172.729136354064;55411.44588554224;55475.72262138664;55500.72249638726;55545.444545554026;489487;499647;500278;501311;505337;37224.441633374976;43454.56545434632;44255.77872110619;44708.234412095466;47848.760756195996;49740.75129624329;50411;50717.746411267704;50931;50955.2356714657;41446;42651.57348426476;43438.56561434472;43542.346864797684;43942.780286098365;43494.3186048942;43505.34741978809;43586.205517392424;43652.56347436612;44371.556284436745;42248.78875605603;42625.36061959135;42634.57365426306;42940;43024.56975430331;35936.28127437489;37822.942469731905;37929.81035094807;38102;38386;27648;28508.144755657362;28707.856460718398;28847.5672864903;28963.420731585673 10:55:54 INFO - PROCESS | 21663 | |2;jquery.html;389.29343242015756;389.67851522493936;392.59954846057013;405.9857904973323;408.5934495177299;18324.267029318828;20571.382858514233;20814.479638009056;20821.687674684872;20848.89575552124;18758.249670013218;18974.335898243564;19201.903990480063;19893.60212795743;19909.3031743889;5581.8604534886545;5734.881698068868;5891.88216235675;5892.14563888236;5976.043832986723;5773.1051686988585;5830.038043722802;5835.153902684108;5846.88306233875;5862.589618726691;5650.802221922234;5813.44772246638;5851.297844258695;5884.264466941632;5893.263342082239;5667.376588575254;5749.166370876221;5796.42035796417;5798.681072541009;5869.823905282827;5191.273221748958;5195.116830138885;5218.112920803473;5221.503957124067;5230.189320655304;23192.956316965778;23570.646440303237;23900.16349427779;24269.1505797298;24305.635415468783;2390.067873529325;2404.831661783676;2415.6376543518436;2453.4234454903085;2537.8984840606354;14335.641608959755;14994.925025374912;15066.171360575165;15345.386184552604;15529.767053494206;1983.6627773278433;1990.8805471671747;1994.112619884152;2019.162047750182;2047.846411519142;79435.6028219861;80518.75331220219;81236;81419.59290203512;81674.59162704209;10418.447480367358;10442.477876106164;10815.459227038617;10878.456077196108;11063.114950803916;14951.925240373728;15048.548543543711;15052.397904083715;15059.698806023818;15068.623284417758;8322;8523.190296921783;8576.699815506552;8597.527136007455;8698.260647845003;8414.537200453911;8439.156084391512;8466.830663386698;8596.742097737078;8613.22480976715;6528.771492997722;6719.798406047827;6798.8640227196165;6806.659667016728;6873.5875847449315;1778.052414672917;1832.2916563161145;1941.0876887862682;1962;1993.3621241202966;983.468926779531;1017.7557386227252;1060.4379678770265;1071.4749772611365;1076.5370890517154;19912.70130948037;20100.497487562927;20409;20411.4897127573;20491;986.3194395866828;987.4174237200086;999.4153420249236;1011.5953618552638;1042.5048102151418;11237.269577477438;11403.714907127389;11547.191696581158;11665.941670291595;11792.646220613395;479570;490536;513128;513228;515500;60091;76682;79068.20931790724;80808.59595701983;81441;975.5414954971294;998.8401855703053;1035.6530562261576;1038.5897570459776;1038.678009816959;13362.665933351354;17471;17538.298468061646;18189.272429102686;18294;37063.44404833876;38553.421698673985;44577;45190.32214516851;45878;53147.20279195738;54824.177637336266;55392;55717.44282557123;56277.43722562722;8246.257836794717;8505.149485051692;8532.360072994674;8647.437916535406;8800.295976321751;9895.406275623485;14015.859841401456;14078.296085195494;14383.496577619733;14409.495667652001;11518.25131366492;11796.587119450778;12403.25580465175;12412.81380779271;12856.292903890377;11803.527858885893;11926.821097683369;12163.026957843174;12326.137170397986;12677;12007.81988270194;12548.811767823672;12582.748345033231;12705.17416367933;12829.23024618526;8438.071812100541;8616.698415555426;8622.956885215533;8667.089955554577;8730.345224108345;8704.825903482022;11173.944130279297;11915.642530724092;12329.938350308192;12506.749865002466 10:55:54 INFO - PROCESS | 21663 | |3;mootools.html;1495.1851241073614;1516.681496885654;1650.364609625294;1778.5820332221926;1805.9367922122728;8615.741527754162;9027.14242146995;9148.268138548916;9155.496447695383;9170.816583668331;7836.333911617505;8499.872501912461;8827.470351778882;8834.337424693158;8963.55182240887;2231.2859884836857;2246.6068438023362;2247.1236217875044;2250.1224522436264;2251.763564825694;2204.250554811372;2204.812590929773;2248.5053288276554;2249.8425110242288;2249.921252756154;1808.2495764257817;2111.2082968886666;2188.540406514626;2189.6058709432295;2194.199117322174;2213.7232845894264;2223.1218668625884;2230.609643312414;2233.2965115988413;2244.8204143668468;2173.076442511942;2173.9673904891283;2176.238316589197;2179.106566307806;2181.3564998325533;9023.233025192867;9148.085191480799;9150.81698366029;9157.358984871062;9158.267338612895;5076.111680455905;5196.740162991835;5201.635885488017;5204.609654275944;5205.869853253661;3257.8859739909226;3312.0560640217664;3407.8296085195643;3410.2497450560836;3426.623071462137;1057.2810488867567;1065.55779351569;1076.6716151573767;1091.4051841746268;1096.117625311624;12616.621501354974;12629.24224546521;12635.684107897285;12639.052071094704;12646.304453255067;4414.735115893057;4484.663650226246;4582.335561343587;4583.312503124558;4613.561711637389;10469.68590942273;10526.526306316235;10540.472976351151;10541.84187237192;10542.631007914686;5160.380754309507;5165.173572228426;5166.535011848951;5168.8966220675375;5169.302144210484;4704.647151463654;4737.0525894820485;4738.3840100787365;4742.668013239109;4839.080574690797;3906.3554513504955;3919.2945269851703;3944.783036932939;3976.383660532622;4012.498437695288;1092.5738961804902;1222.2422098299112;1223.1010207497482;1250.93745312734;1252.824604555363;890.3144578674385;996.8106059848751;999.6051559633904;1001.5342865567401;1002.8445590933417;5860.208871802337;5925.200097986803;5943.078822782476;5975.7609695612555;6107.511399088063;963.6868017894072;979.1481411172183;980.3529670417632;988.0761488008735;993.046675191824;4289.806958686867;4360.847370342023;4373.497047839475;4375.2780791169735;4376.540463251376;11183.105351571854;11332.206745527734;11525.538978440936;11567.826482602768;11609.593664221711;10772.78454430907;11209;11216.327020378803;11508.654740357802;11518.675352334589;7435.25647435263;8067.919320806717;8292.37807164465;8354.498730076215;8511.04246023418;6300.905486417616;6314.715837787402;6388.8083357499345;6427.903581446376;6595.175603049619;10247.128994035591;10584.788304233718;10639.468026598484;10653.254272200871;10830.133589312994;10554.630587929385;10934.398608076632;11025.393603351893;11067.667969960914;11159.72100697489;7931.286184243446;8191.79520511992;8195.877061843958;8200.343972482067;8201.343892488467;8650.956745216234;8660.523671197892;8680.826383472422;8698.565071746514;8721;6623.531665905262;7316.746857207821;7412.814679633052;8056.476329038594;8294.626741796514;7615.276548727862;7664.463487555818;7904.565248911365;7938.04743430792;8018.8396232073865;7086.078809754699;7295.635218239173;7301.890471643036;7353.448491363062;7400.222976587596;5188.325517682677;5320.334958130234;5327.600429967845;5328.254044433705;5423.728813559227;5379.919301210407;5384.838454846361;5518.779248830162;5575.275214222125;5644.096944488862 10:55:54 INFO - PROCESS | 21663 | |4;prototype.html;301.08019998903353;308.40631783816156;313.07018156076447;316.1921291101235;319.380402020081;5052.469490703478;5133.691978481284;5227.738613069346;5277.393099793525;5281.155015197569;5161.657968928078;5209.088409528336;5228.215767634857;5241.161414173733;5262.210668399742;4055.959440405588;4061.4566464743357;4068.2270368629866;4073.9592604074023;4081.693872959525;3874.4769456123486;3910.335243008695;4072.6538244249273;4073.103917138225;4122.402251673506;4089.8364065437345;4090.365993271048;4096.201240758039;4105.762359514072;4107.897302567445;4083.2854250506193;4088.3049881520215;4093.8362465501345;4095.1400205956784;4118.114605359862;3404.8297585120645;3639.5268615080136;3640.526731524911;3650.7809531428197;3657.4148136298063;5090.669106508065;5109.6678715883345;5118.667286626357;5118.667286626394;5118.846434606968;4595.414581969215;4622.237330840408;4623.283391074388;4630.884227894329;4634.953650463486;5183.429822719498;5408.945910540883;5413.458654134594;5422.15956526739;5446.264754258164;3940.133170702441;3972.5828787977425;3995.1011022519992;3998.5601583825755;4000.419939108842;5616.241807356037;5639.6334238274385;5644.971775141098;5666.9716651416475;5671.149327600851;4100.425940368351;4102.261592913244;4109.9589004109575;4118.402831589463;4135.524414692289;3952.9011774705864;4178.22702799983;4186.644135248477;4195.832166713297;4205.495340559152;4608.216603177468;4639.306653071604;4687.718736875799;4703.341532185496;4710.905781884343;5387.24578559002;5408.458024728371;5413.891722165614;5480.972595136999;5488.121900495901;1307.6534718299658;1312.4750099960092;1404.7822587498954;1407.90848594841;1410.6543896745363;948.369334392635;965.3532133470592;972.246508955551;979.7501637082498;980.9852852207223;5251.343582052244;5270.604704647167;5298.231756395301;5302.522772950453;5307.177387504943;5498.697571633598;5551.306086739158;5551.805686800943;5580.581456390706;5582.497575218169;5090.821821236239;5270.49930256625;5278.947210527922;5283.1546952487415;5392.352917649829;2974.973634096233;2977.5533669949245;2977.955330670042;2980.7317341439375;2995.2811325281777;5712.942870571324;5751.827445176651;5778.624389414675;5798.59409841307;5834.299884013945;5588.161775733591;5697.259356283656;5731.484166425042;5737.483626473554;5777.45114214149;5765.4811067004175;5783.219265399117;5791.82624521265;5817.360090390053;5832.912506312324;5394.757235924471;5593.608447408642;5624.212610234652;5637.774489020393;5647.943520564906;5521.585881058856;5570.359408668055;5596;5600.523955463668;5606.411326810626;5769.538436924952;5772.19189313488;5779.36426993022;5802.796902108406;5818.359980402068;3594.730395220421;3659.670629643345;3775.8489660413275;3968.583298753589;3983.1834473933354;5489.780408783764;5544.1960915666195;5576.944230557642;5577.330720313588;5577.776888924398;5412.188171774108;5420.620556561003;5423.74575254844;5424.3761967372675;5430.348358196884;5231.921521177262;5420.457954204706;5500.697461639648;5533.501984821385;5542.307211598551;5415.48552887475;5427.580624206725;5434.918476222781;5437.755301011385;5440.891182176413;5352.464753524617;5522.502974732293;5533;5540.8087261239025;5545.750441230073;5404.189371594292;5418.729063546728;5436.211749296409;5437.891242175056;5439.9456005441025 10:55:54 INFO - PROCESS | 21663 | |5;yui.html;687.7579092159558;692.580988501956;736.8673638745025;769.7729169894884;862.6075135813204;15394.461193858217;15637.218139093056;16409.917950410232;16441.588960275985;16444.58888527786;14126;14581.92709036456;14594.562163135122;14595.708085838276;14694.118352898808;663.0485253661;690.5166383531523;693.3655705029892;694.0179645801185;794.2534018023068;813.8250276190618;822.0751654388813;822.6627082896014;824.1305422778966;825.9008918929737;847.9321654267675;852.228732996639;852.9402941794077;853.0403296291672;853.2832420766555;695.6591270277553;849.133883438892;852.2713080316333;853.0318088969003;883.3110174064176;613.4080612209195;619.4115590189293;619.4889216396491;620.0141774578397;620.0482259731291;15318.463853765175;15348.846511534854;15365.462208822637;15402.768958465633;15438.9228053859;15375.923120384326;15663.608409789733;15768.369265229378;15781.447649332333;15782.68434631301;12088.697782555419;12124.818127728091;12215.450304736309;12542.74914501705;12817.166884152593;4688.179568575486;4788.928166077511;4812.278158276252;4943.505649435064;4943.92584111235;78578.21421785766;79763;80028.59985700093;80659;81626;11436.31382117059;11510.251833630788;11546.364949927667;11639.53441862316;11654.650360489199;21223;21252.681209781866;21268.468288292606;21279.255226067322;21291.57416851654;8341.45780524264;8478.576071196416;8494.108118647453;8693.261072808882;8864.556772161366;4824.638152138604;4913.31213630092;4949.554540091337;4992.975035124801;5226;3706.703463722896;3817.770933743984;3819.102510909934;3826.655600995868;3841.4045822897497;642.9324920883333;649.1009951217598;655.7409823119841;660.9405153536205;665.55075324156;608.2275510102234;616.315889362807;695.1658010387555;722.7181399254295;739.5008369350775;9234.1689247968;9723.416595004323;9746.171575416169;9876.209903207726;9943.204543636637;670.9429698475684;695.5061906046662;706.4560288577767;714.5783987447431;716.8207948012997;4499.244641441484;4771.475137734847;4831;4898.769075834706;4914.115459217375;71245;114532;119048;120467;121033.78966210401;72798.99999999894;100738;100779;102470;102953;87673.56163219143;87902;88648.5567572158;89123.55438222637;90175;8875.689350872688;9064.818703626022;9067.501287429255;9096.408733432305;9104.590293436679;52668.20997685115;52808.73595631997;53683.731581341846;53841;54054.456034584335;74367.62816185884;78577;79804;80088.59955700184;80275.59862200651;11926.821097683369;12597.685057873627;12981.091323607257;13429.328533573087;13594.728105438033;15733.685326293182;15796.68406631884;15814.446494372642;16335.168001272023;16434.178291085158;14729.55811325662;14796.334164962387;15235.923820380827;15588.454404095803;16201.75697364517;14176.858231417966;14615.561533154023;15187.316570754563;15569.766453503433;15757.212139393214;13840.861591383957;14366.209858457885;14495.275236238356;14718.852811471748;15657.217139143226;10748.4088375137;11259.796131548828;11736.88263117358;12257.509699611915;12500.812487812873;11900.166988310735;12207.938960305142;12262.632121036384;12488.25070495773;12522.812157817458 10:55:54 INFO - PROCESS | 21663 | __end_tp_report 10:55:54 INFO - PROCESS | 21663 | __start_cc_report 10:55:54 INFO - PROCESS | 21663 | _x_x_mozilla_cycle_collect,902 10:55:54 INFO - PROCESS | 21663 | __end_cc_report 10:55:54 INFO - PROCESS | 21663 | __startTimestamp1467914154498__endTimestamp 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | ------- Summary: start ------- 10:55:54 INFO - PROCESS | 21663 | Number of tests: 6 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | [#0] dojo.html Cycles:165 Average:5387.87 Median:5567.36 stddev:614.52 (11.0%) stddev-sans-first:588.54 10:55:54 INFO - PROCESS | 21663 | Values: 3055.8 3085.3 3128.9 3133.6 3153.0 5185.0 5254.7 5371.5 5486.6 5509.0 5347.3 5364.3 5380.7 5390.2 5425.2 4861.9 4898.5 4949.5 4957.6 5095.9 4990.7 4997.2 5044.1 5049.8 5057.9 4847.1 4880.2 4921.8 4922.7 4932.6 4895.9 4923.9 4925.7 4959.3 5009.6 4920.7 4944.5 4953.3 4962.4 4998.0 5273.4 5275.4 5344.8 5377.2 5431.9 5798.9 5805.7 5840.6 5842.6 5847.0 5631.1 5770.2 5851.7 5902.5 5919.4 5403.3 5442.7 5458.6 5462.6 5464.4 6006.5 6018.0 6019.1 6022.6 6023.0 5562.7 5582.4 5646.1 5753.7 5756.3 5751.2 5758.4 5791.6 5804.6 5809.5 5734.5 5737.3 5740.7 5742.9 5746.2 5570.1 5729.9 5746.7 5786.2 5802.8 4413.1 4427.2 4432.1 4433.9 4475.3 3931.8 3942.2 3951.6 3998.8 4000.6 5285.4 5296.0 5449.1 5451.3 5494.4 5828.4 5832.8 5834.6 5838.2 5854.2 5370.2 5500.8 5504.6 5508.0 5516.9 5024.4 5060.3 5065.4 5107.8 5116.8 6060.2 6063.6 6065.0 6065.4 6079.4 5644.6 5742.6 5853.6 5869.5 5870.6 5999.1 6043.2 6052.1 6052.4 6122.9 5680.9 5735.3 5739.5 5744.5 5755.4 5646.7 5761.9 5798.7 5847.0 5864.9 5668.8 5690.2 5691.2 5697.8 5737.2 5638.5 5677.6 5690.4 5694.8 5698.4 5464.8 5519.6 5537.2 5559.1 5623.2 5682.1 5683.8 5685.4 5746.2 5748.0 5522.6 5562.4 5567.4 5572.3 5575.6 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | [#1] ext.html Cycles:180 Average:61286.69 Median:43564.28 stddev:126499.04 (290.4%) stddev-sans-first:126771.80 10:55:54 INFO - PROCESS | 21663 | Values: 585.4 596.1 626.1 626.7 637.5 31579.0 43617.6 44341.0 44406.6 44411.0 46896.1 47292.3 47322.1 47359.8 47494.8 8742.3 8865.6 8873.5 8884.2 8884.9 8794.7 8823.6 8884.8 8891.4 8892.2 8900.8 8931.2 8932.7 8946.8 8976.5 8919.7 8945.4 8961.9 8966.8 8967.6 8687.7 8745.0 8767.0 8774.7 8776.0 44720.0 44953.3 45125.5 45182.0 45183.8 3597.2 3679.0 3755.9 3834.2 4111.7 33320.0 33443.0 33881.2 34209.0 34581.3 4317.7 4367.3 4383.5 4398.8 4477.1 262818.0 262865.0 264777.0 265194.0 265374.0 34483.7 60843.7 61056.4 61138.0 61152.0 35389.8 36836.0 36926.6 37056.3 37106.3 15354.9 15643.8 15656.8 15680.2 15680.6 12984.7 13039.7 13109.5 13119.6 13123.3 8296.9 8337.0 8354.6 8411.7 8426.6 3248.7 3273.9 3277.7 3285.4 3295.6 1008.4 1054.9 1058.7 1136.1 1140.7 33290.7 33417.7 33487.5 33491.8 34075.8 1093.7 1099.7 1101.8 1125.7 1165.5 17342.8 17523.6 17546.8 17721.6 17854.3 589609.0 592546.0 597822.0 598405.0 600000.0 59623.0 60305.0 60339.4 60357.7 60667.4 1202.0 1273.6 1276.3 1278.1 1354.6 30845.5 34203.7 34263.3 34530.1 34926.7 54172.7 55411.4 55475.7 55500.7 55545.4 489487.0 499647.0 500278.0 501311.0 505337.0 37224.4 43454.6 44255.8 44708.2 47848.8 49740.8 50411.0 50717.7 50931.0 50955.2 41446.0 42651.6 43438.6 43542.3 43942.8 43494.3 43505.3 43586.2 43652.6 44371.6 42248.8 42625.4 42634.6 42940.0 43024.6 35936.3 37822.9 37929.8 38102.0 38386.0 27648.0 28508.1 28707.9 28847.6 28963.4 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | [#2] jquery.html Cycles:180 Average:29168.20 Median:2495.66 stddev:82417.67 (3302.4%) stddev-sans-first:82620.54 10:55:54 INFO - PROCESS | 21663 | Values: 389.3 389.7 392.6 406.0 408.6 18324.3 20571.4 20814.5 20821.7 20848.9 18758.2 18974.3 19201.9 19893.6 19909.3 5581.9 5734.9 5891.9 5892.1 5976.0 5773.1 5830.0 5835.2 5846.9 5862.6 5650.8 5813.4 5851.3 5884.3 5893.3 5667.4 5749.2 5796.4 5798.7 5869.8 5191.3 5195.1 5218.1 5221.5 5230.2 23193.0 23570.6 23900.2 24269.2 24305.6 2390.1 2404.8 2415.6 2453.4 2537.9 14335.6 14994.9 15066.2 15345.4 15529.8 1983.7 1990.9 1994.1 2019.2 2047.8 79435.6 80518.8 81236.0 81419.6 81674.6 10418.4 10442.5 10815.5 10878.5 11063.1 14951.9 15048.5 15052.4 15059.7 15068.6 8322.0 8523.2 8576.7 8597.5 8698.3 8414.5 8439.2 8466.8 8596.7 8613.2 6528.8 6719.8 6798.9 6806.7 6873.6 1778.1 1832.3 1941.1 1962.0 1993.4 983.5 1017.8 1060.4 1071.5 1076.5 19912.7 20100.5 20409.0 20411.5 20491.0 986.3 987.4 999.4 1011.6 1042.5 11237.3 11403.7 11547.2 11665.9 11792.6 479570.0 490536.0 513128.0 513228.0 515500.0 60091.0 76682.0 79068.2 80808.6 81441.0 975.5 998.8 1035.7 1038.6 1038.7 13362.7 17471.0 17538.3 18189.3 18294.0 37063.4 38553.4 44577.0 45190.3 45878.0 53147.2 54824.2 55392.0 55717.4 56277.4 8246.3 8505.1 8532.4 8647.4 8800.3 9895.4 14015.9 14078.3 14383.5 14409.5 11518.3 11796.6 12403.3 12412.8 12856.3 11803.5 11926.8 12163.0 12326.1 12677.0 12007.8 12548.8 12582.7 12705.2 12829.2 8438.1 8616.7 8623.0 8667.1 8730.3 8704.8 11173.9 11915.6 12329.9 12506.7 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | [#3] mootools.html Cycles:180 Average:5919.63 Median:4598.44 stddev:3449.67 (75.0%) stddev-sans-first:3443.33 10:55:54 INFO - PROCESS | 21663 | Values: 1495.2 1516.7 1650.4 1778.6 1805.9 8615.7 9027.1 9148.3 9155.5 9170.8 7836.3 8499.9 8827.5 8834.3 8963.6 2231.3 2246.6 2247.1 2250.1 2251.8 2204.3 2204.8 2248.5 2249.8 2249.9 1808.2 2111.2 2188.5 2189.6 2194.2 2213.7 2223.1 2230.6 2233.3 2244.8 2173.1 2174.0 2176.2 2179.1 2181.4 9023.2 9148.1 9150.8 9157.4 9158.3 5076.1 5196.7 5201.6 5204.6 5205.9 3257.9 3312.1 3407.8 3410.2 3426.6 1057.3 1065.6 1076.7 1091.4 1096.1 12616.6 12629.2 12635.7 12639.1 12646.3 4414.7 4484.7 4582.3 4583.3 4613.6 10469.7 10526.5 10540.5 10541.8 10542.6 5160.4 5165.2 5166.5 5168.9 5169.3 4704.6 4737.1 4738.4 4742.7 4839.1 3906.4 3919.3 3944.8 3976.4 4012.5 1092.6 1222.2 1223.1 1250.9 1252.8 890.3 996.8 999.6 1001.5 1002.8 5860.2 5925.2 5943.1 5975.8 6107.5 963.7 979.1 980.4 988.1 993.0 4289.8 4360.8 4373.5 4375.3 4376.5 11183.1 11332.2 11525.5 11567.8 11609.6 10772.8 11209.0 11216.3 11508.7 11518.7 7435.3 8067.9 8292.4 8354.5 8511.0 6300.9 6314.7 6388.8 6427.9 6595.2 10247.1 10584.8 10639.5 10653.3 10830.1 10554.6 10934.4 11025.4 11067.7 11159.7 7931.3 8191.8 8195.9 8200.3 8201.3 8651.0 8660.5 8680.8 8698.6 8721.0 6623.5 7316.7 7412.8 8056.5 8294.6 7615.3 7664.5 7904.6 7938.0 8018.8 7086.1 7295.6 7301.9 7353.4 7400.2 5188.3 5320.3 5327.6 5328.3 5423.7 5379.9 5384.8 5518.8 5575.3 5644.1 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | [#4] prototype.html Cycles:180 Average:4608.91 Median:5280.05 stddev:1352.07 (25.6%) stddev-sans-first:1316.63 10:55:54 INFO - PROCESS | 21663 | Values: 301.1 308.4 313.1 316.2 319.4 5052.5 5133.7 5227.7 5277.4 5281.2 5161.7 5209.1 5228.2 5241.2 5262.2 4056.0 4061.5 4068.2 4074.0 4081.7 3874.5 3910.3 4072.7 4073.1 4122.4 4089.8 4090.4 4096.2 4105.8 4107.9 4083.3 4088.3 4093.8 4095.1 4118.1 3404.8 3639.5 3640.5 3650.8 3657.4 5090.7 5109.7 5118.7 5118.7 5118.8 4595.4 4622.2 4623.3 4630.9 4635.0 5183.4 5408.9 5413.5 5422.2 5446.3 3940.1 3972.6 3995.1 3998.6 4000.4 5616.2 5639.6 5645.0 5667.0 5671.1 4100.4 4102.3 4110.0 4118.4 4135.5 3952.9 4178.2 4186.6 4195.8 4205.5 4608.2 4639.3 4687.7 4703.3 4710.9 5387.2 5408.5 5413.9 5481.0 5488.1 1307.7 1312.5 1404.8 1407.9 1410.7 948.4 965.4 972.2 979.8 981.0 5251.3 5270.6 5298.2 5302.5 5307.2 5498.7 5551.3 5551.8 5580.6 5582.5 5090.8 5270.5 5278.9 5283.2 5392.4 2975.0 2977.6 2978.0 2980.7 2995.3 5712.9 5751.8 5778.6 5798.6 5834.3 5588.2 5697.3 5731.5 5737.5 5777.5 5765.5 5783.2 5791.8 5817.4 5832.9 5394.8 5593.6 5624.2 5637.8 5647.9 5521.6 5570.4 5596.0 5600.5 5606.4 5769.5 5772.2 5779.4 5802.8 5818.4 3594.7 3659.7 3775.8 3968.6 3983.2 5489.8 5544.2 5576.9 5577.3 5577.8 5412.2 5420.6 5423.7 5424.4 5430.3 5231.9 5420.5 5500.7 5533.5 5542.3 5415.5 5427.6 5434.9 5437.8 5440.9 5352.5 5522.5 5533.0 5540.8 5545.8 5404.2 5418.7 5436.2 5437.9 5439.9 10:55:54 INFO - PROCESS | 21663 | 10:55:54 INFO - PROCESS | 21663 | [#5] yui.html Cycles:180 Average:21197.71 Median:4906.04 stddev:29999.11 (611.5%) stddev-sans-first:30043.73 10:55:54 INFO - PROCESS | 21663 | Values: 687.8 692.6 736.9 769.8 862.6 15394.5 15637.2 16409.9 16441.6 16444.6 14126.0 14581.9 14594.6 14595.7 14694.1 663.0 690.5 693.4 694.0 794.3 813.8 822.1 822.7 824.1 825.9 847.9 852.2 852.9 853.0 853.3 695.7 849.1 852.3 853.0 883.3 613.4 619.4 619.5 620.0 620.0 15318.5 15348.8 15365.5 15402.8 15438.9 15375.9 15663.6 15768.4 15781.4 15782.7 12088.7 12124.8 12215.5 12542.7 12817.2 4688.2 4788.9 4812.3 4943.5 4943.9 78578.2 79763.0 80028.6 80659.0 81626.0 11436.3 11510.3 11546.4 11639.5 11654.7 21223.0 21252.7 21268.5 21279.3 21291.6 8341.5 8478.6 8494.1 8693.3 8864.6 4824.6 4913.3 4949.6 4993.0 5226.0 3706.7 3817.8 3819.1 3826.7 3841.4 642.9 649.1 655.7 660.9 665.6 608.2 616.3 695.2 722.7 739.5 9234.2 9723.4 9746.2 9876.2 9943.2 670.9 695.5 706.5 714.6 716.8 4499.2 4771.5 4831.0 4898.8 4914.1 71245.0 114532.0 119048.0 120467.0 121033.8 72799.0 100738.0 100779.0 102470.0 102953.0 87673.6 87902.0 88648.6 89123.6 90175.0 8875.7 9064.8 9067.5 9096.4 9104.6 52668.2 52808.7 53683.7 53841.0 54054.5 74367.6 78577.0 79804.0 80088.6 80275.6 11926.8 12597.7 12981.1 13429.3 13594.7 15733.7 15796.7 15814.4 16335.2 16434.2 14729.6 14796.3 15235.9 15588.5 16201.8 14176.9 14615.6 15187.3 15569.8 15757.2 13840.9 14366.2 14495.3 14718.9 15657.2 10748.4 11259.8 11736.9 12257.5 12500.8 11900.2 12207.9 12262.6 12488.3 12522.8 10:55:54 INFO - PROCESS | 21663 | -------- Summary: end -------- 10:55:54 INFO - PROCESS | 21663 | 10:55:55 INFO - TEST-INFO | 21663: exit 0 10:55:55 INFO - TEST-OK | dromaeo_css | took 1113904ms 10:55:55 INFO - TEST-START | kraken 10:55:55 INFO - operating with platform_type : linux_ 10:55:55 INFO - Initialising browser for kraken test... 10:55:55 INFO - TEST-INFO | started process 21854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprneC5M/profile http://localhost:56083/getInfo.html) 10:55:59 INFO - PROCESS | 21854 | __metrics Screen width/height:1600/1200 10:55:59 INFO - PROCESS | 21854 | colorDepth:24 10:55:59 INFO - PROCESS | 21854 | Browser inner width/height: 1024/697 10:55:59 INFO - PROCESS | 21854 | __metrics 10:56:00 INFO - PROCESS | 21854 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:01 INFO - TEST-INFO | 21854: exit 0 10:56:01 INFO - Browser initialized. 10:56:01 INFO - Running cycle 1/1 for kraken test... 10:56:01 INFO - TEST-INFO | started process 21934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprneC5M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:12 INFO - PROCESS | 21934 | RSS: Main: 157163520 10:56:12 INFO - PROCESS | 21934 | 10:56:15 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56083/tests/kraken/driver.html?testName=audio-beat-detection) 10:56:16 INFO - PROCESS | 21934 | RSS: Main: 215703552 10:56:16 INFO - PROCESS | 21934 | 10:56:18 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56083/tests/kraken/driver.html?testName=audio-dft) 10:56:19 INFO - PROCESS | 21934 | RSS: Main: 198193152 10:56:19 INFO - PROCESS | 21934 | 10:56:22 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56083/tests/kraken/driver.html?testName=audio-fft) 10:56:23 INFO - PROCESS | 21934 | RSS: Main: 269828096 10:56:23 INFO - PROCESS | 21934 | 10:56:25 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56083/tests/kraken/driver.html?testName=audio-oscillator) 10:56:25 INFO - PROCESS | 21934 | RSS: Main: 180514816 10:56:25 INFO - PROCESS | 21934 | 10:56:28 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56083/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:28 INFO - PROCESS | 21934 | RSS: Main: 184705024 10:56:28 INFO - PROCESS | 21934 | 10:56:31 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56083/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:32 INFO - PROCESS | 21934 | RSS: Main: 219291648 10:56:32 INFO - PROCESS | 21934 | 10:56:35 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56083/tests/kraken/driver.html?testName=imaging-desaturate) 10:56:36 INFO - PROCESS | 21934 | RSS: Main: 221474816 10:56:36 INFO - PROCESS | 21934 | 10:56:39 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56083/tests/kraken/driver.html?testName=json-parse-financial) 10:56:39 INFO - PROCESS | 21934 | RSS: Main: 221659136 10:56:39 INFO - PROCESS | 21934 | 10:56:41 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56083/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:56:41 INFO - PROCESS | 21934 | RSS: Main: 207839232 10:56:41 INFO - PROCESS | 21934 | 10:56:43 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:56:44 INFO - PROCESS | 21934 | RSS: Main: 211525632 10:56:44 INFO - PROCESS | 21934 | 10:56:46 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:56:46 INFO - PROCESS | 21934 | RSS: Main: 211861504 10:56:46 INFO - PROCESS | 21934 | 10:56:49 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:56:49 INFO - PROCESS | 21934 | RSS: Main: 224694272 10:56:49 INFO - PROCESS | 21934 | 10:56:52 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:56:53 INFO - PROCESS | 21934 | RSS: Main: 224460800 10:56:53 INFO - PROCESS | 21934 | 10:56:54 INFO - PROCESS | 21934 | Cycle 1(1): loaded http://localhost:56083/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56083/tests/kraken/driver.html?testName=ai-astar) 10:56:55 INFO - PROCESS | 21934 | RSS: Main: 266784768 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | __start_tp_report 10:56:55 INFO - PROCESS | 21934 | _x_x_mozilla_page_load 10:56:55 INFO - PROCESS | 21934 | _x_x_mozilla_page_load_details 10:56:55 INFO - PROCESS | 21934 | |i|pagename|runs| 10:56:55 INFO - PROCESS | 21934 | |0;ai-astar;102;111;110;110;116;110;110;110;111;111 10:56:55 INFO - PROCESS | 21934 | |1;audio-beat-detection;145;116;119;179;117;119;143;119;176;117 10:56:55 INFO - PROCESS | 21934 | |2;audio-dft;161;160;159;160;160;159;160;161;160;161 10:56:55 INFO - PROCESS | 21934 | |3;audio-fft;75;74;75;114;75;75;75;74;98;76 10:56:55 INFO - PROCESS | 21934 | |4;audio-oscillator;84;84;117;84;84;83;115;85;84;127 10:56:55 INFO - PROCESS | 21934 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;116;116 10:56:55 INFO - PROCESS | 21934 | |6;imaging-darkroom;146;147;147;145;146;146;145;146;146;146 10:56:55 INFO - PROCESS | 21934 | |7;imaging-desaturate;95;95;96;95;95;95;94;95;95;95 10:56:55 INFO - PROCESS | 21934 | |8;json-parse-financial;54;55;54;54;53;54;56;53;52;54 10:56:55 INFO - PROCESS | 21934 | |9;json-stringify-tinderbox;63;62;62;63;64;63;62;63;62;61 10:56:55 INFO - PROCESS | 21934 | |10;stanford-crypto-aes;75;76;74;75;83;78;75;81;74;80 10:56:55 INFO - PROCESS | 21934 | |11;stanford-crypto-ccm;119;120;121;124;127;125;118;121;161;122 10:56:55 INFO - PROCESS | 21934 | |12;stanford-crypto-pbkdf2;161;156;156;156;157;154;153;161;154;153 10:56:55 INFO - PROCESS | 21934 | |13;stanford-crypto-sha256-iterative;63;65;63;62;63;62;64;63;63;61 10:56:55 INFO - PROCESS | 21934 | __end_tp_report 10:56:55 INFO - PROCESS | 21934 | __start_cc_report 10:56:55 INFO - PROCESS | 21934 | _x_x_mozilla_cycle_collect,1642 10:56:55 INFO - PROCESS | 21934 | __end_cc_report 10:56:55 INFO - PROCESS | 21934 | __startTimestamp1467914215043__endTimestamp 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | ------- Summary: start ------- 10:56:55 INFO - PROCESS | 21934 | Number of tests: 14 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:3.38 (3.1%) stddev-sans-first:1.94 10:56:55 INFO - PROCESS | 21934 | Values: 102.0 111.0 110.0 110.0 116.0 110.0 110.0 110.0 111.0 111.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:131.00 stddev:24.85 (19.0%) stddev-sans-first:26.09 10:56:55 INFO - PROCESS | 21934 | Values: 145.0 116.0 119.0 179.0 117.0 119.0 143.0 119.0 176.0 117.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:56:55 INFO - PROCESS | 21934 | Values: 161.0 160.0 159.0 160.0 160.0 159.0 160.0 161.0 160.0 161.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.67 (18.2%) stddev-sans-first:14.32 10:56:55 INFO - PROCESS | 21934 | Values: 75.0 74.0 75.0 114.0 75.0 75.0 75.0 74.0 98.0 76.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:17.50 (20.8%) stddev-sans-first:18.13 10:56:55 INFO - PROCESS | 21934 | Values: 84.0 84.0 117.0 84.0 84.0 83.0 115.0 85.0 84.0 127.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:56:55 INFO - PROCESS | 21934 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:56:55 INFO - PROCESS | 21934 | Values: 146.0 147.0 147.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:56:55 INFO - PROCESS | 21934 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:1.17 10:56:55 INFO - PROCESS | 21934 | Values: 54.0 55.0 54.0 54.0 53.0 54.0 56.0 53.0 52.0 54.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 10:56:55 INFO - PROCESS | 21934 | Values: 63.0 62.0 62.0 63.0 64.0 63.0 62.0 63.0 62.0 61.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:3.21 (4.2%) stddev-sans-first:3.32 10:56:55 INFO - PROCESS | 21934 | Values: 75.0 76.0 74.0 75.0 83.0 78.0 75.0 81.0 74.0 80.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.00 stddev:12.67 (10.3%) stddev-sans-first:13.20 10:56:55 INFO - PROCESS | 21934 | Values: 119.0 120.0 121.0 124.0 127.0 125.0 118.0 121.0 161.0 122.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.00 stddev:2.92 (1.9%) stddev-sans-first:2.51 10:56:55 INFO - PROCESS | 21934 | Values: 161.0 156.0 156.0 156.0 157.0 154.0 153.0 161.0 154.0 153.0 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - PROCESS | 21934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 10:56:55 INFO - PROCESS | 21934 | Values: 63.0 65.0 63.0 62.0 63.0 62.0 64.0 63.0 63.0 61.0 10:56:55 INFO - PROCESS | 21934 | -------- Summary: end -------- 10:56:55 INFO - PROCESS | 21934 | 10:56:55 INFO - TEST-INFO | 21934: exit 0 10:56:56 INFO - TEST-OK | kraken | took 60885ms 10:56:56 INFO - SUITE-END | took 1174s 10:56:56 INFO - Completed test suite (00:19:34) 10:56:56 INFO - javascript benchmark 10:56:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.7860949733517, 3085.3212293295496, 3128.85920133594, 3133.561301417802, 3152.9527057094133, 5185.0, 5254.710990895499, 5371.462853714626, 5486.561075113991, 5509.00837849187, 5347.25138480613, 5364.302640656719, 5380.650257733245, 5390.245365648812, 5425.159100339453, 4861.927071093936, 4898.461169271395, 4949.480304568023, 4957.553820156185, 5095.898082038357, 4990.675606085593, 4997.150484417658, 5044.092063428581, 5049.823256186034, 5057.898842023157, 4847.054824309261, 4880.17037103695, 4921.827736029221, 4922.680025798348, 4932.630052746058, 4895.853124406238, 4923.852284431473, 4925.679830810986, 4959.280904268897, 5009.599232061426, 4920.680155789898, 4944.505549445063, 4953.281774142765, 4962.404511458648, 4998.0, 5273.393559740641, 5275.4460781618145, 5344.839654810362, 5377.247185394009, 5431.864203394907, 5798.884022319572, 5805.680687562182, 5840.649561026309, 5842.591018628697, 5847.0, 5631.099024156157, 5770.2210201622665, 5851.736671849777, 5902.527797776168, 5919.408059194089, 5403.324584426947, 5442.673439593637, 5458.590605704588, 5462.562994960394, 5464.371597266365, 6006.519478441714, 6017.969910150508, 6019.067044608093, 6022.5784195105925, 6023.0, 5562.721863906789, 5582.441755824466, 5646.096624540136, 5753.712314384264, 5756.30924289088, 5751.22358481608, 5758.3665796762325, 5791.5656325775735, 5804.593678442468, 5809.535237181015, 5734.541236701054, 5737.340205876294, 5740.712964351766, 5742.885142297131, 5746.166805813217, 5570.136628822539, 5729.914051289234, 5746.712664366765, 5786.2477877876445, 5802.796902108406, 4413.073254616503, 4427.203103441347, 4432.13573353193, 4433.889152771142, 4475.283954567253, 3931.8230679619487, 3942.15243722601, 3951.585083566184, 3998.7600743955454, 4000.5599384067727, 5285.392179899284, 5296.0, 5449.128139497661, 5451.291332126798, 5494.36814766299, 5828.358880523139, 5832.766689332464, 5834.649921004753, 5838.182654428383, 5854.18041474194, 5370.167624018205, 5500.779968801203, 5504.614676972574, 5507.972460137674, 5516.862078448071, 5024.371953505812, 5060.291559181717, 5065.442801291855, 5107.795688172506, 5116.769745361467, 6060.2424696912885, 6063.575549711478, 6064.969675151684, 6065.363136870565, 6079.422454866781, 5644.604877658525, 5742.569307301886, 5853.560982926212, 5869.4717475427415, 5870.55970802183, 5999.100134979788, 6043.244594425697, 6052.061930400795, 6052.425019623129, 6122.908156377569, 5680.9147862781265, 5735.254416925773, 5739.540836732968, 5744.540436765133, 5755.395683453345, 5646.689432081275, 5761.942380576141, 5798.652080875161, 5846.970765146147, 5864.882702345843, 5668.801591944262, 5690.174924635988, 5691.23168372281, 5697.829065128053, 5737.225474560881, 5638.5489160867855, 5677.602567820213, 5690.374058853606, 5694.772209111589, 5698.373178950395, 5464.781408743605, 5519.558435325084, 5537.169424586184, 5559.0827513461445, 5623.2127502148915, 5682.062459694104, 5683.77264909399, 5685.403032681675, 5746.166805813217, 5748.022836117786, 5522.641028333145, 5562.415946325739, 5567.359753628384, 5572.331320241597, 5575.637583557218], "value": 5346.110626257651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.4175095779697, 596.0790578556131, 626.1265534579259, 626.7461678020401, 637.5027478566719, 31579.0, 43617.56382436175, 44341.0, 44406.55593444064, 44411.0, 46896.062078758405, 47292.29061564079, 47322.0535589288, 47359.76320118403, 47494.762526187405, 8742.256908162813, 8865.601047952825, 8873.51195684237, 8884.156005179497, 8884.911150888505, 8794.73615791524, 8823.602937867812, 8884.822303553925, 8891.377603567753, 8892.244159246471, 8900.821983560325, 8931.196192342688, 8932.687355942544, 8946.821063578724, 8976.46141231525, 8919.687810926618, 8945.418547794372, 8961.865572016424, 8966.820663586757, 8967.641294348217, 8687.6524939003, 8744.956275218583, 8767.0, 8774.692885749031, 8776.0, 44720.0, 44953.325700114525, 45125.54874451246, 45182.0, 45183.77408112971, 3597.244578638463, 3679.025058359537, 3755.868544600926, 3834.2331533693373, 4111.671066314688, 33320.0, 33443.0, 33881.15297117592, 34209.0, 34581.308373832384, 4317.740935543878, 4367.301231802896, 4383.452068491439, 4398.8020539075815, 4477.104579084164, 262818.0, 262865.0, 264777.0, 265194.0, 265374.0, 34483.655163448544, 60843.69578152081, 61056.38943610596, 61138.0, 61152.0, 35389.8230508851, 36836.0, 36926.63073369286, 37056.25887482235, 37106.257874842355, 15354.925155239025, 15643.765343519857, 15656.765148522782, 15680.215989200495, 15680.607984800472, 12984.740305193844, 13039.739205215843, 13109.475620975054, 13119.606411807661, 13123.343832808321, 8296.917030829734, 8337.0, 8354.58227088643, 8411.70559030431, 8426.620802063922, 3248.6751324867323, 3273.918152046218, 3277.6886195811358, 3285.375778602058, 3295.6374798772117, 1008.3848852200299, 1054.8892366301582, 1058.714147180257, 1136.0797753819434, 1140.6635042662435, 33290.66709332924, 33417.66582334146, 33487.497687534706, 33491.83254083714, 34075.82962085223, 1093.6609651008214, 1099.6810924831868, 1101.752105776194, 1125.7016890524017, 1165.5104855960517, 17342.826571734375, 17523.649527009387, 17546.824531754773, 17721.556961075818, 17854.28582856697, 589609.0, 592546.0, 597822.0, 598405.0, 600000.0, 59623.0, 60305.0, 60339.39660603426, 60357.698211508665, 60667.39332606706, 1201.9963330619032, 1273.57335292678, 1276.2852802430668, 1278.1308710077237, 1354.6274774437109, 30845.537316939815, 34203.65796342104, 34263.31473370569, 34530.136746581535, 34926.650733493356, 54172.729136354064, 55411.44588554224, 55475.72262138664, 55500.72249638726, 55545.444545554026, 489487.0, 499647.0, 500278.0, 501311.0, 505337.0, 37224.441633374976, 43454.56545434632, 44255.77872110619, 44708.234412095466, 47848.760756195996, 49740.75129624329, 50411.0, 50717.746411267704, 50931.0, 50955.2356714657, 41446.0, 42651.57348426476, 43438.56561434472, 43542.346864797684, 43942.780286098365, 43494.3186048942, 43505.34741978809, 43586.205517392424, 43652.56347436612, 44371.556284436745, 42248.78875605603, 42625.36061959135, 42634.57365426306, 42940.0, 43024.56975430331, 35936.28127437489, 37822.942469731905, 37929.81035094807, 38102.0, 38386.0, 27648.0, 28508.144755657362, 28707.856460718398, 28847.5672864903, 28963.420731585673], "value": 19535.400994168376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.29343242015756, 389.67851522493936, 392.59954846057013, 405.9857904973323, 408.5934495177299, 18324.267029318828, 20571.382858514233, 20814.479638009056, 20821.687674684872, 20848.89575552124, 18758.249670013218, 18974.335898243564, 19201.903990480063, 19893.60212795743, 19909.3031743889, 5581.8604534886545, 5734.881698068868, 5891.88216235675, 5892.14563888236, 5976.043832986723, 5773.1051686988585, 5830.038043722802, 5835.153902684108, 5846.88306233875, 5862.589618726691, 5650.802221922234, 5813.44772246638, 5851.297844258695, 5884.264466941632, 5893.263342082239, 5667.376588575254, 5749.166370876221, 5796.42035796417, 5798.681072541009, 5869.823905282827, 5191.273221748958, 5195.116830138885, 5218.112920803473, 5221.503957124067, 5230.189320655304, 23192.956316965778, 23570.646440303237, 23900.16349427779, 24269.1505797298, 24305.635415468783, 2390.067873529325, 2404.831661783676, 2415.6376543518436, 2453.4234454903085, 2537.8984840606354, 14335.641608959755, 14994.925025374912, 15066.171360575165, 15345.386184552604, 15529.767053494206, 1983.6627773278433, 1990.8805471671747, 1994.112619884152, 2019.162047750182, 2047.846411519142, 79435.6028219861, 80518.75331220219, 81236.0, 81419.59290203512, 81674.59162704209, 10418.447480367358, 10442.477876106164, 10815.459227038617, 10878.456077196108, 11063.114950803916, 14951.925240373728, 15048.548543543711, 15052.397904083715, 15059.698806023818, 15068.623284417758, 8322.0, 8523.190296921783, 8576.699815506552, 8597.527136007455, 8698.260647845003, 8414.537200453911, 8439.156084391512, 8466.830663386698, 8596.742097737078, 8613.22480976715, 6528.771492997722, 6719.798406047827, 6798.8640227196165, 6806.659667016728, 6873.5875847449315, 1778.052414672917, 1832.2916563161145, 1941.0876887862682, 1962.0, 1993.3621241202966, 983.468926779531, 1017.7557386227252, 1060.4379678770265, 1071.4749772611365, 1076.5370890517154, 19912.70130948037, 20100.497487562927, 20409.0, 20411.4897127573, 20491.0, 986.3194395866828, 987.4174237200086, 999.4153420249236, 1011.5953618552638, 1042.5048102151418, 11237.269577477438, 11403.714907127389, 11547.191696581158, 11665.941670291595, 11792.646220613395, 479570.0, 490536.0, 513128.0, 513228.0, 515500.0, 60091.0, 76682.0, 79068.20931790724, 80808.59595701983, 81441.0, 975.5414954971294, 998.8401855703053, 1035.6530562261576, 1038.5897570459776, 1038.678009816959, 13362.665933351354, 17471.0, 17538.298468061646, 18189.272429102686, 18294.0, 37063.44404833876, 38553.421698673985, 44577.0, 45190.32214516851, 45878.0, 53147.20279195738, 54824.177637336266, 55392.0, 55717.44282557123, 56277.43722562722, 8246.257836794717, 8505.149485051692, 8532.360072994674, 8647.437916535406, 8800.295976321751, 9895.406275623485, 14015.859841401456, 14078.296085195494, 14383.496577619733, 14409.495667652001, 11518.25131366492, 11796.587119450778, 12403.25580465175, 12412.81380779271, 12856.292903890377, 11803.527858885893, 11926.821097683369, 12163.026957843174, 12326.137170397986, 12677.0, 12007.81988270194, 12548.811767823672, 12582.748345033231, 12705.17416367933, 12829.23024618526, 8438.071812100541, 8616.698415555426, 8622.956885215533, 8667.089955554577, 8730.345224108345, 8704.825903482022, 11173.944130279297, 11915.642530724092, 12329.938350308192, 12506.749865002466], "value": 9493.744898053557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.1851241073614, 1516.681496885654, 1650.364609625294, 1778.5820332221926, 1805.9367922122728, 8615.741527754162, 9027.14242146995, 9148.268138548916, 9155.496447695383, 9170.816583668331, 7836.333911617505, 8499.872501912461, 8827.470351778882, 8834.337424693158, 8963.55182240887, 2231.2859884836857, 2246.6068438023362, 2247.1236217875044, 2250.1224522436264, 2251.763564825694, 2204.250554811372, 2204.812590929773, 2248.5053288276554, 2249.8425110242288, 2249.921252756154, 1808.2495764257817, 2111.2082968886666, 2188.540406514626, 2189.6058709432295, 2194.199117322174, 2213.7232845894264, 2223.1218668625884, 2230.609643312414, 2233.2965115988413, 2244.8204143668468, 2173.076442511942, 2173.9673904891283, 2176.238316589197, 2179.106566307806, 2181.3564998325533, 9023.233025192867, 9148.085191480799, 9150.81698366029, 9157.358984871062, 9158.267338612895, 5076.111680455905, 5196.740162991835, 5201.635885488017, 5204.609654275944, 5205.869853253661, 3257.8859739909226, 3312.0560640217664, 3407.8296085195643, 3410.2497450560836, 3426.623071462137, 1057.2810488867567, 1065.55779351569, 1076.6716151573767, 1091.4051841746268, 1096.117625311624, 12616.621501354974, 12629.24224546521, 12635.684107897285, 12639.052071094704, 12646.304453255067, 4414.735115893057, 4484.663650226246, 4582.335561343587, 4583.312503124558, 4613.561711637389, 10469.68590942273, 10526.526306316235, 10540.472976351151, 10541.84187237192, 10542.631007914686, 5160.380754309507, 5165.173572228426, 5166.535011848951, 5168.8966220675375, 5169.302144210484, 4704.647151463654, 4737.0525894820485, 4738.3840100787365, 4742.668013239109, 4839.080574690797, 3906.3554513504955, 3919.2945269851703, 3944.783036932939, 3976.383660532622, 4012.498437695288, 1092.5738961804902, 1222.2422098299112, 1223.1010207497482, 1250.93745312734, 1252.824604555363, 890.3144578674385, 996.8106059848751, 999.6051559633904, 1001.5342865567401, 1002.8445590933417, 5860.208871802337, 5925.200097986803, 5943.078822782476, 5975.7609695612555, 6107.511399088063, 963.6868017894072, 979.1481411172183, 980.3529670417632, 988.0761488008735, 993.046675191824, 4289.806958686867, 4360.847370342023, 4373.497047839475, 4375.2780791169735, 4376.540463251376, 11183.105351571854, 11332.206745527734, 11525.538978440936, 11567.826482602768, 11609.593664221711, 10772.78454430907, 11209.0, 11216.327020378803, 11508.654740357802, 11518.675352334589, 7435.25647435263, 8067.919320806717, 8292.37807164465, 8354.498730076215, 8511.04246023418, 6300.905486417616, 6314.715837787402, 6388.8083357499345, 6427.903581446376, 6595.175603049619, 10247.128994035591, 10584.788304233718, 10639.468026598484, 10653.254272200871, 10830.133589312994, 10554.630587929385, 10934.398608076632, 11025.393603351893, 11067.667969960914, 11159.72100697489, 7931.286184243446, 8191.79520511992, 8195.877061843958, 8200.343972482067, 8201.343892488467, 8650.956745216234, 8660.523671197892, 8680.826383472422, 8698.565071746514, 8721.0, 6623.531665905262, 7316.746857207821, 7412.814679633052, 8056.476329038594, 8294.626741796514, 7615.276548727862, 7664.463487555818, 7904.565248911365, 7938.04743430792, 8018.8396232073865, 7086.078809754699, 7295.635218239173, 7301.890471643036, 7353.448491363062, 7400.222976587596, 5188.325517682677, 5320.334958130234, 5327.600429967845, 5328.254044433705, 5423.728813559227, 5379.919301210407, 5384.838454846361, 5518.779248830162, 5575.275214222125, 5644.096944488862], "value": 4681.8482595941805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.08019998903353, 308.40631783816156, 313.07018156076447, 316.1921291101235, 319.380402020081, 5052.469490703478, 5133.691978481284, 5227.738613069346, 5277.393099793525, 5281.155015197569, 5161.657968928078, 5209.088409528336, 5228.215767634857, 5241.161414173733, 5262.210668399742, 4055.959440405588, 4061.4566464743357, 4068.2270368629866, 4073.9592604074023, 4081.693872959525, 3874.4769456123486, 3910.335243008695, 4072.6538244249273, 4073.103917138225, 4122.402251673506, 4089.8364065437345, 4090.365993271048, 4096.201240758039, 4105.762359514072, 4107.897302567445, 4083.2854250506193, 4088.3049881520215, 4093.8362465501345, 4095.1400205956784, 4118.114605359862, 3404.8297585120645, 3639.5268615080136, 3640.526731524911, 3650.7809531428197, 3657.4148136298063, 5090.669106508065, 5109.6678715883345, 5118.667286626357, 5118.667286626394, 5118.846434606968, 4595.414581969215, 4622.237330840408, 4623.283391074388, 4630.884227894329, 4634.953650463486, 5183.429822719498, 5408.945910540883, 5413.458654134594, 5422.15956526739, 5446.264754258164, 3940.133170702441, 3972.5828787977425, 3995.1011022519992, 3998.5601583825755, 4000.419939108842, 5616.241807356037, 5639.6334238274385, 5644.971775141098, 5666.9716651416475, 5671.149327600851, 4100.425940368351, 4102.261592913244, 4109.9589004109575, 4118.402831589463, 4135.524414692289, 3952.9011774705864, 4178.22702799983, 4186.644135248477, 4195.832166713297, 4205.495340559152, 4608.216603177468, 4639.306653071604, 4687.718736875799, 4703.341532185496, 4710.905781884343, 5387.24578559002, 5408.458024728371, 5413.891722165614, 5480.972595136999, 5488.121900495901, 1307.6534718299658, 1312.4750099960092, 1404.7822587498954, 1407.90848594841, 1410.6543896745363, 948.369334392635, 965.3532133470592, 972.246508955551, 979.7501637082498, 980.9852852207223, 5251.343582052244, 5270.604704647167, 5298.231756395301, 5302.522772950453, 5307.177387504943, 5498.697571633598, 5551.306086739158, 5551.805686800943, 5580.581456390706, 5582.497575218169, 5090.821821236239, 5270.49930256625, 5278.947210527922, 5283.1546952487415, 5392.352917649829, 2974.973634096233, 2977.5533669949245, 2977.955330670042, 2980.7317341439375, 2995.2811325281777, 5712.942870571324, 5751.827445176651, 5778.624389414675, 5798.59409841307, 5834.299884013945, 5588.161775733591, 5697.259356283656, 5731.484166425042, 5737.483626473554, 5777.45114214149, 5765.4811067004175, 5783.219265399117, 5791.82624521265, 5817.360090390053, 5832.912506312324, 5394.757235924471, 5593.608447408642, 5624.212610234652, 5637.774489020393, 5647.943520564906, 5521.585881058856, 5570.359408668055, 5596.0, 5600.523955463668, 5606.411326810626, 5769.538436924952, 5772.19189313488, 5779.36426993022, 5802.796902108406, 5818.359980402068, 3594.730395220421, 3659.670629643345, 3775.8489660413275, 3968.583298753589, 3983.1834473933354, 5489.780408783764, 5544.1960915666195, 5576.944230557642, 5577.330720313588, 5577.776888924398, 5412.188171774108, 5420.620556561003, 5423.74575254844, 5424.3761967372675, 5430.348358196884, 5231.921521177262, 5420.457954204706, 5500.697461639648, 5533.501984821385, 5542.307211598551, 5415.48552887475, 5427.580624206725, 5434.918476222781, 5437.755301011385, 5440.891182176413, 5352.464753524617, 5522.502974732293, 5533.0, 5540.8087261239025, 5545.750441230073, 5404.189371594292, 5418.729063546728, 5436.211749296409, 5437.891242175056, 5439.9456005441025], "value": 4174.198850536775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.7579092159558, 692.580988501956, 736.8673638745025, 769.7729169894884, 862.6075135813204, 15394.461193858217, 15637.218139093056, 16409.917950410232, 16441.588960275985, 16444.58888527786, 14126.0, 14581.92709036456, 14594.562163135122, 14595.708085838276, 14694.118352898808, 663.0485253661, 690.5166383531523, 693.3655705029892, 694.0179645801185, 794.2534018023068, 813.8250276190618, 822.0751654388813, 822.6627082896014, 824.1305422778966, 825.9008918929737, 847.9321654267675, 852.228732996639, 852.9402941794077, 853.0403296291672, 853.2832420766555, 695.6591270277553, 849.133883438892, 852.2713080316333, 853.0318088969003, 883.3110174064176, 613.4080612209195, 619.4115590189293, 619.4889216396491, 620.0141774578397, 620.0482259731291, 15318.463853765175, 15348.846511534854, 15365.462208822637, 15402.768958465633, 15438.9228053859, 15375.923120384326, 15663.608409789733, 15768.369265229378, 15781.447649332333, 15782.68434631301, 12088.697782555419, 12124.818127728091, 12215.450304736309, 12542.74914501705, 12817.166884152593, 4688.179568575486, 4788.928166077511, 4812.278158276252, 4943.505649435064, 4943.92584111235, 78578.21421785766, 79763.0, 80028.59985700093, 80659.0, 81626.0, 11436.31382117059, 11510.251833630788, 11546.364949927667, 11639.53441862316, 11654.650360489199, 21223.0, 21252.681209781866, 21268.468288292606, 21279.255226067322, 21291.57416851654, 8341.45780524264, 8478.576071196416, 8494.108118647453, 8693.261072808882, 8864.556772161366, 4824.638152138604, 4913.31213630092, 4949.554540091337, 4992.975035124801, 5226.0, 3706.703463722896, 3817.770933743984, 3819.102510909934, 3826.655600995868, 3841.4045822897497, 642.9324920883333, 649.1009951217598, 655.7409823119841, 660.9405153536205, 665.55075324156, 608.2275510102234, 616.315889362807, 695.1658010387555, 722.7181399254295, 739.5008369350775, 9234.1689247968, 9723.416595004323, 9746.171575416169, 9876.209903207726, 9943.204543636637, 670.9429698475684, 695.5061906046662, 706.4560288577767, 714.5783987447431, 716.8207948012997, 4499.244641441484, 4771.475137734847, 4831.0, 4898.769075834706, 4914.115459217375, 71245.0, 114532.0, 119048.0, 120467.0, 121033.78966210401, 72798.99999999894, 100738.0, 100779.0, 102470.0, 102953.0, 87673.56163219143, 87902.0, 88648.5567572158, 89123.55438222637, 90175.0, 8875.689350872688, 9064.818703626022, 9067.501287429255, 9096.408733432305, 9104.590293436679, 52668.20997685115, 52808.73595631997, 53683.731581341846, 53841.0, 54054.456034584335, 74367.62816185884, 78577.0, 79804.0, 80088.59955700184, 80275.59862200651, 11926.821097683369, 12597.685057873627, 12981.091323607257, 13429.328533573087, 13594.728105438033, 15733.685326293182, 15796.68406631884, 15814.446494372642, 16335.168001272023, 16434.178291085158, 14729.55811325662, 14796.334164962387, 15235.923820380827, 15588.454404095803, 16201.75697364517, 14176.858231417966, 14615.561533154023, 15187.316570754563, 15569.766453503433, 15757.212139393214, 13840.861591383957, 14366.209858457885, 14495.275236238356, 14718.852811471748, 15657.217139143226, 10748.4088375137, 11259.796131548828, 11736.88263117358, 12257.509699611915, 12500.812487812873, 11900.166988310735, 12207.938960305142, 12262.632121036384, 12488.25070495773, 12522.812157817458], "value": 7752.8741225236645, "unit": "score"}], "name": "dromaeo_css", "value": 7291.204473971961, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 116.0, 110.0, 110.0, 110.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 119.0, 179.0, 117.0, 119.0, 143.0, 119.0, 176.0, 117.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 160.0, 160.0, 159.0, 160.0, 161.0, 160.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 114.0, 75.0, 75.0, 75.0, 74.0, 98.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 84.0, 83.0, 115.0, 85.0, 84.0, 127.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 53.0, 54.0, 56.0, 53.0, 52.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 64.0, 63.0, 62.0, 63.0, 62.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 75.0, 83.0, 78.0, 75.0, 81.0, 74.0, 80.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 121.0, 124.0, 127.0, 125.0, 118.0, 121.0, 161.0, 122.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 156.0, 156.0, 157.0, 154.0, 153.0, 161.0, 154.0, 153.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 62.0, 63.0, 62.0, 64.0, 63.0, 63.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1476.9999999999998, "alertThreshold": 2.0}]} 10:56:56 INFO - Return code: 0 10:56:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:56:56 INFO - # TBPL SUCCESS # 10:56:56 INFO - Running post-action listener: _resource_record_post_action 10:56:56 INFO - ##### 10:56:56 INFO - ##### Finished run-tests step (success) 10:56:56 INFO - ##### 10:56:56 INFO - Running post-run listener: _resource_record_post_run 10:56:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555995136; Read time: 16; Write time: 412676 10:56:56 INFO - TinderboxPrint: CPU usage
12.9% 10:56:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:56:56 INFO - TinderboxPrint: I/O write bytes / time
555,995,136 / 412,676 10:56:56 INFO - TinderboxPrint: CPU idle
8,282.3 (87.1%) 10:56:56 INFO - TinderboxPrint: CPU user
1,186.2 (12.5%) 10:56:56 INFO - TinderboxPrint: Swap in / out
0 / 0 10:56:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 265375744; Read time: 0; Write time: 257752 10:56:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290619392; Read time: 0; Write time: 154924 10:56:56 INFO - Running post-run listener: _upload_blobber_files 10:56:56 INFO - Blob upload gear active. 10:56:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:56:56 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 10:56:56 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'] 10:56:56 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 10:56:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:56:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:58 INFO - (blobuploader) - INFO - Done attempting. 10:56:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:56:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:57:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:02 INFO - (blobuploader) - INFO - Done attempting. 10:57:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:57:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:57:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:02 INFO - (blobuploader) - INFO - Done attempting. 10:57:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:57:02 INFO - Return code: 0 10:57:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:57:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:57:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b92835b723d75532580ee20a38b967a5866f89bb45a98ff36c7f8d0599d7e7b50e360e068467e4efde154eb5370e890a81cf3017a8269eb7762f91e9d6ad2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3bd92f3f375da890019ca8eb5245ef599fdfbfdc057d005e050b2841181b410f347bcc6ac27b9eaa49c7ba2d6bf87fa1f8bdbac629703d8e04a84b5d4dcaa66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06ce635d4bef023e88f2d09bbf0ff710cd9061c0d24a09b0c1937768884d3c3f761040699982196d6116810d6f21441625ab9a5670c9cd5d55a86483c14ac086"} 10:57:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:57:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:57:02 INFO - Contents: 10:57:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b92835b723d75532580ee20a38b967a5866f89bb45a98ff36c7f8d0599d7e7b50e360e068467e4efde154eb5370e890a81cf3017a8269eb7762f91e9d6ad2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3bd92f3f375da890019ca8eb5245ef599fdfbfdc057d005e050b2841181b410f347bcc6ac27b9eaa49c7ba2d6bf87fa1f8bdbac629703d8e04a84b5d4dcaa66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06ce635d4bef023e88f2d09bbf0ff710cd9061c0d24a09b0c1937768884d3c3f761040699982196d6116810d6f21441625ab9a5670c9cd5d55a86483c14ac086"} 10:57:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:57:02 INFO - Copying logs to upload dir... 10:57:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:57:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.560830 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-07 10:57:03.109482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 10:57:03.117444) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548 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/3b92835b723d75532580ee20a38b967a5866f89bb45a98ff36c7f8d0599d7e7b50e360e068467e4efde154eb5370e890a81cf3017a8269eb7762f91e9d6ad2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3bd92f3f375da890019ca8eb5245ef599fdfbfdc057d005e050b2841181b410f347bcc6ac27b9eaa49c7ba2d6bf87fa1f8bdbac629703d8e04a84b5d4dcaa66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06ce635d4bef023e88f2d09bbf0ff710cd9061c0d24a09b0c1937768884d3c3f761040699982196d6116810d6f21441625ab9a5670c9cd5d55a86483c14ac086"} build_url:https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/dhhxyWyJQy6UhcBMSX4qcg/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/3b92835b723d75532580ee20a38b967a5866f89bb45a98ff36c7f8d0599d7e7b50e360e068467e4efde154eb5370e890a81cf3017a8269eb7762f91e9d6ad2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b3bd92f3f375da890019ca8eb5245ef599fdfbfdc057d005e050b2841181b410f347bcc6ac27b9eaa49c7ba2d6bf87fa1f8bdbac629703d8e04a84b5d4dcaa66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06ce635d4bef023e88f2d09bbf0ff710cd9061c0d24a09b0c1937768884d3c3f761040699982196d6116810d6f21441625ab9a5670c9cd5d55a86483c14ac086"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 10:57:03.145733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:57:03.146069) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1467912990.768194-2029291548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:57:03.194919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 10:57:03.198293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 10:57:03.198601) ========= ========= Total master_lag: 0.64 =========