builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1470709104.39 results: success (0) buildid: 20160808163004 builduid: bf04f85d94ea49af85b12b62f77a3c03 revision: 720b5d2c84d5b253d4dfde4897e13384dc97a46a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.391060) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.391525) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.391866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.409010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.409438) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 19:18:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-08-08 19:18:25 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118936 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.547093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.547432) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016508 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:24.613808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 19:18:24.614184) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 720b5d2c84d5b253d4dfde4897e13384dc97a46a --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 720b5d2c84d5b253d4dfde4897e13384dc97a46a --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=bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 19:18:25,324 truncating revision to first 12 chars 2016-08-08 19:18:25,324 Setting DEBUG logging. 2016-08-08 19:18:25,324 attempt 1/10 2016-08-08 19:18:25,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/720b5d2c84d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 19:18:26,232 unpacking tar archive at: mozilla-central-720b5d2c84d5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.243047 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 19:18:25.888630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:25.889570) ========= script_repo_revision: 720b5d2c84d5b253d4dfde4897e13384dc97a46a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:25.890512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:25.891293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 19:18:25.903894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-08 19:18:25.904279) ========= /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=bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:18:26 INFO - MultiFileLogger online at 20160808 19:18:26 in /builds/slave/test 19:18:26 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 19:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:18:26 INFO - {'append_to_log': False, 19:18:26 INFO - 'base_work_dir': '/builds/slave/test', 19:18:26 INFO - 'blob_upload_branch': 'Firefox', 19:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:18:26 INFO - 'branch': 'Firefox', 19:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:18:26 INFO - 'config_files': ('talos/linux_config.py',), 19:18:26 INFO - 'default_actions': ('clobber', 19:18:26 INFO - 'read-buildbot-config', 19:18:26 INFO - 'download-and-extract', 19:18:26 INFO - 'populate-webroot', 19:18:26 INFO - 'create-virtualenv', 19:18:26 INFO - 'install', 19:18:26 INFO - 'run-tests'), 19:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:18:26 INFO - 'download_minidump_stackwalk': True, 19:18:26 INFO - 'download_symbols': 'ondemand', 19:18:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:18:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:18:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:18:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:18:26 INFO - 'installer_path': 'installer.exe', 19:18:26 INFO - 'log_level': 'info', 19:18:26 INFO - 'log_name': 'talos', 19:18:26 INFO - 'log_to_console': True, 19:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:18:26 INFO - 'opt_config_files': (), 19:18:26 INFO - 'pip_index': False, 19:18:26 INFO - 'sps_profile': False, 19:18:26 INFO - 'sps_profile_interval': 0, 19:18:26 INFO - 'suite': 'dromaeojs-e10s', 19:18:26 INFO - 'system_bits': '32', 19:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:18:26 INFO - 'title': 'talos-linux64-ix-055', 19:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:18:26 INFO - 'use_talos_json': True, 19:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:18:26 INFO - 'work_dir': 'build'} 19:18:26 INFO - [mozharness: 2016-08-09 02:18:26.706645Z] Running clobber step. 19:18:26 INFO - Running pre-action listener: _resource_record_pre_action 19:18:26 INFO - Running main action method: clobber 19:18:26 INFO - rmtree: /builds/slave/test/build 19:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:27 INFO - Running post-action listener: _resource_record_post_action 19:18:27 INFO - [mozharness: 2016-08-09 02:18:27.163426Z] Finished clobber step (success) 19:18:27 INFO - [mozharness: 2016-08-09 02:18:27.163527Z] Running read-buildbot-config step. 19:18:27 INFO - Running pre-action listener: _resource_record_pre_action 19:18:27 INFO - Running main action method: read_buildbot_config 19:18:27 INFO - Using buildbot properties: 19:18:27 INFO - { 19:18:27 INFO - "project": "", 19:18:27 INFO - "product": "firefox", 19:18:27 INFO - "script_repo_revision": "production", 19:18:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:18:27 INFO - "repository": "", 19:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:18:27 INFO - "buildid": "20160808163004", 19:18:27 INFO - "pgo_build": "True", 19:18:27 INFO - "basedir": "/builds/slave/test", 19:18:27 INFO - "buildnumber": 310, 19:18:27 INFO - "slavename": "talos-linux64-ix-055", 19:18:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:18:27 INFO - "platform": "ubuntu64_hw", 19:18:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:18:27 INFO - "branch": "mozilla-central", 19:18:27 INFO - "repo_path": "mozilla-central", 19:18:27 INFO - "revision": "720b5d2c84d5b253d4dfde4897e13384dc97a46a", 19:18:27 INFO - "stage_platform": "linux64-pgo", 19:18:27 INFO - "builduid": "bf04f85d94ea49af85b12b62f77a3c03", 19:18:27 INFO - "slavebuilddir": "test" 19:18:27 INFO - } 19:18:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:18:27 INFO - Running post-action listener: _resource_record_post_action 19:18:27 INFO - [mozharness: 2016-08-09 02:18:27.165954Z] Finished read-buildbot-config step (success) 19:18:27 INFO - [mozharness: 2016-08-09 02:18:27.166043Z] Running download-and-extract step. 19:18:27 INFO - Running pre-action listener: _resource_record_pre_action 19:18:27 INFO - Running main action method: download_and_extract 19:18:27 INFO - mkdir: /builds/slave/test/build/tests 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:27 INFO - trying https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:18:27 INFO - Downloaded 1361 bytes. 19:18:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:18:27 INFO - Using the following test package requirements: 19:18:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:18:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:18:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:18:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'jsshell-linux-x86_64.zip'], 19:18:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:18:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:18:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:18:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:18:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:18:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:18:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:27 INFO - trying https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:18:28 INFO - Downloaded 21829560 bytes. 19:18:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:18:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:18:29 INFO - Return code: 0 19:18:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:18:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:29 INFO - trying https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:18:31 INFO - Downloaded 21829560 bytes. 19:18:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:18:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:18:32 INFO - Return code: 0 19:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:32 INFO - trying https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:18:32 INFO - Downloading https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:18:33 INFO - Downloaded 14413723 bytes. 19:18:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:18:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:18:33 INFO - Return code: 0 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:33 INFO - trying https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:18:33 INFO - Downloading https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:18:35 INFO - Downloaded 59987447 bytes. 19:18:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:18:35 INFO - mkdir: /builds/slave/test/properties 19:18:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:18:35 INFO - Writing to file /builds/slave/test/properties/build_url 19:18:35 INFO - Contents: 19:18:35 INFO - build_url:https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:18:36 INFO - Running post-action listener: _resource_record_post_action 19:18:36 INFO - Running post-action listener: set_extra_try_arguments 19:18:36 INFO - [mozharness: 2016-08-09 02:18:36.174464Z] Finished download-and-extract step (success) 19:18:36 INFO - [mozharness: 2016-08-09 02:18:36.174786Z] Running populate-webroot step. 19:18:36 INFO - Running pre-action listener: _resource_record_pre_action 19:18:36 INFO - Running main action method: populate_webroot 19:18:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:18:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:18:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:18:36 INFO - '--tppagecycles', 19:18:36 INFO - '7'], 19:18:36 INFO - 'tests': ['tsvgm']}}, 19:18:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:18:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:18:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:18:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:18:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['damp', 'tps']}, 19:18:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'tests': ['damp', 'tps']}, 19:18:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['dromaeo_dom']}, 19:18:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:18:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['basic_compositor_video']}, 19:18:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:18:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['a11yr', 19:18:36 INFO - 'ts_paint', 19:18:36 INFO - 'tpaint', 19:18:36 INFO - 'sessionrestore', 19:18:36 INFO - 'sessionrestore_no_auto_restore', 19:18:36 INFO - 'tabpaint']}, 19:18:36 INFO - 'other-e10s': {'tests': ['a11yr', 19:18:36 INFO - 'ts_paint', 19:18:36 INFO - 'tpaint', 19:18:36 INFO - 'sessionrestore', 19:18:36 INFO - 'sessionrestore_no_auto_restore', 19:18:36 INFO - 'tabpaint']}, 19:18:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:18:36 INFO - 'ts_paint', 19:18:36 INFO - 'tpaint', 19:18:36 INFO - 'sessionrestore', 19:18:36 INFO - 'sessionrestore_no_auto_restore', 19:18:36 INFO - 'tabpaint']}, 19:18:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:18:36 INFO - 'ts_paint', 19:18:36 INFO - 'tpaint', 19:18:36 INFO - 'sessionrestore', 19:18:36 INFO - 'sessionrestore_no_auto_restore', 19:18:36 INFO - 'tabpaint']}, 19:18:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['a11yr', 19:18:36 INFO - 'ts_paint', 19:18:36 INFO - 'tpaint', 19:18:36 INFO - 'sessionrestore', 19:18:36 INFO - 'sessionrestore_no_auto_restore', 19:18:36 INFO - 'tabpaint']}, 19:18:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['a11yr', 19:18:36 INFO - 'ts_paint', 19:18:36 INFO - 'tpaint', 19:18:36 INFO - 'sessionrestore', 19:18:36 INFO - 'sessionrestore_no_auto_restore', 19:18:36 INFO - 'tabpaint']}, 19:18:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['tsvgx', 19:18:36 INFO - 'tsvgr_opacity', 19:18:36 INFO - 'tart', 19:18:36 INFO - 'tscrollx', 19:18:36 INFO - 'cart']}, 19:18:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:18:36 INFO - 'tsvgr_opacity', 19:18:36 INFO - 'tart', 19:18:36 INFO - 'tscrollx', 19:18:36 INFO - 'cart']}, 19:18:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'talos_options': ['--disable-e10s'], 19:18:36 INFO - 'tests': ['tp5o']}, 19:18:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'tests': ['tp5o']}, 19:18:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'talos_options': ['--disable-e10s', 19:18:36 INFO - '--xperf_path', 19:18:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:36 INFO - 'tests': ['tp5n']}, 19:18:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:36 INFO - 'talos_options': ['--xperf_path', 19:18:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:36 INFO - 'tests': ['tp5n']}}, 19:18:36 INFO - 'talos.zip': {'path': '', 19:18:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:18:36 INFO - Running post-action listener: _resource_record_post_action 19:18:36 INFO - [mozharness: 2016-08-09 02:18:36.196190Z] Finished populate-webroot step (success) 19:18:36 INFO - [mozharness: 2016-08-09 02:18:36.196278Z] Running create-virtualenv step. 19:18:36 INFO - Running pre-action listener: _resource_record_pre_action 19:18:36 INFO - Running main action method: create_virtualenv 19:18:36 INFO - Creating virtualenv /builds/slave/test/build/venv 19:18:36 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 19:18:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:18:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:18:36 INFO - Using real prefix '/usr' 19:18:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:18:36 INFO - Installing distribute.............................................................................................................................................................................................done. 19:18:38 INFO - Installing pip.................done. 19:18:38 INFO - Return code: 0 19:18:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:38 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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:38 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 19:18:38 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 19:18:38 INFO - Using env: {'DISPLAY': ':0', 19:18:38 INFO - 'HOME': '/home/cltbld', 19:18:38 INFO - 'LANG': 'en_US.UTF-8', 19:18:38 INFO - 'LANGUAGE': 'en_US:en', 19:18:38 INFO - 'LOGNAME': 'cltbld', 19:18:38 INFO - 'MAIL': '/var/mail/cltbld', 19:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:38 INFO - 'MOZ_NO_REMOTE': '1', 19:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:38 INFO - 'NO_EM_RESTART': '1', 19:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:38 INFO - 'PWD': '/builds/slave/test', 19:18:38 INFO - 'SHELL': '/bin/bash', 19:18:38 INFO - 'SHLVL': '1', 19:18:38 INFO - 'TERM': 'linux', 19:18:38 INFO - 'TMOUT': '86400', 19:18:38 INFO - 'USER': 'cltbld', 19:18:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:38 INFO - '_': '/tools/buildbot/bin/python'} 19:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:38 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 19:18:38 INFO - Cleaning up... 19:18:39 INFO - Return code: 0 19:18:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:39 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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:39 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 19:18:39 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 19:18:39 INFO - Using env: {'DISPLAY': ':0', 19:18:39 INFO - 'HOME': '/home/cltbld', 19:18:39 INFO - 'LANG': 'en_US.UTF-8', 19:18:39 INFO - 'LANGUAGE': 'en_US:en', 19:18:39 INFO - 'LOGNAME': 'cltbld', 19:18:39 INFO - 'MAIL': '/var/mail/cltbld', 19:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:39 INFO - 'MOZ_NO_REMOTE': '1', 19:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:39 INFO - 'NO_EM_RESTART': '1', 19:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:39 INFO - 'PWD': '/builds/slave/test', 19:18:39 INFO - 'SHELL': '/bin/bash', 19:18:39 INFO - 'SHLVL': '1', 19:18:39 INFO - 'TERM': 'linux', 19:18:39 INFO - 'TMOUT': '86400', 19:18:39 INFO - 'USER': 'cltbld', 19:18:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:39 INFO - '_': '/tools/buildbot/bin/python'} 19:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:39 INFO - Downloading/unpacking psutil>=3.1.1 19:18:39 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 19:18:39 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 19:18:39 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 19:18:39 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 19:18:39 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 19:18:39 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 19:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:18:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:41 INFO - Installing collected packages: psutil 19:18:41 INFO - Running setup.py install for psutil 19:18:41 INFO - building 'psutil._psutil_linux' extension 19:18:41 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 19:18:41 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 19:18:41 INFO - building 'psutil._psutil_posix' extension 19:18:41 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 19:18:41 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 19:18:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:41 INFO - Successfully installed psutil 19:18:41 INFO - Cleaning up... 19:18:41 INFO - Return code: 0 19:18:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:41 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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:41 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 19:18:41 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 19:18:41 INFO - Using env: {'DISPLAY': ':0', 19:18:41 INFO - 'HOME': '/home/cltbld', 19:18:41 INFO - 'LANG': 'en_US.UTF-8', 19:18:41 INFO - 'LANGUAGE': 'en_US:en', 19:18:41 INFO - 'LOGNAME': 'cltbld', 19:18:41 INFO - 'MAIL': '/var/mail/cltbld', 19:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:41 INFO - 'MOZ_NO_REMOTE': '1', 19:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:41 INFO - 'NO_EM_RESTART': '1', 19:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:41 INFO - 'PWD': '/builds/slave/test', 19:18:41 INFO - 'SHELL': '/bin/bash', 19:18:41 INFO - 'SHLVL': '1', 19:18:41 INFO - 'TERM': 'linux', 19:18:41 INFO - 'TMOUT': '86400', 19:18:41 INFO - 'USER': 'cltbld', 19:18:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:41 INFO - '_': '/tools/buildbot/bin/python'} 19:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:18:41 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 19:18:41 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 19:18:41 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 19:18:41 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 19:18:41 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 19:18:41 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 19:18:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:18:43 INFO - Installing collected packages: mozsystemmonitor 19:18:43 INFO - Running setup.py install for mozsystemmonitor 19:18:44 INFO - Successfully installed mozsystemmonitor 19:18:44 INFO - Cleaning up... 19:18:44 INFO - Return code: 0 19:18:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:18:44 INFO - Using env: {'DISPLAY': ':0', 19:18:44 INFO - 'HOME': '/home/cltbld', 19:18:44 INFO - 'LANG': 'en_US.UTF-8', 19:18:44 INFO - 'LANGUAGE': 'en_US:en', 19:18:44 INFO - 'LOGNAME': 'cltbld', 19:18:44 INFO - 'MAIL': '/var/mail/cltbld', 19:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:44 INFO - 'MOZ_NO_REMOTE': '1', 19:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:44 INFO - 'NO_EM_RESTART': '1', 19:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:44 INFO - 'PWD': '/builds/slave/test', 19:18:44 INFO - 'SHELL': '/bin/bash', 19:18:44 INFO - 'SHLVL': '1', 19:18:44 INFO - 'TERM': 'linux', 19:18:44 INFO - 'TMOUT': '86400', 19:18:44 INFO - 'USER': 'cltbld', 19:18:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:44 INFO - '_': '/tools/buildbot/bin/python'} 19:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:44 INFO - Downloading/unpacking jsonschema==2.5.1 19:18:44 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 19:18:44 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 19:18:44 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 19:18:44 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 19:18:44 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 19:18:44 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 19:18:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:18:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:46 INFO - Downloading functools32-3.2.3-2.tar.gz 19:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:18:46 INFO - warning: no files found matching '*.txt' 19:18:46 INFO - no previously-included directories found matching 'build' 19:18:46 INFO - no previously-included directories found matching 'dist' 19:18:46 INFO - no previously-included directories found matching '.git*' 19:18:46 INFO - Installing collected packages: jsonschema, functools32 19:18:46 INFO - Running setup.py install for functools32 19:18:46 INFO - warning: no files found matching '*.txt' 19:18:46 INFO - no previously-included directories found matching 'build' 19:18:46 INFO - no previously-included directories found matching 'dist' 19:18:46 INFO - no previously-included directories found matching '.git*' 19:18:46 INFO - Successfully installed jsonschema functools32 19:18:46 INFO - Cleaning up... 19:18:46 INFO - Return code: 0 19:18:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:18: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 functools32==3.2.3-2 19:18:46 INFO - Using env: {'DISPLAY': ':0', 19:18:46 INFO - 'HOME': '/home/cltbld', 19:18:46 INFO - 'LANG': 'en_US.UTF-8', 19:18:46 INFO - 'LANGUAGE': 'en_US:en', 19:18:46 INFO - 'LOGNAME': 'cltbld', 19:18:46 INFO - 'MAIL': '/var/mail/cltbld', 19:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:46 INFO - 'MOZ_NO_REMOTE': '1', 19:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:46 INFO - 'NO_EM_RESTART': '1', 19:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:46 INFO - 'PWD': '/builds/slave/test', 19:18:46 INFO - 'SHELL': '/bin/bash', 19:18:46 INFO - 'SHLVL': '1', 19:18:46 INFO - 'TERM': 'linux', 19:18:46 INFO - 'TMOUT': '86400', 19:18:46 INFO - 'USER': 'cltbld', 19:18:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:46 INFO - '_': '/tools/buildbot/bin/python'} 19:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:18:46 INFO - Cleaning up... 19:18:46 INFO - Return code: 0 19:18:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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', '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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:18: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 blobuploader==1.2.4 19:18:46 INFO - Using env: {'DISPLAY': ':0', 19:18:46 INFO - 'HOME': '/home/cltbld', 19:18:46 INFO - 'LANG': 'en_US.UTF-8', 19:18:46 INFO - 'LANGUAGE': 'en_US:en', 19:18:46 INFO - 'LOGNAME': 'cltbld', 19:18:46 INFO - 'MAIL': '/var/mail/cltbld', 19:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:46 INFO - 'MOZ_NO_REMOTE': '1', 19:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:46 INFO - 'NO_EM_RESTART': '1', 19:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:46 INFO - 'PWD': '/builds/slave/test', 19:18:46 INFO - 'SHELL': '/bin/bash', 19:18:46 INFO - 'SHLVL': '1', 19:18:46 INFO - 'TERM': 'linux', 19:18:46 INFO - 'TMOUT': '86400', 19:18:46 INFO - 'USER': 'cltbld', 19:18:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:46 INFO - '_': '/tools/buildbot/bin/python'} 19:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:18:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:18:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:49 INFO - Downloading docopt-0.6.1.tar.gz 19:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:18:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:18:49 INFO - Running setup.py install for blobuploader 19:18:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:49 INFO - Running setup.py install for requests 19:18:50 INFO - Running setup.py install for docopt 19:18:50 INFO - Successfully installed blobuploader requests docopt 19:18:50 INFO - Cleaning up... 19:18:50 INFO - Return code: 0 19:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:50 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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:50 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 19:18:50 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 19:18:50 INFO - Using env: {'DISPLAY': ':0', 19:18:50 INFO - 'HOME': '/home/cltbld', 19:18:50 INFO - 'LANG': 'en_US.UTF-8', 19:18:50 INFO - 'LANGUAGE': 'en_US:en', 19:18:50 INFO - 'LOGNAME': 'cltbld', 19:18:50 INFO - 'MAIL': '/var/mail/cltbld', 19:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:50 INFO - 'MOZ_NO_REMOTE': '1', 19:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:50 INFO - 'NO_EM_RESTART': '1', 19:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:50 INFO - 'PWD': '/builds/slave/test', 19:18:50 INFO - 'SHELL': '/bin/bash', 19:18:50 INFO - 'SHLVL': '1', 19:18:50 INFO - 'TERM': 'linux', 19:18:50 INFO - 'TMOUT': '86400', 19:18:50 INFO - 'USER': 'cltbld', 19:18:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:50 INFO - '_': '/tools/buildbot/bin/python'} 19:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:50 INFO - Running setup.py (path:/tmp/pip-IIXhGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:50 INFO - Running setup.py (path:/tmp/pip-ECUTiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:50 INFO - Running setup.py (path:/tmp/pip-p_Bv0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:50 INFO - Running setup.py (path:/tmp/pip-yuXWhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:50 INFO - Running setup.py (path:/tmp/pip-aZ3Dmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:50 INFO - Running setup.py (path:/tmp/pip-nPhicw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:50 INFO - Running setup.py (path:/tmp/pip-Cy5rMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:50 INFO - Running setup.py (path:/tmp/pip-Q4OEeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:51 INFO - Running setup.py (path:/tmp/pip-dbsr1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:51 INFO - Running setup.py (path:/tmp/pip-lFCthz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:51 INFO - Running setup.py (path:/tmp/pip-YzpBGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:51 INFO - Running setup.py (path:/tmp/pip-Ex0eGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:51 INFO - Running setup.py (path:/tmp/pip-3dpWMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:51 INFO - Running setup.py (path:/tmp/pip-nBgFrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:51 INFO - Running setup.py (path:/tmp/pip-K8QGwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:51 INFO - Running setup.py (path:/tmp/pip-JubXT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:51 INFO - Running setup.py (path:/tmp/pip-ut6vx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:51 INFO - Running setup.py install for manifestparser 19:18:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:51 INFO - Running setup.py install for mozcrash 19:18:51 INFO - Running setup.py install for mozdebug 19:18:51 INFO - Running setup.py install for mozdevice 19:18:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Running setup.py install for mozfile 19:18:52 INFO - Running setup.py install for mozhttpd 19:18:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Running setup.py install for mozinfo 19:18:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Running setup.py install for mozInstall 19:18:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Running setup.py install for mozleak 19:18:52 INFO - Running setup.py install for mozlog 19:18:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Running setup.py install for moznetwork 19:18:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:52 INFO - Running setup.py install for mozprocess 19:18:52 INFO - Running setup.py install for mozprofile 19:18:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Running setup.py install for mozrunner 19:18:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Running setup.py install for mozscreenshot 19:18:53 INFO - Running setup.py install for moztest 19:18:53 INFO - Running setup.py install for mozversion 19:18:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:53 INFO - Cleaning up... 19:18:53 INFO - Return code: 0 19:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:53 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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:53 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 19:18:53 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 19:18:53 INFO - Using env: {'DISPLAY': ':0', 19:18:53 INFO - 'HOME': '/home/cltbld', 19:18:53 INFO - 'LANG': 'en_US.UTF-8', 19:18:53 INFO - 'LANGUAGE': 'en_US:en', 19:18:53 INFO - 'LOGNAME': 'cltbld', 19:18:53 INFO - 'MAIL': '/var/mail/cltbld', 19:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:53 INFO - 'MOZ_NO_REMOTE': '1', 19:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:53 INFO - 'NO_EM_RESTART': '1', 19:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:53 INFO - 'PWD': '/builds/slave/test', 19:18:53 INFO - 'SHELL': '/bin/bash', 19:18:53 INFO - 'SHLVL': '1', 19:18:53 INFO - 'TERM': 'linux', 19:18:53 INFO - 'TMOUT': '86400', 19:18:53 INFO - 'USER': 'cltbld', 19:18:53 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:53 INFO - '_': '/tools/buildbot/bin/python'} 19:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:53 INFO - Running setup.py (path:/tmp/pip-ZtNcIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:53 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)) 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:53 INFO - Running setup.py (path:/tmp/pip-nvwo7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:53 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)) 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:53 INFO - Running setup.py (path:/tmp/pip-8jFKj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:53 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)) 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:53 INFO - Running setup.py (path:/tmp/pip-b3kxJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:53 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)) 19:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:54 INFO - Running setup.py (path:/tmp/pip-DayeeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:54 INFO - Running setup.py (path:/tmp/pip-raa5tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:54 INFO - Running setup.py (path:/tmp/pip-RHvdU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:54 INFO - Running setup.py (path:/tmp/pip-COopgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:54 INFO - Running setup.py (path:/tmp/pip-Zr_uOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:54 INFO - Running setup.py (path:/tmp/pip-98blJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:54 INFO - Running setup.py (path:/tmp/pip-Uzst0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:54 INFO - Running setup.py (path:/tmp/pip-Is_gmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:54 INFO - Running setup.py (path:/tmp/pip-DrntMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:54 INFO - Running setup.py (path:/tmp/pip-SSiKge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:54 INFO - Running setup.py (path:/tmp/pip-J4K75t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:54 INFO - Running setup.py (path:/tmp/pip-xAG3jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:54 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)) 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:54 INFO - Running setup.py (path:/tmp/pip-xEpzTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:54 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)) 19:18:54 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)) 19:18:54 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)) 19:18:54 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)) 19:18:54 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)) 19:18:54 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)) 19:18:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:56 INFO - Downloading blessings-1.6.tar.gz 19:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:56 INFO - Installing collected packages: blessings 19:18:56 INFO - Running setup.py install for blessings 19:18:56 INFO - Successfully installed blessings 19:18:56 INFO - Cleaning up... 19:18:57 INFO - Return code: 0 19:18:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:57 INFO - Reading from file tmpfile_stdout 19:18:57 INFO - Current package versions: 19:18:57 INFO - argparse == 1.2.1 19:18:57 INFO - blessings == 1.6 19:18:57 INFO - blobuploader == 1.2.4 19:18:57 INFO - docopt == 0.6.1 19:18:57 INFO - functools32 == 3.2.3-2 19:18:57 INFO - jsonschema == 2.5.1 19:18:57 INFO - manifestparser == 1.1 19:18:57 INFO - mozInstall == 1.12 19:18:57 INFO - mozcrash == 0.17 19:18:57 INFO - mozdebug == 0.1 19:18:57 INFO - mozdevice == 0.48 19:18:57 INFO - mozfile == 1.2 19:18:57 INFO - mozhttpd == 0.7 19:18:57 INFO - mozinfo == 0.9 19:18:57 INFO - mozleak == 0.1 19:18:57 INFO - mozlog == 3.3 19:18:57 INFO - moznetwork == 0.27 19:18:57 INFO - mozprocess == 0.23 19:18:57 INFO - mozprofile == 0.28 19:18:57 INFO - mozrunner == 6.12 19:18:57 INFO - mozscreenshot == 0.1 19:18:57 INFO - mozsystemmonitor == 0.3 19:18:57 INFO - moztest == 0.7 19:18:57 INFO - mozversion == 1.4 19:18:57 INFO - psutil == 3.1.1 19:18:57 INFO - requests == 1.2.3 19:18:57 INFO - wsgiref == 0.1.2 19:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:57 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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:57 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 19:18:57 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 19:18:57 INFO - Using env: {'DISPLAY': ':0', 19:18:57 INFO - 'HOME': '/home/cltbld', 19:18:57 INFO - 'LANG': 'en_US.UTF-8', 19:18:57 INFO - 'LANGUAGE': 'en_US:en', 19:18:57 INFO - 'LOGNAME': 'cltbld', 19:18:57 INFO - 'MAIL': '/var/mail/cltbld', 19:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:57 INFO - 'MOZ_NO_REMOTE': '1', 19:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:57 INFO - 'NO_EM_RESTART': '1', 19:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:57 INFO - 'PWD': '/builds/slave/test', 19:18:57 INFO - 'SHELL': '/bin/bash', 19:18:57 INFO - 'SHLVL': '1', 19:18:57 INFO - 'TERM': 'linux', 19:18:57 INFO - 'TMOUT': '86400', 19:18:57 INFO - 'USER': 'cltbld', 19:18:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:57 INFO - '_': '/tools/buildbot/bin/python'} 19:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 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)) 19:18:57 INFO - Cleaning up... 19:18:57 INFO - Return code: 0 19:18:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:57 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 0x2a50030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d11180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', '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 19:18:57 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 19:18:57 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 19:18:57 INFO - Using env: {'DISPLAY': ':0', 19:18:57 INFO - 'HOME': '/home/cltbld', 19:18:57 INFO - 'LANG': 'en_US.UTF-8', 19:18:57 INFO - 'LANGUAGE': 'en_US:en', 19:18:57 INFO - 'LOGNAME': 'cltbld', 19:18:57 INFO - 'MAIL': '/var/mail/cltbld', 19:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:57 INFO - 'MOZ_NO_REMOTE': '1', 19:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:57 INFO - 'NO_EM_RESTART': '1', 19:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:57 INFO - 'PWD': '/builds/slave/test', 19:18:57 INFO - 'SHELL': '/bin/bash', 19:18:57 INFO - 'SHLVL': '1', 19:18:57 INFO - 'TERM': 'linux', 19:18:57 INFO - 'TMOUT': '86400', 19:18:57 INFO - 'USER': 'cltbld', 19:18:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:57 INFO - '_': '/tools/buildbot/bin/python'} 19:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:18:57 INFO - Cleaning up... 19:18:57 INFO - Return code: 0 19:18:57 INFO - Running post-action listener: _resource_record_post_action 19:18:57 INFO - Running post-action listener: _start_resource_monitoring 19:18:57 INFO - Starting resource monitoring. 19:18:57 INFO - [mozharness: 2016-08-09 02:18:57.731163Z] Finished create-virtualenv step (success) 19:18:57 INFO - [mozharness: 2016-08-09 02:18:57.731602Z] Running install step. 19:18:57 INFO - Running pre-action listener: _resource_record_pre_action 19:18:57 INFO - Running main action method: install 19:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:57 INFO - Reading from file tmpfile_stdout 19:18:57 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:58 INFO - Reading from file tmpfile_stdout 19:18:58 INFO - Output received: 19:18:58 INFO - Usage: mozinstall [options] installer 19:18:58 INFO - Options: 19:18:58 INFO - -h, --help show this help message and exit 19:18:58 INFO - -d DEST, --destination=DEST 19:18:58 INFO - Directory to install application into. [default: 19:18:58 INFO - "/builds/slave/test"] 19:18:58 INFO - --app=APP Application being installed. [default: firefox] 19:18:58 INFO - mkdir: /builds/slave/test/build/application 19:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:19:15 INFO - Reading from file tmpfile_stdout 19:19:15 INFO - Output received: 19:19:15 INFO - /builds/slave/test/build/application/firefox/firefox 19:19:15 INFO - Running post-action listener: _resource_record_post_action 19:19:15 INFO - [mozharness: 2016-08-09 02:19:15.501032Z] Finished install step (success) 19:19:15 INFO - [mozharness: 2016-08-09 02:19:15.501279Z] Running run-tests step. 19:19:15 INFO - Running pre-action listener: _resource_record_pre_action 19:19:15 INFO - Running main action method: run_tests 19:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:15 INFO - Python 2.7.3 19:19:15 INFO - Return code: 0 19:19:15 INFO - grabbing minidump binary from tooltool 19:19:15 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:15 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 0x2d0f3b0>, '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 0x2d102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d10740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:15 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 19:19:15 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 19:19:15 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 19:19:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:15 INFO - Return code: 0 19:19:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:19:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:19:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:15 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/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 19:19:15 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/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 19:19:15 INFO - Using env: {'DISPLAY': ':0', 19:19:15 INFO - 'HOME': '/home/cltbld', 19:19:15 INFO - 'LANG': 'en_US.UTF-8', 19:19:15 INFO - 'LANGUAGE': 'en_US:en', 19:19:15 INFO - 'LOGNAME': 'cltbld', 19:19:15 INFO - 'MAIL': '/var/mail/cltbld', 19:19:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:15 INFO - 'MOZ_NO_REMOTE': '1', 19:19:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:15 INFO - 'NO_EM_RESTART': '1', 19:19:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:15 INFO - 'PWD': '/builds/slave/test', 19:19:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:15 INFO - 'SHELL': '/bin/bash', 19:19:15 INFO - 'SHLVL': '1', 19:19:15 INFO - 'TERM': 'linux', 19:19:15 INFO - 'TMOUT': '86400', 19:19:15 INFO - 'USER': 'cltbld', 19:19:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276', 19:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:15 INFO - '_': '/tools/buildbot/bin/python'} 19:19:15 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/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 19:19:15 INFO - mozversion application_buildid: 20160808163004 19:19:15 INFO - mozversion application_changeset: 720b5d2c84d5b253d4dfde4897e13384dc97a46a 19:19:15 INFO - mozversion application_display_name: Nightly 19:19:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:15 INFO - mozversion application_name: Firefox 19:19:15 INFO - mozversion application_remotingname: firefox 19:19:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:19:15 INFO - mozversion application_vendor: Mozilla 19:19:15 INFO - mozversion application_version: 51.0a1 19:19:15 INFO - mozversion platform_buildid: 20160808163004 19:19:15 INFO - mozversion platform_changeset: 720b5d2c84d5b253d4dfde4897e13384dc97a46a 19:19:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:19:15 INFO - mozversion platform_version: 51.0a1 19:19:15 INFO - using testdate: 1470709155 19:19:15 INFO - actual date: 1470709155 19:19:15 INFO - starting webserver on 'localhost:59698' 19:19:15 INFO - SUITE-START | Running 2 tests 19:19:15 INFO - TEST-START | dromaeo_css 19:19:15 INFO - operating with platform_type : linux_ 19:19:15 INFO - Initialising browser for dromaeo_css test... 19:19:15 INFO - TEST-INFO | started process 20590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyP5hQo/profile http://localhost:59698/getInfo.html) 19:19:19 INFO - PROCESS | 20590 | __metrics Screen width/height:1600/1200 19:19:19 INFO - PROCESS | 20590 | colorDepth:24 19:19:19 INFO - PROCESS | 20590 | Browser inner width/height: 1024/697 19:19:19 INFO - PROCESS | 20590 | __metrics 19:19:20 ERROR - PROCESS | 20590 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:19:21 INFO - TEST-INFO | 20590: exit 0 19:19:21 INFO - Browser initialized. 19:19:21 INFO - Running cycle 1/1 for dromaeo_css test... 19:19:21 INFO - TEST-INFO | started process 20711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyP5hQo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:33 INFO - PROCESS | 20711 | RSS: Main: 163270656 19:19:33 INFO - PROCESS | 20711 | 19:20:22 INFO - PROCESS | 20711 | 1470709222861 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] 19:22:32 INFO - PROCESS | 20711 | Cycle 1(1): loaded http://localhost:59698/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59698/tests/dromaeo/cssquery-ext.html) 19:22:33 INFO - PROCESS | 20711 | RSS: Main: 165687296 19:22:33 INFO - PROCESS | 20711 | 19:25:35 INFO - PROCESS | 20711 | Cycle 1(1): loaded http://localhost:59698/tests/dromaeo/cssquery-ext.html (next: http://localhost:59698/tests/dromaeo/cssquery-jquery.html) 19:25:36 INFO - PROCESS | 20711 | RSS: Main: 165797888 19:25:36 INFO - PROCESS | 20711 | 19:28:38 INFO - PROCESS | 20711 | Cycle 1(1): loaded http://localhost:59698/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59698/tests/dromaeo/cssquery-mootools.html) 19:28:38 INFO - PROCESS | 20711 | RSS: Main: 169451520 19:28:38 INFO - PROCESS | 20711 | 19:31:40 INFO - PROCESS | 20711 | Cycle 1(1): loaded http://localhost:59698/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59698/tests/dromaeo/cssquery-prototype.html) 19:31:41 INFO - PROCESS | 20711 | RSS: Main: 164143104 19:31:41 INFO - PROCESS | 20711 | 19:34:43 INFO - PROCESS | 20711 | Cycle 1(1): loaded http://localhost:59698/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59698/tests/dromaeo/cssquery-yui.html) 19:34:44 INFO - PROCESS | 20711 | RSS: Main: 166490112 19:34:44 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | Cycle 1(1): loaded http://localhost:59698/tests/dromaeo/cssquery-yui.html (next: http://localhost:59698/tests/dromaeo/cssquery-dojo.html) 19:37:47 INFO - PROCESS | 20711 | RSS: Main: 169172992 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | __start_tp_report 19:37:47 INFO - PROCESS | 20711 | _x_x_mozilla_page_load 19:37:47 INFO - PROCESS | 20711 | _x_x_mozilla_page_load_details 19:37:47 INFO - PROCESS | 20711 | |i|pagename|runs| 19:37:47 INFO - PROCESS | 20711 | |0;dojo.html;3090.196548897287;3099.6435409927867;3125.8437078146085;3131.4050330437217;3134.576832127662;5398.73006349682;5471.06991811392;5501.807436739715;5513.9448605513935;5549.0289199390145;5428.782848686058;5432.320959880015;5434.809781657643;5489.725513724307;5516.641418307807;4970.403551573816;5014.448410674823;5049.520295571915;5082.440931497532;5167.199084141946;4719.575238228559;5118.488151184889;5168.974155129219;5184.248283998818;5224.111900976843;4865.05131499356;4950.900981980376;4972.229304457815;5040.36995375578;5068.4424713281505;4980.97889932563;4987.725675087869;4988.850334489971;5012.423571289312;5038.042771873369;4938.950610493921;4955.1080805455;4964.379452568429;4972.303877457159;5032.572231360339;5360.303160589098;5360.303160589137;5445.319335083114;5493;5500.092484740013;5875.118732190205;5879.029960056586;5879.970600147015;5896.941030589682;5901.822945311647;5928.6739229342365;5935.643861368331;5935.9406405935815;5937.495312898409;5945.108233764927;5322.574194064504;5388.568914486832;5430.185472179165;5430.484104010113;5502.614816962854;5975.67133807636;5998.040313549811;5998.340182579913;6002.4897883679505;6010.248718910137;5718.571107166979;5741.7990370337675;5743.971280143656;5768.048272035151;5770.3652598215;5714;5738.8278351649515;5746.0519014363;5772.191893134965;5782.335031471351;5772.826815195551;5816.88366232673;5821.825345239649;5841.357450680422;5866.970665146647;5786.594938354275;5903.970480147572;5923.259592550931;5925.259342582177;5937.70311484424;4432.601065904019;4450.488193857683;4455.643548516111;4493.438320209973;4496.505384407713;3959.604039596017;3977.801109944491;3990.940135897964;4010.4585880905706;4030.4558884550797;5588.692621905834;5594.832155035274;5603.13151461516;5621.269234999424;5622.353429355595;5696.259486266758;5778.104393818965;5830.854228644318;5892.94107058924;5921.141434491975;5583.4137415571595;5598.3282006159525;5620.57845661577;5634.23937768396;5635.013872572284;4978.701277923336;4984.651074424755;4990.725510096907;4998.525140111684;5064.215046667772;5957.4638282553915;6026.096085587197;6072.392760723892;6077.817665470043;6112.724927378279;5880.588358814842;5882.5293976480925;5898.64608123514;5923.170756094237;5950.018246989372;6015.428534289235;6089.360617135314;6105.786297479567;6118.694065296806;6124.050772130327;5640.717964101696;5737.971310143423;5777.191193233035;5789.305283366023;5815.360310365941;5944.256967879015;5944.613600115978;5946.226990491382;5988.790392336247;5999.970000149971;5782.479576837936;5785.363610002981;5787.681677507778;5791.420857914175;5822.94177058241;5607.046802043744;5677.432256774289;5715.2855893013375;5717.22817419643;5739.196512488172;5678.574106942078;5679.148127780866;5685.403032681675;5695.658260504383;5738.655680659173;5704.971475142598;5739.598228123991;5786.537077033743;5809.5352371811;5809.912851307149;5482.780688772405;5639.54883609302;5656.208130861601;5675.31896172462;5689.061304884648 19:37:47 INFO - PROCESS | 20711 | |1;ext.html;543.3917010970891;586.1588620329827;587.3861814403947;600.3516202501297;617.0928734759907;39466.40800387993;43579.78210108953;43614.56385436145;43644.345334820006;43764.15532990354;44543.554564454345;45264.3210351845;45576.77211613937;45668.54331456693;45730.085398292016;8867.512286824222;8921.643134274622;8931.196192342688;8957.552122393854;9011.504367259831;8915.68795092172;8974.955125224365;9000.189982901538;9005.54972251388;9017.36878418511;8993.415427997192;9015.504147271897;9030.50332231727;9041.683541076063;9045.412048216878;8934.776630584221;8969.596368163415;8995.235404990584;9012.143846334588;9013.05362936892;8855.955720221358;8910;8923.821523569557;8930.642774289021;8937.106289371011;40414;41043.38434923479;41155;41178;41202.38196427056;2867.3978464522474;3315.4032274190636;3491.598466176397;3809.142942837867;4013.7391069580385;32651.673483265102;32666.346673066644;32667.183320417178;32983.6701632983;33824.830875845706;4236.08924081324;4257.850975215883;4258.382534532476;4424.668149888771;4431.534688857656;320060;320394;320415;321137.3943130293;321147;36720.26559468849;36729.69432751065;36746.44880326797;36816.815915920786;36859.81570092186;37917.43123853144;38042.80978595089;38175.427368589495;38329.23341533209;38349;14608.269586520631;14725.852741472449;14778.704425911637;14808.03747756414;16260;12327.198732082386;12657.683557911127;12668.619941401772;12669.49322027127;12688.238705677504;19662.016899154984;19863.900680496794;19874.70187947182;19950.800491995185;19980.60329743947;7205.7838264852135;7340.192578816326;7380.815479613053;7394.223606521237;7447.515911465737;1030.9432981185957;1055.2613170780485;1095.3482677806692;1153.5385845661801;1160.8665003524534;34408.311833763684;34796.65203347985;34805.825970869984;34945.47581786275;35119.648803511634;992.8808542974745;1036.7563622548696;1042.5777560088177;1072.3887384191091;1154.9605355180404;16542.255598498097;18067.186976586087;18095.276188952295;18141.274349026156;18222.27110915575;587037;588232;591003;591293;592921;61519;61760.69119654373;62188.37811621826;62283;62386;1324.9933750331186;1371.430856194688;1377.1668140774887;1380.9447622095004;1392.4778208171936;31849.815018497964;34274.82862585671;34387.484187737704;34487.82756086203;34536.76072632709;54011;54036.459635403146;54442.45557544374;54475.182872256155;54529;376381;376711;377677;380671;465641;29675.55486667745;29889.701102989562;30135.69864301329;30490.390192195588;30630;50502.747486262335;51296;51542;51982;52227.216591751916;42469;42913.78543107265;43398.572369757625;43953.56046439495;44833.775831120634;43724;43890;44190;44978.3253251208;44997.10005799931;42258;42801.92995175145;43067.35398968955;43604.34593481037;43678.56321436872;36313.81843090873;38884.416733748454;38923;39571.8342532591;39622.80188599154;28931.710682892903;29160.56259156072;29227;29371.559426609045;29758.25604359908 19:37:47 INFO - PROCESS | 20711 | |2;jquery.html;381.89116101910963;387.24100762505486;409.84016233668865;413.9523954745204;420.25614662048173;18546.258149674013;19749.321307688864;20120.39638810838;20226.99999999998;20310.492237694067;19223.519412014706;19736.111874965623;19955;19963.10166042528;20126.59746805063;5533.08704063829;5845.357010728816;5930.940690593104;5998.610090344136;6019.067044608093;5881.117832325164;5892.675902825343;5928.496077833368;5929.673867937262;5939.524838012971;5804;5949.643021418707;5962.493188079018;5965.105234214859;5980.6112602680905;5908;5916.526677865761;5957;5964.850878728045;5985.5810093293485;5327.760250788724;5344.946550534483;5348.251244825728;5349.759260833272;5352.384475785296;23304.06783728649;23629.409264768346;23735.406614834596;24012.51974960491;24341.26976190717;2438.30508305134;2502.8122890783266;2593;2964.4219377221234;3139.905802825896;14667.413303467849;14999.925000374928;15328.846711532853;15560.533184004498;15610.375584976588;2000.9799902000939;2006.5585571174317;2042.3158241988804;2074.097767471155;2081.458820706612;80333.19666803315;81995.18004819936;82101;82469;84823;10241.795164096677;10557.841632375521;10787.784244315228;10926.453677316102;11229.157813164045;15182.620434489227;15264.313105910262;15356.846431535765;15365.078095314317;15370.692586148214;7904.249096335954;8001.239882211181;8241.25828675422;8255.628496717542;8288.461250018729;7411.407087432993;7491.887621685679;7535.095788505414;7578.81052973669;7917.168697286817;6392.552521323556;6658.400743932973;6675.132232809704;6794.279124323586;6822.522423430312;1902.1630482587618;1929.2861641192567;1966.763988321382;1973.506623344164;1996.6705493593395;1048.0462778871342;1063.8616979792578;1063.8989296016866;1079.2930630437077;1134.5461815273957;20457.79542204559;20981.475463113544;21043.263485777923;21113.677495475484;21224.469388265417;1037.3568387599737;1064.5848119233506;1073.640330489295;1078.428432930548;1084.511969613677;11081.612143574936;11787.35169565665;11949.701257468632;11997.700057498632;12018.819717704242;447563;449908;458797;469491;484203;81034.18965810267;82859.5857020711;83514.16485835063;83602;84576;974.9756256093655;988.9851652225223;996.342414006752;1009.6365308488938;1015.0509273828847;17215.053172075655;17634.206460709043;18242.17910194018;18399;18605.255789768256;38740.80629596834;39413.408798868615;40135.39796903107;40393.59606404016;41622.1675566493;51206.48793512166;59939.70030149821;60908.69545652244;61858.69070654618;63780.3621963793;7766.611669416619;7960.960195198987;8083.919160808552;8131.471454355448;8240.629171687408;12900.612981610191;13919.16485010862;13934.233617151154;13952.232627205602;13979.161250325013;11379.943100284445;11578.421078946187;12148.635540933787;12298.692532686755;12348.81476777831;11436.485358158736;11670.533178672758;11898.940505297418;11980.460879260629;12166.391680415767;12155.81766273489;12170.695732606755;12347.567835125728;12423;12626;8054.959725201336;8092.4335296531035;8150.877736833833;8180.427370084037;8268.710595129141;9823.950880245553;11560.30638161713;12190.329531875832;12274.14081014356;12278.938605306916 19:37:47 INFO - PROCESS | 20711 | |3;mootools.html;1486.6655002624407;1506.5555661079982;1684.191588037742;1780.3412737287206;1843.1429385335825;8250.752477425687;8916.242119419849;8945.329100317485;9567.234621230302;9571;9073.863892041625;9305.162535371815;9384.296177786659;9388.061193880609;9396.859047114298;2464.8890799914;2492.0405643827166;2501.9749802501924;2512.057978258153;2514.786243169333;2363.7163540375177;2430.914917977871;2439.512097580491;2445.0708730682404;2450.3506570758764;2455.656208130863;2466.7409921958115;2481.7642323979194;2488.1664642344836;2489.153687746166;2419.6249581314837;2445.4375493636476;2448.289995901195;2457.1768457566736;2464.556379851626;2382.749811269809;2383.285014495644;2404.1705611563984;2411.650310704938;2433.063270640816;9375.296852736004;9449.244060475145;9484.430934143973;9495.810083798286;9497.810043799085;5480.424555421663;5588.161775733632;5588.6646801191655;5594.104943209108;5598.356189038272;3389.305192435545;3489.354469423165;3537.646235376442;3542.0259428657328;3593.7304702147444;1122.0967121467215;1134.534840715311;1177.9352135632537;1186.649938268213;1201.9459124339426;13062.804057939233;13077.738445231138;13112.737745245136;13202.537911173158;13212.207267563977;4761.6904901181315;4824;4866.7566621668775;4929.359183306147;5035.77339019745;10816.513256903458;10825.13398928084;10866.619668311729;10881.075108615856;10918.454077296103;5531.944680553223;5554.944450555524;5574.024545704486;5587.966226248157;5590.133529302964;4508.954910450919;4949.232868905326;5084.644074914794;5105.285260063594;5112.821051263188;4200.201961627281;4294.677899157576;4305;4382.474103107584;4390.934135987963;1341.932903354848;1346.3201083452793;1357.0500649545359;1357.8438479574975;1361.251311778518;981.9950900245595;985.113397941858;990.9256805739454;994.0854413939194;1010.7119470950744;6055.424734650202;6151.384861513902;6269.811905642838;6421.068945002949;6463.64449955257;442.07826681369704;448.7285192458581;474.83380816714566;478.5190883162469;482.4307317365542;4243.384709217208;4316.503602085801;4320.503142138694;4321.69748117635;4334.068175342317;11043.392613406178;11386.943065284786;11450.656480305604;11454.599089031844;11486.655400338002;11308.038816700508;11336.319820810777;11354.716132096599;11379.203455758017;11452.94273528627;8233.46482478637;8611.052784193733;8616.956915215384;8786.12138786129;8837.160469755363;6146.508279337731;6310.211223597051;6363.236411630449;6455.322191169859;6520.119783829123;10147.84778228342;10569.524371403459;10686;10790.784184316426;10827.566897324019;10482.423466709099;10765.515551800345;10795.136389088697;10912.345259284468;10938.726531836768;7655.311022008046;7906.367490600853;8150.347972162332;8234.547099909563;8507.659693612433;8894.777630559287;8895.911040889767;8932.19610235056;8960.073584179432;8986.775330616787;8017.158198389318;8272;8351;8374.246317831425;8518.957405212934;7825.686972521263;7903.130655627761;7922.0889597694695;8032.839343212986;8090.878636820335;6855.897161542681;7398.260173982559;7435.962820185864;7463.92536074654;7490.850182996419;5268.157094864957;5366.463353664602;5439.48324909133;5476.452354764491;5618.606697531133;5267.3152490176035;5326.0945639240645;5464.617476776588;5465.125579907196;5499.50504454601 19:37:47 INFO - PROCESS | 20711 | |4;prototype.html;325.38827005230166;333.6646670096553;336.42975157108697;336.96461871503504;338.9137813308347;5597.972010139949;5734.713264336788;5754.424557544244;5758.7408566614495;5765.031009030353;5577.60559860035;5583.413741557129;5658.321001479818;5677.57418193635;5681.943180568193;4178.979105104478;4256.956660802816;4306.397104405386;4344.543822898598;4363.607275345218;4336.308839552561;4344.956550434503;4349.826006959718;4365.956340436603;4382.51792302848;4327.350897365389;4327.848525301615;4333.479982402117;4348.412694446799;4372.054435776081;4236.851710190144;4326.420856387427;4336.804843782037;4346.456692913386;4353.238183317907;3839.0786211309364;3845.3078445879732;3847.1728578355787;3848.268828922524;3882.145927895858;5438.673679579238;5461.672299662033;5476.91784623231;5486.149646804752;5514.310711161105;4799.256115302133;4911.287863259843;4954.455009948902;4997.325361076245;5016.2224855147515;5731.197632331436;5770.6249093808765;5788.479036886658;5813.883722325572;5818.679972601505;4180.205760905418;4183.686223533247;4211.220924129046;4219.122490491733;4226.598473145046;5935.851603709899;6007.849803754941;6042.607230530001;6065.878682426371;6082.90022584046;4283.593058659422;4288.2281189385585;4293.205756934977;4299.269124248885;4305.225059489259;4353.846230748854;4386.758728269976;4390.7585082820115;4395.3408188046415;4419.624331931757;4662.580367766917;4885.8045678172475;4899.755012249373;4939.209726443752;5000.874978125576;5783.65298082108;5822.301323841081;5832.795852145155;5890.823275301748;5947.940520594825;1486.1751727790963;1493.731128396899;1497.8052853129022;1499.8350181480027;1500.5873384819263;920.8204400142042;941.8963913969458;944.485255535721;981.1758123176566;983.8819341679044;5526.861828454321;5589.441055894459;5626.465485778845;5637.802676906289;5638.605297629127;5915.970420147958;5940.346561878277;5955.255593050869;5998.760049598054;6012.789552365646;5368.409474957752;5519.917201241985;5563.746682593556;5585.301837270341;5617.185508101303;3104.5343198520404;3127.937441251208;3162.6837316268648;3171.4925611901986;3205.4390481666082;5912.231409916683;6150.954337762591;6192.420932662142;6255.374462553708;6290.465310448663;6002.939970600325;6015.368386319461;6022.728977196037;6048.790241951539;6085.300190478063;6168.827922694673;6178.474829639531;6201.348858369806;6229.283632382243;6261.405166509175;5746.7701291949525;5888.882222355614;5889.764409423747;5908.084246941731;5908.911366329423;5840.970795145997;5901.675407852437;5917.349091600006;5928.318243402064;5948;5890.440408161217;6053.4261092115485;6118.724657390339;6201.2868520118955;6231.626102433868;4192.68554858393;4193.559676233952;4214.724049013621;4225.830966761295;4230.915381692411;5928.525717942641;5973.223480947449;6005.87988240224;6012.669303188367;6028.306744724237;5619.213310136666;5861.238039054895;5873.530117590497;5882.882342353215;5905.675187864708;5851.61964472308;5894.381089985662;5928.288605367384;5947.702614869326;5969.671668058299;5668.773249069991;5812.628675368361;5832.708364581669;5849.3858144894175;5939.346671866005;5972.34304226526;5989.730462129128;6009.36901625323;6016.789412370546;6065.332813390612;5792.362840087502;5811.56413268998;5876.529877609866;5906.468417842415;5918.93459177335 19:37:47 INFO - PROCESS | 20711 | |5;yui.html;683.6445048574741;734.9044624198854;783.5103060587134;799.3764863406541;844.6283635200515;16262.674746505063;17170.656586868285;17318.393856215036;17328.740068898976;17382.56543586411;15674.451394201205;15800.920995395007;15809.367625295003;15812;15817.525474235763;647.1360733420888;769.4459988808077;787.9566623835701;803.5821372886096;818.0183779464636;793.7539362797522;795.2564352330589;798.2137594469443;801.3789313282194;806.4193780478047;857.37840065952;857.6226460357454;858.3991206155684;859.2224037246302;861.4615865084322;858.219020691168;858.2318824651933;858.4720396955889;861.2507118806647;861.67687117331;625.0811307378146;626.357983067355;628.1645411602603;629.2669040567733;630.2311180359953;12256.938715306456;12320.568780092653;12333.62999110028;12389.070819688559;12533.874661253361;16011.119388433632;16064.116473593947;16100.59748506285;16106.355745770155;16219.513414597463;11293.322400655987;11327.943360283229;11674;13688.384022718901;13901.820879618828;4484.461864576239;4501.144782491317;4571.771411429415;4575.931361029588;4579.9084018319445;83543.5822820882;84730.57634711787;84963;85959;86462.56768716179;11128.332300062022;11201.551937922392;11341.489632966537;11365.65903022894;11826.88173118275;20808.687869681966;21040.894795525925;21130.894345528483;21145.471363215736;21160.259390921245;8323.583820808935;8452.535110568977;8730.126987301219;8816.955915220382;8842.911570884338;4686.695364801277;4701.694389864648;4864.440589332201;4865.318855360252;4937.629677774181;3656.305301992613;3735.813209339522;3754.3992961126637;3765.322241996467;3770.7171962102952;635.7139287320632;655.7639249870043;674.2010717300016;678.3842121492531;705.3546005404997;693.7121094745625;697.9930200698029;738.9519681220703;761.9599247027767;776.9283052941246;10004.249681273934;10514.947425262977;10576.259661823598;10833.133349332034;10944.39805810688;723.8298999735058;740.2375553180233;765.9923400766032;768.8692922203239;777.413053144872;4954.256861470736;5046.621503387188;5071.163258062452;5093.974530127326;5116.616253780981;114090;125557;126481;130050;132829;85770.57114714387;109940;110213;111395;112371.43814280877;62770;83233;98736.50631746795;100973;101663.98336016694;9420.838717023395;9815.411075335503;9824.164945979672;9895.752606184902;9903.801923961624;58106.418935811795;58161.4183858156;58406.707966461596;58549.70725146347;59261;81912.18087819284;84376.57811710902;85416.14583854082;86136;86896.56551717455;12106.818397724217;12280.263184208976;12308.199967002116;12363.381830908598;12703.110782245154;13766.793498097737;14141.6464588382;14478.420863165355;14535.636609084857;15324.080555166725;13245.403956821774;13288.800667990181;13602.455901764215;13871.514496992557;14159.787603185754;13103.60689179326;13210.339483026002;13277.867221327662;13334.799978000145;13464.192148471124;13171.275579842817;13398.69118415479;13733.931330343285;13852.722945541234;14393.208373539555;10782.460876955964;10805.747653307204;11144.721381965515;11361.261518001304;11592.1305902056;9261.398009129385;10071.446070465901;10491.842622360518;10886.891131088587;10990.120790336914 19:37:47 INFO - PROCESS | 20711 | __end_tp_report 19:37:47 INFO - PROCESS | 20711 | __start_cc_report 19:37:47 INFO - PROCESS | 20711 | _x_x_mozilla_cycle_collect,334 19:37:47 INFO - PROCESS | 20711 | __end_cc_report 19:37:47 INFO - PROCESS | 20711 | __startTimestamp1470710267482__endTimestamp 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | ------- Summary: start ------- 19:37:47 INFO - PROCESS | 20711 | Number of tests: 6 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | [#0] dojo.html Cycles:165 Average:5451.30 Median:5678.57 stddev:627.36 (11.0%) stddev-sans-first:601.32 19:37:47 INFO - PROCESS | 20711 | Values: 3090.2 3099.6 3125.8 3131.4 3134.6 5398.7 5471.1 5501.8 5513.9 5549.0 5428.8 5432.3 5434.8 5489.7 5516.6 4970.4 5014.4 5049.5 5082.4 5167.2 4719.6 5118.5 5169.0 5184.2 5224.1 4865.1 4950.9 4972.2 5040.4 5068.4 4981.0 4987.7 4988.9 5012.4 5038.0 4939.0 4955.1 4964.4 4972.3 5032.6 5360.3 5360.3 5445.3 5493.0 5500.1 5875.1 5879.0 5880.0 5896.9 5901.8 5928.7 5935.6 5935.9 5937.5 5945.1 5322.6 5388.6 5430.2 5430.5 5502.6 5975.7 5998.0 5998.3 6002.5 6010.2 5718.6 5741.8 5744.0 5768.0 5770.4 5714.0 5738.8 5746.1 5772.2 5782.3 5772.8 5816.9 5821.8 5841.4 5867.0 5786.6 5904.0 5923.3 5925.3 5937.7 4432.6 4450.5 4455.6 4493.4 4496.5 3959.6 3977.8 3990.9 4010.5 4030.5 5588.7 5594.8 5603.1 5621.3 5622.4 5696.3 5778.1 5830.9 5892.9 5921.1 5583.4 5598.3 5620.6 5634.2 5635.0 4978.7 4984.7 4990.7 4998.5 5064.2 5957.5 6026.1 6072.4 6077.8 6112.7 5880.6 5882.5 5898.6 5923.2 5950.0 6015.4 6089.4 6105.8 6118.7 6124.1 5640.7 5738.0 5777.2 5789.3 5815.4 5944.3 5944.6 5946.2 5988.8 6000.0 5782.5 5785.4 5787.7 5791.4 5822.9 5607.0 5677.4 5715.3 5717.2 5739.2 5678.6 5679.1 5685.4 5695.7 5738.7 5705.0 5739.6 5786.5 5809.5 5809.9 5482.8 5639.5 5656.2 5675.3 5689.1 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | [#1] ext.html Cycles:180 Average:59396.89 Median:41099.19 stddev:119759.90 (291.4%) stddev-sans-first:120014.34 19:37:47 INFO - PROCESS | 20711 | Values: 543.4 586.2 587.4 600.4 617.1 39466.4 43579.8 43614.6 43644.3 43764.2 44543.6 45264.3 45576.8 45668.5 45730.1 8867.5 8921.6 8931.2 8957.6 9011.5 8915.7 8975.0 9000.2 9005.5 9017.4 8993.4 9015.5 9030.5 9041.7 9045.4 8934.8 8969.6 8995.2 9012.1 9013.1 8856.0 8910.0 8923.8 8930.6 8937.1 40414.0 41043.4 41155.0 41178.0 41202.4 2867.4 3315.4 3491.6 3809.1 4013.7 32651.7 32666.3 32667.2 32983.7 33824.8 4236.1 4257.9 4258.4 4424.7 4431.5 320060.0 320394.0 320415.0 321137.4 321147.0 36720.3 36729.7 36746.4 36816.8 36859.8 37917.4 38042.8 38175.4 38329.2 38349.0 14608.3 14725.9 14778.7 14808.0 16260.0 12327.2 12657.7 12668.6 12669.5 12688.2 19662.0 19863.9 19874.7 19950.8 19980.6 7205.8 7340.2 7380.8 7394.2 7447.5 1030.9 1055.3 1095.3 1153.5 1160.9 34408.3 34796.7 34805.8 34945.5 35119.6 992.9 1036.8 1042.6 1072.4 1155.0 16542.3 18067.2 18095.3 18141.3 18222.3 587037.0 588232.0 591003.0 591293.0 592921.0 61519.0 61760.7 62188.4 62283.0 62386.0 1325.0 1371.4 1377.2 1380.9 1392.5 31849.8 34274.8 34387.5 34487.8 34536.8 54011.0 54036.5 54442.5 54475.2 54529.0 376381.0 376711.0 377677.0 380671.0 465641.0 29675.6 29889.7 30135.7 30490.4 30630.0 50502.7 51296.0 51542.0 51982.0 52227.2 42469.0 42913.8 43398.6 43953.6 44833.8 43724.0 43890.0 44190.0 44978.3 44997.1 42258.0 42801.9 43067.4 43604.3 43678.6 36313.8 38884.4 38923.0 39571.8 39622.8 28931.7 29160.6 29227.0 29371.6 29758.3 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | [#2] jquery.html Cycles:180 Average:28384.15 Median:13389.79 stddev:76143.38 (568.7%) stddev-sans-first:76327.95 19:37:47 INFO - PROCESS | 20711 | Values: 381.9 387.2 409.8 414.0 420.3 18546.3 19749.3 20120.4 20227.0 20310.5 19223.5 19736.1 19955.0 19963.1 20126.6 5533.1 5845.4 5930.9 5998.6 6019.1 5881.1 5892.7 5928.5 5929.7 5939.5 5804.0 5949.6 5962.5 5965.1 5980.6 5908.0 5916.5 5957.0 5964.9 5985.6 5327.8 5344.9 5348.3 5349.8 5352.4 23304.1 23629.4 23735.4 24012.5 24341.3 2438.3 2502.8 2593.0 2964.4 3139.9 14667.4 14999.9 15328.8 15560.5 15610.4 2001.0 2006.6 2042.3 2074.1 2081.5 80333.2 81995.2 82101.0 82469.0 84823.0 10241.8 10557.8 10787.8 10926.5 11229.2 15182.6 15264.3 15356.8 15365.1 15370.7 7904.2 8001.2 8241.3 8255.6 8288.5 7411.4 7491.9 7535.1 7578.8 7917.2 6392.6 6658.4 6675.1 6794.3 6822.5 1902.2 1929.3 1966.8 1973.5 1996.7 1048.0 1063.9 1063.9 1079.3 1134.5 20457.8 20981.5 21043.3 21113.7 21224.5 1037.4 1064.6 1073.6 1078.4 1084.5 11081.6 11787.4 11949.7 11997.7 12018.8 447563.0 449908.0 458797.0 469491.0 484203.0 81034.2 82859.6 83514.2 83602.0 84576.0 975.0 989.0 996.3 1009.6 1015.1 17215.1 17634.2 18242.2 18399.0 18605.3 38740.8 39413.4 40135.4 40393.6 41622.2 51206.5 59939.7 60908.7 61858.7 63780.4 7766.6 7961.0 8083.9 8131.5 8240.6 12900.6 13919.2 13934.2 13952.2 13979.2 11379.9 11578.4 12148.6 12298.7 12348.8 11436.5 11670.5 11898.9 11980.5 12166.4 12155.8 12170.7 12347.6 12423.0 12626.0 8055.0 8092.4 8150.9 8180.4 8268.7 9824.0 11560.3 12190.3 12274.1 12278.9 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | [#3] mootools.html Cycles:180 Average:6100.61 Median:2620.10 stddev:3495.97 (133.4%) stddev-sans-first:3488.58 19:37:47 INFO - PROCESS | 20711 | Values: 1486.7 1506.6 1684.2 1780.3 1843.1 8250.8 8916.2 8945.3 9567.2 9571.0 9073.9 9305.2 9384.3 9388.1 9396.9 2464.9 2492.0 2502.0 2512.1 2514.8 2363.7 2430.9 2439.5 2445.1 2450.4 2455.7 2466.7 2481.8 2488.2 2489.2 2419.6 2445.4 2448.3 2457.2 2464.6 2382.7 2383.3 2404.2 2411.7 2433.1 9375.3 9449.2 9484.4 9495.8 9497.8 5480.4 5588.2 5588.7 5594.1 5598.4 3389.3 3489.4 3537.6 3542.0 3593.7 1122.1 1134.5 1177.9 1186.6 1201.9 13062.8 13077.7 13112.7 13202.5 13212.2 4761.7 4824.0 4866.8 4929.4 5035.8 10816.5 10825.1 10866.6 10881.1 10918.5 5531.9 5554.9 5574.0 5588.0 5590.1 4509.0 4949.2 5084.6 5105.3 5112.8 4200.2 4294.7 4305.0 4382.5 4390.9 1341.9 1346.3 1357.1 1357.8 1361.3 982.0 985.1 990.9 994.1 1010.7 6055.4 6151.4 6269.8 6421.1 6463.6 442.1 448.7 474.8 478.5 482.4 4243.4 4316.5 4320.5 4321.7 4334.1 11043.4 11386.9 11450.7 11454.6 11486.7 11308.0 11336.3 11354.7 11379.2 11452.9 8233.5 8611.1 8617.0 8786.1 8837.2 6146.5 6310.2 6363.2 6455.3 6520.1 10147.8 10569.5 10686.0 10790.8 10827.6 10482.4 10765.5 10795.1 10912.3 10938.7 7655.3 7906.4 8150.3 8234.5 8507.7 8894.8 8895.9 8932.2 8960.1 8986.8 8017.2 8272.0 8351.0 8374.2 8519.0 7825.7 7903.1 7922.1 8032.8 8090.9 6855.9 7398.3 7436.0 7463.9 7490.9 5268.2 5366.5 5439.5 5476.5 5618.6 5267.3 5326.1 5464.6 5465.1 5499.5 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | [#4] prototype.html Cycles:180 Average:4925.51 Median:5673.17 stddev:1454.69 (25.6%) stddev-sans-first:1417.20 19:37:47 INFO - PROCESS | 20711 | Values: 325.4 333.7 336.4 337.0 338.9 5598.0 5734.7 5754.4 5758.7 5765.0 5577.6 5583.4 5658.3 5677.6 5681.9 4179.0 4257.0 4306.4 4344.5 4363.6 4336.3 4345.0 4349.8 4366.0 4382.5 4327.4 4327.8 4333.5 4348.4 4372.1 4236.9 4326.4 4336.8 4346.5 4353.2 3839.1 3845.3 3847.2 3848.3 3882.1 5438.7 5461.7 5476.9 5486.1 5514.3 4799.3 4911.3 4954.5 4997.3 5016.2 5731.2 5770.6 5788.5 5813.9 5818.7 4180.2 4183.7 4211.2 4219.1 4226.6 5935.9 6007.8 6042.6 6065.9 6082.9 4283.6 4288.2 4293.2 4299.3 4305.2 4353.8 4386.8 4390.8 4395.3 4419.6 4662.6 4885.8 4899.8 4939.2 5000.9 5783.7 5822.3 5832.8 5890.8 5947.9 1486.2 1493.7 1497.8 1499.8 1500.6 920.8 941.9 944.5 981.2 983.9 5526.9 5589.4 5626.5 5637.8 5638.6 5916.0 5940.3 5955.3 5998.8 6012.8 5368.4 5519.9 5563.7 5585.3 5617.2 3104.5 3127.9 3162.7 3171.5 3205.4 5912.2 6151.0 6192.4 6255.4 6290.5 6002.9 6015.4 6022.7 6048.8 6085.3 6168.8 6178.5 6201.3 6229.3 6261.4 5746.8 5888.9 5889.8 5908.1 5908.9 5841.0 5901.7 5917.3 5928.3 5948.0 5890.4 6053.4 6118.7 6201.3 6231.6 4192.7 4193.6 4214.7 4225.8 4230.9 5928.5 5973.2 6005.9 6012.7 6028.3 5619.2 5861.2 5873.5 5882.9 5905.7 5851.6 5894.4 5928.3 5947.7 5969.7 5668.8 5812.6 5832.7 5849.4 5939.3 5972.3 5989.7 6009.4 6016.8 6065.3 5792.4 5811.6 5876.5 5906.5 5918.9 19:37:47 INFO - PROCESS | 20711 | 19:37:47 INFO - PROCESS | 20711 | [#5] yui.html Cycles:180 Average:22189.09 Median:4492.80 stddev:32913.40 (732.6%) stddev-sans-first:32966.12 19:37:47 INFO - PROCESS | 20711 | Values: 683.6 734.9 783.5 799.4 844.6 16262.7 17170.7 17318.4 17328.7 17382.6 15674.5 15800.9 15809.4 15812.0 15817.5 647.1 769.4 788.0 803.6 818.0 793.8 795.3 798.2 801.4 806.4 857.4 857.6 858.4 859.2 861.5 858.2 858.2 858.5 861.3 861.7 625.1 626.4 628.2 629.3 630.2 12256.9 12320.6 12333.6 12389.1 12533.9 16011.1 16064.1 16100.6 16106.4 16219.5 11293.3 11327.9 11674.0 13688.4 13901.8 4484.5 4501.1 4571.8 4575.9 4579.9 83543.6 84730.6 84963.0 85959.0 86462.6 11128.3 11201.6 11341.5 11365.7 11826.9 20808.7 21040.9 21130.9 21145.5 21160.3 8323.6 8452.5 8730.1 8817.0 8842.9 4686.7 4701.7 4864.4 4865.3 4937.6 3656.3 3735.8 3754.4 3765.3 3770.7 635.7 655.8 674.2 678.4 705.4 693.7 698.0 739.0 762.0 776.9 10004.2 10514.9 10576.3 10833.1 10944.4 723.8 740.2 766.0 768.9 777.4 4954.3 5046.6 5071.2 5094.0 5116.6 114090.0 125557.0 126481.0 130050.0 132829.0 85770.6 109940.0 110213.0 111395.0 112371.4 62770.0 83233.0 98736.5 100973.0 101664.0 9420.8 9815.4 9824.2 9895.8 9903.8 58106.4 58161.4 58406.7 58549.7 59261.0 81912.2 84376.6 85416.1 86136.0 86896.6 12106.8 12280.3 12308.2 12363.4 12703.1 13766.8 14141.6 14478.4 14535.6 15324.1 13245.4 13288.8 13602.5 13871.5 14159.8 13103.6 13210.3 13277.9 13334.8 13464.2 13171.3 13398.7 13733.9 13852.7 14393.2 10782.5 10805.7 11144.7 11361.3 11592.1 9261.4 10071.4 10491.8 10886.9 10990.1 19:37:47 INFO - PROCESS | 20711 | -------- Summary: end -------- 19:37:47 INFO - PROCESS | 20711 | 19:37:48 INFO - TEST-INFO | 20711: exit 0 19:37:48 INFO - TEST-OK | dromaeo_css | took 1112482ms 19:37:48 INFO - TEST-START | kraken 19:37:48 INFO - operating with platform_type : linux_ 19:37:48 INFO - Initialising browser for kraken test... 19:37:48 INFO - TEST-INFO | started process 20957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6r8iY/profile http://localhost:59698/getInfo.html) 19:37:52 INFO - PROCESS | 20957 | __metrics Screen width/height:1600/1200 19:37:52 INFO - PROCESS | 20957 | colorDepth:24 19:37:52 INFO - PROCESS | 20957 | Browser inner width/height: 1024/697 19:37:52 INFO - PROCESS | 20957 | __metrics 19:37:53 ERROR - PROCESS | 20957 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:37:53 INFO - TEST-INFO | 20957: exit 0 19:37:53 INFO - Browser initialized. 19:37:53 INFO - Running cycle 1/1 for kraken test... 19:37:53 INFO - TEST-INFO | started process 21077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6r8iY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:05 INFO - PROCESS | 21077 | RSS: Main: 164175872 19:38:05 INFO - PROCESS | 21077 | 19:38:08 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59698/tests/kraken/driver.html?testName=audio-beat-detection) 19:38:09 INFO - PROCESS | 21077 | RSS: Main: 169381888 19:38:09 INFO - PROCESS | 21077 | 19:38:11 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59698/tests/kraken/driver.html?testName=audio-dft) 19:38:12 INFO - PROCESS | 21077 | RSS: Main: 168931328 19:38:12 INFO - PROCESS | 21077 | 19:38:15 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59698/tests/kraken/driver.html?testName=audio-fft) 19:38:15 INFO - PROCESS | 21077 | RSS: Main: 164380672 19:38:15 INFO - PROCESS | 21077 | 19:38:17 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59698/tests/kraken/driver.html?testName=audio-oscillator) 19:38:18 INFO - PROCESS | 21077 | RSS: Main: 165154816 19:38:18 INFO - PROCESS | 21077 | 19:38:20 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59698/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:38:21 INFO - PROCESS | 21077 | RSS: Main: 166199296 19:38:21 INFO - PROCESS | 21077 | 19:38:24 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59698/tests/kraken/driver.html?testName=imaging-darkroom) 19:38:24 INFO - PROCESS | 21077 | RSS: Main: 165220352 19:38:24 INFO - PROCESS | 21077 | 19:38:28 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59698/tests/kraken/driver.html?testName=imaging-desaturate) 19:38:29 INFO - PROCESS | 21077 | RSS: Main: 163385344 19:38:29 INFO - PROCESS | 21077 | 19:38:31 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59698/tests/kraken/driver.html?testName=json-parse-financial) 19:38:32 INFO - PROCESS | 21077 | RSS: Main: 165294080 19:38:32 INFO - PROCESS | 21077 | 19:38:34 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59698/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:38:34 INFO - PROCESS | 21077 | RSS: Main: 165773312 19:38:34 INFO - PROCESS | 21077 | 19:38:36 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:38:37 INFO - PROCESS | 21077 | RSS: Main: 165265408 19:38:37 INFO - PROCESS | 21077 | 19:38:39 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:38:39 INFO - PROCESS | 21077 | RSS: Main: 166035456 19:38:39 INFO - PROCESS | 21077 | 19:38:42 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:38:43 INFO - PROCESS | 21077 | RSS: Main: 165654528 19:38:43 INFO - PROCESS | 21077 | 19:38:45 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:38:46 INFO - PROCESS | 21077 | RSS: Main: 166244352 19:38:46 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:59698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59698/tests/kraken/driver.html?testName=ai-astar) 19:38:48 INFO - PROCESS | 21077 | RSS: Main: 167137280 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | __start_tp_report 19:38:48 INFO - PROCESS | 21077 | _x_x_mozilla_page_load 19:38:48 INFO - PROCESS | 21077 | _x_x_mozilla_page_load_details 19:38:48 INFO - PROCESS | 21077 | |i|pagename|runs| 19:38:48 INFO - PROCESS | 21077 | |0;ai-astar;104;113;108;112;111;114;112;112;110;112 19:38:48 INFO - PROCESS | 21077 | |1;audio-beat-detection;149;118;143;183;120;148;148;128;180;122 19:38:48 INFO - PROCESS | 21077 | |2;audio-dft;162;162;164;163;161;163;171;162;162;165 19:38:48 INFO - PROCESS | 21077 | |3;audio-fft;76;75;77;137;77;76;75;75;177;74 19:38:48 INFO - PROCESS | 21077 | |4;audio-oscillator;85;83;160;84;84;85;142;85;84;134 19:38:48 INFO - PROCESS | 21077 | |5;imaging-gaussian-blur;118;117;118;117;118;118;118;118;118;118 19:38:48 INFO - PROCESS | 21077 | |6;imaging-darkroom;148;147;148;147;147;146;147;148;147;147 19:38:48 INFO - PROCESS | 21077 | |7;imaging-desaturate;96;96;97;96;95;96;96;101;96;96 19:38:48 INFO - PROCESS | 21077 | |8;json-parse-financial;52;51;52;51;51;51;52;52;50;52 19:38:48 INFO - PROCESS | 21077 | |9;json-stringify-tinderbox;64;63;63;61;62;61;62;61;61;62 19:38:48 INFO - PROCESS | 21077 | |10;stanford-crypto-aes;82;76;82;77;77;78;76;82;81;76 19:38:48 INFO - PROCESS | 21077 | |11;stanford-crypto-ccm;125;133;124;124;132;125;133;131;185;130 19:38:48 INFO - PROCESS | 21077 | |12;stanford-crypto-pbkdf2;164;163;160;161;160;162;159;161;160;165 19:38:48 INFO - PROCESS | 21077 | |13;stanford-crypto-sha256-iterative;64;65;66;63;65;63;63;63;69;66 19:38:48 INFO - PROCESS | 21077 | __end_tp_report 19:38:48 INFO - PROCESS | 21077 | __start_cc_report 19:38:48 INFO - PROCESS | 21077 | _x_x_mozilla_cycle_collect,852 19:38:48 INFO - PROCESS | 21077 | __end_cc_report 19:38:48 INFO - PROCESS | 21077 | __startTimestamp1470710328413__endTimestamp 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | ------- Summary: start ------- 19:38:48 INFO - PROCESS | 21077 | Number of tests: 14 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.90 (2.6%) stddev-sans-first:1.74 19:38:48 INFO - PROCESS | 21077 | Values: 104.0 113.0 108.0 112.0 111.0 114.0 112.0 112.0 110.0 112.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:148.00 stddev:23.25 (15.7%) stddev-sans-first:24.59 19:38:48 INFO - PROCESS | 21077 | Values: 149.0 118.0 143.0 183.0 120.0 148.0 148.0 128.0 180.0 122.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 19:38:48 INFO - PROCESS | 21077 | Values: 162.0 162.0 164.0 163.0 161.0 163.0 171.0 162.0 162.0 165.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.50 stddev:35.59 (47.1%) stddev-sans-first:37.29 19:38:48 INFO - PROCESS | 21077 | Values: 76.0 75.0 77.0 137.0 77.0 76.0 75.0 75.0 177.0 74.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:30.16 (35.9%) stddev-sans-first:31.31 19:38:48 INFO - PROCESS | 21077 | Values: 85.0 83.0 160.0 84.0 84.0 85.0 142.0 85.0 84.0 134.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:38:48 INFO - PROCESS | 21077 | Values: 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 19:38:48 INFO - PROCESS | 21077 | Values: 148.0 147.0 148.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 19:38:48 INFO - PROCESS | 21077 | Values: 96.0 96.0 97.0 96.0 95.0 96.0 96.0 101.0 96.0 96.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 19:38:48 INFO - PROCESS | 21077 | Values: 52.0 51.0 52.0 51.0 51.0 51.0 52.0 52.0 50.0 52.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.05 (1.7%) stddev-sans-first:0.83 19:38:48 INFO - PROCESS | 21077 | Values: 64.0 63.0 63.0 61.0 62.0 61.0 62.0 61.0 61.0 62.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.50 stddev:2.71 (3.4%) stddev-sans-first:2.60 19:38:48 INFO - PROCESS | 21077 | Values: 82.0 76.0 82.0 77.0 77.0 78.0 76.0 82.0 81.0 76.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:131.50 stddev:18.24 (13.9%) stddev-sans-first:19.04 19:38:48 INFO - PROCESS | 21077 | Values: 125.0 133.0 124.0 124.0 132.0 125.0 133.0 131.0 185.0 130.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.50 stddev:1.96 (1.2%) stddev-sans-first:1.86 19:38:48 INFO - PROCESS | 21077 | Values: 164.0 163.0 160.0 161.0 160.0 162.0 159.0 161.0 160.0 165.0 19:38:48 INFO - PROCESS | 21077 | 19:38:48 INFO - PROCESS | 21077 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.95 (3.0%) stddev-sans-first:2.05 19:38:48 INFO - PROCESS | 21077 | Values: 64.0 65.0 66.0 63.0 65.0 63.0 63.0 63.0 69.0 66.0 19:38:48 INFO - PROCESS | 21077 | -------- Summary: end -------- 19:38:48 INFO - PROCESS | 21077 | 19:38:49 INFO - TEST-INFO | 21077: exit 0 19:38:49 INFO - TEST-OK | kraken | took 61112ms 19:38:49 INFO - SUITE-END | took 1173s 19:38:49 INFO - Completed test suite (00:19:33) 19:38:49 INFO - javascript benchmark 19:38:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7453.597786216194, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.196548897287, 3099.6435409927867, 3125.8437078146085, 3131.4050330437217, 3134.576832127662, 5398.73006349682, 5471.06991811392, 5501.807436739715, 5513.9448605513935, 5549.0289199390145, 5428.782848686058, 5432.320959880015, 5434.809781657643, 5489.725513724307, 5516.641418307807, 4970.403551573816, 5014.448410674823, 5049.520295571915, 5082.440931497532, 5167.199084141946, 4719.575238228559, 5118.488151184889, 5168.974155129219, 5184.248283998818, 5224.111900976843, 4865.05131499356, 4950.900981980376, 4972.229304457815, 5040.36995375578, 5068.4424713281505, 4980.97889932563, 4987.725675087869, 4988.850334489971, 5012.423571289312, 5038.042771873369, 4938.950610493921, 4955.1080805455, 4964.379452568429, 4972.303877457159, 5032.572231360339, 5360.303160589098, 5360.303160589137, 5445.319335083114, 5493.0, 5500.092484740013, 5875.118732190205, 5879.029960056586, 5879.970600147015, 5896.941030589682, 5901.822945311647, 5928.6739229342365, 5935.643861368331, 5935.9406405935815, 5937.495312898409, 5945.108233764927, 5322.574194064504, 5388.568914486832, 5430.185472179165, 5430.484104010113, 5502.614816962854, 5975.67133807636, 5998.040313549811, 5998.340182579913, 6002.4897883679505, 6010.248718910137, 5718.571107166979, 5741.7990370337675, 5743.971280143656, 5768.048272035151, 5770.3652598215, 5714.0, 5738.8278351649515, 5746.0519014363, 5772.191893134965, 5782.335031471351, 5772.826815195551, 5816.88366232673, 5821.825345239649, 5841.357450680422, 5866.970665146647, 5786.594938354275, 5903.970480147572, 5923.259592550931, 5925.259342582177, 5937.70311484424, 4432.601065904019, 4450.488193857683, 4455.643548516111, 4493.438320209973, 4496.505384407713, 3959.604039596017, 3977.801109944491, 3990.940135897964, 4010.4585880905706, 4030.4558884550797, 5588.692621905834, 5594.832155035274, 5603.13151461516, 5621.269234999424, 5622.353429355595, 5696.259486266758, 5778.104393818965, 5830.854228644318, 5892.94107058924, 5921.141434491975, 5583.4137415571595, 5598.3282006159525, 5620.57845661577, 5634.23937768396, 5635.013872572284, 4978.701277923336, 4984.651074424755, 4990.725510096907, 4998.525140111684, 5064.215046667772, 5957.4638282553915, 6026.096085587197, 6072.392760723892, 6077.817665470043, 6112.724927378279, 5880.588358814842, 5882.5293976480925, 5898.64608123514, 5923.170756094237, 5950.018246989372, 6015.428534289235, 6089.360617135314, 6105.786297479567, 6118.694065296806, 6124.050772130327, 5640.717964101696, 5737.971310143423, 5777.191193233035, 5789.305283366023, 5815.360310365941, 5944.256967879015, 5944.613600115978, 5946.226990491382, 5988.790392336247, 5999.970000149971, 5782.479576837936, 5785.363610002981, 5787.681677507778, 5791.420857914175, 5822.94177058241, 5607.046802043744, 5677.432256774289, 5715.2855893013375, 5717.22817419643, 5739.196512488172, 5678.574106942078, 5679.148127780866, 5685.403032681675, 5695.658260504383, 5738.655680659173, 5704.971475142598, 5739.598228123991, 5786.537077033743, 5809.5352371811, 5809.912851307149, 5482.780688772405, 5639.54883609302, 5656.208130861601, 5675.31896172462, 5689.061304884648], "value": 5407.9743898975585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.3917010970891, 586.1588620329827, 587.3861814403947, 600.3516202501297, 617.0928734759907, 39466.40800387993, 43579.78210108953, 43614.56385436145, 43644.345334820006, 43764.15532990354, 44543.554564454345, 45264.3210351845, 45576.77211613937, 45668.54331456693, 45730.085398292016, 8867.512286824222, 8921.643134274622, 8931.196192342688, 8957.552122393854, 9011.504367259831, 8915.68795092172, 8974.955125224365, 9000.189982901538, 9005.54972251388, 9017.36878418511, 8993.415427997192, 9015.504147271897, 9030.50332231727, 9041.683541076063, 9045.412048216878, 8934.776630584221, 8969.596368163415, 8995.235404990584, 9012.143846334588, 9013.05362936892, 8855.955720221358, 8910.0, 8923.821523569557, 8930.642774289021, 8937.106289371011, 40414.0, 41043.38434923479, 41155.0, 41178.0, 41202.38196427056, 2867.3978464522474, 3315.4032274190636, 3491.598466176397, 3809.142942837867, 4013.7391069580385, 32651.673483265102, 32666.346673066644, 32667.183320417178, 32983.6701632983, 33824.830875845706, 4236.08924081324, 4257.850975215883, 4258.382534532476, 4424.668149888771, 4431.534688857656, 320060.0, 320394.0, 320415.0, 321137.3943130293, 321147.0, 36720.26559468849, 36729.69432751065, 36746.44880326797, 36816.815915920786, 36859.81570092186, 37917.43123853144, 38042.80978595089, 38175.427368589495, 38329.23341533209, 38349.0, 14608.269586520631, 14725.852741472449, 14778.704425911637, 14808.03747756414, 16260.0, 12327.198732082386, 12657.683557911127, 12668.619941401772, 12669.49322027127, 12688.238705677504, 19662.016899154984, 19863.900680496794, 19874.70187947182, 19950.800491995185, 19980.60329743947, 7205.7838264852135, 7340.192578816326, 7380.815479613053, 7394.223606521237, 7447.515911465737, 1030.9432981185957, 1055.2613170780485, 1095.3482677806692, 1153.5385845661801, 1160.8665003524534, 34408.311833763684, 34796.65203347985, 34805.825970869984, 34945.47581786275, 35119.648803511634, 992.8808542974745, 1036.7563622548696, 1042.5777560088177, 1072.3887384191091, 1154.9605355180404, 16542.255598498097, 18067.186976586087, 18095.276188952295, 18141.274349026156, 18222.27110915575, 587037.0, 588232.0, 591003.0, 591293.0, 592921.0, 61519.0, 61760.69119654373, 62188.37811621826, 62283.0, 62386.0, 1324.9933750331186, 1371.430856194688, 1377.1668140774887, 1380.9447622095004, 1392.4778208171936, 31849.815018497964, 34274.82862585671, 34387.484187737704, 34487.82756086203, 34536.76072632709, 54011.0, 54036.459635403146, 54442.45557544374, 54475.182872256155, 54529.0, 376381.0, 376711.0, 377677.0, 380671.0, 465641.0, 29675.55486667745, 29889.701102989562, 30135.69864301329, 30490.390192195588, 30630.0, 50502.747486262335, 51296.0, 51542.0, 51982.0, 52227.216591751916, 42469.0, 42913.78543107265, 43398.572369757625, 43953.56046439495, 44833.775831120634, 43724.0, 43890.0, 44190.0, 44978.3253251208, 44997.10005799931, 42258.0, 42801.92995175145, 43067.35398968955, 43604.34593481037, 43678.56321436872, 36313.81843090873, 38884.416733748454, 38923.0, 39571.8342532591, 39622.80188599154, 28931.710682892903, 29160.56259156072, 29227.0, 29371.559426609045, 29758.25604359908], "value": 19970.958276565034, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.89116101910963, 387.24100762505486, 409.84016233668865, 413.9523954745204, 420.25614662048173, 18546.258149674013, 19749.321307688864, 20120.39638810838, 20226.99999999998, 20310.492237694067, 19223.519412014706, 19736.111874965623, 19955.0, 19963.10166042528, 20126.59746805063, 5533.08704063829, 5845.357010728816, 5930.940690593104, 5998.610090344136, 6019.067044608093, 5881.117832325164, 5892.675902825343, 5928.496077833368, 5929.673867937262, 5939.524838012971, 5804.0, 5949.643021418707, 5962.493188079018, 5965.105234214859, 5980.6112602680905, 5908.0, 5916.526677865761, 5957.0, 5964.850878728045, 5985.5810093293485, 5327.760250788724, 5344.946550534483, 5348.251244825728, 5349.759260833272, 5352.384475785296, 23304.06783728649, 23629.409264768346, 23735.406614834596, 24012.51974960491, 24341.26976190717, 2438.30508305134, 2502.8122890783266, 2593.0, 2964.4219377221234, 3139.905802825896, 14667.413303467849, 14999.925000374928, 15328.846711532853, 15560.533184004498, 15610.375584976588, 2000.9799902000939, 2006.5585571174317, 2042.3158241988804, 2074.097767471155, 2081.458820706612, 80333.19666803315, 81995.18004819936, 82101.0, 82469.0, 84823.0, 10241.795164096677, 10557.841632375521, 10787.784244315228, 10926.453677316102, 11229.157813164045, 15182.620434489227, 15264.313105910262, 15356.846431535765, 15365.078095314317, 15370.692586148214, 7904.249096335954, 8001.239882211181, 8241.25828675422, 8255.628496717542, 8288.461250018729, 7411.407087432993, 7491.887621685679, 7535.095788505414, 7578.81052973669, 7917.168697286817, 6392.552521323556, 6658.400743932973, 6675.132232809704, 6794.279124323586, 6822.522423430312, 1902.1630482587618, 1929.2861641192567, 1966.763988321382, 1973.506623344164, 1996.6705493593395, 1048.0462778871342, 1063.8616979792578, 1063.8989296016866, 1079.2930630437077, 1134.5461815273957, 20457.79542204559, 20981.475463113544, 21043.263485777923, 21113.677495475484, 21224.469388265417, 1037.3568387599737, 1064.5848119233506, 1073.640330489295, 1078.428432930548, 1084.511969613677, 11081.612143574936, 11787.35169565665, 11949.701257468632, 11997.700057498632, 12018.819717704242, 447563.0, 449908.0, 458797.0, 469491.0, 484203.0, 81034.18965810267, 82859.5857020711, 83514.16485835063, 83602.0, 84576.0, 974.9756256093655, 988.9851652225223, 996.342414006752, 1009.6365308488938, 1015.0509273828847, 17215.053172075655, 17634.206460709043, 18242.17910194018, 18399.0, 18605.255789768256, 38740.80629596834, 39413.408798868615, 40135.39796903107, 40393.59606404016, 41622.1675566493, 51206.48793512166, 59939.70030149821, 60908.69545652244, 61858.69070654618, 63780.3621963793, 7766.611669416619, 7960.960195198987, 8083.919160808552, 8131.471454355448, 8240.629171687408, 12900.612981610191, 13919.16485010862, 13934.233617151154, 13952.232627205602, 13979.161250325013, 11379.943100284445, 11578.421078946187, 12148.635540933787, 12298.692532686755, 12348.81476777831, 11436.485358158736, 11670.533178672758, 11898.940505297418, 11980.460879260629, 12166.391680415767, 12155.81766273489, 12170.695732606755, 12347.567835125728, 12423.0, 12626.0, 8054.959725201336, 8092.4335296531035, 8150.877736833833, 8180.427370084037, 8268.710595129141, 9823.950880245553, 11560.30638161713, 12190.329531875832, 12274.14081014356, 12278.938605306916], "value": 9555.666631223712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.6655002624407, 1506.5555661079982, 1684.191588037742, 1780.3412737287206, 1843.1429385335825, 8250.752477425687, 8916.242119419849, 8945.329100317485, 9567.234621230302, 9571.0, 9073.863892041625, 9305.162535371815, 9384.296177786659, 9388.061193880609, 9396.859047114298, 2464.8890799914, 2492.0405643827166, 2501.9749802501924, 2512.057978258153, 2514.786243169333, 2363.7163540375177, 2430.914917977871, 2439.512097580491, 2445.0708730682404, 2450.3506570758764, 2455.656208130863, 2466.7409921958115, 2481.7642323979194, 2488.1664642344836, 2489.153687746166, 2419.6249581314837, 2445.4375493636476, 2448.289995901195, 2457.1768457566736, 2464.556379851626, 2382.749811269809, 2383.285014495644, 2404.1705611563984, 2411.650310704938, 2433.063270640816, 9375.296852736004, 9449.244060475145, 9484.430934143973, 9495.810083798286, 9497.810043799085, 5480.424555421663, 5588.161775733632, 5588.6646801191655, 5594.104943209108, 5598.356189038272, 3389.305192435545, 3489.354469423165, 3537.646235376442, 3542.0259428657328, 3593.7304702147444, 1122.0967121467215, 1134.534840715311, 1177.9352135632537, 1186.649938268213, 1201.9459124339426, 13062.804057939233, 13077.738445231138, 13112.737745245136, 13202.537911173158, 13212.207267563977, 4761.6904901181315, 4824.0, 4866.7566621668775, 4929.359183306147, 5035.77339019745, 10816.513256903458, 10825.13398928084, 10866.619668311729, 10881.075108615856, 10918.454077296103, 5531.944680553223, 5554.944450555524, 5574.024545704486, 5587.966226248157, 5590.133529302964, 4508.954910450919, 4949.232868905326, 5084.644074914794, 5105.285260063594, 5112.821051263188, 4200.201961627281, 4294.677899157576, 4305.0, 4382.474103107584, 4390.934135987963, 1341.932903354848, 1346.3201083452793, 1357.0500649545359, 1357.8438479574975, 1361.251311778518, 981.9950900245595, 985.113397941858, 990.9256805739454, 994.0854413939194, 1010.7119470950744, 6055.424734650202, 6151.384861513902, 6269.811905642838, 6421.068945002949, 6463.64449955257, 442.07826681369704, 448.7285192458581, 474.83380816714566, 478.5190883162469, 482.4307317365542, 4243.384709217208, 4316.503602085801, 4320.503142138694, 4321.69748117635, 4334.068175342317, 11043.392613406178, 11386.943065284786, 11450.656480305604, 11454.599089031844, 11486.655400338002, 11308.038816700508, 11336.319820810777, 11354.716132096599, 11379.203455758017, 11452.94273528627, 8233.46482478637, 8611.052784193733, 8616.956915215384, 8786.12138786129, 8837.160469755363, 6146.508279337731, 6310.211223597051, 6363.236411630449, 6455.322191169859, 6520.119783829123, 10147.84778228342, 10569.524371403459, 10686.0, 10790.784184316426, 10827.566897324019, 10482.423466709099, 10765.515551800345, 10795.136389088697, 10912.345259284468, 10938.726531836768, 7655.311022008046, 7906.367490600853, 8150.347972162332, 8234.547099909563, 8507.659693612433, 8894.777630559287, 8895.911040889767, 8932.19610235056, 8960.073584179432, 8986.775330616787, 8017.158198389318, 8272.0, 8351.0, 8374.246317831425, 8518.957405212934, 7825.686972521263, 7903.130655627761, 7922.0889597694695, 8032.839343212986, 8090.878636820335, 6855.897161542681, 7398.260173982559, 7435.962820185864, 7463.92536074654, 7490.850182996419, 5268.157094864957, 5366.463353664602, 5439.48324909133, 5476.452354764491, 5618.606697531133, 5267.3152490176035, 5326.0945639240645, 5464.617476776588, 5465.125579907196, 5499.50504454601], "value": 4789.964504725662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.38827005230166, 333.6646670096553, 336.42975157108697, 336.96461871503504, 338.9137813308347, 5597.972010139949, 5734.713264336788, 5754.424557544244, 5758.7408566614495, 5765.031009030353, 5577.60559860035, 5583.413741557129, 5658.321001479818, 5677.57418193635, 5681.943180568193, 4178.979105104478, 4256.956660802816, 4306.397104405386, 4344.543822898598, 4363.607275345218, 4336.308839552561, 4344.956550434503, 4349.826006959718, 4365.956340436603, 4382.51792302848, 4327.350897365389, 4327.848525301615, 4333.479982402117, 4348.412694446799, 4372.054435776081, 4236.851710190144, 4326.420856387427, 4336.804843782037, 4346.456692913386, 4353.238183317907, 3839.0786211309364, 3845.3078445879732, 3847.1728578355787, 3848.268828922524, 3882.145927895858, 5438.673679579238, 5461.672299662033, 5476.91784623231, 5486.149646804752, 5514.310711161105, 4799.256115302133, 4911.287863259843, 4954.455009948902, 4997.325361076245, 5016.2224855147515, 5731.197632331436, 5770.6249093808765, 5788.479036886658, 5813.883722325572, 5818.679972601505, 4180.205760905418, 4183.686223533247, 4211.220924129046, 4219.122490491733, 4226.598473145046, 5935.851603709899, 6007.849803754941, 6042.607230530001, 6065.878682426371, 6082.90022584046, 4283.593058659422, 4288.2281189385585, 4293.205756934977, 4299.269124248885, 4305.225059489259, 4353.846230748854, 4386.758728269976, 4390.7585082820115, 4395.3408188046415, 4419.624331931757, 4662.580367766917, 4885.8045678172475, 4899.755012249373, 4939.209726443752, 5000.874978125576, 5783.65298082108, 5822.301323841081, 5832.795852145155, 5890.823275301748, 5947.940520594825, 1486.1751727790963, 1493.731128396899, 1497.8052853129022, 1499.8350181480027, 1500.5873384819263, 920.8204400142042, 941.8963913969458, 944.485255535721, 981.1758123176566, 983.8819341679044, 5526.861828454321, 5589.441055894459, 5626.465485778845, 5637.802676906289, 5638.605297629127, 5915.970420147958, 5940.346561878277, 5955.255593050869, 5998.760049598054, 6012.789552365646, 5368.409474957752, 5519.917201241985, 5563.746682593556, 5585.301837270341, 5617.185508101303, 3104.5343198520404, 3127.937441251208, 3162.6837316268648, 3171.4925611901986, 3205.4390481666082, 5912.231409916683, 6150.954337762591, 6192.420932662142, 6255.374462553708, 6290.465310448663, 6002.939970600325, 6015.368386319461, 6022.728977196037, 6048.790241951539, 6085.300190478063, 6168.827922694673, 6178.474829639531, 6201.348858369806, 6229.283632382243, 6261.405166509175, 5746.7701291949525, 5888.882222355614, 5889.764409423747, 5908.084246941731, 5908.911366329423, 5840.970795145997, 5901.675407852437, 5917.349091600006, 5928.318243402064, 5948.0, 5890.440408161217, 6053.4261092115485, 6118.724657390339, 6201.2868520118955, 6231.626102433868, 4192.68554858393, 4193.559676233952, 4214.724049013621, 4225.830966761295, 4230.915381692411, 5928.525717942641, 5973.223480947449, 6005.87988240224, 6012.669303188367, 6028.306744724237, 5619.213310136666, 5861.238039054895, 5873.530117590497, 5882.882342353215, 5905.675187864708, 5851.61964472308, 5894.381089985662, 5928.288605367384, 5947.702614869326, 5969.671668058299, 5668.773249069991, 5812.628675368361, 5832.708364581669, 5849.3858144894175, 5939.346671866005, 5972.34304226526, 5989.730462129128, 6009.36901625323, 6016.789412370546, 6065.332813390612, 5792.362840087502, 5811.56413268998, 5876.529877609866, 5906.468417842415, 5918.93459177335], "value": 4453.558592473262, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.6445048574741, 734.9044624198854, 783.5103060587134, 799.3764863406541, 844.6283635200515, 16262.674746505063, 17170.656586868285, 17318.393856215036, 17328.740068898976, 17382.56543586411, 15674.451394201205, 15800.920995395007, 15809.367625295003, 15812.0, 15817.525474235763, 647.1360733420888, 769.4459988808077, 787.9566623835701, 803.5821372886096, 818.0183779464636, 793.7539362797522, 795.2564352330589, 798.2137594469443, 801.3789313282194, 806.4193780478047, 857.37840065952, 857.6226460357454, 858.3991206155684, 859.2224037246302, 861.4615865084322, 858.219020691168, 858.2318824651933, 858.4720396955889, 861.2507118806647, 861.67687117331, 625.0811307378146, 626.357983067355, 628.1645411602603, 629.2669040567733, 630.2311180359953, 12256.938715306456, 12320.568780092653, 12333.62999110028, 12389.070819688559, 12533.874661253361, 16011.119388433632, 16064.116473593947, 16100.59748506285, 16106.355745770155, 16219.513414597463, 11293.322400655987, 11327.943360283229, 11674.0, 13688.384022718901, 13901.820879618828, 4484.461864576239, 4501.144782491317, 4571.771411429415, 4575.931361029588, 4579.9084018319445, 83543.5822820882, 84730.57634711787, 84963.0, 85959.0, 86462.56768716179, 11128.332300062022, 11201.551937922392, 11341.489632966537, 11365.65903022894, 11826.88173118275, 20808.687869681966, 21040.894795525925, 21130.894345528483, 21145.471363215736, 21160.259390921245, 8323.583820808935, 8452.535110568977, 8730.126987301219, 8816.955915220382, 8842.911570884338, 4686.695364801277, 4701.694389864648, 4864.440589332201, 4865.318855360252, 4937.629677774181, 3656.305301992613, 3735.813209339522, 3754.3992961126637, 3765.322241996467, 3770.7171962102952, 635.7139287320632, 655.7639249870043, 674.2010717300016, 678.3842121492531, 705.3546005404997, 693.7121094745625, 697.9930200698029, 738.9519681220703, 761.9599247027767, 776.9283052941246, 10004.249681273934, 10514.947425262977, 10576.259661823598, 10833.133349332034, 10944.39805810688, 723.8298999735058, 740.2375553180233, 765.9923400766032, 768.8692922203239, 777.413053144872, 4954.256861470736, 5046.621503387188, 5071.163258062452, 5093.974530127326, 5116.616253780981, 114090.0, 125557.0, 126481.0, 130050.0, 132829.0, 85770.57114714387, 109940.0, 110213.0, 111395.0, 112371.43814280877, 62770.0, 83233.0, 98736.50631746795, 100973.0, 101663.98336016694, 9420.838717023395, 9815.411075335503, 9824.164945979672, 9895.752606184902, 9903.801923961624, 58106.418935811795, 58161.4183858156, 58406.707966461596, 58549.70725146347, 59261.0, 81912.18087819284, 84376.57811710902, 85416.14583854082, 86136.0, 86896.56551717455, 12106.818397724217, 12280.263184208976, 12308.199967002116, 12363.381830908598, 12703.110782245154, 13766.793498097737, 14141.6464588382, 14478.420863165355, 14535.636609084857, 15324.080555166725, 13245.403956821774, 13288.800667990181, 13602.455901764215, 13871.514496992557, 14159.787603185754, 13103.60689179326, 13210.339483026002, 13277.867221327662, 13334.799978000145, 13464.192148471124, 13171.275579842817, 13398.69118415479, 13733.931330343285, 13852.722945541234, 14393.208373539555, 10782.460876955964, 10805.747653307204, 11144.721381965515, 11361.261518001304, 11592.1305902056, 9261.398009129385, 10071.446070465901, 10491.842622360518, 10886.891131088587, 10990.120790336914], "value": 7787.891518171467, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 108.0, 112.0, 111.0, 114.0, 112.0, 112.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 143.0, 183.0, 120.0, 148.0, 148.0, 128.0, 180.0, 122.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 161.0, 163.0, 171.0, 162.0, 162.0, 165.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 137.0, 77.0, 76.0, 75.0, 75.0, 177.0, 74.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 160.0, 84.0, 84.0, 85.0, 142.0, 85.0, 84.0, 134.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 101.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 51.0, 51.0, 52.0, 52.0, 50.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 82.0, 77.0, 77.0, 78.0, 76.0, 82.0, 81.0, 76.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 133.0, 124.0, 124.0, 132.0, 125.0, 133.0, 131.0, 185.0, 130.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 160.0, 161.0, 160.0, 162.0, 159.0, 161.0, 160.0, 165.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 63.0, 65.0, 63.0, 63.0, 63.0, 69.0, 66.0], "value": 64.7, "unit": "score"}]}]} 19:38:49 INFO - Return code: 0 19:38:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:38:49 ERROR - # TBPL SUCCESS # 19:38:49 INFO - Running post-action listener: _resource_record_post_action 19:38:49 INFO - [mozharness: 2016-08-09 02:38:49.726805Z] Finished run-tests step (success) 19:38:49 INFO - Running post-run listener: _resource_record_post_run 19:38:49 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 558239744; Read time: 272; Write time: 459940 19:38:49 INFO - TinderboxPrint: CPU usage
13.4% 19:38:49 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 272 19:38:49 INFO - TinderboxPrint: I/O write bytes / time
558,239,744 / 459,940 19:38:49 INFO - TinderboxPrint: CPU idle
8,233.7 (86.6%) 19:38:49 INFO - TinderboxPrint: CPU user
1,212.7 (12.8%) 19:38:49 INFO - TinderboxPrint: Swap in / out
0 / 0 19:38:49 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 260931584; Read time: 116; Write time: 225144 19:38:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297132032; Read time: 156; Write time: 234776 19:38:50 INFO - Running post-run listener: _upload_blobber_files 19:38:50 INFO - Blob upload gear active. 19:38:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:38:50 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 19:38:50 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'] 19:38:50 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 19:38:50 INFO - (blobuploader) - INFO - Open directory for files ... 19:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:51 INFO - (blobuploader) - INFO - Done attempting. 19:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:38:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:55 INFO - (blobuploader) - INFO - Done attempting. 19:38:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:38:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:38:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:56 INFO - (blobuploader) - INFO - Done attempting. 19:38:56 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:56 INFO - Return code: 0 19:38:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:38:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a214a58dc3d7952a5229b239af9a6e051d28802422c2e832fe28e87574bf94b9a600a8108d781f0d1b3513d5af5bad259519a4b7b0a245fc01a5c9cb888ab981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a20e68b32ceaa6ad34501a7b706b1d2abb0cd3e83477ccc9b78907ff73ac81cfecdce53a0fd81bee578de65c7b8ba6ed6cda0db0b0e7494a7e6d7c6bb4bfcf54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81ffe4f4ee7d1cbd9bbc85dff936ff3f2b025b3ffb8d080826a2ba9f5fa2b9a573465e23e437921b9232c22dd32aa1890cfe75d0fd2907cfdeb7124754ad62e3"} 19:38:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:38:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:38:56 INFO - Contents: 19:38:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a214a58dc3d7952a5229b239af9a6e051d28802422c2e832fe28e87574bf94b9a600a8108d781f0d1b3513d5af5bad259519a4b7b0a245fc01a5c9cb888ab981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a20e68b32ceaa6ad34501a7b706b1d2abb0cd3e83477ccc9b78907ff73ac81cfecdce53a0fd81bee578de65c7b8ba6ed6cda0db0b0e7494a7e6d7c6bb4bfcf54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81ffe4f4ee7d1cbd9bbc85dff936ff3f2b025b3ffb8d080826a2ba9f5fa2b9a573465e23e437921b9232c22dd32aa1890cfe75d0fd2907cfdeb7124754ad62e3"} 19:38:56 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:56 INFO - Copying logs to upload dir... 19:38:56 INFO - mkdir: /builds/slave/test/build/upload/logs 19:38:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.933316 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-08 19:38:55.849182) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 19:38:55.852721) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276 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/a214a58dc3d7952a5229b239af9a6e051d28802422c2e832fe28e87574bf94b9a600a8108d781f0d1b3513d5af5bad259519a4b7b0a245fc01a5c9cb888ab981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a20e68b32ceaa6ad34501a7b706b1d2abb0cd3e83477ccc9b78907ff73ac81cfecdce53a0fd81bee578de65c7b8ba6ed6cda0db0b0e7494a7e6d7c6bb4bfcf54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81ffe4f4ee7d1cbd9bbc85dff936ff3f2b025b3ffb8d080826a2ba9f5fa2b9a573465e23e437921b9232c22dd32aa1890cfe75d0fd2907cfdeb7124754ad62e3"} build_url:https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/YZyhBo19Tmye4X5119sx2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a214a58dc3d7952a5229b239af9a6e051d28802422c2e832fe28e87574bf94b9a600a8108d781f0d1b3513d5af5bad259519a4b7b0a245fc01a5c9cb888ab981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a20e68b32ceaa6ad34501a7b706b1d2abb0cd3e83477ccc9b78907ff73ac81cfecdce53a0fd81bee578de65c7b8ba6ed6cda0db0b0e7494a7e6d7c6bb4bfcf54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81ffe4f4ee7d1cbd9bbc85dff936ff3f2b025b3ffb8d080826a2ba9f5fa2b9a573465e23e437921b9232c22dd32aa1890cfe75d0fd2907cfdeb7124754ad62e3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 19:38:55.879269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 19:38:55.879643) ========= 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=bb9b54edd4a927dc735d112f000001d9-1470707292.724870-1234255276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 19:38:55.965528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 19:38:55.965908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 19:38:55.966291) ========= ========= Total master_lag: 0.21 =========