builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1471489757.33 results: success (0) buildid: 20160817173001 builduid: 921c711a151f4d7e983975cc6adec061 revision: 11c94ec980d60a48be403d003798d64269e785ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.327401) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.328926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.329203) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.352471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.352807) ========= 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=0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 20:09:17-- 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% 40.0M=0s 2016-08-17 20:09:17 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.518911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.519218) ========= 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=0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.568464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:17.571876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11c94ec980d60a48be403d003798d64269e785ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 11c94ec980d60a48be403d003798d64269e785ef --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=0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 20:09:17,830 truncating revision to first 12 chars 2016-08-17 20:09:17,831 Setting DEBUG logging. 2016-08-17 20:09:17,831 attempt 1/10 2016-08-17 20:09:17,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11c94ec980d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 20:09:18,143 unpacking tar archive at: fx-team-11c94ec980d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.241068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.241357) ========= script_repo_revision: 11c94ec980d60a48be403d003798d64269e785ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.241737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.241998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 20:09:18.256617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-17 20:09:18.256901) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:18 INFO - MultiFileLogger online at 20160817 20:09:18 in /builds/slave/test 20:09:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:09:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:18 INFO - {'append_to_log': False, 20:09:18 INFO - 'base_work_dir': '/builds/slave/test', 20:09:18 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:18 INFO - 'branch': 'Fx-Team', 20:09:18 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:18 INFO - 'config_files': ('talos/linux_config.py',), 20:09:18 INFO - 'default_actions': ('clobber', 20:09:18 INFO - 'read-buildbot-config', 20:09:18 INFO - 'download-and-extract', 20:09:18 INFO - 'populate-webroot', 20:09:18 INFO - 'create-virtualenv', 20:09:18 INFO - 'install', 20:09:18 INFO - 'run-tests'), 20:09:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:18 INFO - 'download_minidump_stackwalk': True, 20:09:18 INFO - 'download_symbols': 'ondemand', 20:09:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:18 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:18 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:18 INFO - 'installer_path': 'installer.exe', 20:09:18 INFO - 'log_level': 'info', 20:09:18 INFO - 'log_name': 'talos', 20:09:18 INFO - 'log_to_console': True, 20:09:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:18 INFO - 'opt_config_files': (), 20:09:18 INFO - 'pip_index': False, 20:09:18 INFO - 'sps_profile': False, 20:09:18 INFO - 'sps_profile_interval': 0, 20:09:18 INFO - 'suite': 'dromaeojs-e10s', 20:09:18 INFO - 'system_bits': '32', 20:09:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:18 INFO - 'title': 'talos-linux64-ix-017', 20:09:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:18 INFO - 'use_talos_json': True, 20:09:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:18 INFO - 'work_dir': 'build'} 20:09:18 INFO - [mozharness: 2016-08-18 03:09:18.613436Z] Running clobber step. 20:09:18 INFO - Running pre-action listener: _resource_record_pre_action 20:09:18 INFO - Running main action method: clobber 20:09:18 INFO - rmtree: /builds/slave/test/build 20:09:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:19 INFO - Running post-action listener: _resource_record_post_action 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.067219Z] Finished clobber step (success) 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.067319Z] Running read-buildbot-config step. 20:09:19 INFO - Running pre-action listener: _resource_record_pre_action 20:09:19 INFO - Running main action method: read_buildbot_config 20:09:19 INFO - Using buildbot properties: 20:09:19 INFO - { 20:09:19 INFO - "project": "", 20:09:19 INFO - "product": "firefox", 20:09:19 INFO - "script_repo_revision": "production", 20:09:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:09:19 INFO - "repository": "", 20:09:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:09:19 INFO - "buildid": "20160817173001", 20:09:19 INFO - "pgo_build": "True", 20:09:19 INFO - "basedir": "/builds/slave/test", 20:09:19 INFO - "buildnumber": 1052, 20:09:19 INFO - "slavename": "talos-linux64-ix-017", 20:09:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:09:19 INFO - "platform": "ubuntu64_hw", 20:09:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:19 INFO - "branch": "fx-team", 20:09:19 INFO - "repo_path": "integration/fx-team", 20:09:19 INFO - "revision": "11c94ec980d60a48be403d003798d64269e785ef", 20:09:19 INFO - "stage_platform": "linux64-pgo", 20:09:19 INFO - "builduid": "921c711a151f4d7e983975cc6adec061", 20:09:19 INFO - "slavebuilddir": "test" 20:09:19 INFO - } 20:09:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:09:19 INFO - Running post-action listener: _resource_record_post_action 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.069726Z] Finished read-buildbot-config step (success) 20:09:19 INFO - [mozharness: 2016-08-18 03:09:19.069813Z] Running download-and-extract step. 20:09:19 INFO - Running pre-action listener: _resource_record_pre_action 20:09:19 INFO - Running main action method: download_and_extract 20:09:19 INFO - mkdir: /builds/slave/test/build/tests 20:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:19 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:09:19 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:19 INFO - Downloaded 1361 bytes. 20:09:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:09:19 INFO - Using the following test package requirements: 20:09:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'jsshell-linux-x86_64.zip'], 20:09:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:19 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:09:19 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:20 INFO - Downloaded 21908217 bytes. 20:09:20 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 20:09:24 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 20:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:24 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:09:24 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:25 INFO - Downloaded 21908217 bytes. 20:09:25 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 20:09: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')]} 20:09:30 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:30 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:31 INFO - Downloaded 14413981 bytes. 20:09:31 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 20:09:31 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')]} 20:09:31 INFO - trying https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:09:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/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 20:09:32 INFO - Downloaded 59612100 bytes. 20:09:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:09:32 INFO - mkdir: /builds/slave/test/properties 20:09:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:32 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:32 INFO - Contents: 20:09:32 INFO - build_url:https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:09:33 INFO - Running post-action listener: _resource_record_post_action 20:09:33 INFO - Running post-action listener: set_extra_try_arguments 20:09:33 INFO - [mozharness: 2016-08-18 03:09:33.410591Z] Finished download-and-extract step (success) 20:09:33 INFO - [mozharness: 2016-08-18 03:09:33.410815Z] Running populate-webroot step. 20:09:33 INFO - Running pre-action listener: _resource_record_pre_action 20:09:33 INFO - Running main action method: populate_webroot 20:09:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:33 INFO - '--tppagecycles', 20:09:33 INFO - '7'], 20:09:33 INFO - 'tests': ['tsvgm']}}, 20:09:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['damp', 'tps']}, 20:09:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'tests': ['damp', 'tps']}, 20:09:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['dromaeo_dom']}, 20:09:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['basic_compositor_video']}, 20:09:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:09:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['a11yr', 20:09:33 INFO - 'ts_paint', 20:09:33 INFO - 'tpaint', 20:09:33 INFO - 'sessionrestore', 20:09:33 INFO - 'sessionrestore_no_auto_restore', 20:09:33 INFO - 'tabpaint']}, 20:09:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:33 INFO - 'ts_paint', 20:09:33 INFO - 'tpaint', 20:09:33 INFO - 'sessionrestore', 20:09:33 INFO - 'sessionrestore_no_auto_restore', 20:09:33 INFO - 'tabpaint']}, 20:09:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:33 INFO - 'ts_paint', 20:09:33 INFO - 'tpaint', 20:09:33 INFO - 'sessionrestore', 20:09:33 INFO - 'sessionrestore_no_auto_restore', 20:09:33 INFO - 'tabpaint']}, 20:09:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:33 INFO - 'ts_paint', 20:09:33 INFO - 'tpaint', 20:09:33 INFO - 'sessionrestore', 20:09:33 INFO - 'sessionrestore_no_auto_restore', 20:09:33 INFO - 'tabpaint']}, 20:09:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['a11yr', 20:09:33 INFO - 'ts_paint', 20:09:33 INFO - 'tpaint', 20:09:33 INFO - 'sessionrestore', 20:09:33 INFO - 'sessionrestore_no_auto_restore', 20:09:33 INFO - 'tabpaint']}, 20:09:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['a11yr', 20:09:33 INFO - 'ts_paint', 20:09:33 INFO - 'tpaint', 20:09:33 INFO - 'sessionrestore', 20:09:33 INFO - 'sessionrestore_no_auto_restore', 20:09:33 INFO - 'tabpaint']}, 20:09:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['tsvgx', 20:09:33 INFO - 'tsvgr_opacity', 20:09:33 INFO - 'tart', 20:09:33 INFO - 'tscrollx', 20:09:33 INFO - 'cart']}, 20:09:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:33 INFO - 'tsvgr_opacity', 20:09:33 INFO - 'tart', 20:09:33 INFO - 'tscrollx', 20:09:33 INFO - 'cart']}, 20:09:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'talos_options': ['--disable-e10s'], 20:09:33 INFO - 'tests': ['tp5o']}, 20:09:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'tests': ['tp5o']}, 20:09:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'talos_options': ['--disable-e10s', 20:09:33 INFO - '--xperf_path', 20:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:33 INFO - 'tests': ['tp5n']}, 20:09:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:33 INFO - 'talos_options': ['--xperf_path', 20:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:33 INFO - 'tests': ['tp5n']}}, 20:09:33 INFO - 'talos.zip': {'path': '', 20:09:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:33 INFO - Running post-action listener: _resource_record_post_action 20:09:33 INFO - [mozharness: 2016-08-18 03:09:33.430350Z] Finished populate-webroot step (success) 20:09:33 INFO - [mozharness: 2016-08-18 03:09:33.430437Z] Running create-virtualenv step. 20:09:33 INFO - Running pre-action listener: _resource_record_pre_action 20:09:33 INFO - Running main action method: create_virtualenv 20:09:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:33 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 20:09:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:33 INFO - Using real prefix '/usr' 20:09:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:35 INFO - Installing pip.................done. 20:09:36 INFO - Return code: 0 20:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:36 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')]} 20:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:36 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')]} 20:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:36 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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:36 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 20:09:36 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 20:09:36 INFO - Using env: {'DISPLAY': ':0', 20:09:36 INFO - 'HOME': '/home/cltbld', 20:09:36 INFO - 'LANG': 'en_US.UTF-8', 20:09:36 INFO - 'LANGUAGE': 'en_US:en', 20:09:36 INFO - 'LOGNAME': 'cltbld', 20:09:36 INFO - 'MAIL': '/var/mail/cltbld', 20:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:36 INFO - 'MOZ_NO_REMOTE': '1', 20:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:36 INFO - 'NO_EM_RESTART': '1', 20:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:36 INFO - 'PWD': '/builds/slave/test', 20:09:36 INFO - 'SHELL': '/bin/bash', 20:09:36 INFO - 'SHLVL': '1', 20:09:36 INFO - 'TERM': 'linux', 20:09:36 INFO - 'TMOUT': '86400', 20:09:36 INFO - 'USER': 'cltbld', 20:09:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:36 INFO - '_': '/tools/buildbot/bin/python'} 20:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:36 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 20:09:36 INFO - Cleaning up... 20:09:36 INFO - Return code: 0 20:09:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09:36 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')]} 20:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:36 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')]} 20:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:36 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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:36 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 20:09:36 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 20:09:36 INFO - Using env: {'DISPLAY': ':0', 20:09:36 INFO - 'HOME': '/home/cltbld', 20:09:36 INFO - 'LANG': 'en_US.UTF-8', 20:09:36 INFO - 'LANGUAGE': 'en_US:en', 20:09:36 INFO - 'LOGNAME': 'cltbld', 20:09:36 INFO - 'MAIL': '/var/mail/cltbld', 20:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:36 INFO - 'MOZ_NO_REMOTE': '1', 20:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:36 INFO - 'NO_EM_RESTART': '1', 20:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:36 INFO - 'PWD': '/builds/slave/test', 20:09:36 INFO - 'SHELL': '/bin/bash', 20:09:36 INFO - 'SHLVL': '1', 20:09:36 INFO - 'TERM': 'linux', 20:09:36 INFO - 'TMOUT': '86400', 20:09:36 INFO - 'USER': 'cltbld', 20:09:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:36 INFO - '_': '/tools/buildbot/bin/python'} 20:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:36 INFO - Downloading/unpacking psutil>=3.1.1 20:09:36 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 20:09:36 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 20:09:36 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 20:09:36 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 20:09:36 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 20:09:36 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 20:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:38 INFO - Installing collected packages: psutil 20:09:38 INFO - Running setup.py install for psutil 20:09:38 INFO - building 'psutil._psutil_linux' extension 20:09:38 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 20:09:38 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 20:09:38 INFO - building 'psutil._psutil_posix' extension 20:09:38 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 20:09:38 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 20:09:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:38 INFO - Successfully installed psutil 20:09:38 INFO - Cleaning up... 20:09:39 INFO - Return code: 0 20:09:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:09:39 INFO - Using env: {'DISPLAY': ':0', 20:09:39 INFO - 'HOME': '/home/cltbld', 20:09:39 INFO - 'LANG': 'en_US.UTF-8', 20:09:39 INFO - 'LANGUAGE': 'en_US:en', 20:09:39 INFO - 'LOGNAME': 'cltbld', 20:09:39 INFO - 'MAIL': '/var/mail/cltbld', 20:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:39 INFO - 'MOZ_NO_REMOTE': '1', 20:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:39 INFO - 'NO_EM_RESTART': '1', 20:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:39 INFO - 'PWD': '/builds/slave/test', 20:09:39 INFO - 'SHELL': '/bin/bash', 20:09:39 INFO - 'SHLVL': '1', 20:09:39 INFO - 'TERM': 'linux', 20:09:39 INFO - 'TMOUT': '86400', 20:09:39 INFO - 'USER': 'cltbld', 20:09:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:39 INFO - '_': '/tools/buildbot/bin/python'} 20:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:41 INFO - Installing collected packages: mozsystemmonitor 20:09:41 INFO - Running setup.py install for mozsystemmonitor 20:09:41 INFO - Successfully installed mozsystemmonitor 20:09:41 INFO - Cleaning up... 20:09:41 INFO - Return code: 0 20:09:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:09:41 INFO - Using env: {'DISPLAY': ':0', 20:09:41 INFO - 'HOME': '/home/cltbld', 20:09:41 INFO - 'LANG': 'en_US.UTF-8', 20:09:41 INFO - 'LANGUAGE': 'en_US:en', 20:09:41 INFO - 'LOGNAME': 'cltbld', 20:09:41 INFO - 'MAIL': '/var/mail/cltbld', 20:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:41 INFO - 'MOZ_NO_REMOTE': '1', 20:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:41 INFO - 'NO_EM_RESTART': '1', 20:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:41 INFO - 'PWD': '/builds/slave/test', 20:09:41 INFO - 'SHELL': '/bin/bash', 20:09:41 INFO - 'SHLVL': '1', 20:09:41 INFO - 'TERM': 'linux', 20:09:41 INFO - 'TMOUT': '86400', 20:09:41 INFO - 'USER': 'cltbld', 20:09:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:41 INFO - '_': '/tools/buildbot/bin/python'} 20:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:41 INFO - Downloading/unpacking jsonschema==2.5.1 20:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:43 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:43 INFO - warning: no files found matching '*.txt' 20:09:43 INFO - no previously-included directories found matching 'build' 20:09:43 INFO - no previously-included directories found matching 'dist' 20:09:43 INFO - no previously-included directories found matching '.git*' 20:09:43 INFO - Installing collected packages: jsonschema, functools32 20:09:43 INFO - Running setup.py install for functools32 20:09:43 INFO - warning: no files found matching '*.txt' 20:09:43 INFO - no previously-included directories found matching 'build' 20:09:43 INFO - no previously-included directories found matching 'dist' 20:09:43 INFO - no previously-included directories found matching '.git*' 20:09:43 INFO - Successfully installed jsonschema functools32 20:09:43 INFO - Cleaning up... 20:09:43 INFO - Return code: 0 20:09:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:09:43 INFO - Using env: {'DISPLAY': ':0', 20:09:43 INFO - 'HOME': '/home/cltbld', 20:09:43 INFO - 'LANG': 'en_US.UTF-8', 20:09:43 INFO - 'LANGUAGE': 'en_US:en', 20:09:43 INFO - 'LOGNAME': 'cltbld', 20:09:43 INFO - 'MAIL': '/var/mail/cltbld', 20:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:43 INFO - 'MOZ_NO_REMOTE': '1', 20:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:43 INFO - 'NO_EM_RESTART': '1', 20:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:43 INFO - 'PWD': '/builds/slave/test', 20:09:43 INFO - 'SHELL': '/bin/bash', 20:09:43 INFO - 'SHLVL': '1', 20:09:43 INFO - 'TERM': 'linux', 20:09:43 INFO - 'TMOUT': '86400', 20:09:43 INFO - 'USER': 'cltbld', 20:09:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:43 INFO - '_': '/tools/buildbot/bin/python'} 20:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:09:44 INFO - Cleaning up... 20:09:44 INFO - Return code: 0 20:09:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:09:44 INFO - Using env: {'DISPLAY': ':0', 20:09:44 INFO - 'HOME': '/home/cltbld', 20:09:44 INFO - 'LANG': 'en_US.UTF-8', 20:09:44 INFO - 'LANGUAGE': 'en_US:en', 20:09:44 INFO - 'LOGNAME': 'cltbld', 20:09:44 INFO - 'MAIL': '/var/mail/cltbld', 20:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:44 INFO - 'MOZ_NO_REMOTE': '1', 20:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:44 INFO - 'NO_EM_RESTART': '1', 20:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:44 INFO - 'PWD': '/builds/slave/test', 20:09:44 INFO - 'SHELL': '/bin/bash', 20:09:44 INFO - 'SHLVL': '1', 20:09:44 INFO - 'TERM': 'linux', 20:09:44 INFO - 'TMOUT': '86400', 20:09:44 INFO - 'USER': 'cltbld', 20:09:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:44 INFO - '_': '/tools/buildbot/bin/python'} 20:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:46 INFO - Downloading docopt-0.6.1.tar.gz 20:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:47 INFO - Running setup.py install for blobuploader 20:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:47 INFO - Running setup.py install for requests 20:09:47 INFO - Running setup.py install for docopt 20:09:47 INFO - Successfully installed blobuploader requests docopt 20:09:47 INFO - Cleaning up... 20:09:47 INFO - Return code: 0 20:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:47 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')]} 20:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:47 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')]} 20:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:47 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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:47 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 20:09:47 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 20:09:47 INFO - Using env: {'DISPLAY': ':0', 20:09:47 INFO - 'HOME': '/home/cltbld', 20:09:47 INFO - 'LANG': 'en_US.UTF-8', 20:09:47 INFO - 'LANGUAGE': 'en_US:en', 20:09:47 INFO - 'LOGNAME': 'cltbld', 20:09:47 INFO - 'MAIL': '/var/mail/cltbld', 20:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:47 INFO - 'MOZ_NO_REMOTE': '1', 20:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:47 INFO - 'NO_EM_RESTART': '1', 20:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:47 INFO - 'PWD': '/builds/slave/test', 20:09:47 INFO - 'SHELL': '/bin/bash', 20:09:47 INFO - 'SHLVL': '1', 20:09:47 INFO - 'TERM': 'linux', 20:09:47 INFO - 'TMOUT': '86400', 20:09:47 INFO - 'USER': 'cltbld', 20:09:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:47 INFO - '_': '/tools/buildbot/bin/python'} 20:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:47 INFO - Running setup.py (path:/tmp/pip-fL_S1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:47 INFO - Running setup.py (path:/tmp/pip-8v579i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:48 INFO - Running setup.py (path:/tmp/pip-l0RM_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:48 INFO - Running setup.py (path:/tmp/pip-V6pGsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:48 INFO - Running setup.py (path:/tmp/pip-2cAVBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:48 INFO - Running setup.py (path:/tmp/pip-dh9e0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:48 INFO - Running setup.py (path:/tmp/pip-358ZVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:48 INFO - Running setup.py (path:/tmp/pip-y1G_Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:48 INFO - Running setup.py (path:/tmp/pip-8yCv0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:48 INFO - Running setup.py (path:/tmp/pip-oyKNpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:48 INFO - Running setup.py (path:/tmp/pip-cZapc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:48 INFO - Running setup.py (path:/tmp/pip-cwvWJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:48 INFO - Running setup.py (path:/tmp/pip-7nbVCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:48 INFO - Running setup.py (path:/tmp/pip-vDuL7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:48 INFO - Running setup.py (path:/tmp/pip-heU5_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:48 INFO - Running setup.py (path:/tmp/pip-UkZAiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:49 INFO - Running setup.py (path:/tmp/pip-VYcx2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:49 INFO - Running setup.py install for manifestparser 20:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozcrash 20:09:49 INFO - Running setup.py install for mozdebug 20:09:49 INFO - Running setup.py install for mozdevice 20:09:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozfile 20:09:49 INFO - Running setup.py install for mozhttpd 20:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozinfo 20:09:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozInstall 20:09:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozleak 20:09:50 INFO - Running setup.py install for mozlog 20:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for moznetwork 20:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozprocess 20:09:50 INFO - Running setup.py install for mozprofile 20:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozrunner 20:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozscreenshot 20:09:50 INFO - Running setup.py install for moztest 20:09:50 INFO - Running setup.py install for mozversion 20:09:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:50 INFO - Cleaning up... 20:09:50 INFO - Return code: 0 20:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:50 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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:50 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 20:09:50 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 20:09:50 INFO - Using env: {'DISPLAY': ':0', 20:09:50 INFO - 'HOME': '/home/cltbld', 20:09:50 INFO - 'LANG': 'en_US.UTF-8', 20:09:50 INFO - 'LANGUAGE': 'en_US:en', 20:09:50 INFO - 'LOGNAME': 'cltbld', 20:09:50 INFO - 'MAIL': '/var/mail/cltbld', 20:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:50 INFO - 'MOZ_NO_REMOTE': '1', 20:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:50 INFO - 'NO_EM_RESTART': '1', 20:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:50 INFO - 'PWD': '/builds/slave/test', 20:09:50 INFO - 'SHELL': '/bin/bash', 20:09:50 INFO - 'SHLVL': '1', 20:09:50 INFO - 'TERM': 'linux', 20:09:50 INFO - 'TMOUT': '86400', 20:09:50 INFO - 'USER': 'cltbld', 20:09:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:50 INFO - '_': '/tools/buildbot/bin/python'} 20:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:51 INFO - Running setup.py (path:/tmp/pip-dU1lSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:51 INFO - Running setup.py (path:/tmp/pip-J_ROVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:51 INFO - Running setup.py (path:/tmp/pip-834SzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:51 INFO - Running setup.py (path:/tmp/pip-EVQ3yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:51 INFO - Running setup.py (path:/tmp/pip-jkgYhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:51 INFO - Running setup.py (path:/tmp/pip-T90tZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:51 INFO - Running setup.py (path:/tmp/pip-fJIvdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:51 INFO - Running setup.py (path:/tmp/pip-CwA6_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:51 INFO - Running setup.py (path:/tmp/pip-iaeUGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:51 INFO - Running setup.py (path:/tmp/pip-kKHS7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:51 INFO - Running setup.py (path:/tmp/pip-uqMvfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:51 INFO - Running setup.py (path:/tmp/pip-_Bs5Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:51 INFO - Running setup.py (path:/tmp/pip-ZED6RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:52 INFO - Running setup.py (path:/tmp/pip-Tog4KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:52 INFO - Running setup.py (path:/tmp/pip-Kgkgkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:52 INFO - Running setup.py (path:/tmp/pip-Pj37mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:52 INFO - Running setup.py (path:/tmp/pip-ISfJpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:52 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)) 20:09:52 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)) 20:09:52 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)) 20:09:52 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)) 20:09:52 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)) 20:09:52 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)) 20:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:52 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 20:09:52 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 20:09:52 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 20:09:52 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 20:09:52 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 20:09:52 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 20:09:54 INFO - Downloading blessings-1.6.tar.gz 20:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:54 INFO - Installing collected packages: blessings 20:09:54 INFO - Running setup.py install for blessings 20:09:54 INFO - Successfully installed blessings 20:09:54 INFO - Cleaning up... 20:09:54 INFO - Return code: 0 20:09:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:54 INFO - Reading from file tmpfile_stdout 20:09:54 INFO - Current package versions: 20:09:54 INFO - argparse == 1.2.1 20:09:54 INFO - blessings == 1.6 20:09:54 INFO - blobuploader == 1.2.4 20:09:54 INFO - docopt == 0.6.1 20:09:54 INFO - functools32 == 3.2.3-2 20:09:54 INFO - jsonschema == 2.5.1 20:09:54 INFO - manifestparser == 1.1 20:09:54 INFO - mozInstall == 1.12 20:09:54 INFO - mozcrash == 0.17 20:09:54 INFO - mozdebug == 0.1 20:09:54 INFO - mozdevice == 0.48 20:09:54 INFO - mozfile == 1.2 20:09:54 INFO - mozhttpd == 0.7 20:09:54 INFO - mozinfo == 0.9 20:09:54 INFO - mozleak == 0.1 20:09:54 INFO - mozlog == 3.3 20:09:54 INFO - moznetwork == 0.27 20:09:54 INFO - mozprocess == 0.23 20:09:54 INFO - mozprofile == 0.28 20:09:54 INFO - mozrunner == 6.12 20:09:54 INFO - mozscreenshot == 0.1 20:09:54 INFO - mozsystemmonitor == 0.3 20:09:54 INFO - moztest == 0.7 20:09:54 INFO - mozversion == 1.4 20:09:54 INFO - psutil == 3.1.1 20:09:54 INFO - requests == 1.2.3 20:09:54 INFO - wsgiref == 0.1.2 20:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 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 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09:54 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 20:09:54 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 20:09:54 INFO - Using env: {'DISPLAY': ':0', 20:09:54 INFO - 'HOME': '/home/cltbld', 20:09:54 INFO - 'LANG': 'en_US.UTF-8', 20:09:54 INFO - 'LANGUAGE': 'en_US:en', 20:09:54 INFO - 'LOGNAME': 'cltbld', 20:09:54 INFO - 'MAIL': '/var/mail/cltbld', 20:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:54 INFO - 'MOZ_NO_REMOTE': '1', 20:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:54 INFO - 'NO_EM_RESTART': '1', 20:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:54 INFO - 'PWD': '/builds/slave/test', 20:09:54 INFO - 'SHELL': '/bin/bash', 20:09:54 INFO - 'SHLVL': '1', 20:09:54 INFO - 'TERM': 'linux', 20:09:54 INFO - 'TMOUT': '86400', 20:09:54 INFO - 'USER': 'cltbld', 20:09:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:54 INFO - '_': '/tools/buildbot/bin/python'} 20:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 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)) 20:09:54 INFO - Cleaning up... 20:09:54 INFO - Return code: 0 20:09:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec3295df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a04850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, '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': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', '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 20:09: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', 'jsonschema'] in /builds/slave/test/build 20:09: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 jsonschema 20:09:54 INFO - Using env: {'DISPLAY': ':0', 20:09:54 INFO - 'HOME': '/home/cltbld', 20:09:54 INFO - 'LANG': 'en_US.UTF-8', 20:09:54 INFO - 'LANGUAGE': 'en_US:en', 20:09:54 INFO - 'LOGNAME': 'cltbld', 20:09:54 INFO - 'MAIL': '/var/mail/cltbld', 20:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:54 INFO - 'MOZ_NO_REMOTE': '1', 20:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:54 INFO - 'NO_EM_RESTART': '1', 20:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:54 INFO - 'PWD': '/builds/slave/test', 20:09:54 INFO - 'SHELL': '/bin/bash', 20:09:54 INFO - 'SHLVL': '1', 20:09:54 INFO - 'TERM': 'linux', 20:09:54 INFO - 'TMOUT': '86400', 20:09:54 INFO - 'USER': 'cltbld', 20:09:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:54 INFO - '_': '/tools/buildbot/bin/python'} 20:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:09:55 INFO - Cleaning up... 20:09:55 INFO - Return code: 0 20:09:55 INFO - Running post-action listener: _resource_record_post_action 20:09:55 INFO - Running post-action listener: _start_resource_monitoring 20:09:55 INFO - Starting resource monitoring. 20:09:55 INFO - [mozharness: 2016-08-18 03:09:55.183942Z] Finished create-virtualenv step (success) 20:09:55 INFO - [mozharness: 2016-08-18 03:09:55.184401Z] Running install step. 20:09:55 INFO - Running pre-action listener: _resource_record_pre_action 20:09:55 INFO - Running main action method: install 20:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:55 INFO - Reading from file tmpfile_stdout 20:09:55 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:55 INFO - Reading from file tmpfile_stdout 20:09:55 INFO - Output received: 20:09:55 INFO - Usage: mozinstall [options] installer 20:09:55 INFO - Options: 20:09:55 INFO - -h, --help show this help message and exit 20:09:55 INFO - -d DEST, --destination=DEST 20:09:55 INFO - Directory to install application into. [default: 20:09:55 INFO - "/builds/slave/test"] 20:09:55 INFO - --app=APP Application being installed. [default: firefox] 20:09:55 INFO - mkdir: /builds/slave/test/build/application 20:09:55 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'] 20:09:55 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 20:10:12 INFO - Reading from file tmpfile_stdout 20:10:12 INFO - Output received: 20:10:12 INFO - /builds/slave/test/build/application/firefox/firefox 20:10:12 INFO - Running post-action listener: _resource_record_post_action 20:10:12 INFO - [mozharness: 2016-08-18 03:10:12.435110Z] Finished install step (success) 20:10:12 INFO - [mozharness: 2016-08-18 03:10:12.435355Z] Running run-tests step. 20:10:12 INFO - Running pre-action listener: _resource_record_pre_action 20:10:12 INFO - Running main action method: run_tests 20:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:10:12 INFO - Python 2.7.3 20:10:12 INFO - Return code: 0 20:10:12 INFO - grabbing minidump binary from tooltool 20:10:12 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')]} 20:10:12 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 0x29ff370>, '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 0x2a028f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:10:12 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 20:10:12 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 20:10:12 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 20:10:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:12 INFO - Return code: 0 20:10:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:10:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:10:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:10:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:10:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:10:12 INFO - Using env: {'DISPLAY': ':0', 20:10:12 INFO - 'HOME': '/home/cltbld', 20:10:12 INFO - 'LANG': 'en_US.UTF-8', 20:10:12 INFO - 'LANGUAGE': 'en_US:en', 20:10:12 INFO - 'LOGNAME': 'cltbld', 20:10:12 INFO - 'MAIL': '/var/mail/cltbld', 20:10:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:10:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:12 INFO - 'MOZ_NO_REMOTE': '1', 20:10:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:12 INFO - 'NO_EM_RESTART': '1', 20:10:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:12 INFO - 'PWD': '/builds/slave/test', 20:10:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:10:12 INFO - 'SHELL': '/bin/bash', 20:10:12 INFO - 'SHLVL': '1', 20:10:12 INFO - 'TERM': 'linux', 20:10:12 INFO - 'TMOUT': '86400', 20:10:12 INFO - 'USER': 'cltbld', 20:10:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813', 20:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:12 INFO - '_': '/tools/buildbot/bin/python'} 20:10:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:10:12 INFO - mozversion application_buildid: 20160817173001 20:10:12 INFO - mozversion application_changeset: 11c94ec980d60a48be403d003798d64269e785ef 20:10:12 INFO - mozversion application_display_name: Nightly 20:10:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:12 INFO - mozversion application_name: Firefox 20:10:12 INFO - mozversion application_remotingname: firefox 20:10:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:10:12 INFO - mozversion application_vendor: Mozilla 20:10:12 INFO - mozversion application_version: 51.0a1 20:10:12 INFO - mozversion platform_buildid: 20160817173001 20:10:12 INFO - mozversion platform_changeset: 11c94ec980d60a48be403d003798d64269e785ef 20:10:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:10:12 INFO - mozversion platform_version: 51.0a1 20:10:12 INFO - using testdate: 1471489812 20:10:12 INFO - actual date: 1471489812 20:10:12 INFO - starting webserver on 'localhost:40462' 20:10:12 INFO - SUITE-START | Running 2 tests 20:10:12 INFO - TEST-START | dromaeo_css 20:10:12 INFO - operating with platform_type : linux_ 20:10:12 INFO - Initialising browser for dromaeo_css test... 20:10:12 INFO - TEST-INFO | started process 8776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4GY67N/profile http://localhost:40462/getInfo.html) 20:10:16 INFO - PROCESS | 8776 | __metrics Screen width/height:1600/1200 20:10:16 INFO - PROCESS | 8776 | colorDepth:24 20:10:16 INFO - PROCESS | 8776 | Browser inner width/height: 1024/697 20:10:16 INFO - PROCESS | 8776 | __metrics 20:10:17 ERROR - PROCESS | 8776 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:10:18 INFO - TEST-INFO | 8776: exit 0 20:10:18 INFO - Browser initialized. 20:10:18 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:18 INFO - TEST-INFO | started process 8896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4GY67N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:29 INFO - PROCESS | 8896 | RSS: Main: 163233792 20:10:29 INFO - PROCESS | 8896 | 20:11:19 INFO - PROCESS | 8896 | 1471489879544 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] 20:13:29 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40462/tests/dromaeo/cssquery-ext.html) 20:13:30 INFO - PROCESS | 8896 | RSS: Main: 165322752 20:13:30 INFO - PROCESS | 8896 | 20:16:32 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-ext.html (next: http://localhost:40462/tests/dromaeo/cssquery-jquery.html) 20:16:33 INFO - PROCESS | 8896 | RSS: Main: 165081088 20:16:33 INFO - PROCESS | 8896 | 20:19:35 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40462/tests/dromaeo/cssquery-mootools.html) 20:19:35 INFO - PROCESS | 8896 | RSS: Main: 166621184 20:19:35 INFO - PROCESS | 8896 | 20:22:37 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40462/tests/dromaeo/cssquery-prototype.html) 20:22:38 INFO - PROCESS | 8896 | RSS: Main: 163516416 20:22:38 INFO - PROCESS | 8896 | 20:25:40 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40462/tests/dromaeo/cssquery-yui.html) 20:25:41 INFO - PROCESS | 8896 | RSS: Main: 166252544 20:25:41 INFO - PROCESS | 8896 | 20:28:43 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-yui.html (next: http://localhost:40462/tests/dromaeo/cssquery-dojo.html) 20:28:44 INFO - PROCESS | 8896 | RSS: Main: 166768640 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | __start_tp_report 20:28:44 INFO - PROCESS | 8896 | _x_x_mozilla_page_load 20:28:44 INFO - PROCESS | 8896 | _x_x_mozilla_page_load_details 20:28:44 INFO - PROCESS | 8896 | |i|pagename|runs| 20:28:44 INFO - PROCESS | 8896 | |0;dojo.html;3067.1565319537126;3085.3674996625696;3085.9074227773167;3094.798838075525;3110.6889311068894;5320.042392369372;5409.8106566270135;5413.43158968308;5432;5448.782048718056;5314.415414304433;5351.331083614548;5368.892622147555;5384.165454354572;5422.620416570841;4878.926636140043;4925.3597032385915;4964.87587810304;4977.104121258172;5058.7976480940715;4985.501449855022;5000.849974500771;5017.84946451607;5055.266986286986;5058.013687330972;4817.879553011167;4857;4882.096812089775;4904.092742842586;4905.901881962359;4907.705537667715;4924.335214745999;4939.753012349368;4940.086084074422;4955.331030310898;4861.076395484846;4901.754912254373;4914.017196560702;4919.188333924898;4925.482824303468;5169.819056333048;5274.815381461669;5366.463353664602;5373.489518495737;5467.398586155519;5727.914081288784;5753.050746626802;5761.452661997104;5770.711464426804;5810.796622118248;5806.332271788714;5814.854628634275;5818.44724751148;5818.5054270386645;5820;5293.338332708373;5300.1519756838725;5322.228276899867;5327.706976116351;5395.973020134914;5874.295084589877;5879.941200588025;5885.117232415172;5896.262967129109;5909.202257695242;5578.944210557924;5627.296587926509;5633.57748168889;5641.379448260688;5651.604387692904;5585.58108141891;5686.60193786431;5714.342850572238;5716.371199168088;5728.140778883201;5572.0527510323345;5580.525655319262;5601.047821870292;5601.6358936668985;5605.915911261334;5639.041362968223;5668.206451096849;5693.17448969897;5693.345265294462;5704.543636509069;4343.04453020335;4349.652027837766;4394.736315821061;4409.9559004410185;4456.398386217819;3882.0877093882914;3950.3481925482547;3957.604239576077;3972.463717398172;3981.0843505993785;5481.561475081984;5501.889962200734;5505.284313039359;5509.724513774296;5516.227728118067;5655.349634792052;5676.290463692038;5802;5806.2451881255165;5811.476967072984;5389.541888939484;5462.754176062087;5464.043792336325;5470.288862447856;5503.091989821714;4900.975495122501;4908.656394052382;4909.165441874889;4913.606911447076;4951.702897826142;5801.970990145022;5865.970670146622;5948.702564871825;5950.375210602911;5955.940440595626;5600.159976003632;5643.830685079454;5651.039323315129;5724;5743.56923230751;5911.261092363455;5920.407959204045;5922.082077278029;5926.111083337534;5950.821475355746;5467.808626698046;5531.778728850801;5557.388687244481;5611.074172761449;5624.803131890364;5692.743826527733;5719.742611582572;5725.828225153252;5734.741936612946;5841.561882858718;5631.465010824129;5642.943570564242;5662.631928924607;5673.914891276717;5678.034734095131;5456.972715136399;5606.355269144101;5613.719314034363;5619.578531610064;5622.606417550732;5430.647007944471;5477.123660214346;5487.945120548743;5490.780368785204;5576.553875689854;5535.474129957647;5581.6930068846605;5581.74882130297;5582.106862901916;5587.860303492283;5346;5436.0758671026815;5462.317210348707;5477.04151773446;5511.889762204813 20:28:44 INFO - PROCESS | 8896 | |1;ext.html;582.4001278682957;585.5725320516024;587.0694948506617;589.7523040323065;597.1729155120157;39945.4008189877;43941.560584394145;44040.55959440405;44062.55937440625;44156;44021.77989110058;44331.11337773243;44618.55381446185;44644.53554644534;44650.77674611622;8758.824823503526;8901.73294801157;8910.643574257021;8944.597493112793;8962.551872406386;8768.298536117096;8837.204651581356;8841;8847;8868.955655221747;8931.687390941319;8942.418742781698;8942.731718048437;8984.10158984103;8988.820223595525;8818.250448711835;8830.514321712304;8867.512286824222;8876.689315873946;8917;8781.912180878173;8817.515036672981;8862.335324850663;8887.822243555158;8901.955490222508;42177.78911105455;42504.78747606242;42572.36141457881;42607.78696106531;42645;2636.8549729764854;3432.5537680101675;3524.559430071241;3543.3799085159994;4295.78521073945;29382.70617293821;31335.686643133504;31355;31691;31780.523292150636;3965.345717956534;4067.369557718529;4144.295469770146;4145.647619952308;4175.812088456027;315495;316624;316654;316807;317113.82886171073;34853.477197841545;34948.825255873555;35039.82480087583;35074.64925350765;35124.892506449694;36638.267234655155;37070;37474.625253747115;38729.225415491535;38852.80573597114;15632.531024069296;15744.92127539355;15760.896737228284;15788.60528486797;15794.289256983464;11817.940910295394;11864.466099025565;11865.762684746429;11904.226225295328;11915.344656044;18244.817551824577;18660.253589856526;18674.626507470046;18689.252429902925;18717.532061698294;7002.614856182959;7169.89245161323;7180.281971802778;7326.743563975236;7380.557166570023;945.3146468810195;995.00002497491;1000.3997601439224;1014.3102690170607;1033.3644808442752;30598.38803223923;31936.68063319337;32098.111169994812;32844.17889552732;33533.49699754506;1050.3592808386877;1095.39753135775;1118.2451845004753;1130.4856290387854;1154.1286328821855;16028.358865645478;16137.59656008609;16393.508194754177;16690.48271054784;16746.4138755143;557929;560852;562381;563014;563579;59697.672558585626;60206.69896650576;60287.39712602906;60681.69659151676;60724;1346.777781666014;1368.7604669182854;1391.1027387335112;1401.6706074072586;1404.9438022478987;28964.855175723987;30800.53799193059;30971.65081158312;31205.843970780003;31731;49338.506614933394;49514;49576.752116239186;49719.751401242764;49730.502694974035;369549;372187;374782;375389;375871;28184.43631127325;28398.43203135967;28873.566896496148;28905.42189156163;29039.274018149714;48257.5174248253;48410.5158948406;48461.5153848457;48681.269780954026;48864.75567622281;38972.369370041306;39250.80374598109;39926.60073399229;40582;42103;39940.60059399485;40042.59957400505;40685.186296273314;41441.79279103585;42114;42156.15687686168;42283.3657495144;42810;42999;45193.77403112964;33844.83077584596;36767;37566.248675026894;37853.621463785006;38160.23679526449;28532.714672853836;28597.14208573746;28665.69684608354;28778.568321475614;28917.42165156727 20:28:44 INFO - PROCESS | 8896 | |2;jquery.html;374.36589287758943;380.1351924372053;382.5294887288635;392.18817048709184;399.94600728901605;14905;17692.469225923225;18603.255869765195;19919.99999999998;20278.29025984091;18272;19364.9031754841;19415.51461213467;19816;19854.70217946732;5442.455754424545;5636.859078523029;5751.7699292028265;5764.106563482646;5787.102999035135;5617;5667.489925906688;5719.828405147852;5734.397888221739;5779.884402311951;5779.2775903012125;5886.793962211324;5887.058070708687;5938.524918006549;5973.910391344133;5852.268466441695;5954.9281129396695;5980.401959804007;6325;6415.518836087265;5622.184783206453;5662.122371032497;5663.830085097413;5668.489835914787;5672.092465205588;14835.554933352018;21570;22855.31434056981;22858.314250572508;23324.416889577726;2336.7663233676494;2446.2294377271282;2468.0744720729726;2860.313524754065;2966.1842993176833;10102.646407375707;10509.159267258678;10602.151827853753;10603.46982650872;10728.678139655824;1865.2352535460532;1953.7069439584034;1954.980450195494;1999.3602047344855;2012.8792272463552;83433;84421.57789211076;84428.57785711094;84450.57774711149;87249.56375218146;9186.40288381253;9405.388649737744;9486.430814151036;9628.277879159092;10652.254342195973;11852.76294474123;12614.936925315498;12664.74670506603;12669.176503527242;12813.423395947204;6201.56589038772;6331.4301712845145;6450.612963222222;7085.82285442868;7761.5731134787;7512.812179695551;7684.538927664358;7737.187595302525;7920.495105929855;8101.554414507141;3800.5819359870393;3850.4801851750217;3877.747946383476;3917.7257591968287;3935;1813.7460755493978;1850.9259629614935;1869.7943226245102;1933.2846846666823;1937.1379736017336;893.5710858787818;924.9445033298024;968.6464440479174;995.8854731705947;1059.8940105989338;19679.90160049219;20143.294984675467;20179.587428879837;20218.696719549218;20558.486037849172;995.3331268050424;1001.33911618333;1009.1472705563787;1024.800163968034;1057.5769692123213;10436;11150;11294.887051129548;11360.54557817678;11497.540098396137;488137;491752;498933;504274;507474;93299.53350233205;93412.56620005552;95824.52087739656;96397;97155;948.4546385828177;995.5569771451779;998.031909048222;1008.1581879130861;1008.2740426892625;16976.74534881953;17410.47768566945;17426.30294788245;17480.21339039721;17507.140770956034;40123.796286111465;43838.56161438345;44099.33850992302;44269.557304427835;44953.10093798171;52251.216231755796;58885.41114588799;61387.69306153441;61783;61909;8405.059762344583;8417.537035463109;8519.787005324917;8638.611262493328;8829.33779966518;9543.90456095458;13153.85841201535;13785.448582057006;13840.307984600931;13928.442862285396;11853.52585896589;11872.881271187523;11904.702382440508;12226.20529665569;12408.193467424588;11384.203105782515;11589.478473468545;11753.294802311888;11760.588379407021;12239.571614993432;12009.219400739274;12100.213486123374;12175.452104655134;12320;12435.253884766942;8505.914940850513;8688.609012594576;8707.259882910024;8742;8770.517621530622;11263.605773797877;12005.39973001329;12007;12211.450484728386;12460.439280232593 20:28:44 INFO - PROCESS | 8896 | |3;mootools.html;1456.6722487440325;1480.7334679757644;1568.1453607783756;1687.3588036546112;1701.5405840423077;7290.489665723401;7773.883391749128;7950.244726750964;8390.077091519928;8399.916000839998;8340.791480212998;8362.540060296682;8411.91588084119;8442.071372149074;8446.239838414542;2331.484535052217;2334.8365614407;2345.4253707841604;2351.5296940611947;2352.2943117064897;2289.5077558324956;2324.2910912171865;2324.418895276181;2331.6735657008035;2341.356127065054;2282.167009041696;2299.4596269876647;2308.6421604651305;2316.733575638806;2339.555484457956;2236.474428509299;2238.429200553848;2239.4065572623267;2251.2570851619007;2273.863568185914;2284.3147055883333;2292.415434064303;2294.4608017115966;2296.196331284054;2300.2409204962323;8100.878486822702;8155.632996515171;8192.689169732814;8193.139720329398;8254.133316001793;4852.951470485285;4917.483664215278;4933.383327084114;4938.678985865908;4951.925721114186;3201.9039428817173;3254.1864533866533;3385.9322813543836;3430.7255419566377;3431.742619303537;1073.8228192348254;1089.9073578745738;1112;1120.3613940054172;1130.5477808876433;10815.080718138888;10832.945835270773;10849.132069434427;10934.835977460345;10942.17933654979;4141.503019637663;4275.764832934156;4357.1939191249085;4453.821847126143;4477.417935668343;9297.953510232406;9303.25573954082;9311.255099592152;9313.580888860017;9316.301277404222;4887.486813884491;4918.827841025547;4954.40547134339;4960.23116416956;4968.329275547755;4192.958070419257;4498.2577874650315;4579.633629309647;4648.140094082605;4657.068586282757;3609.6751292383287;3714.7028237741456;3756.9060773480883;3773.3019391412677;3845.384738441836;1207.7765613361555;1216.3735676126803;1222.6515443098674;1232.0451649971344;1234.2224398628807;792.9167437419103;852.3564708644933;880.1198801198801;938.2400255792693;950.1496160935924;5586.944130558723;5638.19577735129;5668.489835914787;5697.914531282034;5860.941390586039;933.1042199488567;949.8480243161199;950.9381890177116;952.3048174832411;988.8665030220828;3802.7718336899875;3932.508436445444;4002.539707933625;4054.3715724062818;4094.447249621263;9803.754906127404;10218.18254539635;10252;10264.433891527118;10271.126954208827;10065.144462720751;10128.898711012796;10212.489375531342;10217.897821021843;10229.28395012342;7486.13909400415;7768.495047821986;7781.416393770377;8000.679972801023;8001.599920003977;5590.189422533791;5635.098384258499;5710.5717071219;5857.297124344936;5881.882362352643;9212.677556285498;9313.25493960495;9315.953420232856;9415.246780257427;9454.196393306645;9226.40028398152;9425.151736343762;9442.763930901783;9466.384684995453;9594.66418675343;6662.400383965466;7015.298470152944;7127.893081603884;7193.280671932765;7232.783016509513;7897.24976127267;7922.603869806602;7990.560519171501;7998.5600791957;8003.4797738146835;7100.644967751695;7131.42948564124;7253.1296244448895;7264.927350726425;7392.926070739224;6927.44580433554;6980.860382792417;6994.370506654425;7009.264027277062;7016.333448322605;6510.056041873996;6585.604863708193;6586.604803711793;6594.274629790815;6596.67016649156;4887.951120488749;4901.215805471107;4923.064617722621;4956.3804524434445;4981.651284410056;4894.070126675921;4986.800527978985;5012.974935125301;5057.69653820772;5086.160783470834 20:28:44 INFO - PROCESS | 8896 | |4;prototype.html;323.15494980625664;323.72483389119253;330.25856951144686;333.9181900434394;335.4967548676984;5480.3971563128025;5547.916781248285;5554.389017208104;5560;5564.387917329095;5448.673079615226;5465.863353416166;5467;5470.699111548864;5483.7806487740445;4059.5534491206017;4160.271952408317;4251;4277.422547956017;4299.914001719963;4288.742675439468;4289.806958686851;4296.505901821283;4304.397384366192;4322.502912165094;4277.25148099083;4277.465316835395;4294.570542945712;4309.59058889405;4324.481062272532;4079.837246384766;4240.575942405766;4289.906073951122;4297.505786834523;4307.913841723148;3779.6598306152305;3803.67668748154;3806.352920003606;3809.695224382043;3817.1220619257724;5342.2787923630585;5349.411564727877;5363.463653634644;5378.838634840961;5384.326959130109;4862.246351815475;4886.193778026622;4893.549095117407;4953.405591329064;4966.379202599675;5728.742206600713;5729;5729.5702822288495;5766.952731780199;5811.302643682743;4213.6839737019845;4214.662826973866;4217.430646862665;4223.324268117087;4228.492580890282;5828.9417105828825;5960.731767070492;5968.253968253968;5975.43233392827;6015.676551158738;4269.231538323132;4280.614744672995;4281.678874084456;4286.742795432284;4287.8070486828165;4343.348497725303;4373.540778218241;4384.539623339503;4385.758783266887;4385.802638881258;4660.300954856799;4916.213405855117;4948.554630083309;4965.4041515018425;4971.45314015458;5750.166225897305;5767.452092051249;5771.711414429262;5794.62334948227;5794.82615521535;1482.1996122094165;1497.5507347795617;1504.857038581333;1508.5775982724854;1516.924153792306;905.4341036851968;929.4330458420358;941.223490620241;988.3773222869689;1011.014261095426;5481.835544933579;5488.91766623501;5515.889682206413;5537.916931246034;5545.694986775686;5827.970860145672;5844.620099693507;5852.180694702745;5888.32182827892;5915.964706176402;5275.920861187085;5421.430749771296;5473.863153421196;5487.917681234785;5510.5316048135555;3106.580611617448;3130.1705048162257;3132.7963682360573;3143.355612099514;3148.7008734170217;5885.352611212763;6080.689338051512;6085.4523092921845;6095.725692343855;6108.75564977396;5933;5960.4635582797755;5967;5989.8203053908455;5993.550483713651;6087.726052327567;6089.786857459968;6101.206843110456;6128.4790792783115;6165.0543652062715;5732.484076433141;5755.597108202385;5846.239988801429;5850.94149058521;5867;5793.91309130355;5813.94186058134;5822.097574875901;5822.184894114912;5831.883362332815;5854.9121763174435;6068.332483426908;6112.663803490673;6138.907916381168;6191.597546159485;4112.814923328518;4135.503739551153;4139.778765264315;4142.855000074983;4161.708680392343;5769.3942136076785;5984.850378740566;6002.579819412774;6044.818655440344;6048.092786082123;5668.319801623831;5757.683327417032;5786.235198264401;5837.161294192316;5840.386759390203;5803.39064398249;5817.301923769175;5838.211841401357;5839.328477225174;5858.121281807763;5573.247611572386;5766.250387449605;5778.85552861165;5800.622959507618;5805.158252053513;5851.882962340815;5868.765249389977;5895.174675545512;5899.581171719575;5927.170196172626;5407.891842163056;5711.343195532567;5746.867956963549;5748.252727145445;5777 20:28:44 INFO - PROCESS | 8896 | |5;yui.html;728.9198188199297;745.2733584754861;799.7680672604941;823.5552801487197;854.4958474500046;15497.457588984375;17091;17207.3117075317;17225.82774172258;17235.569110772238;14303.213323267217;14308.427662893499;14321.57035288943;14334.354954027067;14394.352254148562;791.7980914866715;799.8680217764062;826.7933016745814;832.3008672714918;833.4332653795417;809.4253080312956;810.307187354812;810.4205493072452;810.4245985350408;811.4036183405193;845.7758693946109;848.3467729848013;848.5121055393142;848.8047749017729;850.8213275212182;838.2330167896367;838.9244967952914;846.2764336492272;846.9153084691512;847.0936098374741;612.7763366371242;614.241411856357;616.3312805605923;618.1685632823845;619.9194104766397;14571.271436428242;14583.520801463777;14602.342894569663;14623.926880365636;14638.048526845721;14746.70506589873;14930.402783888632;15206;15291.235438228156;15534.456294029767;11279.43602819864;11282.435878206057;11370.829437558443;11426.485808138654;11608.593699220572;3875.922481550353;3880.8835734927716;3883.990162557727;3914.5693973662874;3966.464527288808;82343;82398.58800706019;82794;83672.58163709204;84029;11508.769824603462;11551.537938482536;11575.13186511015;11674.182807203415;11700.473478693479;21215.575688486144;21397.358079257647;21506.677399839016;21572;21709.891450542964;8703.608337624823;8713.25937295337;8857.202851743374;8934.106589341143;8997.910020899839;4933.383327084114;5079.568236699848;5083.771230294646;5106.259592359087;5123.257127716461;3519.6128425873135;3617.330793803155;3619.638036196412;3622.166901612591;3640.7633503822167;576.5531712922518;581.7789240088824;584.2083976212172;587.538782056084;588.1266319515516;602.9125776762345;693.767587858063;723.5297056913049;737.7086051009821;762.7444805989944;9920.404775713336;10264.743381415376;10345.120664743581;10636.361818290927;10838.620648277272;692.51869950384;765.1353970013848;773.8993930788962;774.9535027898344;775.4726785785607;4862.41651001882;5104.055749686246;5140.820071297487;5157.793688252428;5167.638265321467;72499.63750181215;74148;119966;125231.3738431302;128070;102988.48505757423;103558.48220758847;103604;107534;109766;91784.36264192163;92094.53952730194;93352.53323733338;95562;96524.51737741266;9025.548722563977;9155.267578593563;9353.438793672402;9422.62309507612;9455.858162127712;43964;45735;53434.732826337175;54429;55071;70438.64780676064;70613;71229.6438517804;71366.28633713597;76123.61938190274;13826.861731382558;13915.02594818353;14004.579862604138;14195.148291102567;14429.855701443272;14736.547477432989;15155.545333639568;15993.440229592374;16066.678666426373;16689;14418.567442976728;14755.336009879367;14845.92577037108;15721.707252685621;15846.920765396098;11028.889711102785;13844.30778461093;13907.58277251684;14194.432222710975;14267.71464570682;12693.936530317289;12695.111342206326;12998.480060797463;13231.139975901535;13249.072564920363;10995.615153469591;11165.162612804235;11420.714482138013;11439.256448330832;11665.825012624988;11176.217664763388;11453.770924581628;11729.41352932367;11843.644690659294;11867.406629668654 20:28:44 INFO - PROCESS | 8896 | __end_tp_report 20:28:44 INFO - PROCESS | 8896 | __start_cc_report 20:28:44 INFO - PROCESS | 8896 | _x_x_mozilla_cycle_collect,324 20:28:44 INFO - PROCESS | 8896 | __end_cc_report 20:28:44 INFO - PROCESS | 8896 | __startTimestamp1471490924146__endTimestamp 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | ------- Summary: start ------- 20:28:44 INFO - PROCESS | 8896 | Number of tests: 6 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | [#0] dojo.html Cycles:165 Average:5327.17 Median:5505.28 stddev:591.85 (10.8%) stddev-sans-first:566.49 20:28:44 INFO - PROCESS | 8896 | Values: 3067.2 3085.4 3085.9 3094.8 3110.7 5320.0 5409.8 5413.4 5432.0 5448.8 5314.4 5351.3 5368.9 5384.2 5422.6 4878.9 4925.4 4964.9 4977.1 5058.8 4985.5 5000.8 5017.8 5055.3 5058.0 4817.9 4857.0 4882.1 4904.1 4905.9 4907.7 4924.3 4939.8 4940.1 4955.3 4861.1 4901.8 4914.0 4919.2 4925.5 5169.8 5274.8 5366.5 5373.5 5467.4 5727.9 5753.1 5761.5 5770.7 5810.8 5806.3 5814.9 5818.4 5818.5 5820.0 5293.3 5300.2 5322.2 5327.7 5396.0 5874.3 5879.9 5885.1 5896.3 5909.2 5578.9 5627.3 5633.6 5641.4 5651.6 5585.6 5686.6 5714.3 5716.4 5728.1 5572.1 5580.5 5601.0 5601.6 5605.9 5639.0 5668.2 5693.2 5693.3 5704.5 4343.0 4349.7 4394.7 4410.0 4456.4 3882.1 3950.3 3957.6 3972.5 3981.1 5481.6 5501.9 5505.3 5509.7 5516.2 5655.3 5676.3 5802.0 5806.2 5811.5 5389.5 5462.8 5464.0 5470.3 5503.1 4901.0 4908.7 4909.2 4913.6 4951.7 5802.0 5866.0 5948.7 5950.4 5955.9 5600.2 5643.8 5651.0 5724.0 5743.6 5911.3 5920.4 5922.1 5926.1 5950.8 5467.8 5531.8 5557.4 5611.1 5624.8 5692.7 5719.7 5725.8 5734.7 5841.6 5631.5 5642.9 5662.6 5673.9 5678.0 5457.0 5606.4 5613.7 5619.6 5622.6 5430.6 5477.1 5487.9 5490.8 5576.6 5535.5 5581.7 5581.7 5582.1 5587.9 5346.0 5436.1 5462.3 5477.0 5511.9 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | [#1] ext.html Cycles:180 Average:56979.83 Median:39933.60 stddev:114280.57 (286.2%) stddev-sans-first:114522.71 20:28:44 INFO - PROCESS | 8896 | Values: 582.4 585.6 587.1 589.8 597.2 39945.4 43941.6 44040.6 44062.6 44156.0 44021.8 44331.1 44618.6 44644.5 44650.8 8758.8 8901.7 8910.6 8944.6 8962.6 8768.3 8837.2 8841.0 8847.0 8869.0 8931.7 8942.4 8942.7 8984.1 8988.8 8818.3 8830.5 8867.5 8876.7 8917.0 8781.9 8817.5 8862.3 8887.8 8902.0 42177.8 42504.8 42572.4 42607.8 42645.0 2636.9 3432.6 3524.6 3543.4 4295.8 29382.7 31335.7 31355.0 31691.0 31780.5 3965.3 4067.4 4144.3 4145.6 4175.8 315495.0 316624.0 316654.0 316807.0 317113.8 34853.5 34948.8 35039.8 35074.6 35124.9 36638.3 37070.0 37474.6 38729.2 38852.8 15632.5 15744.9 15760.9 15788.6 15794.3 11817.9 11864.5 11865.8 11904.2 11915.3 18244.8 18660.3 18674.6 18689.3 18717.5 7002.6 7169.9 7180.3 7326.7 7380.6 945.3 995.0 1000.4 1014.3 1033.4 30598.4 31936.7 32098.1 32844.2 33533.5 1050.4 1095.4 1118.2 1130.5 1154.1 16028.4 16137.6 16393.5 16690.5 16746.4 557929.0 560852.0 562381.0 563014.0 563579.0 59697.7 60206.7 60287.4 60681.7 60724.0 1346.8 1368.8 1391.1 1401.7 1404.9 28964.9 30800.5 30971.7 31205.8 31731.0 49338.5 49514.0 49576.8 49719.8 49730.5 369549.0 372187.0 374782.0 375389.0 375871.0 28184.4 28398.4 28873.6 28905.4 29039.3 48257.5 48410.5 48461.5 48681.3 48864.8 38972.4 39250.8 39926.6 40582.0 42103.0 39940.6 40042.6 40685.2 41441.8 42114.0 42156.2 42283.4 42810.0 42999.0 45193.8 33844.8 36767.0 37566.2 37853.6 38160.2 28532.7 28597.1 28665.7 28778.6 28917.4 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | [#2] jquery.html Cycles:180 Average:29341.36 Median:2116.50 stddev:82288.37 (3887.9%) stddev-sans-first:82490.47 20:28:44 INFO - PROCESS | 8896 | Values: 374.4 380.1 382.5 392.2 399.9 14905.0 17692.5 18603.3 19920.0 20278.3 18272.0 19364.9 19415.5 19816.0 19854.7 5442.5 5636.9 5751.8 5764.1 5787.1 5617.0 5667.5 5719.8 5734.4 5779.9 5779.3 5886.8 5887.1 5938.5 5973.9 5852.3 5954.9 5980.4 6325.0 6415.5 5622.2 5662.1 5663.8 5668.5 5672.1 14835.6 21570.0 22855.3 22858.3 23324.4 2336.8 2446.2 2468.1 2860.3 2966.2 10102.6 10509.2 10602.2 10603.5 10728.7 1865.2 1953.7 1955.0 1999.4 2012.9 83433.0 84421.6 84428.6 84450.6 87249.6 9186.4 9405.4 9486.4 9628.3 10652.3 11852.8 12614.9 12664.7 12669.2 12813.4 6201.6 6331.4 6450.6 7085.8 7761.6 7512.8 7684.5 7737.2 7920.5 8101.6 3800.6 3850.5 3877.7 3917.7 3935.0 1813.7 1850.9 1869.8 1933.3 1937.1 893.6 924.9 968.6 995.9 1059.9 19679.9 20143.3 20179.6 20218.7 20558.5 995.3 1001.3 1009.1 1024.8 1057.6 10436.0 11150.0 11294.9 11360.5 11497.5 488137.0 491752.0 498933.0 504274.0 507474.0 93299.5 93412.6 95824.5 96397.0 97155.0 948.5 995.6 998.0 1008.2 1008.3 16976.7 17410.5 17426.3 17480.2 17507.1 40123.8 43838.6 44099.3 44269.6 44953.1 52251.2 58885.4 61387.7 61783.0 61909.0 8405.1 8417.5 8519.8 8638.6 8829.3 9543.9 13153.9 13785.4 13840.3 13928.4 11853.5 11872.9 11904.7 12226.2 12408.2 11384.2 11589.5 11753.3 11760.6 12239.6 12009.2 12100.2 12175.5 12320.0 12435.3 8505.9 8688.6 8707.3 8742.0 8770.5 11263.6 12005.4 12007.0 12211.5 12460.4 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | [#3] mootools.html Cycles:180 Average:5439.74 Median:4955.39 stddev:2985.15 (60.2%) stddev-sans-first:2978.52 20:28:44 INFO - PROCESS | 8896 | Values: 1456.7 1480.7 1568.1 1687.4 1701.5 7290.5 7773.9 7950.2 8390.1 8399.9 8340.8 8362.5 8411.9 8442.1 8446.2 2331.5 2334.8 2345.4 2351.5 2352.3 2289.5 2324.3 2324.4 2331.7 2341.4 2282.2 2299.5 2308.6 2316.7 2339.6 2236.5 2238.4 2239.4 2251.3 2273.9 2284.3 2292.4 2294.5 2296.2 2300.2 8100.9 8155.6 8192.7 8193.1 8254.1 4853.0 4917.5 4933.4 4938.7 4951.9 3201.9 3254.2 3385.9 3430.7 3431.7 1073.8 1089.9 1112.0 1120.4 1130.5 10815.1 10832.9 10849.1 10934.8 10942.2 4141.5 4275.8 4357.2 4453.8 4477.4 9298.0 9303.3 9311.3 9313.6 9316.3 4887.5 4918.8 4954.4 4960.2 4968.3 4193.0 4498.3 4579.6 4648.1 4657.1 3609.7 3714.7 3756.9 3773.3 3845.4 1207.8 1216.4 1222.7 1232.0 1234.2 792.9 852.4 880.1 938.2 950.1 5586.9 5638.2 5668.5 5697.9 5860.9 933.1 949.8 950.9 952.3 988.9 3802.8 3932.5 4002.5 4054.4 4094.4 9803.8 10218.2 10252.0 10264.4 10271.1 10065.1 10128.9 10212.5 10217.9 10229.3 7486.1 7768.5 7781.4 8000.7 8001.6 5590.2 5635.1 5710.6 5857.3 5881.9 9212.7 9313.3 9316.0 9415.2 9454.2 9226.4 9425.2 9442.8 9466.4 9594.7 6662.4 7015.3 7127.9 7193.3 7232.8 7897.2 7922.6 7990.6 7998.6 8003.5 7100.6 7131.4 7253.1 7264.9 7392.9 6927.4 6980.9 6994.4 7009.3 7016.3 6510.1 6585.6 6586.6 6594.3 6596.7 4888.0 4901.2 4923.1 4956.4 4981.7 4894.1 4986.8 5013.0 5057.7 5086.2 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | [#4] prototype.html Cycles:180 Average:4860.58 Median:5526.90 stddev:1427.28 (25.8%) stddev-sans-first:1390.05 20:28:44 INFO - PROCESS | 8896 | Values: 323.2 323.7 330.3 333.9 335.5 5480.4 5547.9 5554.4 5560.0 5564.4 5448.7 5465.9 5467.0 5470.7 5483.8 4059.6 4160.3 4251.0 4277.4 4299.9 4288.7 4289.8 4296.5 4304.4 4322.5 4277.3 4277.5 4294.6 4309.6 4324.5 4079.8 4240.6 4289.9 4297.5 4307.9 3779.7 3803.7 3806.4 3809.7 3817.1 5342.3 5349.4 5363.5 5378.8 5384.3 4862.2 4886.2 4893.5 4953.4 4966.4 5728.7 5729.0 5729.6 5767.0 5811.3 4213.7 4214.7 4217.4 4223.3 4228.5 5828.9 5960.7 5968.3 5975.4 6015.7 4269.2 4280.6 4281.7 4286.7 4287.8 4343.3 4373.5 4384.5 4385.8 4385.8 4660.3 4916.2 4948.6 4965.4 4971.5 5750.2 5767.5 5771.7 5794.6 5794.8 1482.2 1497.6 1504.9 1508.6 1516.9 905.4 929.4 941.2 988.4 1011.0 5481.8 5488.9 5515.9 5537.9 5545.7 5828.0 5844.6 5852.2 5888.3 5916.0 5275.9 5421.4 5473.9 5487.9 5510.5 3106.6 3130.2 3132.8 3143.4 3148.7 5885.4 6080.7 6085.5 6095.7 6108.8 5933.0 5960.5 5967.0 5989.8 5993.6 6087.7 6089.8 6101.2 6128.5 6165.1 5732.5 5755.6 5846.2 5850.9 5867.0 5793.9 5813.9 5822.1 5822.2 5831.9 5854.9 6068.3 6112.7 6138.9 6191.6 4112.8 4135.5 4139.8 4142.9 4161.7 5769.4 5984.9 6002.6 6044.8 6048.1 5668.3 5757.7 5786.2 5837.2 5840.4 5803.4 5817.3 5838.2 5839.3 5858.1 5573.2 5766.3 5778.9 5800.6 5805.2 5851.9 5868.8 5895.2 5899.6 5927.2 5407.9 5711.3 5746.9 5748.3 5777.0 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - PROCESS | 8896 | [#5] yui.html Cycles:180 Average:21153.31 Median:3940.52 stddev:30473.97 (773.3%) stddev-sans-first:30520.87 20:28:44 INFO - PROCESS | 8896 | Values: 728.9 745.3 799.8 823.6 854.5 15497.5 17091.0 17207.3 17225.8 17235.6 14303.2 14308.4 14321.6 14334.4 14394.4 791.8 799.9 826.8 832.3 833.4 809.4 810.3 810.4 810.4 811.4 845.8 848.3 848.5 848.8 850.8 838.2 838.9 846.3 846.9 847.1 612.8 614.2 616.3 618.2 619.9 14571.3 14583.5 14602.3 14623.9 14638.0 14746.7 14930.4 15206.0 15291.2 15534.5 11279.4 11282.4 11370.8 11426.5 11608.6 3875.9 3880.9 3884.0 3914.6 3966.5 82343.0 82398.6 82794.0 83672.6 84029.0 11508.8 11551.5 11575.1 11674.2 11700.5 21215.6 21397.4 21506.7 21572.0 21709.9 8703.6 8713.3 8857.2 8934.1 8997.9 4933.4 5079.6 5083.8 5106.3 5123.3 3519.6 3617.3 3619.6 3622.2 3640.8 576.6 581.8 584.2 587.5 588.1 602.9 693.8 723.5 737.7 762.7 9920.4 10264.7 10345.1 10636.4 10838.6 692.5 765.1 773.9 775.0 775.5 4862.4 5104.1 5140.8 5157.8 5167.6 72499.6 74148.0 119966.0 125231.4 128070.0 102988.5 103558.5 103604.0 107534.0 109766.0 91784.4 92094.5 93352.5 95562.0 96524.5 9025.5 9155.3 9353.4 9422.6 9455.9 43964.0 45735.0 53434.7 54429.0 55071.0 70438.6 70613.0 71229.6 71366.3 76123.6 13826.9 13915.0 14004.6 14195.1 14429.9 14736.5 15155.5 15993.4 16066.7 16689.0 14418.6 14755.3 14845.9 15721.7 15846.9 11028.9 13844.3 13907.6 14194.4 14267.7 12693.9 12695.1 12998.5 13231.1 13249.1 10995.6 11165.2 11420.7 11439.3 11665.8 11176.2 11453.8 11729.4 11843.6 11867.4 20:28:44 INFO - PROCESS | 8896 | -------- Summary: end -------- 20:28:44 INFO - PROCESS | 8896 | 20:28:44 INFO - TEST-INFO | 8896: exit 0 20:28:44 INFO - TEST-OK | dromaeo_css | took 1112183ms 20:28:44 INFO - TEST-START | kraken 20:28:44 INFO - operating with platform_type : linux_ 20:28:44 INFO - Initialising browser for kraken test... 20:28:44 INFO - TEST-INFO | started process 9254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLt9v4u/profile http://localhost:40462/getInfo.html) 20:28:49 INFO - PROCESS | 9254 | __metrics Screen width/height:1600/1200 20:28:49 INFO - PROCESS | 9254 | colorDepth:24 20:28:49 INFO - PROCESS | 9254 | Browser inner width/height: 1024/697 20:28:49 INFO - PROCESS | 9254 | __metrics 20:28:49 ERROR - PROCESS | 9254 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:28:50 INFO - TEST-INFO | 9254: exit 0 20:28:50 INFO - Browser initialized. 20:28:50 INFO - Running cycle 1/1 for kraken test... 20:28:50 INFO - TEST-INFO | started process 9373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLt9v4u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:02 INFO - PROCESS | 9373 | RSS: Main: 163090432 20:29:02 INFO - PROCESS | 9373 | 20:29:04 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:05 INFO - PROCESS | 9373 | RSS: Main: 168124416 20:29:05 INFO - PROCESS | 9373 | 20:29:08 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-dft) 20:29:08 INFO - PROCESS | 9373 | RSS: Main: 167227392 20:29:08 INFO - PROCESS | 9373 | 20:29:11 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-fft) 20:29:12 INFO - PROCESS | 9373 | RSS: Main: 163401728 20:29:12 INFO - PROCESS | 9373 | 20:29:14 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-oscillator) 20:29:15 INFO - PROCESS | 9373 | RSS: Main: 164216832 20:29:15 INFO - PROCESS | 9373 | 20:29:17 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:18 INFO - PROCESS | 9373 | RSS: Main: 164478976 20:29:18 INFO - PROCESS | 9373 | 20:29:21 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40462/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:21 INFO - PROCESS | 9373 | RSS: Main: 164876288 20:29:21 INFO - PROCESS | 9373 | 20:29:25 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40462/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:25 INFO - PROCESS | 9373 | RSS: Main: 162164736 20:29:25 INFO - PROCESS | 9373 | 20:29:28 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40462/tests/kraken/driver.html?testName=json-parse-financial) 20:29:29 INFO - PROCESS | 9373 | RSS: Main: 164012032 20:29:29 INFO - PROCESS | 9373 | 20:29:30 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:31 INFO - PROCESS | 9373 | RSS: Main: 164286464 20:29:31 INFO - PROCESS | 9373 | 20:29:33 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:34 INFO - PROCESS | 9373 | RSS: Main: 164298752 20:29:34 INFO - PROCESS | 9373 | 20:29:36 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:36 INFO - PROCESS | 9373 | RSS: Main: 164769792 20:29:36 INFO - PROCESS | 9373 | 20:29:39 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:40 INFO - PROCESS | 9373 | RSS: Main: 164802560 20:29:40 INFO - PROCESS | 9373 | 20:29:42 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:43 INFO - PROCESS | 9373 | RSS: Main: 165179392 20:29:43 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40462/tests/kraken/driver.html?testName=ai-astar) 20:29:45 INFO - PROCESS | 9373 | RSS: Main: 165961728 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | __start_tp_report 20:29:45 INFO - PROCESS | 9373 | _x_x_mozilla_page_load 20:29:45 INFO - PROCESS | 9373 | _x_x_mozilla_page_load_details 20:29:45 INFO - PROCESS | 9373 | |i|pagename|runs| 20:29:45 INFO - PROCESS | 9373 | |0;ai-astar;105;114;111;113;114;114;118;112;114;112 20:29:45 INFO - PROCESS | 9373 | |1;audio-beat-detection;146;119;148;190;122;147;154;123;183;125 20:29:45 INFO - PROCESS | 9373 | |2;audio-dft;162;164;160;161;165;176;163;162;163;162 20:29:45 INFO - PROCESS | 9373 | |3;audio-fft;75;75;74;193;83;75;76;78;172;76 20:29:45 INFO - PROCESS | 9373 | |4;audio-oscillator;85;85;147;87;86;86;151;87;86;141 20:29:45 INFO - PROCESS | 9373 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;117;117;118 20:29:45 INFO - PROCESS | 9373 | |6;imaging-darkroom;147;147;149;147;147;147;147;146;148;148 20:29:45 INFO - PROCESS | 9373 | |7;imaging-desaturate;97;96;95;95;96;98;96;96;96;96 20:29:45 INFO - PROCESS | 9373 | |8;json-parse-financial;51;51;55;54;53;55;58;55;52;57 20:29:45 INFO - PROCESS | 9373 | |9;json-stringify-tinderbox;62;63;63;63;64;62;63;63;64;64 20:29:45 INFO - PROCESS | 9373 | |10;stanford-crypto-aes;86;85;81;82;84;80;86;88;80;88 20:29:45 INFO - PROCESS | 9373 | |11;stanford-crypto-ccm;136;133;135;128;126;135;138;126;202;127 20:29:45 INFO - PROCESS | 9373 | |12;stanford-crypto-pbkdf2;175;164;161;163;162;164;164;167;166;163 20:29:45 INFO - PROCESS | 9373 | |13;stanford-crypto-sha256-iterative;67;66;67;66;65;64;70;67;66;65 20:29:45 INFO - PROCESS | 9373 | __end_tp_report 20:29:45 INFO - PROCESS | 9373 | __start_cc_report 20:29:45 INFO - PROCESS | 9373 | _x_x_mozilla_cycle_collect,886 20:29:45 INFO - PROCESS | 9373 | __end_cc_report 20:29:45 INFO - PROCESS | 9373 | __startTimestamp1471490985540__endTimestamp 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | ------- Summary: start ------- 20:29:45 INFO - PROCESS | 9373 | Number of tests: 14 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.30 (2.9%) stddev-sans-first:2.01 20:29:45 INFO - PROCESS | 9373 | Values: 105.0 114.0 111.0 113.0 114.0 114.0 118.0 112.0 114.0 112.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:147.50 stddev:25.05 (17.0%) stddev-sans-first:26.57 20:29:45 INFO - PROCESS | 9373 | Values: 146.0 119.0 148.0 190.0 122.0 147.0 154.0 123.0 183.0 125.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.52 (2.8%) stddev-sans-first:4.74 20:29:45 INFO - PROCESS | 9373 | Values: 162.0 164.0 160.0 161.0 165.0 176.0 163.0 162.0 163.0 162.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#3] audio-fft Cycles:10 Average:97.70 Median:75.50 stddev:45.04 (59.7%) stddev-sans-first:47.02 20:29:45 INFO - PROCESS | 9373 | Values: 75.0 75.0 74.0 193.0 83.0 75.0 76.0 78.0 172.0 76.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:86.00 stddev:29.25 (34.0%) stddev-sans-first:30.19 20:29:45 INFO - PROCESS | 9373 | Values: 85.0 85.0 147.0 87.0 86.0 86.0 151.0 87.0 86.0 141.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:29:45 INFO - PROCESS | 9373 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 20:29:45 INFO - PROCESS | 9373 | Values: 147.0 147.0 149.0 147.0 147.0 147.0 147.0 146.0 148.0 148.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 20:29:45 INFO - PROCESS | 9373 | Values: 97.0 96.0 95.0 95.0 96.0 98.0 96.0 96.0 96.0 96.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:2.38 (4.3%) stddev-sans-first:2.24 20:29:45 INFO - PROCESS | 9373 | Values: 51.0 51.0 55.0 54.0 53.0 55.0 58.0 55.0 52.0 57.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 20:29:45 INFO - PROCESS | 9373 | Values: 62.0 63.0 63.0 63.0 64.0 62.0 63.0 63.0 64.0 64.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:85.50 stddev:3.09 (3.6%) stddev-sans-first:3.19 20:29:45 INFO - PROCESS | 9373 | Values: 86.0 85.0 81.0 82.0 84.0 80.0 86.0 88.0 80.0 88.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:135.00 stddev:22.73 (16.8%) stddev-sans-first:24.09 20:29:45 INFO - PROCESS | 9373 | Values: 136.0 133.0 135.0 128.0 126.0 135.0 138.0 126.0 202.0 127.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:164.00 stddev:3.96 (2.4%) stddev-sans-first:1.86 20:29:45 INFO - PROCESS | 9373 | Values: 175.0 164.0 161.0 163.0 162.0 164.0 164.0 167.0 166.0 163.0 20:29:45 INFO - PROCESS | 9373 | 20:29:45 INFO - PROCESS | 9373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.64 (2.5%) stddev-sans-first:1.72 20:29:45 INFO - PROCESS | 9373 | Values: 67.0 66.0 67.0 66.0 65.0 64.0 70.0 67.0 66.0 65.0 20:29:45 INFO - PROCESS | 9373 | -------- Summary: end -------- 20:29:45 INFO - PROCESS | 9373 | 20:29:46 INFO - TEST-INFO | 9373: exit 0 20:29:46 INFO - TEST-OK | kraken | took 61616ms 20:29:46 INFO - SUITE-END | took 1173s 20:29:46 INFO - Completed test suite (00:19:33) 20:29:46 INFO - javascript benchmark 20:29:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7201.196889765704, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.1565319537126, 3085.3674996625696, 3085.9074227773167, 3094.798838075525, 3110.6889311068894, 5320.042392369372, 5409.8106566270135, 5413.43158968308, 5432.0, 5448.782048718056, 5314.415414304433, 5351.331083614548, 5368.892622147555, 5384.165454354572, 5422.620416570841, 4878.926636140043, 4925.3597032385915, 4964.87587810304, 4977.104121258172, 5058.7976480940715, 4985.501449855022, 5000.849974500771, 5017.84946451607, 5055.266986286986, 5058.013687330972, 4817.879553011167, 4857.0, 4882.096812089775, 4904.092742842586, 4905.901881962359, 4907.705537667715, 4924.335214745999, 4939.753012349368, 4940.086084074422, 4955.331030310898, 4861.076395484846, 4901.754912254373, 4914.017196560702, 4919.188333924898, 4925.482824303468, 5169.819056333048, 5274.815381461669, 5366.463353664602, 5373.489518495737, 5467.398586155519, 5727.914081288784, 5753.050746626802, 5761.452661997104, 5770.711464426804, 5810.796622118248, 5806.332271788714, 5814.854628634275, 5818.44724751148, 5818.5054270386645, 5820.0, 5293.338332708373, 5300.1519756838725, 5322.228276899867, 5327.706976116351, 5395.973020134914, 5874.295084589877, 5879.941200588025, 5885.117232415172, 5896.262967129109, 5909.202257695242, 5578.944210557924, 5627.296587926509, 5633.57748168889, 5641.379448260688, 5651.604387692904, 5585.58108141891, 5686.60193786431, 5714.342850572238, 5716.371199168088, 5728.140778883201, 5572.0527510323345, 5580.525655319262, 5601.047821870292, 5601.6358936668985, 5605.915911261334, 5639.041362968223, 5668.206451096849, 5693.17448969897, 5693.345265294462, 5704.543636509069, 4343.04453020335, 4349.652027837766, 4394.736315821061, 4409.9559004410185, 4456.398386217819, 3882.0877093882914, 3950.3481925482547, 3957.604239576077, 3972.463717398172, 3981.0843505993785, 5481.561475081984, 5501.889962200734, 5505.284313039359, 5509.724513774296, 5516.227728118067, 5655.349634792052, 5676.290463692038, 5802.0, 5806.2451881255165, 5811.476967072984, 5389.541888939484, 5462.754176062087, 5464.043792336325, 5470.288862447856, 5503.091989821714, 4900.975495122501, 4908.656394052382, 4909.165441874889, 4913.606911447076, 4951.702897826142, 5801.970990145022, 5865.970670146622, 5948.702564871825, 5950.375210602911, 5955.940440595626, 5600.159976003632, 5643.830685079454, 5651.039323315129, 5724.0, 5743.56923230751, 5911.261092363455, 5920.407959204045, 5922.082077278029, 5926.111083337534, 5950.821475355746, 5467.808626698046, 5531.778728850801, 5557.388687244481, 5611.074172761449, 5624.803131890364, 5692.743826527733, 5719.742611582572, 5725.828225153252, 5734.741936612946, 5841.561882858718, 5631.465010824129, 5642.943570564242, 5662.631928924607, 5673.914891276717, 5678.034734095131, 5456.972715136399, 5606.355269144101, 5613.719314034363, 5619.578531610064, 5622.606417550732, 5430.647007944471, 5477.123660214346, 5487.945120548743, 5490.780368785204, 5576.553875689854, 5535.474129957647, 5581.6930068846605, 5581.74882130297, 5582.106862901916, 5587.860303492283, 5346.0, 5436.0758671026815, 5462.317210348707, 5477.04151773446, 5511.889762204813], "value": 5287.674812892863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.4001278682957, 585.5725320516024, 587.0694948506617, 589.7523040323065, 597.1729155120157, 39945.4008189877, 43941.560584394145, 44040.55959440405, 44062.55937440625, 44156.0, 44021.77989110058, 44331.11337773243, 44618.55381446185, 44644.53554644534, 44650.77674611622, 8758.824823503526, 8901.73294801157, 8910.643574257021, 8944.597493112793, 8962.551872406386, 8768.298536117096, 8837.204651581356, 8841.0, 8847.0, 8868.955655221747, 8931.687390941319, 8942.418742781698, 8942.731718048437, 8984.10158984103, 8988.820223595525, 8818.250448711835, 8830.514321712304, 8867.512286824222, 8876.689315873946, 8917.0, 8781.912180878173, 8817.515036672981, 8862.335324850663, 8887.822243555158, 8901.955490222508, 42177.78911105455, 42504.78747606242, 42572.36141457881, 42607.78696106531, 42645.0, 2636.8549729764854, 3432.5537680101675, 3524.559430071241, 3543.3799085159994, 4295.78521073945, 29382.70617293821, 31335.686643133504, 31355.0, 31691.0, 31780.523292150636, 3965.345717956534, 4067.369557718529, 4144.295469770146, 4145.647619952308, 4175.812088456027, 315495.0, 316624.0, 316654.0, 316807.0, 317113.82886171073, 34853.477197841545, 34948.825255873555, 35039.82480087583, 35074.64925350765, 35124.892506449694, 36638.267234655155, 37070.0, 37474.625253747115, 38729.225415491535, 38852.80573597114, 15632.531024069296, 15744.92127539355, 15760.896737228284, 15788.60528486797, 15794.289256983464, 11817.940910295394, 11864.466099025565, 11865.762684746429, 11904.226225295328, 11915.344656044, 18244.817551824577, 18660.253589856526, 18674.626507470046, 18689.252429902925, 18717.532061698294, 7002.614856182959, 7169.89245161323, 7180.281971802778, 7326.743563975236, 7380.557166570023, 945.3146468810195, 995.00002497491, 1000.3997601439224, 1014.3102690170607, 1033.3644808442752, 30598.38803223923, 31936.68063319337, 32098.111169994812, 32844.17889552732, 33533.49699754506, 1050.3592808386877, 1095.39753135775, 1118.2451845004753, 1130.4856290387854, 1154.1286328821855, 16028.358865645478, 16137.59656008609, 16393.508194754177, 16690.48271054784, 16746.4138755143, 557929.0, 560852.0, 562381.0, 563014.0, 563579.0, 59697.672558585626, 60206.69896650576, 60287.39712602906, 60681.69659151676, 60724.0, 1346.777781666014, 1368.7604669182854, 1391.1027387335112, 1401.6706074072586, 1404.9438022478987, 28964.855175723987, 30800.53799193059, 30971.65081158312, 31205.843970780003, 31731.0, 49338.506614933394, 49514.0, 49576.752116239186, 49719.751401242764, 49730.502694974035, 369549.0, 372187.0, 374782.0, 375389.0, 375871.0, 28184.43631127325, 28398.43203135967, 28873.566896496148, 28905.42189156163, 29039.274018149714, 48257.5174248253, 48410.5158948406, 48461.5153848457, 48681.269780954026, 48864.75567622281, 38972.369370041306, 39250.80374598109, 39926.60073399229, 40582.0, 42103.0, 39940.60059399485, 40042.59957400505, 40685.186296273314, 41441.79279103585, 42114.0, 42156.15687686168, 42283.3657495144, 42810.0, 42999.0, 45193.77403112964, 33844.83077584596, 36767.0, 37566.248675026894, 37853.621463785006, 38160.23679526449, 28532.714672853836, 28597.14208573746, 28665.69684608354, 28778.568321475614, 28917.42165156727], "value": 19329.97251442334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.36589287758943, 380.1351924372053, 382.5294887288635, 392.18817048709184, 399.94600728901605, 14905.0, 17692.469225923225, 18603.255869765195, 19919.99999999998, 20278.29025984091, 18272.0, 19364.9031754841, 19415.51461213467, 19816.0, 19854.70217946732, 5442.455754424545, 5636.859078523029, 5751.7699292028265, 5764.106563482646, 5787.102999035135, 5617.0, 5667.489925906688, 5719.828405147852, 5734.397888221739, 5779.884402311951, 5779.2775903012125, 5886.793962211324, 5887.058070708687, 5938.524918006549, 5973.910391344133, 5852.268466441695, 5954.9281129396695, 5980.401959804007, 6325.0, 6415.518836087265, 5622.184783206453, 5662.122371032497, 5663.830085097413, 5668.489835914787, 5672.092465205588, 14835.554933352018, 21570.0, 22855.31434056981, 22858.314250572508, 23324.416889577726, 2336.7663233676494, 2446.2294377271282, 2468.0744720729726, 2860.313524754065, 2966.1842993176833, 10102.646407375707, 10509.159267258678, 10602.151827853753, 10603.46982650872, 10728.678139655824, 1865.2352535460532, 1953.7069439584034, 1954.980450195494, 1999.3602047344855, 2012.8792272463552, 83433.0, 84421.57789211076, 84428.57785711094, 84450.57774711149, 87249.56375218146, 9186.40288381253, 9405.388649737744, 9486.430814151036, 9628.277879159092, 10652.254342195973, 11852.76294474123, 12614.936925315498, 12664.74670506603, 12669.176503527242, 12813.423395947204, 6201.56589038772, 6331.4301712845145, 6450.612963222222, 7085.82285442868, 7761.5731134787, 7512.812179695551, 7684.538927664358, 7737.187595302525, 7920.495105929855, 8101.554414507141, 3800.5819359870393, 3850.4801851750217, 3877.747946383476, 3917.7257591968287, 3935.0, 1813.7460755493978, 1850.9259629614935, 1869.7943226245102, 1933.2846846666823, 1937.1379736017336, 893.5710858787818, 924.9445033298024, 968.6464440479174, 995.8854731705947, 1059.8940105989338, 19679.90160049219, 20143.294984675467, 20179.587428879837, 20218.696719549218, 20558.486037849172, 995.3331268050424, 1001.33911618333, 1009.1472705563787, 1024.800163968034, 1057.5769692123213, 10436.0, 11150.0, 11294.887051129548, 11360.54557817678, 11497.540098396137, 488137.0, 491752.0, 498933.0, 504274.0, 507474.0, 93299.53350233205, 93412.56620005552, 95824.52087739656, 96397.0, 97155.0, 948.4546385828177, 995.5569771451779, 998.031909048222, 1008.1581879130861, 1008.2740426892625, 16976.74534881953, 17410.47768566945, 17426.30294788245, 17480.21339039721, 17507.140770956034, 40123.796286111465, 43838.56161438345, 44099.33850992302, 44269.557304427835, 44953.10093798171, 52251.216231755796, 58885.41114588799, 61387.69306153441, 61783.0, 61909.0, 8405.059762344583, 8417.537035463109, 8519.787005324917, 8638.611262493328, 8829.33779966518, 9543.90456095458, 13153.85841201535, 13785.448582057006, 13840.307984600931, 13928.442862285396, 11853.52585896589, 11872.881271187523, 11904.702382440508, 12226.20529665569, 12408.193467424588, 11384.203105782515, 11589.478473468545, 11753.294802311888, 11760.588379407021, 12239.571614993432, 12009.219400739274, 12100.213486123374, 12175.452104655134, 12320.0, 12435.253884766942, 8505.914940850513, 8688.609012594576, 8707.259882910024, 8742.0, 8770.517621530622, 11263.605773797877, 12005.39973001329, 12007.0, 12211.450484728386, 12460.439280232593], "value": 9127.205374661946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.6722487440325, 1480.7334679757644, 1568.1453607783756, 1687.3588036546112, 1701.5405840423077, 7290.489665723401, 7773.883391749128, 7950.244726750964, 8390.077091519928, 8399.916000839998, 8340.791480212998, 8362.540060296682, 8411.91588084119, 8442.071372149074, 8446.239838414542, 2331.484535052217, 2334.8365614407, 2345.4253707841604, 2351.5296940611947, 2352.2943117064897, 2289.5077558324956, 2324.2910912171865, 2324.418895276181, 2331.6735657008035, 2341.356127065054, 2282.167009041696, 2299.4596269876647, 2308.6421604651305, 2316.733575638806, 2339.555484457956, 2236.474428509299, 2238.429200553848, 2239.4065572623267, 2251.2570851619007, 2273.863568185914, 2284.3147055883333, 2292.415434064303, 2294.4608017115966, 2296.196331284054, 2300.2409204962323, 8100.878486822702, 8155.632996515171, 8192.689169732814, 8193.139720329398, 8254.133316001793, 4852.951470485285, 4917.483664215278, 4933.383327084114, 4938.678985865908, 4951.925721114186, 3201.9039428817173, 3254.1864533866533, 3385.9322813543836, 3430.7255419566377, 3431.742619303537, 1073.8228192348254, 1089.9073578745738, 1112.0, 1120.3613940054172, 1130.5477808876433, 10815.080718138888, 10832.945835270773, 10849.132069434427, 10934.835977460345, 10942.17933654979, 4141.503019637663, 4275.764832934156, 4357.1939191249085, 4453.821847126143, 4477.417935668343, 9297.953510232406, 9303.25573954082, 9311.255099592152, 9313.580888860017, 9316.301277404222, 4887.486813884491, 4918.827841025547, 4954.40547134339, 4960.23116416956, 4968.329275547755, 4192.958070419257, 4498.2577874650315, 4579.633629309647, 4648.140094082605, 4657.068586282757, 3609.6751292383287, 3714.7028237741456, 3756.9060773480883, 3773.3019391412677, 3845.384738441836, 1207.7765613361555, 1216.3735676126803, 1222.6515443098674, 1232.0451649971344, 1234.2224398628807, 792.9167437419103, 852.3564708644933, 880.1198801198801, 938.2400255792693, 950.1496160935924, 5586.944130558723, 5638.19577735129, 5668.489835914787, 5697.914531282034, 5860.941390586039, 933.1042199488567, 949.8480243161199, 950.9381890177116, 952.3048174832411, 988.8665030220828, 3802.7718336899875, 3932.508436445444, 4002.539707933625, 4054.3715724062818, 4094.447249621263, 9803.754906127404, 10218.18254539635, 10252.0, 10264.433891527118, 10271.126954208827, 10065.144462720751, 10128.898711012796, 10212.489375531342, 10217.897821021843, 10229.28395012342, 7486.13909400415, 7768.495047821986, 7781.416393770377, 8000.679972801023, 8001.599920003977, 5590.189422533791, 5635.098384258499, 5710.5717071219, 5857.297124344936, 5881.882362352643, 9212.677556285498, 9313.25493960495, 9315.953420232856, 9415.246780257427, 9454.196393306645, 9226.40028398152, 9425.151736343762, 9442.763930901783, 9466.384684995453, 9594.66418675343, 6662.400383965466, 7015.298470152944, 7127.893081603884, 7193.280671932765, 7232.783016509513, 7897.24976127267, 7922.603869806602, 7990.560519171501, 7998.5600791957, 8003.4797738146835, 7100.644967751695, 7131.42948564124, 7253.1296244448895, 7264.927350726425, 7392.926070739224, 6927.44580433554, 6980.860382792417, 6994.370506654425, 7009.264027277062, 7016.333448322605, 6510.056041873996, 6585.604863708193, 6586.604803711793, 6594.274629790815, 6596.67016649156, 4887.951120488749, 4901.215805471107, 4923.064617722621, 4956.3804524434445, 4981.651284410056, 4894.070126675921, 4986.800527978985, 5012.974935125301, 5057.69653820772, 5086.160783470834], "value": 4413.764810921804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.15494980625664, 323.72483389119253, 330.25856951144686, 333.9181900434394, 335.4967548676984, 5480.3971563128025, 5547.916781248285, 5554.389017208104, 5560.0, 5564.387917329095, 5448.673079615226, 5465.863353416166, 5467.0, 5470.699111548864, 5483.7806487740445, 4059.5534491206017, 4160.271952408317, 4251.0, 4277.422547956017, 4299.914001719963, 4288.742675439468, 4289.806958686851, 4296.505901821283, 4304.397384366192, 4322.502912165094, 4277.25148099083, 4277.465316835395, 4294.570542945712, 4309.59058889405, 4324.481062272532, 4079.837246384766, 4240.575942405766, 4289.906073951122, 4297.505786834523, 4307.913841723148, 3779.6598306152305, 3803.67668748154, 3806.352920003606, 3809.695224382043, 3817.1220619257724, 5342.2787923630585, 5349.411564727877, 5363.463653634644, 5378.838634840961, 5384.326959130109, 4862.246351815475, 4886.193778026622, 4893.549095117407, 4953.405591329064, 4966.379202599675, 5728.742206600713, 5729.0, 5729.5702822288495, 5766.952731780199, 5811.302643682743, 4213.6839737019845, 4214.662826973866, 4217.430646862665, 4223.324268117087, 4228.492580890282, 5828.9417105828825, 5960.731767070492, 5968.253968253968, 5975.43233392827, 6015.676551158738, 4269.231538323132, 4280.614744672995, 4281.678874084456, 4286.742795432284, 4287.8070486828165, 4343.348497725303, 4373.540778218241, 4384.539623339503, 4385.758783266887, 4385.802638881258, 4660.300954856799, 4916.213405855117, 4948.554630083309, 4965.4041515018425, 4971.45314015458, 5750.166225897305, 5767.452092051249, 5771.711414429262, 5794.62334948227, 5794.82615521535, 1482.1996122094165, 1497.5507347795617, 1504.857038581333, 1508.5775982724854, 1516.924153792306, 905.4341036851968, 929.4330458420358, 941.223490620241, 988.3773222869689, 1011.014261095426, 5481.835544933579, 5488.91766623501, 5515.889682206413, 5537.916931246034, 5545.694986775686, 5827.970860145672, 5844.620099693507, 5852.180694702745, 5888.32182827892, 5915.964706176402, 5275.920861187085, 5421.430749771296, 5473.863153421196, 5487.917681234785, 5510.5316048135555, 3106.580611617448, 3130.1705048162257, 3132.7963682360573, 3143.355612099514, 3148.7008734170217, 5885.352611212763, 6080.689338051512, 6085.4523092921845, 6095.725692343855, 6108.75564977396, 5933.0, 5960.4635582797755, 5967.0, 5989.8203053908455, 5993.550483713651, 6087.726052327567, 6089.786857459968, 6101.206843110456, 6128.4790792783115, 6165.0543652062715, 5732.484076433141, 5755.597108202385, 5846.239988801429, 5850.94149058521, 5867.0, 5793.91309130355, 5813.94186058134, 5822.097574875901, 5822.184894114912, 5831.883362332815, 5854.9121763174435, 6068.332483426908, 6112.663803490673, 6138.907916381168, 6191.597546159485, 4112.814923328518, 4135.503739551153, 4139.778765264315, 4142.855000074983, 4161.708680392343, 5769.3942136076785, 5984.850378740566, 6002.579819412774, 6044.818655440344, 6048.092786082123, 5668.319801623831, 5757.683327417032, 5786.235198264401, 5837.161294192316, 5840.386759390203, 5803.39064398249, 5817.301923769175, 5838.211841401357, 5839.328477225174, 5858.121281807763, 5573.247611572386, 5766.250387449605, 5778.85552861165, 5800.622959507618, 5805.158252053513, 5851.882962340815, 5868.765249389977, 5895.174675545512, 5899.581171719575, 5927.170196172626, 5407.891842163056, 5711.343195532567, 5746.867956963549, 5748.252727145445, 5777.0], "value": 4399.03568625152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.9198188199297, 745.2733584754861, 799.7680672604941, 823.5552801487197, 854.4958474500046, 15497.457588984375, 17091.0, 17207.3117075317, 17225.82774172258, 17235.569110772238, 14303.213323267217, 14308.427662893499, 14321.57035288943, 14334.354954027067, 14394.352254148562, 791.7980914866715, 799.8680217764062, 826.7933016745814, 832.3008672714918, 833.4332653795417, 809.4253080312956, 810.307187354812, 810.4205493072452, 810.4245985350408, 811.4036183405193, 845.7758693946109, 848.3467729848013, 848.5121055393142, 848.8047749017729, 850.8213275212182, 838.2330167896367, 838.9244967952914, 846.2764336492272, 846.9153084691512, 847.0936098374741, 612.7763366371242, 614.241411856357, 616.3312805605923, 618.1685632823845, 619.9194104766397, 14571.271436428242, 14583.520801463777, 14602.342894569663, 14623.926880365636, 14638.048526845721, 14746.70506589873, 14930.402783888632, 15206.0, 15291.235438228156, 15534.456294029767, 11279.43602819864, 11282.435878206057, 11370.829437558443, 11426.485808138654, 11608.593699220572, 3875.922481550353, 3880.8835734927716, 3883.990162557727, 3914.5693973662874, 3966.464527288808, 82343.0, 82398.58800706019, 82794.0, 83672.58163709204, 84029.0, 11508.769824603462, 11551.537938482536, 11575.13186511015, 11674.182807203415, 11700.473478693479, 21215.575688486144, 21397.358079257647, 21506.677399839016, 21572.0, 21709.891450542964, 8703.608337624823, 8713.25937295337, 8857.202851743374, 8934.106589341143, 8997.910020899839, 4933.383327084114, 5079.568236699848, 5083.771230294646, 5106.259592359087, 5123.257127716461, 3519.6128425873135, 3617.330793803155, 3619.638036196412, 3622.166901612591, 3640.7633503822167, 576.5531712922518, 581.7789240088824, 584.2083976212172, 587.538782056084, 588.1266319515516, 602.9125776762345, 693.767587858063, 723.5297056913049, 737.7086051009821, 762.7444805989944, 9920.404775713336, 10264.743381415376, 10345.120664743581, 10636.361818290927, 10838.620648277272, 692.51869950384, 765.1353970013848, 773.8993930788962, 774.9535027898344, 775.4726785785607, 4862.41651001882, 5104.055749686246, 5140.820071297487, 5157.793688252428, 5167.638265321467, 72499.63750181215, 74148.0, 119966.0, 125231.3738431302, 128070.0, 102988.48505757423, 103558.48220758847, 103604.0, 107534.0, 109766.0, 91784.36264192163, 92094.53952730194, 93352.53323733338, 95562.0, 96524.51737741266, 9025.548722563977, 9155.267578593563, 9353.438793672402, 9422.62309507612, 9455.858162127712, 43964.0, 45735.0, 53434.732826337175, 54429.0, 55071.0, 70438.64780676064, 70613.0, 71229.6438517804, 71366.28633713597, 76123.61938190274, 13826.861731382558, 13915.02594818353, 14004.579862604138, 14195.148291102567, 14429.855701443272, 14736.547477432989, 15155.545333639568, 15993.440229592374, 16066.678666426373, 16689.0, 14418.567442976728, 14755.336009879367, 14845.92577037108, 15721.707252685621, 15846.920765396098, 11028.889711102785, 13844.30778461093, 13907.58277251684, 14194.432222710975, 14267.71464570682, 12693.936530317289, 12695.111342206326, 12998.480060797463, 13231.139975901535, 13249.072564920363, 10995.615153469591, 11165.162612804235, 11420.714482138013, 11439.256448330832, 11665.825012624988, 11176.217664763388, 11453.770924581628, 11729.41352932367, 11843.644690659294, 11867.406629668654], "value": 7698.104192299028, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 111.0, 113.0, 114.0, 114.0, 118.0, 112.0, 114.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 148.0, 190.0, 122.0, 147.0, 154.0, 123.0, 183.0, 125.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 160.0, 161.0, 165.0, 176.0, 163.0, 162.0, 163.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 193.0, 83.0, 75.0, 76.0, 78.0, 172.0, 76.0], "value": 97.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 87.0, 86.0, 86.0, 151.0, 87.0, 86.0, 141.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 55.0, 54.0, 53.0, 55.0, 58.0, 55.0, 52.0, 57.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 62.0, 63.0, 63.0, 64.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 81.0, 82.0, 84.0, 80.0, 86.0, 88.0, 80.0, 88.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 135.0, 128.0, 126.0, 135.0, 138.0, 126.0, 202.0, 127.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 164.0, 161.0, 163.0, 162.0, 164.0, 164.0, 167.0, 166.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 65.0, 64.0, 70.0, 67.0, 66.0, 65.0], "value": 66.3, "unit": "score"}]}]} 20:29:46 INFO - Return code: 0 20:29:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:29:46 ERROR - # TBPL SUCCESS # 20:29:46 INFO - Running post-action listener: _resource_record_post_action 20:29:46 INFO - [mozharness: 2016-08-18 03:29:46.825977Z] Finished run-tests step (success) 20:29:46 INFO - Running post-run listener: _resource_record_post_run 20:29:46 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 421089280; Read time: 24; Write time: 278712 20:29:46 INFO - TinderboxPrint: CPU usage
13.3% 20:29:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 20:29:46 INFO - TinderboxPrint: I/O write bytes / time
421,089,280 / 278,712 20:29:46 INFO - TinderboxPrint: CPU idle
8,236.6 (86.7%) 20:29:46 INFO - TinderboxPrint: CPU user
1,207.6 (12.7%) 20:29:46 INFO - TinderboxPrint: Swap in / out
0 / 0 20:29:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128675840; Read time: 0; Write time: 78332 20:29:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291127296; Read time: 12; Write time: 200348 20:29:47 INFO - Running post-run listener: _upload_blobber_files 20:29:47 INFO - Blob upload gear active. 20:29:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:47 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 20:29:47 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:47 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:47 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:29:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:48 INFO - (blobuploader) - INFO - Done attempting. 20:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:49 INFO - (blobuploader) - INFO - Done attempting. 20:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:53 INFO - (blobuploader) - INFO - Done attempting. 20:29:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:53 INFO - Return code: 0 20:29:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/586582cea9fbaf126c5299ed2e7b7f75d9c202a75378dbded70d9bbbc07bf61fc41b2ebe1fe4cd5c5f867df9867d039ff4e1956969dead24a8da0887f00f98ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68c715b98bfbbf97a3ce580fab567a76b0b62f70acf5ec0f3b6cad4cdb5da53b8cfd96df33c030f7c320a0ab9e968e1e1e340d00f1a0e1f043b46c1b82e154a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb25cea2f6953f4004fd7ef3f0e989a31c57175b41c729a069b4c851d7f94fb661083bd5289029a8d36987f89baf6bed268018ff6e4c88aced7331fb36d7441e"} 20:29:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:53 INFO - Contents: 20:29:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/586582cea9fbaf126c5299ed2e7b7f75d9c202a75378dbded70d9bbbc07bf61fc41b2ebe1fe4cd5c5f867df9867d039ff4e1956969dead24a8da0887f00f98ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68c715b98bfbbf97a3ce580fab567a76b0b62f70acf5ec0f3b6cad4cdb5da53b8cfd96df33c030f7c320a0ab9e968e1e1e340d00f1a0e1f043b46c1b82e154a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb25cea2f6953f4004fd7ef3f0e989a31c57175b41c729a069b4c851d7f94fb661083bd5289029a8d36987f89baf6bed268018ff6e4c88aced7331fb36d7441e"} 20:29:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:53 INFO - Copying logs to upload dir... 20:29:53 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.504809 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-17 20:29:53.773331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:53.777125) ========= 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=0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/586582cea9fbaf126c5299ed2e7b7f75d9c202a75378dbded70d9bbbc07bf61fc41b2ebe1fe4cd5c5f867df9867d039ff4e1956969dead24a8da0887f00f98ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68c715b98bfbbf97a3ce580fab567a76b0b62f70acf5ec0f3b6cad4cdb5da53b8cfd96df33c030f7c320a0ab9e968e1e1e340d00f1a0e1f043b46c1b82e154a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb25cea2f6953f4004fd7ef3f0e989a31c57175b41c729a069b4c851d7f94fb661083bd5289029a8d36987f89baf6bed268018ff6e4c88aced7331fb36d7441e"} build_url:https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/PysAcebgTIadNeKc1oKBxg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/586582cea9fbaf126c5299ed2e7b7f75d9c202a75378dbded70d9bbbc07bf61fc41b2ebe1fe4cd5c5f867df9867d039ff4e1956969dead24a8da0887f00f98ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68c715b98bfbbf97a3ce580fab567a76b0b62f70acf5ec0f3b6cad4cdb5da53b8cfd96df33c030f7c320a0ab9e968e1e1e340d00f1a0e1f043b46c1b82e154a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb25cea2f6953f4004fd7ef3f0e989a31c57175b41c729a069b4c851d7f94fb661083bd5289029a8d36987f89baf6bed268018ff6e4c88aced7331fb36d7441e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:53.802531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:53.802861) ========= 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=0333a256a5e4f052382dd180000001b1-1471489543.311892-2098266813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 20:29:53.888068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:29:53.888387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 20:29:53.888696) ========= ========= Total master_lag: 0.17 =========