builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1468279643.57 results: success (0) buildid: 20160711133152 builduid: 68c12927bce84086bd7c73f9611ba76f revision: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.568115) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.568662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.568953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.584392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.584891) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 16:27:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-07-11 16:27:23 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112745 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.712281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.712623) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014190 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:23.762716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 16:27:23.763113) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9189a2cc39d0c35e8823349aa0b4057ab8167b32 --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 9189a2cc39d0c35e8823349aa0b4057ab8167b32 --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=14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 16:27:23,880 truncating revision to first 12 chars 2016-07-11 16:27:23,880 Setting DEBUG logging. 2016-07-11 16:27:23,880 attempt 1/10 2016-07-11 16:27:23,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9189a2cc39d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 16:27:24,905 unpacking tar archive at: mozilla-inbound-9189a2cc39d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 16:27:25.167333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:25.167679) ========= script_repo_revision: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:25.168086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:25.168361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 16:27:25.177588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-11 16:27:25.177887) ========= /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=14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:27:25 INFO - MultiFileLogger online at 20160711 16:27:25 in /builds/slave/test 16:27:25 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 16:27:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:27:25 INFO - {'append_to_log': False, 16:27:25 INFO - 'base_work_dir': '/builds/slave/test', 16:27:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:27:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:27:25 INFO - 'branch': 'Mozilla-Inbound', 16:27:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:27:25 INFO - 'config_files': ('talos/linux_config.py',), 16:27:25 INFO - 'default_actions': ('clobber', 16:27:25 INFO - 'read-buildbot-config', 16:27:25 INFO - 'download-and-extract', 16:27:25 INFO - 'populate-webroot', 16:27:25 INFO - 'create-virtualenv', 16:27:25 INFO - 'install', 16:27:25 INFO - 'run-tests'), 16:27:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:27:25 INFO - 'download_minidump_stackwalk': True, 16:27:25 INFO - 'download_symbols': 'ondemand', 16:27:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:27:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:27:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:27:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:27:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:27:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:27:25 INFO - 'installer_path': 'installer.exe', 16:27:25 INFO - 'log_level': 'info', 16:27:25 INFO - 'log_name': 'talos', 16:27:25 INFO - 'log_to_console': True, 16:27:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:27:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:27:25 INFO - 'opt_config_files': (), 16:27:25 INFO - 'pip_index': False, 16:27:25 INFO - 'sps_profile': False, 16:27:25 INFO - 'sps_profile_interval': 0, 16:27:25 INFO - 'suite': 'dromaeojs', 16:27:25 INFO - 'system_bits': '32', 16:27:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:27:25 INFO - 'title': 'talos-linux64-ix-036', 16:27:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:27:25 INFO - 'use_talos_json': True, 16:27:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:27:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:27:25 INFO - 'work_dir': 'build'} 16:27:25 INFO - ##### 16:27:25 INFO - ##### Running clobber step. 16:27:25 INFO - ##### 16:27:25 INFO - Running pre-action listener: _resource_record_pre_action 16:27:25 INFO - Running main action method: clobber 16:27:25 INFO - rmtree: /builds/slave/test/build 16:27:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:27:25 INFO - Running post-action listener: _resource_record_post_action 16:27:25 INFO - ##### 16:27:25 INFO - ##### Finished clobber step (success) 16:27:25 INFO - ##### 16:27:25 INFO - ##### 16:27:25 INFO - ##### Running read-buildbot-config step. 16:27:25 INFO - ##### 16:27:25 INFO - Running pre-action listener: _resource_record_pre_action 16:27:25 INFO - Running main action method: read_buildbot_config 16:27:25 INFO - Using buildbot properties: 16:27:25 INFO - { 16:27:25 INFO - "project": "", 16:27:25 INFO - "product": "firefox", 16:27:25 INFO - "script_repo_revision": "production", 16:27:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:27:25 INFO - "repository": "", 16:27:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:27:25 INFO - "buildid": "20160711133152", 16:27:25 INFO - "pgo_build": "True", 16:27:25 INFO - "basedir": "/builds/slave/test", 16:27:25 INFO - "buildnumber": 1233, 16:27:25 INFO - "slavename": "talos-linux64-ix-036", 16:27:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:27:25 INFO - "platform": "ubuntu64_hw", 16:27:25 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:27:25 INFO - "branch": "mozilla-inbound", 16:27:25 INFO - "repo_path": "integration/mozilla-inbound", 16:27:25 INFO - "revision": "9189a2cc39d0c35e8823349aa0b4057ab8167b32", 16:27:25 INFO - "stage_platform": "linux64-pgo", 16:27:25 INFO - "builduid": "68c12927bce84086bd7c73f9611ba76f", 16:27:25 INFO - "slavebuilddir": "test" 16:27:25 INFO - } 16:27:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:27:25 INFO - Running post-action listener: _resource_record_post_action 16:27:25 INFO - ##### 16:27:25 INFO - ##### Finished read-buildbot-config step (success) 16:27:25 INFO - ##### 16:27:25 INFO - ##### 16:27:25 INFO - ##### Running download-and-extract step. 16:27:25 INFO - ##### 16:27:25 INFO - Running pre-action listener: _resource_record_pre_action 16:27:25 INFO - Running main action method: download_and_extract 16:27:25 INFO - mkdir: /builds/slave/test/build/tests 16:27:25 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')]} 16:27:25 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:27:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:27:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:27:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:26 INFO - Downloaded 1361 bytes. 16:27:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:27:26 INFO - Using the following test package requirements: 16:27:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:27:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:27:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:27:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'jsshell-linux-x86_64.zip'], 16:27:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:27:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:27:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:27:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:27:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:27:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:27:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:26 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:27:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:27:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:27:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:27 INFO - Downloaded 24307618 bytes. 16:27:27 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'] 16:27:27 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 16:27:28 INFO - Return code: 0 16:27:28 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 16:27:28 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')]} 16:27:28 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:27:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:27:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:27:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:30 INFO - Downloaded 24307618 bytes. 16:27:30 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'] 16:27:30 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 16:27:31 INFO - Return code: 0 16:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:31 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:32 INFO - Downloaded 14403317 bytes. 16:27:32 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'] 16:27:32 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 16:27:32 INFO - Return code: 0 16:27:32 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')]} 16:27:32 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:27:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:27:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:27:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:27:34 INFO - Downloaded 60489570 bytes. 16:27:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:27:34 INFO - mkdir: /builds/slave/test/properties 16:27:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:27:34 INFO - Writing to file /builds/slave/test/properties/build_url 16:27:34 INFO - Contents: 16:27:34 INFO - build_url:https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:27:34 INFO - Running post-action listener: _resource_record_post_action 16:27:35 INFO - Running post-action listener: set_extra_try_arguments 16:27:35 INFO - ##### 16:27:35 INFO - ##### Finished download-and-extract step (success) 16:27:35 INFO - ##### 16:27:35 INFO - ##### 16:27:35 INFO - ##### Running populate-webroot step. 16:27:35 INFO - ##### 16:27:35 INFO - Running pre-action listener: _resource_record_pre_action 16:27:35 INFO - Running main action method: populate_webroot 16:27:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:27:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:27:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:27:35 INFO - '--tppagecycles', 16:27:35 INFO - '7'], 16:27:35 INFO - 'tests': ['tsvgm']}}, 16:27:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:27:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:27:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:27:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:27:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['damp', 'tps']}, 16:27:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'tests': ['damp', 'tps']}, 16:27:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['dromaeo_dom']}, 16:27:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:27:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['basic_compositor_video']}, 16:27:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:27:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['a11yr', 16:27:35 INFO - 'ts_paint', 16:27:35 INFO - 'tpaint', 16:27:35 INFO - 'sessionrestore', 16:27:35 INFO - 'sessionrestore_no_auto_restore', 16:27:35 INFO - 'tabpaint']}, 16:27:35 INFO - 'other-e10s': {'tests': ['a11yr', 16:27:35 INFO - 'ts_paint', 16:27:35 INFO - 'tpaint', 16:27:35 INFO - 'sessionrestore', 16:27:35 INFO - 'sessionrestore_no_auto_restore', 16:27:35 INFO - 'tabpaint']}, 16:27:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:27:35 INFO - 'ts_paint', 16:27:35 INFO - 'tpaint', 16:27:35 INFO - 'sessionrestore', 16:27:35 INFO - 'sessionrestore_no_auto_restore', 16:27:35 INFO - 'tabpaint']}, 16:27:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:27:35 INFO - 'ts_paint', 16:27:35 INFO - 'tpaint', 16:27:35 INFO - 'sessionrestore', 16:27:35 INFO - 'sessionrestore_no_auto_restore', 16:27:35 INFO - 'tabpaint']}, 16:27:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['a11yr', 16:27:35 INFO - 'ts_paint', 16:27:35 INFO - 'tpaint', 16:27:35 INFO - 'sessionrestore', 16:27:35 INFO - 'sessionrestore_no_auto_restore', 16:27:35 INFO - 'tabpaint']}, 16:27:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['a11yr', 16:27:35 INFO - 'ts_paint', 16:27:35 INFO - 'tpaint', 16:27:35 INFO - 'sessionrestore', 16:27:35 INFO - 'sessionrestore_no_auto_restore', 16:27:35 INFO - 'tabpaint']}, 16:27:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['tsvgx', 16:27:35 INFO - 'tsvgr_opacity', 16:27:35 INFO - 'tart', 16:27:35 INFO - 'tscrollx', 16:27:35 INFO - 'cart']}, 16:27:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:27:35 INFO - 'tsvgr_opacity', 16:27:35 INFO - 'tart', 16:27:35 INFO - 'tscrollx', 16:27:35 INFO - 'cart']}, 16:27:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'talos_options': ['--disable-e10s'], 16:27:35 INFO - 'tests': ['tp5o']}, 16:27:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'tests': ['tp5o']}, 16:27:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'talos_options': ['--disable-e10s', 16:27:35 INFO - '--xperf_path', 16:27:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:35 INFO - 'tests': ['tp5n']}, 16:27:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:27:35 INFO - 'talos_options': ['--xperf_path', 16:27:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:35 INFO - 'tests': ['tp5n']}}, 16:27:35 INFO - 'talos.zip': {'path': '', 16:27:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:27:35 INFO - Running post-action listener: _resource_record_post_action 16:27:35 INFO - ##### 16:27:35 INFO - ##### Finished populate-webroot step (success) 16:27:35 INFO - ##### 16:27:35 INFO - ##### 16:27:35 INFO - ##### Running create-virtualenv step. 16:27:35 INFO - ##### 16:27:35 INFO - Running pre-action listener: _resource_record_pre_action 16:27:35 INFO - Running main action method: create_virtualenv 16:27:35 INFO - Creating virtualenv /builds/slave/test/build/venv 16:27:35 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 16:27:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:27:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:27:35 INFO - Using real prefix '/usr' 16:27:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:27:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:27:37 INFO - Installing pip.................done. 16:27:37 INFO - Return code: 0 16:27:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:37 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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:37 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 16:27:37 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 16:27:37 INFO - Using env: {'DISPLAY': ':0', 16:27:37 INFO - 'HOME': '/home/cltbld', 16:27:37 INFO - 'LANG': 'en_US.UTF-8', 16:27:37 INFO - 'LANGUAGE': 'en_US:en', 16:27:37 INFO - 'LOGNAME': 'cltbld', 16:27:37 INFO - 'MAIL': '/var/mail/cltbld', 16:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:37 INFO - 'MOZ_NO_REMOTE': '1', 16:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:37 INFO - 'NO_EM_RESTART': '1', 16:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:37 INFO - 'PWD': '/builds/slave/test', 16:27:37 INFO - 'SHELL': '/bin/bash', 16:27:37 INFO - 'SHLVL': '1', 16:27:37 INFO - 'TERM': 'linux', 16:27:37 INFO - 'TMOUT': '86400', 16:27:37 INFO - 'USER': 'cltbld', 16:27:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:37 INFO - '_': '/tools/buildbot/bin/python'} 16:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:37 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 16:27:37 INFO - Cleaning up... 16:27:37 INFO - Return code: 0 16:27:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:37 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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:37 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 16:27:37 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 16:27:37 INFO - Using env: {'DISPLAY': ':0', 16:27:37 INFO - 'HOME': '/home/cltbld', 16:27:37 INFO - 'LANG': 'en_US.UTF-8', 16:27:37 INFO - 'LANGUAGE': 'en_US:en', 16:27:37 INFO - 'LOGNAME': 'cltbld', 16:27:37 INFO - 'MAIL': '/var/mail/cltbld', 16:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:37 INFO - 'MOZ_NO_REMOTE': '1', 16:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:37 INFO - 'NO_EM_RESTART': '1', 16:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:37 INFO - 'PWD': '/builds/slave/test', 16:27:37 INFO - 'SHELL': '/bin/bash', 16:27:37 INFO - 'SHLVL': '1', 16:27:37 INFO - 'TERM': 'linux', 16:27:37 INFO - 'TMOUT': '86400', 16:27:37 INFO - 'USER': 'cltbld', 16:27:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:37 INFO - '_': '/tools/buildbot/bin/python'} 16:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:38 INFO - Downloading/unpacking psutil>=3.1.1 16:27:38 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 16:27:38 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 16:27:38 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 16:27:38 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 16:27:38 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 16:27:38 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 16:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:27:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:40 INFO - Installing collected packages: psutil 16:27:40 INFO - Running setup.py install for psutil 16:27:40 INFO - building 'psutil._psutil_linux' extension 16:27:40 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 16:27:40 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 16:27:40 INFO - building 'psutil._psutil_posix' extension 16:27:40 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 16:27:40 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 16:27:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:40 INFO - Successfully installed psutil 16:27:40 INFO - Cleaning up... 16:27:40 INFO - Return code: 0 16:27:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:40 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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:40 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 16:27:40 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 16:27:40 INFO - Using env: {'DISPLAY': ':0', 16:27:40 INFO - 'HOME': '/home/cltbld', 16:27:40 INFO - 'LANG': 'en_US.UTF-8', 16:27:40 INFO - 'LANGUAGE': 'en_US:en', 16:27:40 INFO - 'LOGNAME': 'cltbld', 16:27:40 INFO - 'MAIL': '/var/mail/cltbld', 16:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:40 INFO - 'MOZ_NO_REMOTE': '1', 16:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:40 INFO - 'NO_EM_RESTART': '1', 16:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:40 INFO - 'PWD': '/builds/slave/test', 16:27:40 INFO - 'SHELL': '/bin/bash', 16:27:40 INFO - 'SHLVL': '1', 16:27:40 INFO - 'TERM': 'linux', 16:27:40 INFO - 'TMOUT': '86400', 16:27:40 INFO - 'USER': 'cltbld', 16:27:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:40 INFO - '_': '/tools/buildbot/bin/python'} 16:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:27:40 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 16:27:40 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 16:27:40 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 16:27:40 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 16:27:40 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 16:27:40 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 16:27:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:27:42 INFO - Installing collected packages: mozsystemmonitor 16:27:42 INFO - Running setup.py install for mozsystemmonitor 16:27:42 INFO - Successfully installed mozsystemmonitor 16:27:42 INFO - Cleaning up... 16:27:42 INFO - Return code: 0 16:27:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:27:42 INFO - Using env: {'DISPLAY': ':0', 16:27:42 INFO - 'HOME': '/home/cltbld', 16:27:42 INFO - 'LANG': 'en_US.UTF-8', 16:27:42 INFO - 'LANGUAGE': 'en_US:en', 16:27:42 INFO - 'LOGNAME': 'cltbld', 16:27:42 INFO - 'MAIL': '/var/mail/cltbld', 16:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:42 INFO - 'MOZ_NO_REMOTE': '1', 16:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:42 INFO - 'NO_EM_RESTART': '1', 16:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:42 INFO - 'PWD': '/builds/slave/test', 16:27:42 INFO - 'SHELL': '/bin/bash', 16:27:42 INFO - 'SHLVL': '1', 16:27:42 INFO - 'TERM': 'linux', 16:27:42 INFO - 'TMOUT': '86400', 16:27:42 INFO - 'USER': 'cltbld', 16:27:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:42 INFO - '_': '/tools/buildbot/bin/python'} 16:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:43 INFO - Downloading/unpacking jsonschema==2.5.1 16:27:43 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 16:27:43 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 16:27:43 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 16:27:43 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 16:27:43 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 16:27:43 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 16:27:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:27:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27:45 INFO - Downloading functools32-3.2.3-2.tar.gz 16:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:27:45 INFO - warning: no files found matching '*.txt' 16:27:45 INFO - no previously-included directories found matching 'build' 16:27:45 INFO - no previously-included directories found matching 'dist' 16:27:45 INFO - no previously-included directories found matching '.git*' 16:27:45 INFO - Installing collected packages: jsonschema, functools32 16:27:45 INFO - Running setup.py install for functools32 16:27:45 INFO - warning: no files found matching '*.txt' 16:27:45 INFO - no previously-included directories found matching 'build' 16:27:45 INFO - no previously-included directories found matching 'dist' 16:27:45 INFO - no previously-included directories found matching '.git*' 16:27:45 INFO - Successfully installed jsonschema functools32 16:27:45 INFO - Cleaning up... 16:27:45 INFO - Return code: 0 16:27:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:27:45 INFO - Using env: {'DISPLAY': ':0', 16:27:45 INFO - 'HOME': '/home/cltbld', 16:27:45 INFO - 'LANG': 'en_US.UTF-8', 16:27:45 INFO - 'LANGUAGE': 'en_US:en', 16:27:45 INFO - 'LOGNAME': 'cltbld', 16:27:45 INFO - 'MAIL': '/var/mail/cltbld', 16:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:45 INFO - 'MOZ_NO_REMOTE': '1', 16:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:45 INFO - 'NO_EM_RESTART': '1', 16:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:45 INFO - 'PWD': '/builds/slave/test', 16:27:45 INFO - 'SHELL': '/bin/bash', 16:27:45 INFO - 'SHLVL': '1', 16:27:45 INFO - 'TERM': 'linux', 16:27:45 INFO - 'TMOUT': '86400', 16:27:45 INFO - 'USER': 'cltbld', 16:27:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:45 INFO - '_': '/tools/buildbot/bin/python'} 16:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:45 INFO - Downloading/unpacking blobuploader==1.2.4 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27:47 INFO - Downloading blobuploader-1.2.4.tar.gz 16:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:27:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:27:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:27:48 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 16:27:48 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 16:27:48 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 16:27:48 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 16:27:48 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 16:27:48 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 16:27:48 INFO - Downloading docopt-0.6.1.tar.gz 16:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:27:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:27:48 INFO - Running setup.py install for blobuploader 16:27:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:27:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:27:48 INFO - Running setup.py install for requests 16:27:48 INFO - Running setup.py install for docopt 16:27:48 INFO - Successfully installed blobuploader requests docopt 16:27:48 INFO - Cleaning up... 16:27:48 INFO - Return code: 0 16:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:48 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')]} 16:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:48 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')]} 16:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:48 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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:48 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 16:27:48 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 16:27:48 INFO - Using env: {'DISPLAY': ':0', 16:27:48 INFO - 'HOME': '/home/cltbld', 16:27:48 INFO - 'LANG': 'en_US.UTF-8', 16:27:48 INFO - 'LANGUAGE': 'en_US:en', 16:27:48 INFO - 'LOGNAME': 'cltbld', 16:27:48 INFO - 'MAIL': '/var/mail/cltbld', 16:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:48 INFO - 'MOZ_NO_REMOTE': '1', 16:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:48 INFO - 'NO_EM_RESTART': '1', 16:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:48 INFO - 'PWD': '/builds/slave/test', 16:27:48 INFO - 'SHELL': '/bin/bash', 16:27:48 INFO - 'SHLVL': '1', 16:27:48 INFO - 'TERM': 'linux', 16:27:48 INFO - 'TMOUT': '86400', 16:27:48 INFO - 'USER': 'cltbld', 16:27:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:48 INFO - '_': '/tools/buildbot/bin/python'} 16:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:27:49 INFO - Running setup.py (path:/tmp/pip-jFFJ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:27:49 INFO - Running setup.py (path:/tmp/pip-BF_nAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:27:49 INFO - Running setup.py (path:/tmp/pip-yBzE7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:27:49 INFO - Running setup.py (path:/tmp/pip-Szw5B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:27:49 INFO - Running setup.py (path:/tmp/pip-snPrQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:27:49 INFO - Running setup.py (path:/tmp/pip-3TMYIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:27:49 INFO - Running setup.py (path:/tmp/pip-S6jxI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:27:49 INFO - Running setup.py (path:/tmp/pip-oGRp33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:27:49 INFO - Running setup.py (path:/tmp/pip-leOVGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:27:49 INFO - Running setup.py (path:/tmp/pip-gmfBgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:27:49 INFO - Running setup.py (path:/tmp/pip-qZBZcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:27:49 INFO - Running setup.py (path:/tmp/pip-xBSTAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:27:50 INFO - Running setup.py (path:/tmp/pip-C4s2gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:27:50 INFO - Running setup.py (path:/tmp/pip-U1eSgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:50 INFO - Running setup.py (path:/tmp/pip-Otgzgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:27:50 INFO - Running setup.py (path:/tmp/pip-THfu_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:27:50 INFO - Running setup.py (path:/tmp/pip-ZifFeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:27:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:27:50 INFO - Running setup.py install for manifestparser 16:27:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:27:50 INFO - Running setup.py install for mozcrash 16:27:50 INFO - Running setup.py install for mozdebug 16:27:50 INFO - Running setup.py install for mozdevice 16:27:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:27:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:27:50 INFO - Running setup.py install for mozfile 16:27:50 INFO - Running setup.py install for mozhttpd 16:27:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Running setup.py install for mozinfo 16:27:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Running setup.py install for mozInstall 16:27:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Running setup.py install for mozleak 16:27:51 INFO - Running setup.py install for mozlog 16:27:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Running setup.py install for moznetwork 16:27:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Running setup.py install for mozprocess 16:27:51 INFO - Running setup.py install for mozprofile 16:27:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Running setup.py install for mozrunner 16:27:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:27:51 INFO - Running setup.py install for mozscreenshot 16:27:51 INFO - Running setup.py install for moztest 16:27:52 INFO - Running setup.py install for mozversion 16:27:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:27:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:27:52 INFO - Cleaning up... 16:27:52 INFO - Return code: 0 16:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:52 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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:52 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 16:27:52 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 16:27:52 INFO - Using env: {'DISPLAY': ':0', 16:27:52 INFO - 'HOME': '/home/cltbld', 16:27:52 INFO - 'LANG': 'en_US.UTF-8', 16:27:52 INFO - 'LANGUAGE': 'en_US:en', 16:27:52 INFO - 'LOGNAME': 'cltbld', 16:27:52 INFO - 'MAIL': '/var/mail/cltbld', 16:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:52 INFO - 'MOZ_NO_REMOTE': '1', 16:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:52 INFO - 'NO_EM_RESTART': '1', 16:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:52 INFO - 'PWD': '/builds/slave/test', 16:27:52 INFO - 'SHELL': '/bin/bash', 16:27:52 INFO - 'SHLVL': '1', 16:27:52 INFO - 'TERM': 'linux', 16:27:52 INFO - 'TMOUT': '86400', 16:27:52 INFO - 'USER': 'cltbld', 16:27:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:52 INFO - '_': '/tools/buildbot/bin/python'} 16:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:27:52 INFO - Running setup.py (path:/tmp/pip-OC505x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:27:52 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)) 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:27:52 INFO - Running setup.py (path:/tmp/pip-V1R2vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:27:52 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)) 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:27:52 INFO - Running setup.py (path:/tmp/pip-Iyqau3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:27:52 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)) 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:27:52 INFO - Running setup.py (path:/tmp/pip-JpUB25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:27:52 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)) 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:27:52 INFO - Running setup.py (path:/tmp/pip-GMbEEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:27:52 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)) 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:27:52 INFO - Running setup.py (path:/tmp/pip-bO3B9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:27:52 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)) 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:27:52 INFO - Running setup.py (path:/tmp/pip-sSIFFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:27:52 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)) 16:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:27:52 INFO - Running setup.py (path:/tmp/pip-1WyyyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:27:53 INFO - Running setup.py (path:/tmp/pip-2YW1SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:27:53 INFO - Running setup.py (path:/tmp/pip-ryE3Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:27:53 INFO - Running setup.py (path:/tmp/pip-vBjq7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:27:53 INFO - Running setup.py (path:/tmp/pip-Kv4ic7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:27:53 INFO - Running setup.py (path:/tmp/pip-2d95G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:27:53 INFO - Running setup.py (path:/tmp/pip-BHJH8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:53 INFO - Running setup.py (path:/tmp/pip-JSBINu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:27:53 INFO - Running setup.py (path:/tmp/pip-U1_DD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:27:53 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)) 16:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:27:53 INFO - Running setup.py (path:/tmp/pip-_DY1KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:27:53 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)) 16:27:53 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)) 16:27:53 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)) 16:27:53 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)) 16:27:53 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)) 16:27:53 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)) 16:27:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:55 INFO - Downloading blessings-1.6.tar.gz 16:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:27:55 INFO - Installing collected packages: blessings 16:27:55 INFO - Running setup.py install for blessings 16:27:55 INFO - Successfully installed blessings 16:27:55 INFO - Cleaning up... 16:27:55 INFO - Return code: 0 16:27:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:27:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:56 INFO - Reading from file tmpfile_stdout 16:27:56 INFO - Current package versions: 16:27:56 INFO - argparse == 1.2.1 16:27:56 INFO - blessings == 1.6 16:27:56 INFO - blobuploader == 1.2.4 16:27:56 INFO - docopt == 0.6.1 16:27:56 INFO - functools32 == 3.2.3-2 16:27:56 INFO - jsonschema == 2.5.1 16:27:56 INFO - manifestparser == 1.1 16:27:56 INFO - mozInstall == 1.12 16:27:56 INFO - mozcrash == 0.17 16:27:56 INFO - mozdebug == 0.1 16:27:56 INFO - mozdevice == 0.48 16:27:56 INFO - mozfile == 1.2 16:27:56 INFO - mozhttpd == 0.7 16:27:56 INFO - mozinfo == 0.9 16:27:56 INFO - mozleak == 0.1 16:27:56 INFO - mozlog == 3.2 16:27:56 INFO - moznetwork == 0.27 16:27:56 INFO - mozprocess == 0.23 16:27:56 INFO - mozprofile == 0.28 16:27:56 INFO - mozrunner == 6.12 16:27:56 INFO - mozscreenshot == 0.1 16:27:56 INFO - mozsystemmonitor == 0.3 16:27:56 INFO - moztest == 0.7 16:27:56 INFO - mozversion == 1.4 16:27:56 INFO - psutil == 3.1.1 16:27:56 INFO - requests == 1.2.3 16:27:56 INFO - wsgiref == 0.1.2 16:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:56 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 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:56 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 16:27:56 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 16:27:56 INFO - Using env: {'DISPLAY': ':0', 16:27:56 INFO - 'HOME': '/home/cltbld', 16:27:56 INFO - 'LANG': 'en_US.UTF-8', 16:27:56 INFO - 'LANGUAGE': 'en_US:en', 16:27:56 INFO - 'LOGNAME': 'cltbld', 16:27:56 INFO - 'MAIL': '/var/mail/cltbld', 16:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:56 INFO - 'MOZ_NO_REMOTE': '1', 16:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:56 INFO - 'NO_EM_RESTART': '1', 16:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:56 INFO - 'PWD': '/builds/slave/test', 16:27:56 INFO - 'SHELL': '/bin/bash', 16:27:56 INFO - 'SHLVL': '1', 16:27:56 INFO - 'TERM': 'linux', 16:27:56 INFO - 'TMOUT': '86400', 16:27:56 INFO - 'USER': 'cltbld', 16:27:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:56 INFO - '_': '/tools/buildbot/bin/python'} 16:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 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)) 16:27:56 INFO - Cleaning up... 16:27:56 INFO - Return code: 0 16:27:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, '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': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', '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 16:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:27:56 INFO - Using env: {'DISPLAY': ':0', 16:27:56 INFO - 'HOME': '/home/cltbld', 16:27:56 INFO - 'LANG': 'en_US.UTF-8', 16:27:56 INFO - 'LANGUAGE': 'en_US:en', 16:27:56 INFO - 'LOGNAME': 'cltbld', 16:27:56 INFO - 'MAIL': '/var/mail/cltbld', 16:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:56 INFO - 'MOZ_NO_REMOTE': '1', 16:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:56 INFO - 'NO_EM_RESTART': '1', 16:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:56 INFO - 'PWD': '/builds/slave/test', 16:27:56 INFO - 'SHELL': '/bin/bash', 16:27:56 INFO - 'SHLVL': '1', 16:27:56 INFO - 'TERM': 'linux', 16:27:56 INFO - 'TMOUT': '86400', 16:27:56 INFO - 'USER': 'cltbld', 16:27:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:56 INFO - '_': '/tools/buildbot/bin/python'} 16:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:27:56 INFO - Cleaning up... 16:27:56 INFO - Return code: 0 16:27:56 INFO - Running post-action listener: _resource_record_post_action 16:27:56 INFO - Running post-action listener: _start_resource_monitoring 16:27:56 INFO - Starting resource monitoring. 16:27:56 INFO - ##### 16:27:56 INFO - ##### Finished create-virtualenv step (success) 16:27:56 INFO - ##### 16:27:56 INFO - ##### 16:27:56 INFO - ##### Running install step. 16:27:56 INFO - ##### 16:27:56 INFO - Running pre-action listener: _resource_record_pre_action 16:27:56 INFO - Running main action method: install 16:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:56 INFO - Reading from file tmpfile_stdout 16:27:56 INFO - Detecting whether we're running mozinstall >=1.0... 16:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:27:56 INFO - Reading from file tmpfile_stdout 16:27:56 INFO - Output received: 16:27:56 INFO - Usage: mozinstall [options] installer 16:27:56 INFO - Options: 16:27:56 INFO - -h, --help show this help message and exit 16:27:56 INFO - -d DEST, --destination=DEST 16:27:56 INFO - Directory to install application into. [default: 16:27:56 INFO - "/builds/slave/test"] 16:27:56 INFO - --app=APP Application being installed. [default: firefox] 16:27:56 INFO - mkdir: /builds/slave/test/build/application 16:27:56 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'] 16:27:56 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 16:28:13 INFO - Reading from file tmpfile_stdout 16:28:13 INFO - Output received: 16:28:13 INFO - /builds/slave/test/build/application/firefox/firefox 16:28:13 INFO - Running post-action listener: _resource_record_post_action 16:28:13 INFO - ##### 16:28:13 INFO - ##### Finished install step (success) 16:28:13 INFO - ##### 16:28:13 INFO - ##### 16:28:13 INFO - ##### Running run-tests step. 16:28:13 INFO - ##### 16:28:13 INFO - Running pre-action listener: _resource_record_pre_action 16:28:13 INFO - Running main action method: run_tests 16:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:28:13 INFO - Python 2.7.3 16:28:13 INFO - Return code: 0 16:28:13 INFO - grabbing minidump binary from tooltool 16:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:13 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 0x22893b0>, '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 0x228a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:28:13 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 16:28:13 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 16:28:13 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 16:28:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:28:14 INFO - Return code: 0 16:28:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:28:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:28:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:28:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:28:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:28:14 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/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:28:14 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/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 16:28:14 INFO - Using env: {'DISPLAY': ':0', 16:28:14 INFO - 'HOME': '/home/cltbld', 16:28:14 INFO - 'LANG': 'en_US.UTF-8', 16:28:14 INFO - 'LANGUAGE': 'en_US:en', 16:28:14 INFO - 'LOGNAME': 'cltbld', 16:28:14 INFO - 'MAIL': '/var/mail/cltbld', 16:28:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:28:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:14 INFO - 'MOZ_NO_REMOTE': '1', 16:28:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:14 INFO - 'NO_EM_RESTART': '1', 16:28:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:14 INFO - 'PWD': '/builds/slave/test', 16:28:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:28:14 INFO - 'SHELL': '/bin/bash', 16:28:14 INFO - 'SHLVL': '1', 16:28:14 INFO - 'TERM': 'linux', 16:28:14 INFO - 'TMOUT': '86400', 16:28:14 INFO - 'USER': 'cltbld', 16:28:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326', 16:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:14 INFO - '_': '/tools/buildbot/bin/python'} 16:28:14 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/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 16:28:14 INFO - mozversion application_buildid: 20160711133152 16:28:14 INFO - mozversion application_changeset: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 16:28:14 INFO - mozversion application_display_name: Nightly 16:28:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:28:14 INFO - mozversion application_name: Firefox 16:28:14 INFO - mozversion application_remotingname: firefox 16:28:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:28:14 INFO - mozversion application_vendor: Mozilla 16:28:14 INFO - mozversion application_version: 50.0a1 16:28:14 INFO - mozversion platform_buildid: 20160711133152 16:28:14 INFO - mozversion platform_changeset: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 16:28:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:28:14 INFO - mozversion platform_version: 50.0a1 16:28:14 INFO - using testdate: 1468279694 16:28:14 INFO - actual date: 1468279694 16:28:14 INFO - starting webserver on 'localhost:49533' 16:28:14 INFO - SUITE-START | Running 2 tests 16:28:14 INFO - TEST-START | dromaeo_css 16:28:14 INFO - operating with platform_type : linux_ 16:28:14 INFO - Initialising browser for dromaeo_css test... 16:28:14 INFO - TEST-INFO | started process 6259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ODS6G/profile http://localhost:49533/getInfo.html) 16:28:18 INFO - PROCESS | 6259 | __metrics Screen width/height:1600/1200 16:28:18 INFO - PROCESS | 6259 | colorDepth:24 16:28:18 INFO - PROCESS | 6259 | Browser inner width/height: 1024/697 16:28:18 INFO - PROCESS | 6259 | __metrics 16:28:19 INFO - PROCESS | 6259 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:28:19 INFO - PROCESS | 6259 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:28:20 INFO - TEST-INFO | 6259: exit 0 16:28:20 INFO - Browser initialized. 16:28:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:28:20 INFO - TEST-INFO | started process 6345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ODS6G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:32 INFO - PROCESS | 6345 | RSS: Main: 157306880 16:28:32 INFO - PROCESS | 6345 | 16:29:23 INFO - PROCESS | 6345 | 1468279763485 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] 16:31:31 INFO - PROCESS | 6345 | Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49533/tests/dromaeo/cssquery-ext.html) 16:31:32 INFO - PROCESS | 6345 | RSS: Main: 259125248 16:31:32 INFO - PROCESS | 6345 | 16:34:34 INFO - PROCESS | 6345 | Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-ext.html (next: http://localhost:49533/tests/dromaeo/cssquery-jquery.html) 16:34:35 INFO - PROCESS | 6345 | RSS: Main: 243630080 16:34:35 INFO - PROCESS | 6345 | 16:37:37 INFO - PROCESS | 6345 | Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49533/tests/dromaeo/cssquery-mootools.html) 16:37:38 INFO - PROCESS | 6345 | RSS: Main: 239394816 16:37:38 INFO - PROCESS | 6345 | 16:40:40 INFO - PROCESS | 6345 | Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49533/tests/dromaeo/cssquery-prototype.html) 16:40:40 INFO - PROCESS | 6345 | RSS: Main: 240287744 16:40:40 INFO - PROCESS | 6345 | 16:43:43 INFO - PROCESS | 6345 | Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49533/tests/dromaeo/cssquery-yui.html) 16:43:44 INFO - PROCESS | 6345 | RSS: Main: 216268800 16:43:44 INFO - PROCESS | 6345 | 16:46:46 INFO - PROCESS | 6345 | Cycle 1(1): loaded http://localhost:49533/tests/dromaeo/cssquery-yui.html (next: http://localhost:49533/tests/dromaeo/cssquery-dojo.html) 16:46:47 INFO - PROCESS | 6345 | RSS: Main: 273035264 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | __start_tp_report 16:46:47 INFO - PROCESS | 6345 | _x_x_mozilla_page_load 16:46:47 INFO - PROCESS | 6345 | _x_x_mozilla_page_load_details 16:46:47 INFO - PROCESS | 6345 | |i|pagename|runs| 16:46:47 INFO - PROCESS | 6345 | |0;dojo.html;3096.67484914084;3114.5639610454527;3138.905832825015;3145.732612727918;3164.3196712706763;5220.112580861253;5314.5748340132795;5433.8369848904495;5551.750171242294;5561.749721262543;5451;5497.642653227537;5507.146392309189;5517.172424136382;5550.58370622204;4907.484714105021;4975.626827987915;5003.699778013331;5017.247412888059;5165.7158856262895;5063.189889617662;5075.9746201268945;5122.692638441706;5122.8207012754565;5139.331886854704;4858.514148585148;4869.9269510957365;4874.512548745115;4899.951000489985;4912.38595175603;4908.116539022974;4912.582430493412;4919.532644398776;4926.408830940274;4964.851054468371;4878.146324393252;4909.042736666352;4931.309616653635;4946.752662366867;4978.477259887696;5437.157240627709;5496.587755918282;5498.147787093007;5552.583556233299;5569.888602227973;5917.763289468416;5928.7628494860155;5932.792352267693;5942.702864856783;5943.138244954501;5599.216109744639;5793.362730099686;5986.132010858401;5987.820365389045;5989.700514974277;5457.645253058538;5502.339719233718;5557.943990641765;5558.388577256539;5558.638688485276;6050.695825049702;6059.372921898114;6059.824140052826;6091.451769340781;6113;5553.305836770403;5662.716864156776;5720.399358067343;5848.88302233953;5856.238688970407;5881.823545293648;5892.263467066617;5893.263342082239;5893.322267939242;5895.174675545427;5774.983698438591;5824.912626310609;5835.474807267281;5838.9124163137585;5842.1236814477315;5679.829605111853;5756.02147634903;5825.446582574648;5835.970820145957;5859.560532959959;4455.732656040583;4455.933161002587;4458.35353873693;4463.04044630406;4495.910081798345;3935.940960885589;3958.129211573449;3978.085040440657;4009.719319647655;4029.778362190049;5284.815031473957;5311.044012077863;5409.188621706697;5449.1826226066405;5458.699771512605;5921.289445266596;5922.940770592239;5924.674142922095;5936.584439089309;5944.167816505693;5490.890182196334;5491.28613280279;5499.945000549943;5506.697131657797;5508.669479831223;4864.246041863516;4971.577415919615;4997.925031124536;5008.5993120550265;5041;6019.909701354483;6037.939620603738;6086.056661217518;6086.847828804404;6090.056041313604;5683.005474042109;5883.882322353615;5899.321578018583;5906.793262235801;5907.054871220584;6005.519558435228;6058.545609079249;6069.51443884497;6095.420935011167;6102.359252278625;5760.366359700346;5789.421057894177;5800.187973683772;5800.477956983723;5801;5669.773209071591;5722.942770572241;5915.704214789157;5923.022701254245;5923.289205295392;5651.039323314964;5716.628419152742;5718.199452076629;5720.713964301685;5781.884362312814;5626.915596265977;5662.7734890603915;5675.971620141873;5696.715164241688;5712;5557.833265002057;5570.637908535932;5581.9162712560155;5694.14587811815;5702.743376548148;5685.118806584986;5692.857678558069;5702.91644587527;5756;5756.597038207453;5530.281063461724;5574.470425309589;5574.749136288796;5578.051731205624;5594.244776955222 16:46:47 INFO - PROCESS | 6345 | |1;ext.html;590.6485641043578;633.5565104426901;634.2452481546961;641.4836056974137;646.6540400885527;33342.66657333426;36439.81780091099;46201.53798462015;47278.527214727845;47291.52708472914;46010.07979840401;46444.30333544999;46601.76699116508;46626;46636.53363466365;8920.910790892089;9043.095690430937;9078;9094.181523662868;9109.089091090871;8949.776255593597;9038.186563209343;9039.819203615923;9040.502772347518;9042.276617870588;9058.094190580921;9099.090090990881;9103.271738260923;9112.49881256534;9120.452772833618;8979.416337938046;9001.054889236666;9045.638174473013;9046.095390460967;9049.502277374742;8885.067067957836;8957.686480973134;8959.776005599848;8966.520524113579;8973.730788076367;41989.580104198874;42151.578484215075;42423.57576424227;42464.15071698549;42498;3477.4609935460044;3624.4925710400566;4092.5702801205744;4289.656827453796;4417.271150260203;31520;33584.49623255653;33814.661853381396;33964.66035339639;34597.82701086504;4350.1734670412525;4380.89047773805;4419.668524860648;4421.828215522889;4462.732236065846;380429;381063;382130;382695;383328;30873.228169295497;31623;31861.362772744415;61406;62378.37621623816;37081.47725966029;37086.258274834356;37273.62726372756;37285.44071838925;37320;15617.921910390603;15745;15810.762838557432;15844.44544440939;15848.841511584737;13437.395317210749;13494.055416120973;13518.59444216675;13522.459101636021;13523.188608683511;8029.197080291924;8063.758087257392;8070.2333278338465;8087.636056377477;8135.959320203361;3146.496560550301;3179.60254968129;3191.5850939377733;3193.680631936788;3207.8716851325685;1005.648023191877;1008.455434065611;1053.1101219469535;1117.1621284036971;1171.753931674341;32095.358092838014;32777.344453111284;32952.67047329496;33005;33483.49774753381;1122.119136477861;1144.6279959013189;1149.0864762513822;1170.806816875206;1192.934388608635;17006.914965425094;17167.914160429118;17298.567535811704;17317;17524.91237543804;163632;582950;583115;590268;590374;58866;59219.703901480214;59396.703016484644;59504.404955950755;59665.70167149136;1225.7732319520917;1325.8541560428346;1361.8433880103717;1379.1587131849565;1387.424218949125;32396.676033239364;34099.318013639095;34342.31315373728;34625;34937.82531087328;48840;49152.75423622859;49377;49402.25896611626;49403.50596493989;397894;398633;400134;401745;401747;23135.537289253785;25254.242372728848;27060;27142.321441964108;27562.586561202;47053.29420058634;48570.271445929044;49014;49173.508264918324;49277;41429.34282628661;41762;42250.36624450574;42415.1516969665;42981;42076.158476830904;42572.36141457818;42997;43191.78404107959;43463;40653.39019914763;41021.179576408904;41773.164536708486;42280.57719422889;42281.71478565179;35306.47040294449;36683.81658091692;36861.26277474489;37715.43426848545;37794.62205377911;28165.692300004343;28411.289717757223;28433.715662843933;28491.857540712164;28566.285842854097 16:46:47 INFO - PROCESS | 6345 | |2;jquery.html;389.69798406235145;390.13195639701667;390.78841809438984;395.0853773514314;417.6199658310938;15027.173505457196;18551.35070272541;18715.3449629263;20409.081591328388;20443.284485043027;14091.859081409182;14700.191489468076;18491.445256642288;19268.614627707437;19810;5583.832485025446;5768.163616275638;5768.567357448187;5770.740316685738;5780.971095144519;4166.958330416687;5647.943520564803;5739.540836733051;5743.5118014968775;6093.695315234243;6363.809085727413;6431.742730290783;6435.806925792233;6457.9677101614425;6467.094606755058;6211.565190436671;6391.265004524493;6401.807945761635;6406.359364063603;6428.903566446507;5545;5657.8019769308285;5660.433956604348;5662.688552129631;5686.2039314496005;23395.532089358287;23691.407714807094;24015.279541613778;24059.518809623885;24327.148549800673;2199.549092436047;2840.5597132444504;2969.6881827408242;2976.389840082778;3143.104215298652;9407.858882116774;9559;9819.263555233314;9826.459544725038;9895.950520247425;1935.7289979402894;1952.375239923225;1963.2834015584351;1967.9409617711492;2029.7462817147857;83644.58177709073;84777;85069.57465212635;86836;89582.5520872398;10479.68560943173;10813.18901082422;10900;10904.890951090547;11084.224104312621;15357.692846143014;15374.692506149815;15435.536933892;15445.84554154444;15452.072875627273;8223.835523289501;8225.971753530808;8226;8419.579021048923;8429.367797415218;8111.716089936942;8267.338612910953;8381;8495.830083398298;8509.361797865186;4236.406903033578;4395.934060989088;4483.349914262479;4503.527129651339;4550.704204226715;1910.2645481489726;1958.1579920634265;2030.9492262693254;2054.075665950328;2074.834013278934;963.6819849449665;1054.093479607537;1055.5355643516828;1067.8451624514403;1079.7030816525519;19164.61670766577;19583.804161958196;19634.21463141487;19713.901430492755;19869.30457433983;961.077365728894;976.4531862157073;987.6247026130025;999.6551189839494;1009.7122320138872;9324.673636422693;10848.186386020921;11012.063974562252;11020.228583999044;11089.33463992163;483345;484235;496488;499084;501825;98752;98941.50529247307;99557;99656.50171749094;99863;974.2449601558849;976.9706908792748;977.4330888085036;982.7199248214224;991.2961797124123;17178.570535736708;17397.739033914248;17631.735523966894;17710.468685939442;17810.465686029438;44540;45364.773176135226;45575;45756.77121614371;45919.3112103312;61111;62721.68639156775;63166;63203.36796631975;63755.362446374944;6052.66710330936;6947.548409353376;8379.49723016621;8848.20366167048;9075.500847453453;10571.418571978615;12831.743365132459;13310.600681979557;13669.38487768033;14263.857361426253;12134.211276267015;12334.876651233373;12413.069019823368;12458.813117803422;12544.435500402322;11663.358515281741;12015.699607509881;12185.756284874431;12220.205686630341;12466.563670271496;12216.328101954477;12400.56598019065;12414.193077449936;12494.750104998031;12594.811077834023;7322.267773222635;7779.72770953014;7841.882371764542;8916.821663566821;9107.089291071105;9089.409188402733;11470.885291146982;11963.042956563628;12106.273623582612;12498 16:46:47 INFO - PROCESS | 6345 | |3;mootools.html;1342.5837990223026;1427.0296198584965;1473.6094934842265;1568.1501912804067;1801.3155001099587;8418.873716894244;8769.736907892757;8776.2101410873;9052.094790520945;9070.63717451301;8845.823083538342;9028.458292502455;9033.23217526511;9042.140996605329;9053.864192037108;1954.794746551613;2001;2002.1090614676475;2336.976630233697;2362.988185059081;2079.3553998260513;2087.6972838938345;2238.9776102238934;2320.3619004773655;2324.407276144581;2297.3682237384687;2324.7791459811374;2339.6724458575814;2342.2504798464497;2343.3790045637834;2023.3727544461117;2333.3000099970027;2352.4354155002848;2353.882305884699;2356.564035653401;2291.7395432512053;2353.670486131943;2356.4815740537056;2373.584622691022;2377.8573285602747;8789.64841406343;8804.911950880472;8827.382083254175;8838.911610883937;8845.29237660992;5060.721660308682;5187.714675692835;5188.948110518884;5198.142306519419;5215.426303106655;3396.3716712408036;3423.0757695422344;3473.6179020307745;3512.8243587820507;3525.347810655037;1186.833843261944;1210.8970737487325;1210.9818352724717;1231.2735486063177;1233.9197952133084;12251.203671761306;12567.937160314323;12604.11771176018;12612.432440540199;12615.243085414813;4427.601515863587;4478.104379124188;4650.348951146842;4671;4674.182018146811;10492.26554141218;10513.579456821795;10516.369017858953;10518.211134164969;10523.94738026305;5262.92105618416;5265.473452654704;5268.552173065333;5272.815451459181;5273.6572122811895;3863.517060367454;4709.411323584552;4745.762711864393;4795.112904112751;4796.976015119972;3946.8026598670526;3964.286428442908;4028.3353246713964;4063.374650139968;4079.265732168179;1223.9938800305943;1258.6916205529703;1267.6260503151593;1268.346801397281;1290.7031382782013;951.6859436385976;993.7267251505749;1031.9742006449749;1034.5913364221242;1035.3994683083793;6160.568760186834;6230.096635987847;6238.500919926395;6251.9687401563615;6330.810075697645;453.20462588158233;460.79724921034637;464.848924099669;467.74040407574125;472.25855407010664;4287.614114729627;4442.2892337225885;4477.485089214717;4488.887777805581;4508.32375143731;10743.08683761889;11143.888561114285;11203.71990700239;11227.045701115334;11235.83146252807;10761.870003649661;11184.217104802749;11262.493187806405;11280.661580152608;11292.096632269398;8271.751847444586;8372;8398.790030249293;8399.160083991552;8455.365847561457;5948.5538584605465;5970.223870896755;5973.402659734165;6024.578279520391;6063.272407311151;10208.132308753839;10209.948950255499;10226.744331391776;10333.638322658671;10343.84484232722;10321.329113607591;10476.580936762444;10480.790384192425;10652.520636571218;10770.838437423601;7186.640667966685;7774.805629859299;7969.521828690297;8102.959485202537;8114.350851931949;8527.616257268313;8853.114688531095;8879.556022198993;8889.155530224618;8902.86645700328;7681.7695469136015;7782.961085194538;7816.257455541714;8132.024157101186;8182.590870456334;7770.417218708506;7851.8037049071945;7920.405969552191;8048.275655190827;8117.391195660231;6679.398854103154;6694.698738556679;6714.697838597177;6737.3599508046655;6738.225104113089;5202.817901373433;5243.632945693765;5318.7074710891275;5391.595630327663;5394.838154855361;5115.616328775432;5418.945810542002;5483.917741233964;5574.91637625444;5610.635308704921 16:46:47 INFO - PROCESS | 6345 | |4;prototype.html;319.5047179201338;324.8278412441406;326.0918342416371;327.46132611853517;331.19684764446214;5310.336207974004;5319;5333.679979201251;5352.357717073952;5359.19612058191;5263.3683957925105;5274.472552744734;5274.736263186835;5336.8132115375965;5338.62629615927;3917.373220284755;4154.376843473473;4170.103427763031;4177.916441671165;4200.873973780792;4077.857274995376;4116.444280022203;4124.422580838685;4139.958600413987;4157.023099571598;4074.97962510187;4102.774347410891;4107.979460102695;4110.917781644365;4124.752514849104;3920.2943470175355;3977.6817854571564;4079.3269110596716;4097.672186225095;4101.179764047202;3601.243738814826;3609.7292703047115;3616.367135751233;3616.566012078541;3624.2932628137523;5136.64043516954;5142.871428214325;5160.303359046518;5188.792448302063;5210.635255532115;4435.955640443586;4504.729716217004;4640.190325772951;4684.976575117136;4713.764311784432;5427.647202931837;5441.891162176735;5451.209574611698;5463.508284254436;5471.425500322488;3955.3473676843287;3977.3039718049226;3979.880603581897;3980.661643760284;3983.721139520235;5495.587830912697;5727.1695604137585;5728.484436400702;5736.684482353469;5768.855778605568;3945.6448919597374;3955.7428767130045;3970.126572154179;3981.8805435836393;3994.2810294147334;4034.1931613677384;4037.596240375939;4048;4052.2908491014546;4056.127932494528;4481.775911204427;4588.839390621312;4603.125406172817;4682.906341873144;4690.624750020059;5491.972540137273;5509.531689806331;5511.366192887869;5526.253955716007;5547.420449491006;1421.1047040364504;1429.1282317786142;1433.3263366217861;1434.5696291112624;1439.5537383411177;866.9033672404413;913.0641092879852;916.3219217778795;916.5050872528893;928.4475736936512;4674.906501870011;4698;4705.55297246761;4707.741074240949;4720.504347043511;5003.324551185616;5019.891645508895;5020.623453241022;5031.7987280509105;5059.114654935372;4712.64655150865;4717.905641887143;4730.408698912636;4731.621470282369;5115.825774046016;3015.5325924481303;3035.605371301717;3039.2553824313186;3039.6504401994052;3040;5890.67601281925;5898.439648233411;5902.557308201902;5912.763489460373;5929.584929055011;5539.584531160099;5704.258446401941;5767.769289228468;5786.363500014995;5826.533877289807;5794.275715535558;5799.3620701722775;5851.683371241522;5866.970665146647;5871.236739223959;5403.83788486346;5669.489745922887;5691.260136182435;5697;5698.857528561819;5629.6903670298525;5639.689817059937;5648.390208790475;5654.123610840326;5658.292713410824;5851.561132915133;5885.793412350372;5891.675957822361;5902.822915312548;5927.555433342431;3867;3992.48097747291;4008.238434697398;4074.1851629673592;4083.8366465341055;5615.241942337732;5615.550755939434;5637.88724225505;5695.316562012585;5703.600747947769;5550.833474995757;5557.5553955682635;5573.498385145356;5588.469095435927;5615.606907516435;5403.811161544454;5485.725713714378;5492.258545096521;5532.640378375393;5536.529395001309;5426.2674538936735;5471.343438787371;5488.807891723771;5515.558755299647;5562.638428502134;5316.315260793274;5414.702191379354;5600.159976003632;5602.52378547828;5632.464915832989;5427.728613569385;5450.5912056595125;5468.644538105011;5477.4796394342475;5550.916736248879 16:46:47 INFO - PROCESS | 6345 | |5;yui.html;707.2927072927076;713.6289129652578;724.4385601159103;790.592844684987;862.8791969124323;15692.76460853088;16256.918715406437;17010.23453944574;17011.319547218096;17034.82965170348;15502.30239639216;15523.922380388081;15689.215539223022;15814.525564233063;15837.524874253791;671.2750229751881;790.8260182759798;793.1632128104847;824.8638974569219;831.6922738586732;811.8173410982512;812.5693382507251;812.8252425728467;815.5799763121997;817.7424111404919;866.6576702202626;867.2108381372921;869.5565261716539;870.5125129927229;870.9608067636972;701.4493622506334;837.949723016621;854.8333075050367;856.3748463621529;858.1847245117164;621.7481919822479;623.1774058243121;624.09506215987;624.4005754475709;625.0811307378146;15642.374305027899;15648.530544083582;15668.68662626741;15691.215439227994;15696.058236505845;12649;12995.740085198338;13084.607461776162;13125.60623181306;13317.067805253637;13290.3354832258;13297.401616927262;13314.134581252187;13487.460501579924;13556.796648050287;4549.658775591844;4566.54334566544;4577.931331030038;4709.175894218532;4712.222483290253;76723.23276767216;77328.61335693342;77785.22214777836;78530.21469785286;78845;11816.70458238551;11846.881531184577;11883.120115486121;11994.520219191134;12204.511819527119;22099.226527071474;22126.336209913727;22226.888865555567;22248.88875555612;22259;8621.61202745878;8827.117288271122;8883.244924181388;8893.866592001124;8931.374803763803;4652.32541281519;4670.5329467053025;4701.341812146302;4747.738874361943;4882.194437917704;3343.632200457948;3491.5810102787827;3498.9825050874583;3502.5796904371637;3503.369393509142;665.0954701605813;677.1467950382455;704.8942658601251;711.3917600451539;722.7000794670258;711.9644017799089;722.7109156337402;736.3777607921298;753.3031945450437;774.9883751743729;10001.79996400068;10074.647387341407;10499.160067194605;10510.55814414596;10667.413292269;647.223371844281;694.8749225139422;745.3440971944763;752.6086435053742;768.757841279995;4751.952480475151;4979.427365852901;5026.220935754964;5070.138076527;5090.465501122403;78934.605326973;126656;131982;135080;138748;116003;116195;117175.48519303225;118226.40886795682;120543;99286;99382.5030874841;101063;101273.49363253136;102894.9999999985;9419;9680.467574283482;9693.951530242304;9701;9733.853992189981;55339.72330138324;55632;57005;57276.8553571604;58355;47473.52526474691;75518;86395.56802215948;87011.68848049713;89600.5519972396;12669.366531673195;12708.173968692005;12811.295378754257;12940.935295323463;13240.867591323964;14329;14370.49703260381;14538.563843084725;14663.48677796272;14693.19187444658;13409.396577154246;13786.586402407944;13897.722045559234;14187.574372768833;14209.715805684034;13901.930490347888;14026.579202623938;14128.43486260538;14726.337314821074;14848.109113453227;12984.15602985803;13135.737285254432;13226.140300880412;13707.520236791665;13739.106958048094;10501.842472362769;10720.19598530129;10841.186910981865;10874.782504350027;10899.237053406185;10608;11377.829332560184;11395;11418.429078546205;11451.370174640475 16:46:47 INFO - PROCESS | 6345 | __end_tp_report 16:46:47 INFO - PROCESS | 6345 | __start_cc_report 16:46:47 INFO - PROCESS | 6345 | _x_x_mozilla_cycle_collect,900 16:46:47 INFO - PROCESS | 6345 | __end_cc_report 16:46:47 INFO - PROCESS | 6345 | __startTimestamp1468280807021__endTimestamp 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | ------- Summary: start ------- 16:46:47 INFO - PROCESS | 6345 | Number of tests: 6 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | [#0] dojo.html Cycles:165 Average:5430.57 Median:5581.92 stddev:629.60 (11.3%) stddev-sans-first:604.33 16:46:47 INFO - PROCESS | 6345 | Values: 3096.7 3114.6 3138.9 3145.7 3164.3 5220.1 5314.6 5433.8 5551.8 5561.7 5451.0 5497.6 5507.1 5517.2 5550.6 4907.5 4975.6 5003.7 5017.2 5165.7 5063.2 5076.0 5122.7 5122.8 5139.3 4858.5 4869.9 4874.5 4900.0 4912.4 4908.1 4912.6 4919.5 4926.4 4964.9 4878.1 4909.0 4931.3 4946.8 4978.5 5437.2 5496.6 5498.1 5552.6 5569.9 5917.8 5928.8 5932.8 5942.7 5943.1 5599.2 5793.4 5986.1 5987.8 5989.7 5457.6 5502.3 5557.9 5558.4 5558.6 6050.7 6059.4 6059.8 6091.5 6113.0 5553.3 5662.7 5720.4 5848.9 5856.2 5881.8 5892.3 5893.3 5893.3 5895.2 5775.0 5824.9 5835.5 5838.9 5842.1 5679.8 5756.0 5825.4 5836.0 5859.6 4455.7 4455.9 4458.4 4463.0 4495.9 3935.9 3958.1 3978.1 4009.7 4029.8 5284.8 5311.0 5409.2 5449.2 5458.7 5921.3 5922.9 5924.7 5936.6 5944.2 5490.9 5491.3 5499.9 5506.7 5508.7 4864.2 4971.6 4997.9 5008.6 5041.0 6019.9 6037.9 6086.1 6086.8 6090.1 5683.0 5883.9 5899.3 5906.8 5907.1 6005.5 6058.5 6069.5 6095.4 6102.4 5760.4 5789.4 5800.2 5800.5 5801.0 5669.8 5722.9 5915.7 5923.0 5923.3 5651.0 5716.6 5718.2 5720.7 5781.9 5626.9 5662.8 5676.0 5696.7 5712.0 5557.8 5570.6 5581.9 5694.1 5702.7 5685.1 5692.9 5702.9 5756.0 5756.6 5530.3 5574.5 5574.7 5578.1 5594.2 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | [#1] ext.html Cycles:180 Average:57967.60 Median:41225.26 stddev:117710.48 (285.5%) stddev-sans-first:117961.86 16:46:47 INFO - PROCESS | 6345 | Values: 590.6 633.6 634.2 641.5 646.7 33342.7 36439.8 46201.5 47278.5 47291.5 46010.1 46444.3 46601.8 46626.0 46636.5 8920.9 9043.1 9078.0 9094.2 9109.1 8949.8 9038.2 9039.8 9040.5 9042.3 9058.1 9099.1 9103.3 9112.5 9120.5 8979.4 9001.1 9045.6 9046.1 9049.5 8885.1 8957.7 8959.8 8966.5 8973.7 41989.6 42151.6 42423.6 42464.2 42498.0 3477.5 3624.5 4092.6 4289.7 4417.3 31520.0 33584.5 33814.7 33964.7 34597.8 4350.2 4380.9 4419.7 4421.8 4462.7 380429.0 381063.0 382130.0 382695.0 383328.0 30873.2 31623.0 31861.4 61406.0 62378.4 37081.5 37086.3 37273.6 37285.4 37320.0 15617.9 15745.0 15810.8 15844.4 15848.8 13437.4 13494.1 13518.6 13522.5 13523.2 8029.2 8063.8 8070.2 8087.6 8136.0 3146.5 3179.6 3191.6 3193.7 3207.9 1005.6 1008.5 1053.1 1117.2 1171.8 32095.4 32777.3 32952.7 33005.0 33483.5 1122.1 1144.6 1149.1 1170.8 1192.9 17006.9 17167.9 17298.6 17317.0 17524.9 163632.0 582950.0 583115.0 590268.0 590374.0 58866.0 59219.7 59396.7 59504.4 59665.7 1225.8 1325.9 1361.8 1379.2 1387.4 32396.7 34099.3 34342.3 34625.0 34937.8 48840.0 49152.8 49377.0 49402.3 49403.5 397894.0 398633.0 400134.0 401745.0 401747.0 23135.5 25254.2 27060.0 27142.3 27562.6 47053.3 48570.3 49014.0 49173.5 49277.0 41429.3 41762.0 42250.4 42415.2 42981.0 42076.2 42572.4 42997.0 43191.8 43463.0 40653.4 41021.2 41773.2 42280.6 42281.7 35306.5 36683.8 36861.3 37715.4 37794.6 28165.7 28411.3 28433.7 28491.9 28566.3 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | [#2] jquery.html Cycles:180 Average:29677.20 Median:24467.97 stddev:81603.30 (333.5%) stddev-sans-first:81802.59 16:46:47 INFO - PROCESS | 6345 | Values: 389.7 390.1 390.8 395.1 417.6 15027.2 18551.4 18715.3 20409.1 20443.3 14091.9 14700.2 18491.4 19268.6 19810.0 5583.8 5768.2 5768.6 5770.7 5781.0 4167.0 5647.9 5739.5 5743.5 6093.7 6363.8 6431.7 6435.8 6458.0 6467.1 6211.6 6391.3 6401.8 6406.4 6428.9 5545.0 5657.8 5660.4 5662.7 5686.2 23395.5 23691.4 24015.3 24059.5 24327.1 2199.5 2840.6 2969.7 2976.4 3143.1 9407.9 9559.0 9819.3 9826.5 9896.0 1935.7 1952.4 1963.3 1967.9 2029.7 83644.6 84777.0 85069.6 86836.0 89582.6 10479.7 10813.2 10900.0 10904.9 11084.2 15357.7 15374.7 15435.5 15445.8 15452.1 8223.8 8226.0 8226.0 8419.6 8429.4 8111.7 8267.3 8381.0 8495.8 8509.4 4236.4 4395.9 4483.3 4503.5 4550.7 1910.3 1958.2 2030.9 2054.1 2074.8 963.7 1054.1 1055.5 1067.8 1079.7 19164.6 19583.8 19634.2 19713.9 19869.3 961.1 976.5 987.6 999.7 1009.7 9324.7 10848.2 11012.1 11020.2 11089.3 483345.0 484235.0 496488.0 499084.0 501825.0 98752.0 98941.5 99557.0 99656.5 99863.0 974.2 977.0 977.4 982.7 991.3 17178.6 17397.7 17631.7 17710.5 17810.5 44540.0 45364.8 45575.0 45756.8 45919.3 61111.0 62721.7 63166.0 63203.4 63755.4 6052.7 6947.5 8379.5 8848.2 9075.5 10571.4 12831.7 13310.6 13669.4 14263.9 12134.2 12334.9 12413.1 12458.8 12544.4 11663.4 12015.7 12185.8 12220.2 12466.6 12216.3 12400.6 12414.2 12494.8 12594.8 7322.3 7779.7 7841.9 8916.8 9107.1 9089.4 11470.9 11963.0 12106.3 12498.0 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | [#3] mootools.html Cycles:180 Average:5878.89 Median:2480.76 stddev:3401.41 (137.1%) stddev-sans-first:3393.87 16:46:47 INFO - PROCESS | 6345 | Values: 1342.6 1427.0 1473.6 1568.2 1801.3 8418.9 8769.7 8776.2 9052.1 9070.6 8845.8 9028.5 9033.2 9042.1 9053.9 1954.8 2001.0 2002.1 2337.0 2363.0 2079.4 2087.7 2239.0 2320.4 2324.4 2297.4 2324.8 2339.7 2342.3 2343.4 2023.4 2333.3 2352.4 2353.9 2356.6 2291.7 2353.7 2356.5 2373.6 2377.9 8789.6 8804.9 8827.4 8838.9 8845.3 5060.7 5187.7 5188.9 5198.1 5215.4 3396.4 3423.1 3473.6 3512.8 3525.3 1186.8 1210.9 1211.0 1231.3 1233.9 12251.2 12567.9 12604.1 12612.4 12615.2 4427.6 4478.1 4650.3 4671.0 4674.2 10492.3 10513.6 10516.4 10518.2 10523.9 5262.9 5265.5 5268.6 5272.8 5273.7 3863.5 4709.4 4745.8 4795.1 4797.0 3946.8 3964.3 4028.3 4063.4 4079.3 1224.0 1258.7 1267.6 1268.3 1290.7 951.7 993.7 1032.0 1034.6 1035.4 6160.6 6230.1 6238.5 6252.0 6330.8 453.2 460.8 464.8 467.7 472.3 4287.6 4442.3 4477.5 4488.9 4508.3 10743.1 11143.9 11203.7 11227.0 11235.8 10761.9 11184.2 11262.5 11280.7 11292.1 8271.8 8372.0 8398.8 8399.2 8455.4 5948.6 5970.2 5973.4 6024.6 6063.3 10208.1 10209.9 10226.7 10333.6 10343.8 10321.3 10476.6 10480.8 10652.5 10770.8 7186.6 7774.8 7969.5 8103.0 8114.4 8527.6 8853.1 8879.6 8889.2 8902.9 7681.8 7783.0 7816.3 8132.0 8182.6 7770.4 7851.8 7920.4 8048.3 8117.4 6679.4 6694.7 6714.7 6737.4 6738.2 5202.8 5243.6 5318.7 5391.6 5394.8 5115.6 5418.9 5483.9 5574.9 5610.6 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | [#4] prototype.html Cycles:180 Average:4603.66 Median:5268.92 stddev:1356.57 (25.7%) stddev-sans-first:1321.72 16:46:47 INFO - PROCESS | 6345 | Values: 319.5 324.8 326.1 327.5 331.2 5310.3 5319.0 5333.7 5352.4 5359.2 5263.4 5274.5 5274.7 5336.8 5338.6 3917.4 4154.4 4170.1 4177.9 4200.9 4077.9 4116.4 4124.4 4140.0 4157.0 4075.0 4102.8 4108.0 4110.9 4124.8 3920.3 3977.7 4079.3 4097.7 4101.2 3601.2 3609.7 3616.4 3616.6 3624.3 5136.6 5142.9 5160.3 5188.8 5210.6 4436.0 4504.7 4640.2 4685.0 4713.8 5427.6 5441.9 5451.2 5463.5 5471.4 3955.3 3977.3 3979.9 3980.7 3983.7 5495.6 5727.2 5728.5 5736.7 5768.9 3945.6 3955.7 3970.1 3981.9 3994.3 4034.2 4037.6 4048.0 4052.3 4056.1 4481.8 4588.8 4603.1 4682.9 4690.6 5492.0 5509.5 5511.4 5526.3 5547.4 1421.1 1429.1 1433.3 1434.6 1439.6 866.9 913.1 916.3 916.5 928.4 4674.9 4698.0 4705.6 4707.7 4720.5 5003.3 5019.9 5020.6 5031.8 5059.1 4712.6 4717.9 4730.4 4731.6 5115.8 3015.5 3035.6 3039.3 3039.7 3040.0 5890.7 5898.4 5902.6 5912.8 5929.6 5539.6 5704.3 5767.8 5786.4 5826.5 5794.3 5799.4 5851.7 5867.0 5871.2 5403.8 5669.5 5691.3 5697.0 5698.9 5629.7 5639.7 5648.4 5654.1 5658.3 5851.6 5885.8 5891.7 5902.8 5927.6 3867.0 3992.5 4008.2 4074.2 4083.8 5615.2 5615.6 5637.9 5695.3 5703.6 5550.8 5557.6 5573.5 5588.5 5615.6 5403.8 5485.7 5492.3 5532.6 5536.5 5426.3 5471.3 5488.8 5515.6 5562.6 5316.3 5414.7 5600.2 5602.5 5632.5 5427.7 5450.6 5468.6 5477.5 5550.9 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - PROCESS | 6345 | [#5] yui.html Cycles:180 Average:22372.70 Median:3502.97 stddev:33514.36 (956.7%) stddev-sans-first:33568.89 16:46:47 INFO - PROCESS | 6345 | Values: 707.3 713.6 724.4 790.6 862.9 15692.8 16256.9 17010.2 17011.3 17034.8 15502.3 15523.9 15689.2 15814.5 15837.5 671.3 790.8 793.2 824.9 831.7 811.8 812.6 812.8 815.6 817.7 866.7 867.2 869.6 870.5 871.0 701.4 837.9 854.8 856.4 858.2 621.7 623.2 624.1 624.4 625.1 15642.4 15648.5 15668.7 15691.2 15696.1 12649.0 12995.7 13084.6 13125.6 13317.1 13290.3 13297.4 13314.1 13487.5 13556.8 4549.7 4566.5 4577.9 4709.2 4712.2 76723.2 77328.6 77785.2 78530.2 78845.0 11816.7 11846.9 11883.1 11994.5 12204.5 22099.2 22126.3 22226.9 22248.9 22259.0 8621.6 8827.1 8883.2 8893.9 8931.4 4652.3 4670.5 4701.3 4747.7 4882.2 3343.6 3491.6 3499.0 3502.6 3503.4 665.1 677.1 704.9 711.4 722.7 712.0 722.7 736.4 753.3 775.0 10001.8 10074.6 10499.2 10510.6 10667.4 647.2 694.9 745.3 752.6 768.8 4752.0 4979.4 5026.2 5070.1 5090.5 78934.6 126656.0 131982.0 135080.0 138748.0 116003.0 116195.0 117175.5 118226.4 120543.0 99286.0 99382.5 101063.0 101273.5 102895.0 9419.0 9680.5 9694.0 9701.0 9733.9 55339.7 55632.0 57005.0 57276.9 58355.0 47473.5 75518.0 86395.6 87011.7 89600.6 12669.4 12708.2 12811.3 12940.9 13240.9 14329.0 14370.5 14538.6 14663.5 14693.2 13409.4 13786.6 13897.7 14187.6 14209.7 13901.9 14026.6 14128.4 14726.3 14848.1 12984.2 13135.7 13226.1 13707.5 13739.1 10501.8 10720.2 10841.2 10874.8 10899.2 10608.0 11377.8 11395.0 11418.4 11451.4 16:46:47 INFO - PROCESS | 6345 | -------- Summary: end -------- 16:46:47 INFO - PROCESS | 6345 | 16:46:47 INFO - TEST-INFO | 6345: exit 0 16:46:47 INFO - TEST-OK | dromaeo_css | took 1113536ms 16:46:47 INFO - TEST-START | kraken 16:46:47 INFO - operating with platform_type : linux_ 16:46:47 INFO - Initialising browser for kraken test... 16:46:47 INFO - TEST-INFO | started process 6535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMKuoS/profile http://localhost:49533/getInfo.html) 16:46:51 INFO - PROCESS | 6535 | __metrics Screen width/height:1600/1200 16:46:51 INFO - PROCESS | 6535 | colorDepth:24 16:46:51 INFO - PROCESS | 6535 | Browser inner width/height: 1024/697 16:46:51 INFO - PROCESS | 6535 | __metrics 16:46:52 INFO - PROCESS | 6535 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:46:52 INFO - PROCESS | 6535 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:53 INFO - PROCESS | 6535 | console.error: PushService: 16:46:53 INFO - PROCESS | 6535 | stateChangeProcessEnqueue: Error transitioning state 16:46:53 INFO - PROCESS | 6535 | UnknownError 16:46:53 INFO - TEST-INFO | 6535: exit 0 16:46:53 INFO - Browser initialized. 16:46:53 INFO - Running cycle 1/1 for kraken test... 16:46:53 INFO - TEST-INFO | started process 6616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMKuoS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:47:05 INFO - PROCESS | 6616 | RSS: Main: 156950528 16:47:05 INFO - PROCESS | 6616 | 16:47:08 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-beat-detection) 16:47:08 INFO - PROCESS | 6616 | RSS: Main: 215330816 16:47:08 INFO - PROCESS | 6616 | 16:47:11 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-dft) 16:47:12 INFO - PROCESS | 6616 | RSS: Main: 204144640 16:47:12 INFO - PROCESS | 6616 | 16:47:15 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-fft) 16:47:15 INFO - PROCESS | 6616 | RSS: Main: 268722176 16:47:15 INFO - PROCESS | 6616 | 16:47:17 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49533/tests/kraken/driver.html?testName=audio-oscillator) 16:47:18 INFO - PROCESS | 6616 | RSS: Main: 180060160 16:47:18 INFO - PROCESS | 6616 | 16:47:20 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:47:21 INFO - PROCESS | 6616 | RSS: Main: 184700928 16:47:21 INFO - PROCESS | 6616 | 16:47:24 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49533/tests/kraken/driver.html?testName=imaging-darkroom) 16:47:24 INFO - PROCESS | 6616 | RSS: Main: 218943488 16:47:24 INFO - PROCESS | 6616 | 16:47:28 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49533/tests/kraken/driver.html?testName=imaging-desaturate) 16:47:28 INFO - PROCESS | 6616 | RSS: Main: 220495872 16:47:28 INFO - PROCESS | 6616 | 16:47:31 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49533/tests/kraken/driver.html?testName=json-parse-financial) 16:47:32 INFO - PROCESS | 6616 | RSS: Main: 221700096 16:47:32 INFO - PROCESS | 6616 | 16:47:33 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:47:34 INFO - PROCESS | 6616 | RSS: Main: 209170432 16:47:34 INFO - PROCESS | 6616 | 16:47:36 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:47:36 INFO - PROCESS | 6616 | RSS: Main: 211984384 16:47:36 INFO - PROCESS | 6616 | 16:47:38 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:47:39 INFO - PROCESS | 6616 | RSS: Main: 211509248 16:47:39 INFO - PROCESS | 6616 | 16:47:42 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:47:42 INFO - PROCESS | 6616 | RSS: Main: 224608256 16:47:42 INFO - PROCESS | 6616 | 16:47:45 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:47:45 INFO - PROCESS | 6616 | RSS: Main: 225927168 16:47:45 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:49533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49533/tests/kraken/driver.html?testName=ai-astar) 16:47:47 INFO - PROCESS | 6616 | RSS: Main: 269418496 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | __start_tp_report 16:47:47 INFO - PROCESS | 6616 | _x_x_mozilla_page_load 16:47:47 INFO - PROCESS | 6616 | _x_x_mozilla_page_load_details 16:47:47 INFO - PROCESS | 6616 | |i|pagename|runs| 16:47:47 INFO - PROCESS | 6616 | |0;ai-astar;102;112;110;110;111;113;112;112;113;110 16:47:47 INFO - PROCESS | 6616 | |1;audio-beat-detection;146;121;118;172;119;121;151;117;152;116 16:47:47 INFO - PROCESS | 6616 | |2;audio-dft;161;163;160;161;160;160;161;161;161;161 16:47:47 INFO - PROCESS | 6616 | |3;audio-fft;76;75;76;109;75;75;84;74;109;75 16:47:47 INFO - PROCESS | 6616 | |4;audio-oscillator;83;84;126;84;83;84;117;83;85;143 16:47:47 INFO - PROCESS | 6616 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;116 16:47:47 INFO - PROCESS | 6616 | |6;imaging-darkroom;146;145;147;145;146;146;146;146;146;145 16:47:47 INFO - PROCESS | 6616 | |7;imaging-desaturate;94;94;96;94;95;94;95;95;95;95 16:47:47 INFO - PROCESS | 6616 | |8;json-parse-financial;57;56;57;55;56;56;59;57;56;55 16:47:47 INFO - PROCESS | 6616 | |9;json-stringify-tinderbox;63;63;64;63;64;63;63;63;64;63 16:47:47 INFO - PROCESS | 6616 | |10;stanford-crypto-aes;75;75;74;80;75;75;74;74;83;84 16:47:47 INFO - PROCESS | 6616 | |11;stanford-crypto-ccm;120;121;118;119;128;126;119;128;220;121 16:47:47 INFO - PROCESS | 6616 | |12;stanford-crypto-pbkdf2;160;159;159;157;157;160;160;159;158;157 16:47:47 INFO - PROCESS | 6616 | |13;stanford-crypto-sha256-iterative;65;66;65;64;62;62;62;62;61;61 16:47:47 INFO - PROCESS | 6616 | __end_tp_report 16:47:47 INFO - PROCESS | 6616 | __start_cc_report 16:47:47 INFO - PROCESS | 6616 | _x_x_mozilla_cycle_collect,1612 16:47:47 INFO - PROCESS | 6616 | __end_cc_report 16:47:47 INFO - PROCESS | 6616 | __startTimestamp1468280867832__endTimestamp 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | ------- Summary: start ------- 16:47:47 INFO - PROCESS | 6616 | Number of tests: 14 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.21 (2.9%) stddev-sans-first:1.24 16:47:47 INFO - PROCESS | 6616 | Values: 102.0 112.0 110.0 110.0 111.0 113.0 112.0 112.0 113.0 110.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:133.50 stddev:20.08 (15.0%) stddev-sans-first:20.76 16:47:47 INFO - PROCESS | 6616 | Values: 146.0 121.0 118.0 172.0 119.0 121.0 151.0 117.0 152.0 116.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 16:47:47 INFO - PROCESS | 6616 | Values: 161.0 163.0 160.0 161.0 160.0 160.0 161.0 161.0 161.0 161.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:14.09 (18.8%) stddev-sans-first:14.73 16:47:47 INFO - PROCESS | 6616 | Values: 76.0 75.0 76.0 109.0 75.0 75.0 84.0 74.0 109.0 75.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:83.50 stddev:22.60 (27.1%) stddev-sans-first:23.38 16:47:47 INFO - PROCESS | 6616 | Values: 83.0 84.0 126.0 84.0 83.0 84.0 117.0 83.0 85.0 143.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:47:47 INFO - PROCESS | 6616 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:47:47 INFO - PROCESS | 6616 | Values: 146.0 145.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 16:47:47 INFO - PROCESS | 6616 | Values: 94.0 94.0 96.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.17 (2.1%) stddev-sans-first:1.22 16:47:47 INFO - PROCESS | 6616 | Values: 57.0 56.0 57.0 55.0 56.0 56.0 59.0 57.0 56.0 55.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 16:47:47 INFO - PROCESS | 6616 | Values: 63.0 63.0 64.0 63.0 64.0 63.0 63.0 63.0 64.0 63.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:75.00 stddev:3.90 (5.2%) stddev-sans-first:4.08 16:47:47 INFO - PROCESS | 6616 | Values: 75.0 75.0 74.0 80.0 75.0 75.0 74.0 74.0 83.0 84.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:123.50 stddev:31.15 (25.2%) stddev-sans-first:32.73 16:47:47 INFO - PROCESS | 6616 | Values: 120.0 121.0 118.0 119.0 128.0 126.0 119.0 128.0 220.0 121.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:159.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 16:47:47 INFO - PROCESS | 6616 | Values: 160.0 159.0 159.0 157.0 157.0 160.0 160.0 159.0 158.0 157.0 16:47:47 INFO - PROCESS | 6616 | 16:47:47 INFO - PROCESS | 6616 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.83 (2.9%) stddev-sans-first:1.79 16:47:47 INFO - PROCESS | 6616 | Values: 65.0 66.0 65.0 64.0 62.0 62.0 62.0 62.0 61.0 61.0 16:47:47 INFO - PROCESS | 6616 | -------- Summary: end -------- 16:47:47 INFO - PROCESS | 6616 | 16:47:48 INFO - TEST-INFO | 6616: exit 0 16:47:48 INFO - TEST-OK | kraken | took 61079ms 16:47:48 INFO - SUITE-END | took 1174s 16:47:48 INFO - Completed test suite (00:19:34) 16:47:48 INFO - javascript benchmark 16:47:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.67484914084, 3114.5639610454527, 3138.905832825015, 3145.732612727918, 3164.3196712706763, 5220.112580861253, 5314.5748340132795, 5433.8369848904495, 5551.750171242294, 5561.749721262543, 5451.0, 5497.642653227537, 5507.146392309189, 5517.172424136382, 5550.58370622204, 4907.484714105021, 4975.626827987915, 5003.699778013331, 5017.247412888059, 5165.7158856262895, 5063.189889617662, 5075.9746201268945, 5122.692638441706, 5122.8207012754565, 5139.331886854704, 4858.514148585148, 4869.9269510957365, 4874.512548745115, 4899.951000489985, 4912.38595175603, 4908.116539022974, 4912.582430493412, 4919.532644398776, 4926.408830940274, 4964.851054468371, 4878.146324393252, 4909.042736666352, 4931.309616653635, 4946.752662366867, 4978.477259887696, 5437.157240627709, 5496.587755918282, 5498.147787093007, 5552.583556233299, 5569.888602227973, 5917.763289468416, 5928.7628494860155, 5932.792352267693, 5942.702864856783, 5943.138244954501, 5599.216109744639, 5793.362730099686, 5986.132010858401, 5987.820365389045, 5989.700514974277, 5457.645253058538, 5502.339719233718, 5557.943990641765, 5558.388577256539, 5558.638688485276, 6050.695825049702, 6059.372921898114, 6059.824140052826, 6091.451769340781, 6113.0, 5553.305836770403, 5662.716864156776, 5720.399358067343, 5848.88302233953, 5856.238688970407, 5881.823545293648, 5892.263467066617, 5893.263342082239, 5893.322267939242, 5895.174675545427, 5774.983698438591, 5824.912626310609, 5835.474807267281, 5838.9124163137585, 5842.1236814477315, 5679.829605111853, 5756.02147634903, 5825.446582574648, 5835.970820145957, 5859.560532959959, 4455.732656040583, 4455.933161002587, 4458.35353873693, 4463.04044630406, 4495.910081798345, 3935.940960885589, 3958.129211573449, 3978.085040440657, 4009.719319647655, 4029.778362190049, 5284.815031473957, 5311.044012077863, 5409.188621706697, 5449.1826226066405, 5458.699771512605, 5921.289445266596, 5922.940770592239, 5924.674142922095, 5936.584439089309, 5944.167816505693, 5490.890182196334, 5491.28613280279, 5499.945000549943, 5506.697131657797, 5508.669479831223, 4864.246041863516, 4971.577415919615, 4997.925031124536, 5008.5993120550265, 5041.0, 6019.909701354483, 6037.939620603738, 6086.056661217518, 6086.847828804404, 6090.056041313604, 5683.005474042109, 5883.882322353615, 5899.321578018583, 5906.793262235801, 5907.054871220584, 6005.519558435228, 6058.545609079249, 6069.51443884497, 6095.420935011167, 6102.359252278625, 5760.366359700346, 5789.421057894177, 5800.187973683772, 5800.477956983723, 5801.0, 5669.773209071591, 5722.942770572241, 5915.704214789157, 5923.022701254245, 5923.289205295392, 5651.039323314964, 5716.628419152742, 5718.199452076629, 5720.713964301685, 5781.884362312814, 5626.915596265977, 5662.7734890603915, 5675.971620141873, 5696.715164241688, 5712.0, 5557.833265002057, 5570.637908535932, 5581.9162712560155, 5694.14587811815, 5702.743376548148, 5685.118806584986, 5692.857678558069, 5702.91644587527, 5756.0, 5756.597038207453, 5530.281063461724, 5574.470425309589, 5574.749136288796, 5578.051731205624, 5594.244776955222], "value": 5387.25028166062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6485641043578, 633.5565104426901, 634.2452481546961, 641.4836056974137, 646.6540400885527, 33342.66657333426, 36439.81780091099, 46201.53798462015, 47278.527214727845, 47291.52708472914, 46010.07979840401, 46444.30333544999, 46601.76699116508, 46626.0, 46636.53363466365, 8920.910790892089, 9043.095690430937, 9078.0, 9094.181523662868, 9109.089091090871, 8949.776255593597, 9038.186563209343, 9039.819203615923, 9040.502772347518, 9042.276617870588, 9058.094190580921, 9099.090090990881, 9103.271738260923, 9112.49881256534, 9120.452772833618, 8979.416337938046, 9001.054889236666, 9045.638174473013, 9046.095390460967, 9049.502277374742, 8885.067067957836, 8957.686480973134, 8959.776005599848, 8966.520524113579, 8973.730788076367, 41989.580104198874, 42151.578484215075, 42423.57576424227, 42464.15071698549, 42498.0, 3477.4609935460044, 3624.4925710400566, 4092.5702801205744, 4289.656827453796, 4417.271150260203, 31520.0, 33584.49623255653, 33814.661853381396, 33964.66035339639, 34597.82701086504, 4350.1734670412525, 4380.89047773805, 4419.668524860648, 4421.828215522889, 4462.732236065846, 380429.0, 381063.0, 382130.0, 382695.0, 383328.0, 30873.228169295497, 31623.0, 31861.362772744415, 61406.0, 62378.37621623816, 37081.47725966029, 37086.258274834356, 37273.62726372756, 37285.44071838925, 37320.0, 15617.921910390603, 15745.0, 15810.762838557432, 15844.44544440939, 15848.841511584737, 13437.395317210749, 13494.055416120973, 13518.59444216675, 13522.459101636021, 13523.188608683511, 8029.197080291924, 8063.758087257392, 8070.2333278338465, 8087.636056377477, 8135.959320203361, 3146.496560550301, 3179.60254968129, 3191.5850939377733, 3193.680631936788, 3207.8716851325685, 1005.648023191877, 1008.455434065611, 1053.1101219469535, 1117.1621284036971, 1171.753931674341, 32095.358092838014, 32777.344453111284, 32952.67047329496, 33005.0, 33483.49774753381, 1122.119136477861, 1144.6279959013189, 1149.0864762513822, 1170.806816875206, 1192.934388608635, 17006.914965425094, 17167.914160429118, 17298.567535811704, 17317.0, 17524.91237543804, 163632.0, 582950.0, 583115.0, 590268.0, 590374.0, 58866.0, 59219.703901480214, 59396.703016484644, 59504.404955950755, 59665.70167149136, 1225.7732319520917, 1325.8541560428346, 1361.8433880103717, 1379.1587131849565, 1387.424218949125, 32396.676033239364, 34099.318013639095, 34342.31315373728, 34625.0, 34937.82531087328, 48840.0, 49152.75423622859, 49377.0, 49402.25896611626, 49403.50596493989, 397894.0, 398633.0, 400134.0, 401745.0, 401747.0, 23135.537289253785, 25254.242372728848, 27060.0, 27142.321441964108, 27562.586561202, 47053.29420058634, 48570.271445929044, 49014.0, 49173.508264918324, 49277.0, 41429.34282628661, 41762.0, 42250.36624450574, 42415.1516969665, 42981.0, 42076.158476830904, 42572.36141457818, 42997.0, 43191.78404107959, 43463.0, 40653.39019914763, 41021.179576408904, 41773.164536708486, 42280.57719422889, 42281.71478565179, 35306.47040294449, 36683.81658091692, 36861.26277474489, 37715.43426848545, 37794.62205377911, 28165.692300004343, 28411.289717757223, 28433.715662843933, 28491.857540712164, 28566.285842854097], "value": 19040.777156982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.69798406235145, 390.13195639701667, 390.78841809438984, 395.0853773514314, 417.6199658310938, 15027.173505457196, 18551.35070272541, 18715.3449629263, 20409.081591328388, 20443.284485043027, 14091.859081409182, 14700.191489468076, 18491.445256642288, 19268.614627707437, 19810.0, 5583.832485025446, 5768.163616275638, 5768.567357448187, 5770.740316685738, 5780.971095144519, 4166.958330416687, 5647.943520564803, 5739.540836733051, 5743.5118014968775, 6093.695315234243, 6363.809085727413, 6431.742730290783, 6435.806925792233, 6457.9677101614425, 6467.094606755058, 6211.565190436671, 6391.265004524493, 6401.807945761635, 6406.359364063603, 6428.903566446507, 5545.0, 5657.8019769308285, 5660.433956604348, 5662.688552129631, 5686.2039314496005, 23395.532089358287, 23691.407714807094, 24015.279541613778, 24059.518809623885, 24327.148549800673, 2199.549092436047, 2840.5597132444504, 2969.6881827408242, 2976.389840082778, 3143.104215298652, 9407.858882116774, 9559.0, 9819.263555233314, 9826.459544725038, 9895.950520247425, 1935.7289979402894, 1952.375239923225, 1963.2834015584351, 1967.9409617711492, 2029.7462817147857, 83644.58177709073, 84777.0, 85069.57465212635, 86836.0, 89582.5520872398, 10479.68560943173, 10813.18901082422, 10900.0, 10904.890951090547, 11084.224104312621, 15357.692846143014, 15374.692506149815, 15435.536933892, 15445.84554154444, 15452.072875627273, 8223.835523289501, 8225.971753530808, 8226.0, 8419.579021048923, 8429.367797415218, 8111.716089936942, 8267.338612910953, 8381.0, 8495.830083398298, 8509.361797865186, 4236.406903033578, 4395.934060989088, 4483.349914262479, 4503.527129651339, 4550.704204226715, 1910.2645481489726, 1958.1579920634265, 2030.9492262693254, 2054.075665950328, 2074.834013278934, 963.6819849449665, 1054.093479607537, 1055.5355643516828, 1067.8451624514403, 1079.7030816525519, 19164.61670766577, 19583.804161958196, 19634.21463141487, 19713.901430492755, 19869.30457433983, 961.077365728894, 976.4531862157073, 987.6247026130025, 999.6551189839494, 1009.7122320138872, 9324.673636422693, 10848.186386020921, 11012.063974562252, 11020.228583999044, 11089.33463992163, 483345.0, 484235.0, 496488.0, 499084.0, 501825.0, 98752.0, 98941.50529247307, 99557.0, 99656.50171749094, 99863.0, 974.2449601558849, 976.9706908792748, 977.4330888085036, 982.7199248214224, 991.2961797124123, 17178.570535736708, 17397.739033914248, 17631.735523966894, 17710.468685939442, 17810.465686029438, 44540.0, 45364.773176135226, 45575.0, 45756.77121614371, 45919.3112103312, 61111.0, 62721.68639156775, 63166.0, 63203.36796631975, 63755.362446374944, 6052.66710330936, 6947.548409353376, 8379.49723016621, 8848.20366167048, 9075.500847453453, 10571.418571978615, 12831.743365132459, 13310.600681979557, 13669.38487768033, 14263.857361426253, 12134.211276267015, 12334.876651233373, 12413.069019823368, 12458.813117803422, 12544.435500402322, 11663.358515281741, 12015.699607509881, 12185.756284874431, 12220.205686630341, 12466.563670271496, 12216.328101954477, 12400.56598019065, 12414.193077449936, 12494.750104998031, 12594.811077834023, 7322.267773222635, 7779.72770953014, 7841.882371764542, 8916.821663566821, 9107.089291071105, 9089.409188402733, 11470.885291146982, 11963.042956563628, 12106.273623582612, 12498.0], "value": 9374.270670354419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.5837990223026, 1427.0296198584965, 1473.6094934842265, 1568.1501912804067, 1801.3155001099587, 8418.873716894244, 8769.736907892757, 8776.2101410873, 9052.094790520945, 9070.63717451301, 8845.823083538342, 9028.458292502455, 9033.23217526511, 9042.140996605329, 9053.864192037108, 1954.794746551613, 2001.0, 2002.1090614676475, 2336.976630233697, 2362.988185059081, 2079.3553998260513, 2087.6972838938345, 2238.9776102238934, 2320.3619004773655, 2324.407276144581, 2297.3682237384687, 2324.7791459811374, 2339.6724458575814, 2342.2504798464497, 2343.3790045637834, 2023.3727544461117, 2333.3000099970027, 2352.4354155002848, 2353.882305884699, 2356.564035653401, 2291.7395432512053, 2353.670486131943, 2356.4815740537056, 2373.584622691022, 2377.8573285602747, 8789.64841406343, 8804.911950880472, 8827.382083254175, 8838.911610883937, 8845.29237660992, 5060.721660308682, 5187.714675692835, 5188.948110518884, 5198.142306519419, 5215.426303106655, 3396.3716712408036, 3423.0757695422344, 3473.6179020307745, 3512.8243587820507, 3525.347810655037, 1186.833843261944, 1210.8970737487325, 1210.9818352724717, 1231.2735486063177, 1233.9197952133084, 12251.203671761306, 12567.937160314323, 12604.11771176018, 12612.432440540199, 12615.243085414813, 4427.601515863587, 4478.104379124188, 4650.348951146842, 4671.0, 4674.182018146811, 10492.26554141218, 10513.579456821795, 10516.369017858953, 10518.211134164969, 10523.94738026305, 5262.92105618416, 5265.473452654704, 5268.552173065333, 5272.815451459181, 5273.6572122811895, 3863.517060367454, 4709.411323584552, 4745.762711864393, 4795.112904112751, 4796.976015119972, 3946.8026598670526, 3964.286428442908, 4028.3353246713964, 4063.374650139968, 4079.265732168179, 1223.9938800305943, 1258.6916205529703, 1267.6260503151593, 1268.346801397281, 1290.7031382782013, 951.6859436385976, 993.7267251505749, 1031.9742006449749, 1034.5913364221242, 1035.3994683083793, 6160.568760186834, 6230.096635987847, 6238.500919926395, 6251.9687401563615, 6330.810075697645, 453.20462588158233, 460.79724921034637, 464.848924099669, 467.74040407574125, 472.25855407010664, 4287.614114729627, 4442.2892337225885, 4477.485089214717, 4488.887777805581, 4508.32375143731, 10743.08683761889, 11143.888561114285, 11203.71990700239, 11227.045701115334, 11235.83146252807, 10761.870003649661, 11184.217104802749, 11262.493187806405, 11280.661580152608, 11292.096632269398, 8271.751847444586, 8372.0, 8398.790030249293, 8399.160083991552, 8455.365847561457, 5948.5538584605465, 5970.223870896755, 5973.402659734165, 6024.578279520391, 6063.272407311151, 10208.132308753839, 10209.948950255499, 10226.744331391776, 10333.638322658671, 10343.84484232722, 10321.329113607591, 10476.580936762444, 10480.790384192425, 10652.520636571218, 10770.838437423601, 7186.640667966685, 7774.805629859299, 7969.521828690297, 8102.959485202537, 8114.350851931949, 8527.616257268313, 8853.114688531095, 8879.556022198993, 8889.155530224618, 8902.86645700328, 7681.7695469136015, 7782.961085194538, 7816.257455541714, 8132.024157101186, 8182.590870456334, 7770.417218708506, 7851.8037049071945, 7920.405969552191, 8048.275655190827, 8117.391195660231, 6679.398854103154, 6694.698738556679, 6714.697838597177, 6737.3599508046655, 6738.225104113089, 5202.817901373433, 5243.632945693765, 5318.7074710891275, 5391.595630327663, 5394.838154855361, 5115.616328775432, 5418.945810542002, 5483.917741233964, 5574.91637625444, 5610.635308704921], "value": 4603.870243761741, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.5047179201338, 324.8278412441406, 326.0918342416371, 327.46132611853517, 331.19684764446214, 5310.336207974004, 5319.0, 5333.679979201251, 5352.357717073952, 5359.19612058191, 5263.3683957925105, 5274.472552744734, 5274.736263186835, 5336.8132115375965, 5338.62629615927, 3917.373220284755, 4154.376843473473, 4170.103427763031, 4177.916441671165, 4200.873973780792, 4077.857274995376, 4116.444280022203, 4124.422580838685, 4139.958600413987, 4157.023099571598, 4074.97962510187, 4102.774347410891, 4107.979460102695, 4110.917781644365, 4124.752514849104, 3920.2943470175355, 3977.6817854571564, 4079.3269110596716, 4097.672186225095, 4101.179764047202, 3601.243738814826, 3609.7292703047115, 3616.367135751233, 3616.566012078541, 3624.2932628137523, 5136.64043516954, 5142.871428214325, 5160.303359046518, 5188.792448302063, 5210.635255532115, 4435.955640443586, 4504.729716217004, 4640.190325772951, 4684.976575117136, 4713.764311784432, 5427.647202931837, 5441.891162176735, 5451.209574611698, 5463.508284254436, 5471.425500322488, 3955.3473676843287, 3977.3039718049226, 3979.880603581897, 3980.661643760284, 3983.721139520235, 5495.587830912697, 5727.1695604137585, 5728.484436400702, 5736.684482353469, 5768.855778605568, 3945.6448919597374, 3955.7428767130045, 3970.126572154179, 3981.8805435836393, 3994.2810294147334, 4034.1931613677384, 4037.596240375939, 4048.0, 4052.2908491014546, 4056.127932494528, 4481.775911204427, 4588.839390621312, 4603.125406172817, 4682.906341873144, 4690.624750020059, 5491.972540137273, 5509.531689806331, 5511.366192887869, 5526.253955716007, 5547.420449491006, 1421.1047040364504, 1429.1282317786142, 1433.3263366217861, 1434.5696291112624, 1439.5537383411177, 866.9033672404413, 913.0641092879852, 916.3219217778795, 916.5050872528893, 928.4475736936512, 4674.906501870011, 4698.0, 4705.55297246761, 4707.741074240949, 4720.504347043511, 5003.324551185616, 5019.891645508895, 5020.623453241022, 5031.7987280509105, 5059.114654935372, 4712.64655150865, 4717.905641887143, 4730.408698912636, 4731.621470282369, 5115.825774046016, 3015.5325924481303, 3035.605371301717, 3039.2553824313186, 3039.6504401994052, 3040.0, 5890.67601281925, 5898.439648233411, 5902.557308201902, 5912.763489460373, 5929.584929055011, 5539.584531160099, 5704.258446401941, 5767.769289228468, 5786.363500014995, 5826.533877289807, 5794.275715535558, 5799.3620701722775, 5851.683371241522, 5866.970665146647, 5871.236739223959, 5403.83788486346, 5669.489745922887, 5691.260136182435, 5697.0, 5698.857528561819, 5629.6903670298525, 5639.689817059937, 5648.390208790475, 5654.123610840326, 5658.292713410824, 5851.561132915133, 5885.793412350372, 5891.675957822361, 5902.822915312548, 5927.555433342431, 3867.0, 3992.48097747291, 4008.238434697398, 4074.1851629673592, 4083.8366465341055, 5615.241942337732, 5615.550755939434, 5637.88724225505, 5695.316562012585, 5703.600747947769, 5550.833474995757, 5557.5553955682635, 5573.498385145356, 5588.469095435927, 5615.606907516435, 5403.811161544454, 5485.725713714378, 5492.258545096521, 5532.640378375393, 5536.529395001309, 5426.2674538936735, 5471.343438787371, 5488.807891723771, 5515.558755299647, 5562.638428502134, 5316.315260793274, 5414.702191379354, 5600.159976003632, 5602.52378547828, 5632.464915832989, 5427.728613569385, 5450.5912056595125, 5468.644538105011, 5477.4796394342475, 5550.916736248879], "value": 4171.480379237108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2927072927076, 713.6289129652578, 724.4385601159103, 790.592844684987, 862.8791969124323, 15692.76460853088, 16256.918715406437, 17010.23453944574, 17011.319547218096, 17034.82965170348, 15502.30239639216, 15523.922380388081, 15689.215539223022, 15814.525564233063, 15837.524874253791, 671.2750229751881, 790.8260182759798, 793.1632128104847, 824.8638974569219, 831.6922738586732, 811.8173410982512, 812.5693382507251, 812.8252425728467, 815.5799763121997, 817.7424111404919, 866.6576702202626, 867.2108381372921, 869.5565261716539, 870.5125129927229, 870.9608067636972, 701.4493622506334, 837.949723016621, 854.8333075050367, 856.3748463621529, 858.1847245117164, 621.7481919822479, 623.1774058243121, 624.09506215987, 624.4005754475709, 625.0811307378146, 15642.374305027899, 15648.530544083582, 15668.68662626741, 15691.215439227994, 15696.058236505845, 12649.0, 12995.740085198338, 13084.607461776162, 13125.60623181306, 13317.067805253637, 13290.3354832258, 13297.401616927262, 13314.134581252187, 13487.460501579924, 13556.796648050287, 4549.658775591844, 4566.54334566544, 4577.931331030038, 4709.175894218532, 4712.222483290253, 76723.23276767216, 77328.61335693342, 77785.22214777836, 78530.21469785286, 78845.0, 11816.70458238551, 11846.881531184577, 11883.120115486121, 11994.520219191134, 12204.511819527119, 22099.226527071474, 22126.336209913727, 22226.888865555567, 22248.88875555612, 22259.0, 8621.61202745878, 8827.117288271122, 8883.244924181388, 8893.866592001124, 8931.374803763803, 4652.32541281519, 4670.5329467053025, 4701.341812146302, 4747.738874361943, 4882.194437917704, 3343.632200457948, 3491.5810102787827, 3498.9825050874583, 3502.5796904371637, 3503.369393509142, 665.0954701605813, 677.1467950382455, 704.8942658601251, 711.3917600451539, 722.7000794670258, 711.9644017799089, 722.7109156337402, 736.3777607921298, 753.3031945450437, 774.9883751743729, 10001.79996400068, 10074.647387341407, 10499.160067194605, 10510.55814414596, 10667.413292269, 647.223371844281, 694.8749225139422, 745.3440971944763, 752.6086435053742, 768.757841279995, 4751.952480475151, 4979.427365852901, 5026.220935754964, 5070.138076527, 5090.465501122403, 78934.605326973, 126656.0, 131982.0, 135080.0, 138748.0, 116003.0, 116195.0, 117175.48519303225, 118226.40886795682, 120543.0, 99286.0, 99382.5030874841, 101063.0, 101273.49363253136, 102894.9999999985, 9419.0, 9680.467574283482, 9693.951530242304, 9701.0, 9733.853992189981, 55339.72330138324, 55632.0, 57005.0, 57276.8553571604, 58355.0, 47473.52526474691, 75518.0, 86395.56802215948, 87011.68848049713, 89600.5519972396, 12669.366531673195, 12708.173968692005, 12811.295378754257, 12940.935295323463, 13240.867591323964, 14329.0, 14370.49703260381, 14538.563843084725, 14663.48677796272, 14693.19187444658, 13409.396577154246, 13786.586402407944, 13897.722045559234, 14187.574372768833, 14209.715805684034, 13901.930490347888, 14026.579202623938, 14128.43486260538, 14726.337314821074, 14848.109113453227, 12984.15602985803, 13135.737285254432, 13226.140300880412, 13707.520236791665, 13739.106958048094, 10501.842472362769, 10720.19598530129, 10841.186910981865, 10874.782504350027, 10899.237053406185, 10608.0, 11377.829332560184, 11395.0, 11418.429078546205, 11451.370174640475], "value": 7832.3854705599, "unit": "score"}], "name": "dromaeo_css", "value": 7245.306650954005, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 110.0, 111.0, 113.0, 112.0, 112.0, 113.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 118.0, 172.0, 119.0, 121.0, 151.0, 117.0, 152.0, 116.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 109.0, 75.0, 75.0, 84.0, 74.0, 109.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 126.0, 84.0, 83.0, 84.0, 117.0, 83.0, 85.0, 143.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 55.0, 56.0, 56.0, 59.0, 57.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 80.0, 75.0, 75.0, 74.0, 74.0, 83.0, 84.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 118.0, 119.0, 128.0, 126.0, 119.0, 128.0, 220.0, 121.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 157.0, 157.0, 160.0, 160.0, 159.0, 158.0, 157.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1492.0000000000002, "alertThreshold": 2.0}]} 16:47:49 INFO - Return code: 0 16:47:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:47:49 INFO - # TBPL SUCCESS # 16:47:49 INFO - Running post-action listener: _resource_record_post_action 16:47:49 INFO - ##### 16:47:49 INFO - ##### Finished run-tests step (success) 16:47:49 INFO - ##### 16:47:49 INFO - Running post-run listener: _resource_record_post_run 16:47:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 567918592; Read time: 0; Write time: 762036 16:47:49 INFO - TinderboxPrint: CPU usage
13.0% 16:47:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:47:49 INFO - TinderboxPrint: I/O write bytes / time
567,918,592 / 762,036 16:47:49 INFO - TinderboxPrint: CPU idle
8,279.1 (87.0%) 16:47:49 INFO - TinderboxPrint: CPU user
1,189.0 (12.5%) 16:47:49 INFO - TinderboxPrint: Swap in / out
0 / 0 16:47:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 272646144; Read time: 0; Write time: 407816 16:47:49 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295034880; Read time: 0; Write time: 354168 16:47:49 INFO - Running post-run listener: _upload_blobber_files 16:47:49 INFO - Blob upload gear active. 16:47:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:47:49 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 16:47:49 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'] 16:47:49 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 16:47:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:47:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:47:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:47:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:50 INFO - (blobuploader) - INFO - Done attempting. 16:47:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:47:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:47:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:51 INFO - (blobuploader) - INFO - Done attempting. 16:47:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:47:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:47:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:55 INFO - (blobuploader) - INFO - Done attempting. 16:47:55 INFO - (blobuploader) - INFO - Iteration through files over. 16:47:55 INFO - Return code: 0 16:47:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:47:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:47:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c9c4991279539f81526c09b4c69d44f9cbcd975dfe1bcd3e8e53b75e18862900dd94d41bc244b9c7c396a686fe89f028c1f963efd4811b023ae784f1c888a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf7ee08d3552b7147a0ced9dd89f3bdf72114abe892501ef66beb034983c0f408bc0d315e746680682738a93a8996c14ef6f4aca91c2c579992734604d88c34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41798945325097df563805ac2d300b82f325cbdfecc9b9d5164a447d082bed1acb11887c2a32a556187b5d918aa1fbce1c6e307d8d3dada0af4461323e228749"} 16:47:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:47:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:47:55 INFO - Contents: 16:47:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c9c4991279539f81526c09b4c69d44f9cbcd975dfe1bcd3e8e53b75e18862900dd94d41bc244b9c7c396a686fe89f028c1f963efd4811b023ae784f1c888a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf7ee08d3552b7147a0ced9dd89f3bdf72114abe892501ef66beb034983c0f408bc0d315e746680682738a93a8996c14ef6f4aca91c2c579992734604d88c34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41798945325097df563805ac2d300b82f325cbdfecc9b9d5164a447d082bed1acb11887c2a32a556187b5d918aa1fbce1c6e307d8d3dada0af4461323e228749"} 16:47:55 INFO - Running post-run listener: copy_logs_to_upload_dir 16:47:55 INFO - Copying logs to upload dir... 16:47:55 INFO - mkdir: /builds/slave/test/build/upload/logs 16:47:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.959690 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-11 16:47:55.174736) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:47:55.179169) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326 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/9c9c4991279539f81526c09b4c69d44f9cbcd975dfe1bcd3e8e53b75e18862900dd94d41bc244b9c7c396a686fe89f028c1f963efd4811b023ae784f1c888a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf7ee08d3552b7147a0ced9dd89f3bdf72114abe892501ef66beb034983c0f408bc0d315e746680682738a93a8996c14ef6f4aca91c2c579992734604d88c34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41798945325097df563805ac2d300b82f325cbdfecc9b9d5164a447d082bed1acb11887c2a32a556187b5d918aa1fbce1c6e307d8d3dada0af4461323e228749"} build_url:https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/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/9c9c4991279539f81526c09b4c69d44f9cbcd975dfe1bcd3e8e53b75e18862900dd94d41bc244b9c7c396a686fe89f028c1f963efd4811b023ae784f1c888a92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bf7ee08d3552b7147a0ced9dd89f3bdf72114abe892501ef66beb034983c0f408bc0d315e746680682738a93a8996c14ef6f4aca91c2c579992734604d88c34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41798945325097df563805ac2d300b82f325cbdfecc9b9d5164a447d082bed1acb11887c2a32a556187b5d918aa1fbce1c6e307d8d3dada0af4461323e228749"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:47:55.211034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:47:55.211599) ========= 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=14ef55db36f7623abb31b9cf000001d5-1468279642.904207-73896326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:47:55.297197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:47:55.297762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:47:55.298246) ========= ========= Total master_lag: 0.20 =========