builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1472570368.07 results: success (0) buildid: 20160830065321 builduid: 1f3b0468af7a41ba852782b03ceabc74 revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.066390) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.069989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.070377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.107296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.107556) ========= 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=62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 08:19:28-- 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% 227M=0s 2016-08-30 08:19:28 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.209202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.209532) ========= 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=62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.262352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.262945) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b18c8bcdc116eef8799880b7c50317bf54218474 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b18c8bcdc116eef8799880b7c50317bf54218474 --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=62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 08:19:28,830 truncating revision to first 12 chars 2016-08-30 08:19:28,830 Setting DEBUG logging. 2016-08-30 08:19:28,830 attempt 1/10 2016-08-30 08:19:28,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b18c8bcdc116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 08:19:29,099 unpacking tar archive at: mozilla-central-b18c8bcdc116/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.826323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.826663) ========= script_repo_revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.827065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.827335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:19:28.838238) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 08:19:28.838509) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:19:29 INFO - MultiFileLogger online at 20160830 08:19:29 in /builds/slave/test 08:19:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:19:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:19:29 INFO - {'append_to_log': False, 08:19:29 INFO - 'base_work_dir': '/builds/slave/test', 08:19:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:19:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:19:29 INFO - 'branch': 'Firefox-Non-PGO', 08:19:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:19:29 INFO - 'config_files': ('talos/linux_config.py',), 08:19:29 INFO - 'default_actions': ('clobber', 08:19:29 INFO - 'read-buildbot-config', 08:19:29 INFO - 'download-and-extract', 08:19:29 INFO - 'populate-webroot', 08:19:29 INFO - 'create-virtualenv', 08:19:29 INFO - 'install', 08:19:29 INFO - 'run-tests'), 08:19:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:19:29 INFO - 'download_minidump_stackwalk': True, 08:19:29 INFO - 'download_symbols': 'ondemand', 08:19:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:19:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:19:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:19:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:19:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:19:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:19:29 INFO - 'installer_path': 'installer.exe', 08:19:29 INFO - 'log_level': 'info', 08:19:29 INFO - 'log_name': 'talos', 08:19:29 INFO - 'log_to_console': True, 08:19:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:19:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:19:29 INFO - 'opt_config_files': (), 08:19:29 INFO - 'pip_index': False, 08:19:29 INFO - 'sps_profile': False, 08:19:29 INFO - 'sps_profile_interval': 0, 08:19:29 INFO - 'suite': 'dromaeojs', 08:19:29 INFO - 'system_bits': '32', 08:19:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:19:29 INFO - 'title': 'talos-linux64-ix-018', 08:19:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:19:29 INFO - 'use_talos_json': True, 08:19:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:19:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:19:29 INFO - 'work_dir': 'build'} 08:19:29 INFO - [mozharness: 2016-08-30 15:19:29.494978Z] Running clobber step. 08:19:29 INFO - Running pre-action listener: _resource_record_pre_action 08:19:29 INFO - Running main action method: clobber 08:19:29 INFO - rmtree: /builds/slave/test/build 08:19:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:19:29 INFO - Running post-action listener: _resource_record_post_action 08:19:29 INFO - [mozharness: 2016-08-30 15:19:29.956162Z] Finished clobber step (success) 08:19:29 INFO - [mozharness: 2016-08-30 15:19:29.956264Z] Running read-buildbot-config step. 08:19:29 INFO - Running pre-action listener: _resource_record_pre_action 08:19:29 INFO - Running main action method: read_buildbot_config 08:19:29 INFO - Using buildbot properties: 08:19:29 INFO - { 08:19:29 INFO - "project": "", 08:19:29 INFO - "product": "firefox", 08:19:29 INFO - "script_repo_revision": "production", 08:19:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:19:29 INFO - "repository": "", 08:19:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:19:29 INFO - "buildid": "20160830065321", 08:19:29 INFO - "pgo_build": "False", 08:19:29 INFO - "basedir": "/builds/slave/test", 08:19:29 INFO - "buildnumber": 697, 08:19:29 INFO - "slavename": "talos-linux64-ix-018", 08:19:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:19:29 INFO - "platform": "ubuntu64_hw", 08:19:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:19:29 INFO - "branch": "mozilla-central", 08:19:29 INFO - "repo_path": "mozilla-central", 08:19:29 INFO - "revision": "b18c8bcdc116eef8799880b7c50317bf54218474", 08:19:29 INFO - "stage_platform": "linux64", 08:19:29 INFO - "builduid": "1f3b0468af7a41ba852782b03ceabc74", 08:19:29 INFO - "slavebuilddir": "test" 08:19:29 INFO - } 08:19:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:19:29 INFO - Running post-action listener: _resource_record_post_action 08:19:29 INFO - [mozharness: 2016-08-30 15:19:29.958700Z] Finished read-buildbot-config step (success) 08:19:29 INFO - [mozharness: 2016-08-30 15:19:29.958791Z] Running download-and-extract step. 08:19:29 INFO - Running pre-action listener: _resource_record_pre_action 08:19:29 INFO - Running main action method: download_and_extract 08:19:29 INFO - mkdir: /builds/slave/test/build/tests 08:19: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')]} 08:19:29 INFO - trying https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:19:29 INFO - Downloading https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:30 INFO - Downloaded 1361 bytes. 08:19:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:19:30 INFO - Using the following test package requirements: 08:19:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:19:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:19:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'jsshell-linux-x86_64.zip'], 08:19:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:19:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:19:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:19:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:19:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:19:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:30 INFO - trying https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:19:30 INFO - Downloading https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:31 INFO - Downloaded 20315393 bytes. 08:19:31 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 08:19:35 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 08:19: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')]} 08:19:35 INFO - trying https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:19:35 INFO - Downloading https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:36 INFO - Downloaded 20315393 bytes. 08:19:36 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 08:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:41 INFO - trying https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:41 INFO - Downloading https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:41 INFO - Downloaded 14413998 bytes. 08:19:41 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 08:19: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')]} 08:19:42 INFO - trying https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:19:42 INFO - Downloading https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/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 08:19:43 INFO - Downloaded 55849386 bytes. 08:19:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:19:43 INFO - mkdir: /builds/slave/test/properties 08:19:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:19:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:19:43 INFO - Contents: 08:19:43 INFO - build_url:https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:19:43 INFO - Running post-action listener: _resource_record_post_action 08:19:43 INFO - Running post-action listener: set_extra_try_arguments 08:19:43 INFO - [mozharness: 2016-08-30 15:19:43.888997Z] Finished download-and-extract step (success) 08:19:43 INFO - [mozharness: 2016-08-30 15:19:43.889342Z] Running populate-webroot step. 08:19:43 INFO - Running pre-action listener: _resource_record_pre_action 08:19:43 INFO - Running main action method: populate_webroot 08:19:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:43 INFO - '--tppagecycles', 08:19:43 INFO - '7'], 08:19:43 INFO - 'tests': ['tsvgm']}}, 08:19:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:19:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:19:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:19:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['damp', 'tps']}, 08:19:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'tests': ['damp', 'tps']}, 08:19:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['dromaeo_dom']}, 08:19:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['basic_compositor_video']}, 08:19:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:19:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore', 08:19:43 INFO - 'tabpaint']}, 08:19:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore', 08:19:43 INFO - 'tabpaint']}, 08:19:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore', 08:19:43 INFO - 'tabpaint']}, 08:19:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore', 08:19:43 INFO - 'tabpaint']}, 08:19:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore', 08:19:43 INFO - 'tabpaint']}, 08:19:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore', 08:19:43 INFO - 'tabpaint']}, 08:19:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['tsvgx', 08:19:43 INFO - 'tsvgr_opacity', 08:19:43 INFO - 'tart', 08:19:43 INFO - 'tscrollx', 08:19:43 INFO - 'cart']}, 08:19:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:19:43 INFO - 'tsvgr_opacity', 08:19:43 INFO - 'tart', 08:19:43 INFO - 'tscrollx', 08:19:43 INFO - 'cart']}, 08:19:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--disable-e10s'], 08:19:43 INFO - 'tests': ['tp5o']}, 08:19:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'tests': ['tp5o']}, 08:19:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--disable-e10s', 08:19:43 INFO - '--xperf_path', 08:19:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:43 INFO - 'tests': ['tp5n']}, 08:19:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--xperf_path', 08:19:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:43 INFO - 'tests': ['tp5n']}}, 08:19:43 INFO - 'talos.zip': {'path': '', 08:19:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:43 INFO - Running post-action listener: _resource_record_post_action 08:19:43 INFO - [mozharness: 2016-08-30 15:19:43.906883Z] Finished populate-webroot step (success) 08:19:43 INFO - [mozharness: 2016-08-30 15:19:43.906978Z] Running create-virtualenv step. 08:19:43 INFO - Running pre-action listener: _resource_record_pre_action 08:19:43 INFO - Running main action method: create_virtualenv 08:19:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19:43 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 08:19:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:44 INFO - Using real prefix '/usr' 08:19:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:46 INFO - Installing pip.................done. 08:19:46 INFO - Return code: 0 08:19:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:19:46 INFO - Using env: {'DISPLAY': ':0', 08:19:46 INFO - 'HOME': '/home/cltbld', 08:19:46 INFO - 'LANG': 'en_US.UTF-8', 08:19:46 INFO - 'LANGUAGE': 'en_US:en', 08:19:46 INFO - 'LOGNAME': 'cltbld', 08:19:46 INFO - 'MAIL': '/var/mail/cltbld', 08:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:46 INFO - 'MOZ_NO_REMOTE': '1', 08:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:46 INFO - 'NO_EM_RESTART': '1', 08:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:46 INFO - 'PWD': '/builds/slave/test', 08:19:46 INFO - 'SHELL': '/bin/bash', 08:19:46 INFO - 'SHLVL': '1', 08:19:46 INFO - 'TERM': 'linux', 08:19:46 INFO - 'TMOUT': '86400', 08:19:46 INFO - 'USER': 'cltbld', 08:19:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:46 INFO - '_': '/tools/buildbot/bin/python'} 08:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:46 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 08:19:46 INFO - Cleaning up... 08:19:46 INFO - Return code: 0 08:19:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:19:46 INFO - Using env: {'DISPLAY': ':0', 08:19:46 INFO - 'HOME': '/home/cltbld', 08:19:46 INFO - 'LANG': 'en_US.UTF-8', 08:19:46 INFO - 'LANGUAGE': 'en_US:en', 08:19:46 INFO - 'LOGNAME': 'cltbld', 08:19:46 INFO - 'MAIL': '/var/mail/cltbld', 08:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:46 INFO - 'MOZ_NO_REMOTE': '1', 08:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:46 INFO - 'NO_EM_RESTART': '1', 08:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:46 INFO - 'PWD': '/builds/slave/test', 08:19:46 INFO - 'SHELL': '/bin/bash', 08:19:46 INFO - 'SHLVL': '1', 08:19:46 INFO - 'TERM': 'linux', 08:19:46 INFO - 'TMOUT': '86400', 08:19:46 INFO - 'USER': 'cltbld', 08:19:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:46 INFO - '_': '/tools/buildbot/bin/python'} 08:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:46 INFO - Downloading/unpacking psutil>=3.1.1 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:48 INFO - Installing collected packages: psutil 08:19:48 INFO - Running setup.py install for psutil 08:19:48 INFO - building 'psutil._psutil_linux' extension 08:19:48 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 08:19:49 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 08:19:49 INFO - building 'psutil._psutil_posix' extension 08:19:49 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 08:19:49 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 08:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:49 INFO - Successfully installed psutil 08:19:49 INFO - Cleaning up... 08:19:49 INFO - Return code: 0 08:19:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:49 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')]} 08:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:49 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')]} 08:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:49 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:19:49 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 08:19:49 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 08:19:49 INFO - Using env: {'DISPLAY': ':0', 08:19:49 INFO - 'HOME': '/home/cltbld', 08:19:49 INFO - 'LANG': 'en_US.UTF-8', 08:19:49 INFO - 'LANGUAGE': 'en_US:en', 08:19:49 INFO - 'LOGNAME': 'cltbld', 08:19:49 INFO - 'MAIL': '/var/mail/cltbld', 08:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:49 INFO - 'MOZ_NO_REMOTE': '1', 08:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:49 INFO - 'NO_EM_RESTART': '1', 08:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:49 INFO - 'PWD': '/builds/slave/test', 08:19:49 INFO - 'SHELL': '/bin/bash', 08:19:49 INFO - 'SHLVL': '1', 08:19:49 INFO - 'TERM': 'linux', 08:19:49 INFO - 'TMOUT': '86400', 08:19:49 INFO - 'USER': 'cltbld', 08:19:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:49 INFO - '_': '/tools/buildbot/bin/python'} 08:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:51 INFO - Installing collected packages: mozsystemmonitor 08:19:51 INFO - Running setup.py install for mozsystemmonitor 08:19:51 INFO - Successfully installed mozsystemmonitor 08:19:51 INFO - Cleaning up... 08:19:51 INFO - Return code: 0 08:19:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19:51 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')]} 08:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:51 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')]} 08:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:51 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:19:51 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 08:19:51 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 08:19:51 INFO - Using env: {'DISPLAY': ':0', 08:19:51 INFO - 'HOME': '/home/cltbld', 08:19:51 INFO - 'LANG': 'en_US.UTF-8', 08:19:51 INFO - 'LANGUAGE': 'en_US:en', 08:19:51 INFO - 'LOGNAME': 'cltbld', 08:19:51 INFO - 'MAIL': '/var/mail/cltbld', 08:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:51 INFO - 'MOZ_NO_REMOTE': '1', 08:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:51 INFO - 'NO_EM_RESTART': '1', 08:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:51 INFO - 'PWD': '/builds/slave/test', 08:19:51 INFO - 'SHELL': '/bin/bash', 08:19:51 INFO - 'SHLVL': '1', 08:19:51 INFO - 'TERM': 'linux', 08:19:51 INFO - 'TMOUT': '86400', 08:19:51 INFO - 'USER': 'cltbld', 08:19:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:51 INFO - '_': '/tools/buildbot/bin/python'} 08:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:51 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 08:19:51 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 08:19:51 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 08:19:51 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 08:19:51 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 08:19:51 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 08:19:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:54 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:54 INFO - warning: no files found matching '*.txt' 08:19:54 INFO - no previously-included directories found matching 'build' 08:19:54 INFO - no previously-included directories found matching 'dist' 08:19:54 INFO - no previously-included directories found matching '.git*' 08:19:54 INFO - Installing collected packages: jsonschema, functools32 08:19:54 INFO - Running setup.py install for functools32 08:19:54 INFO - warning: no files found matching '*.txt' 08:19:54 INFO - no previously-included directories found matching 'build' 08:19:54 INFO - no previously-included directories found matching 'dist' 08:19:54 INFO - no previously-included directories found matching '.git*' 08:19:54 INFO - Successfully installed jsonschema functools32 08:19:54 INFO - Cleaning up... 08:19:54 INFO - Return code: 0 08:19:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:19:54 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')]} 08:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:54 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')]} 08:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:54 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:19:54 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 08:19:54 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 08:19:54 INFO - Using env: {'DISPLAY': ':0', 08:19:54 INFO - 'HOME': '/home/cltbld', 08:19:54 INFO - 'LANG': 'en_US.UTF-8', 08:19:54 INFO - 'LANGUAGE': 'en_US:en', 08:19:54 INFO - 'LOGNAME': 'cltbld', 08:19:54 INFO - 'MAIL': '/var/mail/cltbld', 08:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:54 INFO - 'MOZ_NO_REMOTE': '1', 08:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:54 INFO - 'NO_EM_RESTART': '1', 08:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:54 INFO - 'PWD': '/builds/slave/test', 08:19:54 INFO - 'SHELL': '/bin/bash', 08:19:54 INFO - 'SHLVL': '1', 08:19:54 INFO - 'TERM': 'linux', 08:19:54 INFO - 'TMOUT': '86400', 08:19:54 INFO - 'USER': 'cltbld', 08:19:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:54 INFO - '_': '/tools/buildbot/bin/python'} 08:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:19:54 INFO - Cleaning up... 08:19:54 INFO - Return code: 0 08:19:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:54 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')]} 08:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:54 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')]} 08:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:54 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:19:54 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 08:19:54 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 08:19:54 INFO - Using env: {'DISPLAY': ':0', 08:19:54 INFO - 'HOME': '/home/cltbld', 08:19:54 INFO - 'LANG': 'en_US.UTF-8', 08:19:54 INFO - 'LANGUAGE': 'en_US:en', 08:19:54 INFO - 'LOGNAME': 'cltbld', 08:19:54 INFO - 'MAIL': '/var/mail/cltbld', 08:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:54 INFO - 'MOZ_NO_REMOTE': '1', 08:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:54 INFO - 'NO_EM_RESTART': '1', 08:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:54 INFO - 'PWD': '/builds/slave/test', 08:19:54 INFO - 'SHELL': '/bin/bash', 08:19:54 INFO - 'SHLVL': '1', 08:19:54 INFO - 'TERM': 'linux', 08:19:54 INFO - 'TMOUT': '86400', 08:19:54 INFO - 'USER': 'cltbld', 08:19:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:54 INFO - '_': '/tools/buildbot/bin/python'} 08:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:56 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 08:19:56 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 08:19:56 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 08:19:56 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 08:19:56 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 08:19:56 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 08:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:57 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 08:19:57 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 08:19:57 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 08:19:57 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 08:19:57 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 08:19:57 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 08:19:57 INFO - Downloading docopt-0.6.1.tar.gz 08:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:57 INFO - Running setup.py install for blobuploader 08:19:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:57 INFO - Running setup.py install for requests 08:19:57 INFO - Running setup.py install for docopt 08:19:57 INFO - Successfully installed blobuploader requests docopt 08:19:57 INFO - Cleaning up... 08:19:57 INFO - Return code: 0 08:19:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:57 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:19:58 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 08:19:58 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 08:19:58 INFO - Using env: {'DISPLAY': ':0', 08:19:58 INFO - 'HOME': '/home/cltbld', 08:19:58 INFO - 'LANG': 'en_US.UTF-8', 08:19:58 INFO - 'LANGUAGE': 'en_US:en', 08:19:58 INFO - 'LOGNAME': 'cltbld', 08:19:58 INFO - 'MAIL': '/var/mail/cltbld', 08:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:58 INFO - 'MOZ_NO_REMOTE': '1', 08:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:58 INFO - 'NO_EM_RESTART': '1', 08:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:58 INFO - 'PWD': '/builds/slave/test', 08:19:58 INFO - 'SHELL': '/bin/bash', 08:19:58 INFO - 'SHLVL': '1', 08:19:58 INFO - 'TERM': 'linux', 08:19:58 INFO - 'TMOUT': '86400', 08:19:58 INFO - 'USER': 'cltbld', 08:19:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:58 INFO - '_': '/tools/buildbot/bin/python'} 08:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:58 INFO - Running setup.py (path:/tmp/pip-NIFJHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:58 INFO - Running setup.py (path:/tmp/pip-znolZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:58 INFO - Running setup.py (path:/tmp/pip-3yf28M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:58 INFO - Running setup.py (path:/tmp/pip-NT93rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:58 INFO - Running setup.py (path:/tmp/pip-wL4Bgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:58 INFO - Running setup.py (path:/tmp/pip-EcKXmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:58 INFO - Running setup.py (path:/tmp/pip-QvbZXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:58 INFO - Running setup.py (path:/tmp/pip-YQpLcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:58 INFO - Running setup.py (path:/tmp/pip-47n0Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:58 INFO - Running setup.py (path:/tmp/pip-l53eHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:58 INFO - Running setup.py (path:/tmp/pip-apaHqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:58 INFO - Running setup.py (path:/tmp/pip-EarW0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:59 INFO - Running setup.py (path:/tmp/pip-OgoDW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:59 INFO - Running setup.py (path:/tmp/pip-EUhsN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:59 INFO - Running setup.py (path:/tmp/pip-6kgONE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:59 INFO - Running setup.py (path:/tmp/pip-L428h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:59 INFO - Running setup.py (path:/tmp/pip-3fx165-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:59 INFO - Running setup.py install for manifestparser 08:19:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:59 INFO - Running setup.py install for mozcrash 08:19:59 INFO - Running setup.py install for mozdebug 08:19:59 INFO - Running setup.py install for mozdevice 08:19:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:59 INFO - Running setup.py install for mozfile 08:19:59 INFO - Running setup.py install for mozhttpd 08:20:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Running setup.py install for mozinfo 08:20:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Running setup.py install for mozInstall 08:20:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Running setup.py install for mozleak 08:20:00 INFO - Running setup.py install for mozlog 08:20:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Running setup.py install for moznetwork 08:20:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Running setup.py install for mozprocess 08:20:00 INFO - Running setup.py install for mozprofile 08:20:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Running setup.py install for mozrunner 08:20:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:20:00 INFO - Running setup.py install for mozscreenshot 08:20:01 INFO - Running setup.py install for moztest 08:20:01 INFO - Running setup.py install for mozversion 08:20:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:20:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:20:01 INFO - Cleaning up... 08:20:01 INFO - Return code: 0 08:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:01 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')]} 08:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:01 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')]} 08:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:01 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:20:01 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 08:20:01 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 08:20:01 INFO - Using env: {'DISPLAY': ':0', 08:20:01 INFO - 'HOME': '/home/cltbld', 08:20:01 INFO - 'LANG': 'en_US.UTF-8', 08:20:01 INFO - 'LANGUAGE': 'en_US:en', 08:20:01 INFO - 'LOGNAME': 'cltbld', 08:20:01 INFO - 'MAIL': '/var/mail/cltbld', 08:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:01 INFO - 'MOZ_NO_REMOTE': '1', 08:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:01 INFO - 'NO_EM_RESTART': '1', 08:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:01 INFO - 'PWD': '/builds/slave/test', 08:20:01 INFO - 'SHELL': '/bin/bash', 08:20:01 INFO - 'SHLVL': '1', 08:20:01 INFO - 'TERM': 'linux', 08:20:01 INFO - 'TMOUT': '86400', 08:20:01 INFO - 'USER': 'cltbld', 08:20:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:01 INFO - '_': '/tools/buildbot/bin/python'} 08:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:01 INFO - Running setup.py (path:/tmp/pip-gn7C58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:01 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)) 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:01 INFO - Running setup.py (path:/tmp/pip-PiP_lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:01 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)) 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:01 INFO - Running setup.py (path:/tmp/pip-UkI3VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:01 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)) 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:01 INFO - Running setup.py (path:/tmp/pip-Lsnrto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:01 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)) 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:01 INFO - Running setup.py (path:/tmp/pip-h5F9Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:01 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)) 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:01 INFO - Running setup.py (path:/tmp/pip-qxF83j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:01 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)) 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:01 INFO - Running setup.py (path:/tmp/pip-TZxKF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:01 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)) 08:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:01 INFO - Running setup.py (path:/tmp/pip-lXg63Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:02 INFO - Running setup.py (path:/tmp/pip-xB6NT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:02 INFO - Running setup.py (path:/tmp/pip-0sRiBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:02 INFO - Running setup.py (path:/tmp/pip-PVgJP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:02 INFO - Running setup.py (path:/tmp/pip-mujYjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:02 INFO - Running setup.py (path:/tmp/pip-3uYWdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:02 INFO - Running setup.py (path:/tmp/pip-i8Za0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:02 INFO - Running setup.py (path:/tmp/pip-Va1rAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:02 INFO - Running setup.py (path:/tmp/pip-w6vvfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:02 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)) 08:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:02 INFO - Running setup.py (path:/tmp/pip-J__4Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:02 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 08:20:02 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 08:20:02 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 08:20:02 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 08:20:02 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 08:20:02 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 08:20:04 INFO - Downloading blessings-1.6.tar.gz 08:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:20:04 INFO - Installing collected packages: blessings 08:20:04 INFO - Running setup.py install for blessings 08:20:04 INFO - Successfully installed blessings 08:20:04 INFO - Cleaning up... 08:20:04 INFO - Return code: 0 08:20:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:05 INFO - Reading from file tmpfile_stdout 08:20:05 INFO - Current package versions: 08:20:05 INFO - argparse == 1.2.1 08:20:05 INFO - blessings == 1.6 08:20:05 INFO - blobuploader == 1.2.4 08:20:05 INFO - docopt == 0.6.1 08:20:05 INFO - functools32 == 3.2.3-2 08:20:05 INFO - jsonschema == 2.5.1 08:20:05 INFO - manifestparser == 1.1 08:20:05 INFO - mozInstall == 1.12 08:20:05 INFO - mozcrash == 0.17 08:20:05 INFO - mozdebug == 0.1 08:20:05 INFO - mozdevice == 0.48 08:20:05 INFO - mozfile == 1.2 08:20:05 INFO - mozhttpd == 0.7 08:20:05 INFO - mozinfo == 0.9 08:20:05 INFO - mozleak == 0.1 08:20:05 INFO - mozlog == 3.3 08:20:05 INFO - moznetwork == 0.27 08:20:05 INFO - mozprocess == 0.23 08:20:05 INFO - mozprofile == 0.28 08:20:05 INFO - mozrunner == 6.12 08:20:05 INFO - mozscreenshot == 0.1 08:20:05 INFO - mozsystemmonitor == 0.3 08:20:05 INFO - moztest == 0.7 08:20:05 INFO - mozversion == 1.4 08:20:05 INFO - psutil == 3.1.1 08:20:05 INFO - requests == 1.2.3 08:20:05 INFO - wsgiref == 0.1.2 08:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:05 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')]} 08:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 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')]} 08:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:20:05 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 08:20:05 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 08:20:05 INFO - Using env: {'DISPLAY': ':0', 08:20:05 INFO - 'HOME': '/home/cltbld', 08:20:05 INFO - 'LANG': 'en_US.UTF-8', 08:20:05 INFO - 'LANGUAGE': 'en_US:en', 08:20:05 INFO - 'LOGNAME': 'cltbld', 08:20:05 INFO - 'MAIL': '/var/mail/cltbld', 08:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:05 INFO - 'MOZ_NO_REMOTE': '1', 08:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:05 INFO - 'NO_EM_RESTART': '1', 08:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:05 INFO - 'PWD': '/builds/slave/test', 08:20:05 INFO - 'SHELL': '/bin/bash', 08:20:05 INFO - 'SHLVL': '1', 08:20:05 INFO - 'TERM': 'linux', 08:20:05 INFO - 'TMOUT': '86400', 08:20:05 INFO - 'USER': 'cltbld', 08:20:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:05 INFO - '_': '/tools/buildbot/bin/python'} 08:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 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)) 08:20:05 INFO - Cleaning up... 08:20:05 INFO - Return code: 0 08:20:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:20:05 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')]} 08:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 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')]} 08:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 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 0x7f2597fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a44230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, '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': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', '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 08:20:05 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 08:20:05 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 08:20:05 INFO - Using env: {'DISPLAY': ':0', 08:20:05 INFO - 'HOME': '/home/cltbld', 08:20:05 INFO - 'LANG': 'en_US.UTF-8', 08:20:05 INFO - 'LANGUAGE': 'en_US:en', 08:20:05 INFO - 'LOGNAME': 'cltbld', 08:20:05 INFO - 'MAIL': '/var/mail/cltbld', 08:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:05 INFO - 'MOZ_NO_REMOTE': '1', 08:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:05 INFO - 'NO_EM_RESTART': '1', 08:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:05 INFO - 'PWD': '/builds/slave/test', 08:20:05 INFO - 'SHELL': '/bin/bash', 08:20:05 INFO - 'SHLVL': '1', 08:20:05 INFO - 'TERM': 'linux', 08:20:05 INFO - 'TMOUT': '86400', 08:20:05 INFO - 'USER': 'cltbld', 08:20:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:05 INFO - '_': '/tools/buildbot/bin/python'} 08:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:20:05 INFO - Cleaning up... 08:20:05 INFO - Return code: 0 08:20:05 INFO - Running post-action listener: _resource_record_post_action 08:20:05 INFO - Running post-action listener: _start_resource_monitoring 08:20:05 INFO - Starting resource monitoring. 08:20:05 INFO - [mozharness: 2016-08-30 15:20:05.519181Z] Finished create-virtualenv step (success) 08:20:05 INFO - [mozharness: 2016-08-30 15:20:05.519739Z] Running install step. 08:20:05 INFO - Running pre-action listener: _resource_record_pre_action 08:20:05 INFO - Running main action method: install 08:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:05 INFO - Reading from file tmpfile_stdout 08:20:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:20:05 INFO - Reading from file tmpfile_stdout 08:20:05 INFO - Output received: 08:20:05 INFO - Usage: mozinstall [options] installer 08:20:05 INFO - Options: 08:20:05 INFO - -h, --help show this help message and exit 08:20:05 INFO - -d DEST, --destination=DEST 08:20:05 INFO - Directory to install application into. [default: 08:20:05 INFO - "/builds/slave/test"] 08:20:05 INFO - --app=APP Application being installed. [default: firefox] 08:20:05 INFO - mkdir: /builds/slave/test/build/application 08:20:05 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'] 08:20:05 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 08:20:21 INFO - Reading from file tmpfile_stdout 08:20:21 INFO - Output received: 08:20:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:20:21 INFO - Running post-action listener: _resource_record_post_action 08:20:21 INFO - [mozharness: 2016-08-30 15:20:21.955966Z] Finished install step (success) 08:20:21 INFO - [mozharness: 2016-08-30 15:20:21.956246Z] Running run-tests step. 08:20:21 INFO - Running pre-action listener: _resource_record_pre_action 08:20:21 INFO - Running main action method: run_tests 08:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:20:21 INFO - Python 2.7.3 08:20:21 INFO - Return code: 0 08:20:21 INFO - grabbing minidump binary from tooltool 08:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:21 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 0x2a3e090>, '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 0x2a419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a41e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:20:21 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 08:20:21 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 08:20:21 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 08:20:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:20:22 INFO - Return code: 0 08:20:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:20:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:20:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:20:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:20:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:20:22 INFO - Using env: {'DISPLAY': ':0', 08:20:22 INFO - 'HOME': '/home/cltbld', 08:20:22 INFO - 'LANG': 'en_US.UTF-8', 08:20:22 INFO - 'LANGUAGE': 'en_US:en', 08:20:22 INFO - 'LOGNAME': 'cltbld', 08:20:22 INFO - 'MAIL': '/var/mail/cltbld', 08:20:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:20:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:22 INFO - 'MOZ_NO_REMOTE': '1', 08:20:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:22 INFO - 'NO_EM_RESTART': '1', 08:20:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:22 INFO - 'PWD': '/builds/slave/test', 08:20:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:20:22 INFO - 'SHELL': '/bin/bash', 08:20:22 INFO - 'SHLVL': '1', 08:20:22 INFO - 'TERM': 'linux', 08:20:22 INFO - 'TMOUT': '86400', 08:20:22 INFO - 'USER': 'cltbld', 08:20:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872', 08:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:22 INFO - '_': '/tools/buildbot/bin/python'} 08:20:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:20:22 INFO - mozversion application_buildid: 20160830065321 08:20:22 INFO - mozversion application_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 08:20:22 INFO - mozversion application_display_name: Nightly 08:20:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:20:22 INFO - mozversion application_name: Firefox 08:20:22 INFO - mozversion application_remotingname: firefox 08:20:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:20:22 INFO - mozversion application_vendor: Mozilla 08:20:22 INFO - mozversion application_version: 51.0a1 08:20:22 INFO - mozversion platform_buildid: 20160830065321 08:20:22 INFO - mozversion platform_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 08:20:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:20:22 INFO - mozversion platform_version: 51.0a1 08:20:22 INFO - using testdate: 1472570422 08:20:22 INFO - actual date: 1472570422 08:20:22 INFO - starting webserver on 'localhost:40998' 08:20:22 INFO - SUITE-START | Running 2 tests 08:20:22 INFO - TEST-START | dromaeo_css 08:20:22 INFO - operating with platform_type : linux_ 08:20:22 INFO - Initialising browser for dromaeo_css test... 08:20:22 INFO - TEST-INFO | started process 11594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXCvMq/profile http://localhost:40998/getInfo.html) 08:20:26 INFO - PROCESS | 11594 | __metrics Screen width/height:1600/1200 08:20:26 INFO - PROCESS | 11594 | colorDepth:24 08:20:26 INFO - PROCESS | 11594 | Browser inner width/height: 1024/697 08:20:26 INFO - PROCESS | 11594 | __metrics 08:20:27 INFO - PROCESS | 11594 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:20:27 INFO - PROCESS | 11594 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:28 INFO - TEST-INFO | 11594: exit 0 08:20:28 INFO - Browser initialized. 08:20:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:20:28 INFO - TEST-INFO | started process 11675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXCvMq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:40 INFO - PROCESS | 11675 | RSS: Main: 181637120 08:20:40 INFO - PROCESS | 11675 | 08:21:32 INFO - PROCESS | 11675 | 1472570492392 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] 08:23:45 INFO - PROCESS | 11675 | Cycle 1(1): loaded http://localhost:40998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40998/tests/dromaeo/cssquery-ext.html) 08:23:46 INFO - PROCESS | 11675 | RSS: Main: 289361920 08:23:46 INFO - PROCESS | 11675 | 08:26:49 INFO - PROCESS | 11675 | Cycle 1(1): loaded http://localhost:40998/tests/dromaeo/cssquery-ext.html (next: http://localhost:40998/tests/dromaeo/cssquery-jquery.html) 08:26:50 INFO - PROCESS | 11675 | RSS: Main: 274415616 08:26:50 INFO - PROCESS | 11675 | 08:29:52 INFO - PROCESS | 11675 | Cycle 1(1): loaded http://localhost:40998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40998/tests/dromaeo/cssquery-mootools.html) 08:29:52 INFO - PROCESS | 11675 | RSS: Main: 244224000 08:29:52 INFO - PROCESS | 11675 | 08:32:55 INFO - PROCESS | 11675 | Cycle 1(1): loaded http://localhost:40998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40998/tests/dromaeo/cssquery-prototype.html) 08:32:55 INFO - PROCESS | 11675 | RSS: Main: 241782784 08:32:55 INFO - PROCESS | 11675 | 08:35:58 INFO - PROCESS | 11675 | Cycle 1(1): loaded http://localhost:40998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40998/tests/dromaeo/cssquery-yui.html) 08:35:59 INFO - PROCESS | 11675 | RSS: Main: 219983872 08:35:59 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | Cycle 1(1): loaded http://localhost:40998/tests/dromaeo/cssquery-yui.html (next: http://localhost:40998/tests/dromaeo/cssquery-dojo.html) 08:39:02 INFO - PROCESS | 11675 | RSS: Main: 310362112 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | __start_tp_report 08:39:02 INFO - PROCESS | 11675 | _x_x_mozilla_page_load 08:39:02 INFO - PROCESS | 11675 | _x_x_mozilla_page_load_details 08:39:02 INFO - PROCESS | 11675 | |i|pagename|runs| 08:39:02 INFO - PROCESS | 11675 | |0;dojo.html;2596.8182227244088;2612.5428050091236;2615.7122716501194;2648.8808003639833;2671.0517766193;4564.995700945787;4640.814367425303;4643.396358473402;4706.199946009174;4745.193317136086;4686.9296960545535;4688.5545873142;4737.455192652855;4740.478547359788;4744.217204161318;4229.894252643678;4285.678574106939;4321.589449002356;4373.846915357964;4452.421185245914;4354.368616550582;4384.408104905845;4408.030233348658;4436.733795972236;4439.75581343026;4226.429432026668;4263.701540892139;4282.828686852522;4308.719933204363;4328.545502722201;4236.110416812442;4254.7872606369865;4262.232798096342;4343.04453020335;4378.452693413324;4271.209826182135;4284.592963668478;4297.892552686177;4313.61177494027;4337.306031035051;4541.682082254243;4629.652776041777;4635.675502714811;4686.109639168547;4739.478657347689;4983.72589507577;5018.071656743514;5020.59835213182;5032.194848824171;5084.669496482754;4997.825076122318;5025.623078269108;5030.622703297231;5078.31442755227;5084.567811736007;4609.861704148881;4652.837150699777;4684.976575117103;4686.601638860667;4737.692050016738;5153.587712982952;5181.0415073210825;5185.922211166836;5234.97382513085;5243.659162154524;4963.081829861487;4975.129352363322;4978.77595508203;4980.05378977993;5040.974795126001;4932.408111026628;4951.653384263139;4982.576480999083;5076.695398276115;5084.211947148198;4926.433460152057;4968.428630707443;4978.27814966835;5002.649814512949;5003.849884503471;4952.232403977389;4965.577925876269;4967.3294105296045;4970.3290055842;5029.321041659329;4231.280682284019;4273.358996150602;4288.056627541936;4291.249031419551;4344.891377715582;3751.8499260029294;3766.0773110587534;3818.045488627843;3854.171353159028;3876.7092468064443;4317.525072242051;4326.658229732723;4327.069680018748;4327.76197309151;4379.277419225856;4929.827456039093;4995.675281106789;5056.089903817348;5080.644354895196;5136.203888397305;4244.596763307481;4270.274053410928;4281.186574550826;4328.091100868853;4332.415123958225;4547.8180872764715;4548.431446069175;4550.977245113753;4589.265717485253;4611.100835337077;4614.746188959505;4739.715617062987;4742.288656701385;4742.715437073786;4744.051189761993;5044.899102018013;5050.217216331474;5103.260027296095;5119.5648369887485;5133.614978876524;4726.740029298284;4728.645351598575;4739.526047395233;4752.524747525358;4816.95183048165;4785.282207668738;4956.8760780980765;4964.205727083649;4975.57707594844;5029.723365214948;5059.924101138412;5079.314292570456;5079.77141028662;5114.207297868837;5141.53726164647;4940.9505904941925;4954.20732682769;4958.851234462972;4969.726665033458;5024.070546948826;4792.9281060784815;4906.484819093944;4964.230544265644;4964.826231082039;5018.272350509083;4872.317875497362;4901.852944411673;4906.607471402208;4934.679245849008;4960.429550601582;5002.674826136289;5008.949910500848;5011.649184557046;5014.398272207212;5077.898442031213;4728.054389122258;4780.904381912412;4888.60891128716;4907.754612269301;4961.156603377507 08:39:02 INFO - PROCESS | 11675 | |1;ext.html;559.7816851427942;573.5411670663468;578.3118089473529;580.4804699793684;582.449585142041;27783.44433111339;30913.845430772843;38844.22311553771;40134;40263;40332.39501407474;40658.39012414816;40696.38955415671;40704.38943415844;40772.79613601928;7687.692492300315;7832.530048197098;7836.373090152774;7839.882401763978;7840.4511684182135;7147.49967502275;10045.748856278578;10368.48157592121;10377.221708371902;10386.896131038706;9991.600335986552;10056.597736090584;10083.596656133783;10084.445355505444;10095.29332946694;9962.302638815287;10024.248181386425;10033.49832508379;10042.096211341015;10071.093601575893;9897.901020989842;9950.651727189586;9955.75110622233;9961.153301969342;9972.850407243897;37873;38028.61971380306;38064.61935380638;38104;38148.237035259415;2907.752841008517;3089.274020605156;3300.9174770630684;3361.445361515347;3523.3481805865995;26718.46563068728;28152.859235703894;28444.431111377657;28505.28736781597;28514;3415.894874173417;3488.8081155536433;3541.8583256669704;3551.982240088809;3616.168281295317;257023;257568;257884;258173;259618;53448.19827702588;53800.19299710508;53867.19199212015;53868;53872.73063634657;56575;56577.71711141418;56679.43320566742;56918;56989;13401.195928244337;13517.459301628021;13539.187648741106;13542.864571354357;13545.322733863268;9470.14768670823;9951.452670103214;10681.359118452918;10713.78572428547;10723.03492685662;17440.389586364417;17624.55938601545;17685.911570442324;17756.28974840992;17890.463286101436;6579.671016449159;6796.218434879953;6852.246252912176;6865.691043903036;6898.2756810535175;727.447140173472;811;814.242754238552;900.9729708108767;922.543341046173;26150.476990460465;27356.863215684192;27404.451910962067;27642.72357276442;28303.858480707877;919.2186641354795;936.8126374725082;958.7698952251549;969.2004096620317;973.99026009739;14411.207383593794;14530.418783248762;14619.122852628876;14962.326695298738;14987;122404;123320.38339808423;123396.38301808613;123521;123905;49369;49776.75111624491;49848.75075624599;50029.24956125661;50080.24879626808;1031.6389263757624;1039.9168066554657;1104.6520346090956;1122.629532254354;1144.3820337017917;25521.61717574201;28764.137075887757;29122.854385727936;29570.852145739133;29609.111726648236;41145.58854411537;41376.58623413727;41461.58538414698;41476.377854332815;41760.16479670451;277664;278795;278830;278853;278958;24032.158874439312;24324.51350973006;25013;25091.24726258215;26011.60982585225;41554.584454156284;41745.37381939212;41912.790436047624;42457.5754242466;43155.352669710606;35135.297294054486;35182.64817351794;35218;35325.293494130485;35736.463953040206;33690.663093368756;33746.49380259249;33854;33987.66012339845;34087;34845;34905.47641785426;35724;35836.462453062704;35947.28105437929;29803.701962980093;31528.684713152576;31628.683713162573;31654;31816.204594885312;24482.387940301636;24859.875700621382;24930.875345623157;25157.87421062883;25183.496330073664 08:39:02 INFO - PROCESS | 11675 | |2;jquery.html;319.4936026398159;340.48756621284946;347.7548328428458;349.9842507087181;367.2013370918252;12617.810732839003;15901.602459938507;15987.360505579793;16771.74842377364;17271.39550115746;15410.691786164298;15434.768478472804;15571.844281557182;15673.216339183024;15801.130937798416;4404.97797511012;4874.585660218886;5095.770690318926;5102.285680004802;5102.923456148161;4968.875778105558;5094.388673359202;5096.566791822699;5101.056304583664;5102.132637451642;4900.877478063059;5053.595712343023;5060.721660308682;5065.214891691775;5065.696058236499;4805.807767689288;4934.309196712463;4946.5795407390415;4947.1589829728855;4948.035133149056;4370.978145109286;4395.7362558246605;4400.713953593006;4405.867823965286;4406.140802543506;19580.51048723779;20120.396388108235;20134.093965771575;20185.596288074157;20315.492112697153;1929.2379510093574;1952.2776572668063;1969.1532640964379;2011.7887621799646;2542.313575334668;12443.440045197987;12775.61673149807;13018.15382000167;13094.279814610192;13433.731325373437;1685.2500637216444;1710.563806229416;1714.185761763165;1789.1143883777484;1799.6310756295059;63347.366526334605;64065.3593464064;65282.673586632234;70409;73066.63466682633;9082.18260356571;9186.311026672893;9453.084396113982;9531.380460270198;9689.660861869801;12412.131150819356;12495.125341226209;12516.937415312865;12532.498700052078;12584.937075314565;6619.238787539398;6791.626460544718;6981.650917454107;7013.859722805515;7018.789436316919;6395.488360931115;6479.708413121327;6612.570182938093;6632.469402447792;6638.5684930479365;3964.5638979712207;4002.9985007496252;4017.276890159799;4073.5926407359025;4283.201055556674;1647.324596915259;1714.4942242038628;1714.9657006860043;1767.89506558401;1770.2034084661955;758.7496126278315;784.8744200927938;924.9676261330821;927.1146055516965;927.5872236854669;16082;16351.509454716377;17040.829591704172;17191.1404429778;17350.739738903925;789.3882241263067;816.7794695432319;836.6402446947749;886.3573908915985;903.4579252448478;8998.820023599492;9002.099790020946;9222.400543964755;9508.381955172892;9663.565139568736;382759;395714;403106;403607;409963;71879.28120718726;72434.27565724381;73652.63173684098;77792;79604.6019769909;911.7082533589321;929.9209567186865;970.7330484116924;970.9465979371203;973.9464329461948;15232.314545845686;15269.160196189316;15649.765253521435;16058.518244452685;16119.516414507583;24848;25325.62011569791;26769.19692409231;34485.310293794486;35730.32368311319;52838.47161528336;52924;54893.17660235179;55406;55493.167602485184;7279;7408.555486670817;7625.389968802593;7666.501677390952;7712.460127791225;10489.632862849763;11694.766104677688;11718.472668730099;11809.291442513477;11952.64142075739;10176.796464070825;10189.337693049929;10219.437930913871;10314.690559283234;10414.583416663248;10255.58977640886;10323.225758068025;10385.584576616851;10391.896081039395;10444.477776111316;10167.389956602627;10401.427921464392;10429.9478502607;10518.842217366899;10790.352578845295;7451.40388768908;7473.775786726407;7495.850082998419;7626.54240745557;7769.145394006768;9546.570404331684;9751.902480975099;9820.754481138028;9916.206703463562;10034.297599167989 08:39:02 INFO - PROCESS | 11675 | |3;mootools.html;1217.5495066825276;1320.089138494439;1342.583799022303;1382.9792553111706;1622.3348427144865;6994.8251293717685;7269.963650181749;7333.9266607333975;7501.287377699124;7551.9622401888055;7409.147947985984;7542.434317426201;7546.886796698054;7547.0943486781525;7550.3582195513445;2166.1010680567547;2177.564487102578;2180.2369170790175;2181.378307182453;2188.2559929623926;2123;2130.28635407138;2188.3106821351225;2191.123550579765;2191.7808219178114;2153.5800518898823;2161.0383379396176;2167.54481558872;2176.9985806529016;2179.7493288271894;2114.38682781993;2115.513431910669;2119.1417475922276;2120.6182887080317;2121.3847984084673;2059.2895451069357;2115.6403411420097;2117.428294360514;2118.565694032735;2122.755883073451;7209.603471809049;7395.334419902235;7437.739679111205;7446.590437525934;7446.739364122284;4182;4347.3696314034605;4356.085222103362;4361.542038086019;4361.956380436219;2748.3266599683006;2840.2757296889367;2869.2885223463836;2883.5345779358554;2896.2614533294086;932.9626814927462;935.1910597333326;947.8815148106487;948.2319321349729;961.6441916490874;9721.562529686182;9763.463009534473;9784.412935223909;9817.460039697813;9840.606375744961;3728.1611637381916;3832.5017747692623;3930.4890364252465;3939.901502462404;3963.7027222958395;7814.492058016211;7872.252136047181;7875.527468351917;7878.881816772753;7888.447808653339;4189.141226048653;4195.454590903163;4203.369494575838;4208.85269015583;4210.789460526961;3616.0598244456633;3739.476473293741;3854.9614503854605;3863;3901.551321597996;3228.806271623663;3242.8974148789525;3369.79781213128;3372.426687463088;3378.44255697812;997.9650712225038;1008.5864795433984;1011.1405305490274;1017.8524114003428;1022.5909636145601;738.446165375968;746.9468050049404;747.5925620536821;772.9536227826349;784.5057613703331;4402.911941761146;4493.191225579427;4540.341650460731;4547.840825571156;4605.0559635274685;392.6995848176148;408.78947342118835;413.0973822198506;414.79467663506153;416.43365023567924;3085.78399512032;3146.276356437986;3294.159989202738;3310.486874534451;3360.3951288767767;8246.670133194604;8454.661813527513;8503.319734421231;8591.785205369792;8626.094260102724;8570.571471426403;8597.054324024477;8628.611712472954;8628.741137765752;8634.568271586395;6392.169018027626;6484;6541.771038013647;6557.983512555562;6571.967140164173;4630.791614377294;4697.694649847749;4699.459562150397;4712.905741885212;4781.378420805273;7668.69325227007;7702.114256860309;7738.303552680286;7788.454808163374;7799;7643.4267429941865;7778.183290754389;7887.250711182429;7940.801479963047;8007.679692812222;5746.195532625519;6330.8100756977365;6457.418832305115;6457.4511166551365;6464.5151613630105;6315.526335524946;6479;6485.77299794505;6707.094542236736;6943.826404339729;6080.787172448943;6162.907556386568;6208.068789681584;6215;6314.179156709783;6109;6156.661383623765;6171.506279497719;6212.06818977157;6301.936980630135;5487.067198576331;5663.773449061991;5705.828825135252;5836.270466191726;5848.590598658053;4237.766922819152;4294.248506511285;4367.58507941745;4369.890752731207;4446.488653804854;4167.349798041568;4199.328107502785;4255.659547236151;4307.375430562488;4352.781221258053 08:39:02 INFO - PROCESS | 11675 | |4;prototype.html;283.58596449184176;288.46201833580375;292.9414117176565;295.8860838577148;298.7415885259251;4719.150552900485;4843.53986371295;4854.5873600743935;4924.310596516486;4934.457209706934;4655.7439340836245;4789.688670236432;4795.448523419807;4802.83190088347;4822.541858523444;3810.40938654509;3811.5616704079107;3815.4276858471176;3820.35054040813;3847.5190601174854;3590.8743193988216;3648.7628304160276;3812.942805857914;3833.8466461341513;3849.499565056539;3753.1180172659538;3757.117077486802;3763.516079387605;3776.3957766757326;3790.753601015939;3747.625237476258;3766.510353654035;3779.622037796226;3782.394816829322;3787.5833658297565;3331.916702082443;3333.616634087087;3337.599488061448;3339.1151344893624;3347.681970212826;4649.5350464953235;4657.627389808841;4671.602913752336;4688.859334219979;4776.761161941924;4338.566143385668;4369.082492676542;4380.4305440292555;4386.363977223285;4401.933970990438;5048.545630893201;5069.822556210552;5083.517065878736;5091.854332775096;5094.032133894548;3577.105723569108;3635.6909662678704;3659.396199627058;3734.2158146789207;3745.1198968242443;5214.296070030536;5219.373675158968;5223.582113430916;5228.346456692913;5339.599530035224;3702.9629703702617;3704.7036237100965;3708.7589306694977;3709.4250391189407;3722.7021838252876;3704.944425833615;3793.6585707286476;3801.885943421702;3804.6766024888193;3820.56063552695;4297.59172878576;4300.247456695066;4301.634361079344;4330.783460826946;4339.175556644227;4982.377202849644;4996.525330093636;4999.200127979506;5018.247262910592;5038.84883453497;1241.4475558376616;1283.3775618824861;1283.5186804948144;1291.9741605168033;1317.4795955597485;864.4381152251087;892.5671049540967;907.3240435875315;926.4533924984157;942.6936245720168;4363.38912552243;4372.278574035248;4372.497162826316;4388.429504164502;4407.272799987966;5149.2791009258735;5181.8081841176745;5192.8961420771375;5201.427842937273;5201.713905735145;4288.421063156434;4475.977620111878;4489.259272220047;4499.1451624191295;4508.233600287894;2750.9037183698474;2777.6250206221903;2778.0692418768763;2787.7351651593067;2789.316617428743;4773.76131193439;4922.950770492321;4923.655344125948;4928.950710492849;4946.826861059845;5218.712970786567;5238.5023422774775;5264.210368444764;5300.9734951325;5341.332333458317;4817.325574419584;4841.733704646208;4864.124457597595;4868.537488938545;4908.239222920453;5041.218611115283;5179.938112686966;5206.438068579487;5211.400688920823;5213.817516386908;5015.699058056528;5072.264521644414;5078.492150784892;5093.286939828353;5103.260027295947;4896;4903.53416425439;4909.754512274443;4910.8281210157475;4911.7298548580175;3521.6654417830264;3693.445983102556;3708.332500149999;3722;3735.4396840474146;5137.5889928806355;5149.348085735924;5186.340371081218;5212.426633070435;5233.528982391603;5030.974845125751;5047.116754567863;5047.671901326402;5082.415522214845;5088.847334579968;4868.367112275381;5036.672616280077;5068.569171620306;5082.567981721595;5099.3370861787735;4715.63246658479;4812.783424745825;4932.605391568594;4985.9501404985485;5008.774605142705;5071.290019397361;5079.517445842639;5080.491950805038;5086.872828179177;5108.56577190943;4991.625628077836;4991.675541089818;4994.80020799164;4997.875053123701;4998.300237966615 08:39:02 INFO - PROCESS | 11675 | |5;yui.html;610.9633421994681;658.0458335413648;684.9794506164817;725.3580581185653;737.5574655206875;12020.038396928247;12402.193857399263;12436.937815310923;12445.004399648029;12531.31077790721;13181.340932953362;13268.601941941733;13279.336033198326;13299.46802127916;13303.201807891533;592.9110633404981;708.7590219325429;726.3499168244405;734.3611058379191;735.6321839080459;735.9264073592651;737.3290305821703;739.9445041621873;740.1599184925095;740.1857956248137;773.9458237923347;779.4894344204555;780.0210735526906;784.8704963681014;784.9175836537167;621.1118101115426;742.9405647548238;761.7981234972737;764.8164440534288;779.1818590479974;569.6012791046285;569.6724383479516;569.7607005057886;569.8546870548025;570.2842932120204;13158.07893447459;13232.801507977389;13236.669083272995;13238.602841914759;13245.337733113305;12522.311272879988;12838.55065072718;13111.934440327737;13169.407376668072;13324.866751332556;12041.337726425043;12221;12279.815802762965;12339.321337326444;12442.076112113646;4113.753174809521;4164.083901541656;4166.625003749647;4203.936940945889;4210.5578914213875;64015;64126;64365.356346436405;64389.356106438805;64528;9886.4562449066;9921.80156396868;10041.748956276006;10161.441120738431;10544.156467482582;19318.03409829503;19420.61158776845;19492.12285447158;19524.12141453638;19547.609047818965;6897.7240910363025;7033.8944915826305;7059.682314295869;7151.499395042297;7174.605396703231;3778.5465744110334;3810.2950954073585;3832.1186127190904;3866.052817059838;3878.4764056852528;2738.6713594368803;2860.556613724876;2861.0272507347604;2864.8854045838348;2866.8279903205457;489.7477798933552;492.99260511091643;499.4381321013859;500.1747117256556;504.8359283232964;419.7544436504679;468.59934755783996;472.595930479442;495.42035818092916;510.86332909277303;7604;7735.458517903805;7791.896307918322;8067.596620168968;8104.27061564462;441.98232070717455;481.74467532207984;503.5845427522309;506.3417557175657;526.9947300527023;3464.5496085509226;3484.6689564491335;3746.4754934309217;3767.698584113264;3786.5077539920185;73660;75576;86159;96315.51842240743;102329;72657.6367118161;75352.24647753562;76495;77368.61315693386;77587.22412775912;66414;70625;71083.6445817778;72021.63989180021;72782.2721772786;7376.557406555624;7640.73257435987;7740.14858365568;7920.564368959763;8083.434159609006;42514.36228456638;42684.78657606816;42817.35773963455;43436.78281608572;45132.097358052;54425.455745442036;59259.99990001295;59735.701321493114;60689.69655151696;64724.67637661781;9839;9886.555105020147;10159.796804064024;10159.949200253952;10445.268831181744;10908.672739817817;11054.613088541862;11083.833742494031;11265.605703800327;11379.829302560634;7488.213737557696;10440.164786816884;10591.364518128938;10697.946510267398;11060.668179954615;10131.544080516247;10263.23025773055;10578.89421105779;10654.73363165927;10862.076723478593;10526.842097368393;10550.525226364985;10585.788284234426;10647.467626618483;10843.24097313212;8397.412181147261;8555.187257210555;8772.736817895473;9166.908330916605;9306.395084319498;9007.549622518716;9309.86035209486;9401.764955876159;9443.197328227177;9456.338056336266 08:39:02 INFO - PROCESS | 11675 | __end_tp_report 08:39:02 INFO - PROCESS | 11675 | __start_cc_report 08:39:02 INFO - PROCESS | 11675 | _x_x_mozilla_cycle_collect,1069 08:39:02 INFO - PROCESS | 11675 | __end_cc_report 08:39:02 INFO - PROCESS | 11675 | __startTimestamp1472571542573__endTimestamp 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | ------- Summary: start ------- 08:39:02 INFO - PROCESS | 11675 | Number of tests: 6 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | [#0] dojo.html Cycles:165 Average:4660.15 Median:4744.22 stddev:490.71 (10.3%) stddev-sans-first:464.75 08:39:02 INFO - PROCESS | 11675 | Values: 2596.8 2612.5 2615.7 2648.9 2671.1 4565.0 4640.8 4643.4 4706.2 4745.2 4686.9 4688.6 4737.5 4740.5 4744.2 4229.9 4285.7 4321.6 4373.8 4452.4 4354.4 4384.4 4408.0 4436.7 4439.8 4226.4 4263.7 4282.8 4308.7 4328.5 4236.1 4254.8 4262.2 4343.0 4378.5 4271.2 4284.6 4297.9 4313.6 4337.3 4541.7 4629.7 4635.7 4686.1 4739.5 4983.7 5018.1 5020.6 5032.2 5084.7 4997.8 5025.6 5030.6 5078.3 5084.6 4609.9 4652.8 4685.0 4686.6 4737.7 5153.6 5181.0 5185.9 5235.0 5243.7 4963.1 4975.1 4978.8 4980.1 5041.0 4932.4 4951.7 4982.6 5076.7 5084.2 4926.4 4968.4 4978.3 5002.6 5003.8 4952.2 4965.6 4967.3 4970.3 5029.3 4231.3 4273.4 4288.1 4291.2 4344.9 3751.8 3766.1 3818.0 3854.2 3876.7 4317.5 4326.7 4327.1 4327.8 4379.3 4929.8 4995.7 5056.1 5080.6 5136.2 4244.6 4270.3 4281.2 4328.1 4332.4 4547.8 4548.4 4551.0 4589.3 4611.1 4614.7 4739.7 4742.3 4742.7 4744.1 5044.9 5050.2 5103.3 5119.6 5133.6 4726.7 4728.6 4739.5 4752.5 4817.0 4785.3 4956.9 4964.2 4975.6 5029.7 5059.9 5079.3 5079.8 5114.2 5141.5 4941.0 4954.2 4958.9 4969.7 5024.1 4792.9 4906.5 4964.2 4964.8 5018.3 4872.3 4901.9 4906.6 4934.7 4960.4 5002.7 5008.9 5011.6 5014.4 5077.9 4728.1 4780.9 4888.6 4907.8 4961.2 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | [#1] ext.html Cycles:180 Average:39128.24 Median:18751.45 stddev:60344.74 (321.8%) stddev-sans-first:60444.54 08:39:02 INFO - PROCESS | 11675 | Values: 559.8 573.5 578.3 580.5 582.4 27783.4 30913.8 38844.2 40134.0 40263.0 40332.4 40658.4 40696.4 40704.4 40772.8 7687.7 7832.5 7836.4 7839.9 7840.5 7147.5 10045.7 10368.5 10377.2 10386.9 9991.6 10056.6 10083.6 10084.4 10095.3 9962.3 10024.2 10033.5 10042.1 10071.1 9897.9 9950.7 9955.8 9961.2 9972.9 37873.0 38028.6 38064.6 38104.0 38148.2 2907.8 3089.3 3300.9 3361.4 3523.3 26718.5 28152.9 28444.4 28505.3 28514.0 3415.9 3488.8 3541.9 3552.0 3616.2 257023.0 257568.0 257884.0 258173.0 259618.0 53448.2 53800.2 53867.2 53868.0 53872.7 56575.0 56577.7 56679.4 56918.0 56989.0 13401.2 13517.5 13539.2 13542.9 13545.3 9470.1 9951.5 10681.4 10713.8 10723.0 17440.4 17624.6 17685.9 17756.3 17890.5 6579.7 6796.2 6852.2 6865.7 6898.3 727.4 811.0 814.2 901.0 922.5 26150.5 27356.9 27404.5 27642.7 28303.9 919.2 936.8 958.8 969.2 974.0 14411.2 14530.4 14619.1 14962.3 14987.0 122404.0 123320.4 123396.4 123521.0 123905.0 49369.0 49776.8 49848.8 50029.2 50080.2 1031.6 1039.9 1104.7 1122.6 1144.4 25521.6 28764.1 29122.9 29570.9 29609.1 41145.6 41376.6 41461.6 41476.4 41760.2 277664.0 278795.0 278830.0 278853.0 278958.0 24032.2 24324.5 25013.0 25091.2 26011.6 41554.6 41745.4 41912.8 42457.6 43155.4 35135.3 35182.6 35218.0 35325.3 35736.5 33690.7 33746.5 33854.0 33987.7 34087.0 34845.0 34905.5 35724.0 35836.5 35947.3 29803.7 31528.7 31628.7 31654.0 31816.2 24482.4 24859.9 24930.9 25157.9 25183.5 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | [#2] jquery.html Cycles:180 Average:24193.13 Median:4327.09 stddev:65818.06 (1521.1%) stddev-sans-first:65978.29 08:39:02 INFO - PROCESS | 11675 | Values: 319.5 340.5 347.8 350.0 367.2 12617.8 15901.6 15987.4 16771.7 17271.4 15410.7 15434.8 15571.8 15673.2 15801.1 4405.0 4874.6 5095.8 5102.3 5102.9 4968.9 5094.4 5096.6 5101.1 5102.1 4900.9 5053.6 5060.7 5065.2 5065.7 4805.8 4934.3 4946.6 4947.2 4948.0 4371.0 4395.7 4400.7 4405.9 4406.1 19580.5 20120.4 20134.1 20185.6 20315.5 1929.2 1952.3 1969.2 2011.8 2542.3 12443.4 12775.6 13018.2 13094.3 13433.7 1685.3 1710.6 1714.2 1789.1 1799.6 63347.4 64065.4 65282.7 70409.0 73066.6 9082.2 9186.3 9453.1 9531.4 9689.7 12412.1 12495.1 12516.9 12532.5 12584.9 6619.2 6791.6 6981.7 7013.9 7018.8 6395.5 6479.7 6612.6 6632.5 6638.6 3964.6 4003.0 4017.3 4073.6 4283.2 1647.3 1714.5 1715.0 1767.9 1770.2 758.7 784.9 925.0 927.1 927.6 16082.0 16351.5 17040.8 17191.1 17350.7 789.4 816.8 836.6 886.4 903.5 8998.8 9002.1 9222.4 9508.4 9663.6 382759.0 395714.0 403106.0 403607.0 409963.0 71879.3 72434.3 73652.6 77792.0 79604.6 911.7 929.9 970.7 970.9 973.9 15232.3 15269.2 15649.8 16058.5 16119.5 24848.0 25325.6 26769.2 34485.3 35730.3 52838.5 52924.0 54893.2 55406.0 55493.2 7279.0 7408.6 7625.4 7666.5 7712.5 10489.6 11694.8 11718.5 11809.3 11952.6 10176.8 10189.3 10219.4 10314.7 10414.6 10255.6 10323.2 10385.6 10391.9 10444.5 10167.4 10401.4 10429.9 10518.8 10790.4 7451.4 7473.8 7495.9 7626.5 7769.1 9546.6 9751.9 9820.8 9916.2 10034.3 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | [#3] mootools.html Cycles:180 Average:4686.65 Median:4698.58 stddev:2572.54 (54.8%) stddev-sans-first:2566.55 08:39:02 INFO - PROCESS | 11675 | Values: 1217.5 1320.1 1342.6 1383.0 1622.3 6994.8 7270.0 7333.9 7501.3 7552.0 7409.1 7542.4 7546.9 7547.1 7550.4 2166.1 2177.6 2180.2 2181.4 2188.3 2123.0 2130.3 2188.3 2191.1 2191.8 2153.6 2161.0 2167.5 2177.0 2179.7 2114.4 2115.5 2119.1 2120.6 2121.4 2059.3 2115.6 2117.4 2118.6 2122.8 7209.6 7395.3 7437.7 7446.6 7446.7 4182.0 4347.4 4356.1 4361.5 4362.0 2748.3 2840.3 2869.3 2883.5 2896.3 933.0 935.2 947.9 948.2 961.6 9721.6 9763.5 9784.4 9817.5 9840.6 3728.2 3832.5 3930.5 3939.9 3963.7 7814.5 7872.3 7875.5 7878.9 7888.4 4189.1 4195.5 4203.4 4208.9 4210.8 3616.1 3739.5 3855.0 3863.0 3901.6 3228.8 3242.9 3369.8 3372.4 3378.4 998.0 1008.6 1011.1 1017.9 1022.6 738.4 746.9 747.6 773.0 784.5 4402.9 4493.2 4540.3 4547.8 4605.1 392.7 408.8 413.1 414.8 416.4 3085.8 3146.3 3294.2 3310.5 3360.4 8246.7 8454.7 8503.3 8591.8 8626.1 8570.6 8597.1 8628.6 8628.7 8634.6 6392.2 6484.0 6541.8 6558.0 6572.0 4630.8 4697.7 4699.5 4712.9 4781.4 7668.7 7702.1 7738.3 7788.5 7799.0 7643.4 7778.2 7887.3 7940.8 8007.7 5746.2 6330.8 6457.4 6457.5 6464.5 6315.5 6479.0 6485.8 6707.1 6943.8 6080.8 6162.9 6208.1 6215.0 6314.2 6109.0 6156.7 6171.5 6212.1 6301.9 5487.1 5663.8 5705.8 5836.3 5848.6 4237.8 4294.2 4367.6 4369.9 4446.5 4167.3 4199.3 4255.7 4307.4 4352.8 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | [#4] prototype.html Cycles:180 Average:4203.59 Median:4799.14 stddev:1209.24 (25.2%) stddev-sans-first:1176.30 08:39:02 INFO - PROCESS | 11675 | Values: 283.6 288.5 292.9 295.9 298.7 4719.2 4843.5 4854.6 4924.3 4934.5 4655.7 4789.7 4795.4 4802.8 4822.5 3810.4 3811.6 3815.4 3820.4 3847.5 3590.9 3648.8 3812.9 3833.8 3849.5 3753.1 3757.1 3763.5 3776.4 3790.8 3747.6 3766.5 3779.6 3782.4 3787.6 3331.9 3333.6 3337.6 3339.1 3347.7 4649.5 4657.6 4671.6 4688.9 4776.8 4338.6 4369.1 4380.4 4386.4 4401.9 5048.5 5069.8 5083.5 5091.9 5094.0 3577.1 3635.7 3659.4 3734.2 3745.1 5214.3 5219.4 5223.6 5228.3 5339.6 3703.0 3704.7 3708.8 3709.4 3722.7 3704.9 3793.7 3801.9 3804.7 3820.6 4297.6 4300.2 4301.6 4330.8 4339.2 4982.4 4996.5 4999.2 5018.2 5038.8 1241.4 1283.4 1283.5 1292.0 1317.5 864.4 892.6 907.3 926.5 942.7 4363.4 4372.3 4372.5 4388.4 4407.3 5149.3 5181.8 5192.9 5201.4 5201.7 4288.4 4476.0 4489.3 4499.1 4508.2 2750.9 2777.6 2778.1 2787.7 2789.3 4773.8 4923.0 4923.7 4929.0 4946.8 5218.7 5238.5 5264.2 5301.0 5341.3 4817.3 4841.7 4864.1 4868.5 4908.2 5041.2 5179.9 5206.4 5211.4 5213.8 5015.7 5072.3 5078.5 5093.3 5103.3 4896.0 4903.5 4909.8 4910.8 4911.7 3521.7 3693.4 3708.3 3722.0 3735.4 5137.6 5149.3 5186.3 5212.4 5233.5 5031.0 5047.1 5047.7 5082.4 5088.8 4868.4 5036.7 5068.6 5082.6 5099.3 4715.6 4812.8 4932.6 4986.0 5008.8 5071.3 5079.5 5080.5 5086.9 5108.6 4991.6 4991.7 4994.8 4997.9 4998.3 08:39:02 INFO - PROCESS | 11675 | 08:39:02 INFO - PROCESS | 11675 | [#5] yui.html Cycles:180 Average:16882.31 Median:501.88 stddev:23632.94 (4708.9%) stddev-sans-first:23667.65 08:39:02 INFO - PROCESS | 11675 | Values: 611.0 658.0 685.0 725.4 737.6 12020.0 12402.2 12436.9 12445.0 12531.3 13181.3 13268.6 13279.3 13299.5 13303.2 592.9 708.8 726.3 734.4 735.6 735.9 737.3 739.9 740.2 740.2 773.9 779.5 780.0 784.9 784.9 621.1 742.9 761.8 764.8 779.2 569.6 569.7 569.8 569.9 570.3 13158.1 13232.8 13236.7 13238.6 13245.3 12522.3 12838.6 13111.9 13169.4 13324.9 12041.3 12221.0 12279.8 12339.3 12442.1 4113.8 4164.1 4166.6 4203.9 4210.6 64015.0 64126.0 64365.4 64389.4 64528.0 9886.5 9921.8 10041.7 10161.4 10544.2 19318.0 19420.6 19492.1 19524.1 19547.6 6897.7 7033.9 7059.7 7151.5 7174.6 3778.5 3810.3 3832.1 3866.1 3878.5 2738.7 2860.6 2861.0 2864.9 2866.8 489.7 493.0 499.4 500.2 504.8 419.8 468.6 472.6 495.4 510.9 7604.0 7735.5 7791.9 8067.6 8104.3 442.0 481.7 503.6 506.3 527.0 3464.5 3484.7 3746.5 3767.7 3786.5 73660.0 75576.0 86159.0 96315.5 102329.0 72657.6 75352.2 76495.0 77368.6 77587.2 66414.0 70625.0 71083.6 72021.6 72782.3 7376.6 7640.7 7740.1 7920.6 8083.4 42514.4 42684.8 42817.4 43436.8 45132.1 54425.5 59260.0 59735.7 60689.7 64724.7 9839.0 9886.6 10159.8 10159.9 10445.3 10908.7 11054.6 11083.8 11265.6 11379.8 7488.2 10440.2 10591.4 10697.9 11060.7 10131.5 10263.2 10578.9 10654.7 10862.1 10526.8 10550.5 10585.8 10647.5 10843.2 8397.4 8555.2 8772.7 9166.9 9306.4 9007.5 9309.9 9401.8 9443.2 9456.3 08:39:02 INFO - PROCESS | 11675 | -------- Summary: end -------- 08:39:02 INFO - PROCESS | 11675 | 08:39:03 INFO - TEST-INFO | 11675: exit 0 08:39:03 INFO - TEST-OK | dromaeo_css | took 1121403ms 08:39:03 INFO - TEST-START | kraken 08:39:03 INFO - operating with platform_type : linux_ 08:39:03 INFO - Initialising browser for kraken test... 08:39:03 INFO - TEST-INFO | started process 11980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pzxgP/profile http://localhost:40998/getInfo.html) 08:39:08 INFO - PROCESS | 11980 | __metrics Screen width/height:1600/1200 08:39:08 INFO - PROCESS | 11980 | colorDepth:24 08:39:08 INFO - PROCESS | 11980 | Browser inner width/height: 1024/697 08:39:08 INFO - PROCESS | 11980 | __metrics 08:39:08 INFO - PROCESS | 11980 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:39:08 INFO - PROCESS | 11980 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:09 INFO - PROCESS | 11980 | console.error: PushService: 08:39:09 INFO - PROCESS | 11980 | stateChangeProcessEnqueue: Error transitioning state 08:39:09 INFO - PROCESS | 11980 | UnknownError 08:39:09 INFO - TEST-INFO | 11980: exit 0 08:39:09 INFO - Browser initialized. 08:39:09 INFO - Running cycle 1/1 for kraken test... 08:39:09 INFO - TEST-INFO | started process 12061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pzxgP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:22 INFO - PROCESS | 12061 | RSS: Main: 182136832 08:39:22 INFO - PROCESS | 12061 | 08:39:24 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40998/tests/kraken/driver.html?testName=audio-beat-detection) 08:39:25 INFO - PROCESS | 12061 | RSS: Main: 235339776 08:39:25 INFO - PROCESS | 12061 | 08:39:28 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40998/tests/kraken/driver.html?testName=audio-dft) 08:39:29 INFO - PROCESS | 12061 | RSS: Main: 225550336 08:39:29 INFO - PROCESS | 12061 | 08:39:32 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40998/tests/kraken/driver.html?testName=audio-fft) 08:39:33 INFO - PROCESS | 12061 | RSS: Main: 303636480 08:39:33 INFO - PROCESS | 12061 | 08:39:35 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40998/tests/kraken/driver.html?testName=audio-oscillator) 08:39:35 INFO - PROCESS | 12061 | RSS: Main: 213569536 08:39:35 INFO - PROCESS | 12061 | 08:39:38 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:39:38 INFO - PROCESS | 12061 | RSS: Main: 215523328 08:39:38 INFO - PROCESS | 12061 | 08:39:41 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40998/tests/kraken/driver.html?testName=imaging-darkroom) 08:39:42 INFO - PROCESS | 12061 | RSS: Main: 253624320 08:39:42 INFO - PROCESS | 12061 | 08:39:46 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40998/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:46 INFO - PROCESS | 12061 | RSS: Main: 247287808 08:39:46 INFO - PROCESS | 12061 | 08:39:49 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40998/tests/kraken/driver.html?testName=json-parse-financial) 08:39:50 INFO - PROCESS | 12061 | RSS: Main: 250679296 08:39:50 INFO - PROCESS | 12061 | 08:39:51 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:52 INFO - PROCESS | 12061 | RSS: Main: 214081536 08:39:52 INFO - PROCESS | 12061 | 08:39:54 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:55 INFO - PROCESS | 12061 | RSS: Main: 222322688 08:39:55 INFO - PROCESS | 12061 | 08:39:57 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:57 INFO - PROCESS | 12061 | RSS: Main: 222777344 08:39:57 INFO - PROCESS | 12061 | 08:40:00 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:01 INFO - PROCESS | 12061 | RSS: Main: 223182848 08:40:01 INFO - PROCESS | 12061 | 08:40:04 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:40:04 INFO - PROCESS | 12061 | RSS: Main: 220565504 08:40:04 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:40998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40998/tests/kraken/driver.html?testName=ai-astar) 08:40:06 INFO - PROCESS | 12061 | RSS: Main: 272171008 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | __start_tp_report 08:40:06 INFO - PROCESS | 12061 | _x_x_mozilla_page_load 08:40:06 INFO - PROCESS | 12061 | _x_x_mozilla_page_load_details 08:40:06 INFO - PROCESS | 12061 | |i|pagename|runs| 08:40:06 INFO - PROCESS | 12061 | |0;ai-astar;114;117;135;114;113;115;113;114;114;113 08:40:06 INFO - PROCESS | 12061 | |1;audio-beat-detection;151;123;152;189;130;145;149;130;179;125 08:40:06 INFO - PROCESS | 12061 | |2;audio-dft;162;162;163;163;163;161;161;161;160;161 08:40:06 INFO - PROCESS | 12061 | |3;audio-fft;76;75;84;177;77;78;78;78;164;77 08:40:06 INFO - PROCESS | 12061 | |4;audio-oscillator;84;83;140;84;85;84;152;85;84;132 08:40:06 INFO - PROCESS | 12061 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;119;117 08:40:06 INFO - PROCESS | 12061 | |6;imaging-darkroom;147;147;147;147;147;147;147;147;147;147 08:40:06 INFO - PROCESS | 12061 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;94;94 08:40:06 INFO - PROCESS | 12061 | |8;json-parse-financial;65;65;65;64;66;67;65;66;65;65 08:40:06 INFO - PROCESS | 12061 | |9;json-stringify-tinderbox;68;68;68;68;68;68;69;69;70;68 08:40:06 INFO - PROCESS | 12061 | |10;stanford-crypto-aes;82;83;83;82;83;83;83;83;82;81 08:40:06 INFO - PROCESS | 12061 | |11;stanford-crypto-ccm;133;131;135;131;132;133;134;135;172;147 08:40:06 INFO - PROCESS | 12061 | |12;stanford-crypto-pbkdf2;177;175;172;175;172;173;172;175;173;172 08:40:06 INFO - PROCESS | 12061 | |13;stanford-crypto-sha256-iterative;69;67;69;68;68;68;67;67;69;67 08:40:06 INFO - PROCESS | 12061 | __end_tp_report 08:40:06 INFO - PROCESS | 12061 | __start_cc_report 08:40:06 INFO - PROCESS | 12061 | _x_x_mozilla_cycle_collect,1975 08:40:06 INFO - PROCESS | 12061 | __end_cc_report 08:40:06 INFO - PROCESS | 12061 | __startTimestamp1472571606835__endTimestamp 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | ------- Summary: start ------- 08:40:06 INFO - PROCESS | 12061 | Number of tests: 14 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#0] ai-astar Cycles:10 Average:116.20 Median:114.00 stddev:6.71 (5.9%) stddev-sans-first:7.07 08:40:06 INFO - PROCESS | 12061 | Values: 114.0 117.0 135.0 114.0 113.0 115.0 113.0 114.0 114.0 113.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:150.00 stddev:22.30 (14.9%) stddev-sans-first:23.61 08:40:06 INFO - PROCESS | 12061 | Values: 151.0 123.0 152.0 189.0 130.0 145.0 149.0 130.0 179.0 125.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 08:40:06 INFO - PROCESS | 12061 | Values: 162.0 162.0 163.0 163.0 163.0 161.0 161.0 161.0 160.0 161.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#3] audio-fft Cycles:10 Average:96.40 Median:77.50 stddev:39.25 (50.6%) stddev-sans-first:40.93 08:40:06 INFO - PROCESS | 12061 | Values: 76.0 75.0 84.0 177.0 77.0 78.0 78.0 78.0 164.0 77.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:84.00 stddev:28.04 (33.4%) stddev-sans-first:29.03 08:40:06 INFO - PROCESS | 12061 | Values: 84.0 83.0 140.0 84.0 85.0 84.0 152.0 85.0 84.0 132.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 08:40:06 INFO - PROCESS | 12061 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 119.0 117.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:40:06 INFO - PROCESS | 12061 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:40:06 INFO - PROCESS | 12061 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 08:40:06 INFO - PROCESS | 12061 | Values: 65.0 65.0 65.0 64.0 66.0 67.0 65.0 66.0 65.0 65.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 08:40:06 INFO - PROCESS | 12061 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 70.0 68.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:0.71 (0.9%) stddev-sans-first:0.73 08:40:06 INFO - PROCESS | 12061 | Values: 82.0 83.0 83.0 82.0 83.0 83.0 83.0 83.0 82.0 81.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:134.50 stddev:12.71 (9.5%) stddev-sans-first:13.34 08:40:06 INFO - PROCESS | 12061 | Values: 133.0 131.0 135.0 131.0 132.0 133.0 134.0 135.0 172.0 147.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:1.78 (1.0%) stddev-sans-first:1.39 08:40:06 INFO - PROCESS | 12061 | Values: 177.0 175.0 172.0 175.0 172.0 173.0 172.0 175.0 173.0 172.0 08:40:06 INFO - PROCESS | 12061 | 08:40:06 INFO - PROCESS | 12061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 08:40:06 INFO - PROCESS | 12061 | Values: 69.0 67.0 69.0 68.0 68.0 68.0 67.0 67.0 69.0 67.0 08:40:06 INFO - PROCESS | 12061 | -------- Summary: end -------- 08:40:06 INFO - PROCESS | 12061 | 08:40:08 INFO - TEST-INFO | 12061: exit 0 08:40:08 INFO - TEST-OK | kraken | took 64593ms 08:40:08 INFO - SUITE-END | took 1185s 08:40:08 INFO - Completed test suite (00:19:46) 08:40:08 INFO - javascript benchmark 08:40:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.8182227244088, 2612.5428050091236, 2615.7122716501194, 2648.8808003639833, 2671.0517766193, 4564.995700945787, 4640.814367425303, 4643.396358473402, 4706.199946009174, 4745.193317136086, 4686.9296960545535, 4688.5545873142, 4737.455192652855, 4740.478547359788, 4744.217204161318, 4229.894252643678, 4285.678574106939, 4321.589449002356, 4373.846915357964, 4452.421185245914, 4354.368616550582, 4384.408104905845, 4408.030233348658, 4436.733795972236, 4439.75581343026, 4226.429432026668, 4263.701540892139, 4282.828686852522, 4308.719933204363, 4328.545502722201, 4236.110416812442, 4254.7872606369865, 4262.232798096342, 4343.04453020335, 4378.452693413324, 4271.209826182135, 4284.592963668478, 4297.892552686177, 4313.61177494027, 4337.306031035051, 4541.682082254243, 4629.652776041777, 4635.675502714811, 4686.109639168547, 4739.478657347689, 4983.72589507577, 5018.071656743514, 5020.59835213182, 5032.194848824171, 5084.669496482754, 4997.825076122318, 5025.623078269108, 5030.622703297231, 5078.31442755227, 5084.567811736007, 4609.861704148881, 4652.837150699777, 4684.976575117103, 4686.601638860667, 4737.692050016738, 5153.587712982952, 5181.0415073210825, 5185.922211166836, 5234.97382513085, 5243.659162154524, 4963.081829861487, 4975.129352363322, 4978.77595508203, 4980.05378977993, 5040.974795126001, 4932.408111026628, 4951.653384263139, 4982.576480999083, 5076.695398276115, 5084.211947148198, 4926.433460152057, 4968.428630707443, 4978.27814966835, 5002.649814512949, 5003.849884503471, 4952.232403977389, 4965.577925876269, 4967.3294105296045, 4970.3290055842, 5029.321041659329, 4231.280682284019, 4273.358996150602, 4288.056627541936, 4291.249031419551, 4344.891377715582, 3751.8499260029294, 3766.0773110587534, 3818.045488627843, 3854.171353159028, 3876.7092468064443, 4317.525072242051, 4326.658229732723, 4327.069680018748, 4327.76197309151, 4379.277419225856, 4929.827456039093, 4995.675281106789, 5056.089903817348, 5080.644354895196, 5136.203888397305, 4244.596763307481, 4270.274053410928, 4281.186574550826, 4328.091100868853, 4332.415123958225, 4547.8180872764715, 4548.431446069175, 4550.977245113753, 4589.265717485253, 4611.100835337077, 4614.746188959505, 4739.715617062987, 4742.288656701385, 4742.715437073786, 4744.051189761993, 5044.899102018013, 5050.217216331474, 5103.260027296095, 5119.5648369887485, 5133.614978876524, 4726.740029298284, 4728.645351598575, 4739.526047395233, 4752.524747525358, 4816.95183048165, 4785.282207668738, 4956.8760780980765, 4964.205727083649, 4975.57707594844, 5029.723365214948, 5059.924101138412, 5079.314292570456, 5079.77141028662, 5114.207297868837, 5141.53726164647, 4940.9505904941925, 4954.20732682769, 4958.851234462972, 4969.726665033458, 5024.070546948826, 4792.9281060784815, 4906.484819093944, 4964.230544265644, 4964.826231082039, 5018.272350509083, 4872.317875497362, 4901.852944411673, 4906.607471402208, 4934.679245849008, 4960.429550601582, 5002.674826136289, 5008.949910500848, 5011.649184557046, 5014.398272207212, 5077.898442031213, 4728.054389122258, 4780.904381912412, 4888.60891128716, 4907.754612269301, 4961.156603377507], "value": 4628.782109242433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.7816851427942, 573.5411670663468, 578.3118089473529, 580.4804699793684, 582.449585142041, 27783.44433111339, 30913.845430772843, 38844.22311553771, 40134.0, 40263.0, 40332.39501407474, 40658.39012414816, 40696.38955415671, 40704.38943415844, 40772.79613601928, 7687.692492300315, 7832.530048197098, 7836.373090152774, 7839.882401763978, 7840.4511684182135, 7147.49967502275, 10045.748856278578, 10368.48157592121, 10377.221708371902, 10386.896131038706, 9991.600335986552, 10056.597736090584, 10083.596656133783, 10084.445355505444, 10095.29332946694, 9962.302638815287, 10024.248181386425, 10033.49832508379, 10042.096211341015, 10071.093601575893, 9897.901020989842, 9950.651727189586, 9955.75110622233, 9961.153301969342, 9972.850407243897, 37873.0, 38028.61971380306, 38064.61935380638, 38104.0, 38148.237035259415, 2907.752841008517, 3089.274020605156, 3300.9174770630684, 3361.445361515347, 3523.3481805865995, 26718.46563068728, 28152.859235703894, 28444.431111377657, 28505.28736781597, 28514.0, 3415.894874173417, 3488.8081155536433, 3541.8583256669704, 3551.982240088809, 3616.168281295317, 257023.0, 257568.0, 257884.0, 258173.0, 259618.0, 53448.19827702588, 53800.19299710508, 53867.19199212015, 53868.0, 53872.73063634657, 56575.0, 56577.71711141418, 56679.43320566742, 56918.0, 56989.0, 13401.195928244337, 13517.459301628021, 13539.187648741106, 13542.864571354357, 13545.322733863268, 9470.14768670823, 9951.452670103214, 10681.359118452918, 10713.78572428547, 10723.03492685662, 17440.389586364417, 17624.55938601545, 17685.911570442324, 17756.28974840992, 17890.463286101436, 6579.671016449159, 6796.218434879953, 6852.246252912176, 6865.691043903036, 6898.2756810535175, 727.447140173472, 811.0, 814.242754238552, 900.9729708108767, 922.543341046173, 26150.476990460465, 27356.863215684192, 27404.451910962067, 27642.72357276442, 28303.858480707877, 919.2186641354795, 936.8126374725082, 958.7698952251549, 969.2004096620317, 973.99026009739, 14411.207383593794, 14530.418783248762, 14619.122852628876, 14962.326695298738, 14987.0, 122404.0, 123320.38339808423, 123396.38301808613, 123521.0, 123905.0, 49369.0, 49776.75111624491, 49848.75075624599, 50029.24956125661, 50080.24879626808, 1031.6389263757624, 1039.9168066554657, 1104.6520346090956, 1122.629532254354, 1144.3820337017917, 25521.61717574201, 28764.137075887757, 29122.854385727936, 29570.852145739133, 29609.111726648236, 41145.58854411537, 41376.58623413727, 41461.58538414698, 41476.377854332815, 41760.16479670451, 277664.0, 278795.0, 278830.0, 278853.0, 278958.0, 24032.158874439312, 24324.51350973006, 25013.0, 25091.24726258215, 26011.60982585225, 41554.584454156284, 41745.37381939212, 41912.790436047624, 42457.5754242466, 43155.352669710606, 35135.297294054486, 35182.64817351794, 35218.0, 35325.293494130485, 35736.463953040206, 33690.663093368756, 33746.49380259249, 33854.0, 33987.66012339845, 34087.0, 34845.0, 34905.47641785426, 35724.0, 35836.462453062704, 35947.28105437929, 29803.701962980093, 31528.684713152576, 31628.683713162573, 31654.0, 31816.204594885312, 24482.387940301636, 24859.875700621382, 24930.875345623157, 25157.87421062883, 25183.496330073664], "value": 17107.681796661764, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.4936026398159, 340.48756621284946, 347.7548328428458, 349.9842507087181, 367.2013370918252, 12617.810732839003, 15901.602459938507, 15987.360505579793, 16771.74842377364, 17271.39550115746, 15410.691786164298, 15434.768478472804, 15571.844281557182, 15673.216339183024, 15801.130937798416, 4404.97797511012, 4874.585660218886, 5095.770690318926, 5102.285680004802, 5102.923456148161, 4968.875778105558, 5094.388673359202, 5096.566791822699, 5101.056304583664, 5102.132637451642, 4900.877478063059, 5053.595712343023, 5060.721660308682, 5065.214891691775, 5065.696058236499, 4805.807767689288, 4934.309196712463, 4946.5795407390415, 4947.1589829728855, 4948.035133149056, 4370.978145109286, 4395.7362558246605, 4400.713953593006, 4405.867823965286, 4406.140802543506, 19580.51048723779, 20120.396388108235, 20134.093965771575, 20185.596288074157, 20315.492112697153, 1929.2379510093574, 1952.2776572668063, 1969.1532640964379, 2011.7887621799646, 2542.313575334668, 12443.440045197987, 12775.61673149807, 13018.15382000167, 13094.279814610192, 13433.731325373437, 1685.2500637216444, 1710.563806229416, 1714.185761763165, 1789.1143883777484, 1799.6310756295059, 63347.366526334605, 64065.3593464064, 65282.673586632234, 70409.0, 73066.63466682633, 9082.18260356571, 9186.311026672893, 9453.084396113982, 9531.380460270198, 9689.660861869801, 12412.131150819356, 12495.125341226209, 12516.937415312865, 12532.498700052078, 12584.937075314565, 6619.238787539398, 6791.626460544718, 6981.650917454107, 7013.859722805515, 7018.789436316919, 6395.488360931115, 6479.708413121327, 6612.570182938093, 6632.469402447792, 6638.5684930479365, 3964.5638979712207, 4002.9985007496252, 4017.276890159799, 4073.5926407359025, 4283.201055556674, 1647.324596915259, 1714.4942242038628, 1714.9657006860043, 1767.89506558401, 1770.2034084661955, 758.7496126278315, 784.8744200927938, 924.9676261330821, 927.1146055516965, 927.5872236854669, 16082.0, 16351.509454716377, 17040.829591704172, 17191.1404429778, 17350.739738903925, 789.3882241263067, 816.7794695432319, 836.6402446947749, 886.3573908915985, 903.4579252448478, 8998.820023599492, 9002.099790020946, 9222.400543964755, 9508.381955172892, 9663.565139568736, 382759.0, 395714.0, 403106.0, 403607.0, 409963.0, 71879.28120718726, 72434.27565724381, 73652.63173684098, 77792.0, 79604.6019769909, 911.7082533589321, 929.9209567186865, 970.7330484116924, 970.9465979371203, 973.9464329461948, 15232.314545845686, 15269.160196189316, 15649.765253521435, 16058.518244452685, 16119.516414507583, 24848.0, 25325.62011569791, 26769.19692409231, 34485.310293794486, 35730.32368311319, 52838.47161528336, 52924.0, 54893.17660235179, 55406.0, 55493.167602485184, 7279.0, 7408.555486670817, 7625.389968802593, 7666.501677390952, 7712.460127791225, 10489.632862849763, 11694.766104677688, 11718.472668730099, 11809.291442513477, 11952.64142075739, 10176.796464070825, 10189.337693049929, 10219.437930913871, 10314.690559283234, 10414.583416663248, 10255.58977640886, 10323.225758068025, 10385.584576616851, 10391.896081039395, 10444.477776111316, 10167.389956602627, 10401.427921464392, 10429.9478502607, 10518.842217366899, 10790.352578845295, 7451.40388768908, 7473.775786726407, 7495.850082998419, 7626.54240745557, 7769.145394006768, 9546.570404331684, 9751.902480975099, 9820.754481138028, 9916.206703463562, 10034.297599167989], "value": 7994.371896185899, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.5495066825276, 1320.089138494439, 1342.583799022303, 1382.9792553111706, 1622.3348427144865, 6994.8251293717685, 7269.963650181749, 7333.9266607333975, 7501.287377699124, 7551.9622401888055, 7409.147947985984, 7542.434317426201, 7546.886796698054, 7547.0943486781525, 7550.3582195513445, 2166.1010680567547, 2177.564487102578, 2180.2369170790175, 2181.378307182453, 2188.2559929623926, 2123.0, 2130.28635407138, 2188.3106821351225, 2191.123550579765, 2191.7808219178114, 2153.5800518898823, 2161.0383379396176, 2167.54481558872, 2176.9985806529016, 2179.7493288271894, 2114.38682781993, 2115.513431910669, 2119.1417475922276, 2120.6182887080317, 2121.3847984084673, 2059.2895451069357, 2115.6403411420097, 2117.428294360514, 2118.565694032735, 2122.755883073451, 7209.603471809049, 7395.334419902235, 7437.739679111205, 7446.590437525934, 7446.739364122284, 4182.0, 4347.3696314034605, 4356.085222103362, 4361.542038086019, 4361.956380436219, 2748.3266599683006, 2840.2757296889367, 2869.2885223463836, 2883.5345779358554, 2896.2614533294086, 932.9626814927462, 935.1910597333326, 947.8815148106487, 948.2319321349729, 961.6441916490874, 9721.562529686182, 9763.463009534473, 9784.412935223909, 9817.460039697813, 9840.606375744961, 3728.1611637381916, 3832.5017747692623, 3930.4890364252465, 3939.901502462404, 3963.7027222958395, 7814.492058016211, 7872.252136047181, 7875.527468351917, 7878.881816772753, 7888.447808653339, 4189.141226048653, 4195.454590903163, 4203.369494575838, 4208.85269015583, 4210.789460526961, 3616.0598244456633, 3739.476473293741, 3854.9614503854605, 3863.0, 3901.551321597996, 3228.806271623663, 3242.8974148789525, 3369.79781213128, 3372.426687463088, 3378.44255697812, 997.9650712225038, 1008.5864795433984, 1011.1405305490274, 1017.8524114003428, 1022.5909636145601, 738.446165375968, 746.9468050049404, 747.5925620536821, 772.9536227826349, 784.5057613703331, 4402.911941761146, 4493.191225579427, 4540.341650460731, 4547.840825571156, 4605.0559635274685, 392.6995848176148, 408.78947342118835, 413.0973822198506, 414.79467663506153, 416.43365023567924, 3085.78399512032, 3146.276356437986, 3294.159989202738, 3310.486874534451, 3360.3951288767767, 8246.670133194604, 8454.661813527513, 8503.319734421231, 8591.785205369792, 8626.094260102724, 8570.571471426403, 8597.054324024477, 8628.611712472954, 8628.741137765752, 8634.568271586395, 6392.169018027626, 6484.0, 6541.771038013647, 6557.983512555562, 6571.967140164173, 4630.791614377294, 4697.694649847749, 4699.459562150397, 4712.905741885212, 4781.378420805273, 7668.69325227007, 7702.114256860309, 7738.303552680286, 7788.454808163374, 7799.0, 7643.4267429941865, 7778.183290754389, 7887.250711182429, 7940.801479963047, 8007.679692812222, 5746.195532625519, 6330.8100756977365, 6457.418832305115, 6457.4511166551365, 6464.5151613630105, 6315.526335524946, 6479.0, 6485.77299794505, 6707.094542236736, 6943.826404339729, 6080.787172448943, 6162.907556386568, 6208.068789681584, 6215.0, 6314.179156709783, 6109.0, 6156.661383623765, 6171.506279497719, 6212.06818977157, 6301.936980630135, 5487.067198576331, 5663.773449061991, 5705.828825135252, 5836.270466191726, 5848.590598658053, 4237.766922819152, 4294.248506511285, 4367.58507941745, 4369.890752731207, 4446.488653804854, 4167.349798041568, 4199.328107502785, 4255.659547236151, 4307.375430562488, 4352.781221258053], "value": 3756.960269783693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.58596449184176, 288.46201833580375, 292.9414117176565, 295.8860838577148, 298.7415885259251, 4719.150552900485, 4843.53986371295, 4854.5873600743935, 4924.310596516486, 4934.457209706934, 4655.7439340836245, 4789.688670236432, 4795.448523419807, 4802.83190088347, 4822.541858523444, 3810.40938654509, 3811.5616704079107, 3815.4276858471176, 3820.35054040813, 3847.5190601174854, 3590.8743193988216, 3648.7628304160276, 3812.942805857914, 3833.8466461341513, 3849.499565056539, 3753.1180172659538, 3757.117077486802, 3763.516079387605, 3776.3957766757326, 3790.753601015939, 3747.625237476258, 3766.510353654035, 3779.622037796226, 3782.394816829322, 3787.5833658297565, 3331.916702082443, 3333.616634087087, 3337.599488061448, 3339.1151344893624, 3347.681970212826, 4649.5350464953235, 4657.627389808841, 4671.602913752336, 4688.859334219979, 4776.761161941924, 4338.566143385668, 4369.082492676542, 4380.4305440292555, 4386.363977223285, 4401.933970990438, 5048.545630893201, 5069.822556210552, 5083.517065878736, 5091.854332775096, 5094.032133894548, 3577.105723569108, 3635.6909662678704, 3659.396199627058, 3734.2158146789207, 3745.1198968242443, 5214.296070030536, 5219.373675158968, 5223.582113430916, 5228.346456692913, 5339.599530035224, 3702.9629703702617, 3704.7036237100965, 3708.7589306694977, 3709.4250391189407, 3722.7021838252876, 3704.944425833615, 3793.6585707286476, 3801.885943421702, 3804.6766024888193, 3820.56063552695, 4297.59172878576, 4300.247456695066, 4301.634361079344, 4330.783460826946, 4339.175556644227, 4982.377202849644, 4996.525330093636, 4999.200127979506, 5018.247262910592, 5038.84883453497, 1241.4475558376616, 1283.3775618824861, 1283.5186804948144, 1291.9741605168033, 1317.4795955597485, 864.4381152251087, 892.5671049540967, 907.3240435875315, 926.4533924984157, 942.6936245720168, 4363.38912552243, 4372.278574035248, 4372.497162826316, 4388.429504164502, 4407.272799987966, 5149.2791009258735, 5181.8081841176745, 5192.8961420771375, 5201.427842937273, 5201.713905735145, 4288.421063156434, 4475.977620111878, 4489.259272220047, 4499.1451624191295, 4508.233600287894, 2750.9037183698474, 2777.6250206221903, 2778.0692418768763, 2787.7351651593067, 2789.316617428743, 4773.76131193439, 4922.950770492321, 4923.655344125948, 4928.950710492849, 4946.826861059845, 5218.712970786567, 5238.5023422774775, 5264.210368444764, 5300.9734951325, 5341.332333458317, 4817.325574419584, 4841.733704646208, 4864.124457597595, 4868.537488938545, 4908.239222920453, 5041.218611115283, 5179.938112686966, 5206.438068579487, 5211.400688920823, 5213.817516386908, 5015.699058056528, 5072.264521644414, 5078.492150784892, 5093.286939828353, 5103.260027295947, 4896.0, 4903.53416425439, 4909.754512274443, 4910.8281210157475, 4911.7298548580175, 3521.6654417830264, 3693.445983102556, 3708.332500149999, 3722.0, 3735.4396840474146, 5137.5889928806355, 5149.348085735924, 5186.340371081218, 5212.426633070435, 5233.528982391603, 5030.974845125751, 5047.116754567863, 5047.671901326402, 5082.415522214845, 5088.847334579968, 4868.367112275381, 5036.672616280077, 5068.569171620306, 5082.567981721595, 5099.3370861787735, 4715.63246658479, 4812.783424745825, 4932.605391568594, 4985.9501404985485, 5008.774605142705, 5071.290019397361, 5079.517445842639, 5080.491950805038, 5086.872828179177, 5108.56577190943, 4991.625628077836, 4991.675541089818, 4994.80020799164, 4997.875053123701, 4998.300237966615], "value": 3819.1224040921343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.9633421994681, 658.0458335413648, 684.9794506164817, 725.3580581185653, 737.5574655206875, 12020.038396928247, 12402.193857399263, 12436.937815310923, 12445.004399648029, 12531.31077790721, 13181.340932953362, 13268.601941941733, 13279.336033198326, 13299.46802127916, 13303.201807891533, 592.9110633404981, 708.7590219325429, 726.3499168244405, 734.3611058379191, 735.6321839080459, 735.9264073592651, 737.3290305821703, 739.9445041621873, 740.1599184925095, 740.1857956248137, 773.9458237923347, 779.4894344204555, 780.0210735526906, 784.8704963681014, 784.9175836537167, 621.1118101115426, 742.9405647548238, 761.7981234972737, 764.8164440534288, 779.1818590479974, 569.6012791046285, 569.6724383479516, 569.7607005057886, 569.8546870548025, 570.2842932120204, 13158.07893447459, 13232.801507977389, 13236.669083272995, 13238.602841914759, 13245.337733113305, 12522.311272879988, 12838.55065072718, 13111.934440327737, 13169.407376668072, 13324.866751332556, 12041.337726425043, 12221.0, 12279.815802762965, 12339.321337326444, 12442.076112113646, 4113.753174809521, 4164.083901541656, 4166.625003749647, 4203.936940945889, 4210.5578914213875, 64015.0, 64126.0, 64365.356346436405, 64389.356106438805, 64528.0, 9886.4562449066, 9921.80156396868, 10041.748956276006, 10161.441120738431, 10544.156467482582, 19318.03409829503, 19420.61158776845, 19492.12285447158, 19524.12141453638, 19547.609047818965, 6897.7240910363025, 7033.8944915826305, 7059.682314295869, 7151.499395042297, 7174.605396703231, 3778.5465744110334, 3810.2950954073585, 3832.1186127190904, 3866.052817059838, 3878.4764056852528, 2738.6713594368803, 2860.556613724876, 2861.0272507347604, 2864.8854045838348, 2866.8279903205457, 489.7477798933552, 492.99260511091643, 499.4381321013859, 500.1747117256556, 504.8359283232964, 419.7544436504679, 468.59934755783996, 472.595930479442, 495.42035818092916, 510.86332909277303, 7604.0, 7735.458517903805, 7791.896307918322, 8067.596620168968, 8104.27061564462, 441.98232070717455, 481.74467532207984, 503.5845427522309, 506.3417557175657, 526.9947300527023, 3464.5496085509226, 3484.6689564491335, 3746.4754934309217, 3767.698584113264, 3786.5077539920185, 73660.0, 75576.0, 86159.0, 96315.51842240743, 102329.0, 72657.6367118161, 75352.24647753562, 76495.0, 77368.61315693386, 77587.22412775912, 66414.0, 70625.0, 71083.6445817778, 72021.63989180021, 72782.2721772786, 7376.557406555624, 7640.73257435987, 7740.14858365568, 7920.564368959763, 8083.434159609006, 42514.36228456638, 42684.78657606816, 42817.35773963455, 43436.78281608572, 45132.097358052, 54425.455745442036, 59259.99990001295, 59735.701321493114, 60689.69655151696, 64724.67637661781, 9839.0, 9886.555105020147, 10159.796804064024, 10159.949200253952, 10445.268831181744, 10908.672739817817, 11054.613088541862, 11083.833742494031, 11265.605703800327, 11379.829302560634, 7488.213737557696, 10440.164786816884, 10591.364518128938, 10697.946510267398, 11060.668179954615, 10131.544080516247, 10263.23025773055, 10578.89421105779, 10654.73363165927, 10862.076723478593, 10526.842097368393, 10550.525226364985, 10585.788284234426, 10647.467626618483, 10843.24097313212, 8397.412181147261, 8555.187257210555, 8772.736817895473, 9166.908330916605, 9306.395084319498, 9007.549622518716, 9309.86035209486, 9401.764955876159, 9443.197328227177, 9456.338056336266], "value": 6278.502667708933, "unit": "score"}], "name": "dromaeo_css", "value": 6204.285204816955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 135.0, 114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 113.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 152.0, 189.0, 130.0, 145.0, 149.0, 130.0, 179.0, 125.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 163.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 84.0, 177.0, 77.0, 78.0, 78.0, 78.0, 164.0, 77.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 140.0, 84.0, 85.0, 84.0, 152.0, 85.0, 84.0, 132.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 119.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 83.0, 83.0, 83.0, 82.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 135.0, 131.0, 132.0, 133.0, 134.0, 135.0, 172.0, 147.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 172.0, 175.0, 172.0, 173.0, 172.0, 175.0, 173.0, 172.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0, 69.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1577.5, "alertThreshold": 2.0}]} 08:40:08 INFO - Return code: 0 08:40:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:40:08 INFO - # TBPL SUCCESS # 08:40:08 INFO - Running post-action listener: _resource_record_post_action 08:40:08 INFO - [mozharness: 2016-08-30 15:40:08.640626Z] Finished run-tests step (success) 08:40:08 INFO - Running post-run listener: _resource_record_post_run 08:40:08 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406478848; Read time: 12; Write time: 290124 08:40:08 INFO - TinderboxPrint: CPU usage
13.0% 08:40:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:40:08 INFO - TinderboxPrint: I/O write bytes / time
406,478,848 / 290,124 08:40:08 INFO - TinderboxPrint: CPU idle
8,347.4 (87.0%) 08:40:08 INFO - TinderboxPrint: CPU user
1,202.5 (12.5%) 08:40:08 INFO - TinderboxPrint: Swap in / out
0 / 0 08:40:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113635328; Read time: 0; Write time: 85368 08:40:08 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292843520; Read time: 0; Write time: 204756 08:40:09 INFO - Running post-run listener: _upload_blobber_files 08:40:09 INFO - Blob upload gear active. 08:40:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:40:09 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 08:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:40:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:10 INFO - (blobuploader) - INFO - Done attempting. 08:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:11 INFO - (blobuploader) - INFO - Done attempting. 08:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:40:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:14 INFO - (blobuploader) - INFO - Done attempting. 08:40:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:14 INFO - Return code: 0 08:40:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6ec53a38a9bc762c0991e445772cd6efa5162919559db200f3dd617a1a130be9e26337e12662815f469f384eced23acfb5f1fa206806d6ed2fa9cf75a591a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd0e40e86d28d05ab15796f64fbc73c93d4e0d9b08cbd7018339436069a7955073bf168c63f3216a7b502600f74e4c6dea0d8a1f27c394d22db31bfa3ab1af6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52377319a2647f9c9c36c6d8f0e7519779730a610e269fff4c810f9721adccb63620fe60ce1aa8c1fc69c04662e87d8808004bad9fbff0f4dfc4573118d2958f"} 08:40:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:14 INFO - Contents: 08:40:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6ec53a38a9bc762c0991e445772cd6efa5162919559db200f3dd617a1a130be9e26337e12662815f469f384eced23acfb5f1fa206806d6ed2fa9cf75a591a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd0e40e86d28d05ab15796f64fbc73c93d4e0d9b08cbd7018339436069a7955073bf168c63f3216a7b502600f74e4c6dea0d8a1f27c394d22db31bfa3ab1af6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52377319a2647f9c9c36c6d8f0e7519779730a610e269fff4c810f9721adccb63620fe60ce1aa8c1fc69c04662e87d8808004bad9fbff0f4dfc4573118d2958f"} 08:40:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:14 INFO - Copying logs to upload dir... 08:40:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.577007 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 08:40:14.432196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 08:40:14.436009) ========= 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=62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6ec53a38a9bc762c0991e445772cd6efa5162919559db200f3dd617a1a130be9e26337e12662815f469f384eced23acfb5f1fa206806d6ed2fa9cf75a591a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd0e40e86d28d05ab15796f64fbc73c93d4e0d9b08cbd7018339436069a7955073bf168c63f3216a7b502600f74e4c6dea0d8a1f27c394d22db31bfa3ab1af6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52377319a2647f9c9c36c6d8f0e7519779730a610e269fff4c810f9721adccb63620fe60ce1aa8c1fc69c04662e87d8808004bad9fbff0f4dfc4573118d2958f"} build_url:https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/O7NMypm8TSKchkX_NWkxkA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc6ec53a38a9bc762c0991e445772cd6efa5162919559db200f3dd617a1a130be9e26337e12662815f469f384eced23acfb5f1fa206806d6ed2fa9cf75a591a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fd0e40e86d28d05ab15796f64fbc73c93d4e0d9b08cbd7018339436069a7955073bf168c63f3216a7b502600f74e4c6dea0d8a1f27c394d22db31bfa3ab1af6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52377319a2647f9c9c36c6d8f0e7519779730a610e269fff4c810f9721adccb63620fe60ce1aa8c1fc69c04662e87d8808004bad9fbff0f4dfc4573118d2958f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 08:40:14.461028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:40:14.461327) ========= 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=62c568580acbfdaac3eec7be000001dc-1472569113.665287-518237872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:40:14.544815) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 08:40:14.545134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 08:40:14.545438) ========= ========= Total master_lag: 0.17 =========