builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1468668116.48 results: success (0) buildid: 20160716013011 builduid: f00423380d51420d80de489ac5f816cc revision: 4c05938a64a7fde3ac2d7f4493aee1c5f2ad8a0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.476763) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.477224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.477803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.501792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.502114) ========= 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=fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 04:21:57-- 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% 223M=0s 2016-07-16 04:21:57 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.648732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.649061) ========= 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=fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015942 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:56.699246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 04:21:56.699680) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c05938a64a7fde3ac2d7f4493aee1c5f2ad8a0a --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 4c05938a64a7fde3ac2d7f4493aee1c5f2ad8a0a --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=fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 04:21:57,594 truncating revision to first 12 chars 2016-07-16 04:21:57,594 Setting DEBUG logging. 2016-07-16 04:21:57,594 attempt 1/10 2016-07-16 04:21:57,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c05938a64a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 04:21:58,904 unpacking tar archive at: mozilla-central-4c05938a64a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.697467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-16 04:21:58.410689) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:58.411025) ========= script_repo_revision: 4c05938a64a7fde3ac2d7f4493aee1c5f2ad8a0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:58.411452) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:58.411712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 04:21:58.423935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-16 04:21:58.424344) ========= /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=fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:59 INFO - MultiFileLogger online at 20160716 04:21:59 in /builds/slave/test 04:21:59 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 04:21:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:59 INFO - {'append_to_log': False, 04:21:59 INFO - 'base_work_dir': '/builds/slave/test', 04:21:59 INFO - 'blob_upload_branch': 'Firefox', 04:21:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:59 INFO - 'branch': 'Firefox', 04:21:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:59 INFO - 'config_files': ('talos/linux_config.py',), 04:21:59 INFO - 'default_actions': ('clobber', 04:21:59 INFO - 'read-buildbot-config', 04:21:59 INFO - 'download-and-extract', 04:21:59 INFO - 'populate-webroot', 04:21:59 INFO - 'create-virtualenv', 04:21:59 INFO - 'install', 04:21:59 INFO - 'run-tests'), 04:21:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:59 INFO - 'download_minidump_stackwalk': True, 04:21:59 INFO - 'download_symbols': 'ondemand', 04:21:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:59 INFO - 'installer_path': 'installer.exe', 04:21:59 INFO - 'log_level': 'info', 04:21:59 INFO - 'log_name': 'talos', 04:21:59 INFO - 'log_to_console': True, 04:21:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:59 INFO - 'opt_config_files': (), 04:21:59 INFO - 'pip_index': False, 04:21:59 INFO - 'sps_profile': False, 04:21:59 INFO - 'sps_profile_interval': 0, 04:21:59 INFO - 'suite': 'dromaeojs-e10s', 04:21:59 INFO - 'system_bits': '32', 04:21:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:59 INFO - 'title': 'talos-linux64-ix-048', 04:21:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:59 INFO - 'use_talos_json': True, 04:21:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:59 INFO - 'work_dir': 'build'} 04:21:59 INFO - ##### 04:21:59 INFO - ##### Running clobber step. 04:21:59 INFO - ##### 04:21:59 INFO - Running pre-action listener: _resource_record_pre_action 04:21:59 INFO - Running main action method: clobber 04:21:59 INFO - rmtree: /builds/slave/test/build 04:21:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:00 INFO - Running post-action listener: _resource_record_post_action 04:22:00 INFO - ##### 04:22:00 INFO - ##### Finished clobber step (success) 04:22:00 INFO - ##### 04:22:00 INFO - ##### 04:22:00 INFO - ##### Running read-buildbot-config step. 04:22:00 INFO - ##### 04:22:00 INFO - Running pre-action listener: _resource_record_pre_action 04:22:00 INFO - Running main action method: read_buildbot_config 04:22:00 INFO - Using buildbot properties: 04:22:00 INFO - { 04:22:00 INFO - "project": "", 04:22:00 INFO - "product": "firefox", 04:22:00 INFO - "script_repo_revision": "production", 04:22:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:22:00 INFO - "repository": "", 04:22:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:22:00 INFO - "buildid": "20160716013011", 04:22:00 INFO - "pgo_build": "True", 04:22:00 INFO - "basedir": "/builds/slave/test", 04:22:00 INFO - "buildnumber": 294, 04:22:00 INFO - "slavename": "talos-linux64-ix-048", 04:22:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:22:00 INFO - "platform": "ubuntu64_hw", 04:22:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:22:00 INFO - "branch": "mozilla-central", 04:22:00 INFO - "repo_path": "mozilla-central", 04:22:00 INFO - "revision": "4c05938a64a7fde3ac2d7f4493aee1c5f2ad8a0a", 04:22:00 INFO - "stage_platform": "linux64-pgo", 04:22:00 INFO - "builduid": "f00423380d51420d80de489ac5f816cc", 04:22:00 INFO - "slavebuilddir": "test" 04:22:00 INFO - } 04:22:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:22:00 INFO - Running post-action listener: _resource_record_post_action 04:22:00 INFO - ##### 04:22:00 INFO - ##### Finished read-buildbot-config step (success) 04:22:00 INFO - ##### 04:22:00 INFO - ##### 04:22:00 INFO - ##### Running download-and-extract step. 04:22:00 INFO - ##### 04:22:00 INFO - Running pre-action listener: _resource_record_pre_action 04:22:00 INFO - Running main action method: download_and_extract 04:22:00 INFO - mkdir: /builds/slave/test/build/tests 04:22:00 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')]} 04:22:00 INFO - https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:22:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:07 INFO - Downloaded 1361 bytes. 04:22:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:07 INFO - Using the following test package requirements: 04:22:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:22:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'jsshell-linux-x86_64.zip'], 04:22:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22: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')]} 04:22:07 INFO - https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:16 INFO - Downloaded 24328319 bytes. 04:22:16 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'] 04:22:16 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 04:22:17 INFO - Return code: 0 04:22:17 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 04:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:17 INFO - https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:19 INFO - Downloaded 24328319 bytes. 04:22:19 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'] 04:22:19 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 04:22:21 INFO - Return code: 0 04:22:21 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')]} 04:22:21 INFO - https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:22:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:22 INFO - Downloaded 14403317 bytes. 04:22:22 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'] 04:22:22 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 04:22:22 INFO - Return code: 0 04:22:22 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')]} 04:22:22 INFO - https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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 04:22:24 INFO - Downloaded 60815486 bytes. 04:22:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:24 INFO - mkdir: /builds/slave/test/properties 04:22:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:24 INFO - Contents: 04:22:24 INFO - build_url:https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:25 INFO - Running post-action listener: _resource_record_post_action 04:22:25 INFO - Running post-action listener: set_extra_try_arguments 04:22:25 INFO - ##### 04:22:25 INFO - ##### Finished download-and-extract step (success) 04:22:25 INFO - ##### 04:22:25 INFO - ##### 04:22:25 INFO - ##### Running populate-webroot step. 04:22:25 INFO - ##### 04:22:25 INFO - Running pre-action listener: _resource_record_pre_action 04:22:25 INFO - Running main action method: populate_webroot 04:22:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:25 INFO - '--tppagecycles', 04:22:25 INFO - '7'], 04:22:25 INFO - 'tests': ['tsvgm']}}, 04:22:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['damp', 'tps']}, 04:22:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'tests': ['damp', 'tps']}, 04:22:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['dromaeo_dom']}, 04:22:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['basic_compositor_video']}, 04:22:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:22:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['a11yr', 04:22:25 INFO - 'ts_paint', 04:22:25 INFO - 'tpaint', 04:22:25 INFO - 'sessionrestore', 04:22:25 INFO - 'sessionrestore_no_auto_restore', 04:22:25 INFO - 'tabpaint']}, 04:22:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:25 INFO - 'ts_paint', 04:22:25 INFO - 'tpaint', 04:22:25 INFO - 'sessionrestore', 04:22:25 INFO - 'sessionrestore_no_auto_restore', 04:22:25 INFO - 'tabpaint']}, 04:22:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:25 INFO - 'ts_paint', 04:22:25 INFO - 'tpaint', 04:22:25 INFO - 'sessionrestore', 04:22:25 INFO - 'sessionrestore_no_auto_restore', 04:22:25 INFO - 'tabpaint']}, 04:22:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:25 INFO - 'ts_paint', 04:22:25 INFO - 'tpaint', 04:22:25 INFO - 'sessionrestore', 04:22:25 INFO - 'sessionrestore_no_auto_restore', 04:22:25 INFO - 'tabpaint']}, 04:22:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['a11yr', 04:22:25 INFO - 'ts_paint', 04:22:25 INFO - 'tpaint', 04:22:25 INFO - 'sessionrestore', 04:22:25 INFO - 'sessionrestore_no_auto_restore', 04:22:25 INFO - 'tabpaint']}, 04:22:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['a11yr', 04:22:25 INFO - 'ts_paint', 04:22:25 INFO - 'tpaint', 04:22:25 INFO - 'sessionrestore', 04:22:25 INFO - 'sessionrestore_no_auto_restore', 04:22:25 INFO - 'tabpaint']}, 04:22:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['tsvgx', 04:22:25 INFO - 'tsvgr_opacity', 04:22:25 INFO - 'tart', 04:22:25 INFO - 'tscrollx', 04:22:25 INFO - 'cart']}, 04:22:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:25 INFO - 'tsvgr_opacity', 04:22:25 INFO - 'tart', 04:22:25 INFO - 'tscrollx', 04:22:25 INFO - 'cart']}, 04:22:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'talos_options': ['--disable-e10s'], 04:22:25 INFO - 'tests': ['tp5o']}, 04:22:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'tests': ['tp5o']}, 04:22:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'talos_options': ['--disable-e10s', 04:22:25 INFO - '--xperf_path', 04:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:25 INFO - 'tests': ['tp5n']}, 04:22:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:25 INFO - 'talos_options': ['--xperf_path', 04:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:25 INFO - 'tests': ['tp5n']}}, 04:22:25 INFO - 'talos.zip': {'path': '', 04:22:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:25 INFO - Running post-action listener: _resource_record_post_action 04:22:25 INFO - ##### 04:22:25 INFO - ##### Finished populate-webroot step (success) 04:22:25 INFO - ##### 04:22:25 INFO - ##### 04:22:25 INFO - ##### Running create-virtualenv step. 04:22:25 INFO - ##### 04:22:25 INFO - Running pre-action listener: _resource_record_pre_action 04:22:25 INFO - Running main action method: create_virtualenv 04:22:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:25 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 04:22:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:25 INFO - Using real prefix '/usr' 04:22:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:27 INFO - Installing pip.................done. 04:22:27 INFO - Return code: 0 04:22:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:27 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')]} 04:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:27 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')]} 04:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:27 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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22:27 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 04:22:27 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 04:22:27 INFO - Using env: {'DISPLAY': ':0', 04:22:27 INFO - 'HOME': '/home/cltbld', 04:22:27 INFO - 'LANG': 'en_US.UTF-8', 04:22:27 INFO - 'LANGUAGE': 'en_US:en', 04:22:27 INFO - 'LOGNAME': 'cltbld', 04:22:27 INFO - 'MAIL': '/var/mail/cltbld', 04:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:27 INFO - 'MOZ_NO_REMOTE': '1', 04:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:27 INFO - 'NO_EM_RESTART': '1', 04:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:27 INFO - 'PWD': '/builds/slave/test', 04:22:27 INFO - 'SHELL': '/bin/bash', 04:22:27 INFO - 'SHLVL': '1', 04:22:27 INFO - 'TERM': 'linux', 04:22:27 INFO - 'TMOUT': '86400', 04:22:27 INFO - 'USER': 'cltbld', 04:22:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:27 INFO - '_': '/tools/buildbot/bin/python'} 04:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:27 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 04:22:27 INFO - Cleaning up... 04:22:27 INFO - Return code: 0 04:22:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:22:27 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')]} 04:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:27 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')]} 04:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:27 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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22:27 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 04:22:27 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 04:22:27 INFO - Using env: {'DISPLAY': ':0', 04:22:27 INFO - 'HOME': '/home/cltbld', 04:22:27 INFO - 'LANG': 'en_US.UTF-8', 04:22:27 INFO - 'LANGUAGE': 'en_US:en', 04:22:27 INFO - 'LOGNAME': 'cltbld', 04:22:27 INFO - 'MAIL': '/var/mail/cltbld', 04:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:27 INFO - 'MOZ_NO_REMOTE': '1', 04:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:27 INFO - 'NO_EM_RESTART': '1', 04:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:27 INFO - 'PWD': '/builds/slave/test', 04:22:27 INFO - 'SHELL': '/bin/bash', 04:22:27 INFO - 'SHLVL': '1', 04:22:27 INFO - 'TERM': 'linux', 04:22:27 INFO - 'TMOUT': '86400', 04:22:27 INFO - 'USER': 'cltbld', 04:22:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:27 INFO - '_': '/tools/buildbot/bin/python'} 04:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:28 INFO - Downloading/unpacking psutil>=3.1.1 04:22:28 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 04:22:28 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 04:22:28 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 04:22:28 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 04:22:28 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 04:22:28 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 04:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:30 INFO - Installing collected packages: psutil 04:22:30 INFO - Running setup.py install for psutil 04:22:30 INFO - building 'psutil._psutil_linux' extension 04:22:30 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 04:22:30 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 04:22:30 INFO - building 'psutil._psutil_posix' extension 04:22:30 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 04:22:30 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 04:22:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:30 INFO - Successfully installed psutil 04:22:30 INFO - Cleaning up... 04:22:30 INFO - Return code: 0 04:22:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:22: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 mozsystemmonitor==0.3 04:22:30 INFO - Using env: {'DISPLAY': ':0', 04:22:30 INFO - 'HOME': '/home/cltbld', 04:22:30 INFO - 'LANG': 'en_US.UTF-8', 04:22:30 INFO - 'LANGUAGE': 'en_US:en', 04:22:30 INFO - 'LOGNAME': 'cltbld', 04:22:30 INFO - 'MAIL': '/var/mail/cltbld', 04:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:30 INFO - 'MOZ_NO_REMOTE': '1', 04:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:30 INFO - 'NO_EM_RESTART': '1', 04:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:30 INFO - 'PWD': '/builds/slave/test', 04:22:30 INFO - 'SHELL': '/bin/bash', 04:22:30 INFO - 'SHLVL': '1', 04:22:30 INFO - 'TERM': 'linux', 04:22:30 INFO - 'TMOUT': '86400', 04:22:30 INFO - 'USER': 'cltbld', 04:22:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:30 INFO - '_': '/tools/buildbot/bin/python'} 04:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:22:31 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 04:22:31 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 04:22:31 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 04:22:31 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 04:22:31 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 04:22:31 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 04:22:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:22:32 INFO - Installing collected packages: mozsystemmonitor 04:22:32 INFO - Running setup.py install for mozsystemmonitor 04:22:33 INFO - Successfully installed mozsystemmonitor 04:22:33 INFO - Cleaning up... 04:22:33 INFO - Return code: 0 04:22:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', '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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:22: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 jsonschema==2.5.1 04:22:33 INFO - Using env: {'DISPLAY': ':0', 04:22:33 INFO - 'HOME': '/home/cltbld', 04:22:33 INFO - 'LANG': 'en_US.UTF-8', 04:22:33 INFO - 'LANGUAGE': 'en_US:en', 04:22:33 INFO - 'LOGNAME': 'cltbld', 04:22:33 INFO - 'MAIL': '/var/mail/cltbld', 04:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:33 INFO - 'MOZ_NO_REMOTE': '1', 04:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:33 INFO - 'NO_EM_RESTART': '1', 04:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:33 INFO - 'PWD': '/builds/slave/test', 04:22:33 INFO - 'SHELL': '/bin/bash', 04:22:33 INFO - 'SHLVL': '1', 04:22:33 INFO - 'TERM': 'linux', 04:22:33 INFO - 'TMOUT': '86400', 04:22:33 INFO - 'USER': 'cltbld', 04:22:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:33 INFO - '_': '/tools/buildbot/bin/python'} 04:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:33 INFO - Downloading/unpacking jsonschema==2.5.1 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:35 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:35 INFO - warning: no files found matching '*.txt' 04:22:35 INFO - no previously-included directories found matching 'build' 04:22:35 INFO - no previously-included directories found matching 'dist' 04:22:35 INFO - no previously-included directories found matching '.git*' 04:22:35 INFO - Installing collected packages: jsonschema, functools32 04:22:35 INFO - Running setup.py install for functools32 04:22:35 INFO - warning: no files found matching '*.txt' 04:22:35 INFO - no previously-included directories found matching 'build' 04:22:35 INFO - no previously-included directories found matching 'dist' 04:22:35 INFO - no previously-included directories found matching '.git*' 04:22:35 INFO - Successfully installed jsonschema functools32 04:22:35 INFO - Cleaning up... 04:22:35 INFO - Return code: 0 04:22:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', '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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22: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 blobuploader==1.2.4 04:22:35 INFO - Using env: {'DISPLAY': ':0', 04:22:35 INFO - 'HOME': '/home/cltbld', 04:22:35 INFO - 'LANG': 'en_US.UTF-8', 04:22:35 INFO - 'LANGUAGE': 'en_US:en', 04:22:35 INFO - 'LOGNAME': 'cltbld', 04:22:35 INFO - 'MAIL': '/var/mail/cltbld', 04:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:35 INFO - 'MOZ_NO_REMOTE': '1', 04:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:35 INFO - 'NO_EM_RESTART': '1', 04:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:35 INFO - 'PWD': '/builds/slave/test', 04:22:35 INFO - 'SHELL': '/bin/bash', 04:22:35 INFO - 'SHLVL': '1', 04:22:35 INFO - 'TERM': 'linux', 04:22:35 INFO - 'TMOUT': '86400', 04:22:35 INFO - 'USER': 'cltbld', 04:22:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:35 INFO - '_': '/tools/buildbot/bin/python'} 04:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:35 INFO - Downloading/unpacking blobuploader==1.2.4 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:37 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:38 INFO - Downloading docopt-0.6.1.tar.gz 04:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:38 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:38 INFO - Running setup.py install for blobuploader 04:22:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:38 INFO - Running setup.py install for requests 04:22:39 INFO - Running setup.py install for docopt 04:22:39 INFO - Successfully installed blobuploader requests docopt 04:22:39 INFO - Cleaning up... 04:22:39 INFO - Return code: 0 04:22:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:39 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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22:39 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 04:22:39 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 04:22:39 INFO - Using env: {'DISPLAY': ':0', 04:22:39 INFO - 'HOME': '/home/cltbld', 04:22:39 INFO - 'LANG': 'en_US.UTF-8', 04:22:39 INFO - 'LANGUAGE': 'en_US:en', 04:22:39 INFO - 'LOGNAME': 'cltbld', 04:22:39 INFO - 'MAIL': '/var/mail/cltbld', 04:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:39 INFO - 'MOZ_NO_REMOTE': '1', 04:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:39 INFO - 'NO_EM_RESTART': '1', 04:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:39 INFO - 'PWD': '/builds/slave/test', 04:22:39 INFO - 'SHELL': '/bin/bash', 04:22:39 INFO - 'SHLVL': '1', 04:22:39 INFO - 'TERM': 'linux', 04:22:39 INFO - 'TMOUT': '86400', 04:22:39 INFO - 'USER': 'cltbld', 04:22:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:39 INFO - '_': '/tools/buildbot/bin/python'} 04:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:39 INFO - Running setup.py (path:/tmp/pip-_eqAYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:39 INFO - Running setup.py (path:/tmp/pip-7i24mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:39 INFO - Running setup.py (path:/tmp/pip-2KUVF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:39 INFO - Running setup.py (path:/tmp/pip-cdYZO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:39 INFO - Running setup.py (path:/tmp/pip-K2nvKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:39 INFO - Running setup.py (path:/tmp/pip-FIbV6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:39 INFO - Running setup.py (path:/tmp/pip-gFM36f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:39 INFO - Running setup.py (path:/tmp/pip-qQtm18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:40 INFO - Running setup.py (path:/tmp/pip-vO1a16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:40 INFO - Running setup.py (path:/tmp/pip-YNEqql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:40 INFO - Running setup.py (path:/tmp/pip-wezb4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:40 INFO - Running setup.py (path:/tmp/pip-1ycbC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:40 INFO - Running setup.py (path:/tmp/pip-kDVoVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:40 INFO - Running setup.py (path:/tmp/pip-9Xh_3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:40 INFO - Running setup.py (path:/tmp/pip-003lKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:40 INFO - Running setup.py (path:/tmp/pip-99MuVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:40 INFO - Running setup.py (path:/tmp/pip-o5eLQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:40 INFO - Running setup.py install for manifestparser 04:22:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:40 INFO - Running setup.py install for mozcrash 04:22:40 INFO - Running setup.py install for mozdebug 04:22:40 INFO - Running setup.py install for mozdevice 04:22:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Running setup.py install for mozfile 04:22:41 INFO - Running setup.py install for mozhttpd 04:22:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Running setup.py install for mozinfo 04:22:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Running setup.py install for mozInstall 04:22:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Running setup.py install for mozleak 04:22:41 INFO - Running setup.py install for mozlog 04:22:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Running setup.py install for moznetwork 04:22:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:41 INFO - Running setup.py install for mozprocess 04:22:41 INFO - Running setup.py install for mozprofile 04:22:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:42 INFO - Running setup.py install for mozrunner 04:22:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:42 INFO - Running setup.py install for mozscreenshot 04:22:42 INFO - Running setup.py install for moztest 04:22:42 INFO - Running setup.py install for mozversion 04:22:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:42 INFO - Cleaning up... 04:22:42 INFO - Return code: 0 04:22:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:42 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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22:42 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 04:22:42 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 04:22:42 INFO - Using env: {'DISPLAY': ':0', 04:22:42 INFO - 'HOME': '/home/cltbld', 04:22:42 INFO - 'LANG': 'en_US.UTF-8', 04:22:42 INFO - 'LANGUAGE': 'en_US:en', 04:22:42 INFO - 'LOGNAME': 'cltbld', 04:22:42 INFO - 'MAIL': '/var/mail/cltbld', 04:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:42 INFO - 'MOZ_NO_REMOTE': '1', 04:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:42 INFO - 'NO_EM_RESTART': '1', 04:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:42 INFO - 'PWD': '/builds/slave/test', 04:22:42 INFO - 'SHELL': '/bin/bash', 04:22:42 INFO - 'SHLVL': '1', 04:22:42 INFO - 'TERM': 'linux', 04:22:42 INFO - 'TMOUT': '86400', 04:22:42 INFO - 'USER': 'cltbld', 04:22:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:42 INFO - '_': '/tools/buildbot/bin/python'} 04:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:42 INFO - Running setup.py (path:/tmp/pip-Bvtnwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:42 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)) 04:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:42 INFO - Running setup.py (path:/tmp/pip-t7dWKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:42 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)) 04:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:42 INFO - Running setup.py (path:/tmp/pip-vM3_U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:42 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)) 04:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:42 INFO - Running setup.py (path:/tmp/pip-7uxuKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:42 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)) 04:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:42 INFO - Running setup.py (path:/tmp/pip-1P0uC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:43 INFO - Running setup.py (path:/tmp/pip-fLbuNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:43 INFO - Running setup.py (path:/tmp/pip-i6Yltu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:43 INFO - Running setup.py (path:/tmp/pip-8yqHBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:43 INFO - Running setup.py (path:/tmp/pip-lfsZTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:43 INFO - Running setup.py (path:/tmp/pip-U2Rv0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:43 INFO - Running setup.py (path:/tmp/pip-_qj9oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:43 INFO - Running setup.py (path:/tmp/pip-GBsbMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:43 INFO - Running setup.py (path:/tmp/pip-gT5uN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:43 INFO - Running setup.py (path:/tmp/pip-XwNjFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:43 INFO - Running setup.py (path:/tmp/pip-jxexJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:43 INFO - Running setup.py (path:/tmp/pip-kMbcZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:43 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)) 04:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:43 INFO - Running setup.py (path:/tmp/pip-KAwkkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:43 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)) 04:22:43 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)) 04:22:43 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)) 04:22:43 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)) 04:22:43 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)) 04:22:43 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)) 04:22:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:45 INFO - Downloading blessings-1.6.tar.gz 04:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:45 INFO - Installing collected packages: blessings 04:22:45 INFO - Running setup.py install for blessings 04:22:45 INFO - Successfully installed blessings 04:22:46 INFO - Cleaning up... 04:22:46 INFO - Return code: 0 04:22:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:46 INFO - Reading from file tmpfile_stdout 04:22:46 INFO - Current package versions: 04:22:46 INFO - argparse == 1.2.1 04:22:46 INFO - blessings == 1.6 04:22:46 INFO - blobuploader == 1.2.4 04:22:46 INFO - docopt == 0.6.1 04:22:46 INFO - functools32 == 3.2.3-2 04:22:46 INFO - jsonschema == 2.5.1 04:22:46 INFO - manifestparser == 1.1 04:22:46 INFO - mozInstall == 1.12 04:22:46 INFO - mozcrash == 0.17 04:22:46 INFO - mozdebug == 0.1 04:22:46 INFO - mozdevice == 0.48 04:22:46 INFO - mozfile == 1.2 04:22:46 INFO - mozhttpd == 0.7 04:22:46 INFO - mozinfo == 0.9 04:22:46 INFO - mozleak == 0.1 04:22:46 INFO - mozlog == 3.2 04:22:46 INFO - moznetwork == 0.27 04:22:46 INFO - mozprocess == 0.23 04:22:46 INFO - mozprofile == 0.28 04:22:46 INFO - mozrunner == 6.12 04:22:46 INFO - mozscreenshot == 0.1 04:22:46 INFO - mozsystemmonitor == 0.3 04:22:46 INFO - moztest == 0.7 04:22:46 INFO - mozversion == 1.4 04:22:46 INFO - psutil == 3.1.1 04:22:46 INFO - requests == 1.2.3 04:22:46 INFO - wsgiref == 0.1.2 04:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:46 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')]} 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 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')]} 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22:46 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 04:22:46 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 04:22:46 INFO - Using env: {'DISPLAY': ':0', 04:22:46 INFO - 'HOME': '/home/cltbld', 04:22:46 INFO - 'LANG': 'en_US.UTF-8', 04:22:46 INFO - 'LANGUAGE': 'en_US:en', 04:22:46 INFO - 'LOGNAME': 'cltbld', 04:22:46 INFO - 'MAIL': '/var/mail/cltbld', 04:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:46 INFO - 'MOZ_NO_REMOTE': '1', 04:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:46 INFO - 'NO_EM_RESTART': '1', 04:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:46 INFO - 'PWD': '/builds/slave/test', 04:22:46 INFO - 'SHELL': '/bin/bash', 04:22:46 INFO - 'SHLVL': '1', 04:22:46 INFO - 'TERM': 'linux', 04:22:46 INFO - 'TMOUT': '86400', 04:22:46 INFO - 'USER': 'cltbld', 04:22:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:46 INFO - '_': '/tools/buildbot/bin/python'} 04:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 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)) 04:22:46 INFO - Cleaning up... 04:22:46 INFO - Return code: 0 04:22:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22:46 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')]} 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 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')]} 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:46 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 0x17cc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, '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': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', '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 04:22:46 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 04:22:46 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 04:22:46 INFO - Using env: {'DISPLAY': ':0', 04:22:46 INFO - 'HOME': '/home/cltbld', 04:22:46 INFO - 'LANG': 'en_US.UTF-8', 04:22:46 INFO - 'LANGUAGE': 'en_US:en', 04:22:46 INFO - 'LOGNAME': 'cltbld', 04:22:46 INFO - 'MAIL': '/var/mail/cltbld', 04:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:46 INFO - 'MOZ_NO_REMOTE': '1', 04:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:46 INFO - 'NO_EM_RESTART': '1', 04:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:46 INFO - 'PWD': '/builds/slave/test', 04:22:46 INFO - 'SHELL': '/bin/bash', 04:22:46 INFO - 'SHLVL': '1', 04:22:46 INFO - 'TERM': 'linux', 04:22:46 INFO - 'TMOUT': '86400', 04:22:46 INFO - 'USER': 'cltbld', 04:22:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:46 INFO - '_': '/tools/buildbot/bin/python'} 04:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:22:46 INFO - Cleaning up... 04:22:46 INFO - Return code: 0 04:22:46 INFO - Running post-action listener: _resource_record_post_action 04:22:46 INFO - Running post-action listener: _start_resource_monitoring 04:22:46 INFO - Starting resource monitoring. 04:22:46 INFO - ##### 04:22:46 INFO - ##### Finished create-virtualenv step (success) 04:22:46 INFO - ##### 04:22:46 INFO - ##### 04:22:46 INFO - ##### Running install step. 04:22:46 INFO - ##### 04:22:46 INFO - Running pre-action listener: _resource_record_pre_action 04:22:46 INFO - Running main action method: install 04:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:46 INFO - Reading from file tmpfile_stdout 04:22:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:47 INFO - Reading from file tmpfile_stdout 04:22:47 INFO - Output received: 04:22:47 INFO - Usage: mozinstall [options] installer 04:22:47 INFO - Options: 04:22:47 INFO - -h, --help show this help message and exit 04:22:47 INFO - -d DEST, --destination=DEST 04:22:47 INFO - Directory to install application into. [default: 04:22:47 INFO - "/builds/slave/test"] 04:22:47 INFO - --app=APP Application being installed. [default: firefox] 04:22:47 INFO - mkdir: /builds/slave/test/build/application 04:22:47 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'] 04:22:47 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 04:23:04 INFO - Reading from file tmpfile_stdout 04:23:04 INFO - Output received: 04:23:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:04 INFO - Running post-action listener: _resource_record_post_action 04:23:04 INFO - ##### 04:23:04 INFO - ##### Finished install step (success) 04:23:04 INFO - ##### 04:23:04 INFO - ##### 04:23:04 INFO - ##### Running run-tests step. 04:23:04 INFO - ##### 04:23:04 INFO - Running pre-action listener: _resource_record_pre_action 04:23:04 INFO - Running main action method: run_tests 04:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:04 INFO - Python 2.7.3 04:23:04 INFO - Return code: 0 04:23:04 INFO - grabbing minidump binary from tooltool 04:23: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')]} 04:23:04 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 0x1a8b3b0>, '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 0x1a8c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:04 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 04:23:04 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 04:23:04 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 04:23:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:04 INFO - Return code: 0 04:23:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:04 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/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 04:23:04 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/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 04:23:04 INFO - Using env: {'DISPLAY': ':0', 04:23:04 INFO - 'HOME': '/home/cltbld', 04:23:04 INFO - 'LANG': 'en_US.UTF-8', 04:23:04 INFO - 'LANGUAGE': 'en_US:en', 04:23:04 INFO - 'LOGNAME': 'cltbld', 04:23:04 INFO - 'MAIL': '/var/mail/cltbld', 04:23:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:04 INFO - 'MOZ_NO_REMOTE': '1', 04:23:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:04 INFO - 'NO_EM_RESTART': '1', 04:23:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:04 INFO - 'PWD': '/builds/slave/test', 04:23:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:04 INFO - 'SHELL': '/bin/bash', 04:23:04 INFO - 'SHLVL': '1', 04:23:04 INFO - 'TERM': 'linux', 04:23:04 INFO - 'TMOUT': '86400', 04:23:04 INFO - 'USER': 'cltbld', 04:23:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281', 04:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:04 INFO - '_': '/tools/buildbot/bin/python'} 04:23:04 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/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 04:23:04 INFO - mozversion application_buildid: 20160716013011 04:23:04 INFO - mozversion application_changeset: 4c05938a64a7fde3ac2d7f4493aee1c5f2ad8a0a 04:23:04 INFO - mozversion application_display_name: Nightly 04:23:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:04 INFO - mozversion application_name: Firefox 04:23:04 INFO - mozversion application_remotingname: firefox 04:23:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:04 INFO - mozversion application_vendor: Mozilla 04:23:04 INFO - mozversion application_version: 50.0a1 04:23:04 INFO - mozversion platform_buildid: 20160716013011 04:23:04 INFO - mozversion platform_changeset: 4c05938a64a7fde3ac2d7f4493aee1c5f2ad8a0a 04:23:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:04 INFO - mozversion platform_version: 50.0a1 04:23:04 INFO - using testdate: 1468668184 04:23:04 INFO - actual date: 1468668184 04:23:04 INFO - starting webserver on 'localhost:50234' 04:23:04 INFO - SUITE-START | Running 2 tests 04:23:04 INFO - TEST-START | dromaeo_css 04:23:04 INFO - operating with platform_type : linux_ 04:23:04 INFO - Initialising browser for dromaeo_css test... 04:23:04 INFO - TEST-INFO | started process 762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_M1cgf/profile http://localhost:50234/getInfo.html) 04:23:09 INFO - PROCESS | 762 | __metrics Screen width/height:1600/1200 04:23:09 INFO - PROCESS | 762 | colorDepth:24 04:23:09 INFO - PROCESS | 762 | Browser inner width/height: 1024/697 04:23:09 INFO - PROCESS | 762 | __metrics 04:23:10 ERROR - PROCESS | 762 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:23:11 INFO - TEST-INFO | 762: exit 0 04:23:11 INFO - Browser initialized. 04:23:11 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:11 INFO - TEST-INFO | started process 893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_M1cgf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:23 INFO - PROCESS | 893 | RSS: Main: 167616512 04:23:23 INFO - PROCESS | 893 | 04:24:12 INFO - PROCESS | 893 | 1468668252798 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] 04:26:20 INFO - PROCESS | 893 | Cycle 1(1): loaded http://localhost:50234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50234/tests/dromaeo/cssquery-ext.html) 04:26:21 INFO - PROCESS | 893 | RSS: Main: 172175360 04:26:21 INFO - PROCESS | 893 | 04:29:23 INFO - PROCESS | 893 | Cycle 1(1): loaded http://localhost:50234/tests/dromaeo/cssquery-ext.html (next: http://localhost:50234/tests/dromaeo/cssquery-jquery.html) 04:29:24 INFO - PROCESS | 893 | RSS: Main: 168402944 04:29:24 INFO - PROCESS | 893 | 04:32:26 INFO - PROCESS | 893 | Cycle 1(1): loaded http://localhost:50234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50234/tests/dromaeo/cssquery-mootools.html) 04:32:26 INFO - PROCESS | 893 | RSS: Main: 173150208 04:32:26 INFO - PROCESS | 893 | 04:35:28 INFO - PROCESS | 893 | Cycle 1(1): loaded http://localhost:50234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50234/tests/dromaeo/cssquery-prototype.html) 04:35:29 INFO - PROCESS | 893 | RSS: Main: 167034880 04:35:29 INFO - PROCESS | 893 | 04:38:31 INFO - PROCESS | 893 | Cycle 1(1): loaded http://localhost:50234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50234/tests/dromaeo/cssquery-yui.html) 04:38:32 INFO - PROCESS | 893 | RSS: Main: 168689664 04:38:32 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | Cycle 1(1): loaded http://localhost:50234/tests/dromaeo/cssquery-yui.html (next: http://localhost:50234/tests/dromaeo/cssquery-dojo.html) 04:41:35 INFO - PROCESS | 893 | RSS: Main: 170233856 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | __start_tp_report 04:41:35 INFO - PROCESS | 893 | _x_x_mozilla_page_load 04:41:35 INFO - PROCESS | 893 | _x_x_mozilla_page_load_details 04:41:35 INFO - PROCESS | 893 | |i|pagename|runs| 04:41:35 INFO - PROCESS | 893 | |0;dojo.html;3029.5455681647763;3052.6184226971627;3055.6944305569446;3059.204606802231;3079.923001924952;5387.595930305228;5392.352917649878;5397.973010134949;5404.432534583871;5431.674099554019;5331.147016477365;5383.192521121834;5414.756335964881;5458.235846981426;5523.1163013917785;4887.731174785395;4951.77717002734;4953.851384458472;5049.468124674541;5056.544910958013;280.7191363758335;4796.472388037313;4842.733649649268;4845.588125009378;4991.600671946236;4844.539768721966;4845.927311090319;4858.441279252896;4866.878328041792;4900.607951363882;4844.394450693663;4877.268409738567;4884.975575122137;4885.43817460993;4895.11887860185;4791.401074865642;4825.469198388175;4877.146499362598;4904.117258893398;4910.779014944301;5400.540954018874;5402.297701298845;5402.91895621566;5435.83692489226;5460.972695136538;5609.439056094398;5815.069588865804;5824.24284842972;5830.854228644275;5879.235699359098;5818.243628328332;5871.55963302754;5911.733971971272;5912.526997840162;5933.554983376221;5482.068048431736;5485.9725701371235;5488.396276409591;5508.531774799107;5513.61404701667;5741.19623252745;5871.882562348729;5965.55258355625;6024.57827952048;6029.758809647653;5582.051051321285;5583.637063590853;5595.916061259084;5621.634593751393;5668.348139963874;5787.247657804459;5798.507126894261;5807.070868660994;5817.825465236049;5823.126531020296;5733.77064917407;5760.971195143998;5787.2187254720075;5795.217645617788;5810.041343178328;5805.94194058054;5809.8547536311935;5829.504492118217;5842.182094506772;5845.006348920694;4441.888952776207;4460.977695111568;4463.575960283768;4466.0844526871915;4500.527444618333;3895.0651843557907;3896.2597106549665;3897.3569361055675;3909.8045097745;3919.7256192066284;5401.6218864679095;5489.698066606375;5561.110222364402;5583.4137415571595;5592.804251851166;5870.823875283749;5884.117382392676;5890.204822348928;5897.616654917417;5897.7935772247765;5369.194620806832;5491.505764481216;5508.338999320027;5542.279503664578;5554.305711786027;4947.554720075211;4954.653174277766;4996.725180115129;5002.424721157041;5042.647014708935;5727.2268243787385;5944.316403613553;5947;5958.314793798682;5960.4635582797755;5692.573057020657;5736.053551164011;5738.856528586652;5794.246747922743;5798.304203495608;5878.735456904535;5892.440218179266;5898.469137777621;5918.378570250062;5957.434043765836;5614.803481878114;5653.886922261449;5694.402087780723;5698.1737648041635;5753.626014309057;5717.799877004285;5767.5385969121535;5794.507466865363;5813.389594092729;5853.707314634166;5631.8592035199445;5639.295088113986;5653.745581448927;5659.066254068197;5659.179418984307;5483.506484416422;5600.243967064394;5625.774969001358;5642.830715078554;5653.208550802973;5645.1532270159805;5647.887042259214;5649.943500564942;5670.546356291405;5720.771169153188;5655.377908430151;5672.092465205547;5687.687177205294;5704.885902281848;5733.483986441241;5457.235986961749;5485.561155107662;5523.8895222096135;5581.665100094007;5617.4101719320515 04:41:35 INFO - PROCESS | 893 | |1;ext.html;571.1404336473606;574.8993926062938;592.6740292838938;599.913012613171;631.1164369882162;40826.59173408265;44670.55329446705;44981.99999999992;45068.54931450685;45110.09779804402;45613.77193114038;46319.76840115803;46463;46536.069278614406;46555.30167047497;8866.20204181622;9017.098290170996;9043.638254469814;9045.23115535177;9047.185753282203;8866.822663546725;8965.731028069136;8992.640294388217;8993.415427997159;9028.638854445815;9058.275337972946;9067.909320906772;9102.180803727662;9116.58975346111;9131.634734610607;9038.638454461814;9047.095290470967;9072.455652660861;9078.54607269634;9088.727338179866;8994.0556241595;8999.910000899972;9064.68273610427;9072.591733372014;9077.863832042525;42795.57204427947;42797;43232.35151472731;43308.350374744405;43329;3373.3590617782543;3514.61339252682;3538.2569660371355;3561.857525698969;3964.385520244338;33679.6632033679;34253.314933701186;34311.14222144442;34319;34517.65482345194;4468.307412351059;4484.708493947883;4513.074819661962;4530.954690453086;4594.035252596958;370500;370851;372032.99999999726;373258;375314;32820.507692384635;60872.39127608756;61323;61449.07826382608;61572.69213653903;35157;36509;36759.26481470356;36813.631863681556;37016;15368.077915325117;15694.529164125095;15776.68446631061;15796.921015395079;15806.130662813655;13092.803607945889;13204.405801738945;13209.471621135048;13216.273104979125;13261;8481.109483504266;8503.574821258911;8548.572571371407;8588.184122508352;8612.526311052827;3223.693749093832;3245.6754324567355;3260.1523603863166;3281.0648965044848;3288.852001659931;1021.4126877045728;1026.7923963478431;1113.3041848844473;1132.7709435262832;1139.225326777799;33588.664113359046;33967;34014.659853401645;34046.48930266048;34293.314133717686;1092.378292098953;1098.6758906122552;1154.936478493674;1171.718787491013;1204.692803335144;17640.558986025197;17871.73192402115;17898.28406863711;17958.91020544889;18356.908215459105;628060;633179;634784;635478;636194;62652;63728;63817.68091159515;63826.68086659537;64071.359286406536;1354.593621913422;1401.922894240806;1409.1615488784362;1411.8023476713267;1413.547664747271;34523.30953380968;35610;36021.81989090038;36215.63784362228;36678.81660591787;55163.44836551583;55247;55833.441665582824;55998.32005039855;56081.43918560762;570359;570844;570973;571159;571686;29314.7068529312;29516;29723.702762972094;30000.099997000125;30205;50649.74675126601;51230.74384628053;51561.7421912903;51849;52348.738256309996;43813.56186438095;44039;44221.778891105336;44579.55420445754;45433.77283113563;43708.34437483504;43943.78028109839;44282.3357649629;44892.77553612211;45481;42386.788066059475;43358.61527615885;44307;44536.77731611321;44591;38360.42459363056;38528.80735596416;38727.419088714254;38788.6121138785;38789.836304910896;29891.187647626204;29961.850190748908;29991;29993;30244.54633180548 04:41:35 INFO - PROCESS | 893 | |2;jquery.html;383.8004237796345;384.72876621981504;386.51299362802877;393.3713983766089;410.3454989292078;14154.433822647108;18845.811541884577;19945.900270498627;20284.89857550712;20308.89845550772;18820.24719011238;19267.132979015943;19550;19604.901975490102;19688.409347719557;5728.255326807509;5884.76460941564;5953.732082056296;5959.255093113361;5967.6419414835245;5755.136729490568;5790.13148027795;5821.3887541808135;5832.883342333151;5867.501262392701;5624.3813180550105;5706.914396284059;5765.884682306351;5802.071668533035;5843.620164689281;5701.914471282934;5708.686022268774;5724.112762521795;5742.569307301948;5758.193852860602;5019.096562618727;5030.8239211627415;5111.974440127776;5120.3855537335385;5138.974305128488;22707.318780436613;23270.53458930829;23345.182918597766;23668.763312367002;23718;2273.624851899435;2514.8742562871785;2585.172744721671;2945.4698154332214;3073.9673390970374;13925.23411212383;14487.637809054753;14604.196769177692;14648;14786.18675972821;1768.6816373052845;1800.8649351298575;1817.2095138614745;1897.1652472912012;1972.7336809530673;62507;75292.24707752907;77097.229027709;80352;82501.58749206275;10226.6420675276;10683.412412317397;10736.443215733674;10787.298825576312;10929.868675608339;14665.48670796517;14687.26563671812;14690.926545367205;14867.18230497333;14877.628059298604;7932.484388514728;8480.618372173267;8575.228229459379;8674.6530138795;8709.869351959725;8532.402731808837;8677.696280630147;8678.826423471495;8679.913200868037;8686.087960764155;6503.869922601616;6531.4651057001565;6668.366505182;6669.666516674147;6715.6977935993;1849.5930895203035;1877.8029705244896;1882.830545250934;1904.4477101640646;1948.162290215221;977.5747549815853;988.6292640259902;1015.5836107196014;1067.5854492797075;1114.6266000889793;20955.476113097295;21082.262120825697;21288.467788305108;21350.679739803603;21487.892560537097;1002.8646132771983;1015.5836107196162;1026.3585259212991;1027.5170669785189;1144.0504381363448;10583.31208471447;10978.945105274423;11648.534058637559;11848.28910265387;11911.76176476483;462911;465985;471713;472100;525467;88748;91550;92856;94675;95721;1025.266934142092;1057.180684969155;1076.8061748885275;1083.544911137324;1093.436880006797;17052.65894682124;17168.484945451655;17185.484435466955;17573.472795816146;17679.116044197996;29353.412931741674;36578.26843463169;42857.57142428536;42890.78554607207;44519.33221001752;57625;57775.422245777;58126;59610.40389596049;59704.40295597162;7246.855062898818;8162.795930101557;8240.093589705008;8538.487690738575;8547.358948078794;12232.877671223174;12748.61754147377;12821.358932053174;12966.35168241603;12994.090413670952;10706.464676765974;10892.727681808019;11194.328340299608;11246.437678116225;11310.434478276218;11110.666679999613;11130.499127539118;11145;11253.324800511995;11287.548498060314;11229.55081796719;11241.04451121631;11355.432228388712;11519.481623326803;11546.653600392001;7270.309320614533;7538.472306938462;7603.4297427694255;7661.118971318369;7888.132305446511;10490.475476226311;11289;11337.03635190985;11421.486033128695;11694.649160524858 04:41:35 INFO - PROCESS | 893 | |3;mootools.html;1469.404891019137;1470.6838029823587;1607.4615003973668;1762.1013283225552;1766.178726891995;7740.458167928247;8324.791880202998;8390.202930721587;8706.303495720344;8728.781780455492;8438.367122465808;8689.087645797195;8738.694145704902;8760.605772740226;8765.123487651248;2322.4542232575373;2335.7781010803947;2338.555674421863;2341.906323747048;2348.3894187511287;2272.3750968483632;2298.5747636687183;2314.8611083334968;2322.4310044039235;2329.37106981115;2324.174917904145;2343.929682109531;2348.3072493614427;2348.659444380564;2353.2234362660365;2217.2018073493527;2224.088123869214;2231.5983123037927;2235.552889422114;2250.032486031006;2218.866867987926;2227.866328020324;2231.34175418252;2239.742429620598;2245;8838.337124715608;9042.86435703465;9052.637894484213;9056;9071.410358326688;5135.97280543889;5263.36839579253;5302.965921645281;5309.309789727349;5317.096093664087;3254.902352929416;3365.3605814895336;3420.572428446444;3453.4647129694936;3463.6709512596262;1289.3424353579649;1299.7595444842639;1300.193879794524;1301.2517802263735;1328.48853191521;12271.815922761165;12406.81389779154;12418.56535021279;12422.130450868442;12472.0645951554;4530.275155975029;4658.416138512922;4802.591779698765;4807.495213002654;4813.855584332476;10517.263791534671;10553.261271710906;10569.735756606146;10586.047255746866;10605.310654807412;5333.386660534011;5357.598180136428;5359.062164121263;5362.168863826113;5372.7313634318125;4452.265376212888;4823.710577365369;4960.007998400334;5002.124628190052;5021.121303771825;4091.4067460218102;4116.029804359067;4124.484439445069;4131.442255295557;4170.103427763045;1298.0913360647585;1333.9266340351373;1340.5844188301658;1346.6364081697886;1357.2670757790681;976.4580657734883;985.4186030242191;1004.9899501005043;1021.5352014833232;1036.6630844975261;5900.616459930091;6001.219841420588;6102.176206212193;6122;6232.844178895564;447.91937451258434;453.47170546313174;454.1734044039816;469.08294284673383;471.0884438611298;4442.777861106932;4465;4467.463904331501;4469.10617876426;4469.642428605704;10522.894771052344;10896.18278629106;10982.341059536293;10995.615153469591;11030.724231894106;9899.752506187258;10278.486075696186;10828.891711082946;10829.566817327377;10865;8063.1130575636635;8173.223543763333;8270.545120018456;8310.459820111673;8324;6032.819015429544;6275;6339.524535659936;6447.097406363207;6475.579087359307;10350.637727679496;10394.636187733393;10401.323913945569;10421.531031103466;10504;9909.256805739455;10294.3823370598;10297.588096476056;10320.741981450525;10346.689599312032;7146.499745017799;7476.5514069156025;7588.506747061423;7770.961145194238;8124.22819832115;8497.787555311166;8544.530050847263;8565.186307300797;8628.180322869317;8630.870536941826;7498.212687667935;7641.2740789624895;7648.73229436967;7741.729039483591;7773.883391749241;7403.259674032553;7613.5431874087735;7711.3830893527265;7738.729144480141;7755.224477552425;7171;7183.95832604259;7231.4214862811905;7243.710251589878;7251.311125443074;4996.325496058131;5171.81898633546;5305.1776974569;5330.227117068081;5356.651817631841;5342.43904390049;5361.571074313967;5491.835244942658;5502.504774570148;5506.33923929115 04:41:35 INFO - PROCESS | 893 | |4;prototype.html;309.834238682305;313.57510573173334;326.05931886507426;327.23916893223253;331.6401704150996;5415.810446634368;5442.482964118402;5551.611387202897;5634.549236061115;5636.915446268299;5529.668219906808;5541.254504830976;5620;5630.662160270386;5632.690202038886;4333.180064372955;4336.241157797389;4352.194843953863;4353.651707863379;4359.542248063955;4166.458360413158;4322.956770432287;4331.7184383015165;4343.717658352213;4349.195398851222;4262.78686065697;4263.616274535291;4271;4292.65658747301;4314.956850431503;4330.523642399334;4331.4802223733195;4337.804798784046;4350.8912277193;4366.908272931767;3795.3927371620684;3825.6365645263654;3863.74885632433;3868.9806550967346;3875.418687196915;5401.756920938567;5429.728513574345;5430.212619170237;5451.536619387357;5452.182172674091;4991.975040124777;5017;5024.623153263483;5031.716912187406;5046.697198168122;5702.857428564277;5859.091840764646;5867.530597552186;5871.442212989759;5890.970545147246;4190.350495673176;4203.432536607549;4208.452901122865;4212.199682060429;4212.53662097169;6043.365446628085;6080.270367555878;6083.634981901056;6088.630058236906;6097.688996865651;4115.9588404116175;4321.962728945031;4330.17726631939;4394.626456751148;4405.801738921757;4346.304941072984;4363.102050607996;4376.978115109468;4398.450193725785;4402.449693788277;4965.1807451770055;5031.622628302892;5039.143345631252;5046.9747651261505;5049.495050494921;5786.71066446676;5867.325257595346;5894.850504151735;5923.4076592340425;5982.312034116046;1497.610621238486;1504.601280660626;1513.2585033333808;1516.6435887566413;1519.3618680154361;955.9904400956041;967.1489089601106;984.7488890333062;989.737719504332;994.4480813148772;5011.298418221452;5015.598752099823;5052.91362357095;5060.924086138711;5096.337476128154;5217.287010754387;5234.869128271824;5241.659292145999;5280.551153151949;5294.517535090181;5011.899762004812;5052.418971818288;5075;5288.524032836986;5727.8854422912145;3183.5702180205376;3193.042087373825;3202.4876019836715;3209.8234597096916;3216.774825762221;6044.516438684895;6185.474234690102;6208.596441231305;6215.844603884939;6251.686606098775;6026.849328766816;6098.451139397475;6114.296855861633;6128.3258841527395;6134.877302453926;6172.024952015312;6224.751009959551;6226.159468471789;6237.625742455376;6238.1266622672865;5862.863368098047;5958.582899197015;6004.459598636144;6007.519398448027;6057.7879774207695;5926.4666180044005;5926.911096333644;5933.228680271537;5947.3457919627945;5987.5808693391045;5554.916676249779;6117.724702388492;6153.630782153085;6188.710177234272;6199.783007594712;4125.484314460692;4145.523264824584;4151.8339266429;4166.270902591974;4181.853635122756;5979.162917191684;6011.128386384037;6092.360302168208;6101.627133894838;6113.877722445615;5685.658860468385;5864.706764661835;5865.618734782225;5866.011112443579;5917.556183286185;5768.740406681625;5803.738831752666;5835.591508594358;5844.503217226584;5892.587518873637;5537.390887002507;5833.883322333614;5837.766489340549;5848.87085409304;5854.648721076749;5905.704714764331;5916.378780228014;5935.664475492979;5937.287525496968;5946.45392198023;5781.479666830005;5795.638025064022;5804.94195058044;5810.099434587646;5871.1486834409625 04:41:35 INFO - PROCESS | 893 | |5;yui.html;713.9393151582112;718.2888939949452;741.0625558668286;754.6566312327891;767.7965339185121;15238.771418428718;16408.917955410205;16434.917825410856;16465.67068658626;16500.587485312873;13485.39315730792;13740.24428656426;13804.44782208713;13834.446622135129;13880.791788123186;636.5289685632645;786.5516655506349;789.376392649806;813.8860559521672;816.0941355095839;812.569338250728;816.143049797713;816.4896939412866;817.3992115794886;818.4025661267278;857.1471385970967;857.8798968144465;858.2533196119385;858.8926384201975;867.0029466113956;848.3213429256601;851.9957400213021;855.3029281135886;856.7686724584328;857.5412154497315;620.419907386595;627.7865525721231;629.672570263465;630.987380252397;633.0504243634548;14699.412023519046;14756.631084222872;14771.482998095014;14843.406263749437;14871;13758;14430.855691443056;14823.925880370529;14893.32980015891;14927.626809329746;11996.460159292765;12033.217785979718;12128.272303661808;12239.75520489594;12367.381630918508;3881.1849511602595;3893.669038131734;3912.2762288976633;3964.0882597002565;3968.265870813909;71235.64382178056;71977;73685.63157184233;74851.62574187148;74864.62567687182;11485.310881347146;11537.653870383901;11562;11797.52809887595;11877;20994.475138121365;21107.26124585632;21124.78875211259;21168.894155529124;21175.78824211769;7890.250426209501;7984.520928744294;7995.320397766255;8265.090840007595;8426.957865210634;4609.316491087869;4768.976155119271;4788.353572267769;4824.107540105092;4925.7783399747095;3251.5772949516413;3290.5393244945726;3345;3360.5799275090612;3364.6205055926953;597.8116893178635;606.3633185155658;609.4880300547561;616.7779599344233;628.7233617208414;729.4018904498366;735.7424901284508;744.6053591596354;746.895434639151;747.3871425431203;9257.537123143817;9636.807263854684;9945.254105941938;10114.797704045877;10444.843327350096;620.7641096383345;677.7797215904851;705.8941158826217;713.165596252386;744.3003576637943;4427.424434823452;4889.559939605381;4978.153713868651;5007.674501157413;5014.2979982802435;92646;114934.4253278745;117631;119790;120953;101389.49305253573;102970;103008;103107;103278.48360758148;55545.444545554834;56594.717026414604;56649.7167514168;58326.99999999915;63861;8482.406231563731;8637.913620863963;8640.135986401561;8663.133686631287;8722.171393717586;50737;50750;51844.44466666006;51858.96282074413;51998.480015200876;73218.63390683013;74689;75922.62038689772;75966.6201668988;77881.61059194668;13653.385597648328;13659.931700341434;13723.176609403468;13734.862651373758;13778.586642400744;13831.723365532433;14337.139771613736;14426;15274.236288185324;15310.540683779505;13893.166410015432;14026.158430493795;14460.20468874222;14892.62768430798;14997.77503337429;14159;14465.710685786014;14610.196439195946;14648.560543183721;14800.185989770665;13980.300984950914;14388.28058597087;14471.131732096108;14600.634984125481;14647.926760366556;11344.716382090513;11475.770484590428;11485.425728713699;11717.238379505305;11977.281363118242;11615.361155136548;11710.180287379802;11797.17419780607;11965.880341196476;12083.275003499819 04:41:35 INFO - PROCESS | 893 | __end_tp_report 04:41:35 INFO - PROCESS | 893 | __start_cc_report 04:41:35 INFO - PROCESS | 893 | _x_x_mozilla_cycle_collect,364 04:41:35 INFO - PROCESS | 893 | __end_cc_report 04:41:35 INFO - PROCESS | 893 | __startTimestamp1468669295311__endTimestamp 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | ------- Summary: start ------- 04:41:35 INFO - PROCESS | 893 | Number of tests: 6 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | [#0] dojo.html Cycles:165 Average:5345.66 Median:5595.92 stddev:738.22 (13.2%) stddev-sans-first:717.77 04:41:35 INFO - PROCESS | 893 | Values: 3029.5 3052.6 3055.7 3059.2 3079.9 5387.6 5392.4 5398.0 5404.4 5431.7 5331.1 5383.2 5414.8 5458.2 5523.1 4887.7 4951.8 4953.9 5049.5 5056.5 280.7 4796.5 4842.7 4845.6 4991.6 4844.5 4845.9 4858.4 4866.9 4900.6 4844.4 4877.3 4885.0 4885.4 4895.1 4791.4 4825.5 4877.1 4904.1 4910.8 5400.5 5402.3 5402.9 5435.8 5461.0 5609.4 5815.1 5824.2 5830.9 5879.2 5818.2 5871.6 5911.7 5912.5 5933.6 5482.1 5486.0 5488.4 5508.5 5513.6 5741.2 5871.9 5965.6 6024.6 6029.8 5582.1 5583.6 5595.9 5621.6 5668.3 5787.2 5798.5 5807.1 5817.8 5823.1 5733.8 5761.0 5787.2 5795.2 5810.0 5805.9 5809.9 5829.5 5842.2 5845.0 4441.9 4461.0 4463.6 4466.1 4500.5 3895.1 3896.3 3897.4 3909.8 3919.7 5401.6 5489.7 5561.1 5583.4 5592.8 5870.8 5884.1 5890.2 5897.6 5897.8 5369.2 5491.5 5508.3 5542.3 5554.3 4947.6 4954.7 4996.7 5002.4 5042.6 5727.2 5944.3 5947.0 5958.3 5960.5 5692.6 5736.1 5738.9 5794.2 5798.3 5878.7 5892.4 5898.5 5918.4 5957.4 5614.8 5653.9 5694.4 5698.2 5753.6 5717.8 5767.5 5794.5 5813.4 5853.7 5631.9 5639.3 5653.7 5659.1 5659.2 5483.5 5600.2 5625.8 5642.8 5653.2 5645.2 5647.9 5649.9 5670.5 5720.8 5655.4 5672.1 5687.7 5704.9 5733.5 5457.2 5485.6 5523.9 5581.7 5617.4 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | [#1] ext.html Cycles:180 Average:67350.05 Median:43878.67 stddev:143494.34 (327.0%) stddev-sans-first:143809.28 04:41:35 INFO - PROCESS | 893 | Values: 571.1 574.9 592.7 599.9 631.1 40826.6 44670.6 44982.0 45068.5 45110.1 45613.8 46319.8 46463.0 46536.1 46555.3 8866.2 9017.1 9043.6 9045.2 9047.2 8866.8 8965.7 8992.6 8993.4 9028.6 9058.3 9067.9 9102.2 9116.6 9131.6 9038.6 9047.1 9072.5 9078.5 9088.7 8994.1 8999.9 9064.7 9072.6 9077.9 42795.6 42797.0 43232.4 43308.4 43329.0 3373.4 3514.6 3538.3 3561.9 3964.4 33679.7 34253.3 34311.1 34319.0 34517.7 4468.3 4484.7 4513.1 4531.0 4594.0 370500.0 370851.0 372033.0 373258.0 375314.0 32820.5 60872.4 61323.0 61449.1 61572.7 35157.0 36509.0 36759.3 36813.6 37016.0 15368.1 15694.5 15776.7 15796.9 15806.1 13092.8 13204.4 13209.5 13216.3 13261.0 8481.1 8503.6 8548.6 8588.2 8612.5 3223.7 3245.7 3260.2 3281.1 3288.9 1021.4 1026.8 1113.3 1132.8 1139.2 33588.7 33967.0 34014.7 34046.5 34293.3 1092.4 1098.7 1154.9 1171.7 1204.7 17640.6 17871.7 17898.3 17958.9 18356.9 628060.0 633179.0 634784.0 635478.0 636194.0 62652.0 63728.0 63817.7 63826.7 64071.4 1354.6 1401.9 1409.2 1411.8 1413.5 34523.3 35610.0 36021.8 36215.6 36678.8 55163.4 55247.0 55833.4 55998.3 56081.4 570359.0 570844.0 570973.0 571159.0 571686.0 29314.7 29516.0 29723.7 30000.1 30205.0 50649.7 51230.7 51561.7 51849.0 52348.7 43813.6 44039.0 44221.8 44579.6 45433.8 43708.3 43943.8 44282.3 44892.8 45481.0 42386.8 43358.6 44307.0 44536.8 44591.0 38360.4 38528.8 38727.4 38788.6 38789.8 29891.2 29961.9 29991.0 29993.0 30244.5 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | [#2] jquery.html Cycles:180 Average:28676.79 Median:23307.86 stddev:79136.69 (339.5%) stddev-sans-first:79330.18 04:41:35 INFO - PROCESS | 893 | Values: 383.8 384.7 386.5 393.4 410.3 14154.4 18845.8 19945.9 20284.9 20308.9 18820.2 19267.1 19550.0 19604.9 19688.4 5728.3 5884.8 5953.7 5959.3 5967.6 5755.1 5790.1 5821.4 5832.9 5867.5 5624.4 5706.9 5765.9 5802.1 5843.6 5701.9 5708.7 5724.1 5742.6 5758.2 5019.1 5030.8 5112.0 5120.4 5139.0 22707.3 23270.5 23345.2 23668.8 23718.0 2273.6 2514.9 2585.2 2945.5 3074.0 13925.2 14487.6 14604.2 14648.0 14786.2 1768.7 1800.9 1817.2 1897.2 1972.7 62507.0 75292.2 77097.2 80352.0 82501.6 10226.6 10683.4 10736.4 10787.3 10929.9 14665.5 14687.3 14690.9 14867.2 14877.6 7932.5 8480.6 8575.2 8674.7 8709.9 8532.4 8677.7 8678.8 8679.9 8686.1 6503.9 6531.5 6668.4 6669.7 6715.7 1849.6 1877.8 1882.8 1904.4 1948.2 977.6 988.6 1015.6 1067.6 1114.6 20955.5 21082.3 21288.5 21350.7 21487.9 1002.9 1015.6 1026.4 1027.5 1144.1 10583.3 10978.9 11648.5 11848.3 11911.8 462911.0 465985.0 471713.0 472100.0 525467.0 88748.0 91550.0 92856.0 94675.0 95721.0 1025.3 1057.2 1076.8 1083.5 1093.4 17052.7 17168.5 17185.5 17573.5 17679.1 29353.4 36578.3 42857.6 42890.8 44519.3 57625.0 57775.4 58126.0 59610.4 59704.4 7246.9 8162.8 8240.1 8538.5 8547.4 12232.9 12748.6 12821.4 12966.4 12994.1 10706.5 10892.7 11194.3 11246.4 11310.4 11110.7 11130.5 11145.0 11253.3 11287.5 11229.6 11241.0 11355.4 11519.5 11546.7 7270.3 7538.5 7603.4 7661.1 7888.1 10490.5 11289.0 11337.0 11421.5 11694.6 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | [#3] mootools.html Cycles:180 Average:5846.11 Median:2556.29 stddev:3307.53 (129.4%) stddev-sans-first:3300.45 04:41:35 INFO - PROCESS | 893 | Values: 1469.4 1470.7 1607.5 1762.1 1766.2 7740.5 8324.8 8390.2 8706.3 8728.8 8438.4 8689.1 8738.7 8760.6 8765.1 2322.5 2335.8 2338.6 2341.9 2348.4 2272.4 2298.6 2314.9 2322.4 2329.4 2324.2 2343.9 2348.3 2348.7 2353.2 2217.2 2224.1 2231.6 2235.6 2250.0 2218.9 2227.9 2231.3 2239.7 2245.0 8838.3 9042.9 9052.6 9056.0 9071.4 5136.0 5263.4 5303.0 5309.3 5317.1 3254.9 3365.4 3420.6 3453.5 3463.7 1289.3 1299.8 1300.2 1301.3 1328.5 12271.8 12406.8 12418.6 12422.1 12472.1 4530.3 4658.4 4802.6 4807.5 4813.9 10517.3 10553.3 10569.7 10586.0 10605.3 5333.4 5357.6 5359.1 5362.2 5372.7 4452.3 4823.7 4960.0 5002.1 5021.1 4091.4 4116.0 4124.5 4131.4 4170.1 1298.1 1333.9 1340.6 1346.6 1357.3 976.5 985.4 1005.0 1021.5 1036.7 5900.6 6001.2 6102.2 6122.0 6232.8 447.9 453.5 454.2 469.1 471.1 4442.8 4465.0 4467.5 4469.1 4469.6 10522.9 10896.2 10982.3 10995.6 11030.7 9899.8 10278.5 10828.9 10829.6 10865.0 8063.1 8173.2 8270.5 8310.5 8324.0 6032.8 6275.0 6339.5 6447.1 6475.6 10350.6 10394.6 10401.3 10421.5 10504.0 9909.3 10294.4 10297.6 10320.7 10346.7 7146.5 7476.6 7588.5 7771.0 8124.2 8497.8 8544.5 8565.2 8628.2 8630.9 7498.2 7641.3 7648.7 7741.7 7773.9 7403.3 7613.5 7711.4 7738.7 7755.2 7171.0 7184.0 7231.4 7243.7 7251.3 4996.3 5171.8 5305.2 5330.2 5356.7 5342.4 5361.6 5491.8 5502.5 5506.3 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | [#4] prototype.html Cycles:180 Average:4884.75 Median:5490.93 stddev:1436.68 (26.2%) stddev-sans-first:1399.07 04:41:35 INFO - PROCESS | 893 | Values: 309.8 313.6 326.1 327.2 331.6 5415.8 5442.5 5551.6 5634.5 5636.9 5529.7 5541.3 5620.0 5630.7 5632.7 4333.2 4336.2 4352.2 4353.7 4359.5 4166.5 4323.0 4331.7 4343.7 4349.2 4262.8 4263.6 4271.0 4292.7 4315.0 4330.5 4331.5 4337.8 4350.9 4366.9 3795.4 3825.6 3863.7 3869.0 3875.4 5401.8 5429.7 5430.2 5451.5 5452.2 4992.0 5017.0 5024.6 5031.7 5046.7 5702.9 5859.1 5867.5 5871.4 5891.0 4190.4 4203.4 4208.5 4212.2 4212.5 6043.4 6080.3 6083.6 6088.6 6097.7 4116.0 4322.0 4330.2 4394.6 4405.8 4346.3 4363.1 4377.0 4398.5 4402.4 4965.2 5031.6 5039.1 5047.0 5049.5 5786.7 5867.3 5894.9 5923.4 5982.3 1497.6 1504.6 1513.3 1516.6 1519.4 956.0 967.1 984.7 989.7 994.4 5011.3 5015.6 5052.9 5060.9 5096.3 5217.3 5234.9 5241.7 5280.6 5294.5 5011.9 5052.4 5075.0 5288.5 5727.9 3183.6 3193.0 3202.5 3209.8 3216.8 6044.5 6185.5 6208.6 6215.8 6251.7 6026.8 6098.5 6114.3 6128.3 6134.9 6172.0 6224.8 6226.2 6237.6 6238.1 5862.9 5958.6 6004.5 6007.5 6057.8 5926.5 5926.9 5933.2 5947.3 5987.6 5554.9 6117.7 6153.6 6188.7 6199.8 4125.5 4145.5 4151.8 4166.3 4181.9 5979.2 6011.1 6092.4 6101.6 6113.9 5685.7 5864.7 5865.6 5866.0 5917.6 5768.7 5803.7 5835.6 5844.5 5892.6 5537.4 5833.9 5837.8 5848.9 5854.6 5905.7 5916.4 5935.7 5937.3 5946.5 5781.5 5795.6 5804.9 5810.1 5871.1 04:41:35 INFO - PROCESS | 893 | 04:41:35 INFO - PROCESS | 893 | [#5] yui.html Cycles:180 Average:20113.36 Median:4197.85 stddev:28597.97 (681.3%) stddev-sans-first:28641.10 04:41:35 INFO - PROCESS | 893 | Values: 713.9 718.3 741.1 754.7 767.8 15238.8 16408.9 16434.9 16465.7 16500.6 13485.4 13740.2 13804.4 13834.4 13880.8 636.5 786.6 789.4 813.9 816.1 812.6 816.1 816.5 817.4 818.4 857.1 857.9 858.3 858.9 867.0 848.3 852.0 855.3 856.8 857.5 620.4 627.8 629.7 631.0 633.1 14699.4 14756.6 14771.5 14843.4 14871.0 13758.0 14430.9 14823.9 14893.3 14927.6 11996.5 12033.2 12128.3 12239.8 12367.4 3881.2 3893.7 3912.3 3964.1 3968.3 71235.6 71977.0 73685.6 74851.6 74864.6 11485.3 11537.7 11562.0 11797.5 11877.0 20994.5 21107.3 21124.8 21168.9 21175.8 7890.3 7984.5 7995.3 8265.1 8427.0 4609.3 4769.0 4788.4 4824.1 4925.8 3251.6 3290.5 3345.0 3360.6 3364.6 597.8 606.4 609.5 616.8 628.7 729.4 735.7 744.6 746.9 747.4 9257.5 9636.8 9945.3 10114.8 10444.8 620.8 677.8 705.9 713.2 744.3 4427.4 4889.6 4978.2 5007.7 5014.3 92646.0 114934.4 117631.0 119790.0 120953.0 101389.5 102970.0 103008.0 103107.0 103278.5 55545.4 56594.7 56649.7 58327.0 63861.0 8482.4 8637.9 8640.1 8663.1 8722.2 50737.0 50750.0 51844.4 51859.0 51998.5 73218.6 74689.0 75922.6 75966.6 77881.6 13653.4 13659.9 13723.2 13734.9 13778.6 13831.7 14337.1 14426.0 15274.2 15310.5 13893.2 14026.2 14460.2 14892.6 14997.8 14159.0 14465.7 14610.2 14648.6 14800.2 13980.3 14388.3 14471.1 14600.6 14647.9 11344.7 11475.8 11485.4 11717.2 11977.3 11615.4 11710.2 11797.2 11965.9 12083.3 04:41:35 INFO - PROCESS | 893 | -------- Summary: end -------- 04:41:35 INFO - PROCESS | 893 | 04:41:36 INFO - TEST-INFO | 893: exit 0 04:41:36 INFO - TEST-OK | dromaeo_css | took 1111467ms 04:41:36 INFO - TEST-START | kraken 04:41:36 INFO - operating with platform_type : linux_ 04:41:36 INFO - Initialising browser for kraken test... 04:41:36 INFO - TEST-INFO | started process 1212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdRM5F/profile http://localhost:50234/getInfo.html) 04:41:40 INFO - PROCESS | 1212 | __metrics Screen width/height:1600/1200 04:41:40 INFO - PROCESS | 1212 | colorDepth:24 04:41:40 INFO - PROCESS | 1212 | Browser inner width/height: 1024/697 04:41:40 INFO - PROCESS | 1212 | __metrics 04:41:41 ERROR - PROCESS | 1212 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:41:42 INFO - TEST-INFO | 1212: exit 0 04:41:42 INFO - Browser initialized. 04:41:42 INFO - Running cycle 1/1 for kraken test... 04:41:42 INFO - TEST-INFO | started process 1343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdRM5F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:54 INFO - PROCESS | 1343 | RSS: Main: 167714816 04:41:54 INFO - PROCESS | 1343 | 04:41:56 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50234/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:57 INFO - PROCESS | 1343 | RSS: Main: 173002752 04:41:57 INFO - PROCESS | 1343 | 04:42:00 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50234/tests/kraken/driver.html?testName=audio-dft) 04:42:00 INFO - PROCESS | 1343 | RSS: Main: 172474368 04:42:00 INFO - PROCESS | 1343 | 04:42:03 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50234/tests/kraken/driver.html?testName=audio-fft) 04:42:04 INFO - PROCESS | 1343 | RSS: Main: 166883328 04:42:04 INFO - PROCESS | 1343 | 04:42:06 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50234/tests/kraken/driver.html?testName=audio-oscillator) 04:42:07 INFO - PROCESS | 1343 | RSS: Main: 167866368 04:42:07 INFO - PROCESS | 1343 | 04:42:09 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:09 INFO - PROCESS | 1343 | RSS: Main: 168275968 04:42:09 INFO - PROCESS | 1343 | 04:42:12 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50234/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:13 INFO - PROCESS | 1343 | RSS: Main: 168300544 04:42:13 INFO - PROCESS | 1343 | 04:42:17 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50234/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:17 INFO - PROCESS | 1343 | RSS: Main: 166313984 04:42:17 INFO - PROCESS | 1343 | 04:42:20 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50234/tests/kraken/driver.html?testName=json-parse-financial) 04:42:21 INFO - PROCESS | 1343 | RSS: Main: 168083456 04:42:21 INFO - PROCESS | 1343 | 04:42:22 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:23 INFO - PROCESS | 1343 | RSS: Main: 168497152 04:42:23 INFO - PROCESS | 1343 | 04:42:25 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:25 INFO - PROCESS | 1343 | RSS: Main: 168321024 04:42:25 INFO - PROCESS | 1343 | 04:42:27 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:28 INFO - PROCESS | 1343 | RSS: Main: 169418752 04:42:28 INFO - PROCESS | 1343 | 04:42:31 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:31 INFO - PROCESS | 1343 | RSS: Main: 169537536 04:42:31 INFO - PROCESS | 1343 | 04:42:34 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:35 INFO - PROCESS | 1343 | RSS: Main: 169037824 04:42:35 INFO - PROCESS | 1343 | 04:42:36 INFO - PROCESS | 1343 | Cycle 1(1): loaded http://localhost:50234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50234/tests/kraken/driver.html?testName=ai-astar) 04:42:36 INFO - PROCESS | 1343 | RSS: Main: 169304064 04:42:36 INFO - PROCESS | 1343 | 04:42:36 INFO - PROCESS | 1343 | __start_tp_report 04:42:36 INFO - PROCESS | 1343 | _x_x_mozilla_page_load 04:42:36 INFO - PROCESS | 1343 | _x_x_mozilla_page_load_details 04:42:36 INFO - PROCESS | 1343 | |i|pagename|runs| 04:42:36 INFO - PROCESS | 1343 | |0;ai-astar;101;110;107;110;113;112;112;111;111;111 04:42:36 INFO - PROCESS | 1343 | |1;audio-beat-detection;150;119;148;171;123;146;153;118;184;124 04:42:36 INFO - PROCESS | 1343 | |2;audio-dft;164;163;171;163;164;165;183;164;161;161 04:42:36 INFO - PROCESS | 1343 | |3;audio-fft;74;82;76;167;77;75;76;74;169;75 04:42:36 INFO - PROCESS | 1343 | |4;audio-oscillator;85;84;155;86;84;84;152;85;84;143 04:42:36 INFO - PROCESS | 1343 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;117;117;117 04:42:36 INFO - PROCESS | 1343 | |6;imaging-darkroom;147;149;147;147;149;147;148;147;148;147 04:42:36 INFO - PROCESS | 1343 | |7;imaging-desaturate;96;97;95;96;96;97;95;96;96;95 04:42:36 INFO - PROCESS | 1343 | |8;json-parse-financial;51;56;52;52;54;52;63;53;55;52 04:42:36 INFO - PROCESS | 1343 | |9;json-stringify-tinderbox;62;62;62;62;63;62;61;62;61;62 04:42:36 INFO - PROCESS | 1343 | |10;stanford-crypto-aes;81;76;75;76;75;81;76;75;79;75 04:42:36 INFO - PROCESS | 1343 | |11;stanford-crypto-ccm;121;120;128;125;131;144;121;123;164;139 04:42:36 INFO - PROCESS | 1343 | |12;stanford-crypto-pbkdf2;157;157;167;159;159;158;156;158;159;157 04:42:36 INFO - PROCESS | 1343 | |13;stanford-crypto-sha256-iterative;67;66;64;64;65;64;68;67;63;66 04:42:36 INFO - PROCESS | 1343 | __end_tp_report 04:42:36 INFO - PROCESS | 1343 | __start_cc_report 04:42:36 INFO - PROCESS | 1343 | _x_x_mozilla_cycle_collect,918 04:42:36 INFO - PROCESS | 1343 | __end_cc_report 04:42:36 INFO - PROCESS | 1343 | __startTimestamp1468669356988__endTimestamp 04:42:36 INFO - PROCESS | 1343 | 04:42:36 INFO - PROCESS | 1343 | ------- Summary: start ------- 04:42:36 INFO - PROCESS | 1343 | Number of tests: 14 04:42:36 INFO - PROCESS | 1343 | 04:42:36 INFO - PROCESS | 1343 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.49 (3.1%) stddev-sans-first:1.72 04:42:36 INFO - PROCESS | 1343 | Values: 101.0 110.0 107.0 110.0 113.0 112.0 112.0 111.0 111.0 111.0 04:42:36 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:149.00 stddev:22.62 (15.2%) stddev-sans-first:23.88 04:42:37 INFO - PROCESS | 1343 | Values: 150.0 119.0 148.0 171.0 123.0 146.0 153.0 118.0 184.0 124.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#2] audio-dft Cycles:10 Average:165.90 Median:164.00 stddev:6.62 (4.0%) stddev-sans-first:6.99 04:42:37 INFO - PROCESS | 1343 | Values: 164.0 163.0 171.0 163.0 164.0 165.0 183.0 164.0 161.0 161.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.50 stddev:38.81 (51.4%) stddev-sans-first:40.45 04:42:37 INFO - PROCESS | 1343 | Values: 74.0 82.0 76.0 167.0 77.0 75.0 76.0 74.0 169.0 75.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:84.00 stddev:31.75 (37.8%) stddev-sans-first:32.91 04:42:37 INFO - PROCESS | 1343 | Values: 85.0 84.0 155.0 86.0 84.0 84.0 152.0 85.0 84.0 143.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:42:37 INFO - PROCESS | 1343 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 04:42:37 INFO - PROCESS | 1343 | Values: 147.0 149.0 147.0 147.0 149.0 147.0 148.0 147.0 148.0 147.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 04:42:37 INFO - PROCESS | 1343 | Values: 96.0 97.0 95.0 96.0 96.0 97.0 95.0 96.0 96.0 95.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:3.53 (6.6%) stddev-sans-first:3.57 04:42:37 INFO - PROCESS | 1343 | Values: 51.0 56.0 52.0 52.0 54.0 52.0 63.0 53.0 55.0 52.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 04:42:37 INFO - PROCESS | 1343 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 61.0 62.0 61.0 62.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:2.47 (3.2%) stddev-sans-first:2.13 04:42:37 INFO - PROCESS | 1343 | Values: 81.0 76.0 75.0 76.0 75.0 81.0 76.0 75.0 79.0 75.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:129.50 stddev:13.94 (10.8%) stddev-sans-first:14.25 04:42:37 INFO - PROCESS | 1343 | Values: 121.0 120.0 128.0 125.0 131.0 144.0 121.0 123.0 164.0 139.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:158.50 stddev:3.09 (2.0%) stddev-sans-first:3.22 04:42:37 INFO - PROCESS | 1343 | Values: 157.0 157.0 167.0 159.0 159.0 158.0 156.0 158.0 159.0 157.0 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - PROCESS | 1343 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.64 04:42:37 INFO - PROCESS | 1343 | Values: 67.0 66.0 64.0 64.0 65.0 64.0 68.0 67.0 63.0 66.0 04:42:37 INFO - PROCESS | 1343 | -------- Summary: end -------- 04:42:37 INFO - PROCESS | 1343 | 04:42:37 INFO - TEST-INFO | 1343: exit 0 04:42:38 INFO - TEST-OK | kraken | took 61978ms 04:42:38 INFO - SUITE-END | took 1173s 04:42:38 INFO - Completed test suite (00:19:33) 04:42:38 INFO - javascript benchmark 04:42:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7299.79735918339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.5455681647763, 3052.6184226971627, 3055.6944305569446, 3059.204606802231, 3079.923001924952, 5387.595930305228, 5392.352917649878, 5397.973010134949, 5404.432534583871, 5431.674099554019, 5331.147016477365, 5383.192521121834, 5414.756335964881, 5458.235846981426, 5523.1163013917785, 4887.731174785395, 4951.77717002734, 4953.851384458472, 5049.468124674541, 5056.544910958013, 280.7191363758335, 4796.472388037313, 4842.733649649268, 4845.588125009378, 4991.600671946236, 4844.539768721966, 4845.927311090319, 4858.441279252896, 4866.878328041792, 4900.607951363882, 4844.394450693663, 4877.268409738567, 4884.975575122137, 4885.43817460993, 4895.11887860185, 4791.401074865642, 4825.469198388175, 4877.146499362598, 4904.117258893398, 4910.779014944301, 5400.540954018874, 5402.297701298845, 5402.91895621566, 5435.83692489226, 5460.972695136538, 5609.439056094398, 5815.069588865804, 5824.24284842972, 5830.854228644275, 5879.235699359098, 5818.243628328332, 5871.55963302754, 5911.733971971272, 5912.526997840162, 5933.554983376221, 5482.068048431736, 5485.9725701371235, 5488.396276409591, 5508.531774799107, 5513.61404701667, 5741.19623252745, 5871.882562348729, 5965.55258355625, 6024.57827952048, 6029.758809647653, 5582.051051321285, 5583.637063590853, 5595.916061259084, 5621.634593751393, 5668.348139963874, 5787.247657804459, 5798.507126894261, 5807.070868660994, 5817.825465236049, 5823.126531020296, 5733.77064917407, 5760.971195143998, 5787.2187254720075, 5795.217645617788, 5810.041343178328, 5805.94194058054, 5809.8547536311935, 5829.504492118217, 5842.182094506772, 5845.006348920694, 4441.888952776207, 4460.977695111568, 4463.575960283768, 4466.0844526871915, 4500.527444618333, 3895.0651843557907, 3896.2597106549665, 3897.3569361055675, 3909.8045097745, 3919.7256192066284, 5401.6218864679095, 5489.698066606375, 5561.110222364402, 5583.4137415571595, 5592.804251851166, 5870.823875283749, 5884.117382392676, 5890.204822348928, 5897.616654917417, 5897.7935772247765, 5369.194620806832, 5491.505764481216, 5508.338999320027, 5542.279503664578, 5554.305711786027, 4947.554720075211, 4954.653174277766, 4996.725180115129, 5002.424721157041, 5042.647014708935, 5727.2268243787385, 5944.316403613553, 5947.0, 5958.314793798682, 5960.4635582797755, 5692.573057020657, 5736.053551164011, 5738.856528586652, 5794.246747922743, 5798.304203495608, 5878.735456904535, 5892.440218179266, 5898.469137777621, 5918.378570250062, 5957.434043765836, 5614.803481878114, 5653.886922261449, 5694.402087780723, 5698.1737648041635, 5753.626014309057, 5717.799877004285, 5767.5385969121535, 5794.507466865363, 5813.389594092729, 5853.707314634166, 5631.8592035199445, 5639.295088113986, 5653.745581448927, 5659.066254068197, 5659.179418984307, 5483.506484416422, 5600.243967064394, 5625.774969001358, 5642.830715078554, 5653.208550802973, 5645.1532270159805, 5647.887042259214, 5649.943500564942, 5670.546356291405, 5720.771169153188, 5655.377908430151, 5672.092465205547, 5687.687177205294, 5704.885902281848, 5733.483986441241, 5457.235986961749, 5485.561155107662, 5523.8895222096135, 5581.665100094007, 5617.4101719320515], "value": 5296.219407119918, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.1404336473606, 574.8993926062938, 592.6740292838938, 599.913012613171, 631.1164369882162, 40826.59173408265, 44670.55329446705, 44981.99999999992, 45068.54931450685, 45110.09779804402, 45613.77193114038, 46319.76840115803, 46463.0, 46536.069278614406, 46555.30167047497, 8866.20204181622, 9017.098290170996, 9043.638254469814, 9045.23115535177, 9047.185753282203, 8866.822663546725, 8965.731028069136, 8992.640294388217, 8993.415427997159, 9028.638854445815, 9058.275337972946, 9067.909320906772, 9102.180803727662, 9116.58975346111, 9131.634734610607, 9038.638454461814, 9047.095290470967, 9072.455652660861, 9078.54607269634, 9088.727338179866, 8994.0556241595, 8999.910000899972, 9064.68273610427, 9072.591733372014, 9077.863832042525, 42795.57204427947, 42797.0, 43232.35151472731, 43308.350374744405, 43329.0, 3373.3590617782543, 3514.61339252682, 3538.2569660371355, 3561.857525698969, 3964.385520244338, 33679.6632033679, 34253.314933701186, 34311.14222144442, 34319.0, 34517.65482345194, 4468.307412351059, 4484.708493947883, 4513.074819661962, 4530.954690453086, 4594.035252596958, 370500.0, 370851.0, 372032.99999999726, 373258.0, 375314.0, 32820.507692384635, 60872.39127608756, 61323.0, 61449.07826382608, 61572.69213653903, 35157.0, 36509.0, 36759.26481470356, 36813.631863681556, 37016.0, 15368.077915325117, 15694.529164125095, 15776.68446631061, 15796.921015395079, 15806.130662813655, 13092.803607945889, 13204.405801738945, 13209.471621135048, 13216.273104979125, 13261.0, 8481.109483504266, 8503.574821258911, 8548.572571371407, 8588.184122508352, 8612.526311052827, 3223.693749093832, 3245.6754324567355, 3260.1523603863166, 3281.0648965044848, 3288.852001659931, 1021.4126877045728, 1026.7923963478431, 1113.3041848844473, 1132.7709435262832, 1139.225326777799, 33588.664113359046, 33967.0, 34014.659853401645, 34046.48930266048, 34293.314133717686, 1092.378292098953, 1098.6758906122552, 1154.936478493674, 1171.718787491013, 1204.692803335144, 17640.558986025197, 17871.73192402115, 17898.28406863711, 17958.91020544889, 18356.908215459105, 628060.0, 633179.0, 634784.0, 635478.0, 636194.0, 62652.0, 63728.0, 63817.68091159515, 63826.68086659537, 64071.359286406536, 1354.593621913422, 1401.922894240806, 1409.1615488784362, 1411.8023476713267, 1413.547664747271, 34523.30953380968, 35610.0, 36021.81989090038, 36215.63784362228, 36678.81660591787, 55163.44836551583, 55247.0, 55833.441665582824, 55998.32005039855, 56081.43918560762, 570359.0, 570844.0, 570973.0, 571159.0, 571686.0, 29314.7068529312, 29516.0, 29723.702762972094, 30000.099997000125, 30205.0, 50649.74675126601, 51230.74384628053, 51561.7421912903, 51849.0, 52348.738256309996, 43813.56186438095, 44039.0, 44221.778891105336, 44579.55420445754, 45433.77283113563, 43708.34437483504, 43943.78028109839, 44282.3357649629, 44892.77553612211, 45481.0, 42386.788066059475, 43358.61527615885, 44307.0, 44536.77731611321, 44591.0, 38360.42459363056, 38528.80735596416, 38727.419088714254, 38788.6121138785, 38789.836304910896, 29891.187647626204, 29961.850190748908, 29991.0, 29993.0, 30244.54633180548], "value": 19898.683353314253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8004237796345, 384.72876621981504, 386.51299362802877, 393.3713983766089, 410.3454989292078, 14154.433822647108, 18845.811541884577, 19945.900270498627, 20284.89857550712, 20308.89845550772, 18820.24719011238, 19267.132979015943, 19550.0, 19604.901975490102, 19688.409347719557, 5728.255326807509, 5884.76460941564, 5953.732082056296, 5959.255093113361, 5967.6419414835245, 5755.136729490568, 5790.13148027795, 5821.3887541808135, 5832.883342333151, 5867.501262392701, 5624.3813180550105, 5706.914396284059, 5765.884682306351, 5802.071668533035, 5843.620164689281, 5701.914471282934, 5708.686022268774, 5724.112762521795, 5742.569307301948, 5758.193852860602, 5019.096562618727, 5030.8239211627415, 5111.974440127776, 5120.3855537335385, 5138.974305128488, 22707.318780436613, 23270.53458930829, 23345.182918597766, 23668.763312367002, 23718.0, 2273.624851899435, 2514.8742562871785, 2585.172744721671, 2945.4698154332214, 3073.9673390970374, 13925.23411212383, 14487.637809054753, 14604.196769177692, 14648.0, 14786.18675972821, 1768.6816373052845, 1800.8649351298575, 1817.2095138614745, 1897.1652472912012, 1972.7336809530673, 62507.0, 75292.24707752907, 77097.229027709, 80352.0, 82501.58749206275, 10226.6420675276, 10683.412412317397, 10736.443215733674, 10787.298825576312, 10929.868675608339, 14665.48670796517, 14687.26563671812, 14690.926545367205, 14867.18230497333, 14877.628059298604, 7932.484388514728, 8480.618372173267, 8575.228229459379, 8674.6530138795, 8709.869351959725, 8532.402731808837, 8677.696280630147, 8678.826423471495, 8679.913200868037, 8686.087960764155, 6503.869922601616, 6531.4651057001565, 6668.366505182, 6669.666516674147, 6715.6977935993, 1849.5930895203035, 1877.8029705244896, 1882.830545250934, 1904.4477101640646, 1948.162290215221, 977.5747549815853, 988.6292640259902, 1015.5836107196014, 1067.5854492797075, 1114.6266000889793, 20955.476113097295, 21082.262120825697, 21288.467788305108, 21350.679739803603, 21487.892560537097, 1002.8646132771983, 1015.5836107196162, 1026.3585259212991, 1027.5170669785189, 1144.0504381363448, 10583.31208471447, 10978.945105274423, 11648.534058637559, 11848.28910265387, 11911.76176476483, 462911.0, 465985.0, 471713.0, 472100.0, 525467.0, 88748.0, 91550.0, 92856.0, 94675.0, 95721.0, 1025.266934142092, 1057.180684969155, 1076.8061748885275, 1083.544911137324, 1093.436880006797, 17052.65894682124, 17168.484945451655, 17185.484435466955, 17573.472795816146, 17679.116044197996, 29353.412931741674, 36578.26843463169, 42857.57142428536, 42890.78554607207, 44519.33221001752, 57625.0, 57775.422245777, 58126.0, 59610.40389596049, 59704.40295597162, 7246.855062898818, 8162.795930101557, 8240.093589705008, 8538.487690738575, 8547.358948078794, 12232.877671223174, 12748.61754147377, 12821.358932053174, 12966.35168241603, 12994.090413670952, 10706.464676765974, 10892.727681808019, 11194.328340299608, 11246.437678116225, 11310.434478276218, 11110.666679999613, 11130.499127539118, 11145.0, 11253.324800511995, 11287.548498060314, 11229.55081796719, 11241.04451121631, 11355.432228388712, 11519.481623326803, 11546.653600392001, 7270.309320614533, 7538.472306938462, 7603.4297427694255, 7661.118971318369, 7888.132305446511, 10490.475476226311, 11289.0, 11337.03635190985, 11421.486033128695, 11694.649160524858], "value": 9360.334198511708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.404891019137, 1470.6838029823587, 1607.4615003973668, 1762.1013283225552, 1766.178726891995, 7740.458167928247, 8324.791880202998, 8390.202930721587, 8706.303495720344, 8728.781780455492, 8438.367122465808, 8689.087645797195, 8738.694145704902, 8760.605772740226, 8765.123487651248, 2322.4542232575373, 2335.7781010803947, 2338.555674421863, 2341.906323747048, 2348.3894187511287, 2272.3750968483632, 2298.5747636687183, 2314.8611083334968, 2322.4310044039235, 2329.37106981115, 2324.174917904145, 2343.929682109531, 2348.3072493614427, 2348.659444380564, 2353.2234362660365, 2217.2018073493527, 2224.088123869214, 2231.5983123037927, 2235.552889422114, 2250.032486031006, 2218.866867987926, 2227.866328020324, 2231.34175418252, 2239.742429620598, 2245.0, 8838.337124715608, 9042.86435703465, 9052.637894484213, 9056.0, 9071.410358326688, 5135.97280543889, 5263.36839579253, 5302.965921645281, 5309.309789727349, 5317.096093664087, 3254.902352929416, 3365.3605814895336, 3420.572428446444, 3453.4647129694936, 3463.6709512596262, 1289.3424353579649, 1299.7595444842639, 1300.193879794524, 1301.2517802263735, 1328.48853191521, 12271.815922761165, 12406.81389779154, 12418.56535021279, 12422.130450868442, 12472.0645951554, 4530.275155975029, 4658.416138512922, 4802.591779698765, 4807.495213002654, 4813.855584332476, 10517.263791534671, 10553.261271710906, 10569.735756606146, 10586.047255746866, 10605.310654807412, 5333.386660534011, 5357.598180136428, 5359.062164121263, 5362.168863826113, 5372.7313634318125, 4452.265376212888, 4823.710577365369, 4960.007998400334, 5002.124628190052, 5021.121303771825, 4091.4067460218102, 4116.029804359067, 4124.484439445069, 4131.442255295557, 4170.103427763045, 1298.0913360647585, 1333.9266340351373, 1340.5844188301658, 1346.6364081697886, 1357.2670757790681, 976.4580657734883, 985.4186030242191, 1004.9899501005043, 1021.5352014833232, 1036.6630844975261, 5900.616459930091, 6001.219841420588, 6102.176206212193, 6122.0, 6232.844178895564, 447.91937451258434, 453.47170546313174, 454.1734044039816, 469.08294284673383, 471.0884438611298, 4442.777861106932, 4465.0, 4467.463904331501, 4469.10617876426, 4469.642428605704, 10522.894771052344, 10896.18278629106, 10982.341059536293, 10995.615153469591, 11030.724231894106, 9899.752506187258, 10278.486075696186, 10828.891711082946, 10829.566817327377, 10865.0, 8063.1130575636635, 8173.223543763333, 8270.545120018456, 8310.459820111673, 8324.0, 6032.819015429544, 6275.0, 6339.524535659936, 6447.097406363207, 6475.579087359307, 10350.637727679496, 10394.636187733393, 10401.323913945569, 10421.531031103466, 10504.0, 9909.256805739455, 10294.3823370598, 10297.588096476056, 10320.741981450525, 10346.689599312032, 7146.499745017799, 7476.5514069156025, 7588.506747061423, 7770.961145194238, 8124.22819832115, 8497.787555311166, 8544.530050847263, 8565.186307300797, 8628.180322869317, 8630.870536941826, 7498.212687667935, 7641.2740789624895, 7648.73229436967, 7741.729039483591, 7773.883391749241, 7403.259674032553, 7613.5431874087735, 7711.3830893527265, 7738.729144480141, 7755.224477552425, 7171.0, 7183.95832604259, 7231.4214862811905, 7243.710251589878, 7251.311125443074, 4996.325496058131, 5171.81898633546, 5305.1776974569, 5330.227117068081, 5356.651817631841, 5342.43904390049, 5361.571074313967, 5491.835244942658, 5502.504774570148, 5506.33923929115], "value": 4622.467641884072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.834238682305, 313.57510573173334, 326.05931886507426, 327.23916893223253, 331.6401704150996, 5415.810446634368, 5442.482964118402, 5551.611387202897, 5634.549236061115, 5636.915446268299, 5529.668219906808, 5541.254504830976, 5620.0, 5630.662160270386, 5632.690202038886, 4333.180064372955, 4336.241157797389, 4352.194843953863, 4353.651707863379, 4359.542248063955, 4166.458360413158, 4322.956770432287, 4331.7184383015165, 4343.717658352213, 4349.195398851222, 4262.78686065697, 4263.616274535291, 4271.0, 4292.65658747301, 4314.956850431503, 4330.523642399334, 4331.4802223733195, 4337.804798784046, 4350.8912277193, 4366.908272931767, 3795.3927371620684, 3825.6365645263654, 3863.74885632433, 3868.9806550967346, 3875.418687196915, 5401.756920938567, 5429.728513574345, 5430.212619170237, 5451.536619387357, 5452.182172674091, 4991.975040124777, 5017.0, 5024.623153263483, 5031.716912187406, 5046.697198168122, 5702.857428564277, 5859.091840764646, 5867.530597552186, 5871.442212989759, 5890.970545147246, 4190.350495673176, 4203.432536607549, 4208.452901122865, 4212.199682060429, 4212.53662097169, 6043.365446628085, 6080.270367555878, 6083.634981901056, 6088.630058236906, 6097.688996865651, 4115.9588404116175, 4321.962728945031, 4330.17726631939, 4394.626456751148, 4405.801738921757, 4346.304941072984, 4363.102050607996, 4376.978115109468, 4398.450193725785, 4402.449693788277, 4965.1807451770055, 5031.622628302892, 5039.143345631252, 5046.9747651261505, 5049.495050494921, 5786.71066446676, 5867.325257595346, 5894.850504151735, 5923.4076592340425, 5982.312034116046, 1497.610621238486, 1504.601280660626, 1513.2585033333808, 1516.6435887566413, 1519.3618680154361, 955.9904400956041, 967.1489089601106, 984.7488890333062, 989.737719504332, 994.4480813148772, 5011.298418221452, 5015.598752099823, 5052.91362357095, 5060.924086138711, 5096.337476128154, 5217.287010754387, 5234.869128271824, 5241.659292145999, 5280.551153151949, 5294.517535090181, 5011.899762004812, 5052.418971818288, 5075.0, 5288.524032836986, 5727.8854422912145, 3183.5702180205376, 3193.042087373825, 3202.4876019836715, 3209.8234597096916, 3216.774825762221, 6044.516438684895, 6185.474234690102, 6208.596441231305, 6215.844603884939, 6251.686606098775, 6026.849328766816, 6098.451139397475, 6114.296855861633, 6128.3258841527395, 6134.877302453926, 6172.024952015312, 6224.751009959551, 6226.159468471789, 6237.625742455376, 6238.1266622672865, 5862.863368098047, 5958.582899197015, 6004.459598636144, 6007.519398448027, 6057.7879774207695, 5926.4666180044005, 5926.911096333644, 5933.228680271537, 5947.3457919627945, 5987.5808693391045, 5554.916676249779, 6117.724702388492, 6153.630782153085, 6188.710177234272, 6199.783007594712, 4125.484314460692, 4145.523264824584, 4151.8339266429, 4166.270902591974, 4181.853635122756, 5979.162917191684, 6011.128386384037, 6092.360302168208, 6101.627133894838, 6113.877722445615, 5685.658860468385, 5864.706764661835, 5865.618734782225, 5866.011112443579, 5917.556183286185, 5768.740406681625, 5803.738831752666, 5835.591508594358, 5844.503217226584, 5892.587518873637, 5537.390887002507, 5833.883322333614, 5837.766489340549, 5848.87085409304, 5854.648721076749, 5905.704714764331, 5916.378780228014, 5935.664475492979, 5937.287525496968, 5946.45392198023, 5781.479666830005, 5795.638025064022, 5804.94195058044, 5810.099434587646, 5871.1486834409625], "value": 4419.854794692598, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9393151582112, 718.2888939949452, 741.0625558668286, 754.6566312327891, 767.7965339185121, 15238.771418428718, 16408.917955410205, 16434.917825410856, 16465.67068658626, 16500.587485312873, 13485.39315730792, 13740.24428656426, 13804.44782208713, 13834.446622135129, 13880.791788123186, 636.5289685632645, 786.5516655506349, 789.376392649806, 813.8860559521672, 816.0941355095839, 812.569338250728, 816.143049797713, 816.4896939412866, 817.3992115794886, 818.4025661267278, 857.1471385970967, 857.8798968144465, 858.2533196119385, 858.8926384201975, 867.0029466113956, 848.3213429256601, 851.9957400213021, 855.3029281135886, 856.7686724584328, 857.5412154497315, 620.419907386595, 627.7865525721231, 629.672570263465, 630.987380252397, 633.0504243634548, 14699.412023519046, 14756.631084222872, 14771.482998095014, 14843.406263749437, 14871.0, 13758.0, 14430.855691443056, 14823.925880370529, 14893.32980015891, 14927.626809329746, 11996.460159292765, 12033.217785979718, 12128.272303661808, 12239.75520489594, 12367.381630918508, 3881.1849511602595, 3893.669038131734, 3912.2762288976633, 3964.0882597002565, 3968.265870813909, 71235.64382178056, 71977.0, 73685.63157184233, 74851.62574187148, 74864.62567687182, 11485.310881347146, 11537.653870383901, 11562.0, 11797.52809887595, 11877.0, 20994.475138121365, 21107.26124585632, 21124.78875211259, 21168.894155529124, 21175.78824211769, 7890.250426209501, 7984.520928744294, 7995.320397766255, 8265.090840007595, 8426.957865210634, 4609.316491087869, 4768.976155119271, 4788.353572267769, 4824.107540105092, 4925.7783399747095, 3251.5772949516413, 3290.5393244945726, 3345.0, 3360.5799275090612, 3364.6205055926953, 597.8116893178635, 606.3633185155658, 609.4880300547561, 616.7779599344233, 628.7233617208414, 729.4018904498366, 735.7424901284508, 744.6053591596354, 746.895434639151, 747.3871425431203, 9257.537123143817, 9636.807263854684, 9945.254105941938, 10114.797704045877, 10444.843327350096, 620.7641096383345, 677.7797215904851, 705.8941158826217, 713.165596252386, 744.3003576637943, 4427.424434823452, 4889.559939605381, 4978.153713868651, 5007.674501157413, 5014.2979982802435, 92646.0, 114934.4253278745, 117631.0, 119790.0, 120953.0, 101389.49305253573, 102970.0, 103008.0, 103107.0, 103278.48360758148, 55545.444545554834, 56594.717026414604, 56649.7167514168, 58326.99999999915, 63861.0, 8482.406231563731, 8637.913620863963, 8640.135986401561, 8663.133686631287, 8722.171393717586, 50737.0, 50750.0, 51844.44466666006, 51858.96282074413, 51998.480015200876, 73218.63390683013, 74689.0, 75922.62038689772, 75966.6201668988, 77881.61059194668, 13653.385597648328, 13659.931700341434, 13723.176609403468, 13734.862651373758, 13778.586642400744, 13831.723365532433, 14337.139771613736, 14426.0, 15274.236288185324, 15310.540683779505, 13893.166410015432, 14026.158430493795, 14460.20468874222, 14892.62768430798, 14997.77503337429, 14159.0, 14465.710685786014, 14610.196439195946, 14648.560543183721, 14800.185989770665, 13980.300984950914, 14388.28058597087, 14471.131732096108, 14600.634984125481, 14647.926760366556, 11344.716382090513, 11475.770484590428, 11485.425728713699, 11717.238379505305, 11977.281363118242, 11615.361155136548, 11710.180287379802, 11797.17419780607, 11965.880341196476, 12083.275003499819], "value": 7506.853952346615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 107.0, 110.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 148.0, 171.0, 123.0, 146.0, 153.0, 118.0, 184.0, 124.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 171.0, 163.0, 164.0, 165.0, 183.0, 164.0, 161.0, 161.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 76.0, 167.0, 77.0, 75.0, 76.0, 74.0, 169.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 155.0, 86.0, 84.0, 84.0, 152.0, 85.0, 84.0, 143.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 56.0, 52.0, 52.0, 54.0, 52.0, 63.0, 53.0, 55.0, 52.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0, 61.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 75.0, 76.0, 75.0, 81.0, 76.0, 75.0, 79.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 128.0, 125.0, 131.0, 144.0, 121.0, 123.0, 164.0, 139.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 167.0, 159.0, 159.0, 158.0, 156.0, 158.0, 159.0, 157.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 64.0, 65.0, 64.0, 68.0, 67.0, 63.0, 66.0], "value": 65.4, "unit": "score"}]}]} 04:42:38 INFO - Return code: 0 04:42:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:42:38 ERROR - # TBPL SUCCESS # 04:42:38 INFO - Running post-action listener: _resource_record_post_action 04:42:38 INFO - ##### 04:42:38 INFO - ##### Finished run-tests step (success) 04:42:38 INFO - ##### 04:42:38 INFO - Running post-run listener: _resource_record_post_run 04:42:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553320448; Read time: 16; Write time: 609156 04:42:38 INFO - TinderboxPrint: CPU usage
13.3% 04:42:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:42:38 INFO - TinderboxPrint: I/O write bytes / time
553,320,448 / 609,156 04:42:38 INFO - TinderboxPrint: CPU idle
8,236.9 (86.7%) 04:42:38 INFO - TinderboxPrint: CPU user
1,208.7 (12.7%) 04:42:38 INFO - TinderboxPrint: Swap in / out
0 / 0 04:42:38 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256827392; Read time: 0; Write time: 321084 04:42:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295747584; Read time: 0; Write time: 288048 04:42:38 INFO - Running post-run listener: _upload_blobber_files 04:42:38 INFO - Blob upload gear active. 04:42:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:38 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 04:42:38 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'] 04:42:38 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 04:42:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:40 INFO - (blobuploader) - INFO - Done attempting. 04:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:40 INFO - (blobuploader) - INFO - Done attempting. 04:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:46 INFO - (blobuploader) - INFO - Done attempting. 04:42:46 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:46 INFO - Return code: 0 04:42:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/741adb93d926073606e88d90fed83f66f83641690742cddf133b322a0a47d130299c801eb8e9d788fce42ce93589e94bd3aa6b0d499baea83a445a8d316f179a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00e326ed0837143e705178dbfe3dcfacd90865ced433bcf307cc5f1b7f264f874e6a2061c4011187dcd4587c4d7475004e3a5811645ef39c64a1d436371bcbd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bf5ca82a6de31bc51583c5a94f39675a1cfdae26dbc4c09ae7538b9fe7f2c55d2a042b72b38d0621217b5abaa135cfa81c0d9f6436616da0a5a99910d376a89"} 04:42:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:46 INFO - Contents: 04:42:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/741adb93d926073606e88d90fed83f66f83641690742cddf133b322a0a47d130299c801eb8e9d788fce42ce93589e94bd3aa6b0d499baea83a445a8d316f179a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00e326ed0837143e705178dbfe3dcfacd90865ced433bcf307cc5f1b7f264f874e6a2061c4011187dcd4587c4d7475004e3a5811645ef39c64a1d436371bcbd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bf5ca82a6de31bc51583c5a94f39675a1cfdae26dbc4c09ae7538b9fe7f2c55d2a042b72b38d0621217b5abaa135cfa81c0d9f6436616da0a5a99910d376a89"} 04:42:46 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:46 INFO - Copying logs to upload dir... 04:42:46 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.135985 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-16 04:42:45.565181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:42:45.568841) ========= 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=fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281 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/741adb93d926073606e88d90fed83f66f83641690742cddf133b322a0a47d130299c801eb8e9d788fce42ce93589e94bd3aa6b0d499baea83a445a8d316f179a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00e326ed0837143e705178dbfe3dcfacd90865ced433bcf307cc5f1b7f264f874e6a2061c4011187dcd4587c4d7475004e3a5811645ef39c64a1d436371bcbd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bf5ca82a6de31bc51583c5a94f39675a1cfdae26dbc4c09ae7538b9fe7f2c55d2a042b72b38d0621217b5abaa135cfa81c0d9f6436616da0a5a99910d376a89"} build_url:https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/ecgEOmDMQiujRrYtfEwZ7g/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/741adb93d926073606e88d90fed83f66f83641690742cddf133b322a0a47d130299c801eb8e9d788fce42ce93589e94bd3aa6b0d499baea83a445a8d316f179a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00e326ed0837143e705178dbfe3dcfacd90865ced433bcf307cc5f1b7f264f874e6a2061c4011187dcd4587c4d7475004e3a5811645ef39c64a1d436371bcbd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bf5ca82a6de31bc51583c5a94f39675a1cfdae26dbc4c09ae7538b9fe7f2c55d2a042b72b38d0621217b5abaa135cfa81c0d9f6436616da0a5a99910d376a89"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:42:45.595085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:42:45.595529) ========= 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=fa44defc139c4ba8574fe040000001db-1468667276.779925-2001902281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:42:45.680493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:42:45.680847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:42:45.681272) ========= ========= Total master_lag: 0.16 =========