builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1472606766.12 results: success (0) buildid: 20160830155221 builduid: bf019e69046e4bae906a310eed4e55dc revision: 63812e8894ced1e8922ad7f120432e2f7930d60a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.119499) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.119968) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.120309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.153498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.153845) ========= 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=0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 18:26:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.0M=0s 2016-08-30 18:26:06 (26.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.298738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.299441) ========= 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=0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.350211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.350560) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 63812e8894ced1e8922ad7f120432e2f7930d60a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 63812e8894ced1e8922ad7f120432e2f7930d60a --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=0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 18:26:06,584 truncating revision to first 12 chars 2016-08-30 18:26:06,584 Setting DEBUG logging. 2016-08-30 18:26:06,584 attempt 1/10 2016-08-30 18:26:06,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/63812e8894ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 18:26:06,881 unpacking tar archive at: autoland-63812e8894ce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.921263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.921537) ========= script_repo_revision: 63812e8894ced1e8922ad7f120432e2f7930d60a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.921967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.922253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 18:26:06.931436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 18:26:06.931719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:26:07 INFO - MultiFileLogger online at 20160830 18:26:07 in /builds/slave/test 18:26:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 18:26:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:26:07 INFO - {'append_to_log': False, 18:26:07 INFO - 'base_work_dir': '/builds/slave/test', 18:26:07 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 18:26:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:26:07 INFO - 'branch': 'Autoland-Non-PGO', 18:26:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:26:07 INFO - 'config_files': ('talos/linux_config.py',), 18:26:07 INFO - 'default_actions': ('clobber', 18:26:07 INFO - 'read-buildbot-config', 18:26:07 INFO - 'download-and-extract', 18:26:07 INFO - 'populate-webroot', 18:26:07 INFO - 'create-virtualenv', 18:26:07 INFO - 'install', 18:26:07 INFO - 'run-tests'), 18:26:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:26:07 INFO - 'download_minidump_stackwalk': True, 18:26:07 INFO - 'download_symbols': 'ondemand', 18:26:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:26:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:26:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:26:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:26:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:26:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:26:07 INFO - 'installer_path': 'installer.exe', 18:26:07 INFO - 'log_level': 'info', 18:26:07 INFO - 'log_name': 'talos', 18:26:07 INFO - 'log_to_console': True, 18:26:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:26:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:26:07 INFO - 'opt_config_files': (), 18:26:07 INFO - 'pip_index': False, 18:26:07 INFO - 'sps_profile': False, 18:26:07 INFO - 'sps_profile_interval': 0, 18:26:07 INFO - 'suite': 'dromaeojs-e10s', 18:26:07 INFO - 'system_bits': '32', 18:26:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:26:07 INFO - 'title': 'talos-linux64-ix-058', 18:26:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:26:07 INFO - 'use_talos_json': True, 18:26:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:26:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:26:07 INFO - 'work_dir': 'build'} 18:26:07 INFO - [mozharness: 2016-08-31 01:26:07.268801Z] Running clobber step. 18:26:07 INFO - Running pre-action listener: _resource_record_pre_action 18:26:07 INFO - Running main action method: clobber 18:26:07 INFO - rmtree: /builds/slave/test/build 18:26:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:26:07 INFO - Running post-action listener: _resource_record_post_action 18:26:07 INFO - [mozharness: 2016-08-31 01:26:07.720678Z] Finished clobber step (success) 18:26:07 INFO - [mozharness: 2016-08-31 01:26:07.720784Z] Running read-buildbot-config step. 18:26:07 INFO - Running pre-action listener: _resource_record_pre_action 18:26:07 INFO - Running main action method: read_buildbot_config 18:26:07 INFO - Using buildbot properties: 18:26:07 INFO - { 18:26:07 INFO - "project": "", 18:26:07 INFO - "product": "firefox", 18:26:07 INFO - "script_repo_revision": "production", 18:26:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 18:26:07 INFO - "repository": "", 18:26:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 18:26:07 INFO - "buildid": "20160830155221", 18:26:07 INFO - "pgo_build": "False", 18:26:07 INFO - "basedir": "/builds/slave/test", 18:26:07 INFO - "buildnumber": 364, 18:26:07 INFO - "slavename": "talos-linux64-ix-058", 18:26:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:26:07 INFO - "platform": "ubuntu64_hw", 18:26:07 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 18:26:07 INFO - "branch": "autoland", 18:26:07 INFO - "repo_path": "integration/autoland", 18:26:07 INFO - "revision": "63812e8894ced1e8922ad7f120432e2f7930d60a", 18:26:07 INFO - "stage_platform": "linux64", 18:26:07 INFO - "builduid": "bf019e69046e4bae906a310eed4e55dc", 18:26:07 INFO - "slavebuilddir": "test" 18:26:07 INFO - } 18:26:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:26:07 INFO - Running post-action listener: _resource_record_post_action 18:26:07 INFO - [mozharness: 2016-08-31 01:26:07.723247Z] Finished read-buildbot-config step (success) 18:26:07 INFO - [mozharness: 2016-08-31 01:26:07.723337Z] Running download-and-extract step. 18:26:07 INFO - Running pre-action listener: _resource_record_pre_action 18:26:07 INFO - Running main action method: download_and_extract 18:26:07 INFO - mkdir: /builds/slave/test/build/tests 18:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:07 INFO - trying https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:26:07 INFO - Downloading https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:08 INFO - Downloaded 1361 bytes. 18:26:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:26:08 INFO - Using the following test package requirements: 18:26:08 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:26:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:26:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'jsshell-linux-x86_64.zip'], 18:26:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:26:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:26:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:26:08 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:26:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:26:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:26:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:26:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:26:08 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')]} 18:26:08 INFO - trying https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:26:08 INFO - Downloading https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:09 INFO - Downloaded 20316189 bytes. 18:26:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 18:26:13 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 18:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:13 INFO - trying https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:26:13 INFO - Downloading https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:14 INFO - Downloaded 20316189 bytes. 18:26:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 18:26:18 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')]} 18:26:18 INFO - trying https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:18 INFO - Downloading https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:19 INFO - Downloaded 14413998 bytes. 18:26:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 18:26:19 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')]} 18:26:19 INFO - trying https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:26:19 INFO - Downloading https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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 18:26:20 INFO - Downloaded 55857312 bytes. 18:26:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:26:20 INFO - mkdir: /builds/slave/test/properties 18:26:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:26:20 INFO - Writing to file /builds/slave/test/properties/build_url 18:26:20 INFO - Contents: 18:26:20 INFO - build_url:https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:26:21 INFO - Running post-action listener: _resource_record_post_action 18:26:21 INFO - Running post-action listener: set_extra_try_arguments 18:26:21 INFO - [mozharness: 2016-08-31 01:26:21.623372Z] Finished download-and-extract step (success) 18:26:21 INFO - [mozharness: 2016-08-31 01:26:21.623675Z] Running populate-webroot step. 18:26:21 INFO - Running pre-action listener: _resource_record_pre_action 18:26:21 INFO - Running main action method: populate_webroot 18:26:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:26:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:26:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:26:21 INFO - '--tppagecycles', 18:26:21 INFO - '7'], 18:26:21 INFO - 'tests': ['tsvgm']}}, 18:26:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:26:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:26:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:26:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:26:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['damp', 'tps']}, 18:26:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'tests': ['damp', 'tps']}, 18:26:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['dromaeo_dom']}, 18:26:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:26:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['basic_compositor_video']}, 18:26:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:26:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['a11yr', 18:26:21 INFO - 'ts_paint', 18:26:21 INFO - 'tpaint', 18:26:21 INFO - 'sessionrestore', 18:26:21 INFO - 'sessionrestore_no_auto_restore', 18:26:21 INFO - 'tabpaint']}, 18:26:21 INFO - 'other-e10s': {'tests': ['a11yr', 18:26:21 INFO - 'ts_paint', 18:26:21 INFO - 'tpaint', 18:26:21 INFO - 'sessionrestore', 18:26:21 INFO - 'sessionrestore_no_auto_restore', 18:26:21 INFO - 'tabpaint']}, 18:26:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:26:21 INFO - 'ts_paint', 18:26:21 INFO - 'tpaint', 18:26:21 INFO - 'sessionrestore', 18:26:21 INFO - 'sessionrestore_no_auto_restore', 18:26:21 INFO - 'tabpaint']}, 18:26:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:26:21 INFO - 'ts_paint', 18:26:21 INFO - 'tpaint', 18:26:21 INFO - 'sessionrestore', 18:26:21 INFO - 'sessionrestore_no_auto_restore', 18:26:21 INFO - 'tabpaint']}, 18:26:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['a11yr', 18:26:21 INFO - 'ts_paint', 18:26:21 INFO - 'tpaint', 18:26:21 INFO - 'sessionrestore', 18:26:21 INFO - 'sessionrestore_no_auto_restore', 18:26:21 INFO - 'tabpaint']}, 18:26:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['a11yr', 18:26:21 INFO - 'ts_paint', 18:26:21 INFO - 'tpaint', 18:26:21 INFO - 'sessionrestore', 18:26:21 INFO - 'sessionrestore_no_auto_restore', 18:26:21 INFO - 'tabpaint']}, 18:26:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['tsvgx', 18:26:21 INFO - 'tsvgr_opacity', 18:26:21 INFO - 'tart', 18:26:21 INFO - 'tscrollx', 18:26:21 INFO - 'cart']}, 18:26:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:26:21 INFO - 'tsvgr_opacity', 18:26:21 INFO - 'tart', 18:26:21 INFO - 'tscrollx', 18:26:21 INFO - 'cart']}, 18:26:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'talos_options': ['--disable-e10s'], 18:26:21 INFO - 'tests': ['tp5o']}, 18:26:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'tests': ['tp5o']}, 18:26:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'talos_options': ['--disable-e10s', 18:26:21 INFO - '--xperf_path', 18:26:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:21 INFO - 'tests': ['tp5n']}, 18:26:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:21 INFO - 'talos_options': ['--xperf_path', 18:26:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:21 INFO - 'tests': ['tp5n']}}, 18:26:21 INFO - 'talos.zip': {'path': '', 18:26:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:26:21 INFO - Running post-action listener: _resource_record_post_action 18:26:21 INFO - [mozharness: 2016-08-31 01:26:21.644056Z] Finished populate-webroot step (success) 18:26:21 INFO - [mozharness: 2016-08-31 01:26:21.644151Z] Running create-virtualenv step. 18:26:21 INFO - Running pre-action listener: _resource_record_pre_action 18:26:21 INFO - Running main action method: create_virtualenv 18:26:21 INFO - Creating virtualenv /builds/slave/test/build/venv 18:26:21 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 18:26:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:26:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:26:21 INFO - Using real prefix '/usr' 18:26:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:26:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:26:24 INFO - Installing pip.................done. 18:26:24 INFO - Return code: 0 18:26:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:26:24 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')]} 18:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:24 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')]} 18:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:24 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:24 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 18:26:24 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 18:26:24 INFO - Using env: {'DISPLAY': ':0', 18:26:24 INFO - 'HOME': '/home/cltbld', 18:26:24 INFO - 'LANG': 'en_US.UTF-8', 18:26:24 INFO - 'LANGUAGE': 'en_US:en', 18:26:24 INFO - 'LOGNAME': 'cltbld', 18:26:24 INFO - 'MAIL': '/var/mail/cltbld', 18:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:24 INFO - 'MOZ_NO_REMOTE': '1', 18:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:24 INFO - 'NO_EM_RESTART': '1', 18:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:24 INFO - 'PWD': '/builds/slave/test', 18:26:24 INFO - 'SHELL': '/bin/bash', 18:26:24 INFO - 'SHLVL': '1', 18:26:24 INFO - 'TERM': 'linux', 18:26:24 INFO - 'TMOUT': '86400', 18:26:24 INFO - 'USER': 'cltbld', 18:26:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:24 INFO - '_': '/tools/buildbot/bin/python'} 18:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:24 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 18:26:24 INFO - Cleaning up... 18:26:24 INFO - Return code: 0 18:26:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:26:24 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')]} 18:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:24 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')]} 18:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:24 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:24 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 18:26:24 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 18:26:24 INFO - Using env: {'DISPLAY': ':0', 18:26:24 INFO - 'HOME': '/home/cltbld', 18:26:24 INFO - 'LANG': 'en_US.UTF-8', 18:26:24 INFO - 'LANGUAGE': 'en_US:en', 18:26:24 INFO - 'LOGNAME': 'cltbld', 18:26:24 INFO - 'MAIL': '/var/mail/cltbld', 18:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:24 INFO - 'MOZ_NO_REMOTE': '1', 18:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:24 INFO - 'NO_EM_RESTART': '1', 18:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:24 INFO - 'PWD': '/builds/slave/test', 18:26:24 INFO - 'SHELL': '/bin/bash', 18:26:24 INFO - 'SHLVL': '1', 18:26:24 INFO - 'TERM': 'linux', 18:26:24 INFO - 'TMOUT': '86400', 18:26:24 INFO - 'USER': 'cltbld', 18:26:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:24 INFO - '_': '/tools/buildbot/bin/python'} 18:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:24 INFO - Downloading/unpacking psutil>=3.1.1 18:26:24 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 18:26:24 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 18:26:24 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 18:26:24 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 18:26:24 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 18:26:24 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 18:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:26 INFO - Installing collected packages: psutil 18:26:26 INFO - Running setup.py install for psutil 18:26:26 INFO - building 'psutil._psutil_linux' extension 18:26:26 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 18:26:26 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 18:26:26 INFO - building 'psutil._psutil_posix' extension 18:26:26 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 18:26:27 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 18:26:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:27 INFO - Successfully installed psutil 18:26:27 INFO - Cleaning up... 18:26:27 INFO - Return code: 0 18:26:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:26:27 INFO - Using env: {'DISPLAY': ':0', 18:26:27 INFO - 'HOME': '/home/cltbld', 18:26:27 INFO - 'LANG': 'en_US.UTF-8', 18:26:27 INFO - 'LANGUAGE': 'en_US:en', 18:26:27 INFO - 'LOGNAME': 'cltbld', 18:26:27 INFO - 'MAIL': '/var/mail/cltbld', 18:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:27 INFO - 'MOZ_NO_REMOTE': '1', 18:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:27 INFO - 'NO_EM_RESTART': '1', 18:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:27 INFO - 'PWD': '/builds/slave/test', 18:26:27 INFO - 'SHELL': '/bin/bash', 18:26:27 INFO - 'SHLVL': '1', 18:26:27 INFO - 'TERM': 'linux', 18:26:27 INFO - 'TMOUT': '86400', 18:26:27 INFO - 'USER': 'cltbld', 18:26:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:27 INFO - '_': '/tools/buildbot/bin/python'} 18:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:26:29 INFO - Installing collected packages: mozsystemmonitor 18:26:29 INFO - Running setup.py install for mozsystemmonitor 18:26:29 INFO - Successfully installed mozsystemmonitor 18:26:29 INFO - Cleaning up... 18:26:29 INFO - Return code: 0 18:26:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:29 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:29 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 18:26:29 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 18:26:29 INFO - Using env: {'DISPLAY': ':0', 18:26:29 INFO - 'HOME': '/home/cltbld', 18:26:29 INFO - 'LANG': 'en_US.UTF-8', 18:26:29 INFO - 'LANGUAGE': 'en_US:en', 18:26:29 INFO - 'LOGNAME': 'cltbld', 18:26:29 INFO - 'MAIL': '/var/mail/cltbld', 18:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:29 INFO - 'MOZ_NO_REMOTE': '1', 18:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:29 INFO - 'NO_EM_RESTART': '1', 18:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:29 INFO - 'PWD': '/builds/slave/test', 18:26:29 INFO - 'SHELL': '/bin/bash', 18:26:29 INFO - 'SHLVL': '1', 18:26:29 INFO - 'TERM': 'linux', 18:26:29 INFO - 'TMOUT': '86400', 18:26:29 INFO - 'USER': 'cltbld', 18:26:29 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:29 INFO - '_': '/tools/buildbot/bin/python'} 18:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:29 INFO - Downloading/unpacking jsonschema==2.5.1 18:26:29 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 18:26:29 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 18:26:29 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 18:26:29 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 18:26:29 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 18:26:29 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 18:26:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:31 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:31 INFO - warning: no files found matching '*.txt' 18:26:31 INFO - no previously-included directories found matching 'build' 18:26:31 INFO - no previously-included directories found matching 'dist' 18:26:31 INFO - no previously-included directories found matching '.git*' 18:26:31 INFO - Installing collected packages: jsonschema, functools32 18:26:31 INFO - Running setup.py install for functools32 18:26:32 INFO - warning: no files found matching '*.txt' 18:26:32 INFO - no previously-included directories found matching 'build' 18:26:32 INFO - no previously-included directories found matching 'dist' 18:26:32 INFO - no previously-included directories found matching '.git*' 18:26:32 INFO - Successfully installed jsonschema functools32 18:26:32 INFO - Cleaning up... 18:26:32 INFO - Return code: 0 18:26:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:32 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:32 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 18:26:32 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 18:26:32 INFO - Using env: {'DISPLAY': ':0', 18:26:32 INFO - 'HOME': '/home/cltbld', 18:26:32 INFO - 'LANG': 'en_US.UTF-8', 18:26:32 INFO - 'LANGUAGE': 'en_US:en', 18:26:32 INFO - 'LOGNAME': 'cltbld', 18:26:32 INFO - 'MAIL': '/var/mail/cltbld', 18:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:32 INFO - 'MOZ_NO_REMOTE': '1', 18:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:32 INFO - 'NO_EM_RESTART': '1', 18:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:32 INFO - 'PWD': '/builds/slave/test', 18:26:32 INFO - 'SHELL': '/bin/bash', 18:26:32 INFO - 'SHLVL': '1', 18:26:32 INFO - 'TERM': 'linux', 18:26:32 INFO - 'TMOUT': '86400', 18:26:32 INFO - 'USER': 'cltbld', 18:26:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:32 INFO - '_': '/tools/buildbot/bin/python'} 18:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:26:32 INFO - Cleaning up... 18:26:32 INFO - Return code: 0 18:26:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:32 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:32 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 18:26:32 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 18:26:32 INFO - Using env: {'DISPLAY': ':0', 18:26:32 INFO - 'HOME': '/home/cltbld', 18:26:32 INFO - 'LANG': 'en_US.UTF-8', 18:26:32 INFO - 'LANGUAGE': 'en_US:en', 18:26:32 INFO - 'LOGNAME': 'cltbld', 18:26:32 INFO - 'MAIL': '/var/mail/cltbld', 18:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:32 INFO - 'MOZ_NO_REMOTE': '1', 18:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:32 INFO - 'NO_EM_RESTART': '1', 18:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:32 INFO - 'PWD': '/builds/slave/test', 18:26:32 INFO - 'SHELL': '/bin/bash', 18:26:32 INFO - 'SHLVL': '1', 18:26:32 INFO - 'TERM': 'linux', 18:26:32 INFO - 'TMOUT': '86400', 18:26:32 INFO - 'USER': 'cltbld', 18:26:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:32 INFO - '_': '/tools/buildbot/bin/python'} 18:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:32 INFO - Downloading/unpacking blobuploader==1.2.4 18:26:32 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 18:26:32 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 18:26:32 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 18:26:32 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 18:26:32 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 18:26:32 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 18:26:34 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 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 18:26:35 INFO - Downloading docopt-0.6.1.tar.gz 18:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:35 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:35 INFO - Running setup.py install for blobuploader 18:26:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:35 INFO - Running setup.py install for requests 18:26:35 INFO - Running setup.py install for docopt 18:26:35 INFO - Successfully installed blobuploader requests docopt 18:26:35 INFO - Cleaning up... 18:26:35 INFO - Return code: 0 18:26:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:35 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:35 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 18:26:35 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 18:26:35 INFO - Using env: {'DISPLAY': ':0', 18:26:35 INFO - 'HOME': '/home/cltbld', 18:26:35 INFO - 'LANG': 'en_US.UTF-8', 18:26:35 INFO - 'LANGUAGE': 'en_US:en', 18:26:35 INFO - 'LOGNAME': 'cltbld', 18:26:35 INFO - 'MAIL': '/var/mail/cltbld', 18:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:35 INFO - 'MOZ_NO_REMOTE': '1', 18:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:35 INFO - 'NO_EM_RESTART': '1', 18:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:35 INFO - 'PWD': '/builds/slave/test', 18:26:35 INFO - 'SHELL': '/bin/bash', 18:26:35 INFO - 'SHLVL': '1', 18:26:35 INFO - 'TERM': 'linux', 18:26:35 INFO - 'TMOUT': '86400', 18:26:35 INFO - 'USER': 'cltbld', 18:26:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:35 INFO - '_': '/tools/buildbot/bin/python'} 18:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:35 INFO - Running setup.py (path:/tmp/pip-Ch8Zh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:36 INFO - Running setup.py (path:/tmp/pip-6CQ6v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:36 INFO - Running setup.py (path:/tmp/pip-lSk55u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:36 INFO - Running setup.py (path:/tmp/pip-WH34qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:36 INFO - Running setup.py (path:/tmp/pip-6o8dDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:36 INFO - Running setup.py (path:/tmp/pip-Brd3fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:36 INFO - Running setup.py (path:/tmp/pip-TGkPsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:36 INFO - Running setup.py (path:/tmp/pip-qkGeUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:36 INFO - Running setup.py (path:/tmp/pip-61Te8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:36 INFO - Running setup.py (path:/tmp/pip-qoIJnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:36 INFO - Running setup.py (path:/tmp/pip-56d5eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:36 INFO - Running setup.py (path:/tmp/pip-gMvAKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:36 INFO - Running setup.py (path:/tmp/pip-jTzHYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:36 INFO - Running setup.py (path:/tmp/pip-c42Omv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:37 INFO - Running setup.py (path:/tmp/pip-0oSO_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:37 INFO - Running setup.py (path:/tmp/pip-2EfYjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:37 INFO - Running setup.py (path:/tmp/pip-TY1gOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:37 INFO - Running setup.py install for manifestparser 18:26:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:37 INFO - Running setup.py install for mozcrash 18:26:37 INFO - Running setup.py install for mozdebug 18:26:37 INFO - Running setup.py install for mozdevice 18:26:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:37 INFO - Running setup.py install for mozfile 18:26:37 INFO - Running setup.py install for mozhttpd 18:26:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:37 INFO - Running setup.py install for mozinfo 18:26:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:37 INFO - Running setup.py install for mozInstall 18:26:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Running setup.py install for mozleak 18:26:38 INFO - Running setup.py install for mozlog 18:26:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Running setup.py install for moznetwork 18:26:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Running setup.py install for mozprocess 18:26:38 INFO - Running setup.py install for mozprofile 18:26:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Running setup.py install for mozrunner 18:26:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Running setup.py install for mozscreenshot 18:26:38 INFO - Running setup.py install for moztest 18:26:38 INFO - Running setup.py install for mozversion 18:26:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:38 INFO - Cleaning up... 18:26:38 INFO - Return code: 0 18:26:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:39 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:39 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 18:26:39 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 18:26:39 INFO - Using env: {'DISPLAY': ':0', 18:26:39 INFO - 'HOME': '/home/cltbld', 18:26:39 INFO - 'LANG': 'en_US.UTF-8', 18:26:39 INFO - 'LANGUAGE': 'en_US:en', 18:26:39 INFO - 'LOGNAME': 'cltbld', 18:26:39 INFO - 'MAIL': '/var/mail/cltbld', 18:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:39 INFO - 'MOZ_NO_REMOTE': '1', 18:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:39 INFO - 'NO_EM_RESTART': '1', 18:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:39 INFO - 'PWD': '/builds/slave/test', 18:26:39 INFO - 'SHELL': '/bin/bash', 18:26:39 INFO - 'SHLVL': '1', 18:26:39 INFO - 'TERM': 'linux', 18:26:39 INFO - 'TMOUT': '86400', 18:26:39 INFO - 'USER': 'cltbld', 18:26:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:39 INFO - '_': '/tools/buildbot/bin/python'} 18:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:39 INFO - Running setup.py (path:/tmp/pip-TKP_Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:39 INFO - Running setup.py (path:/tmp/pip-1DLVNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:39 INFO - Running setup.py (path:/tmp/pip-1__qBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:39 INFO - Running setup.py (path:/tmp/pip-B40Rwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:39 INFO - Running setup.py (path:/tmp/pip-qMRCkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:39 INFO - Running setup.py (path:/tmp/pip-awt0oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:39 INFO - Running setup.py (path:/tmp/pip-n15AAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:39 INFO - Running setup.py (path:/tmp/pip-9VsIHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:39 INFO - Running setup.py (path:/tmp/pip-U5pWVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:39 INFO - Running setup.py (path:/tmp/pip-DmtZsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:39 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)) 18:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:39 INFO - Running setup.py (path:/tmp/pip-mi9McJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:40 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)) 18:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:40 INFO - Running setup.py (path:/tmp/pip-wYw_I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:40 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)) 18:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:40 INFO - Running setup.py (path:/tmp/pip-Ipev9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:40 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)) 18:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:40 INFO - Running setup.py (path:/tmp/pip-j6tiY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:40 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)) 18:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:40 INFO - Running setup.py (path:/tmp/pip-4ChQED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:40 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)) 18:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:40 INFO - Running setup.py (path:/tmp/pip-T95QCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:40 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)) 18:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:40 INFO - Running setup.py (path:/tmp/pip-DQ9KBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:40 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)) 18:26:40 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)) 18:26:40 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)) 18:26:40 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)) 18:26:40 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)) 18:26:40 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)) 18:26:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:42 INFO - Downloading blessings-1.6.tar.gz 18:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:42 INFO - Installing collected packages: blessings 18:26:42 INFO - Running setup.py install for blessings 18:26:42 INFO - Successfully installed blessings 18:26:42 INFO - Cleaning up... 18:26:42 INFO - Return code: 0 18:26:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:42 INFO - Reading from file tmpfile_stdout 18:26:42 INFO - Current package versions: 18:26:42 INFO - argparse == 1.2.1 18:26:42 INFO - blessings == 1.6 18:26:42 INFO - blobuploader == 1.2.4 18:26:42 INFO - docopt == 0.6.1 18:26:42 INFO - functools32 == 3.2.3-2 18:26:42 INFO - jsonschema == 2.5.1 18:26:42 INFO - manifestparser == 1.1 18:26:42 INFO - mozInstall == 1.12 18:26:42 INFO - mozcrash == 0.17 18:26:42 INFO - mozdebug == 0.1 18:26:42 INFO - mozdevice == 0.48 18:26:42 INFO - mozfile == 1.2 18:26:42 INFO - mozhttpd == 0.7 18:26:42 INFO - mozinfo == 0.9 18:26:42 INFO - mozleak == 0.1 18:26:42 INFO - mozlog == 3.3 18:26:42 INFO - moznetwork == 0.27 18:26:42 INFO - mozprocess == 0.23 18:26:42 INFO - mozprofile == 0.28 18:26:42 INFO - mozrunner == 6.12 18:26:42 INFO - mozscreenshot == 0.1 18:26:42 INFO - mozsystemmonitor == 0.3 18:26:42 INFO - moztest == 0.7 18:26:42 INFO - mozversion == 1.4 18:26:42 INFO - psutil == 3.1.1 18:26:42 INFO - requests == 1.2.3 18:26:42 INFO - wsgiref == 0.1.2 18:26:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:42 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:42 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 18:26:42 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 18:26:42 INFO - Using env: {'DISPLAY': ':0', 18:26:42 INFO - 'HOME': '/home/cltbld', 18:26:42 INFO - 'LANG': 'en_US.UTF-8', 18:26:42 INFO - 'LANGUAGE': 'en_US:en', 18:26:42 INFO - 'LOGNAME': 'cltbld', 18:26:42 INFO - 'MAIL': '/var/mail/cltbld', 18:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:42 INFO - 'MOZ_NO_REMOTE': '1', 18:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:42 INFO - 'NO_EM_RESTART': '1', 18:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:42 INFO - 'PWD': '/builds/slave/test', 18:26:42 INFO - 'SHELL': '/bin/bash', 18:26:42 INFO - 'SHLVL': '1', 18:26:42 INFO - 'TERM': 'linux', 18:26:42 INFO - 'TMOUT': '86400', 18:26:42 INFO - 'USER': 'cltbld', 18:26:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:42 INFO - '_': '/tools/buildbot/bin/python'} 18:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 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)) 18:26:43 INFO - Cleaning up... 18:26:43 INFO - Return code: 0 18:26:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26:43 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')]} 18:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:43 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')]} 18:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:43 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 0x7f9b9d2cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, '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': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', '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 18:26:43 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 18:26:43 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 18:26:43 INFO - Using env: {'DISPLAY': ':0', 18:26:43 INFO - 'HOME': '/home/cltbld', 18:26:43 INFO - 'LANG': 'en_US.UTF-8', 18:26:43 INFO - 'LANGUAGE': 'en_US:en', 18:26:43 INFO - 'LOGNAME': 'cltbld', 18:26:43 INFO - 'MAIL': '/var/mail/cltbld', 18:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:43 INFO - 'MOZ_NO_REMOTE': '1', 18:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:43 INFO - 'NO_EM_RESTART': '1', 18:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:43 INFO - 'PWD': '/builds/slave/test', 18:26:43 INFO - 'SHELL': '/bin/bash', 18:26:43 INFO - 'SHLVL': '1', 18:26:43 INFO - 'TERM': 'linux', 18:26:43 INFO - 'TMOUT': '86400', 18:26:43 INFO - 'USER': 'cltbld', 18:26:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:43 INFO - '_': '/tools/buildbot/bin/python'} 18:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:26:43 INFO - Cleaning up... 18:26:43 INFO - Return code: 0 18:26:43 INFO - Running post-action listener: _resource_record_post_action 18:26:43 INFO - Running post-action listener: _start_resource_monitoring 18:26:43 INFO - Starting resource monitoring. 18:26:43 INFO - [mozharness: 2016-08-31 01:26:43.306857Z] Finished create-virtualenv step (success) 18:26:43 INFO - [mozharness: 2016-08-31 01:26:43.307449Z] Running install step. 18:26:43 INFO - Running pre-action listener: _resource_record_pre_action 18:26:43 INFO - Running main action method: install 18:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:43 INFO - Reading from file tmpfile_stdout 18:26:43 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:43 INFO - Reading from file tmpfile_stdout 18:26:43 INFO - Output received: 18:26:43 INFO - Usage: mozinstall [options] installer 18:26:43 INFO - Options: 18:26:43 INFO - -h, --help show this help message and exit 18:26:43 INFO - -d DEST, --destination=DEST 18:26:43 INFO - Directory to install application into. [default: 18:26:43 INFO - "/builds/slave/test"] 18:26:43 INFO - --app=APP Application being installed. [default: firefox] 18:26:43 INFO - mkdir: /builds/slave/test/build/application 18:26:43 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'] 18:26:43 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 18:26:59 INFO - Reading from file tmpfile_stdout 18:26:59 INFO - Output received: 18:26:59 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:59 INFO - Running post-action listener: _resource_record_post_action 18:26:59 INFO - [mozharness: 2016-08-31 01:26:59.736554Z] Finished install step (success) 18:26:59 INFO - [mozharness: 2016-08-31 01:26:59.736836Z] Running run-tests step. 18:26:59 INFO - Running pre-action listener: _resource_record_pre_action 18:26:59 INFO - Running main action method: run_tests 18:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:59 INFO - Python 2.7.3 18:26:59 INFO - Return code: 0 18:26:59 INFO - grabbing minidump binary from tooltool 18:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:59 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 0x14e8090>, '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 0x14eb9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ebe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:59 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 18:26:59 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 18:26:59 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 18:26:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:59 INFO - Return code: 0 18:26:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 18:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 18:26:59 INFO - Using env: {'DISPLAY': ':0', 18:26:59 INFO - 'HOME': '/home/cltbld', 18:26:59 INFO - 'LANG': 'en_US.UTF-8', 18:26:59 INFO - 'LANGUAGE': 'en_US:en', 18:26:59 INFO - 'LOGNAME': 'cltbld', 18:26:59 INFO - 'MAIL': '/var/mail/cltbld', 18:26:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:59 INFO - 'MOZ_NO_REMOTE': '1', 18:26:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:59 INFO - 'NO_EM_RESTART': '1', 18:26:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:59 INFO - 'PWD': '/builds/slave/test', 18:26:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:59 INFO - 'SHELL': '/bin/bash', 18:26:59 INFO - 'SHLVL': '1', 18:26:59 INFO - 'TERM': 'linux', 18:26:59 INFO - 'TMOUT': '86400', 18:26:59 INFO - 'USER': 'cltbld', 18:26:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925', 18:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:59 INFO - '_': '/tools/buildbot/bin/python'} 18:26:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 18:27:00 INFO - mozversion application_buildid: 20160830155221 18:27:00 INFO - mozversion application_changeset: 63812e8894ced1e8922ad7f120432e2f7930d60a 18:27:00 INFO - mozversion application_display_name: Nightly 18:27:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:27:00 INFO - mozversion application_name: Firefox 18:27:00 INFO - mozversion application_remotingname: firefox 18:27:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:27:00 INFO - mozversion application_vendor: Mozilla 18:27:00 INFO - mozversion application_version: 51.0a1 18:27:00 INFO - mozversion platform_buildid: 20160830155221 18:27:00 INFO - mozversion platform_changeset: 63812e8894ced1e8922ad7f120432e2f7930d60a 18:27:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:27:00 INFO - mozversion platform_version: 51.0a1 18:27:00 INFO - using testdate: 1472606820 18:27:00 INFO - actual date: 1472606820 18:27:00 INFO - starting webserver on 'localhost:55440' 18:27:00 INFO - SUITE-START | Running 2 tests 18:27:00 INFO - TEST-START | dromaeo_css 18:27:00 INFO - operating with platform_type : linux_ 18:27:00 INFO - Initialising browser for dromaeo_css test... 18:27:00 INFO - TEST-INFO | started process 12226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvU5sO6/profile http://localhost:55440/getInfo.html) 18:27:05 INFO - PROCESS | 12226 | __metrics Screen width/height:1600/1200 18:27:05 INFO - PROCESS | 12226 | colorDepth:24 18:27:05 INFO - PROCESS | 12226 | Browser inner width/height: 1024/697 18:27:05 INFO - PROCESS | 12226 | __metrics 18:27:05 ERROR - PROCESS | 12226 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 18:27:06 INFO - TEST-INFO | 12226: exit 0 18:27:06 INFO - Browser initialized. 18:27:06 INFO - Running cycle 1/1 for dromaeo_css test... 18:27:06 INFO - TEST-INFO | started process 12345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvU5sO6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:18 INFO - PROCESS | 12345 | RSS: Main: 192278528 18:27:18 INFO - PROCESS | 12345 | 18:28:08 INFO - PROCESS | 12345 | 1472606888479 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] 18:30:21 INFO - PROCESS | 12345 | Cycle 1(1): loaded http://localhost:55440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55440/tests/dromaeo/cssquery-ext.html) 18:30:22 INFO - PROCESS | 12345 | RSS: Main: 210554880 18:30:22 INFO - PROCESS | 12345 | 18:33:24 INFO - PROCESS | 12345 | Cycle 1(1): loaded http://localhost:55440/tests/dromaeo/cssquery-ext.html (next: http://localhost:55440/tests/dromaeo/cssquery-jquery.html) 18:33:25 INFO - PROCESS | 12345 | RSS: Main: 204603392 18:33:25 INFO - PROCESS | 12345 | 18:36:27 INFO - PROCESS | 12345 | Cycle 1(1): loaded http://localhost:55440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55440/tests/dromaeo/cssquery-mootools.html) 18:36:28 INFO - PROCESS | 12345 | RSS: Main: 203669504 18:36:28 INFO - PROCESS | 12345 | 18:39:30 INFO - PROCESS | 12345 | Cycle 1(1): loaded http://localhost:55440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55440/tests/dromaeo/cssquery-prototype.html) 18:39:30 INFO - PROCESS | 12345 | RSS: Main: 197337088 18:39:30 INFO - PROCESS | 12345 | 18:42:33 INFO - PROCESS | 12345 | Cycle 1(1): loaded http://localhost:55440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55440/tests/dromaeo/cssquery-yui.html) 18:42:34 INFO - PROCESS | 12345 | RSS: Main: 199589888 18:42:34 INFO - PROCESS | 12345 | 18:45:36 INFO - PROCESS | 12345 | Cycle 1(1): loaded http://localhost:55440/tests/dromaeo/cssquery-yui.html (next: http://localhost:55440/tests/dromaeo/cssquery-dojo.html) 18:45:37 INFO - PROCESS | 12345 | RSS: Main: 199389184 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | __start_tp_report 18:45:37 INFO - PROCESS | 12345 | _x_x_mozilla_page_load 18:45:37 INFO - PROCESS | 12345 | _x_x_mozilla_page_load_details 18:45:37 INFO - PROCESS | 12345 | |i|pagename|runs| 18:45:37 INFO - PROCESS | 12345 | |0;dojo.html;2562.064846331089;2604.1666666666674;2624.461985293015;2633.9209823705282;2639.3401649587613;4565.794539245733;4625.629949604027;4702.130105930405;4711.670183087181;4713.552212539812;4635.351050852875;4661.347411362403;4691.671582989192;4729.9054018919605;4789.928151077736;4251.234777740014;4339.891502712426;4365.170617582665;4386.758728269944;4479.39528163697;4391.890202744925;4441.178381999324;4462.352958820969;4474.7762611869275;4486.798094085774;4142.150859073882;4273.038566322583;4297.892552686177;4367.519572846984;4427.690061695683;4293.592108749664;4300.397944287803;4306.547812479707;4377.058932329533;4433.1577000369825;4321.222180007598;4321.913561728779;4325;4355.324924636687;4389.868303950887;4696;4733.124371991193;4748.667593268473;4748.857534273978;4797.736124513151;5044.319016932704;5046.09170349337;5093.567046801027;5096.05722941257;5139.0749665060275;5106.131957567222;5118.718470484122;5129.948700512984;5131.281620573122;5138.30632864566;4610.308453731967;4706.694064885772;4743.95256047442;4751.6436267279405;4812;5171.069207542679;5190.766415511235;5194.766235519411;5203.947960520422;5216.556592689588;4986.925196122061;4990.151674215392;4992.076465853828;5027.044861476308;5057.317262169634;4908.3619129513645;5026.723530205801;5058;5070.3155074064525;5117.462666420047;5019.648624596316;5029.1450453423;5032.345795046621;5032.597392208614;5080.898382032338;4997.0505603935135;4999;5008.924866127011;5013.373328333958;5021.196608542616;3847.499825022729;3900.863469778544;3937.114149316381;3938.1926705025403;3966.4248683941246;3455.568053993251;3486.6164721880573;3493.109257139464;3514.0336407488144;3527.8236088196;4302.053548219449;4337.457817772778;4344.478662560513;4346.739195648272;4397.2964325707735;4904.901901962012;5021.271915572222;5095.87260318495;5106.821261255913;5171.793128274902;4307.870763877088;4328.458942632171;4341.696081274281;4341.891452713708;4393.143337049245;4524.140413321458;4541.205289074399;4546.818127274938;4548.818047278138;4584.4498660161;4658.277966915201;4751.667383283137;4784.784684689267;4804.975975120102;4855.708657480563;5015.724135172601;5025.346704928336;5065.518775716301;5077.492250775041;5090.745462726774;4713.481517033055;4761.476237613929;4784.545468180518;4802.303665968345;4824.638152138534;4857.028594281087;4933.802647894187;4971.701697898137;4989.950100498949;5029.84910452687;5032.245163225545;5033.622478314068;5079.060373830853;5083.745812709423;5153.6907785532985;4893.73084480357;4945.727984960718;4950.183219768698;4953.405591329064;5000.2999580058095;4782.856514304576;4814.085323788469;4840.443349014768;4884.633652476007;4921.434035086011;4716.080364328923;4758.833440829554;4783.880402989953;4804.42346918372;4862.659613826998;4901.068796928572;4902.63230257725;4913.017396520639;4918.6556941015215;4982.427020892499;4681.274402467623;4728.17256980034;4775.6657034007285;4803.759812009455;4899.191633380452 18:45:37 INFO - PROCESS | 12345 | |1;ext.html;548.019045907825;548.1202669715107;554.035977399325;562.1764115570688;585.5666806563145;33589.66410335896;37637.62362376376;37714.622853771456;37751.81124094376;37791.81104094483;36684;38123;38167.809160954224;38174.80912595433;38208;7351.117865856091;7489.026426564539;7498.925010749905;7503.362214211798;7517.060367454068;7576.696932122709;7644.847103057936;7661.770146895602;7671.347935425496;7680.731174408897;7648.655810488513;7681.9615901920415;7683.961580192119;7693.576853273095;7708.922910770904;7608.809779755523;7623.4282428817505;7641.044869391326;7658.617069146576;7663.463557550974;7585.734499292498;7599.468037237396;7650.961745191294;7669.578173200472;7674.46278760487;35846.28307433837;36148.9155325338;36170.819145904105;36205;36260.27479450423;2974.2415684000657;3009.7291243787945;3058.1590062732703;3214.582104326446;3514.8066856322894;27620.58569121465;28083.29791755202;28279;28450.715492845015;28650.283742906595;3123.7151702786377;3135.733462655677;3207.5990501187352;3230.660780618048;3336.4494858348344;230399;232183;232417;232861;233595;49227.26159107616;49896.750516247914;49901.50098499041;49929.75035124801;49946.500534994186;31210;31865;31970.520442193385;33976.32047359039;52124;13002.739945201043;13011.804822927663;13057.934710326577;13068.934655326662;13075.346232688518;9693.273004524548;9788.119069283799;9790.853137202948;9800.31397802147;9824.361416507903;17230.310787568356;17238.827611723973;17279.56801079983;17296.308147674205;17313.913430432767;6663.666816659148;6782.525223234425;7018.543794653331;7066.293370662996;7106.2183159852375;712.8503014367041;862.8144948835904;930.6649606141783;947.8293907096651;953.880764904387;25743;27513.72486275152;27611.72388276132;27665;27970.72029279681;874.3224001398967;896.3322324868016;911.1594578950483;933.6125507914139;1019.261035749076;13362.592538902518;14330.283485825667;14492.782608260884;14554.636134096732;14630.487932922297;345061;345972;346464.0151988611;350536;351381;46945.5305446948;47449.52550474451;47471.525284747404;47662.28506572335;47662.76168619135;1049.3598904668147;1103.8344248362648;1111.6164923101517;1113.7438389170375;1114.1031469666834;24211.689294103762;24846.751532485167;26000.8699956499;26035.218943431726;26359.4728105433;39994.60005400025;40772.79613601913;40979.7951010255;41002;41038.99999999881;292664;293055;293143;294210;294382;24477.51044979055;24798.752012479643;25060.498790023732;25066;25128;39195.608043919194;39497;39553.406698898965;39949.2010159801;40242.39636405398;34510.30979380449;34671;34933.82533087318;35071.93345530491;35550.288994220486;33747.49378759271;34133.317333653686;34235.4864677025;34427.4835877457;34523.30953380968;26894.32764180911;33905.83047084749;34120;34646.65353346535;34846.12884677904;30045.84977075188;31459.84270078635;32081.839590801897;32111.357772843945;33123.66876331302;24527.38681532976;24698.259052228463;24714.752852471243;25194.118205862706;25333.113341032975 18:45:37 INFO - PROCESS | 12345 | |2;jquery.html;345.45073333399887;355.8576569372251;359.3083314619357;369.1730523627076;380.33061811212275;15701.685966280682;15933;16800.83199168008;16804.32782688694;16855.494335169966;12068.69828254294;15195.772063419057;15875.682486350295;15890;15958.361665533364;4589.701669391496;5095.133827249358;5117.1556693145585;5143.074246635604;5143.639945203838;4965.652404331699;5088.313077734496;5097.898042039157;5112.258722485256;5132.743362831843;5080.618953578478;6319.589226700273;6615.106960560335;6638.93361066388;6641.269460359356;6496.545241833073;6532.967335163341;6600.636964966925;6602.7028783704845;6678.632675202862;6447.355264473562;6593.505487088488;6648.16897887764;6669.099671544328;6686.632235227061;22411.88794056019;22776;23383;23712.76287237123;23833.285001449985;1996.7304413904083;2026.432598872318;2035.236786205173;2038.2254743197639;2057.609054279682;13802.253509970451;14123;14306.499272525412;14773.187474688888;14995.775063374058;1843.5391152211946;1865.123392005755;1875.4186202277338;1894.5547796267865;1906.1300309597523;74019;75193.62403188004;75856.86214706839;76281.61859190724;77631;15487.767683484757;15524.767128493082;16419.507414777574;16482;16660.50018499447;27886.860565697043;28022.85988570044;28039.299017524725;28211.43577128487;28302.150935471967;7522.511036782592;7739.380849532024;7840.294373506412;8021.358291336679;8204.318114786454;6290.119383286344;6409.102725618417;6414.326495717883;6465.450436712838;6524.380183882524;7789.33790627803;8062.677492900336;8155.79610509742;8197.918020819716;8321.875171872427;3186.7851842969376;3268.2973160770075;3317.7345812334956;3414.6756058174433;3633.3247109855365;719.4639993205095;752.578556008637;893.1871996483169;897.1611543207122;899.5457294066586;16395;16437.424690135787;17252.74120888188;17594.208260628304;17695.46913592594;747.4767662636176;779.9883001754978;792.1603100713262;800.8077713171542;802.9116797152309;9051.864222036675;9612.1829644481;9721.951390243003;9756.707298781048;9791.559379827924;351821;358773;361542;367589;367609;76064.23935760683;78269;79818.6009069951;79997;80288;907.4782000349825;907.677774390082;945.744648944781;949.1647350331802;949.4920217683506;15704.528864134094;15749.921250393674;15928.601784955468;16033.679326413174;16056.438024669547;34419.31161376708;36465.453018204214;36507.634923650425;36707.63292367042;37921.81039094787;49913;52624.473755261955;52910.47089529056;53532.197017043996;53661.46338536565;7373.9262607375385;7510.737124200627;7573.394128469819;7727.6136193188995;7784.766457006299;8262.554053040814;8432.957835210786;8451.32389408858;8455.619497122767;8481.87277190855;7727;7781.5331080135375;7864.803379915319;8054.798630034296;8073.959630201812;7150.821229469305;7335.5695639349815;7477.214892436215;7691.30778229962;7769.7669069928;7633.618319084135;7767.53394796314;7882.802929926797;7907.84184316322;7951.562664053533;10793.977686247863;10998.285111468049;11322.773544529227;11407.37259450705;12012.099092567918;11102.944485277521;11136.276142050741;11551.422428878355;11684.766304674029;11783.469743861719 18:45:37 INFO - PROCESS | 12345 | |3;mootools.html;1328.309279174829;1365.8019587159863;1408.8661577150174;1600.4158482154016;1641.0891954965005;6519;6986.161660600722;7143.89284160738;7741.380689544837;7747.92252077479;7126.536775109627;7350.4854660173805;7362.042934418531;7364.705411783522;7367.8894816577795;2157.072458842701;2180.4439867833757;2182.301663467683;2184.4429670434015;2184.8142907852853;2099.307228614561;2132.2004248406847;2159.84881058326;2160.6542953127505;2163.588918105555;2110.9472263193466;2113.408245691209;2133.445304220906;2135.9145634174615;2168.490404754881;2111.282164064218;2115.862468939529;2116.8200702940267;2117.587070521249;2119.5972765174565;2022.2719820864477;2056.5269987902866;2065.64883969724;2070.3064473401278;2070.5858828234263;7277.963610181915;7314.122305323342;7354.595497247649;7358.595277259748;7363.926360736431;4181.121964387482;4270.402143699885;4282.721623094489;4293.592108749664;4311.461067366579;2722.754952054325;2780.2771279467283;2846.644169478815;2848.957265641017;2877.136858942309;900.4131364716104;923.6997975657938;928.6007016982695;929.9581518831669;955.2835373469898;9773.267004974585;9790.510474476248;9907.356021858555;9912.950435247849;9920.553575089138;3766.1902690921033;3937.2125574884567;4063.0858056936954;4063.512378514597;4066.573009833984;8512.914870851213;8515.446495977742;8521.957390213009;8543.949452131445;8551.059383467813;4297.892552686208;4308.526062133163;4316.935245971313;4317;4320.870373888788;3442.9483557746653;3712.9071773205887;3798.734088613826;3868.3617203161725;3878.2437424702475;3302.1084307237393;3349.0790032740706;3394.5247665326874;3440.7097338498065;3463.8960831175104;1141.9657410277705;1142.5658249864998;1143.918996548254;1144.1533265383557;1146.541383446628;793.7618714385777;797.7487091566138;802.2859654907137;811.2779626132747;813.8779183122579;4638.744869032168;4733.171694953369;4778.1399348116975;4985.651004429655;5008.57427118699;397.84285207342936;404.7106318981942;408.14493635833475;412.70904012670997;821.7165078048064;3364.108511244522;3375.780574262665;3384.7461440392067;3401.064707205538;3491;8829.867551986725;8890.244329231959;8994.820103597891;9058.682946096855;9079.636814527345;9036.412633178954;9052.140046695553;9082.091790820865;9096.909030909606;9108.726738197865;6449.7420103195345;6824.93175068243;6915.066466027122;6925.515213934977;6929.826754331081;4915.508449155056;5044.117279476003;5200.921986170286;5236.240745092016;5239.580833533232;8015.599220039091;8078.555679437452;8097.2712455879255;8109.39179561547;8126.75619731409;8154.184581541798;8326;8377.70678026266;8386.371022173484;8448.23965843077;5555.444455554412;6099.359567245376;6170.352113028068;6355.3644635536075;6386.584871983492;7083.964580177066;7097.503174777716;7113.786586402416;7120.0387947626405;7151.892721609284;6133.693315334304;6218.875622487615;6250.1874756281395;6316.7157477914525;6361.268454127835;6203.689815509297;6211.316755156839;6220.346863579259;6234.251889773256;6240.063990401476;5826.155207494974;5944.762209511571;5945.732442040205;5948.702564871653;5951.583389162717;4377.321515165155;4381.868543943687;4402.537733537933;4405.691601587858;4494.752788596658;4323.351497275434;4357.694961352801;4367.432233809584;4384.49578298487;4551.8634440966825 18:45:37 INFO - PROCESS | 12345 | |4;prototype.html;293.09872143159777;294.27020987949885;301.47693751341427;302.9712177343152;305.8944664090888;4787.409442917811;4849.393825771778;4907.411110666721;4938.48145944676;4957.950420495794;4849.660523763338;4881.707097574148;4888.73111978841;4901.901961960768;4920.507949205078;3888.3001059809294;3890.183061557062;3897.279003384383;3914.53025636924;3919.6864250859862;3652.652997965189;3898.922021559567;3903.7657740535515;3922.548906875703;3946.1910308386714;3799.5440547134244;3817.7136714746366;3817.961820381802;3819.2552452271816;3827.789471579062;3786.315089785033;3833.789141597197;3833.9041523961846;3843.13529455873;3855.4024126260474;3366.4613661814237;3381.5434916286476;3385.1029477188563;3389.7796643218358;3401.914952126192;4760.857174284777;4911.189653707134;4915.926261106087;4934.111859865223;4942.18453955097;4375.709165796098;4380.2115619188535;4385.649148068147;4403.933940990888;4405.691601587891;5189.610779191576;5193.766280517386;5206.76569554371;5227.059129356714;5240.292560504321;3577.731670124751;3655.3603119453987;3662.7840156705074;3672.338978983782;3678.9514988228493;5391.272178255925;5394.8921021579345;5447.210154527611;5451.155070964047;5495.395506494322;3755.2114056048536;3779.0174554615446;3790.166163444038;3793.81030948457;3802.2775672622115;3853.3064048470983;3854.190619969782;3856.5757766645647;3856.845726170922;3858.2862170498547;4298.63461605767;4356.324769660708;4362.236608593484;4372.5352007077345;4398.142362239397;5205.820208892101;5211.713355765393;5219.781592823035;5220.817271395483;5236.816711415082;1249.5938819883393;1270.4410059573759;1287.6008437384442;1307.8495972963042;1316.2760481735008;846.1284876577135;878.2359347367831;893.9910600893908;905.1401168889581;909.977250568741;4465.732056076646;4517.186906356887;4517.819287228474;4519.638428925678;4543.613792827647;5297.284866543045;5308.177232528964;5311.256424100629;5328.440513746078;5331.493508116722;4483.932741008887;4487.506374298824;4495.370648109202;4499.887502812456;4519.299508576176;2674.371522692166;2830.1933948824485;2845.402465482272;2846.4876322262194;2855.7858160638034;5020.47285035066;5039.949600504021;5043;5046.6719663221775;5054.570361519312;5283.603729720209;5420.485053919951;5453.291072160594;5509.834704958777;5517.889642207214;5052.45900000496;5080.441151473409;5080.847574572768;5084.847454576368;5090;5402.648827826179;5411.891762164656;5414.35027796667;5426.511613954763;5441.183822426668;5081.898362032813;5231.947680523298;5260;5289.523942845162;5306.814261500829;5053.7220452875445;5066.797328106834;5069.986002799381;5078.695278283315;5081.18701007837;3732.3654978654235;3769.1896242308035;3769.7738135711943;3782.451544525973;3788.6021967694096;5177.585793136615;5288.894222115613;5345.438728933406;5377.704226267593;5380.730963451733;5136.871578210575;5137.2037334213255;5148.794048238028;5157.7679004444135;5160.741962901915;5111.3355263815465;5160.741962901915;5175.430702622783;5184.533391994739;5223.242629818731;4987.950120498894;5061.721605311744;5104.3619547556555;5131.538161565477;5134;5191.974040129775;5195.636305458582;5204.245384419162;5212.5569326607665;5233.633645644921;5101.489851014869;5109.233614957786;5124.769385377593;5126.923096153635;5129.3840141528835 18:45:37 INFO - PROCESS | 12345 | |5;yui.html;607.3319348716412;626.6177631644699;634.5970308853879;699.7900629811058;710.8862581986881;14158.504452344157;14721.779173312409;14725.55823325302;15276.236188190602;15294.388224471035;13802.309884505785;13822.723545529083;13826.17042977422;13832.792508112361;13891.861081389183;611.4955161991375;744.6797876912925;749.9212582678822;763.904511936008;774.2064384006383;774.639792496489;776.3245976000887;776.755322073545;777.5956502618664;777.6928113395205;811.1037303779298;815.1278132398336;816.5753808019826;818.0265484073933;820.7086484298078;795.7612716185122;802.6147449224405;810.0198759501011;812.2567850416891;812.9878051829228;585.060977131706;590.6456126324214;591.1753104419311;592.0734051209843;594.7472324262171;12775.680607984781;12852.55016074433;12863.292518911456;12866.935665321707;12918.741625167444;12911.160774549719;13058.412371443213;13190;13191.142575732547;13452.636840789803;10155.441450720207;10200.948995254976;10267.640632577899;10342.327748696385;10460.843087353696;3260.4783234682336;3281.9015429537153;3309.9172520686934;3311.718503927169;3329.716974057208;66062.3393766061;66475.66762166159;67079.32920670828;67160.6641966787;67921.320786792;10276.434796086138;10292.279540432248;10311.07200351957;10331.845022324671;10374.043397631638;18607.348742793936;18661.97359145233;18783.342583009802;18869.62260754777;18900;6318.178636777281;6406.871862562816;6492.058651495507;6591.274959754423;6739.797806065826;3798.867039653599;3829.6936245100324;3841.7118716096406;3882.7476214045996;3950.20995800841;2828.7029861864207;2949.8672559734864;2952.0405868092957;2953.9113826585235;2953.9852300738357;474.78160046379054;475.28469653171754;486.42358804816405;486.5548023558475;496.12434053894907;476.4663576794013;481.61952057873884;505.4490605240306;509.82665893596356;524.5803357314134;7208.639568021683;7363.079615048119;7512.5492470451945;7956.761297161094;8044.637991290406;507.22901190190703;508.2046597075565;509.53377659441196;512.851273130788;524.4676653197008;3489.9302013959577;3556.78659280444;3557.786532807988;3584.7311451640708;3729.5710993235584;93916;98623.50688246512;99667;103147;103467;74286;82516.58741706373;83383.58308208542;84824;85643.57178214069;77921;79218.60390698125;79237;79330.20669793343;79701.60149199217;6876.828079298058;7029.261927497743;7186.568805871664;7314.634268286458;7334.889976650461;44313;45902.54097458983;46479.53520464888;47294.76352618215;47384.28923566218;37287.576472470435;38621.648242311385;38750;58167.70916145561;65093.67453162704;9016.143466370684;9075.54622268897;9090.272778177863;9117.954410227907;9170.358074934691;10050.396976181453;10160.593576256866;10174.74563135898;10194.796104077728;10478.423686697304;8993.190612844875;9398.248140148908;9497.287703422133;9657.034296570288;9691.757706057406;10039.297249192487;10080.596776128872;10143.442110683984;10258.43578603184;10338.0695737384;9289.953550232205;9350.579223935076;9488.857667135137;9495.572699228413;9578;7834.138244793182;7870.763877083697;7906.683732650629;7993;8088.71689490865;7919.0893047298;8538.829223415622;9190.908090919005;9709.9029009709;9866.55600497965 18:45:37 INFO - PROCESS | 12345 | __end_tp_report 18:45:37 INFO - PROCESS | 12345 | __start_cc_report 18:45:37 INFO - PROCESS | 12345 | _x_x_mozilla_cycle_collect,376 18:45:37 INFO - PROCESS | 12345 | __end_cc_report 18:45:37 INFO - PROCESS | 12345 | __startTimestamp1472607937243__endTimestamp 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | ------- Summary: start ------- 18:45:37 INFO - PROCESS | 12345 | Number of tests: 6 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | [#0] dojo.html Cycles:165 Average:4647.85 Median:4783.88 stddev:520.58 (10.9%) stddev-sans-first:495.80 18:45:37 INFO - PROCESS | 12345 | Values: 2562.1 2604.2 2624.5 2633.9 2639.3 4565.8 4625.6 4702.1 4711.7 4713.6 4635.4 4661.3 4691.7 4729.9 4789.9 4251.2 4339.9 4365.2 4386.8 4479.4 4391.9 4441.2 4462.4 4474.8 4486.8 4142.2 4273.0 4297.9 4367.5 4427.7 4293.6 4300.4 4306.5 4377.1 4433.2 4321.2 4321.9 4325.0 4355.3 4389.9 4696.0 4733.1 4748.7 4748.9 4797.7 5044.3 5046.1 5093.6 5096.1 5139.1 5106.1 5118.7 5129.9 5131.3 5138.3 4610.3 4706.7 4744.0 4751.6 4812.0 5171.1 5190.8 5194.8 5203.9 5216.6 4986.9 4990.2 4992.1 5027.0 5057.3 4908.4 5026.7 5058.0 5070.3 5117.5 5019.6 5029.1 5032.3 5032.6 5080.9 4997.1 4999.0 5008.9 5013.4 5021.2 3847.5 3900.9 3937.1 3938.2 3966.4 3455.6 3486.6 3493.1 3514.0 3527.8 4302.1 4337.5 4344.5 4346.7 4397.3 4904.9 5021.3 5095.9 5106.8 5171.8 4307.9 4328.5 4341.7 4341.9 4393.1 4524.1 4541.2 4546.8 4548.8 4584.4 4658.3 4751.7 4784.8 4805.0 4855.7 5015.7 5025.3 5065.5 5077.5 5090.7 4713.5 4761.5 4784.5 4802.3 4824.6 4857.0 4933.8 4971.7 4990.0 5029.8 5032.2 5033.6 5079.1 5083.7 5153.7 4893.7 4945.7 4950.2 4953.4 5000.3 4782.9 4814.1 4840.4 4884.6 4921.4 4716.1 4758.8 4783.9 4804.4 4862.7 4901.1 4902.6 4913.0 4918.7 4982.4 4681.3 4728.2 4775.7 4803.8 4899.2 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | [#1] ext.html Cycles:180 Average:43674.17 Median:192734.91 stddev:77488.42 (40.2%) stddev-sans-first:77638.14 18:45:37 INFO - PROCESS | 12345 | Values: 548.0 548.1 554.0 562.2 585.6 33589.7 37637.6 37714.6 37751.8 37791.8 36684.0 38123.0 38167.8 38174.8 38208.0 7351.1 7489.0 7498.9 7503.4 7517.1 7576.7 7644.8 7661.8 7671.3 7680.7 7648.7 7682.0 7684.0 7693.6 7708.9 7608.8 7623.4 7641.0 7658.6 7663.5 7585.7 7599.5 7651.0 7669.6 7674.5 35846.3 36148.9 36170.8 36205.0 36260.3 2974.2 3009.7 3058.2 3214.6 3514.8 27620.6 28083.3 28279.0 28450.7 28650.3 3123.7 3135.7 3207.6 3230.7 3336.4 230399.0 232183.0 232417.0 232861.0 233595.0 49227.3 49896.8 49901.5 49929.8 49946.5 31210.0 31865.0 31970.5 33976.3 52124.0 13002.7 13011.8 13057.9 13068.9 13075.3 9693.3 9788.1 9790.9 9800.3 9824.4 17230.3 17238.8 17279.6 17296.3 17313.9 6663.7 6782.5 7018.5 7066.3 7106.2 712.9 862.8 930.7 947.8 953.9 25743.0 27513.7 27611.7 27665.0 27970.7 874.3 896.3 911.2 933.6 1019.3 13362.6 14330.3 14492.8 14554.6 14630.5 345061.0 345972.0 346464.0 350536.0 351381.0 46945.5 47449.5 47471.5 47662.3 47662.8 1049.4 1103.8 1111.6 1113.7 1114.1 24211.7 24846.8 26000.9 26035.2 26359.5 39994.6 40772.8 40979.8 41002.0 41039.0 292664.0 293055.0 293143.0 294210.0 294382.0 24477.5 24798.8 25060.5 25066.0 25128.0 39195.6 39497.0 39553.4 39949.2 40242.4 34510.3 34671.0 34933.8 35071.9 35550.3 33747.5 34133.3 34235.5 34427.5 34523.3 26894.3 33905.8 34120.0 34646.7 34846.1 30045.8 31459.8 32081.8 32111.4 33123.7 24527.4 24698.3 24714.8 25194.1 25333.1 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | [#2] jquery.html Cycles:180 Average:24583.15 Median:5143.36 stddev:59995.92 (1166.5%) stddev-sans-first:60136.62 18:45:37 INFO - PROCESS | 12345 | Values: 345.5 355.9 359.3 369.2 380.3 15701.7 15933.0 16800.8 16804.3 16855.5 12068.7 15195.8 15875.7 15890.0 15958.4 4589.7 5095.1 5117.2 5143.1 5143.6 4965.7 5088.3 5097.9 5112.3 5132.7 5080.6 6319.6 6615.1 6638.9 6641.3 6496.5 6533.0 6600.6 6602.7 6678.6 6447.4 6593.5 6648.2 6669.1 6686.6 22411.9 22776.0 23383.0 23712.8 23833.3 1996.7 2026.4 2035.2 2038.2 2057.6 13802.3 14123.0 14306.5 14773.2 14995.8 1843.5 1865.1 1875.4 1894.6 1906.1 74019.0 75193.6 75856.9 76281.6 77631.0 15487.8 15524.8 16419.5 16482.0 16660.5 27886.9 28022.9 28039.3 28211.4 28302.2 7522.5 7739.4 7840.3 8021.4 8204.3 6290.1 6409.1 6414.3 6465.5 6524.4 7789.3 8062.7 8155.8 8197.9 8321.9 3186.8 3268.3 3317.7 3414.7 3633.3 719.5 752.6 893.2 897.2 899.5 16395.0 16437.4 17252.7 17594.2 17695.5 747.5 780.0 792.2 800.8 802.9 9051.9 9612.2 9722.0 9756.7 9791.6 351821.0 358773.0 361542.0 367589.0 367609.0 76064.2 78269.0 79818.6 79997.0 80288.0 907.5 907.7 945.7 949.2 949.5 15704.5 15749.9 15928.6 16033.7 16056.4 34419.3 36465.5 36507.6 36707.6 37921.8 49913.0 52624.5 52910.5 53532.2 53661.5 7373.9 7510.7 7573.4 7727.6 7784.8 8262.6 8433.0 8451.3 8455.6 8481.9 7727.0 7781.5 7864.8 8054.8 8074.0 7150.8 7335.6 7477.2 7691.3 7769.8 7633.6 7767.5 7882.8 7907.8 7951.6 10794.0 10998.3 11322.8 11407.4 12012.1 11102.9 11136.3 11551.4 11684.8 11783.5 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | [#3] mootools.html Cycles:180 Average:4814.07 Median:5122.52 stddev:2666.73 (52.1%) stddev-sans-first:2661.35 18:45:37 INFO - PROCESS | 12345 | Values: 1328.3 1365.8 1408.9 1600.4 1641.1 6519.0 6986.2 7143.9 7741.4 7747.9 7126.5 7350.5 7362.0 7364.7 7367.9 2157.1 2180.4 2182.3 2184.4 2184.8 2099.3 2132.2 2159.8 2160.7 2163.6 2110.9 2113.4 2133.4 2135.9 2168.5 2111.3 2115.9 2116.8 2117.6 2119.6 2022.3 2056.5 2065.6 2070.3 2070.6 7278.0 7314.1 7354.6 7358.6 7363.9 4181.1 4270.4 4282.7 4293.6 4311.5 2722.8 2780.3 2846.6 2849.0 2877.1 900.4 923.7 928.6 930.0 955.3 9773.3 9790.5 9907.4 9913.0 9920.6 3766.2 3937.2 4063.1 4063.5 4066.6 8512.9 8515.4 8522.0 8543.9 8551.1 4297.9 4308.5 4316.9 4317.0 4320.9 3442.9 3712.9 3798.7 3868.4 3878.2 3302.1 3349.1 3394.5 3440.7 3463.9 1142.0 1142.6 1143.9 1144.2 1146.5 793.8 797.7 802.3 811.3 813.9 4638.7 4733.2 4778.1 4985.7 5008.6 397.8 404.7 408.1 412.7 821.7 3364.1 3375.8 3384.7 3401.1 3491.0 8829.9 8890.2 8994.8 9058.7 9079.6 9036.4 9052.1 9082.1 9096.9 9108.7 6449.7 6824.9 6915.1 6925.5 6929.8 4915.5 5044.1 5200.9 5236.2 5239.6 8015.6 8078.6 8097.3 8109.4 8126.8 8154.2 8326.0 8377.7 8386.4 8448.2 5555.4 6099.4 6170.4 6355.4 6386.6 7084.0 7097.5 7113.8 7120.0 7151.9 6133.7 6218.9 6250.2 6316.7 6361.3 6203.7 6211.3 6220.3 6234.3 6240.1 5826.2 5944.8 5945.7 5948.7 5951.6 4377.3 4381.9 4402.5 4405.7 4494.8 4323.4 4357.7 4367.4 4384.5 4551.9 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | [#4] prototype.html Cycles:180 Average:4307.53 Median:4927.31 stddev:1258.88 (25.5%) stddev-sans-first:1225.83 18:45:37 INFO - PROCESS | 12345 | Values: 293.1 294.3 301.5 303.0 305.9 4787.4 4849.4 4907.4 4938.5 4958.0 4849.7 4881.7 4888.7 4901.9 4920.5 3888.3 3890.2 3897.3 3914.5 3919.7 3652.7 3898.9 3903.8 3922.5 3946.2 3799.5 3817.7 3818.0 3819.3 3827.8 3786.3 3833.8 3833.9 3843.1 3855.4 3366.5 3381.5 3385.1 3389.8 3401.9 4760.9 4911.2 4915.9 4934.1 4942.2 4375.7 4380.2 4385.6 4403.9 4405.7 5189.6 5193.8 5206.8 5227.1 5240.3 3577.7 3655.4 3662.8 3672.3 3679.0 5391.3 5394.9 5447.2 5451.2 5495.4 3755.2 3779.0 3790.2 3793.8 3802.3 3853.3 3854.2 3856.6 3856.8 3858.3 4298.6 4356.3 4362.2 4372.5 4398.1 5205.8 5211.7 5219.8 5220.8 5236.8 1249.6 1270.4 1287.6 1307.8 1316.3 846.1 878.2 894.0 905.1 910.0 4465.7 4517.2 4517.8 4519.6 4543.6 5297.3 5308.2 5311.3 5328.4 5331.5 4483.9 4487.5 4495.4 4499.9 4519.3 2674.4 2830.2 2845.4 2846.5 2855.8 5020.5 5039.9 5043.0 5046.7 5054.6 5283.6 5420.5 5453.3 5509.8 5517.9 5052.5 5080.4 5080.8 5084.8 5090.0 5402.6 5411.9 5414.4 5426.5 5441.2 5081.9 5231.9 5260.0 5289.5 5306.8 5053.7 5066.8 5070.0 5078.7 5081.2 3732.4 3769.2 3769.8 3782.5 3788.6 5177.6 5288.9 5345.4 5377.7 5380.7 5136.9 5137.2 5148.8 5157.8 5160.7 5111.3 5160.7 5175.4 5184.5 5223.2 4988.0 5061.7 5104.4 5131.5 5134.0 5192.0 5195.6 5204.2 5212.6 5233.6 5101.5 5109.2 5124.8 5126.9 5129.4 18:45:37 INFO - PROCESS | 12345 | 18:45:37 INFO - PROCESS | 12345 | [#5] yui.html Cycles:180 Average:17277.66 Median:29376.39 stddev:25561.42 (87.0%) stddev-sans-first:25602.47 18:45:37 INFO - PROCESS | 12345 | Values: 607.3 626.6 634.6 699.8 710.9 14158.5 14721.8 14725.6 15276.2 15294.4 13802.3 13822.7 13826.2 13832.8 13891.9 611.5 744.7 749.9 763.9 774.2 774.6 776.3 776.8 777.6 777.7 811.1 815.1 816.6 818.0 820.7 795.8 802.6 810.0 812.3 813.0 585.1 590.6 591.2 592.1 594.7 12775.7 12852.6 12863.3 12866.9 12918.7 12911.2 13058.4 13190.0 13191.1 13452.6 10155.4 10200.9 10267.6 10342.3 10460.8 3260.5 3281.9 3309.9 3311.7 3329.7 66062.3 66475.7 67079.3 67160.7 67921.3 10276.4 10292.3 10311.1 10331.8 10374.0 18607.3 18662.0 18783.3 18869.6 18900.0 6318.2 6406.9 6492.1 6591.3 6739.8 3798.9 3829.7 3841.7 3882.7 3950.2 2828.7 2949.9 2952.0 2953.9 2954.0 474.8 475.3 486.4 486.6 496.1 476.5 481.6 505.4 509.8 524.6 7208.6 7363.1 7512.5 7956.8 8044.6 507.2 508.2 509.5 512.9 524.5 3489.9 3556.8 3557.8 3584.7 3729.6 93916.0 98623.5 99667.0 103147.0 103467.0 74286.0 82516.6 83383.6 84824.0 85643.6 77921.0 79218.6 79237.0 79330.2 79701.6 6876.8 7029.3 7186.6 7314.6 7334.9 44313.0 45902.5 46479.5 47294.8 47384.3 37287.6 38621.6 38750.0 58167.7 65093.7 9016.1 9075.5 9090.3 9118.0 9170.4 10050.4 10160.6 10174.7 10194.8 10478.4 8993.2 9398.2 9497.3 9657.0 9691.8 10039.3 10080.6 10143.4 10258.4 10338.1 9290.0 9350.6 9488.9 9495.6 9578.0 7834.1 7870.8 7906.7 7993.0 8088.7 7919.1 8538.8 9190.9 9709.9 9866.6 18:45:37 INFO - PROCESS | 12345 | -------- Summary: end -------- 18:45:37 INFO - PROCESS | 12345 | 18:45:38 INFO - TEST-INFO | 12345: exit 0 18:45:38 INFO - TEST-OK | dromaeo_css | took 1118341ms 18:45:38 INFO - TEST-START | kraken 18:45:38 INFO - operating with platform_type : linux_ 18:45:38 INFO - Initialising browser for kraken test... 18:45:38 INFO - TEST-INFO | started process 12703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHMPoQK/profile http://localhost:55440/getInfo.html) 18:45:43 INFO - PROCESS | 12703 | __metrics Screen width/height:1600/1200 18:45:43 INFO - PROCESS | 12703 | colorDepth:24 18:45:43 INFO - PROCESS | 12703 | Browser inner width/height: 1024/697 18:45:43 INFO - PROCESS | 12703 | __metrics 18:45:43 ERROR - PROCESS | 12703 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 18:45:44 INFO - TEST-INFO | 12703: exit 0 18:45:44 INFO - Browser initialized. 18:45:44 INFO - Running cycle 1/1 for kraken test... 18:45:44 INFO - TEST-INFO | started process 12821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHMPoQK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:56 INFO - PROCESS | 12821 | RSS: Main: 193036288 18:45:56 INFO - PROCESS | 12821 | 18:45:59 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55440/tests/kraken/driver.html?testName=audio-beat-detection) 18:46:00 INFO - PROCESS | 12821 | RSS: Main: 205975552 18:46:00 INFO - PROCESS | 12821 | 18:46:03 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55440/tests/kraken/driver.html?testName=audio-dft) 18:46:04 INFO - PROCESS | 12821 | RSS: Main: 204550144 18:46:04 INFO - PROCESS | 12821 | 18:46:07 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55440/tests/kraken/driver.html?testName=audio-fft) 18:46:07 INFO - PROCESS | 12821 | RSS: Main: 197931008 18:46:07 INFO - PROCESS | 12821 | 18:46:10 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55440/tests/kraken/driver.html?testName=audio-oscillator) 18:46:10 INFO - PROCESS | 12821 | RSS: Main: 198868992 18:46:10 INFO - PROCESS | 12821 | 18:46:12 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:46:13 INFO - PROCESS | 12821 | RSS: Main: 198860800 18:46:13 INFO - PROCESS | 12821 | 18:46:16 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55440/tests/kraken/driver.html?testName=imaging-darkroom) 18:46:17 INFO - PROCESS | 12821 | RSS: Main: 198991872 18:46:17 INFO - PROCESS | 12821 | 18:46:20 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55440/tests/kraken/driver.html?testName=imaging-desaturate) 18:46:21 INFO - PROCESS | 12821 | RSS: Main: 195362816 18:46:21 INFO - PROCESS | 12821 | 18:46:24 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55440/tests/kraken/driver.html?testName=json-parse-financial) 18:46:25 INFO - PROCESS | 12821 | RSS: Main: 197062656 18:46:25 INFO - PROCESS | 12821 | 18:46:26 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:46:27 INFO - PROCESS | 12821 | RSS: Main: 197152768 18:46:27 INFO - PROCESS | 12821 | 18:46:29 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:46:30 INFO - PROCESS | 12821 | RSS: Main: 197197824 18:46:30 INFO - PROCESS | 12821 | 18:46:32 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:46:33 INFO - PROCESS | 12821 | RSS: Main: 197980160 18:46:33 INFO - PROCESS | 12821 | 18:46:35 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:46:36 INFO - PROCESS | 12821 | RSS: Main: 198213632 18:46:36 INFO - PROCESS | 12821 | 18:46:39 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:40 INFO - PROCESS | 12821 | RSS: Main: 198475776 18:46:40 INFO - PROCESS | 12821 | 18:46:41 INFO - PROCESS | 12821 | Cycle 1(1): loaded http://localhost:55440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55440/tests/kraken/driver.html?testName=ai-astar) 18:46:42 INFO - PROCESS | 12821 | RSS: Main: 200704000 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | __start_tp_report 18:46:42 INFO - PROCESS | 12821 | _x_x_mozilla_page_load 18:46:42 INFO - PROCESS | 12821 | _x_x_mozilla_page_load_details 18:46:42 INFO - PROCESS | 12821 | |i|pagename|runs| 18:46:42 INFO - PROCESS | 12821 | |0;ai-astar;112;120;120;119;116;118;117;116;116;137 18:46:42 INFO - PROCESS | 12821 | |1;audio-beat-detection;152;124;148;182;124;151;162;130;193;128 18:46:42 INFO - PROCESS | 12821 | |2;audio-dft;175;167;165;164;163;162;164;163;163;165 18:46:42 INFO - PROCESS | 12821 | |3;audio-fft;76;79;76;189;79;76;76;76;161;77 18:46:42 INFO - PROCESS | 12821 | |4;audio-oscillator;85;83;139;85;84;84;139;83;84;141 18:46:42 INFO - PROCESS | 12821 | |5;imaging-gaussian-blur;118;119;118;117;119;117;119;117;120;119 18:46:42 INFO - PROCESS | 12821 | |6;imaging-darkroom;149;147;149;149;148;149;148;151;148;148 18:46:42 INFO - PROCESS | 12821 | |7;imaging-desaturate;96;97;96;96;97;97;96;96;95;97 18:46:42 INFO - PROCESS | 12821 | |8;json-parse-financial;65;66;66;66;66;65;66;67;66;65 18:46:42 INFO - PROCESS | 12821 | |9;json-stringify-tinderbox;66;66;66;67;67;65;66;66;66;66 18:46:42 INFO - PROCESS | 12821 | |10;stanford-crypto-aes;86;84;82;85;89;84;84;83;85;83 18:46:42 INFO - PROCESS | 12821 | |11;stanford-crypto-ccm;139;133;136;143;132;144;133;137;191;141 18:46:42 INFO - PROCESS | 12821 | |12;stanford-crypto-pbkdf2;178;180;182;179;186;180;172;173;172;178 18:46:42 INFO - PROCESS | 12821 | |13;stanford-crypto-sha256-iterative;72;72;71;70;69;70;69;69;69;70 18:46:42 INFO - PROCESS | 12821 | __end_tp_report 18:46:42 INFO - PROCESS | 12821 | __start_cc_report 18:46:42 INFO - PROCESS | 12821 | _x_x_mozilla_cycle_collect,904 18:46:42 INFO - PROCESS | 12821 | __end_cc_report 18:46:42 INFO - PROCESS | 12821 | __startTimestamp1472608002161__endTimestamp 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | ------- Summary: start ------- 18:46:42 INFO - PROCESS | 12821 | Number of tests: 14 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#0] ai-astar Cycles:10 Average:119.10 Median:118.50 stddev:6.72 (5.7%) stddev-sans-first:6.62 18:46:42 INFO - PROCESS | 12821 | Values: 112.0 120.0 120.0 119.0 116.0 118.0 117.0 116.0 116.0 137.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:151.50 stddev:24.17 (16.0%) stddev-sans-first:25.62 18:46:42 INFO - PROCESS | 12821 | Values: 152.0 124.0 148.0 182.0 124.0 151.0 162.0 130.0 193.0 128.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.75 (2.3%) stddev-sans-first:1.50 18:46:42 INFO - PROCESS | 12821 | Values: 175.0 167.0 165.0 164.0 163.0 162.0 164.0 163.0 163.0 165.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:41.91 (55.1%) stddev-sans-first:43.79 18:46:42 INFO - PROCESS | 12821 | Values: 76.0 79.0 76.0 189.0 79.0 76.0 76.0 76.0 161.0 77.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:84.00 stddev:26.90 (32.0%) stddev-sans-first:27.93 18:46:42 INFO - PROCESS | 12821 | Values: 85.0 83.0 139.0 85.0 84.0 84.0 139.0 83.0 84.0 141.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:119.00 stddev:1.06 (0.9%) stddev-sans-first:1.12 18:46:42 INFO - PROCESS | 12821 | Values: 118.0 119.0 118.0 117.0 119.0 117.0 119.0 117.0 120.0 119.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 18:46:42 INFO - PROCESS | 12821 | Values: 149.0 147.0 149.0 149.0 148.0 149.0 148.0 151.0 148.0 148.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:46:42 INFO - PROCESS | 12821 | Values: 96.0 97.0 96.0 96.0 97.0 97.0 96.0 96.0 95.0 97.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 18:46:42 INFO - PROCESS | 12821 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 66.0 67.0 66.0 65.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 18:46:42 INFO - PROCESS | 12821 | Values: 66.0 66.0 66.0 67.0 67.0 65.0 66.0 66.0 66.0 66.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:1.96 (2.3%) stddev-sans-first:2.00 18:46:42 INFO - PROCESS | 12821 | Values: 86.0 84.0 82.0 85.0 89.0 84.0 84.0 83.0 85.0 83.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:140.00 stddev:17.42 (12.4%) stddev-sans-first:18.42 18:46:42 INFO - PROCESS | 12821 | Values: 139.0 133.0 136.0 143.0 132.0 144.0 133.0 137.0 191.0 141.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:179.50 stddev:4.55 (2.5%) stddev-sans-first:4.82 18:46:42 INFO - PROCESS | 12821 | Values: 178.0 180.0 182.0 179.0 186.0 180.0 172.0 173.0 172.0 178.0 18:46:42 INFO - PROCESS | 12821 | 18:46:42 INFO - PROCESS | 12821 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.20 (1.7%) stddev-sans-first:1.05 18:46:42 INFO - PROCESS | 12821 | Values: 72.0 72.0 71.0 70.0 69.0 70.0 69.0 69.0 69.0 70.0 18:46:42 INFO - PROCESS | 12821 | -------- Summary: end -------- 18:46:42 INFO - PROCESS | 12821 | 18:46:43 INFO - TEST-INFO | 12821: exit 0 18:46:43 INFO - TEST-OK | kraken | took 65026ms 18:46:43 INFO - SUITE-END | took 1183s 18:46:43 INFO - Completed test suite (00:19:43) 18:46:43 INFO - javascript benchmark 18:46:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6311.375132040829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2562.064846331089, 2604.1666666666674, 2624.461985293015, 2633.9209823705282, 2639.3401649587613, 4565.794539245733, 4625.629949604027, 4702.130105930405, 4711.670183087181, 4713.552212539812, 4635.351050852875, 4661.347411362403, 4691.671582989192, 4729.9054018919605, 4789.928151077736, 4251.234777740014, 4339.891502712426, 4365.170617582665, 4386.758728269944, 4479.39528163697, 4391.890202744925, 4441.178381999324, 4462.352958820969, 4474.7762611869275, 4486.798094085774, 4142.150859073882, 4273.038566322583, 4297.892552686177, 4367.519572846984, 4427.690061695683, 4293.592108749664, 4300.397944287803, 4306.547812479707, 4377.058932329533, 4433.1577000369825, 4321.222180007598, 4321.913561728779, 4325.0, 4355.324924636687, 4389.868303950887, 4696.0, 4733.124371991193, 4748.667593268473, 4748.857534273978, 4797.736124513151, 5044.319016932704, 5046.09170349337, 5093.567046801027, 5096.05722941257, 5139.0749665060275, 5106.131957567222, 5118.718470484122, 5129.948700512984, 5131.281620573122, 5138.30632864566, 4610.308453731967, 4706.694064885772, 4743.95256047442, 4751.6436267279405, 4812.0, 5171.069207542679, 5190.766415511235, 5194.766235519411, 5203.947960520422, 5216.556592689588, 4986.925196122061, 4990.151674215392, 4992.076465853828, 5027.044861476308, 5057.317262169634, 4908.3619129513645, 5026.723530205801, 5058.0, 5070.3155074064525, 5117.462666420047, 5019.648624596316, 5029.1450453423, 5032.345795046621, 5032.597392208614, 5080.898382032338, 4997.0505603935135, 4999.0, 5008.924866127011, 5013.373328333958, 5021.196608542616, 3847.499825022729, 3900.863469778544, 3937.114149316381, 3938.1926705025403, 3966.4248683941246, 3455.568053993251, 3486.6164721880573, 3493.109257139464, 3514.0336407488144, 3527.8236088196, 4302.053548219449, 4337.457817772778, 4344.478662560513, 4346.739195648272, 4397.2964325707735, 4904.901901962012, 5021.271915572222, 5095.87260318495, 5106.821261255913, 5171.793128274902, 4307.870763877088, 4328.458942632171, 4341.696081274281, 4341.891452713708, 4393.143337049245, 4524.140413321458, 4541.205289074399, 4546.818127274938, 4548.818047278138, 4584.4498660161, 4658.277966915201, 4751.667383283137, 4784.784684689267, 4804.975975120102, 4855.708657480563, 5015.724135172601, 5025.346704928336, 5065.518775716301, 5077.492250775041, 5090.745462726774, 4713.481517033055, 4761.476237613929, 4784.545468180518, 4802.303665968345, 4824.638152138534, 4857.028594281087, 4933.802647894187, 4971.701697898137, 4989.950100498949, 5029.84910452687, 5032.245163225545, 5033.622478314068, 5079.060373830853, 5083.745812709423, 5153.6907785532985, 4893.73084480357, 4945.727984960718, 4950.183219768698, 4953.405591329064, 5000.2999580058095, 4782.856514304576, 4814.085323788469, 4840.443349014768, 4884.633652476007, 4921.434035086011, 4716.080364328923, 4758.833440829554, 4783.880402989953, 4804.42346918372, 4862.659613826998, 4901.068796928572, 4902.63230257725, 4913.017396520639, 4918.6556941015215, 4982.427020892499, 4681.274402467623, 4728.17256980034, 4775.6657034007285, 4803.759812009455, 4899.191633380452], "value": 4612.519647338973, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.019045907825, 548.1202669715107, 554.035977399325, 562.1764115570688, 585.5666806563145, 33589.66410335896, 37637.62362376376, 37714.622853771456, 37751.81124094376, 37791.81104094483, 36684.0, 38123.0, 38167.809160954224, 38174.80912595433, 38208.0, 7351.117865856091, 7489.026426564539, 7498.925010749905, 7503.362214211798, 7517.060367454068, 7576.696932122709, 7644.847103057936, 7661.770146895602, 7671.347935425496, 7680.731174408897, 7648.655810488513, 7681.9615901920415, 7683.961580192119, 7693.576853273095, 7708.922910770904, 7608.809779755523, 7623.4282428817505, 7641.044869391326, 7658.617069146576, 7663.463557550974, 7585.734499292498, 7599.468037237396, 7650.961745191294, 7669.578173200472, 7674.46278760487, 35846.28307433837, 36148.9155325338, 36170.819145904105, 36205.0, 36260.27479450423, 2974.2415684000657, 3009.7291243787945, 3058.1590062732703, 3214.582104326446, 3514.8066856322894, 27620.58569121465, 28083.29791755202, 28279.0, 28450.715492845015, 28650.283742906595, 3123.7151702786377, 3135.733462655677, 3207.5990501187352, 3230.660780618048, 3336.4494858348344, 230399.0, 232183.0, 232417.0, 232861.0, 233595.0, 49227.26159107616, 49896.750516247914, 49901.50098499041, 49929.75035124801, 49946.500534994186, 31210.0, 31865.0, 31970.520442193385, 33976.32047359039, 52124.0, 13002.739945201043, 13011.804822927663, 13057.934710326577, 13068.934655326662, 13075.346232688518, 9693.273004524548, 9788.119069283799, 9790.853137202948, 9800.31397802147, 9824.361416507903, 17230.310787568356, 17238.827611723973, 17279.56801079983, 17296.308147674205, 17313.913430432767, 6663.666816659148, 6782.525223234425, 7018.543794653331, 7066.293370662996, 7106.2183159852375, 712.8503014367041, 862.8144948835904, 930.6649606141783, 947.8293907096651, 953.880764904387, 25743.0, 27513.72486275152, 27611.72388276132, 27665.0, 27970.72029279681, 874.3224001398967, 896.3322324868016, 911.1594578950483, 933.6125507914139, 1019.261035749076, 13362.592538902518, 14330.283485825667, 14492.782608260884, 14554.636134096732, 14630.487932922297, 345061.0, 345972.0, 346464.0151988611, 350536.0, 351381.0, 46945.5305446948, 47449.52550474451, 47471.525284747404, 47662.28506572335, 47662.76168619135, 1049.3598904668147, 1103.8344248362648, 1111.6164923101517, 1113.7438389170375, 1114.1031469666834, 24211.689294103762, 24846.751532485167, 26000.8699956499, 26035.218943431726, 26359.4728105433, 39994.60005400025, 40772.79613601913, 40979.7951010255, 41002.0, 41038.99999999881, 292664.0, 293055.0, 293143.0, 294210.0, 294382.0, 24477.51044979055, 24798.752012479643, 25060.498790023732, 25066.0, 25128.0, 39195.608043919194, 39497.0, 39553.406698898965, 39949.2010159801, 40242.39636405398, 34510.30979380449, 34671.0, 34933.82533087318, 35071.93345530491, 35550.288994220486, 33747.49378759271, 34133.317333653686, 34235.4864677025, 34427.4835877457, 34523.30953380968, 26894.32764180911, 33905.83047084749, 34120.0, 34646.65353346535, 34846.12884677904, 30045.84977075188, 31459.84270078635, 32081.839590801897, 32111.357772843945, 33123.66876331302, 24527.38681532976, 24698.259052228463, 24714.752852471243, 25194.118205862706, 25333.113341032975], "value": 16528.049271783766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.45073333399887, 355.8576569372251, 359.3083314619357, 369.1730523627076, 380.33061811212275, 15701.685966280682, 15933.0, 16800.83199168008, 16804.32782688694, 16855.494335169966, 12068.69828254294, 15195.772063419057, 15875.682486350295, 15890.0, 15958.361665533364, 4589.701669391496, 5095.133827249358, 5117.1556693145585, 5143.074246635604, 5143.639945203838, 4965.652404331699, 5088.313077734496, 5097.898042039157, 5112.258722485256, 5132.743362831843, 5080.618953578478, 6319.589226700273, 6615.106960560335, 6638.93361066388, 6641.269460359356, 6496.545241833073, 6532.967335163341, 6600.636964966925, 6602.7028783704845, 6678.632675202862, 6447.355264473562, 6593.505487088488, 6648.16897887764, 6669.099671544328, 6686.632235227061, 22411.88794056019, 22776.0, 23383.0, 23712.76287237123, 23833.285001449985, 1996.7304413904083, 2026.432598872318, 2035.236786205173, 2038.2254743197639, 2057.609054279682, 13802.253509970451, 14123.0, 14306.499272525412, 14773.187474688888, 14995.775063374058, 1843.5391152211946, 1865.123392005755, 1875.4186202277338, 1894.5547796267865, 1906.1300309597523, 74019.0, 75193.62403188004, 75856.86214706839, 76281.61859190724, 77631.0, 15487.767683484757, 15524.767128493082, 16419.507414777574, 16482.0, 16660.50018499447, 27886.860565697043, 28022.85988570044, 28039.299017524725, 28211.43577128487, 28302.150935471967, 7522.511036782592, 7739.380849532024, 7840.294373506412, 8021.358291336679, 8204.318114786454, 6290.119383286344, 6409.102725618417, 6414.326495717883, 6465.450436712838, 6524.380183882524, 7789.33790627803, 8062.677492900336, 8155.79610509742, 8197.918020819716, 8321.875171872427, 3186.7851842969376, 3268.2973160770075, 3317.7345812334956, 3414.6756058174433, 3633.3247109855365, 719.4639993205095, 752.578556008637, 893.1871996483169, 897.1611543207122, 899.5457294066586, 16395.0, 16437.424690135787, 17252.74120888188, 17594.208260628304, 17695.46913592594, 747.4767662636176, 779.9883001754978, 792.1603100713262, 800.8077713171542, 802.9116797152309, 9051.864222036675, 9612.1829644481, 9721.951390243003, 9756.707298781048, 9791.559379827924, 351821.0, 358773.0, 361542.0, 367589.0, 367609.0, 76064.23935760683, 78269.0, 79818.6009069951, 79997.0, 80288.0, 907.4782000349825, 907.677774390082, 945.744648944781, 949.1647350331802, 949.4920217683506, 15704.528864134094, 15749.921250393674, 15928.601784955468, 16033.679326413174, 16056.438024669547, 34419.31161376708, 36465.453018204214, 36507.634923650425, 36707.63292367042, 37921.81039094787, 49913.0, 52624.473755261955, 52910.47089529056, 53532.197017043996, 53661.46338536565, 7373.9262607375385, 7510.737124200627, 7573.394128469819, 7727.6136193188995, 7784.766457006299, 8262.554053040814, 8432.957835210786, 8451.32389408858, 8455.619497122767, 8481.87277190855, 7727.0, 7781.5331080135375, 7864.803379915319, 8054.798630034296, 8073.959630201812, 7150.821229469305, 7335.5695639349815, 7477.214892436215, 7691.30778229962, 7769.7669069928, 7633.618319084135, 7767.53394796314, 7882.802929926797, 7907.84184316322, 7951.562664053533, 10793.977686247863, 10998.285111468049, 11322.773544529227, 11407.37259450705, 12012.099092567918, 11102.944485277521, 11136.276142050741, 11551.422428878355, 11684.766304674029, 11783.469743861719], "value": 8852.119855861603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.309279174829, 1365.8019587159863, 1408.8661577150174, 1600.4158482154016, 1641.0891954965005, 6519.0, 6986.161660600722, 7143.89284160738, 7741.380689544837, 7747.92252077479, 7126.536775109627, 7350.4854660173805, 7362.042934418531, 7364.705411783522, 7367.8894816577795, 2157.072458842701, 2180.4439867833757, 2182.301663467683, 2184.4429670434015, 2184.8142907852853, 2099.307228614561, 2132.2004248406847, 2159.84881058326, 2160.6542953127505, 2163.588918105555, 2110.9472263193466, 2113.408245691209, 2133.445304220906, 2135.9145634174615, 2168.490404754881, 2111.282164064218, 2115.862468939529, 2116.8200702940267, 2117.587070521249, 2119.5972765174565, 2022.2719820864477, 2056.5269987902866, 2065.64883969724, 2070.3064473401278, 2070.5858828234263, 7277.963610181915, 7314.122305323342, 7354.595497247649, 7358.595277259748, 7363.926360736431, 4181.121964387482, 4270.402143699885, 4282.721623094489, 4293.592108749664, 4311.461067366579, 2722.754952054325, 2780.2771279467283, 2846.644169478815, 2848.957265641017, 2877.136858942309, 900.4131364716104, 923.6997975657938, 928.6007016982695, 929.9581518831669, 955.2835373469898, 9773.267004974585, 9790.510474476248, 9907.356021858555, 9912.950435247849, 9920.553575089138, 3766.1902690921033, 3937.2125574884567, 4063.0858056936954, 4063.512378514597, 4066.573009833984, 8512.914870851213, 8515.446495977742, 8521.957390213009, 8543.949452131445, 8551.059383467813, 4297.892552686208, 4308.526062133163, 4316.935245971313, 4317.0, 4320.870373888788, 3442.9483557746653, 3712.9071773205887, 3798.734088613826, 3868.3617203161725, 3878.2437424702475, 3302.1084307237393, 3349.0790032740706, 3394.5247665326874, 3440.7097338498065, 3463.8960831175104, 1141.9657410277705, 1142.5658249864998, 1143.918996548254, 1144.1533265383557, 1146.541383446628, 793.7618714385777, 797.7487091566138, 802.2859654907137, 811.2779626132747, 813.8779183122579, 4638.744869032168, 4733.171694953369, 4778.1399348116975, 4985.651004429655, 5008.57427118699, 397.84285207342936, 404.7106318981942, 408.14493635833475, 412.70904012670997, 821.7165078048064, 3364.108511244522, 3375.780574262665, 3384.7461440392067, 3401.064707205538, 3491.0, 8829.867551986725, 8890.244329231959, 8994.820103597891, 9058.682946096855, 9079.636814527345, 9036.412633178954, 9052.140046695553, 9082.091790820865, 9096.909030909606, 9108.726738197865, 6449.7420103195345, 6824.93175068243, 6915.066466027122, 6925.515213934977, 6929.826754331081, 4915.508449155056, 5044.117279476003, 5200.921986170286, 5236.240745092016, 5239.580833533232, 8015.599220039091, 8078.555679437452, 8097.2712455879255, 8109.39179561547, 8126.75619731409, 8154.184581541798, 8326.0, 8377.70678026266, 8386.371022173484, 8448.23965843077, 5555.444455554412, 6099.359567245376, 6170.352113028068, 6355.3644635536075, 6386.584871983492, 7083.964580177066, 7097.503174777716, 7113.786586402416, 7120.0387947626405, 7151.892721609284, 6133.693315334304, 6218.875622487615, 6250.1874756281395, 6316.7157477914525, 6361.268454127835, 6203.689815509297, 6211.316755156839, 6220.346863579259, 6234.251889773256, 6240.063990401476, 5826.155207494974, 5944.762209511571, 5945.732442040205, 5948.702564871653, 5951.583389162717, 4377.321515165155, 4381.868543943687, 4402.537733537933, 4405.691601587858, 4494.752788596658, 4323.351497275434, 4357.694961352801, 4367.432233809584, 4384.49578298487, 4551.8634440966825], "value": 3866.4961141463837, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.09872143159777, 294.27020987949885, 301.47693751341427, 302.9712177343152, 305.8944664090888, 4787.409442917811, 4849.393825771778, 4907.411110666721, 4938.48145944676, 4957.950420495794, 4849.660523763338, 4881.707097574148, 4888.73111978841, 4901.901961960768, 4920.507949205078, 3888.3001059809294, 3890.183061557062, 3897.279003384383, 3914.53025636924, 3919.6864250859862, 3652.652997965189, 3898.922021559567, 3903.7657740535515, 3922.548906875703, 3946.1910308386714, 3799.5440547134244, 3817.7136714746366, 3817.961820381802, 3819.2552452271816, 3827.789471579062, 3786.315089785033, 3833.789141597197, 3833.9041523961846, 3843.13529455873, 3855.4024126260474, 3366.4613661814237, 3381.5434916286476, 3385.1029477188563, 3389.7796643218358, 3401.914952126192, 4760.857174284777, 4911.189653707134, 4915.926261106087, 4934.111859865223, 4942.18453955097, 4375.709165796098, 4380.2115619188535, 4385.649148068147, 4403.933940990888, 4405.691601587891, 5189.610779191576, 5193.766280517386, 5206.76569554371, 5227.059129356714, 5240.292560504321, 3577.731670124751, 3655.3603119453987, 3662.7840156705074, 3672.338978983782, 3678.9514988228493, 5391.272178255925, 5394.8921021579345, 5447.210154527611, 5451.155070964047, 5495.395506494322, 3755.2114056048536, 3779.0174554615446, 3790.166163444038, 3793.81030948457, 3802.2775672622115, 3853.3064048470983, 3854.190619969782, 3856.5757766645647, 3856.845726170922, 3858.2862170498547, 4298.63461605767, 4356.324769660708, 4362.236608593484, 4372.5352007077345, 4398.142362239397, 5205.820208892101, 5211.713355765393, 5219.781592823035, 5220.817271395483, 5236.816711415082, 1249.5938819883393, 1270.4410059573759, 1287.6008437384442, 1307.8495972963042, 1316.2760481735008, 846.1284876577135, 878.2359347367831, 893.9910600893908, 905.1401168889581, 909.977250568741, 4465.732056076646, 4517.186906356887, 4517.819287228474, 4519.638428925678, 4543.613792827647, 5297.284866543045, 5308.177232528964, 5311.256424100629, 5328.440513746078, 5331.493508116722, 4483.932741008887, 4487.506374298824, 4495.370648109202, 4499.887502812456, 4519.299508576176, 2674.371522692166, 2830.1933948824485, 2845.402465482272, 2846.4876322262194, 2855.7858160638034, 5020.47285035066, 5039.949600504021, 5043.0, 5046.6719663221775, 5054.570361519312, 5283.603729720209, 5420.485053919951, 5453.291072160594, 5509.834704958777, 5517.889642207214, 5052.45900000496, 5080.441151473409, 5080.847574572768, 5084.847454576368, 5090.0, 5402.648827826179, 5411.891762164656, 5414.35027796667, 5426.511613954763, 5441.183822426668, 5081.898362032813, 5231.947680523298, 5260.0, 5289.523942845162, 5306.814261500829, 5053.7220452875445, 5066.797328106834, 5069.986002799381, 5078.695278283315, 5081.18701007837, 3732.3654978654235, 3769.1896242308035, 3769.7738135711943, 3782.451544525973, 3788.6021967694096, 5177.585793136615, 5288.894222115613, 5345.438728933406, 5377.704226267593, 5380.730963451733, 5136.871578210575, 5137.2037334213255, 5148.794048238028, 5157.7679004444135, 5160.741962901915, 5111.3355263815465, 5160.741962901915, 5175.430702622783, 5184.533391994739, 5223.242629818731, 4987.950120498894, 5061.721605311744, 5104.3619547556555, 5131.538161565477, 5134.0, 5191.974040129775, 5195.636305458582, 5204.245384419162, 5212.5569326607665, 5233.633645644921, 5101.489851014869, 5109.233614957786, 5124.769385377593, 5126.923096153635, 5129.3840141528835], "value": 3904.289702918977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.3319348716412, 626.6177631644699, 634.5970308853879, 699.7900629811058, 710.8862581986881, 14158.504452344157, 14721.779173312409, 14725.55823325302, 15276.236188190602, 15294.388224471035, 13802.309884505785, 13822.723545529083, 13826.17042977422, 13832.792508112361, 13891.861081389183, 611.4955161991375, 744.6797876912925, 749.9212582678822, 763.904511936008, 774.2064384006383, 774.639792496489, 776.3245976000887, 776.755322073545, 777.5956502618664, 777.6928113395205, 811.1037303779298, 815.1278132398336, 816.5753808019826, 818.0265484073933, 820.7086484298078, 795.7612716185122, 802.6147449224405, 810.0198759501011, 812.2567850416891, 812.9878051829228, 585.060977131706, 590.6456126324214, 591.1753104419311, 592.0734051209843, 594.7472324262171, 12775.680607984781, 12852.55016074433, 12863.292518911456, 12866.935665321707, 12918.741625167444, 12911.160774549719, 13058.412371443213, 13190.0, 13191.142575732547, 13452.636840789803, 10155.441450720207, 10200.948995254976, 10267.640632577899, 10342.327748696385, 10460.843087353696, 3260.4783234682336, 3281.9015429537153, 3309.9172520686934, 3311.718503927169, 3329.716974057208, 66062.3393766061, 66475.66762166159, 67079.32920670828, 67160.6641966787, 67921.320786792, 10276.434796086138, 10292.279540432248, 10311.07200351957, 10331.845022324671, 10374.043397631638, 18607.348742793936, 18661.97359145233, 18783.342583009802, 18869.62260754777, 18900.0, 6318.178636777281, 6406.871862562816, 6492.058651495507, 6591.274959754423, 6739.797806065826, 3798.867039653599, 3829.6936245100324, 3841.7118716096406, 3882.7476214045996, 3950.20995800841, 2828.7029861864207, 2949.8672559734864, 2952.0405868092957, 2953.9113826585235, 2953.9852300738357, 474.78160046379054, 475.28469653171754, 486.42358804816405, 486.5548023558475, 496.12434053894907, 476.4663576794013, 481.61952057873884, 505.4490605240306, 509.82665893596356, 524.5803357314134, 7208.639568021683, 7363.079615048119, 7512.5492470451945, 7956.761297161094, 8044.637991290406, 507.22901190190703, 508.2046597075565, 509.53377659441196, 512.851273130788, 524.4676653197008, 3489.9302013959577, 3556.78659280444, 3557.786532807988, 3584.7311451640708, 3729.5710993235584, 93916.0, 98623.50688246512, 99667.0, 103147.0, 103467.0, 74286.0, 82516.58741706373, 83383.58308208542, 84824.0, 85643.57178214069, 77921.0, 79218.60390698125, 79237.0, 79330.20669793343, 79701.60149199217, 6876.828079298058, 7029.261927497743, 7186.568805871664, 7314.634268286458, 7334.889976650461, 44313.0, 45902.54097458983, 46479.53520464888, 47294.76352618215, 47384.28923566218, 37287.576472470435, 38621.648242311385, 38750.0, 58167.70916145561, 65093.67453162704, 9016.143466370684, 9075.54622268897, 9090.272778177863, 9117.954410227907, 9170.358074934691, 10050.396976181453, 10160.593576256866, 10174.74563135898, 10194.796104077728, 10478.423686697304, 8993.190612844875, 9398.248140148908, 9497.287703422133, 9657.034296570288, 9691.757706057406, 10039.297249192487, 10080.596776128872, 10143.442110683984, 10258.43578603184, 10338.0695737384, 9289.953550232205, 9350.579223935076, 9488.857667135137, 9495.572699228413, 9578.0, 7834.138244793182, 7870.763877083697, 7906.683732650629, 7993.0, 8088.71689490865, 7919.0893047298, 8538.829223415622, 9190.908090919005, 9709.9029009709, 9866.55600497965], "value": 6203.36110355984, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 120.0, 120.0, 119.0, 116.0, 118.0, 117.0, 116.0, 116.0, 137.0], "value": 119.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 148.0, 182.0, 124.0, 151.0, 162.0, 130.0, 193.0, 128.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 165.0, 164.0, 163.0, 162.0, 164.0, 163.0, 163.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 189.0, 79.0, 76.0, 76.0, 76.0, 161.0, 77.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 139.0, 85.0, 84.0, 84.0, 139.0, 83.0, 84.0, 141.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 119.0, 117.0, 119.0, 117.0, 120.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 149.0, 149.0, 148.0, 149.0, 148.0, 151.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 95.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 82.0, 85.0, 89.0, 84.0, 84.0, 83.0, 85.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 133.0, 136.0, 143.0, 132.0, 144.0, 133.0, 137.0, 191.0, 141.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 180.0, 182.0, 179.0, 186.0, 180.0, 172.0, 173.0, 172.0, 178.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 70.0], "value": 70.1, "unit": "score"}]}]} 18:46:43 INFO - Return code: 0 18:46:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:46:43 ERROR - # TBPL SUCCESS # 18:46:43 INFO - Running post-action listener: _resource_record_post_action 18:46:43 INFO - [mozharness: 2016-08-31 01:46:43.984092Z] Finished run-tests step (success) 18:46:43 INFO - Running post-run listener: _resource_record_post_run 18:46:44 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 196608; Write bytes: 417857536; Read time: 60; Write time: 277760 18:46:44 INFO - TinderboxPrint: CPU usage
13.4% 18:46:44 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 60 18:46:44 INFO - TinderboxPrint: I/O write bytes / time
417,857,536 / 277,760 18:46:44 INFO - TinderboxPrint: CPU idle
8,287.3 (86.6%) 18:46:44 INFO - TinderboxPrint: CPU user
1,220.9 (12.8%) 18:46:44 INFO - TinderboxPrint: Swap in / out
0 / 0 18:46:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124973056; Read time: 0; Write time: 82348 18:46:44 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 192512; Write bytes: 292884480; Read time: 48; Write time: 195412 18:46:44 INFO - Running post-run listener: _upload_blobber_files 18:46:44 INFO - Blob upload gear active. 18:46:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46:44 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 18:46:44 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:46:44 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:46:45 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:46:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:49 INFO - (blobuploader) - INFO - Done attempting. 18:46:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:46:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:46:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:51 INFO - (blobuploader) - INFO - Done attempting. 18:46:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:46:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:46:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:52 INFO - (blobuploader) - INFO - Done attempting. 18:46:52 INFO - (blobuploader) - INFO - Iteration through files over. 18:46:52 INFO - Return code: 0 18:46:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:46:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:46:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/47c370a8640b3851f37602ddb65bfb0c26ba36b97cf64e13d694398baa6dc477f36608a0d6e365d277a727f43c2142857fa8ebdd3822092c19bc180237895191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d03335092dc9d4bee07ffe0bc00ca7c5f075a5fe1245575f7813247e6ed7dcd828c8d54fe357744198246d3fcf604df101ece81885ab068ed9feb6ec69cec068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4b45dcf273ae4953b8c4c1962e9c2e91b6dbf06e3313aa5afe962f8700528c30f9c7febaf6f51f2e0ad7b08ba1088abfb7e8ba2a8ec7a5452e2394ac772f338e"} 18:46:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:46:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:46:52 INFO - Contents: 18:46:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/47c370a8640b3851f37602ddb65bfb0c26ba36b97cf64e13d694398baa6dc477f36608a0d6e365d277a727f43c2142857fa8ebdd3822092c19bc180237895191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d03335092dc9d4bee07ffe0bc00ca7c5f075a5fe1245575f7813247e6ed7dcd828c8d54fe357744198246d3fcf604df101ece81885ab068ed9feb6ec69cec068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4b45dcf273ae4953b8c4c1962e9c2e91b6dbf06e3313aa5afe962f8700528c30f9c7febaf6f51f2e0ad7b08ba1088abfb7e8ba2a8ec7a5452e2394ac772f338e"} 18:46:52 INFO - Running post-run listener: copy_logs_to_upload_dir 18:46:52 INFO - Copying logs to upload dir... 18:46:52 INFO - mkdir: /builds/slave/test/build/upload/logs 18:46:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.999273 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 18:46:51.941295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 18:46:51.944481) ========= 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=0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925 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/Autoland-Non-PGO/sha512/47c370a8640b3851f37602ddb65bfb0c26ba36b97cf64e13d694398baa6dc477f36608a0d6e365d277a727f43c2142857fa8ebdd3822092c19bc180237895191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d03335092dc9d4bee07ffe0bc00ca7c5f075a5fe1245575f7813247e6ed7dcd828c8d54fe357744198246d3fcf604df101ece81885ab068ed9feb6ec69cec068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4b45dcf273ae4953b8c4c1962e9c2e91b6dbf06e3313aa5afe962f8700528c30f9c7febaf6f51f2e0ad7b08ba1088abfb7e8ba2a8ec7a5452e2394ac772f338e"} build_url:https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/dE7kvi4qQrGuqBqpjIG4hA/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/Autoland-Non-PGO/sha512/47c370a8640b3851f37602ddb65bfb0c26ba36b97cf64e13d694398baa6dc477f36608a0d6e365d277a727f43c2142857fa8ebdd3822092c19bc180237895191", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d03335092dc9d4bee07ffe0bc00ca7c5f075a5fe1245575f7813247e6ed7dcd828c8d54fe357744198246d3fcf604df101ece81885ab068ed9feb6ec69cec068", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4b45dcf273ae4953b8c4c1962e9c2e91b6dbf06e3313aa5afe962f8700528c30f9c7febaf6f51f2e0ad7b08ba1088abfb7e8ba2a8ec7a5452e2394ac772f338e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 18:46:51.969506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:46:51.969816) ========= 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=0e2a256762fed810e2f0f810000001b3-1472605620.343705-1852326925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 18:46:52.054010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 18:46:52.054341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 18:46:52.054624) ========= ========= Total master_lag: 0.17 =========