builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1468019041.65 results: success (0) buildid: 20160708133026 builduid: 3f7db57047674eb5af1c76ae62f3dd8f revision: a5bbe665a0d9677fadcd2a11b14818fd81209968 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.651239) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.651731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.652116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.669149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.669425) ========= 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=db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 16:04:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.4M=0s 2016-07-08 16:04:02 (26.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.779483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.779811) ========= 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=db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017754 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.830956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:01.831272) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5bbe665a0d9677fadcd2a11b14818fd81209968 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a5bbe665a0d9677fadcd2a11b14818fd81209968 --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=db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 16:04:02,688 truncating revision to first 12 chars 2016-07-08 16:04:02,688 Setting DEBUG logging. 2016-07-08 16:04:02,688 attempt 1/10 2016-07-08 16:04:02,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5bbe665a0d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 16:04:02,994 unpacking tar archive at: mozilla-central-a5bbe665a0d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655194 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:02.499765) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:02.500064) ========= script_repo_revision: a5bbe665a0d9677fadcd2a11b14818fd81209968 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:02.500481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:02.500758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 16:04:02.510201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-08 16:04:02.510615) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:04:03 INFO - MultiFileLogger online at 20160708 16:04:03 in /builds/slave/test 16:04:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:04:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:04:03 INFO - {'append_to_log': False, 16:04:03 INFO - 'base_work_dir': '/builds/slave/test', 16:04:03 INFO - 'blob_upload_branch': 'Firefox', 16:04:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:04:03 INFO - 'branch': 'Firefox', 16:04:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:04:03 INFO - 'config_files': ('talos/linux_config.py',), 16:04:03 INFO - 'default_actions': ('clobber', 16:04:03 INFO - 'read-buildbot-config', 16:04:03 INFO - 'download-and-extract', 16:04:03 INFO - 'populate-webroot', 16:04:03 INFO - 'create-virtualenv', 16:04:03 INFO - 'install', 16:04:03 INFO - 'run-tests'), 16:04:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:04:03 INFO - 'download_minidump_stackwalk': True, 16:04:03 INFO - 'download_symbols': 'ondemand', 16:04:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:04:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:04:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:04:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:04:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:04:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:04:03 INFO - 'installer_path': 'installer.exe', 16:04:03 INFO - 'log_level': 'info', 16:04:03 INFO - 'log_name': 'talos', 16:04:03 INFO - 'log_to_console': True, 16:04:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:04:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:04:03 INFO - 'opt_config_files': (), 16:04:03 INFO - 'pip_index': False, 16:04:03 INFO - 'sps_profile': False, 16:04:03 INFO - 'sps_profile_interval': 0, 16:04:03 INFO - 'suite': 'dromaeojs-e10s', 16:04:03 INFO - 'system_bits': '32', 16:04:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:04:03 INFO - 'title': 'talos-linux64-ix-049', 16:04:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:04:03 INFO - 'use_talos_json': True, 16:04:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:04:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:04:03 INFO - 'work_dir': 'build'} 16:04:03 INFO - ##### 16:04:03 INFO - ##### Running clobber step. 16:04:03 INFO - ##### 16:04:03 INFO - Running pre-action listener: _resource_record_pre_action 16:04:03 INFO - Running main action method: clobber 16:04:03 INFO - rmtree: /builds/slave/test/build 16:04:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:04:04 INFO - Running post-action listener: _resource_record_post_action 16:04:04 INFO - ##### 16:04:04 INFO - ##### Finished clobber step (success) 16:04:04 INFO - ##### 16:04:04 INFO - ##### 16:04:04 INFO - ##### Running read-buildbot-config step. 16:04:04 INFO - ##### 16:04:04 INFO - Running pre-action listener: _resource_record_pre_action 16:04:04 INFO - Running main action method: read_buildbot_config 16:04:04 INFO - Using buildbot properties: 16:04:04 INFO - { 16:04:04 INFO - "project": "", 16:04:04 INFO - "product": "firefox", 16:04:04 INFO - "script_repo_revision": "production", 16:04:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:04:04 INFO - "repository": "", 16:04:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:04:04 INFO - "buildid": "20160708133026", 16:04:04 INFO - "pgo_build": "True", 16:04:04 INFO - "basedir": "/builds/slave/test", 16:04:04 INFO - "buildnumber": 284, 16:04:04 INFO - "slavename": "talos-linux64-ix-049", 16:04:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:04:04 INFO - "platform": "ubuntu64_hw", 16:04:04 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:04:04 INFO - "branch": "mozilla-central", 16:04:04 INFO - "repo_path": "mozilla-central", 16:04:04 INFO - "revision": "a5bbe665a0d9677fadcd2a11b14818fd81209968", 16:04:04 INFO - "stage_platform": "linux64-pgo", 16:04:04 INFO - "builduid": "3f7db57047674eb5af1c76ae62f3dd8f", 16:04:04 INFO - "slavebuilddir": "test" 16:04:04 INFO - } 16:04:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:04:04 INFO - Running post-action listener: _resource_record_post_action 16:04:04 INFO - ##### 16:04:04 INFO - ##### Finished read-buildbot-config step (success) 16:04:04 INFO - ##### 16:04:04 INFO - ##### 16:04:04 INFO - ##### Running download-and-extract step. 16:04:04 INFO - ##### 16:04:04 INFO - Running pre-action listener: _resource_record_pre_action 16:04:04 INFO - Running main action method: download_and_extract 16:04:04 INFO - mkdir: /builds/slave/test/build/tests 16:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:04 INFO - https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:04:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:04:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:04:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:07 INFO - Downloaded 1361 bytes. 16:04:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:04:07 INFO - Using the following test package requirements: 16:04:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:04:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:04:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:04:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'jsshell-linux-x86_64.zip'], 16:04:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:04:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:04:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:04:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:04:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:04:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:04:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:04:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:04:07 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:04:07 INFO - https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:08 INFO - Downloaded 24304665 bytes. 16:04:08 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:04:08 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:04:09 INFO - Return code: 0 16:04:09 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:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:09 INFO - https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:04:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:04:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:04:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:22 INFO - Downloaded 24304665 bytes. 16:04:22 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:04:22 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:04:23 INFO - Return code: 0 16:04:23 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:04:23 INFO - https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:25 INFO - Downloaded 14403333 bytes. 16:04:25 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:04:25 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:04:25 INFO - Return code: 0 16:04: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:04:25 INFO - https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnubN04USsSVQ-PLtY17jg/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:04:26 INFO - Downloaded 60455781 bytes. 16:04:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:26 INFO - mkdir: /builds/slave/test/properties 16:04:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:04:26 INFO - Writing to file /builds/slave/test/properties/build_url 16:04:26 INFO - Contents: 16:04:26 INFO - build_url:https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:04:27 INFO - Running post-action listener: _resource_record_post_action 16:04:27 INFO - Running post-action listener: set_extra_try_arguments 16:04:27 INFO - ##### 16:04:27 INFO - ##### Finished download-and-extract step (success) 16:04:27 INFO - ##### 16:04:27 INFO - ##### 16:04:27 INFO - ##### Running populate-webroot step. 16:04:27 INFO - ##### 16:04:27 INFO - Running pre-action listener: _resource_record_pre_action 16:04:27 INFO - Running main action method: populate_webroot 16:04:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:04:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:04:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:04:27 INFO - '--tppagecycles', 16:04:27 INFO - '7'], 16:04:27 INFO - 'tests': ['tsvgm']}}, 16:04:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:04:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:04:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:04:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:04:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['damp', 'tps']}, 16:04:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'tests': ['damp', 'tps']}, 16:04:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['dromaeo_dom']}, 16:04:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:04:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['basic_compositor_video']}, 16:04:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:04:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['a11yr', 16:04:27 INFO - 'ts_paint', 16:04:27 INFO - 'tpaint', 16:04:27 INFO - 'sessionrestore', 16:04:27 INFO - 'sessionrestore_no_auto_restore', 16:04:27 INFO - 'tabpaint']}, 16:04:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:04:27 INFO - 'ts_paint', 16:04:27 INFO - 'tpaint', 16:04:27 INFO - 'sessionrestore', 16:04:27 INFO - 'sessionrestore_no_auto_restore', 16:04:27 INFO - 'tabpaint']}, 16:04:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:04:27 INFO - 'ts_paint', 16:04:27 INFO - 'tpaint', 16:04:27 INFO - 'sessionrestore', 16:04:27 INFO - 'sessionrestore_no_auto_restore', 16:04:27 INFO - 'tabpaint']}, 16:04:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:04:27 INFO - 'ts_paint', 16:04:27 INFO - 'tpaint', 16:04:27 INFO - 'sessionrestore', 16:04:27 INFO - 'sessionrestore_no_auto_restore', 16:04:27 INFO - 'tabpaint']}, 16:04:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['a11yr', 16:04:27 INFO - 'ts_paint', 16:04:27 INFO - 'tpaint', 16:04:27 INFO - 'sessionrestore', 16:04:27 INFO - 'sessionrestore_no_auto_restore', 16:04:27 INFO - 'tabpaint']}, 16:04:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['a11yr', 16:04:27 INFO - 'ts_paint', 16:04:27 INFO - 'tpaint', 16:04:27 INFO - 'sessionrestore', 16:04:27 INFO - 'sessionrestore_no_auto_restore', 16:04:27 INFO - 'tabpaint']}, 16:04:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['tsvgx', 16:04:27 INFO - 'tsvgr_opacity', 16:04:27 INFO - 'tart', 16:04:27 INFO - 'tscrollx', 16:04:27 INFO - 'cart']}, 16:04:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:04:27 INFO - 'tsvgr_opacity', 16:04:27 INFO - 'tart', 16:04:27 INFO - 'tscrollx', 16:04:27 INFO - 'cart']}, 16:04:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'talos_options': ['--disable-e10s'], 16:04:27 INFO - 'tests': ['tp5o']}, 16:04:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'tests': ['tp5o']}, 16:04:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'talos_options': ['--disable-e10s', 16:04:27 INFO - '--xperf_path', 16:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:27 INFO - 'tests': ['tp5n']}, 16:04:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:27 INFO - 'talos_options': ['--xperf_path', 16:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:27 INFO - 'tests': ['tp5n']}}, 16:04:27 INFO - 'talos.zip': {'path': '', 16:04:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:04:27 INFO - Running post-action listener: _resource_record_post_action 16:04:27 INFO - ##### 16:04:27 INFO - ##### Finished populate-webroot step (success) 16:04:27 INFO - ##### 16:04:27 INFO - ##### 16:04:27 INFO - ##### Running create-virtualenv step. 16:04:27 INFO - ##### 16:04:27 INFO - Running pre-action listener: _resource_record_pre_action 16:04:27 INFO - Running main action method: create_virtualenv 16:04:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:04:27 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:04:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:04:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:04:27 INFO - Using real prefix '/usr' 16:04:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:04:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:04:30 INFO - Installing pip.................done. 16:04:30 INFO - Return code: 0 16:04:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:04:30 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:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:30 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:04:30 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:04:30 INFO - Using env: {'DISPLAY': ':0', 16:04:30 INFO - 'HOME': '/home/cltbld', 16:04:30 INFO - 'LANG': 'en_US.UTF-8', 16:04:30 INFO - 'LANGUAGE': 'en_US:en', 16:04:30 INFO - 'LOGNAME': 'cltbld', 16:04:30 INFO - 'MAIL': '/var/mail/cltbld', 16:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:30 INFO - 'MOZ_NO_REMOTE': '1', 16:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:30 INFO - 'NO_EM_RESTART': '1', 16:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:30 INFO - 'PWD': '/builds/slave/test', 16:04:30 INFO - 'SHELL': '/bin/bash', 16:04:30 INFO - 'SHLVL': '1', 16:04:30 INFO - 'TERM': 'linux', 16:04:30 INFO - 'TMOUT': '86400', 16:04:30 INFO - 'USER': 'cltbld', 16:04:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:30 INFO - '_': '/tools/buildbot/bin/python'} 16:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:30 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:04:30 INFO - Cleaning up... 16:04:30 INFO - Return code: 0 16:04:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:04:30 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:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:30 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:30 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:04:30 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:04:30 INFO - Using env: {'DISPLAY': ':0', 16:04:30 INFO - 'HOME': '/home/cltbld', 16:04:30 INFO - 'LANG': 'en_US.UTF-8', 16:04:30 INFO - 'LANGUAGE': 'en_US:en', 16:04:30 INFO - 'LOGNAME': 'cltbld', 16:04:30 INFO - 'MAIL': '/var/mail/cltbld', 16:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:30 INFO - 'MOZ_NO_REMOTE': '1', 16:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:30 INFO - 'NO_EM_RESTART': '1', 16:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:30 INFO - 'PWD': '/builds/slave/test', 16:04:30 INFO - 'SHELL': '/bin/bash', 16:04:30 INFO - 'SHLVL': '1', 16:04:30 INFO - 'TERM': 'linux', 16:04:30 INFO - 'TMOUT': '86400', 16:04:30 INFO - 'USER': 'cltbld', 16:04:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:30 INFO - '_': '/tools/buildbot/bin/python'} 16:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:30 INFO - Downloading/unpacking psutil>=3.1.1 16:04:30 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:04:30 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:04:30 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:04:30 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:04:30 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:04:30 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:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:32 INFO - Installing collected packages: psutil 16:04:32 INFO - Running setup.py install for psutil 16:04:32 INFO - building 'psutil._psutil_linux' extension 16:04:32 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:04:32 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:04:32 INFO - building 'psutil._psutil_posix' extension 16:04:32 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:04:32 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:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:33 INFO - Successfully installed psutil 16:04:33 INFO - Cleaning up... 16:04:33 INFO - Return code: 0 16:04:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:33 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:33 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:04:33 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:04:33 INFO - Using env: {'DISPLAY': ':0', 16:04:33 INFO - 'HOME': '/home/cltbld', 16:04:33 INFO - 'LANG': 'en_US.UTF-8', 16:04:33 INFO - 'LANGUAGE': 'en_US:en', 16:04:33 INFO - 'LOGNAME': 'cltbld', 16:04:33 INFO - 'MAIL': '/var/mail/cltbld', 16:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:33 INFO - 'MOZ_NO_REMOTE': '1', 16:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:33 INFO - 'NO_EM_RESTART': '1', 16:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:33 INFO - 'PWD': '/builds/slave/test', 16:04:33 INFO - 'SHELL': '/bin/bash', 16:04:33 INFO - 'SHLVL': '1', 16:04:33 INFO - 'TERM': 'linux', 16:04:33 INFO - 'TMOUT': '86400', 16:04:33 INFO - 'USER': 'cltbld', 16:04:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:33 INFO - '_': '/tools/buildbot/bin/python'} 16:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:04:33 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:04:33 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:04:33 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:04:33 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:04:33 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:04:33 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:04:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:04:35 INFO - Installing collected packages: mozsystemmonitor 16:04:35 INFO - Running setup.py install for mozsystemmonitor 16:04:35 INFO - Successfully installed mozsystemmonitor 16:04:35 INFO - Cleaning up... 16:04:35 INFO - Return code: 0 16:04:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:35 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:35 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:04:35 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:04:35 INFO - Using env: {'DISPLAY': ':0', 16:04:35 INFO - 'HOME': '/home/cltbld', 16:04:35 INFO - 'LANG': 'en_US.UTF-8', 16:04:35 INFO - 'LANGUAGE': 'en_US:en', 16:04:35 INFO - 'LOGNAME': 'cltbld', 16:04:35 INFO - 'MAIL': '/var/mail/cltbld', 16:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:35 INFO - 'MOZ_NO_REMOTE': '1', 16:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:35 INFO - 'NO_EM_RESTART': '1', 16:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:35 INFO - 'PWD': '/builds/slave/test', 16:04:35 INFO - 'SHELL': '/bin/bash', 16:04:35 INFO - 'SHLVL': '1', 16:04:35 INFO - 'TERM': 'linux', 16:04:35 INFO - 'TMOUT': '86400', 16:04:35 INFO - 'USER': 'cltbld', 16:04:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:35 INFO - '_': '/tools/buildbot/bin/python'} 16:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:35 INFO - Downloading/unpacking jsonschema==2.5.1 16:04:35 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:04:35 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:04:35 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:04:35 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:04:35 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:04:35 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:04:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:04:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:04:37 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:04:37 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:04:37 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:04:37 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:04:37 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:04:37 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:04:37 INFO - Downloading functools32-3.2.3-2.tar.gz 16:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:04:37 INFO - warning: no files found matching '*.txt' 16:04:37 INFO - no previously-included directories found matching 'build' 16:04:37 INFO - no previously-included directories found matching 'dist' 16:04:37 INFO - no previously-included directories found matching '.git*' 16:04:37 INFO - Installing collected packages: jsonschema, functools32 16:04:37 INFO - Running setup.py install for functools32 16:04:37 INFO - warning: no files found matching '*.txt' 16:04:37 INFO - no previously-included directories found matching 'build' 16:04:37 INFO - no previously-included directories found matching 'dist' 16:04:37 INFO - no previously-included directories found matching '.git*' 16:04:37 INFO - Successfully installed jsonschema functools32 16:04:37 INFO - Cleaning up... 16:04:37 INFO - Return code: 0 16:04:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:04: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:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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', '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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:04: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 blobuploader==1.2.4 16:04:37 INFO - Using env: {'DISPLAY': ':0', 16:04:37 INFO - 'HOME': '/home/cltbld', 16:04:37 INFO - 'LANG': 'en_US.UTF-8', 16:04:37 INFO - 'LANGUAGE': 'en_US:en', 16:04:37 INFO - 'LOGNAME': 'cltbld', 16:04:37 INFO - 'MAIL': '/var/mail/cltbld', 16:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:37 INFO - 'MOZ_NO_REMOTE': '1', 16:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:37 INFO - 'NO_EM_RESTART': '1', 16:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:37 INFO - 'PWD': '/builds/slave/test', 16:04:37 INFO - 'SHELL': '/bin/bash', 16:04:37 INFO - 'SHLVL': '1', 16:04:37 INFO - 'TERM': 'linux', 16:04:37 INFO - 'TMOUT': '86400', 16:04:37 INFO - 'USER': 'cltbld', 16:04:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:37 INFO - '_': '/tools/buildbot/bin/python'} 16:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:38 INFO - Downloading/unpacking blobuploader==1.2.4 16:04: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:04: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:04: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:04: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:04: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:04: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:04:40 INFO - Downloading blobuploader-1.2.4.tar.gz 16:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:04:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:04: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:04: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:04: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:04: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:04: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:04: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:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:04:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:04: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:04: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:04: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:04: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:04: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:04: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:04:40 INFO - Downloading docopt-0.6.1.tar.gz 16:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:04:40 INFO - Installing collected packages: blobuploader, requests, docopt 16:04:40 INFO - Running setup.py install for blobuploader 16:04:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:04:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:04:40 INFO - Running setup.py install for requests 16:04:41 INFO - Running setup.py install for docopt 16:04:41 INFO - Successfully installed blobuploader requests docopt 16:04:41 INFO - Cleaning up... 16:04:41 INFO - Return code: 0 16:04:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:41 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:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:41 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:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:41 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:41 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:04:41 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:04:41 INFO - Using env: {'DISPLAY': ':0', 16:04:41 INFO - 'HOME': '/home/cltbld', 16:04:41 INFO - 'LANG': 'en_US.UTF-8', 16:04:41 INFO - 'LANGUAGE': 'en_US:en', 16:04:41 INFO - 'LOGNAME': 'cltbld', 16:04:41 INFO - 'MAIL': '/var/mail/cltbld', 16:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:41 INFO - 'MOZ_NO_REMOTE': '1', 16:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:41 INFO - 'NO_EM_RESTART': '1', 16:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:41 INFO - 'PWD': '/builds/slave/test', 16:04:41 INFO - 'SHELL': '/bin/bash', 16:04:41 INFO - 'SHLVL': '1', 16:04:41 INFO - 'TERM': 'linux', 16:04:41 INFO - 'TMOUT': '86400', 16:04:41 INFO - 'USER': 'cltbld', 16:04:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:41 INFO - '_': '/tools/buildbot/bin/python'} 16:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:41 INFO - Running setup.py (path:/tmp/pip-Ov_UJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:41 INFO - Running setup.py (path:/tmp/pip-KUGspl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:41 INFO - Running setup.py (path:/tmp/pip-NQuF0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:41 INFO - Running setup.py (path:/tmp/pip-HMf45L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:41 INFO - Running setup.py (path:/tmp/pip-syA3Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:41 INFO - Running setup.py (path:/tmp/pip-QN4JLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:42 INFO - Running setup.py (path:/tmp/pip-Les8xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:42 INFO - Running setup.py (path:/tmp/pip-GhWKLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:42 INFO - Running setup.py (path:/tmp/pip-3mlKnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:42 INFO - Running setup.py (path:/tmp/pip-0ZEsVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:42 INFO - Running setup.py (path:/tmp/pip-12eVGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:42 INFO - Running setup.py (path:/tmp/pip-w9Z9EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:42 INFO - Running setup.py (path:/tmp/pip-qTfKJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:42 INFO - Running setup.py (path:/tmp/pip-_8X9_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:42 INFO - Running setup.py (path:/tmp/pip-c35vPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:42 INFO - Running setup.py (path:/tmp/pip-JHKitu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:43 INFO - Running setup.py (path:/tmp/pip-9n61ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:04:43 INFO - Running setup.py install for manifestparser 16:04:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Running setup.py install for mozcrash 16:04:43 INFO - Running setup.py install for mozdebug 16:04:43 INFO - Running setup.py install for mozdevice 16:04:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Running setup.py install for mozfile 16:04:43 INFO - Running setup.py install for mozhttpd 16:04:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Running setup.py install for mozinfo 16:04:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Running setup.py install for mozInstall 16:04:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:04:43 INFO - Running setup.py install for mozleak 16:04:44 INFO - Running setup.py install for mozlog 16:04:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:04:44 INFO - Running setup.py install for moznetwork 16:04:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:04:44 INFO - Running setup.py install for mozprocess 16:04:44 INFO - Running setup.py install for mozprofile 16:04:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:04:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:04:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:04:44 INFO - Running setup.py install for mozrunner 16:04:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:04:44 INFO - Running setup.py install for mozscreenshot 16:04:44 INFO - Running setup.py install for moztest 16:04:44 INFO - Running setup.py install for mozversion 16:04:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:04:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:04:44 INFO - Cleaning up... 16:04:44 INFO - Return code: 0 16:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:44 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:44 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:04:44 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:04:44 INFO - Using env: {'DISPLAY': ':0', 16:04:44 INFO - 'HOME': '/home/cltbld', 16:04:44 INFO - 'LANG': 'en_US.UTF-8', 16:04:44 INFO - 'LANGUAGE': 'en_US:en', 16:04:44 INFO - 'LOGNAME': 'cltbld', 16:04:44 INFO - 'MAIL': '/var/mail/cltbld', 16:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:44 INFO - 'MOZ_NO_REMOTE': '1', 16:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:44 INFO - 'NO_EM_RESTART': '1', 16:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:44 INFO - 'PWD': '/builds/slave/test', 16:04:44 INFO - 'SHELL': '/bin/bash', 16:04:44 INFO - 'SHLVL': '1', 16:04:44 INFO - 'TERM': 'linux', 16:04:44 INFO - 'TMOUT': '86400', 16:04:44 INFO - 'USER': 'cltbld', 16:04:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:44 INFO - '_': '/tools/buildbot/bin/python'} 16:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:45 INFO - Running setup.py (path:/tmp/pip-4qYZ9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:45 INFO - Running setup.py (path:/tmp/pip-DmahWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:45 INFO - Running setup.py (path:/tmp/pip-Zp6Xpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:45 INFO - Running setup.py (path:/tmp/pip-o0MHGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:45 INFO - Running setup.py (path:/tmp/pip-1zCsGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:45 INFO - Running setup.py (path:/tmp/pip-q_nOHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:45 INFO - Running setup.py (path:/tmp/pip-nZUHT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:45 INFO - Running setup.py (path:/tmp/pip-7F1lfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:45 INFO - Running setup.py (path:/tmp/pip-iR5xVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:45 INFO - Running setup.py (path:/tmp/pip-ULaBQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:45 INFO - Running setup.py (path:/tmp/pip-23PhjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:45 INFO - Running setup.py (path:/tmp/pip-UP6CFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:45 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:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:45 INFO - Running setup.py (path:/tmp/pip-weIRTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:46 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:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:46 INFO - Running setup.py (path:/tmp/pip-HzrwDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:46 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:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:46 INFO - Running setup.py (path:/tmp/pip-fH0w_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:46 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:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:46 INFO - Running setup.py (path:/tmp/pip-BuKm_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:46 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:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:46 INFO - Running setup.py (path:/tmp/pip-wmKMxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:46 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:04:48 INFO - Downloading blessings-1.6.tar.gz 16:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:04:48 INFO - Installing collected packages: blessings 16:04:48 INFO - Running setup.py install for blessings 16:04:48 INFO - Successfully installed blessings 16:04:48 INFO - Cleaning up... 16:04:48 INFO - Return code: 0 16:04:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:04:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:48 INFO - Reading from file tmpfile_stdout 16:04:48 INFO - Current package versions: 16:04:48 INFO - argparse == 1.2.1 16:04:48 INFO - blessings == 1.6 16:04:48 INFO - blobuploader == 1.2.4 16:04:48 INFO - docopt == 0.6.1 16:04:48 INFO - functools32 == 3.2.3-2 16:04:48 INFO - jsonschema == 2.5.1 16:04:48 INFO - manifestparser == 1.1 16:04:48 INFO - mozInstall == 1.12 16:04:48 INFO - mozcrash == 0.17 16:04:48 INFO - mozdebug == 0.1 16:04:48 INFO - mozdevice == 0.48 16:04:48 INFO - mozfile == 1.2 16:04:48 INFO - mozhttpd == 0.7 16:04:48 INFO - mozinfo == 0.9 16:04:48 INFO - mozleak == 0.1 16:04:48 INFO - mozlog == 3.2 16:04:48 INFO - moznetwork == 0.27 16:04:48 INFO - mozprocess == 0.23 16:04:48 INFO - mozprofile == 0.28 16:04:48 INFO - mozrunner == 6.12 16:04:48 INFO - mozscreenshot == 0.1 16:04:48 INFO - mozsystemmonitor == 0.3 16:04:48 INFO - moztest == 0.7 16:04:48 INFO - mozversion == 1.4 16:04:48 INFO - psutil == 3.1.1 16:04:48 INFO - requests == 1.2.3 16:04:48 INFO - wsgiref == 0.1.2 16:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04: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:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:48 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:48 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:04:48 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:04:48 INFO - Using env: {'DISPLAY': ':0', 16:04:48 INFO - 'HOME': '/home/cltbld', 16:04:48 INFO - 'LANG': 'en_US.UTF-8', 16:04:48 INFO - 'LANGUAGE': 'en_US:en', 16:04:48 INFO - 'LOGNAME': 'cltbld', 16:04:48 INFO - 'MAIL': '/var/mail/cltbld', 16:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:48 INFO - 'MOZ_NO_REMOTE': '1', 16:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:48 INFO - 'NO_EM_RESTART': '1', 16:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:48 INFO - 'PWD': '/builds/slave/test', 16:04:48 INFO - 'SHELL': '/bin/bash', 16:04:48 INFO - 'SHLVL': '1', 16:04:48 INFO - 'TERM': 'linux', 16:04:48 INFO - 'TMOUT': '86400', 16:04:48 INFO - 'USER': 'cltbld', 16:04:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:48 INFO - '_': '/tools/buildbot/bin/python'} 16:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 INFO - Cleaning up... 16:04:48 INFO - Return code: 0 16:04:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:04: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:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:48 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 0x1039030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', '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:04:48 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:04:48 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:04:48 INFO - Using env: {'DISPLAY': ':0', 16:04:48 INFO - 'HOME': '/home/cltbld', 16:04:48 INFO - 'LANG': 'en_US.UTF-8', 16:04:48 INFO - 'LANGUAGE': 'en_US:en', 16:04:48 INFO - 'LOGNAME': 'cltbld', 16:04:48 INFO - 'MAIL': '/var/mail/cltbld', 16:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:48 INFO - 'MOZ_NO_REMOTE': '1', 16:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:48 INFO - 'NO_EM_RESTART': '1', 16:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:48 INFO - 'PWD': '/builds/slave/test', 16:04:48 INFO - 'SHELL': '/bin/bash', 16:04:48 INFO - 'SHLVL': '1', 16:04:48 INFO - 'TERM': 'linux', 16:04:48 INFO - 'TMOUT': '86400', 16:04:48 INFO - 'USER': 'cltbld', 16:04:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:48 INFO - '_': '/tools/buildbot/bin/python'} 16:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:04:49 INFO - Cleaning up... 16:04:49 INFO - Return code: 0 16:04:49 INFO - Running post-action listener: _resource_record_post_action 16:04:49 INFO - Running post-action listener: _start_resource_monitoring 16:04:49 INFO - Starting resource monitoring. 16:04:49 INFO - ##### 16:04:49 INFO - ##### Finished create-virtualenv step (success) 16:04:49 INFO - ##### 16:04:49 INFO - ##### 16:04:49 INFO - ##### Running install step. 16:04:49 INFO - ##### 16:04:49 INFO - Running pre-action listener: _resource_record_pre_action 16:04:49 INFO - Running main action method: install 16:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:49 INFO - Reading from file tmpfile_stdout 16:04:49 INFO - Detecting whether we're running mozinstall >=1.0... 16:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:04:49 INFO - Reading from file tmpfile_stdout 16:04:49 INFO - Output received: 16:04:49 INFO - Usage: mozinstall [options] installer 16:04:49 INFO - Options: 16:04:49 INFO - -h, --help show this help message and exit 16:04:49 INFO - -d DEST, --destination=DEST 16:04:49 INFO - Directory to install application into. [default: 16:04:49 INFO - "/builds/slave/test"] 16:04:49 INFO - --app=APP Application being installed. [default: firefox] 16:04:49 INFO - mkdir: /builds/slave/test/build/application 16:04:49 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:04:49 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:05:06 INFO - Reading from file tmpfile_stdout 16:05:06 INFO - Output received: 16:05:06 INFO - /builds/slave/test/build/application/firefox/firefox 16:05:06 INFO - Running post-action listener: _resource_record_post_action 16:05:06 INFO - ##### 16:05:06 INFO - ##### Finished install step (success) 16:05:06 INFO - ##### 16:05:06 INFO - ##### 16:05:06 INFO - ##### Running run-tests step. 16:05:06 INFO - ##### 16:05:06 INFO - Running pre-action listener: _resource_record_pre_action 16:05:06 INFO - Running main action method: run_tests 16:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:05:06 INFO - Python 2.7.3 16:05:06 INFO - Return code: 0 16:05:06 INFO - grabbing minidump binary from tooltool 16:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:06 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 0x12f83b0>, '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 0x12f92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:05:06 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:05:06 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:05:06 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:05:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:05:06 INFO - Return code: 0 16:05:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:05:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:05:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:05:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:05:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:05:06 INFO - Using env: {'DISPLAY': ':0', 16:05:06 INFO - 'HOME': '/home/cltbld', 16:05:06 INFO - 'LANG': 'en_US.UTF-8', 16:05:06 INFO - 'LANGUAGE': 'en_US:en', 16:05:06 INFO - 'LOGNAME': 'cltbld', 16:05:06 INFO - 'MAIL': '/var/mail/cltbld', 16:05:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:05:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:06 INFO - 'MOZ_NO_REMOTE': '1', 16:05:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:06 INFO - 'NO_EM_RESTART': '1', 16:05:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:06 INFO - 'PWD': '/builds/slave/test', 16:05:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:05:06 INFO - 'SHELL': '/bin/bash', 16:05:06 INFO - 'SHLVL': '1', 16:05:06 INFO - 'TERM': 'linux', 16:05:06 INFO - 'TMOUT': '86400', 16:05:06 INFO - 'USER': 'cltbld', 16:05:06 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447', 16:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:06 INFO - '_': '/tools/buildbot/bin/python'} 16:05:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:05:06 INFO - mozversion application_buildid: 20160708133026 16:05:06 INFO - mozversion application_changeset: a5bbe665a0d9677fadcd2a11b14818fd81209968 16:05:06 INFO - mozversion application_display_name: Nightly 16:05:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:05:06 INFO - mozversion application_name: Firefox 16:05:06 INFO - mozversion application_remotingname: firefox 16:05:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:05:06 INFO - mozversion application_vendor: Mozilla 16:05:06 INFO - mozversion application_version: 50.0a1 16:05:06 INFO - mozversion platform_buildid: 20160708133026 16:05:06 INFO - mozversion platform_changeset: a5bbe665a0d9677fadcd2a11b14818fd81209968 16:05:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:05:06 INFO - mozversion platform_version: 50.0a1 16:05:06 INFO - using testdate: 1468019106 16:05:06 INFO - actual date: 1468019106 16:05:06 INFO - starting webserver on 'localhost:35527' 16:05:06 INFO - SUITE-START | Running 2 tests 16:05:06 INFO - TEST-START | dromaeo_css 16:05:06 INFO - operating with platform_type : linux_ 16:05:06 INFO - Initialising browser for dromaeo_css test... 16:05:06 INFO - TEST-INFO | started process 5345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm79LaH/profile http://localhost:35527/getInfo.html) 16:05:11 INFO - PROCESS | 5345 | __metrics Screen width/height:1600/1200 16:05:11 INFO - PROCESS | 5345 | colorDepth:24 16:05:11 INFO - PROCESS | 5345 | Browser inner width/height: 1024/697 16:05:11 INFO - PROCESS | 5345 | __metrics 16:05:12 ERROR - PROCESS | 5345 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 16:05:13 INFO - TEST-INFO | 5345: exit 0 16:05:13 INFO - Browser initialized. 16:05:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:05:13 INFO - TEST-INFO | started process 5467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm79LaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:24 INFO - PROCESS | 5467 | RSS: Main: 167182336 16:05:24 INFO - PROCESS | 5467 | 16:06:14 INFO - PROCESS | 5467 | 1468019174462 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:08:22 INFO - PROCESS | 5467 | Cycle 1(1): loaded http://localhost:35527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35527/tests/dromaeo/cssquery-ext.html) 16:08:23 INFO - PROCESS | 5467 | RSS: Main: 170651648 16:08:23 INFO - PROCESS | 5467 | 16:11:25 INFO - PROCESS | 5467 | Cycle 1(1): loaded http://localhost:35527/tests/dromaeo/cssquery-ext.html (next: http://localhost:35527/tests/dromaeo/cssquery-jquery.html) 16:11:26 INFO - PROCESS | 5467 | RSS: Main: 167784448 16:11:26 INFO - PROCESS | 5467 | 16:14:28 INFO - PROCESS | 5467 | Cycle 1(1): loaded http://localhost:35527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35527/tests/dromaeo/cssquery-mootools.html) 16:14:28 INFO - PROCESS | 5467 | RSS: Main: 171003904 16:14:28 INFO - PROCESS | 5467 | 16:17:30 INFO - PROCESS | 5467 | Cycle 1(1): loaded http://localhost:35527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35527/tests/dromaeo/cssquery-prototype.html) 16:17:31 INFO - PROCESS | 5467 | RSS: Main: 166359040 16:17:31 INFO - PROCESS | 5467 | 16:20:33 INFO - PROCESS | 5467 | Cycle 1(1): loaded http://localhost:35527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35527/tests/dromaeo/cssquery-yui.html) 16:20:34 INFO - PROCESS | 5467 | RSS: Main: 168476672 16:20:34 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | Cycle 1(1): loaded http://localhost:35527/tests/dromaeo/cssquery-yui.html (next: http://localhost:35527/tests/dromaeo/cssquery-dojo.html) 16:23:37 INFO - PROCESS | 5467 | RSS: Main: 169234432 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | __start_tp_report 16:23:37 INFO - PROCESS | 5467 | _x_x_mozilla_page_load 16:23:37 INFO - PROCESS | 5467 | _x_x_mozilla_page_load_details 16:23:37 INFO - PROCESS | 5467 | |i|pagename|runs| 16:23:37 INFO - PROCESS | 5467 | |0;dojo.html;3044.862981165848;3081.4453398388296;3083.984580077099;3104;3117.6258848938132;5381.91927121093;5390.81132160374;5391.649542779716;5444.265024221729;5515.448455154483;5205.60957928155;5305.708186049766;5310.787568497265;5350.491703288191;5400.270963419937;4857.3685420895235;4881.633877459187;4913.778879950393;5006.799728010893;5055.342805435288;4864.0515099555605;5051.217061355495;5059.671121377117;5060.0385926674;5064.56951159152;4826.227803551415;4886.902261954741;4915.188993816052;4917.164082106051;4940.752962351886;4891.877703057452;4903.8774030649165;4910.091633047898;4927.798551993014;4981.72600506972;4908.950910490885;4923.990581930731;4926.507349265081;4933.851984440473;4957.7769000395065;5146.742662866842;5291.708956007418;5302.2046692996355;5360.410354860962;5416.4312747161375;5699.316082070137;5711.086226203787;5736.053551164053;5740.311162660466;5743.368229494752;5584.301962254718;5777.826665200051;5789.247397838296;5793.333766616851;5795.1886735857015;5325;5379.5427388671615;5391.487808658171;5395.70323632204;5410.431904649994;5881.206037184926;5901;5904.61619994699;5920.407959204045;5933.110033494924;5406.107992181246;5634.154876768435;5674.4892959633835;5690.573207009408;5691.857703557362;5722;5785.218995435563;5799.246098007232;5811.099279611667;5848.502877255396;5454.863628409242;5616.185653080281;5711.7144142792695;5751.1085781703905;5767.048437007847;5450.373207081237;5550.861228469321;5753.913691294634;5756.453136951983;5760.798372056958;4321.783910804447;4342.978285108554;4346.630536404441;4347.391365208873;4378.60592546666;3887.494625698641;3914.628110329514;3934.272159650474;3950.229705207457;3971.4837071180564;5478.150886612581;5499.972500137554;5509.5041446270025;5528;5549.056660367747;5509.917351239735;5754;5755.769769209185;5778.104393818965;5816.447437493432;5529.861753456195;5568.415316391802;5581.330240371181;5582.162675598612;5585.525230355384;4998.525140111684;5020.899582008339;5027.572656324253;5030.647854650139;5049.671771334852;5667.121596152603;5859.736311865891;5944.762209511571;5965.731542080617;6020.157177995085;5737.8565535861935;5747.770089196385;5760.6255593386295;5775.451332123442;5781.479666830005;5717.8570535736935;5951.970240148771;5974.462298393166;5977.193078934288;5977.6114552553945;5596.1605759136455;5623.971880140573;5642.633228840113;5647.632903861236;5693.772249109989;5727.255456790591;5727.599068065196;5729.828105156852;5741.598088133791;5757.107648314518;5458.6724796512335;5565.30433695788;5598.832035038955;5620.634658747168;5649.293838270216;5434.3207099112615;5573.16402539606;5592.217089607377;5642;5687.431256874445;5561.694106824163;5575;5585.273914391103;5599.8880022400135;5607.299087614048;5516.91724624139;5650.830475085754;5692.548400158099;5694.259746232963;5706.400827913176;5571;5598.972005139948;5604.747786349542;5607.523360514402;5651.350094739158 16:23:37 INFO - PROCESS | 5467 | |1;ext.html;561.8818213852994;579.0301245413932;593.187333353306;607.1045208317732;647.4658406814374;37712.811435942815;41955;42129.78935105324;42177.7891110544;42215.577844221545;41155.17689646205;41617.79191104048;41830.163396732045;41897.37153942693;41919.16161676765;8809.339299552543;8881.289496840269;8990.325725570576;8991.190792828644;9000.279977601776;8835;8877.95561022194;8895.377323587352;8920.598573064195;8942.55287235639;8926.062763409846;8950;8981.191692747652;8983.775405614846;9026.45841249527;8932.910670893305;8956.417832840845;8967.686130985418;8979.057198994076;8982.236509896667;8795.78010549735;8837.734867953908;8864.601092950832;8866.822663546758;8924.375293729441;39233.41149882754;39435.802820986;39584;39607.603923960676;39728;3452.171478845084;3472.080713699953;3485.860565577374;3566.5185199997927;3934.350832112698;31957.201069973205;32386.6761332386;32612.836935815405;32659.346813063843;33443.66556334454;4282.571742825724;4339.732863352372;4351.108022855307;4359.346098085281;4408.977955110236;368294;370655;370836;372255.99999999726;372536;60386.0942085869;60705.929407059826;60823;60991.69504152451;61065;35219.295614087576;62996.370036299966;63392;63485;63770.36229637644;16150.273237704332;17049.48851534456;17112.144392780312;17205.397811076553;17253.913730431268;13147.868521314664;13212.273324967027;13225.603231903058;13269.800952985714;13283.26942018179;19074.2370305189;19077.90461047686;19269.132889019747;19287.614247715246;19353.8064619352;6989.30106989297;7067.787966361017;7181.640917954186;7182;7236.457265705093;1030.9484525773682;1075.3547871277171;1125.5666568371237;1159.8144296912453;1159.8550181227347;32981.86672266131;33662.47531435152;33668.32663346719;33712;34117.14707132292;1091.9890801092047;1093.2456604942565;1098.3958822647512;1168.4479183282895;1184.8933595976403;17095.743563846554;17163.014855666668;17279.481615551555;17464;17547.385841495485;576286;577087;580781;584018;585798;56590;56691.14963275554;56717.43282567204;56755.43244567584;56763;1363.0458678924792;1366.9316534173252;1375.326090215787;1381.295539274977;1382.8962827787957;30094.247643808205;31958.52062219022;32051.35897282088;32230.355392891543;32234.677653223167;49034;49421.50578494169;49459;49518.257226140915;49861;450146;452868;453826;454523;455863;27660.723392765816;27890.163295101178;28319.29201769972;28483;28534.143975680763;47174.29238561356;48047.75976120097;48103;49046.509534904195;49258;40044.399334010595;40585;40832;41496.1700765989;42585;40914.59085409227;41057;41204.38193427041;41250.58749412467;42481.787591061846;42382.1523569533;44792.55207447884;45695.31457028081;45711;47956.280655789495;37022.07444813794;37077;37900.2419951605;41039.38440923329;41144.1771164581;34190;35535.28929421346;35775.67458115214;35899.10252243715;35937 16:23:37 INFO - PROCESS | 5467 | |2;jquery.html;396.64698418407625;405.6916743275112;406.9776162311073;408.5281499867654;423.7097588152116;19091.809081909178;19973.800261997374;20952.26667066653;20984.265550705728;21008.05463754131;12736.108472406935;12984.415701293441;17995.37016204433;19882.105305261262;19925;5225.764840582174;5228.973855130738;5763.596548241625;5807.128930660414;5827.271591051119;3936.1734035852505;5723.51350135239;5744.540436765049;5786.218860453827;6039.818805435844;5989.161517387569;6006.849828754294;6023.6385816851125;6039.728212230439;6051;5662.801801936933;5973.133895585138;5988.8502787430225;5992.820215393545;6060.212172417601;5582.637128586629;5811.535077193815;5830.212921255618;5835.649861008353;5845.970770146122;14208.85791142096;14245.216513091777;14315.355808988621;14384.928075359661;14487.710245795026;2301.5396920615776;2301.873396963166;2389.5340408620327;2397.6763136976633;2927.238917881345;10554.683359499228;10624.840627390595;11037.724056898562;11052.944735276273;11175.49710263032;1963.3128405058258;1970.4778233768063;1980.2574034736974;1987.7018447232886;2019.7475315585552;82479;83273.99999999939;85566.57216713938;86448.99999999937;87006;11427.942860285646;11484.368359740127;11519.712007199887;11569.88430115705;11592.130590205768;15932.362705491882;16012.599685007968;16046.679066418606;16058.919705401398;16141.35434582627;8062.959685201537;8430.620622072021;8489.108643592457;8570.100139485388;8695.391322607356;8118.35053195743;8155;8181.95909020463;8346.749597512084;8417.621207045697;4875.95124048762;4881.780319885614;4956.727379994063;4960.429550601727;5046.419661738947;1652.8512433881008;1772.6631939931372;1775.325376357002;1910.6656335141572;2000.109951071759;966.1160038564775;1063.4204358624568;1115.1691989467736;1125.4429057616533;1136.5510623303749;19923.302684405975;20410.489737756674;20465.48836279105;20710.792892070887;20820.583588328147;997.4464172384396;1020.336781092296;1028.9897101029044;1042.4579218806177;1049.5277125293649;11067.391293478937;11419.371934543513;11470.942645286887;11484.770304593862;11548.191626586226;469851;479116;497985;513985;514399;89057.55471222602;93265;93484;93928;94526.52736736409;974.1427543761445;1004.4023805835516;1028.2647906746563;1028.6913925822223;1037.4605205293205;17539.82460175382;17811.198496067966;18071.367502137364;18237.45287641373;18451.72322415138;43319.35020974625;43349;43857.56142438535;44232.7788361069;44806.10387792291;59365.406345937714;59690.70154649199;60660.09009864944;60908.390916092045;60964;5344.812931547377;5856.560757943086;8189.631466584137;8220.136885626924;8264.917350826656;10378.221633377376;13931.094478858842;13971;14256.572302830931;14367.353469093707;12141.514339426323;12283.140180187302;12412;12587.181833180814;12616;11616.244944078608;11682.415879206175;11806.291622502677;11939.104567157672;12000.15998880105;12170.330631815335;12175.147739658492;12300.938495307466;12302.81545776832;12812.10315277959;8023.398245131521;8130.674773009014;8164.877526837221;8285.875711864206;8396.790080247798;10568.524416401127;11748.412579371168;11755;11982.281063136239;12356.443960021641 16:23:37 INFO - PROCESS | 5467 | |3;mootools.html;1464.238595930116;1500.8424115467876;1618.6196243882694;1749.8075211726716;1759.4985429152694;7625.771226863189;8477.618507167177;8624.43941143826;9277.90722092779;9280;8537.060923298432;8735.301175905928;8781.560921953893;8838.558072096386;8859.778505537348;2310.792028717415;2333.2533589251448;2343.3087239264373;2344.10923848938;2351.5179388225456;2358.6697862299293;2360.197532838843;2394.6288325309606;2399.808015358767;2427.2232885476656;2364.527094581082;2385.7137143542714;2407.38611654028;2410.7227668818045;2423.624338227569;2323.337848713117;2333.626619740833;2339.63735620979;2340.0756701103137;2343.168175297762;2323.3959170615594;2332.1137967572213;2341.941451463727;2350.8119350452093;2365.5978483657645;8773.868391974125;8817.691380801705;8853.380263381567;8863.202311791969;8872.423292485968;5220.321358223407;5344.251804747339;5352.892942141136;5354.437784032699;5372.462753724635;3343.3146205028156;3379.509971054208;3405.9829700851583;3416.4021296273054;3434.8797792077407;1071.266182664877;1088.7822435512928;1103.0568863621647;1116.7487315354063;1132.5186795611914;12230.082743794252;12337.321447320393;12352.814707779391;12419.44112514939;12432.875671243262;4489.259272220047;4534.410526631516;4673;4677.111348843777;4731.810727570927;10587.788244235226;10615.89384106149;10619.415932123808;10641.733956651145;10691.518881650345;5337.066013447631;5360.490753378423;5363.785448582091;5378.91931621026;5380.24676545284;4263.062126332202;4682.9531704683195;4859.684120532154;4860.4896485869185;4931.3589233399425;3935.4293627423863;4041.656459200942;4047.4738284022887;4077.225327187825;4158.896027599274;1247.2765795838573;1269.156011252525;1270.2949862826035;1277.8977681785434;1285.755706415778;980.2207245240052;992.5632721602472;999.6201443451442;1009.0414106598761;1011.4993078426226;5954.702264886739;6037.909431358533;6147.538934579924;6189.907151392733;6212.9068063979075;972.397113789455;977.6480467031863;1005.6379703306803;1083.653230966099;1100.0429626225234;4124.649404800565;4268.189044081614;4318.870433886988;4328.523862375137;4348.826046958086;11079.667609971713;11152.609658661908;11363.488643011084;11370.374629395463;11573.826392604118;11127.387993660426;11182.440877956069;11231.157663175294;11356.37539935295;11379.544818207345;8221.876671849926;8494;8509.446885952393;8514.106018868053;8515.31877449815;5980.700964951822;6121.296050954019;6159.907601385893;6173.536984726074;6216.409441103088;10342.431166285927;10430.286461428765;10512.0013598708;10690.57237710514;10727.249092563447;10696.518656660624;10736.677899663022;10751.978562036595;10789.460526973462;10799.730006749895;7281.417486601165;8042.638081286474;8123.47197432165;8123.634436450256;8272.04871439768;9001.90998090037;9023.548822558978;9034.186923176683;9086.36395452312;9148.359614826899;7859.54598399298;8157.918420815953;8183.222593853575;8223.05434874997;8308.169183081643;7821.296083352526;7899.605019749105;7956.045274567089;8023.83952320962;8189.50862948225;7111.751088712077;7130.358267755927;7226.205117437183;7302.233265507045;7368.3736882363455;4969.254611808257;5059.569936555434;5071.39143302806;5135.563477104488;5188.429272779916;5357.116075847597;5416.8104116355735;5434.510894019557;5548.889022219452;5596.636218645775 16:23:37 INFO - PROCESS | 5467 | |4;prototype.html;335.6643356643357;340.2752137946174;340.33124909552754;341.46390167437124;346.63256947635506;5501.614886957909;5619;5622.803201887935;5657;5703.0589952657765;5537.197106419567;5550.417206193352;5554.888902221964;5594.5733837871385;5602.663840169593;4180.331147016478;4239;4339.2879450343535;4352.041581288417;4366.694331396788;4357.760323182224;4359.433273674418;4359.825606975717;4365.716228445157;4367.410399596061;4317.956820431787;4337.327714204288;4349.543297953716;4349.869503914888;4359.411479450266;4284.550122237167;4361.193179261847;4367.912641747179;4368.912621747547;4370.868873933755;3847.6729477994404;3848.4419759134767;3860.36304009838;3886.689064874803;3896.5518965319066;5412.621116521845;5445.754941027663;5462.525118218059;5483.451654834525;5501.339839219279;4859.465458799529;4975.029869175512;4992.750362481897;5061.266116413136;5063.341765570489;5743.770249190027;5808.4191580842;5828.6502809831545;5887.499562537189;5891.528677705774;4234.957650423487;4234.957650423487;4248.766317852517;4252.277112890816;4287.228298906196;5886.381929897342;5991.5206783457215;6033.33633300341;6036.9396306036815;6097.847553811146;4334.024844410045;4347.673924455678;4365.934510982338;4371.737695738266;4383.211022016004;4399.758013309235;4405.647548196137;4408.140412619508;4411.338299255073;4434.224010798098;4661.650376221797;4928.310036594879;4932.55606995365;4950.678205916676;5073.1122053640465;5873.794417195463;5875.882482350329;5882.382344855199;5883.499902508334;5896.469317761336;1454.9597038117797;1455.8544145585568;1473.6463248820205;1473.8820894328428;1481.140938255809;930.9720708378624;955.7180631713661;976.4580657735025;981.568110031598;999.5052449037773;5654.4062873398525;5677.37548869624;5681.801136960269;5689.630174038757;5714.428557144252;5911.261092363455;5929.822105336847;5986.5210783137245;6003;6032;5426;5662.499437649027;5694.572907031989;5717.542596592262;5797.91303130445;3183.108729555728;3212.7952017993252;3224.661410551905;3249.545063691085;3250.658680838525;6105.039056057808;6151.538634602333;6202.34875338083;6206.627602343874;6273.341299163522;6122.234720659918;6182.165407669997;6185.597936134137;6199.535034872402;6227.719752611143;6207.18258271169;6230.532710046674;6319.368063193644;6327.557071004985;6329.145565348711;6038.365971573097;6044.274687037408;6056.212692350143;6061.909071364022;6070.271567411939;5930.28836539618;5957.344692083954;5961.4038596140035;5974.4324289192455;5977.880442391215;6042.305134909541;6198.6280823150755;6268.905966410599;6274.968625156845;6286.622802631857;4225.260579398654;4234.259004674108;4248.277792775298;4252.362145678173;4272.33778764292;5926.4666180044005;6035.969820151046;6048.758049677964;6056.666883321283;6071;5850.36189866838;5853.209816674695;5878.676672783038;5879.676617786063;5901.2033375495475;5862.3844496328975;5881.676507792113;5894.261192948176;5896.469317761422;5917.85205369852;5200.60995425337;5708.343540492897;5736.827895163152;5749.223854779719;5800.941990580209;5863.1791549184;5878.118282257525;5887.234659494409;5929.851753706192;5953;5551.805686800943;5773.960687076198;5786.1899334094105;5818.458108601139;5848.970755146197 16:23:37 INFO - PROCESS | 5467 | |5;yui.html;733.9412846972243;755.6335177438941;767.8349154931689;781.5545139270617;902.2781774580334;14071.085379450342;14448.277586120677;14612.926935365309;14644.633884152889;14672.706545869076;14180.858191418083;14560.708785824278;14584.489542866002;14584.781228281585;14587.489437869677;795.8806179073157;796.6454927557254;800.7317548621219;801.5911884938665;803.1326167738857;674.3324109131974;802.1016461563057;819.901611806584;820.4666966471782;823.7487566292278;860.2730692564772;866;867.7310033889482;871.7646235516406;874.5539774714878;865.2040123086775;866.1208872993916;866.6923242249005;867.0592407238154;867.9435836670597;625.996870015647;631.4190944331226;631.908373285871;632.0708558419117;632.822809613309;14259.287035648176;14274;14286.071405358618;14297.213653249068;14312.57062288133;15405.922970385076;15744.842551574568;15762.290696918666;15937.92031039849;15978.76031859523;12823.87176128236;12931.5473958411;13038.934805326007;13328.533501327407;13589.932050339783;3772.830222639988;3861.343571592808;3874.5156855393075;3906.277338692351;4030.2141082488924;75856.62071689662;75908.04757945232;78837.60581197115;79311.20688793097;81191;11811.173217874839;11894.762104757856;11924.403779810975;11947.223430476992;12161.878381216075;22522;22849.771502285097;22856.542869142522;22946.42633934165;23113.884430578077;8652.221300083023;8824.205821476098;9222.584983675752;9292.7676808079;9379.906200937903;4556.020455602062;4577.198990176706;4644.303354496785;4671.18254305502;4850.587700045536;3489.3370259650587;3575.3385623659706;3583.3549961006747;3595.7123430125525;3599.9820000900354;607.6991889014965;613.0926229180837;624.3132554190354;624.9906251406233;626.7743612299569;660.072597999811;727.516201725857;728.8906664000336;741.9480636355403;772.2316295286226;9811.705648830546;9886.901130988743;10002.199824014062;10112.797744045078;10140.847887281696;695.5339922252103;697.7069630755095;721.4841388407314;733.812877716179;752.2966026764992;4576.748278844696;4730.124926888537;4767.4994125617;4819.108464933998;4841.3222148899185;121010;121848;123838.38080809539;125317;125924.37037814935;105075;105867;106676.79969600924;107924.46037769761;108759;91870.54064729768;93777.531112344;94480.52759736158;94609.5269523648;95065.5246723762;9063.501507417155;9072.773180670536;9130.634774608941;9336.813263734823;9352.485613291334;46825.531744682114;51680.96638067142;52248.21627675512;52589.211161833366;52899.73550132225;68864;80830;80946.5952670233;81321.59339203266;81390.59304703439;11484.770304593694;11767.88232117668;11886.28682279066;12193.634190974284;12587.181833181181;12892.731872090648;12965;12973.935130324287;13346.733065338445;13442.865571344162;11905.166638335233;11947.223430476992;12182.817257741319;12319.44562494672;13095.934520327337;12037.157398981988;12331.198472099284;12343.814842777187;12501;13166;12719.93640031794;12912.483500660244;13127.540536081573;13415.932920335335;13487.650329755483;10184.490775461345;10518.073602727714;10582.153427725918;10824.567017319534;11080.39057851826;10460.424676642553;10785.62250321235;11004.064654504456;11033.44832758375;11044 16:23:37 INFO - PROCESS | 5467 | __end_tp_report 16:23:37 INFO - PROCESS | 5467 | __start_cc_report 16:23:37 INFO - PROCESS | 5467 | _x_x_mozilla_cycle_collect,362 16:23:37 INFO - PROCESS | 5467 | __end_cc_report 16:23:37 INFO - PROCESS | 5467 | __startTimestamp1468020217647__endTimestamp 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | ------- Summary: start ------- 16:23:37 INFO - PROCESS | 5467 | Number of tests: 6 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | [#0] dojo.html Cycles:165 Average:5345.48 Median:5571.00 stddev:601.28 (10.8%) stddev-sans-first:575.40 16:23:37 INFO - PROCESS | 5467 | Values: 3044.9 3081.4 3084.0 3104.0 3117.6 5381.9 5390.8 5391.6 5444.3 5515.4 5205.6 5305.7 5310.8 5350.5 5400.3 4857.4 4881.6 4913.8 5006.8 5055.3 4864.1 5051.2 5059.7 5060.0 5064.6 4826.2 4886.9 4915.2 4917.2 4940.8 4891.9 4903.9 4910.1 4927.8 4981.7 4909.0 4924.0 4926.5 4933.9 4957.8 5146.7 5291.7 5302.2 5360.4 5416.4 5699.3 5711.1 5736.1 5740.3 5743.4 5584.3 5777.8 5789.2 5793.3 5795.2 5325.0 5379.5 5391.5 5395.7 5410.4 5881.2 5901.0 5904.6 5920.4 5933.1 5406.1 5634.2 5674.5 5690.6 5691.9 5722.0 5785.2 5799.2 5811.1 5848.5 5454.9 5616.2 5711.7 5751.1 5767.0 5450.4 5550.9 5753.9 5756.5 5760.8 4321.8 4343.0 4346.6 4347.4 4378.6 3887.5 3914.6 3934.3 3950.2 3971.5 5478.2 5500.0 5509.5 5528.0 5549.1 5509.9 5754.0 5755.8 5778.1 5816.4 5529.9 5568.4 5581.3 5582.2 5585.5 4998.5 5020.9 5027.6 5030.6 5049.7 5667.1 5859.7 5944.8 5965.7 6020.2 5737.9 5747.8 5760.6 5775.5 5781.5 5717.9 5952.0 5974.5 5977.2 5977.6 5596.2 5624.0 5642.6 5647.6 5693.8 5727.3 5727.6 5729.8 5741.6 5757.1 5458.7 5565.3 5598.8 5620.6 5649.3 5434.3 5573.2 5592.2 5642.0 5687.4 5561.7 5575.0 5585.3 5599.9 5607.3 5516.9 5650.8 5692.5 5694.3 5706.4 5571.0 5599.0 5604.7 5607.5 5651.4 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | [#1] ext.html Cycles:180 Average:62763.40 Median:41556.98 stddev:126482.59 (304.4%) stddev-sans-first:126751.18 16:23:37 INFO - PROCESS | 5467 | Values: 561.9 579.0 593.2 607.1 647.5 37712.8 41955.0 42129.8 42177.8 42215.6 41155.2 41617.8 41830.2 41897.4 41919.2 8809.3 8881.3 8990.3 8991.2 9000.3 8835.0 8878.0 8895.4 8920.6 8942.6 8926.1 8950.0 8981.2 8983.8 9026.5 8932.9 8956.4 8967.7 8979.1 8982.2 8795.8 8837.7 8864.6 8866.8 8924.4 39233.4 39435.8 39584.0 39607.6 39728.0 3452.2 3472.1 3485.9 3566.5 3934.4 31957.2 32386.7 32612.8 32659.3 33443.7 4282.6 4339.7 4351.1 4359.3 4409.0 368294.0 370655.0 370836.0 372256.0 372536.0 60386.1 60705.9 60823.0 60991.7 61065.0 35219.3 62996.4 63392.0 63485.0 63770.4 16150.3 17049.5 17112.1 17205.4 17253.9 13147.9 13212.3 13225.6 13269.8 13283.3 19074.2 19077.9 19269.1 19287.6 19353.8 6989.3 7067.8 7181.6 7182.0 7236.5 1030.9 1075.4 1125.6 1159.8 1159.9 32981.9 33662.5 33668.3 33712.0 34117.1 1092.0 1093.2 1098.4 1168.4 1184.9 17095.7 17163.0 17279.5 17464.0 17547.4 576286.0 577087.0 580781.0 584018.0 585798.0 56590.0 56691.1 56717.4 56755.4 56763.0 1363.0 1366.9 1375.3 1381.3 1382.9 30094.2 31958.5 32051.4 32230.4 32234.7 49034.0 49421.5 49459.0 49518.3 49861.0 450146.0 452868.0 453826.0 454523.0 455863.0 27660.7 27890.2 28319.3 28483.0 28534.1 47174.3 48047.8 48103.0 49046.5 49258.0 40044.4 40585.0 40832.0 41496.2 42585.0 40914.6 41057.0 41204.4 41250.6 42481.8 42382.2 44792.6 45695.3 45711.0 47956.3 37022.1 37077.0 37900.2 41039.4 41144.2 34190.0 35535.3 35775.7 35899.1 35937.0 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | [#2] jquery.html Cycles:180 Average:29279.89 Median:20996.16 stddev:81790.90 (389.6%) stddev-sans-first:81991.59 16:23:37 INFO - PROCESS | 5467 | Values: 396.6 405.7 407.0 408.5 423.7 19091.8 19973.8 20952.3 20984.3 21008.1 12736.1 12984.4 17995.4 19882.1 19925.0 5225.8 5229.0 5763.6 5807.1 5827.3 3936.2 5723.5 5744.5 5786.2 6039.8 5989.2 6006.8 6023.6 6039.7 6051.0 5662.8 5973.1 5988.9 5992.8 6060.2 5582.6 5811.5 5830.2 5835.6 5846.0 14208.9 14245.2 14315.4 14384.9 14487.7 2301.5 2301.9 2389.5 2397.7 2927.2 10554.7 10624.8 11037.7 11052.9 11175.5 1963.3 1970.5 1980.3 1987.7 2019.7 82479.0 83274.0 85566.6 86449.0 87006.0 11427.9 11484.4 11519.7 11569.9 11592.1 15932.4 16012.6 16046.7 16058.9 16141.4 8063.0 8430.6 8489.1 8570.1 8695.4 8118.4 8155.0 8182.0 8346.7 8417.6 4876.0 4881.8 4956.7 4960.4 5046.4 1652.9 1772.7 1775.3 1910.7 2000.1 966.1 1063.4 1115.2 1125.4 1136.6 19923.3 20410.5 20465.5 20710.8 20820.6 997.4 1020.3 1029.0 1042.5 1049.5 11067.4 11419.4 11470.9 11484.8 11548.2 469851.0 479116.0 497985.0 513985.0 514399.0 89057.6 93265.0 93484.0 93928.0 94526.5 974.1 1004.4 1028.3 1028.7 1037.5 17539.8 17811.2 18071.4 18237.5 18451.7 43319.4 43349.0 43857.6 44232.8 44806.1 59365.4 59690.7 60660.1 60908.4 60964.0 5344.8 5856.6 8189.6 8220.1 8264.9 10378.2 13931.1 13971.0 14256.6 14367.4 12141.5 12283.1 12412.0 12587.2 12616.0 11616.2 11682.4 11806.3 11939.1 12000.2 12170.3 12175.1 12300.9 12302.8 12812.1 8023.4 8130.7 8164.9 8285.9 8396.8 10568.5 11748.4 11755.0 11982.3 12356.4 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | [#3] mootools.html Cycles:180 Average:5952.57 Median:4419.04 stddev:3401.01 (77.0%) stddev-sans-first:3393.82 16:23:37 INFO - PROCESS | 5467 | Values: 1464.2 1500.8 1618.6 1749.8 1759.5 7625.8 8477.6 8624.4 9277.9 9280.0 8537.1 8735.3 8781.6 8838.6 8859.8 2310.8 2333.3 2343.3 2344.1 2351.5 2358.7 2360.2 2394.6 2399.8 2427.2 2364.5 2385.7 2407.4 2410.7 2423.6 2323.3 2333.6 2339.6 2340.1 2343.2 2323.4 2332.1 2341.9 2350.8 2365.6 8773.9 8817.7 8853.4 8863.2 8872.4 5220.3 5344.3 5352.9 5354.4 5372.5 3343.3 3379.5 3406.0 3416.4 3434.9 1071.3 1088.8 1103.1 1116.7 1132.5 12230.1 12337.3 12352.8 12419.4 12432.9 4489.3 4534.4 4673.0 4677.1 4731.8 10587.8 10615.9 10619.4 10641.7 10691.5 5337.1 5360.5 5363.8 5378.9 5380.2 4263.1 4683.0 4859.7 4860.5 4931.4 3935.4 4041.7 4047.5 4077.2 4158.9 1247.3 1269.2 1270.3 1277.9 1285.8 980.2 992.6 999.6 1009.0 1011.5 5954.7 6037.9 6147.5 6189.9 6212.9 972.4 977.6 1005.6 1083.7 1100.0 4124.6 4268.2 4318.9 4328.5 4348.8 11079.7 11152.6 11363.5 11370.4 11573.8 11127.4 11182.4 11231.2 11356.4 11379.5 8221.9 8494.0 8509.4 8514.1 8515.3 5980.7 6121.3 6159.9 6173.5 6216.4 10342.4 10430.3 10512.0 10690.6 10727.2 10696.5 10736.7 10752.0 10789.5 10799.7 7281.4 8042.6 8123.5 8123.6 8272.0 9001.9 9023.5 9034.2 9086.4 9148.4 7859.5 8157.9 8183.2 8223.1 8308.2 7821.3 7899.6 7956.0 8023.8 8189.5 7111.8 7130.4 7226.2 7302.2 7368.4 4969.3 5059.6 5071.4 5135.6 5188.4 5357.1 5416.8 5434.5 5548.9 5596.6 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | [#4] prototype.html Cycles:180 Average:4945.86 Median:5685.72 stddev:1458.79 (25.7%) stddev-sans-first:1421.25 16:23:37 INFO - PROCESS | 5467 | Values: 335.7 340.3 340.3 341.5 346.6 5501.6 5619.0 5622.8 5657.0 5703.1 5537.2 5550.4 5554.9 5594.6 5602.7 4180.3 4239.0 4339.3 4352.0 4366.7 4357.8 4359.4 4359.8 4365.7 4367.4 4318.0 4337.3 4349.5 4349.9 4359.4 4284.6 4361.2 4367.9 4368.9 4370.9 3847.7 3848.4 3860.4 3886.7 3896.6 5412.6 5445.8 5462.5 5483.5 5501.3 4859.5 4975.0 4992.8 5061.3 5063.3 5743.8 5808.4 5828.7 5887.5 5891.5 4235.0 4235.0 4248.8 4252.3 4287.2 5886.4 5991.5 6033.3 6036.9 6097.8 4334.0 4347.7 4365.9 4371.7 4383.2 4399.8 4405.6 4408.1 4411.3 4434.2 4661.7 4928.3 4932.6 4950.7 5073.1 5873.8 5875.9 5882.4 5883.5 5896.5 1455.0 1455.9 1473.6 1473.9 1481.1 931.0 955.7 976.5 981.6 999.5 5654.4 5677.4 5681.8 5689.6 5714.4 5911.3 5929.8 5986.5 6003.0 6032.0 5426.0 5662.5 5694.6 5717.5 5797.9 3183.1 3212.8 3224.7 3249.5 3250.7 6105.0 6151.5 6202.3 6206.6 6273.3 6122.2 6182.2 6185.6 6199.5 6227.7 6207.2 6230.5 6319.4 6327.6 6329.1 6038.4 6044.3 6056.2 6061.9 6070.3 5930.3 5957.3 5961.4 5974.4 5977.9 6042.3 6198.6 6268.9 6275.0 6286.6 4225.3 4234.3 4248.3 4252.4 4272.3 5926.5 6036.0 6048.8 6056.7 6071.0 5850.4 5853.2 5878.7 5879.7 5901.2 5862.4 5881.7 5894.3 5896.5 5917.9 5200.6 5708.3 5736.8 5749.2 5800.9 5863.2 5878.1 5887.2 5929.9 5953.0 5551.8 5774.0 5786.2 5818.5 5849.0 16:23:37 INFO - PROCESS | 5467 | 16:23:37 INFO - PROCESS | 5467 | [#5] yui.html Cycles:180 Average:21554.92 Median:3890.40 stddev:32083.95 (824.7%) stddev-sans-first:32135.86 16:23:37 INFO - PROCESS | 5467 | Values: 733.9 755.6 767.8 781.6 902.3 14071.1 14448.3 14612.9 14644.6 14672.7 14180.9 14560.7 14584.5 14584.8 14587.5 795.9 796.6 800.7 801.6 803.1 674.3 802.1 819.9 820.5 823.7 860.3 866.0 867.7 871.8 874.6 865.2 866.1 866.7 867.1 867.9 626.0 631.4 631.9 632.1 632.8 14259.3 14274.0 14286.1 14297.2 14312.6 15405.9 15744.8 15762.3 15937.9 15978.8 12823.9 12931.5 13038.9 13328.5 13589.9 3772.8 3861.3 3874.5 3906.3 4030.2 75856.6 75908.0 78837.6 79311.2 81191.0 11811.2 11894.8 11924.4 11947.2 12161.9 22522.0 22849.8 22856.5 22946.4 23113.9 8652.2 8824.2 9222.6 9292.8 9379.9 4556.0 4577.2 4644.3 4671.2 4850.6 3489.3 3575.3 3583.4 3595.7 3600.0 607.7 613.1 624.3 625.0 626.8 660.1 727.5 728.9 741.9 772.2 9811.7 9886.9 10002.2 10112.8 10140.8 695.5 697.7 721.5 733.8 752.3 4576.7 4730.1 4767.5 4819.1 4841.3 121010.0 121848.0 123838.4 125317.0 125924.4 105075.0 105867.0 106676.8 107924.5 108759.0 91870.5 93777.5 94480.5 94609.5 95065.5 9063.5 9072.8 9130.6 9336.8 9352.5 46825.5 51681.0 52248.2 52589.2 52899.7 68864.0 80830.0 80946.6 81321.6 81390.6 11484.8 11767.9 11886.3 12193.6 12587.2 12892.7 12965.0 12973.9 13346.7 13442.9 11905.2 11947.2 12182.8 12319.4 13095.9 12037.2 12331.2 12343.8 12501.0 13166.0 12719.9 12912.5 13127.5 13415.9 13487.7 10184.5 10518.1 10582.2 10824.6 11080.4 10460.4 10785.6 11004.1 11033.4 11044.0 16:23:37 INFO - PROCESS | 5467 | -------- Summary: end -------- 16:23:37 INFO - PROCESS | 5467 | 16:23:38 INFO - TEST-INFO | 5467: exit 0 16:23:38 INFO - TEST-OK | dromaeo_css | took 1111461ms 16:23:38 INFO - TEST-START | kraken 16:23:38 INFO - operating with platform_type : linux_ 16:23:38 INFO - Initialising browser for kraken test... 16:23:38 INFO - TEST-INFO | started process 5708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHZuTm/profile http://localhost:35527/getInfo.html) 16:23:42 INFO - PROCESS | 5708 | __metrics Screen width/height:1600/1200 16:23:42 INFO - PROCESS | 5708 | colorDepth:24 16:23:42 INFO - PROCESS | 5708 | Browser inner width/height: 1024/697 16:23:42 INFO - PROCESS | 5708 | __metrics 16:23:43 ERROR - PROCESS | 5708 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 16:23:44 INFO - TEST-INFO | 5708: exit 0 16:23:44 INFO - Browser initialized. 16:23:44 INFO - Running cycle 1/1 for kraken test... 16:23:44 INFO - TEST-INFO | started process 5828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHZuTm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:56 INFO - PROCESS | 5828 | RSS: Main: 167153664 16:23:56 INFO - PROCESS | 5828 | 16:23:58 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35527/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:59 INFO - PROCESS | 5828 | RSS: Main: 173207552 16:23:59 INFO - PROCESS | 5828 | 16:24:02 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35527/tests/kraken/driver.html?testName=audio-dft) 16:24:02 INFO - PROCESS | 5828 | RSS: Main: 172261376 16:24:02 INFO - PROCESS | 5828 | 16:24:05 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35527/tests/kraken/driver.html?testName=audio-fft) 16:24:06 INFO - PROCESS | 5828 | RSS: Main: 167227392 16:24:06 INFO - PROCESS | 5828 | 16:24:08 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35527/tests/kraken/driver.html?testName=audio-oscillator) 16:24:09 INFO - PROCESS | 5828 | RSS: Main: 167964672 16:24:09 INFO - PROCESS | 5828 | 16:24:11 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:24:11 INFO - PROCESS | 5828 | RSS: Main: 168394752 16:24:11 INFO - PROCESS | 5828 | 16:24:14 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35527/tests/kraken/driver.html?testName=imaging-darkroom) 16:24:15 INFO - PROCESS | 5828 | RSS: Main: 168185856 16:24:15 INFO - PROCESS | 5828 | 16:24:19 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35527/tests/kraken/driver.html?testName=imaging-desaturate) 16:24:19 INFO - PROCESS | 5828 | RSS: Main: 165924864 16:24:19 INFO - PROCESS | 5828 | 16:24:22 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35527/tests/kraken/driver.html?testName=json-parse-financial) 16:24:23 INFO - PROCESS | 5828 | RSS: Main: 167755776 16:24:23 INFO - PROCESS | 5828 | 16:24:24 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:24:25 INFO - PROCESS | 5828 | RSS: Main: 168022016 16:24:25 INFO - PROCESS | 5828 | 16:24:27 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:24:27 INFO - PROCESS | 5828 | RSS: Main: 168546304 16:24:27 INFO - PROCESS | 5828 | 16:24:29 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:24:30 INFO - PROCESS | 5828 | RSS: Main: 168595456 16:24:30 INFO - PROCESS | 5828 | 16:24:33 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:24:33 INFO - PROCESS | 5828 | RSS: Main: 168947712 16:24:33 INFO - PROCESS | 5828 | 16:24:36 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:24:37 INFO - PROCESS | 5828 | RSS: Main: 168628224 16:24:37 INFO - PROCESS | 5828 | 16:24:38 INFO - PROCESS | 5828 | Cycle 1(1): loaded http://localhost:35527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35527/tests/kraken/driver.html?testName=ai-astar) 16:24:39 INFO - PROCESS | 5828 | RSS: Main: 169828352 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | __start_tp_report 16:24:39 INFO - PROCESS | 5828 | _x_x_mozilla_page_load 16:24:39 INFO - PROCESS | 5828 | _x_x_mozilla_page_load_details 16:24:39 INFO - PROCESS | 5828 | |i|pagename|runs| 16:24:39 INFO - PROCESS | 5828 | |0;ai-astar;103;112;107;111;113;112;113;113;113;113 16:24:39 INFO - PROCESS | 5828 | |1;audio-beat-detection;150;116;145;171;119;152;150;120;170;121 16:24:39 INFO - PROCESS | 5828 | |2;audio-dft;163;163;163;162;162;165;179;165;163;163 16:24:39 INFO - PROCESS | 5828 | |3;audio-fft;75;74;76;151;76;79;75;76;182;75 16:24:39 INFO - PROCESS | 5828 | |4;audio-oscillator;85;84;155;83;84;83;153;84;84;139 16:24:39 INFO - PROCESS | 5828 | |5;imaging-gaussian-blur;117;117;117;118;120;117;118;118;118;117 16:24:39 INFO - PROCESS | 5828 | |6;imaging-darkroom;149;150;149;150;154;150;149;150;150;147 16:24:39 INFO - PROCESS | 5828 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 16:24:39 INFO - PROCESS | 5828 | |8;json-parse-financial;55;56;59;54;56;55;55;54;56;62 16:24:39 INFO - PROCESS | 5828 | |9;json-stringify-tinderbox;61;61;61;60;61;60;60;64;65;62 16:24:39 INFO - PROCESS | 5828 | |10;stanford-crypto-aes;76;76;76;84;77;84;81;74;80;76 16:24:39 INFO - PROCESS | 5828 | |11;stanford-crypto-ccm;132;135;126;131;125;132;144;128;199;130 16:24:39 INFO - PROCESS | 5828 | |12;stanford-crypto-pbkdf2;159;171;159;158;163;157;164;160;159;158 16:24:39 INFO - PROCESS | 5828 | |13;stanford-crypto-sha256-iterative;64;67;66;68;65;67;64;70;64;64 16:24:39 INFO - PROCESS | 5828 | __end_tp_report 16:24:39 INFO - PROCESS | 5828 | __start_cc_report 16:24:39 INFO - PROCESS | 5828 | _x_x_mozilla_cycle_collect,908 16:24:39 INFO - PROCESS | 5828 | __end_cc_report 16:24:39 INFO - PROCESS | 5828 | __startTimestamp1468020279244__endTimestamp 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | ------- Summary: start ------- 16:24:39 INFO - PROCESS | 5828 | Number of tests: 14 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.37 (3.0%) stddev-sans-first:1.96 16:24:39 INFO - PROCESS | 5828 | Values: 103.0 112.0 107.0 111.0 113.0 112.0 113.0 113.0 113.0 113.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:150.00 stddev:21.05 (14.0%) stddev-sans-first:22.10 16:24:39 INFO - PROCESS | 5828 | Values: 150.0 116.0 145.0 171.0 119.0 152.0 150.0 120.0 170.0 121.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.00 stddev:5.09 (3.1%) stddev-sans-first:5.36 16:24:39 INFO - PROCESS | 5828 | Values: 163.0 163.0 163.0 162.0 162.0 165.0 179.0 165.0 163.0 163.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:38.98 (51.6%) stddev-sans-first:40.74 16:24:39 INFO - PROCESS | 5828 | Values: 75.0 74.0 76.0 151.0 76.0 79.0 75.0 76.0 182.0 75.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.00 stddev:31.74 (37.8%) stddev-sans-first:32.96 16:24:39 INFO - PROCESS | 5828 | Values: 85.0 84.0 155.0 83.0 84.0 83.0 153.0 84.0 84.0 139.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 16:24:39 INFO - PROCESS | 5828 | Values: 117.0 117.0 117.0 118.0 120.0 117.0 118.0 118.0 118.0 117.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:1.75 (1.2%) stddev-sans-first:1.83 16:24:39 INFO - PROCESS | 5828 | Values: 149.0 150.0 149.0 150.0 154.0 150.0 149.0 150.0 150.0 147.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:24:39 INFO - PROCESS | 5828 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.49 (4.4%) stddev-sans-first:2.60 16:24:39 INFO - PROCESS | 5828 | Values: 55.0 56.0 59.0 54.0 56.0 55.0 55.0 54.0 56.0 62.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:1.72 (2.8%) stddev-sans-first:1.81 16:24:39 INFO - PROCESS | 5828 | Values: 61.0 61.0 61.0 60.0 61.0 60.0 60.0 64.0 65.0 62.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:3.60 (4.6%) stddev-sans-first:3.71 16:24:39 INFO - PROCESS | 5828 | Values: 76.0 76.0 76.0 84.0 77.0 84.0 81.0 74.0 80.0 76.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:132.00 stddev:22.02 (16.7%) stddev-sans-first:23.24 16:24:39 INFO - PROCESS | 5828 | Values: 132.0 135.0 126.0 131.0 125.0 132.0 144.0 128.0 199.0 130.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:159.50 stddev:4.21 (2.6%) stddev-sans-first:4.42 16:24:39 INFO - PROCESS | 5828 | Values: 159.0 171.0 159.0 158.0 163.0 157.0 164.0 160.0 159.0 158.0 16:24:39 INFO - PROCESS | 5828 | 16:24:39 INFO - PROCESS | 5828 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:2.08 (3.1%) stddev-sans-first:2.09 16:24:39 INFO - PROCESS | 5828 | Values: 64.0 67.0 66.0 68.0 65.0 67.0 64.0 70.0 64.0 64.0 16:24:39 INFO - PROCESS | 5828 | -------- Summary: end -------- 16:24:39 INFO - PROCESS | 5828 | 16:24:40 INFO - TEST-INFO | 5828: exit 0 16:24:40 INFO - TEST-OK | kraken | took 61872ms 16:24:40 INFO - SUITE-END | took 1173s 16:24:40 INFO - Completed test suite (00:19:33) 16:24:40 INFO - javascript benchmark 16:24:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7385.928717325009, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3044.862981165848, 3081.4453398388296, 3083.984580077099, 3104.0, 3117.6258848938132, 5381.91927121093, 5390.81132160374, 5391.649542779716, 5444.265024221729, 5515.448455154483, 5205.60957928155, 5305.708186049766, 5310.787568497265, 5350.491703288191, 5400.270963419937, 4857.3685420895235, 4881.633877459187, 4913.778879950393, 5006.799728010893, 5055.342805435288, 4864.0515099555605, 5051.217061355495, 5059.671121377117, 5060.0385926674, 5064.56951159152, 4826.227803551415, 4886.902261954741, 4915.188993816052, 4917.164082106051, 4940.752962351886, 4891.877703057452, 4903.8774030649165, 4910.091633047898, 4927.798551993014, 4981.72600506972, 4908.950910490885, 4923.990581930731, 4926.507349265081, 4933.851984440473, 4957.7769000395065, 5146.742662866842, 5291.708956007418, 5302.2046692996355, 5360.410354860962, 5416.4312747161375, 5699.316082070137, 5711.086226203787, 5736.053551164053, 5740.311162660466, 5743.368229494752, 5584.301962254718, 5777.826665200051, 5789.247397838296, 5793.333766616851, 5795.1886735857015, 5325.0, 5379.5427388671615, 5391.487808658171, 5395.70323632204, 5410.431904649994, 5881.206037184926, 5901.0, 5904.61619994699, 5920.407959204045, 5933.110033494924, 5406.107992181246, 5634.154876768435, 5674.4892959633835, 5690.573207009408, 5691.857703557362, 5722.0, 5785.218995435563, 5799.246098007232, 5811.099279611667, 5848.502877255396, 5454.863628409242, 5616.185653080281, 5711.7144142792695, 5751.1085781703905, 5767.048437007847, 5450.373207081237, 5550.861228469321, 5753.913691294634, 5756.453136951983, 5760.798372056958, 4321.783910804447, 4342.978285108554, 4346.630536404441, 4347.391365208873, 4378.60592546666, 3887.494625698641, 3914.628110329514, 3934.272159650474, 3950.229705207457, 3971.4837071180564, 5478.150886612581, 5499.972500137554, 5509.5041446270025, 5528.0, 5549.056660367747, 5509.917351239735, 5754.0, 5755.769769209185, 5778.104393818965, 5816.447437493432, 5529.861753456195, 5568.415316391802, 5581.330240371181, 5582.162675598612, 5585.525230355384, 4998.525140111684, 5020.899582008339, 5027.572656324253, 5030.647854650139, 5049.671771334852, 5667.121596152603, 5859.736311865891, 5944.762209511571, 5965.731542080617, 6020.157177995085, 5737.8565535861935, 5747.770089196385, 5760.6255593386295, 5775.451332123442, 5781.479666830005, 5717.8570535736935, 5951.970240148771, 5974.462298393166, 5977.193078934288, 5977.6114552553945, 5596.1605759136455, 5623.971880140573, 5642.633228840113, 5647.632903861236, 5693.772249109989, 5727.255456790591, 5727.599068065196, 5729.828105156852, 5741.598088133791, 5757.107648314518, 5458.6724796512335, 5565.30433695788, 5598.832035038955, 5620.634658747168, 5649.293838270216, 5434.3207099112615, 5573.16402539606, 5592.217089607377, 5642.0, 5687.431256874445, 5561.694106824163, 5575.0, 5585.273914391103, 5599.8880022400135, 5607.299087614048, 5516.91724624139, 5650.830475085754, 5692.548400158099, 5694.259746232963, 5706.400827913176, 5571.0, 5598.972005139948, 5604.747786349542, 5607.523360514402, 5651.350094739158], "value": 5304.964693670964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8818213852994, 579.0301245413932, 593.187333353306, 607.1045208317732, 647.4658406814374, 37712.811435942815, 41955.0, 42129.78935105324, 42177.7891110544, 42215.577844221545, 41155.17689646205, 41617.79191104048, 41830.163396732045, 41897.37153942693, 41919.16161676765, 8809.339299552543, 8881.289496840269, 8990.325725570576, 8991.190792828644, 9000.279977601776, 8835.0, 8877.95561022194, 8895.377323587352, 8920.598573064195, 8942.55287235639, 8926.062763409846, 8950.0, 8981.191692747652, 8983.775405614846, 9026.45841249527, 8932.910670893305, 8956.417832840845, 8967.686130985418, 8979.057198994076, 8982.236509896667, 8795.78010549735, 8837.734867953908, 8864.601092950832, 8866.822663546758, 8924.375293729441, 39233.41149882754, 39435.802820986, 39584.0, 39607.603923960676, 39728.0, 3452.171478845084, 3472.080713699953, 3485.860565577374, 3566.5185199997927, 3934.350832112698, 31957.201069973205, 32386.6761332386, 32612.836935815405, 32659.346813063843, 33443.66556334454, 4282.571742825724, 4339.732863352372, 4351.108022855307, 4359.346098085281, 4408.977955110236, 368294.0, 370655.0, 370836.0, 372255.99999999726, 372536.0, 60386.0942085869, 60705.929407059826, 60823.0, 60991.69504152451, 61065.0, 35219.295614087576, 62996.370036299966, 63392.0, 63485.0, 63770.36229637644, 16150.273237704332, 17049.48851534456, 17112.144392780312, 17205.397811076553, 17253.913730431268, 13147.868521314664, 13212.273324967027, 13225.603231903058, 13269.800952985714, 13283.26942018179, 19074.2370305189, 19077.90461047686, 19269.132889019747, 19287.614247715246, 19353.8064619352, 6989.30106989297, 7067.787966361017, 7181.640917954186, 7182.0, 7236.457265705093, 1030.9484525773682, 1075.3547871277171, 1125.5666568371237, 1159.8144296912453, 1159.8550181227347, 32981.86672266131, 33662.47531435152, 33668.32663346719, 33712.0, 34117.14707132292, 1091.9890801092047, 1093.2456604942565, 1098.3958822647512, 1168.4479183282895, 1184.8933595976403, 17095.743563846554, 17163.014855666668, 17279.481615551555, 17464.0, 17547.385841495485, 576286.0, 577087.0, 580781.0, 584018.0, 585798.0, 56590.0, 56691.14963275554, 56717.43282567204, 56755.43244567584, 56763.0, 1363.0458678924792, 1366.9316534173252, 1375.326090215787, 1381.295539274977, 1382.8962827787957, 30094.247643808205, 31958.52062219022, 32051.35897282088, 32230.355392891543, 32234.677653223167, 49034.0, 49421.50578494169, 49459.0, 49518.257226140915, 49861.0, 450146.0, 452868.0, 453826.0, 454523.0, 455863.0, 27660.723392765816, 27890.163295101178, 28319.29201769972, 28483.0, 28534.143975680763, 47174.29238561356, 48047.75976120097, 48103.0, 49046.509534904195, 49258.0, 40044.399334010595, 40585.0, 40832.0, 41496.1700765989, 42585.0, 40914.59085409227, 41057.0, 41204.38193427041, 41250.58749412467, 42481.787591061846, 42382.1523569533, 44792.55207447884, 45695.31457028081, 45711.0, 47956.280655789495, 37022.07444813794, 37077.0, 37900.2419951605, 41039.38440923329, 41144.1771164581, 34190.0, 35535.28929421346, 35775.67458115214, 35899.10252243715, 35937.0], "value": 20472.062809235016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.64698418407625, 405.6916743275112, 406.9776162311073, 408.5281499867654, 423.7097588152116, 19091.809081909178, 19973.800261997374, 20952.26667066653, 20984.265550705728, 21008.05463754131, 12736.108472406935, 12984.415701293441, 17995.37016204433, 19882.105305261262, 19925.0, 5225.764840582174, 5228.973855130738, 5763.596548241625, 5807.128930660414, 5827.271591051119, 3936.1734035852505, 5723.51350135239, 5744.540436765049, 5786.218860453827, 6039.818805435844, 5989.161517387569, 6006.849828754294, 6023.6385816851125, 6039.728212230439, 6051.0, 5662.801801936933, 5973.133895585138, 5988.8502787430225, 5992.820215393545, 6060.212172417601, 5582.637128586629, 5811.535077193815, 5830.212921255618, 5835.649861008353, 5845.970770146122, 14208.85791142096, 14245.216513091777, 14315.355808988621, 14384.928075359661, 14487.710245795026, 2301.5396920615776, 2301.873396963166, 2389.5340408620327, 2397.6763136976633, 2927.238917881345, 10554.683359499228, 10624.840627390595, 11037.724056898562, 11052.944735276273, 11175.49710263032, 1963.3128405058258, 1970.4778233768063, 1980.2574034736974, 1987.7018447232886, 2019.7475315585552, 82479.0, 83273.99999999939, 85566.57216713938, 86448.99999999937, 87006.0, 11427.942860285646, 11484.368359740127, 11519.712007199887, 11569.88430115705, 11592.130590205768, 15932.362705491882, 16012.599685007968, 16046.679066418606, 16058.919705401398, 16141.35434582627, 8062.959685201537, 8430.620622072021, 8489.108643592457, 8570.100139485388, 8695.391322607356, 8118.35053195743, 8155.0, 8181.95909020463, 8346.749597512084, 8417.621207045697, 4875.95124048762, 4881.780319885614, 4956.727379994063, 4960.429550601727, 5046.419661738947, 1652.8512433881008, 1772.6631939931372, 1775.325376357002, 1910.6656335141572, 2000.109951071759, 966.1160038564775, 1063.4204358624568, 1115.1691989467736, 1125.4429057616533, 1136.5510623303749, 19923.302684405975, 20410.489737756674, 20465.48836279105, 20710.792892070887, 20820.583588328147, 997.4464172384396, 1020.336781092296, 1028.9897101029044, 1042.4579218806177, 1049.5277125293649, 11067.391293478937, 11419.371934543513, 11470.942645286887, 11484.770304593862, 11548.191626586226, 469851.0, 479116.0, 497985.0, 513985.0, 514399.0, 89057.55471222602, 93265.0, 93484.0, 93928.0, 94526.52736736409, 974.1427543761445, 1004.4023805835516, 1028.2647906746563, 1028.6913925822223, 1037.4605205293205, 17539.82460175382, 17811.198496067966, 18071.367502137364, 18237.45287641373, 18451.72322415138, 43319.35020974625, 43349.0, 43857.56142438535, 44232.7788361069, 44806.10387792291, 59365.406345937714, 59690.70154649199, 60660.09009864944, 60908.390916092045, 60964.0, 5344.812931547377, 5856.560757943086, 8189.631466584137, 8220.136885626924, 8264.917350826656, 10378.221633377376, 13931.094478858842, 13971.0, 14256.572302830931, 14367.353469093707, 12141.514339426323, 12283.140180187302, 12412.0, 12587.181833180814, 12616.0, 11616.244944078608, 11682.415879206175, 11806.291622502677, 11939.104567157672, 12000.15998880105, 12170.330631815335, 12175.147739658492, 12300.938495307466, 12302.81545776832, 12812.10315277959, 8023.398245131521, 8130.674773009014, 8164.877526837221, 8285.875711864206, 8396.790080247798, 10568.524416401127, 11748.412579371168, 11755.0, 11982.281063136239, 12356.443960021641], "value": 9262.124337693102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.238595930116, 1500.8424115467876, 1618.6196243882694, 1749.8075211726716, 1759.4985429152694, 7625.771226863189, 8477.618507167177, 8624.43941143826, 9277.90722092779, 9280.0, 8537.060923298432, 8735.301175905928, 8781.560921953893, 8838.558072096386, 8859.778505537348, 2310.792028717415, 2333.2533589251448, 2343.3087239264373, 2344.10923848938, 2351.5179388225456, 2358.6697862299293, 2360.197532838843, 2394.6288325309606, 2399.808015358767, 2427.2232885476656, 2364.527094581082, 2385.7137143542714, 2407.38611654028, 2410.7227668818045, 2423.624338227569, 2323.337848713117, 2333.626619740833, 2339.63735620979, 2340.0756701103137, 2343.168175297762, 2323.3959170615594, 2332.1137967572213, 2341.941451463727, 2350.8119350452093, 2365.5978483657645, 8773.868391974125, 8817.691380801705, 8853.380263381567, 8863.202311791969, 8872.423292485968, 5220.321358223407, 5344.251804747339, 5352.892942141136, 5354.437784032699, 5372.462753724635, 3343.3146205028156, 3379.509971054208, 3405.9829700851583, 3416.4021296273054, 3434.8797792077407, 1071.266182664877, 1088.7822435512928, 1103.0568863621647, 1116.7487315354063, 1132.5186795611914, 12230.082743794252, 12337.321447320393, 12352.814707779391, 12419.44112514939, 12432.875671243262, 4489.259272220047, 4534.410526631516, 4673.0, 4677.111348843777, 4731.810727570927, 10587.788244235226, 10615.89384106149, 10619.415932123808, 10641.733956651145, 10691.518881650345, 5337.066013447631, 5360.490753378423, 5363.785448582091, 5378.91931621026, 5380.24676545284, 4263.062126332202, 4682.9531704683195, 4859.684120532154, 4860.4896485869185, 4931.3589233399425, 3935.4293627423863, 4041.656459200942, 4047.4738284022887, 4077.225327187825, 4158.896027599274, 1247.2765795838573, 1269.156011252525, 1270.2949862826035, 1277.8977681785434, 1285.755706415778, 980.2207245240052, 992.5632721602472, 999.6201443451442, 1009.0414106598761, 1011.4993078426226, 5954.702264886739, 6037.909431358533, 6147.538934579924, 6189.907151392733, 6212.9068063979075, 972.397113789455, 977.6480467031863, 1005.6379703306803, 1083.653230966099, 1100.0429626225234, 4124.649404800565, 4268.189044081614, 4318.870433886988, 4328.523862375137, 4348.826046958086, 11079.667609971713, 11152.609658661908, 11363.488643011084, 11370.374629395463, 11573.826392604118, 11127.387993660426, 11182.440877956069, 11231.157663175294, 11356.37539935295, 11379.544818207345, 8221.876671849926, 8494.0, 8509.446885952393, 8514.106018868053, 8515.31877449815, 5980.700964951822, 6121.296050954019, 6159.907601385893, 6173.536984726074, 6216.409441103088, 10342.431166285927, 10430.286461428765, 10512.0013598708, 10690.57237710514, 10727.249092563447, 10696.518656660624, 10736.677899663022, 10751.978562036595, 10789.460526973462, 10799.730006749895, 7281.417486601165, 8042.638081286474, 8123.47197432165, 8123.634436450256, 8272.04871439768, 9001.90998090037, 9023.548822558978, 9034.186923176683, 9086.36395452312, 9148.359614826899, 7859.54598399298, 8157.918420815953, 8183.222593853575, 8223.05434874997, 8308.169183081643, 7821.296083352526, 7899.605019749105, 7956.045274567089, 8023.83952320962, 8189.50862948225, 7111.751088712077, 7130.358267755927, 7226.205117437183, 7302.233265507045, 7368.3736882363455, 4969.254611808257, 5059.569936555434, 5071.39143302806, 5135.563477104488, 5188.429272779916, 5357.116075847597, 5416.8104116355735, 5434.510894019557, 5548.889022219452, 5596.636218645775], "value": 4754.4282514264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.6643356643357, 340.2752137946174, 340.33124909552754, 341.46390167437124, 346.63256947635506, 5501.614886957909, 5619.0, 5622.803201887935, 5657.0, 5703.0589952657765, 5537.197106419567, 5550.417206193352, 5554.888902221964, 5594.5733837871385, 5602.663840169593, 4180.331147016478, 4239.0, 4339.2879450343535, 4352.041581288417, 4366.694331396788, 4357.760323182224, 4359.433273674418, 4359.825606975717, 4365.716228445157, 4367.410399596061, 4317.956820431787, 4337.327714204288, 4349.543297953716, 4349.869503914888, 4359.411479450266, 4284.550122237167, 4361.193179261847, 4367.912641747179, 4368.912621747547, 4370.868873933755, 3847.6729477994404, 3848.4419759134767, 3860.36304009838, 3886.689064874803, 3896.5518965319066, 5412.621116521845, 5445.754941027663, 5462.525118218059, 5483.451654834525, 5501.339839219279, 4859.465458799529, 4975.029869175512, 4992.750362481897, 5061.266116413136, 5063.341765570489, 5743.770249190027, 5808.4191580842, 5828.6502809831545, 5887.499562537189, 5891.528677705774, 4234.957650423487, 4234.957650423487, 4248.766317852517, 4252.277112890816, 4287.228298906196, 5886.381929897342, 5991.5206783457215, 6033.33633300341, 6036.9396306036815, 6097.847553811146, 4334.024844410045, 4347.673924455678, 4365.934510982338, 4371.737695738266, 4383.211022016004, 4399.758013309235, 4405.647548196137, 4408.140412619508, 4411.338299255073, 4434.224010798098, 4661.650376221797, 4928.310036594879, 4932.55606995365, 4950.678205916676, 5073.1122053640465, 5873.794417195463, 5875.882482350329, 5882.382344855199, 5883.499902508334, 5896.469317761336, 1454.9597038117797, 1455.8544145585568, 1473.6463248820205, 1473.8820894328428, 1481.140938255809, 930.9720708378624, 955.7180631713661, 976.4580657735025, 981.568110031598, 999.5052449037773, 5654.4062873398525, 5677.37548869624, 5681.801136960269, 5689.630174038757, 5714.428557144252, 5911.261092363455, 5929.822105336847, 5986.5210783137245, 6003.0, 6032.0, 5426.0, 5662.499437649027, 5694.572907031989, 5717.542596592262, 5797.91303130445, 3183.108729555728, 3212.7952017993252, 3224.661410551905, 3249.545063691085, 3250.658680838525, 6105.039056057808, 6151.538634602333, 6202.34875338083, 6206.627602343874, 6273.341299163522, 6122.234720659918, 6182.165407669997, 6185.597936134137, 6199.535034872402, 6227.719752611143, 6207.18258271169, 6230.532710046674, 6319.368063193644, 6327.557071004985, 6329.145565348711, 6038.365971573097, 6044.274687037408, 6056.212692350143, 6061.909071364022, 6070.271567411939, 5930.28836539618, 5957.344692083954, 5961.4038596140035, 5974.4324289192455, 5977.880442391215, 6042.305134909541, 6198.6280823150755, 6268.905966410599, 6274.968625156845, 6286.622802631857, 4225.260579398654, 4234.259004674108, 4248.277792775298, 4252.362145678173, 4272.33778764292, 5926.4666180044005, 6035.969820151046, 6048.758049677964, 6056.666883321283, 6071.0, 5850.36189866838, 5853.209816674695, 5878.676672783038, 5879.676617786063, 5901.2033375495475, 5862.3844496328975, 5881.676507792113, 5894.261192948176, 5896.469317761422, 5917.85205369852, 5200.60995425337, 5708.343540492897, 5736.827895163152, 5749.223854779719, 5800.941990580209, 5863.1791549184, 5878.118282257525, 5887.234659494409, 5929.851753706192, 5953.0, 5551.805686800943, 5773.960687076198, 5786.1899334094105, 5818.458108601139, 5848.970755146197], "value": 4474.071499773145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.9412846972243, 755.6335177438941, 767.8349154931689, 781.5545139270617, 902.2781774580334, 14071.085379450342, 14448.277586120677, 14612.926935365309, 14644.633884152889, 14672.706545869076, 14180.858191418083, 14560.708785824278, 14584.489542866002, 14584.781228281585, 14587.489437869677, 795.8806179073157, 796.6454927557254, 800.7317548621219, 801.5911884938665, 803.1326167738857, 674.3324109131974, 802.1016461563057, 819.901611806584, 820.4666966471782, 823.7487566292278, 860.2730692564772, 866.0, 867.7310033889482, 871.7646235516406, 874.5539774714878, 865.2040123086775, 866.1208872993916, 866.6923242249005, 867.0592407238154, 867.9435836670597, 625.996870015647, 631.4190944331226, 631.908373285871, 632.0708558419117, 632.822809613309, 14259.287035648176, 14274.0, 14286.071405358618, 14297.213653249068, 14312.57062288133, 15405.922970385076, 15744.842551574568, 15762.290696918666, 15937.92031039849, 15978.76031859523, 12823.87176128236, 12931.5473958411, 13038.934805326007, 13328.533501327407, 13589.932050339783, 3772.830222639988, 3861.343571592808, 3874.5156855393075, 3906.277338692351, 4030.2141082488924, 75856.62071689662, 75908.04757945232, 78837.60581197115, 79311.20688793097, 81191.0, 11811.173217874839, 11894.762104757856, 11924.403779810975, 11947.223430476992, 12161.878381216075, 22522.0, 22849.771502285097, 22856.542869142522, 22946.42633934165, 23113.884430578077, 8652.221300083023, 8824.205821476098, 9222.584983675752, 9292.7676808079, 9379.906200937903, 4556.020455602062, 4577.198990176706, 4644.303354496785, 4671.18254305502, 4850.587700045536, 3489.3370259650587, 3575.3385623659706, 3583.3549961006747, 3595.7123430125525, 3599.9820000900354, 607.6991889014965, 613.0926229180837, 624.3132554190354, 624.9906251406233, 626.7743612299569, 660.072597999811, 727.516201725857, 728.8906664000336, 741.9480636355403, 772.2316295286226, 9811.705648830546, 9886.901130988743, 10002.199824014062, 10112.797744045078, 10140.847887281696, 695.5339922252103, 697.7069630755095, 721.4841388407314, 733.812877716179, 752.2966026764992, 4576.748278844696, 4730.124926888537, 4767.4994125617, 4819.108464933998, 4841.3222148899185, 121010.0, 121848.0, 123838.38080809539, 125317.0, 125924.37037814935, 105075.0, 105867.0, 106676.79969600924, 107924.46037769761, 108759.0, 91870.54064729768, 93777.531112344, 94480.52759736158, 94609.5269523648, 95065.5246723762, 9063.501507417155, 9072.773180670536, 9130.634774608941, 9336.813263734823, 9352.485613291334, 46825.531744682114, 51680.96638067142, 52248.21627675512, 52589.211161833366, 52899.73550132225, 68864.0, 80830.0, 80946.5952670233, 81321.59339203266, 81390.59304703439, 11484.770304593694, 11767.88232117668, 11886.28682279066, 12193.634190974284, 12587.181833181181, 12892.731872090648, 12965.0, 12973.935130324287, 13346.733065338445, 13442.865571344162, 11905.166638335233, 11947.223430476992, 12182.817257741319, 12319.44562494672, 13095.934520327337, 12037.157398981988, 12331.198472099284, 12343.814842777187, 12501.0, 13166.0, 12719.93640031794, 12912.483500660244, 13127.540536081573, 13415.932920335335, 13487.650329755483, 10184.490775461345, 10518.073602727714, 10582.153427725918, 10824.567017319534, 11080.39057851826, 10460.424676642553, 10785.62250321235, 11004.064654504456, 11033.44832758375, 11044.0], "value": 7586.333410269785, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 107.0, 111.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 145.0, 171.0, 119.0, 152.0, 150.0, 120.0, 170.0, 121.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 162.0, 165.0, 179.0, 165.0, 163.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 151.0, 76.0, 79.0, 75.0, 76.0, 182.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 155.0, 83.0, 84.0, 83.0, 153.0, 84.0, 84.0, 139.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 120.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 154.0, 150.0, 149.0, 150.0, 150.0, 147.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 59.0, 54.0, 56.0, 55.0, 55.0, 54.0, 56.0, 62.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 64.0, 65.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 84.0, 77.0, 84.0, 81.0, 74.0, 80.0, 76.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 126.0, 131.0, 125.0, 132.0, 144.0, 128.0, 199.0, 130.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 171.0, 159.0, 158.0, 163.0, 157.0, 164.0, 160.0, 159.0, 158.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 68.0, 65.0, 67.0, 64.0, 70.0, 64.0, 64.0], "value": 65.9, "unit": "score"}]}]} 16:24:40 INFO - Return code: 0 16:24:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:24:40 ERROR - # TBPL SUCCESS # 16:24:40 INFO - Running post-action listener: _resource_record_post_action 16:24:40 INFO - ##### 16:24:40 INFO - ##### Finished run-tests step (success) 16:24:40 INFO - ##### 16:24:40 INFO - Running post-run listener: _resource_record_post_run 16:24:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 554119168; Read time: 0; Write time: 472804 16:24:40 INFO - TinderboxPrint: CPU usage
13.3% 16:24:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:24:40 INFO - TinderboxPrint: I/O write bytes / time
554,119,168 / 472,804 16:24:40 INFO - TinderboxPrint: CPU idle
8,235.7 (86.7%) 16:24:40 INFO - TinderboxPrint: CPU user
1,211.6 (12.7%) 16:24:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:24:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256540672; Read time: 0; Write time: 291372 16:24:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297578496; Read time: 0; Write time: 181432 16:24:41 INFO - Running post-run listener: _upload_blobber_files 16:24:41 INFO - Blob upload gear active. 16:24:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:24:41 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:24:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:24:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:24:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:24:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:24:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:24:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:42 INFO - (blobuploader) - INFO - Done attempting. 16:24:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:24:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:24:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:43 INFO - (blobuploader) - INFO - Done attempting. 16:24:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:24:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:24:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:46 INFO - (blobuploader) - INFO - Done attempting. 16:24:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:24:46 INFO - Return code: 0 16:24:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:24:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:24:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0f8be8b04b23ef42293213da0cc097602ab80ec40f66f82f44a7574c4dac2e79cb7906e17f7404454c91dbf479dbd02138be3949408d79d419c546a9853d96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f52244967eea6d09030249865dac4fb8f6fe5f332be598436efaa7cf3dd93e01b81f8790c32d59bea0126acc93e1ddaa00a553d0f3e8b1f33a0456fb91e00d80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02c148c18b7b9fa3e0ca832707be2f689ac0f49778fea56b9c3ab0e24a499e20ece1d3d7faf1c04996ccfceeb093df4bea197fb6f1ee65e357909ee6d4a6ed4b"} 16:24:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:24:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:24:46 INFO - Contents: 16:24:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0f8be8b04b23ef42293213da0cc097602ab80ec40f66f82f44a7574c4dac2e79cb7906e17f7404454c91dbf479dbd02138be3949408d79d419c546a9853d96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f52244967eea6d09030249865dac4fb8f6fe5f332be598436efaa7cf3dd93e01b81f8790c32d59bea0126acc93e1ddaa00a553d0f3e8b1f33a0456fb91e00d80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02c148c18b7b9fa3e0ca832707be2f689ac0f49778fea56b9c3ab0e24a499e20ece1d3d7faf1c04996ccfceeb093df4bea197fb6f1ee65e357909ee6d4a6ed4b"} 16:24:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:24:46 INFO - Copying logs to upload dir... 16:24:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:24:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.337944 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-08 16:24:45.858094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 16:24:45.861880) ========= 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=db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0f8be8b04b23ef42293213da0cc097602ab80ec40f66f82f44a7574c4dac2e79cb7906e17f7404454c91dbf479dbd02138be3949408d79d419c546a9853d96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f52244967eea6d09030249865dac4fb8f6fe5f332be598436efaa7cf3dd93e01b81f8790c32d59bea0126acc93e1ddaa00a553d0f3e8b1f33a0456fb91e00d80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02c148c18b7b9fa3e0ca832707be2f689ac0f49778fea56b9c3ab0e24a499e20ece1d3d7faf1c04996ccfceeb093df4bea197fb6f1ee65e357909ee6d4a6ed4b"} build_url:https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/HnubN04USsSVQ-PLtY17jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0f8be8b04b23ef42293213da0cc097602ab80ec40f66f82f44a7574c4dac2e79cb7906e17f7404454c91dbf479dbd02138be3949408d79d419c546a9853d96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f52244967eea6d09030249865dac4fb8f6fe5f332be598436efaa7cf3dd93e01b81f8790c32d59bea0126acc93e1ddaa00a553d0f3e8b1f33a0456fb91e00d80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02c148c18b7b9fa3e0ca832707be2f689ac0f49778fea56b9c3ab0e24a499e20ece1d3d7faf1c04996ccfceeb093df4bea197fb6f1ee65e357909ee6d4a6ed4b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 16:24:45.886769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:24:45.887090) ========= 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=db7e7c15f3ca076d53731445000001ba-1468017751.177624-885694447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 16:24:45.969223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 16:24:45.969838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 16:24:45.970162) ========= ========= Total master_lag: 0.17 =========