builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1471551677.99 results: success (0) buildid: 20160818113003 builduid: 71118355ef194af19a1a20ed98ef8df5 revision: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:17.987500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:17.987943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:17.988246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:18.000179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:18.000447) ========= 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=836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 13:21:18-- 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% 50.3M=0s 2016-08-18 13:21:18 (50.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.419090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:18.431831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:18.432230) ========= 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=836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019959 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:18.482577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 13:21:18.482954) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 --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 dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 --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=836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 13:21:18,572 truncating revision to first 12 chars 2016-08-18 13:21:18,572 Setting DEBUG logging. 2016-08-18 13:21:18,572 attempt 1/10 2016-08-18 13:21:18,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dce857dd57e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 13:21:19,497 unpacking tar archive at: fx-team-dce857dd57e2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.212430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 13:21:19.710106) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:19.710459) ========= script_repo_revision: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:19.710853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:19.711135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 13:21:19.722543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-18 13:21:19.723097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:21:19 INFO - MultiFileLogger online at 20160818 13:21:19 in /builds/slave/test 13:21:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:21:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:21:19 INFO - {'append_to_log': False, 13:21:19 INFO - 'base_work_dir': '/builds/slave/test', 13:21:19 INFO - 'blob_upload_branch': 'Fx-Team', 13:21:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:21:19 INFO - 'branch': 'Fx-Team', 13:21:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:19 INFO - 'config_files': ('talos/linux_config.py',), 13:21:19 INFO - 'default_actions': ('clobber', 13:21:19 INFO - 'read-buildbot-config', 13:21:19 INFO - 'download-and-extract', 13:21:19 INFO - 'populate-webroot', 13:21:19 INFO - 'create-virtualenv', 13:21:19 INFO - 'install', 13:21:19 INFO - 'run-tests'), 13:21:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:19 INFO - 'download_minidump_stackwalk': True, 13:21:19 INFO - 'download_symbols': 'ondemand', 13:21:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:19 INFO - 'installer_path': 'installer.exe', 13:21:19 INFO - 'log_level': 'info', 13:21:19 INFO - 'log_name': 'talos', 13:21:19 INFO - 'log_to_console': True, 13:21:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:21:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:21:19 INFO - 'opt_config_files': (), 13:21:19 INFO - 'pip_index': False, 13:21:19 INFO - 'sps_profile': False, 13:21:19 INFO - 'sps_profile_interval': 0, 13:21:19 INFO - 'suite': 'dromaeojs', 13:21:19 INFO - 'system_bits': '32', 13:21:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:19 INFO - 'title': 'talos-linux64-ix-028', 13:21:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:19 INFO - 'use_talos_json': True, 13:21:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:21:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:19 INFO - 'work_dir': 'build'} 13:21:19 INFO - [mozharness: 2016-08-18 20:21:19.907123Z] Running clobber step. 13:21:19 INFO - Running pre-action listener: _resource_record_pre_action 13:21:19 INFO - Running main action method: clobber 13:21:19 INFO - rmtree: /builds/slave/test/build 13:21:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:21:20 INFO - Running post-action listener: _resource_record_post_action 13:21:20 INFO - [mozharness: 2016-08-18 20:21:20.360730Z] Finished clobber step (success) 13:21:20 INFO - [mozharness: 2016-08-18 20:21:20.360830Z] Running read-buildbot-config step. 13:21:20 INFO - Running pre-action listener: _resource_record_pre_action 13:21:20 INFO - Running main action method: read_buildbot_config 13:21:20 INFO - Using buildbot properties: 13:21:20 INFO - { 13:21:20 INFO - "project": "", 13:21:20 INFO - "product": "firefox", 13:21:20 INFO - "script_repo_revision": "production", 13:21:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:21:20 INFO - "repository": "", 13:21:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:21:20 INFO - "buildid": "20160818113003", 13:21:20 INFO - "pgo_build": "True", 13:21:20 INFO - "basedir": "/builds/slave/test", 13:21:20 INFO - "buildnumber": 372, 13:21:20 INFO - "slavename": "talos-linux64-ix-028", 13:21:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:21:20 INFO - "platform": "ubuntu64_hw", 13:21:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:21:20 INFO - "branch": "fx-team", 13:21:20 INFO - "repo_path": "integration/fx-team", 13:21:20 INFO - "revision": "dce857dd57e2d91ae4c6014cf21e93ef95e4dd36", 13:21:20 INFO - "stage_platform": "linux64-pgo", 13:21:20 INFO - "builduid": "71118355ef194af19a1a20ed98ef8df5", 13:21:20 INFO - "slavebuilddir": "test" 13:21:20 INFO - } 13:21:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:21:20 INFO - Running post-action listener: _resource_record_post_action 13:21:20 INFO - [mozharness: 2016-08-18 20:21:20.363254Z] Finished read-buildbot-config step (success) 13:21:20 INFO - [mozharness: 2016-08-18 20:21:20.363343Z] Running download-and-extract step. 13:21:20 INFO - Running pre-action listener: _resource_record_pre_action 13:21:20 INFO - Running main action method: download_and_extract 13:21:20 INFO - mkdir: /builds/slave/test/build/tests 13:21:20 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')]} 13:21:20 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:21:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:20 INFO - Downloaded 1361 bytes. 13:21:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:21:20 INFO - Using the following test package requirements: 13:21:20 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:20 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:21:20 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:21:20 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'jsshell-linux-x86_64.zip'], 13:21:20 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:21:20 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:20 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:21:20 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:21:20 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:21:20 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:20 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:21:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:21:20 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')]} 13:21:20 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:21:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:21 INFO - Downloaded 21905770 bytes. 13:21:21 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 13:21:26 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 13:21:26 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')]} 13:21:26 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:21:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:26 INFO - Downloaded 21905770 bytes. 13:21:26 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 13:21: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')]} 13:21:31 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:32 INFO - Downloaded 14413981 bytes. 13:21:32 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 13:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:32 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:21:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:21:33 INFO - Downloaded 59591696 bytes. 13:21:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:21:33 INFO - mkdir: /builds/slave/test/properties 13:21:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:21:33 INFO - Writing to file /builds/slave/test/properties/build_url 13:21:33 INFO - Contents: 13:21:33 INFO - build_url:https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:21:34 INFO - Running post-action listener: _resource_record_post_action 13:21:34 INFO - Running post-action listener: set_extra_try_arguments 13:21:34 INFO - [mozharness: 2016-08-18 20:21:34.486892Z] Finished download-and-extract step (success) 13:21:34 INFO - [mozharness: 2016-08-18 20:21:34.487117Z] Running populate-webroot step. 13:21:34 INFO - Running pre-action listener: _resource_record_pre_action 13:21:34 INFO - Running main action method: populate_webroot 13:21:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:21:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:21:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:21:34 INFO - '--tppagecycles', 13:21:34 INFO - '7'], 13:21:34 INFO - 'tests': ['tsvgm']}}, 13:21:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:21:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:21:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:21:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:21:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['damp', 'tps']}, 13:21:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'tests': ['damp', 'tps']}, 13:21:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['dromaeo_dom']}, 13:21:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:21:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['basic_compositor_video']}, 13:21:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:21:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['a11yr', 13:21:34 INFO - 'ts_paint', 13:21:34 INFO - 'tpaint', 13:21:34 INFO - 'sessionrestore', 13:21:34 INFO - 'sessionrestore_no_auto_restore', 13:21:34 INFO - 'tabpaint']}, 13:21:34 INFO - 'other-e10s': {'tests': ['a11yr', 13:21:34 INFO - 'ts_paint', 13:21:34 INFO - 'tpaint', 13:21:34 INFO - 'sessionrestore', 13:21:34 INFO - 'sessionrestore_no_auto_restore', 13:21:34 INFO - 'tabpaint']}, 13:21:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:21:34 INFO - 'ts_paint', 13:21:34 INFO - 'tpaint', 13:21:34 INFO - 'sessionrestore', 13:21:34 INFO - 'sessionrestore_no_auto_restore', 13:21:34 INFO - 'tabpaint']}, 13:21:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:21:34 INFO - 'ts_paint', 13:21:34 INFO - 'tpaint', 13:21:34 INFO - 'sessionrestore', 13:21:34 INFO - 'sessionrestore_no_auto_restore', 13:21:34 INFO - 'tabpaint']}, 13:21:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['a11yr', 13:21:34 INFO - 'ts_paint', 13:21:34 INFO - 'tpaint', 13:21:34 INFO - 'sessionrestore', 13:21:34 INFO - 'sessionrestore_no_auto_restore', 13:21:34 INFO - 'tabpaint']}, 13:21:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['a11yr', 13:21:34 INFO - 'ts_paint', 13:21:34 INFO - 'tpaint', 13:21:34 INFO - 'sessionrestore', 13:21:34 INFO - 'sessionrestore_no_auto_restore', 13:21:34 INFO - 'tabpaint']}, 13:21:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['tsvgx', 13:21:34 INFO - 'tsvgr_opacity', 13:21:34 INFO - 'tart', 13:21:34 INFO - 'tscrollx', 13:21:34 INFO - 'cart']}, 13:21:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:21:34 INFO - 'tsvgr_opacity', 13:21:34 INFO - 'tart', 13:21:34 INFO - 'tscrollx', 13:21:34 INFO - 'cart']}, 13:21:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'talos_options': ['--disable-e10s'], 13:21:34 INFO - 'tests': ['tp5o']}, 13:21:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'tests': ['tp5o']}, 13:21:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'talos_options': ['--disable-e10s', 13:21:34 INFO - '--xperf_path', 13:21:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:34 INFO - 'tests': ['tp5n']}, 13:21:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:34 INFO - 'talos_options': ['--xperf_path', 13:21:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:34 INFO - 'tests': ['tp5n']}}, 13:21:34 INFO - 'talos.zip': {'path': '', 13:21:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:21:34 INFO - Running post-action listener: _resource_record_post_action 13:21:34 INFO - [mozharness: 2016-08-18 20:21:34.508415Z] Finished populate-webroot step (success) 13:21:34 INFO - [mozharness: 2016-08-18 20:21:34.508508Z] Running create-virtualenv step. 13:21:34 INFO - Running pre-action listener: _resource_record_pre_action 13:21:34 INFO - Running main action method: create_virtualenv 13:21:34 INFO - Creating virtualenv /builds/slave/test/build/venv 13:21:34 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 13:21:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:21:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:21:34 INFO - Using real prefix '/usr' 13:21:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:21:35 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:37 INFO - Installing pip.................done. 13:21:37 INFO - Return code: 0 13:21:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:21:37 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')]} 13:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:37 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')]} 13:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:37 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:37 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 13:21:37 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 13:21:37 INFO - Using env: {'DISPLAY': ':0', 13:21:37 INFO - 'HOME': '/home/cltbld', 13:21:37 INFO - 'LANG': 'en_US.UTF-8', 13:21:37 INFO - 'LANGUAGE': 'en_US:en', 13:21:37 INFO - 'LOGNAME': 'cltbld', 13:21:37 INFO - 'MAIL': '/var/mail/cltbld', 13:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:37 INFO - 'MOZ_NO_REMOTE': '1', 13:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:37 INFO - 'NO_EM_RESTART': '1', 13:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:37 INFO - 'PWD': '/builds/slave/test', 13:21:37 INFO - 'SHELL': '/bin/bash', 13:21:37 INFO - 'SHLVL': '1', 13:21:37 INFO - 'TERM': 'linux', 13:21:37 INFO - 'TMOUT': '86400', 13:21:37 INFO - 'USER': 'cltbld', 13:21:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:37 INFO - '_': '/tools/buildbot/bin/python'} 13:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:37 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 13:21:37 INFO - Cleaning up... 13:21:37 INFO - Return code: 0 13:21:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:21:37 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')]} 13:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:37 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')]} 13:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:37 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:37 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 13:21:37 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 13:21:37 INFO - Using env: {'DISPLAY': ':0', 13:21:37 INFO - 'HOME': '/home/cltbld', 13:21:37 INFO - 'LANG': 'en_US.UTF-8', 13:21:37 INFO - 'LANGUAGE': 'en_US:en', 13:21:37 INFO - 'LOGNAME': 'cltbld', 13:21:37 INFO - 'MAIL': '/var/mail/cltbld', 13:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:37 INFO - 'MOZ_NO_REMOTE': '1', 13:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:37 INFO - 'NO_EM_RESTART': '1', 13:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:37 INFO - 'PWD': '/builds/slave/test', 13:21:37 INFO - 'SHELL': '/bin/bash', 13:21:37 INFO - 'SHLVL': '1', 13:21:37 INFO - 'TERM': 'linux', 13:21:37 INFO - 'TMOUT': '86400', 13:21:37 INFO - 'USER': 'cltbld', 13:21:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:37 INFO - '_': '/tools/buildbot/bin/python'} 13:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:37 INFO - Downloading/unpacking psutil>=3.1.1 13:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:39 INFO - Installing collected packages: psutil 13:21:39 INFO - Running setup.py install for psutil 13:21:39 INFO - building 'psutil._psutil_linux' extension 13:21:39 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 13:21:39 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 13:21:39 INFO - building 'psutil._psutil_posix' extension 13:21:39 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 13:21:39 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 13:21:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:39 INFO - Successfully installed psutil 13:21:39 INFO - Cleaning up... 13:21:40 INFO - Return code: 0 13:21:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:21:40 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')]} 13:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:40 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')]} 13:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:40 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:40 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 13:21:40 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 13:21:40 INFO - Using env: {'DISPLAY': ':0', 13:21:40 INFO - 'HOME': '/home/cltbld', 13:21:40 INFO - 'LANG': 'en_US.UTF-8', 13:21:40 INFO - 'LANGUAGE': 'en_US:en', 13:21:40 INFO - 'LOGNAME': 'cltbld', 13:21:40 INFO - 'MAIL': '/var/mail/cltbld', 13:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:40 INFO - 'MOZ_NO_REMOTE': '1', 13:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:40 INFO - 'NO_EM_RESTART': '1', 13:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:40 INFO - 'PWD': '/builds/slave/test', 13:21:40 INFO - 'SHELL': '/bin/bash', 13:21:40 INFO - 'SHLVL': '1', 13:21:40 INFO - 'TERM': 'linux', 13:21:40 INFO - 'TMOUT': '86400', 13:21:40 INFO - 'USER': 'cltbld', 13:21:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:40 INFO - '_': '/tools/buildbot/bin/python'} 13:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:21:42 INFO - Installing collected packages: mozsystemmonitor 13:21:42 INFO - Running setup.py install for mozsystemmonitor 13:21:42 INFO - Successfully installed mozsystemmonitor 13:21:42 INFO - Cleaning up... 13:21:42 INFO - Return code: 0 13:21:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:42 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:42 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 13:21:42 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 13:21:42 INFO - Using env: {'DISPLAY': ':0', 13:21:42 INFO - 'HOME': '/home/cltbld', 13:21:42 INFO - 'LANG': 'en_US.UTF-8', 13:21:42 INFO - 'LANGUAGE': 'en_US:en', 13:21:42 INFO - 'LOGNAME': 'cltbld', 13:21:42 INFO - 'MAIL': '/var/mail/cltbld', 13:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:42 INFO - 'MOZ_NO_REMOTE': '1', 13:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:42 INFO - 'NO_EM_RESTART': '1', 13:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:42 INFO - 'PWD': '/builds/slave/test', 13:21:42 INFO - 'SHELL': '/bin/bash', 13:21:42 INFO - 'SHLVL': '1', 13:21:42 INFO - 'TERM': 'linux', 13:21:42 INFO - 'TMOUT': '86400', 13:21:42 INFO - 'USER': 'cltbld', 13:21:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:42 INFO - '_': '/tools/buildbot/bin/python'} 13:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:42 INFO - Downloading/unpacking jsonschema==2.5.1 13:21:42 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 13:21:42 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 13:21:42 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 13:21:42 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 13:21:42 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 13:21:42 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 13:21:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:21:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:21: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 13:21: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 13:21: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 13:21: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 13:21: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 13:21: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 13:21:44 INFO - Downloading functools32-3.2.3-2.tar.gz 13:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:21:44 INFO - warning: no files found matching '*.txt' 13:21:44 INFO - no previously-included directories found matching 'build' 13:21:44 INFO - no previously-included directories found matching 'dist' 13:21:44 INFO - no previously-included directories found matching '.git*' 13:21:44 INFO - Installing collected packages: jsonschema, functools32 13:21:44 INFO - Running setup.py install for functools32 13:21:44 INFO - warning: no files found matching '*.txt' 13:21:44 INFO - no previously-included directories found matching 'build' 13:21:44 INFO - no previously-included directories found matching 'dist' 13:21:44 INFO - no previously-included directories found matching '.git*' 13:21:44 INFO - Successfully installed jsonschema functools32 13:21:44 INFO - Cleaning up... 13:21:44 INFO - Return code: 0 13:21:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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', '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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:21: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 functools32==3.2.3-2 13:21:44 INFO - Using env: {'DISPLAY': ':0', 13:21:44 INFO - 'HOME': '/home/cltbld', 13:21:44 INFO - 'LANG': 'en_US.UTF-8', 13:21:44 INFO - 'LANGUAGE': 'en_US:en', 13:21:44 INFO - 'LOGNAME': 'cltbld', 13:21:44 INFO - 'MAIL': '/var/mail/cltbld', 13:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:44 INFO - 'MOZ_NO_REMOTE': '1', 13:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:44 INFO - 'NO_EM_RESTART': '1', 13:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:44 INFO - 'PWD': '/builds/slave/test', 13:21:44 INFO - 'SHELL': '/bin/bash', 13:21:44 INFO - 'SHLVL': '1', 13:21:44 INFO - 'TERM': 'linux', 13:21:44 INFO - 'TMOUT': '86400', 13:21:44 INFO - 'USER': 'cltbld', 13:21:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:44 INFO - '_': '/tools/buildbot/bin/python'} 13:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:21:45 INFO - Cleaning up... 13:21:45 INFO - Return code: 0 13:21:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:21:45 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')]} 13:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:45 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')]} 13:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:45 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:45 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 13:21:45 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 13:21:45 INFO - Using env: {'DISPLAY': ':0', 13:21:45 INFO - 'HOME': '/home/cltbld', 13:21:45 INFO - 'LANG': 'en_US.UTF-8', 13:21:45 INFO - 'LANGUAGE': 'en_US:en', 13:21:45 INFO - 'LOGNAME': 'cltbld', 13:21:45 INFO - 'MAIL': '/var/mail/cltbld', 13:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:45 INFO - 'MOZ_NO_REMOTE': '1', 13:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:45 INFO - 'NO_EM_RESTART': '1', 13:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:45 INFO - 'PWD': '/builds/slave/test', 13:21:45 INFO - 'SHELL': '/bin/bash', 13:21:45 INFO - 'SHLVL': '1', 13:21:45 INFO - 'TERM': 'linux', 13:21:45 INFO - 'TMOUT': '86400', 13:21:45 INFO - 'USER': 'cltbld', 13:21:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:45 INFO - '_': '/tools/buildbot/bin/python'} 13:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:21:45 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 13:21:45 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 13:21:45 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 13:21:45 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 13:21:45 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 13:21:45 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 13:21:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:21:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:21:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:47 INFO - Downloading docopt-0.6.1.tar.gz 13:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:21:47 INFO - Installing collected packages: blobuploader, requests, docopt 13:21:47 INFO - Running setup.py install for blobuploader 13:21:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:21:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:21:48 INFO - Running setup.py install for requests 13:21:48 INFO - Running setup.py install for docopt 13:21:48 INFO - Successfully installed blobuploader requests docopt 13:21:48 INFO - Cleaning up... 13:21:48 INFO - Return code: 0 13:21:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:48 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')]} 13:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:48 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')]} 13:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:48 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:48 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 13:21:48 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 13:21:48 INFO - Using env: {'DISPLAY': ':0', 13:21:48 INFO - 'HOME': '/home/cltbld', 13:21:48 INFO - 'LANG': 'en_US.UTF-8', 13:21:48 INFO - 'LANGUAGE': 'en_US:en', 13:21:48 INFO - 'LOGNAME': 'cltbld', 13:21:48 INFO - 'MAIL': '/var/mail/cltbld', 13:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:48 INFO - 'MOZ_NO_REMOTE': '1', 13:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:48 INFO - 'NO_EM_RESTART': '1', 13:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:48 INFO - 'PWD': '/builds/slave/test', 13:21:48 INFO - 'SHELL': '/bin/bash', 13:21:48 INFO - 'SHLVL': '1', 13:21:48 INFO - 'TERM': 'linux', 13:21:48 INFO - 'TMOUT': '86400', 13:21:48 INFO - 'USER': 'cltbld', 13:21:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:48 INFO - '_': '/tools/buildbot/bin/python'} 13:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:48 INFO - Running setup.py (path:/tmp/pip-6DjRne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:48 INFO - Running setup.py (path:/tmp/pip-_GQzSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:48 INFO - Running setup.py (path:/tmp/pip-VDsYB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:49 INFO - Running setup.py (path:/tmp/pip-qeQx5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:49 INFO - Running setup.py (path:/tmp/pip-xT2Oa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:49 INFO - Running setup.py (path:/tmp/pip-_6D8N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:49 INFO - Running setup.py (path:/tmp/pip-68LjRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:49 INFO - Running setup.py (path:/tmp/pip-pZei77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:49 INFO - Running setup.py (path:/tmp/pip-WRAQqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:49 INFO - Running setup.py (path:/tmp/pip-TWwJny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:49 INFO - Running setup.py (path:/tmp/pip-93Mra_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:49 INFO - Running setup.py (path:/tmp/pip-kPqdac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:49 INFO - Running setup.py (path:/tmp/pip-bYQwWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:49 INFO - Running setup.py (path:/tmp/pip-5VThwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:49 INFO - Running setup.py (path:/tmp/pip-_PWHcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:49 INFO - Running setup.py (path:/tmp/pip-QWV0ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:49 INFO - Running setup.py (path:/tmp/pip-bAFfNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:21:50 INFO - Running setup.py install for manifestparser 13:21:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Running setup.py install for mozcrash 13:21:50 INFO - Running setup.py install for mozdebug 13:21:50 INFO - Running setup.py install for mozdevice 13:21:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Running setup.py install for mozfile 13:21:50 INFO - Running setup.py install for mozhttpd 13:21:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Running setup.py install for mozinfo 13:21:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Running setup.py install for mozInstall 13:21:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:21:50 INFO - Running setup.py install for mozleak 13:21:50 INFO - Running setup.py install for mozlog 13:21:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:21:51 INFO - Running setup.py install for moznetwork 13:21:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:21:51 INFO - Running setup.py install for mozprocess 13:21:51 INFO - Running setup.py install for mozprofile 13:21:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:21:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:21:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:21:51 INFO - Running setup.py install for mozrunner 13:21:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:21:51 INFO - Running setup.py install for mozscreenshot 13:21:51 INFO - Running setup.py install for moztest 13:21:51 INFO - Running setup.py install for mozversion 13:21:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:21:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:21:51 INFO - Cleaning up... 13:21:51 INFO - Return code: 0 13:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:51 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:51 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 13:21:51 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 13:21:51 INFO - Using env: {'DISPLAY': ':0', 13:21:51 INFO - 'HOME': '/home/cltbld', 13:21:51 INFO - 'LANG': 'en_US.UTF-8', 13:21:51 INFO - 'LANGUAGE': 'en_US:en', 13:21:51 INFO - 'LOGNAME': 'cltbld', 13:21:51 INFO - 'MAIL': '/var/mail/cltbld', 13:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:51 INFO - 'MOZ_NO_REMOTE': '1', 13:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:51 INFO - 'NO_EM_RESTART': '1', 13:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:51 INFO - 'PWD': '/builds/slave/test', 13:21:51 INFO - 'SHELL': '/bin/bash', 13:21:51 INFO - 'SHLVL': '1', 13:21:51 INFO - 'TERM': 'linux', 13:21:51 INFO - 'TMOUT': '86400', 13:21:51 INFO - 'USER': 'cltbld', 13:21:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:51 INFO - '_': '/tools/buildbot/bin/python'} 13:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:52 INFO - Running setup.py (path:/tmp/pip-npvPP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:52 INFO - Running setup.py (path:/tmp/pip-KApQQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:52 INFO - Running setup.py (path:/tmp/pip-1Xr6_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:52 INFO - Running setup.py (path:/tmp/pip-Af1W91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:52 INFO - Running setup.py (path:/tmp/pip-htOJfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:52 INFO - Running setup.py (path:/tmp/pip-1WCIyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:52 INFO - Running setup.py (path:/tmp/pip-IowhFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:52 INFO - Running setup.py (path:/tmp/pip-s3xU5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:52 INFO - Running setup.py (path:/tmp/pip-BwKTDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:52 INFO - Running setup.py (path:/tmp/pip-Zfg31g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:52 INFO - Running setup.py (path:/tmp/pip-5VdWO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:52 INFO - Running setup.py (path:/tmp/pip-v5O_0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:52 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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:52 INFO - Running setup.py (path:/tmp/pip-4kBtM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21: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)) 13:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:52 INFO - Running setup.py (path:/tmp/pip-_zzEFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:53 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)) 13:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:53 INFO - Running setup.py (path:/tmp/pip-xgQDix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:53 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)) 13:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:53 INFO - Running setup.py (path:/tmp/pip-EFuYue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:53 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)) 13:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:53 INFO - Running setup.py (path:/tmp/pip-Tfd6lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:53 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)) 13:21:53 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)) 13:21:53 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)) 13:21:53 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)) 13:21:53 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)) 13:21:53 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)) 13:21:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:55 INFO - Downloading blessings-1.6.tar.gz 13:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:21:55 INFO - Installing collected packages: blessings 13:21:55 INFO - Running setup.py install for blessings 13:21:55 INFO - Successfully installed blessings 13:21:55 INFO - Cleaning up... 13:21:55 INFO - Return code: 0 13:21:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:55 INFO - Reading from file tmpfile_stdout 13:21:55 INFO - Current package versions: 13:21:55 INFO - argparse == 1.2.1 13:21:55 INFO - blessings == 1.6 13:21:55 INFO - blobuploader == 1.2.4 13:21:55 INFO - docopt == 0.6.1 13:21:55 INFO - functools32 == 3.2.3-2 13:21:55 INFO - jsonschema == 2.5.1 13:21:55 INFO - manifestparser == 1.1 13:21:55 INFO - mozInstall == 1.12 13:21:55 INFO - mozcrash == 0.17 13:21:55 INFO - mozdebug == 0.1 13:21:55 INFO - mozdevice == 0.48 13:21:55 INFO - mozfile == 1.2 13:21:55 INFO - mozhttpd == 0.7 13:21:55 INFO - mozinfo == 0.9 13:21:55 INFO - mozleak == 0.1 13:21:55 INFO - mozlog == 3.3 13:21:55 INFO - moznetwork == 0.27 13:21:55 INFO - mozprocess == 0.23 13:21:55 INFO - mozprofile == 0.28 13:21:55 INFO - mozrunner == 6.12 13:21:55 INFO - mozscreenshot == 0.1 13:21:55 INFO - mozsystemmonitor == 0.3 13:21:55 INFO - moztest == 0.7 13:21:55 INFO - mozversion == 1.4 13:21:55 INFO - psutil == 3.1.1 13:21:55 INFO - requests == 1.2.3 13:21:55 INFO - wsgiref == 0.1.2 13:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:55 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')]} 13:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:55 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')]} 13:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:55 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:55 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 13:21:55 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 13:21:55 INFO - Using env: {'DISPLAY': ':0', 13:21:55 INFO - 'HOME': '/home/cltbld', 13:21:55 INFO - 'LANG': 'en_US.UTF-8', 13:21:55 INFO - 'LANGUAGE': 'en_US:en', 13:21:55 INFO - 'LOGNAME': 'cltbld', 13:21:55 INFO - 'MAIL': '/var/mail/cltbld', 13:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:55 INFO - 'MOZ_NO_REMOTE': '1', 13:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:55 INFO - 'NO_EM_RESTART': '1', 13:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:55 INFO - 'PWD': '/builds/slave/test', 13:21:55 INFO - 'SHELL': '/bin/bash', 13:21:55 INFO - 'SHLVL': '1', 13:21:55 INFO - 'TERM': 'linux', 13:21:55 INFO - 'TMOUT': '86400', 13:21:55 INFO - 'USER': 'cltbld', 13:21:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:55 INFO - '_': '/tools/buildbot/bin/python'} 13:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 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)) 13:21:55 INFO - Cleaning up... 13:21:55 INFO - Return code: 0 13:21:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:21:55 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')]} 13:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:55 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')]} 13:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:55 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 0x7f00fa9bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, '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': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', '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 13:21:55 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 13:21:55 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 13:21:55 INFO - Using env: {'DISPLAY': ':0', 13:21:55 INFO - 'HOME': '/home/cltbld', 13:21:55 INFO - 'LANG': 'en_US.UTF-8', 13:21:55 INFO - 'LANGUAGE': 'en_US:en', 13:21:55 INFO - 'LOGNAME': 'cltbld', 13:21:55 INFO - 'MAIL': '/var/mail/cltbld', 13:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:55 INFO - 'MOZ_NO_REMOTE': '1', 13:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:55 INFO - 'NO_EM_RESTART': '1', 13:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:55 INFO - 'PWD': '/builds/slave/test', 13:21:55 INFO - 'SHELL': '/bin/bash', 13:21:55 INFO - 'SHLVL': '1', 13:21:55 INFO - 'TERM': 'linux', 13:21:55 INFO - 'TMOUT': '86400', 13:21:55 INFO - 'USER': 'cltbld', 13:21:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:55 INFO - '_': '/tools/buildbot/bin/python'} 13:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:21:56 INFO - Cleaning up... 13:21:56 INFO - Return code: 0 13:21:56 INFO - Running post-action listener: _resource_record_post_action 13:21:56 INFO - Running post-action listener: _start_resource_monitoring 13:21:56 INFO - Starting resource monitoring. 13:21:56 INFO - [mozharness: 2016-08-18 20:21:56.088460Z] Finished create-virtualenv step (success) 13:21:56 INFO - [mozharness: 2016-08-18 20:21:56.088912Z] Running install step. 13:21:56 INFO - Running pre-action listener: _resource_record_pre_action 13:21:56 INFO - Running main action method: install 13:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:56 INFO - Reading from file tmpfile_stdout 13:21:56 INFO - Detecting whether we're running mozinstall >=1.0... 13:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:21:56 INFO - Reading from file tmpfile_stdout 13:21:56 INFO - Output received: 13:21:56 INFO - Usage: mozinstall [options] installer 13:21:56 INFO - Options: 13:21:56 INFO - -h, --help show this help message and exit 13:21:56 INFO - -d DEST, --destination=DEST 13:21:56 INFO - Directory to install application into. [default: 13:21:56 INFO - "/builds/slave/test"] 13:21:56 INFO - --app=APP Application being installed. [default: firefox] 13:21:56 INFO - mkdir: /builds/slave/test/build/application 13:21:56 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'] 13:21:56 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 13:22:13 INFO - Reading from file tmpfile_stdout 13:22:13 INFO - Output received: 13:22:13 INFO - /builds/slave/test/build/application/firefox/firefox 13:22:13 INFO - Running post-action listener: _resource_record_post_action 13:22:13 INFO - [mozharness: 2016-08-18 20:22:13.332643Z] Finished install step (success) 13:22:13 INFO - [mozharness: 2016-08-18 20:22:13.332886Z] Running run-tests step. 13:22:13 INFO - Running pre-action listener: _resource_record_pre_action 13:22:13 INFO - Running main action method: run_tests 13:22:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:22:13 INFO - Python 2.7.3 13:22:13 INFO - Return code: 0 13:22:13 INFO - grabbing minidump binary from tooltool 13:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:13 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 0x1661370>, '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 0x16648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1664d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:22:13 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 13:22:13 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 13:22:13 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 13:22:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:22:13 INFO - Return code: 0 13:22:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:22:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:22:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:22:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:22:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:22:13 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:22:13 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:22:13 INFO - Using env: {'DISPLAY': ':0', 13:22:13 INFO - 'HOME': '/home/cltbld', 13:22:13 INFO - 'LANG': 'en_US.UTF-8', 13:22:13 INFO - 'LANGUAGE': 'en_US:en', 13:22:13 INFO - 'LOGNAME': 'cltbld', 13:22:13 INFO - 'MAIL': '/var/mail/cltbld', 13:22:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:22:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:13 INFO - 'MOZ_NO_REMOTE': '1', 13:22:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:13 INFO - 'NO_EM_RESTART': '1', 13:22:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:13 INFO - 'PWD': '/builds/slave/test', 13:22:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:22:13 INFO - 'SHELL': '/bin/bash', 13:22:13 INFO - 'SHLVL': '1', 13:22:13 INFO - 'TERM': 'linux', 13:22:13 INFO - 'TMOUT': '86400', 13:22:13 INFO - 'USER': 'cltbld', 13:22:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932', 13:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:13 INFO - '_': '/tools/buildbot/bin/python'} 13:22:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:22:13 INFO - mozversion application_buildid: 20160818113003 13:22:13 INFO - mozversion application_changeset: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 13:22:13 INFO - mozversion application_display_name: Nightly 13:22:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:22:13 INFO - mozversion application_name: Firefox 13:22:13 INFO - mozversion application_remotingname: firefox 13:22:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:22:13 INFO - mozversion application_vendor: Mozilla 13:22:13 INFO - mozversion application_version: 51.0a1 13:22:13 INFO - mozversion platform_buildid: 20160818113003 13:22:13 INFO - mozversion platform_changeset: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 13:22:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:22:13 INFO - mozversion platform_version: 51.0a1 13:22:13 INFO - using testdate: 1471551733 13:22:13 INFO - actual date: 1471551733 13:22:13 INFO - starting webserver on 'localhost:44137' 13:22:13 INFO - SUITE-START | Running 2 tests 13:22:13 INFO - TEST-START | dromaeo_css 13:22:13 INFO - operating with platform_type : linux_ 13:22:13 INFO - Initialising browser for dromaeo_css test... 13:22:13 INFO - TEST-INFO | started process 10386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX_uTAF/profile http://localhost:44137/getInfo.html) 13:22:17 INFO - PROCESS | 10386 | __metrics Screen width/height:1600/1200 13:22:17 INFO - PROCESS | 10386 | colorDepth:24 13:22:17 INFO - PROCESS | 10386 | Browser inner width/height: 1024/697 13:22:17 INFO - PROCESS | 10386 | __metrics 13:22:18 INFO - PROCESS | 10386 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:22:18 INFO - PROCESS | 10386 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:18 INFO - PROCESS | 10386 | console.error: PushService: 13:22:18 INFO - PROCESS | 10386 | stateChangeProcessEnqueue: Error transitioning state 13:22:18 INFO - PROCESS | 10386 | UnknownError 13:22:19 INFO - TEST-INFO | 10386: exit 0 13:22:19 INFO - Browser initialized. 13:22:19 INFO - Running cycle 1/1 for dromaeo_css test... 13:22:19 INFO - TEST-INFO | started process 10468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX_uTAF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:31 INFO - PROCESS | 10468 | RSS: Main: 155770880 13:22:31 INFO - PROCESS | 10468 | 13:23:22 INFO - PROCESS | 10468 | 1471551802907 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] 13:25:32 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44137/tests/dromaeo/cssquery-ext.html) 13:25:33 INFO - PROCESS | 10468 | RSS: Main: 272216064 13:25:33 INFO - PROCESS | 10468 | 13:28:35 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-ext.html (next: http://localhost:44137/tests/dromaeo/cssquery-jquery.html) 13:28:36 INFO - PROCESS | 10468 | RSS: Main: 241385472 13:28:36 INFO - PROCESS | 10468 | 13:31:38 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44137/tests/dromaeo/cssquery-mootools.html) 13:31:39 INFO - PROCESS | 10468 | RSS: Main: 185745408 13:31:39 INFO - PROCESS | 10468 | 13:34:41 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44137/tests/dromaeo/cssquery-prototype.html) 13:34:41 INFO - PROCESS | 10468 | RSS: Main: 186855424 13:34:41 INFO - PROCESS | 10468 | 13:37:44 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44137/tests/dromaeo/cssquery-yui.html) 13:37:45 INFO - PROCESS | 10468 | RSS: Main: 187543552 13:37:45 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:44137/tests/dromaeo/cssquery-yui.html (next: http://localhost:44137/tests/dromaeo/cssquery-dojo.html) 13:40:48 INFO - PROCESS | 10468 | RSS: Main: 277495808 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | __start_tp_report 13:40:48 INFO - PROCESS | 10468 | _x_x_mozilla_page_load 13:40:48 INFO - PROCESS | 10468 | _x_x_mozilla_page_load_details 13:40:48 INFO - PROCESS | 10468 | |i|pagename|runs| 13:40:48 INFO - PROCESS | 10468 | |0;dojo.html;3017;3038;3056.0831750474854;3062.5712400263983;3067.3865226954613;5237.580993520519;5317.388500322464;5321.733913304334;5415.350157981043;5459.754311056007;5284.392294886089;5291.28567643368;5343.679379237248;5347.518723314891;5393.865153371158;4757;4820.493848145929;4828.56542911138;4846.539578740032;4995.700257984533;4902.730349830758;4924.113659541281;4960.553550180483;4964.106460837066;4964.726940018298;4728.858134255944;4763.642726795487;4801.903961920777;4807.158747219258;4893.168161412551;4817.205161148407;4822.927656085161;4843.07981483517;4863.440704318978;4909.386326709161;4841.394825646794;4863.562279394871;4882.609391248691;4905.337779399807;4927.211646136601;5174.61190410717;5207.218917162418;5259.316288882459;5390.973045134789;5446;5593.52455041322;5637.605367624268;5685.687287199203;5685.834403947181;5694.202811606378;5737.512311453532;5742.770289188427;5743.827685169452;5761.020626493464;5761.625494342854;5166.328377310963;5287.048331300402;5313.760880760375;5339.332583427072;5365.03429382711;5918.23063001807;5935.1987481690285;5938.168656388109;5938.435848594377;5947.018741907536;5688.288963879515;5702.315722113373;5704.942950570441;5706.457886500776;5707.600467967202;5545.140503222007;5669.716514174357;5705.686187259657;5717.514011309002;5772.105323674838;5749.683767392834;5753.05074662676;5753.568482363839;5755;5781.884362312814;5663;5745.109508026263;5751.798687045934;5762.827115186551;5764.164196191613;4268.039691069484;4352.39066530686;4358.280883654162;4386.912261754747;4389.056352884145;3957.248122856648;3966.484357033567;3980.1840622672285;3980.641742243154;3981.3231750602467;5308.203769434538;5367.329083864517;5412.269343638637;5412.702301373462;5416.512513873691;5764.74058667361;5780.653160810365;5799.33307669615;5819.5053420459735;5831.329397119385;5355.0896347621;5390.784368625211;5391.676499409969;5394.8921021579345;5397.001554712312;4824.8793780155775;4857.732824694675;4904.60763138948;4907.656464047483;4960.305557221992;5905.143754155623;5968.343482216953;6001.789937352259;6004.279486461653;6030;5734.569907257056;5757.222774925332;5782.855428614318;5783.421657834183;5808.448197421239;5679.37526872052;5943.910841337297;5959.344472108151;5970.223870896755;5974.701264936649;5612.7754889803955;5628.662280263197;5640.88718225625;5725.627834190765;5758.654480731169;5770.451807078321;5771.1920331154515;5799.420057994167;5801.8549536261935;5810.883782324415;5446.509814116748;5620;5642.971785141048;5660.150977353265;5660.801871934463;5506.834794956158;5520.613557051129;5550.27846379968;5617.775288988395;5660.20757093999;5499.312585926759;5519;5539.944600553943;5543.528800051879;5549.139883318092;5432.375276843213;5639.887202256014;5666.178404131296;5685.857853553694;5708.4862362387585;5344.11822049373;5382.085045542189;5400.83797486076;5413.431589683184;5440.455954404528 13:40:48 INFO - PROCESS | 10468 | |1;ext.html;570.9058005429105;592.5200587524105;598.1416667082736;609.8414412252813;621.7606221604682;31483.527747083812;34536.65463345366;34553.82723086384;34618.96143115708;34647.480287795704;43160.784196079054;44391.33412998808;44479.33281000779;48942;48951.51048489514;8878.866816997734;9009.144131307516;9017.54912254388;9018;9020;8875.023747387782;8967.192952634261;8967.641294348217;8970.730878073668;8973.46159230445;9006.144416280476;9033.09669033098;9035.59339829706;9040.819183616324;9054.185123338932;8917.464952102862;8942.508162051085;8958.193762561368;8961;8963.14850089247;8877.156670116394;8892.555372231427;8933.642654293886;8938.508382038985;8943.10568943107;42828.785856070834;43131;43170.56829431728;43212.783936080436;43213;3588.551431071116;3710.350688629479;3733.4586484959527;3738.102855314732;3755.9812200939095;31946;32265.51601725976;32329;32500.512492312635;32583.185420364443;4413.757243351614;4422.601965823059;4429.667774916894;4443.37792709021;4497.730136191806;334581.99999999756;337429;337440;338159;338746;57756.26731198071;57943.420565794644;58169.41830581725;58357.416425835196;58369.41630583725;60711.39288607146;61082.38917610767;61160;61202;61222.20444728822;14873.479428220176;16139.838601614068;16442.260098295606;16481.34074637025;16945.237464314134;12888.80666789999;12938.870611293954;12960.675983100498;13000.544980925622;13009.804852927213;16450.012999220085;16518.917405413136;16538.917305413637;16553.83446165547;16713.582160446087;4917.254374697002;5788.942110578924;6025.276966764016;6069.51443884497;6130.601510901866;929.0198840223629;1006.6476733143488;1028.6708253359002;1031.4430207687915;1097.1716354152722;32838.8358058213;33183.502247466306;33335.66664333374;33546;33831.830840845636;1148.8276758486127;1149.8792626774236;1169.9532018719326;1170.7131752720638;1187.7980743273665;17047.14764261782;17327.306907723803;17417.546454285246;17435.302587896596;17713.645727085644;478006;486606;500065;502068;728885;55218.72390638021;55589;55799;55864.16203756947;56002.43997559972;1225.1730082194483;1344.88568471681;1354.823872896517;1379.903406761517;1411.125102436496;31251.53122703207;33460.83269583636;33529.83235083809;33847.238916427974;33917.15207119842;49796;50097.49902500928;50237.49762502328;50237.74881125571;50285;298267;298311;298591;298632;298743;27612.033578824645;28057.859710701316;28816;28832.855835720686;30321.69678303277;49028.754856226915;49573.504264956886;49789;50387.244191336424;50676.49323506718;39750.801245993585;40373.39439908345;40851.7957410211;41735;42134;40052.399214012396;40395.79802100971;40716.1856762869;41658.79170604127;42509.78745106255;41360.028949442625;41594.168116636894;42453.36319955265;43252.351214732436;46560.301595476776;32701;36592.63407365999;37235.441468378536;38242.80878595701;38753.418698718975;28586;28874.566881496376;28931.56602651004;28969.85515072411;29236.853815730785 13:40:48 INFO - PROCESS | 10468 | |2;jquery.html;382.13065276495985;386.83172819823363;389.20407766118285;398.6133450552964;409.3634398510317;16825;19377.515562110937;19461.513462163417;19662.311819086335;20707.689384659203;16551.50345489634;16899.831001689978;16901.661966760657;19051.714224286614;20259.290924817633;5730.942690573103;5764.2794650668775;5937.732802023919;5983.401659834003;5986.132010858423;5770.105633626774;5880.970595147019;5882.088276317178;5911.674857882815;5920.259967504062;5658.745356458949;5777.624454410471;5841.941580584204;5846.590738648296;5850.824475265727;5825.766969321222;5863.736131874076;5866.560007999417;5870.501007414375;5871.148683440899;5080.390353157608;5216.504432078947;5242.973785131088;5243.4232234454175;5249;24356.39109022271;24424.877875610688;24449.755502445103;24470.265892023268;24515.754842451526;2335.404471859665;2992.8627121693835;3064.6628870824193;3070.205835470237;3196.9040928772174;15031.173285469295;15218.771718424232;15429;15519.612009699735;15947.362105515882;1938.8351990080719;1973.6284975616063;1986.860919735619;1991.5220347116733;2068.2864411777914;80186.19813801846;83137;83869.58065209696;84162.15837841605;85646.57176714139;10351.948240258751;10381.532831022621;10815.945920270506;10863.34819910792;10937.56249750017;14727.116373017654;14759.77860332096;14788.852111478962;14869.925650371895;14898.702025959421;8273.172682731678;8395.53824539644;8483.363747718946;8657.956710216535;8696.739097827076;8248.670053197924;8253.752387428387;8342.207490288412;8520;8535.573221338907;6426.935730642634;6609.801705948829;6628.900566491507;6701.128853249046;6752.5948443093575;1822.8450581700438;1860.3023866050232;1868.5422071592548;1885.679434496139;1933.0624647046172;1019.7705516258783;1022.8414595737672;1068.4390694885246;1074.7581794096423;1084.1272775415707;20764.68852967207;21133.78866211349;21155.365339039854;21164;21202.575948480942;1011.9949400252951;1015.0255754475638;1044.4777611194402;1068.690079876827;1070.5878236878857;10998.395088270221;11740.00209982144;12038.638840834788;12149.331786751636;12181.512739490321;458845;468210;469836;471333;471531;83461.58269208614;84022;84199;84604;89589.10410895808;498.30486471372956;512.6821370750159;515.7679044430097;517.8731210853365;518.189034161536;10924.781504370027;11525.308481491138;11773.293602383885;11866.347350895438;12462.439190236642;42418.78790606027;42934.57065429306;43502.34746478742;44029;44239.55760442483;59598;59753;60370;60508.394916052035;61272.38727612667;8491;8550.615222314886;8724.302055835391;8769.561521923752;8985.415947963362;12199.268043917393;12540.24758514492;13146.671333216746;13170.670733231746;13686.384112715152;11577.189596728149;11752.294862308288;11798.351090690094;11892;12205.572804952139;11303.02197115518;11611.47748351343;11637.709057273636;11767.823482647938;12252.08109391817;11615.245009074382;11864.974431519908;12006.399680016139;12042.578509752117;12052.638420847388;8187.3040791533385;8263.669453221804;8476;8599.14008599135;8780.956095219482;11207.43962801873;11303.660890173307;11534.019608333385;11684.415779211175;11823.76352472963 13:40:48 INFO - PROCESS | 10468 | |3;mootools.html;1334.5395838435747;1461.3350925328973;1496.521113243762;1638.2955329208444;1781.7060185069465;8593.226609605133;9023;9070.274378049757;9341.252699784001;9363;9113.863292050624;9252.167304942554;9268.814623707522;9271.953640231806;9274.118958698913;2059.5983783162287;2320.3155069254612;2378.1914149189315;2393.078664714089;2420.3465064432594;2432.489177272766;2448.7428819973825;2451.0930955546473;2451.7915977141965;2459;2362.799162071226;2400.2079313826393;2422.4670572474115;2429.161939130997;2431.3070774829175;1985.8312043476321;2050.682144267626;2321.466062805556;2326.8371214015024;2341.2039906431896;2100.95798084039;2318.1538738360546;2382.6783384243076;2384.0463814474174;2405.542946840095;9108;9167.174954254082;9170.633174673005;9205.217556507705;9213.0786921308;5275.208718692188;5393.946060539383;5420;5432.402435732066;5442.183672449125;3474.8262586870555;3492.565894895584;3512.8946131615835;3522.137076416269;3548.503209550665;1131.852859128308;1138.3795831271977;1157.8784227656142;1169.3393232823428;2203.7465691445527;12577.622671319876;13027.739445211042;13074.803877941838;13083.803742943863;13100.47598096075;4681.461631912305;4848.10310092634;4870.756462176877;4877.926831097537;4936.456989731127;10085.647002354883;10120.493975301206;10132.949335253425;10135.594576216869;10149.086582207638;5444.863878403072;5447.073997420448;5447.645903016291;5467.425920278313;5470.753816078286;4302.22559939214;4927.433345165352;5008.323876276729;5064.290999260106;5104.41299250591;3829.5978922213326;3897.1231472918366;3917.3928041153667;3950.8419663213726;4003.11931375097;1167.64970508847;1168.2639936839737;1175.4710380328886;1180.9291442513477;1185.5020891225706;868.1188593577524;868.887044684187;925.546482223719;964.1659964130977;972.1008067537499;5943.791967281124;5954.243498168051;6050.6369617823075;6229.0967809667345;6355.173827402408;478.4641201853876;480.9182438985381;481.2636665901107;483.44645381038515;503.0643004012534;4108.260513107669;4178.791060446965;4216.852410165629;4251.9787401062795;4291.206126866539;11261.099112071015;11624.94187529057;11630.185886987829;11644.301341919512;11705.88294117065;11566;11575.942120289345;11582.536698531965;11623.244489108181;11624.476898539417;8224.506529608243;8575.785605359915;8583.828323433496;8597;8610.741677749678;6266.27937787142;6422.42198202164;6479.514036447191;6512.251091124582;6664.466842652673;10525.263231573716;10633.574657013633;10695.518701658288;10748.086412655011;10811.135109191404;10387.532561034923;10731.946340268561;10734;10865.945670271598;10908.945455272673;7347.485676002629;7896.249856263646;8096.959515202387;8210.220029097227;8366.163383661586;9123.178913897782;9189.426960451085;9212.355135140477;9225.538723063954;9225.538723063954;7437.851242975218;7503.737369192052;7675.4243431741725;7753.573553454388;7754.185810489817;7241.203467618663;7698.692052317844;7703.768886933401;7766.49517781365;7940.722074727357;6695.631740254333;6797.762078327235;6808.183018037867;6814.046033555405;6814.829629259309;5135.922961155511;5173.198154286091;5221.921671175011;5261.184516399964;5531.1426728857095;4984.8753781155765;5077.9238311424615;5107.361579802525;5253.13323301651;5365.570754339721 13:40:48 INFO - PROCESS | 10468 | |4;prototype.html;319.642000958926;329.05396983671943;331.7362696656158;333.19533327015256;338.47705295318735;5311.760970756315;5320.4679532046775;5322;5335.173048177529;5344.652597581165;5221.791128354861;5229.555487783543;5273.8945221095555;5280.577553795697;5289.127293996486;3898.161895192533;3943.8619648312315;4018.4976877890263;4030.9395359069636;4043.8786836394956;3784.791836448994;4104.527979282391;4104.897377565555;4113.814878330482;4116.794160291974;4065;4113.465249517559;4115.814788334532;4115.917681646365;4125.628693417591;3967.147063381387;4134.979325103355;4137.668986481074;4156.314208155651;4168.166366726652;3656.829814459374;3666;3706.4810926470313;3709.7588656737494;3724.925501489955;5090.236464530313;5096.1846104623455;5104.719240441774;5108.2848401223855;5135.408023512723;4672.859814205579;4759.619230461555;4766.73782941938;4788.976055119702;4813.975930120327;5439.129739241703;5483.75323110461;5493.478119578634;5496.80761173361;5509.752061157217;4063.349864021742;4082.326416141333;4086.264472394968;4100.938485922714;4110.815013324408;5491.588130890159;5518.862028449281;5719.026106424636;5751;5799.159121927297;3961.603839616073;4053.9391909121387;4088.8160032798596;4102.835886564504;4105.261053010487;4127.174565086994;4138.627523522837;4140.896477588024;4144.316187828975;4186.790660466964;4568.132054909556;4741.2888066789565;4744.359511465908;4745.383100196952;4759.286107083896;5481.287432633732;5491.540329592332;5495.258140151029;5499.257600223918;5547.306586676666;1430.5064752660317;1446.2696338349067;1452.4480697334945;1456.6649670575828;1465.3332733606183;909.8114567070974;930.283681565191;939.1922946266205;950.7290422229631;960.9183219426427;4667.813287468463;4691.9530804692195;4702.95297047032;4715.599174070242;4723.527647235318;4952.2819191217795;4954.801807927714;4961.5286547777905;4983.651144419856;4993.800247990112;4677.836275730333;4710.717356958594;4711.481737008926;4721.433427988663;4894.95105048945;2957.31981644223;3003.5344521599186;3007.045420476664;3013.8643761030808;3024.123004328764;5857.941420585825;5866.677332746654;5866.853328666817;5884.352721200665;5884.617499862496;5628.409017053151;5786;5807.68057756819;5832.212651292106;5853.336731787027;5809.593328466966;5809.82570522885;5824.563157763269;5825.854353641108;5829.679367634821;5388.541973932103;5665.178549110438;5667.943320566907;5668.914966275592;5693.259876216065;5618.410066942912;5627.352854421794;5627.380988091389;5632.802851900327;5639;5602.635828671123;5786.189933409242;5790.334111577223;5793.507551857971;5878.3239927408895;3915.882523524299;3988.74073185242;4051.93922091163;4066.857659982005;4076.5923407658997;5626.1560765883805;5632;5636.633618814764;5642.65829680678;5652.830415087554;5281.551068159096;5422.457754224546;5501.377093757271;5535.616095976006;5562.3881373048125;5512.80705175317;5521.337439507285;5542.418046105262;5560.388357280615;5562.690199331391;5300.734963251745;5477.507024367826;5479.863003424946;5487.725613719218;5492.764128071152;5589.832305030693;5594.552435805044;5595.804146854841;5601.7396085880355;5604.607677462538;5472.315960504937;5478.726063696879;5480.849021705487;5500.4499550044675;5506.1190209566275 13:40:48 INFO - PROCESS | 10468 | |5;yui.html;712.5938215217327;713.3365969648225;755.0863455219185;827.4456114403349;848.4527479775548;14614.634634134152;15050.096994180343;15166.39334426623;15170.84829151708;15234.54296371108;13436.66408339792;13460.326983650803;13509.121907076033;13527.458901643922;13540.39068241929;652.9771457998971;799.8920145780318;800.1718221640604;814.2590242878981;816.3754727633335;801.7955421367543;812.7927378518499;813.8494378539959;814.0109766633539;814.2305521282391;860.7073594977707;861.9051904290554;861.9051904290554;862.4652715316481;862.6894318045498;705.5061456980084;843.0347252396034;853.9871901921445;854.175720429782;856.4133568505563;636.2460484326089;636.290536052303;636.936306369364;637.1684951138762;637.3403527349171;14390.352434140488;14402.855971440362;14415.135091894519;14420.92789536056;14424.495142669955;13648;13959.232242226673;14036.508722194674;14246.358913848902;14668.779968300483;13316.733665326736;13365.53220637273;13522.32388380587;13522.797158042637;13948.860511394858;4419.315006174048;4448.510663826976;4482.125985432842;4484.977575112103;4524.1630298394575;80490;83249;83611.5819420899;83766.58116709438;84651.57674211651;11570.479328430241;11672.241304315192;11810;11940.582079627171;12008.339541325311;22394.424641166148;22410.32769016932;22457.775422245893;22496.437589060406;22584;7744.380449564022;7844.921550784419;8250.339972802161;8271.13153118926;8441.409101362968;4844.806207751721;4860.1737704590305;4868.172410690191;4907.1903135982875;4999.600031997432;3336.199312165063;3471.114865709228;3475.600305964796;3478.9652103479148;3488.4069708149677;585.689584520205;605.0923614578132;605.306923572507;605.5034871405493;605.9849751665942;525.2882344423327;557.4954666027252;586.5864565481326;668.6130514064839;707.8938159276047;9650.890147632972;10095.697129086138;10181.796364072678;10185.847212291821;10204.132648724793;628.9433950944436;670.497127154634;713.134130540143;716.1656669979519;716.9318914703094;4619.284010978304;4769.856904292877;4785.234362501983;4790.185668436374;4796.736179510161;123326.38336808259;127752;128427;132631;135542.32228838792;107621.46189269003;108355.45822270839;108933;109574;112521;59419.702901485216;60676.393236067954;61911.69044154751;96212;99498.00501995032;8611.6985905493;9033.412828166149;9085.591148398205;9123.908760912305;9180;50287.74856125696;52779.472205278995;53335.733321333144;54448.18327725008;57807.4219257802;72687;74377.6281118591;80179.59910200411;82555.5872220635;82786.58606706928;11554.826677599674;11943.761124777282;12143.696407589881;12168.148229623841;12248.142630015813;15068.924655376653;15504.302306396014;15694.2937567812;15832.208389580705;16004.199790010685;14745.410183592536;14806.555803325487;15049.172295523851;15061;15109.244537773287;14428.855711442751;14432.783508247594;14528.418863245775;14645.926770366506;14703.060871285255;14208.218547979961;14386.136831789707;14412.279386030446;14482.452243447256;14685.85314146845;11775.587854425054;11783.882161178279;12024.458899349725;12031.766181710984;12138.87569675321;11374.488148033193;12266.32535210572;12453.315067671365;12463.5014599415;12613.243205407705 13:40:48 INFO - PROCESS | 10468 | __end_tp_report 13:40:48 INFO - PROCESS | 10468 | __start_cc_report 13:40:48 INFO - PROCESS | 10468 | _x_x_mozilla_cycle_collect,1122 13:40:48 INFO - PROCESS | 10468 | __end_cc_report 13:40:48 INFO - PROCESS | 10468 | __startTimestamp1471552848437__endTimestamp 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | ------- Summary: start ------- 13:40:48 INFO - PROCESS | 10468 | Number of tests: 6 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | [#0] dojo.html Cycles:165 Average:5318.50 Median:5499.31 stddev:615.31 (11.2%) stddev-sans-first:590.12 13:40:48 INFO - PROCESS | 10468 | Values: 3017.0 3038.0 3056.1 3062.6 3067.4 5237.6 5317.4 5321.7 5415.4 5459.8 5284.4 5291.3 5343.7 5347.5 5393.9 4757.0 4820.5 4828.6 4846.5 4995.7 4902.7 4924.1 4960.6 4964.1 4964.7 4728.9 4763.6 4801.9 4807.2 4893.2 4817.2 4822.9 4843.1 4863.4 4909.4 4841.4 4863.6 4882.6 4905.3 4927.2 5174.6 5207.2 5259.3 5391.0 5446.0 5593.5 5637.6 5685.7 5685.8 5694.2 5737.5 5742.8 5743.8 5761.0 5761.6 5166.3 5287.0 5313.8 5339.3 5365.0 5918.2 5935.2 5938.2 5938.4 5947.0 5688.3 5702.3 5704.9 5706.5 5707.6 5545.1 5669.7 5705.7 5717.5 5772.1 5749.7 5753.1 5753.6 5755.0 5781.9 5663.0 5745.1 5751.8 5762.8 5764.2 4268.0 4352.4 4358.3 4386.9 4389.1 3957.2 3966.5 3980.2 3980.6 3981.3 5308.2 5367.3 5412.3 5412.7 5416.5 5764.7 5780.7 5799.3 5819.5 5831.3 5355.1 5390.8 5391.7 5394.9 5397.0 4824.9 4857.7 4904.6 4907.7 4960.3 5905.1 5968.3 6001.8 6004.3 6030.0 5734.6 5757.2 5782.9 5783.4 5808.4 5679.4 5943.9 5959.3 5970.2 5974.7 5612.8 5628.7 5640.9 5725.6 5758.7 5770.5 5771.2 5799.4 5801.9 5810.9 5446.5 5620.0 5643.0 5660.2 5660.8 5506.8 5520.6 5550.3 5617.8 5660.2 5499.3 5519.0 5539.9 5543.5 5549.1 5432.4 5639.9 5666.2 5685.9 5708.5 5344.1 5382.1 5400.8 5413.4 5440.5 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | [#1] ext.html Cycles:180 Average:56032.35 Median:41477.10 stddev:108686.61 (262.0%) stddev-sans-first:108911.74 13:40:48 INFO - PROCESS | 10468 | Values: 570.9 592.5 598.1 609.8 621.8 31483.5 34536.7 34553.8 34619.0 34647.5 43160.8 44391.3 44479.3 48942.0 48951.5 8878.9 9009.1 9017.5 9018.0 9020.0 8875.0 8967.2 8967.6 8970.7 8973.5 9006.1 9033.1 9035.6 9040.8 9054.2 8917.5 8942.5 8958.2 8961.0 8963.1 8877.2 8892.6 8933.6 8938.5 8943.1 42828.8 43131.0 43170.6 43212.8 43213.0 3588.6 3710.4 3733.5 3738.1 3756.0 31946.0 32265.5 32329.0 32500.5 32583.2 4413.8 4422.6 4429.7 4443.4 4497.7 334582.0 337429.0 337440.0 338159.0 338746.0 57756.3 57943.4 58169.4 58357.4 58369.4 60711.4 61082.4 61160.0 61202.0 61222.2 14873.5 16139.8 16442.3 16481.3 16945.2 12888.8 12938.9 12960.7 13000.5 13009.8 16450.0 16518.9 16538.9 16553.8 16713.6 4917.3 5788.9 6025.3 6069.5 6130.6 929.0 1006.6 1028.7 1031.4 1097.2 32838.8 33183.5 33335.7 33546.0 33831.8 1148.8 1149.9 1170.0 1170.7 1187.8 17047.1 17327.3 17417.5 17435.3 17713.6 478006.0 486606.0 500065.0 502068.0 728885.0 55218.7 55589.0 55799.0 55864.2 56002.4 1225.2 1344.9 1354.8 1379.9 1411.1 31251.5 33460.8 33529.8 33847.2 33917.2 49796.0 50097.5 50237.5 50237.7 50285.0 298267.0 298311.0 298591.0 298632.0 298743.0 27612.0 28057.9 28816.0 28832.9 30321.7 49028.8 49573.5 49789.0 50387.2 50676.5 39750.8 40373.4 40851.8 41735.0 42134.0 40052.4 40395.8 40716.2 41658.8 42509.8 41360.0 41594.2 42453.4 43252.4 46560.3 32701.0 36592.6 37235.4 38242.8 38753.4 28586.0 28874.6 28931.6 28969.9 29236.9 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | [#2] jquery.html Cycles:180 Average:28510.54 Median:13754.31 stddev:77188.91 (561.2%) stddev-sans-first:77376.55 13:40:48 INFO - PROCESS | 10468 | Values: 382.1 386.8 389.2 398.6 409.4 16825.0 19377.5 19461.5 19662.3 20707.7 16551.5 16899.8 16901.7 19051.7 20259.3 5730.9 5764.3 5937.7 5983.4 5986.1 5770.1 5881.0 5882.1 5911.7 5920.3 5658.7 5777.6 5841.9 5846.6 5850.8 5825.8 5863.7 5866.6 5870.5 5871.1 5080.4 5216.5 5243.0 5243.4 5249.0 24356.4 24424.9 24449.8 24470.3 24515.8 2335.4 2992.9 3064.7 3070.2 3196.9 15031.2 15218.8 15429.0 15519.6 15947.4 1938.8 1973.6 1986.9 1991.5 2068.3 80186.2 83137.0 83869.6 84162.2 85646.6 10351.9 10381.5 10815.9 10863.3 10937.6 14727.1 14759.8 14788.9 14869.9 14898.7 8273.2 8395.5 8483.4 8658.0 8696.7 8248.7 8253.8 8342.2 8520.0 8535.6 6426.9 6609.8 6628.9 6701.1 6752.6 1822.8 1860.3 1868.5 1885.7 1933.1 1019.8 1022.8 1068.4 1074.8 1084.1 20764.7 21133.8 21155.4 21164.0 21202.6 1012.0 1015.0 1044.5 1068.7 1070.6 10998.4 11740.0 12038.6 12149.3 12181.5 458845.0 468210.0 469836.0 471333.0 471531.0 83461.6 84022.0 84199.0 84604.0 89589.1 498.3 512.7 515.8 517.9 518.2 10924.8 11525.3 11773.3 11866.3 12462.4 42418.8 42934.6 43502.3 44029.0 44239.6 59598.0 59753.0 60370.0 60508.4 61272.4 8491.0 8550.6 8724.3 8769.6 8985.4 12199.3 12540.2 13146.7 13170.7 13686.4 11577.2 11752.3 11798.4 11892.0 12205.6 11303.0 11611.5 11637.7 11767.8 12252.1 11615.2 11865.0 12006.4 12042.6 12052.6 8187.3 8263.7 8476.0 8599.1 8781.0 11207.4 11303.7 11534.0 11684.4 11823.8 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | [#3] mootools.html Cycles:180 Average:5981.33 Median:2665.77 stddev:3490.03 (130.9%) stddev-sans-first:3482.35 13:40:48 INFO - PROCESS | 10468 | Values: 1334.5 1461.3 1496.5 1638.3 1781.7 8593.2 9023.0 9070.3 9341.3 9363.0 9113.9 9252.2 9268.8 9272.0 9274.1 2059.6 2320.3 2378.2 2393.1 2420.3 2432.5 2448.7 2451.1 2451.8 2459.0 2362.8 2400.2 2422.5 2429.2 2431.3 1985.8 2050.7 2321.5 2326.8 2341.2 2101.0 2318.2 2382.7 2384.0 2405.5 9108.0 9167.2 9170.6 9205.2 9213.1 5275.2 5393.9 5420.0 5432.4 5442.2 3474.8 3492.6 3512.9 3522.1 3548.5 1131.9 1138.4 1157.9 1169.3 2203.7 12577.6 13027.7 13074.8 13083.8 13100.5 4681.5 4848.1 4870.8 4877.9 4936.5 10085.6 10120.5 10132.9 10135.6 10149.1 5444.9 5447.1 5447.6 5467.4 5470.8 4302.2 4927.4 5008.3 5064.3 5104.4 3829.6 3897.1 3917.4 3950.8 4003.1 1167.6 1168.3 1175.5 1180.9 1185.5 868.1 868.9 925.5 964.2 972.1 5943.8 5954.2 6050.6 6229.1 6355.2 478.5 480.9 481.3 483.4 503.1 4108.3 4178.8 4216.9 4252.0 4291.2 11261.1 11624.9 11630.2 11644.3 11705.9 11566.0 11575.9 11582.5 11623.2 11624.5 8224.5 8575.8 8583.8 8597.0 8610.7 6266.3 6422.4 6479.5 6512.3 6664.5 10525.3 10633.6 10695.5 10748.1 10811.1 10387.5 10731.9 10734.0 10865.9 10908.9 7347.5 7896.2 8097.0 8210.2 8366.2 9123.2 9189.4 9212.4 9225.5 9225.5 7437.9 7503.7 7675.4 7753.6 7754.2 7241.2 7698.7 7703.8 7766.5 7940.7 6695.6 6797.8 6808.2 6814.0 6814.8 5135.9 5173.2 5221.9 5261.2 5531.1 4984.9 5077.9 5107.4 5253.1 5365.6 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | [#4] prototype.html Cycles:180 Average:4607.38 Median:5225.67 stddev:1343.39 (25.7%) stddev-sans-first:1308.04 13:40:48 INFO - PROCESS | 10468 | Values: 319.6 329.1 331.7 333.2 338.5 5311.8 5320.5 5322.0 5335.2 5344.7 5221.8 5229.6 5273.9 5280.6 5289.1 3898.2 3943.9 4018.5 4030.9 4043.9 3784.8 4104.5 4104.9 4113.8 4116.8 4065.0 4113.5 4115.8 4115.9 4125.6 3967.1 4135.0 4137.7 4156.3 4168.2 3656.8 3666.0 3706.5 3709.8 3724.9 5090.2 5096.2 5104.7 5108.3 5135.4 4672.9 4759.6 4766.7 4789.0 4814.0 5439.1 5483.8 5493.5 5496.8 5509.8 4063.3 4082.3 4086.3 4100.9 4110.8 5491.6 5518.9 5719.0 5751.0 5799.2 3961.6 4053.9 4088.8 4102.8 4105.3 4127.2 4138.6 4140.9 4144.3 4186.8 4568.1 4741.3 4744.4 4745.4 4759.3 5481.3 5491.5 5495.3 5499.3 5547.3 1430.5 1446.3 1452.4 1456.7 1465.3 909.8 930.3 939.2 950.7 960.9 4667.8 4692.0 4703.0 4715.6 4723.5 4952.3 4954.8 4961.5 4983.7 4993.8 4677.8 4710.7 4711.5 4721.4 4895.0 2957.3 3003.5 3007.0 3013.9 3024.1 5857.9 5866.7 5866.9 5884.4 5884.6 5628.4 5786.0 5807.7 5832.2 5853.3 5809.6 5809.8 5824.6 5825.9 5829.7 5388.5 5665.2 5667.9 5668.9 5693.3 5618.4 5627.4 5627.4 5632.8 5639.0 5602.6 5786.2 5790.3 5793.5 5878.3 3915.9 3988.7 4051.9 4066.9 4076.6 5626.2 5632.0 5636.6 5642.7 5652.8 5281.6 5422.5 5501.4 5535.6 5562.4 5512.8 5521.3 5542.4 5560.4 5562.7 5300.7 5477.5 5479.9 5487.7 5492.8 5589.8 5594.6 5595.8 5601.7 5604.6 5472.3 5478.7 5480.8 5500.4 5506.1 13:40:48 INFO - PROCESS | 10468 | 13:40:48 INFO - PROCESS | 10468 | [#5] yui.html Cycles:180 Average:21717.73 Median:4465.32 stddev:32200.94 (721.1%) stddev-sans-first:32252.65 13:40:48 INFO - PROCESS | 10468 | Values: 712.6 713.3 755.1 827.4 848.5 14614.6 15050.1 15166.4 15170.8 15234.5 13436.7 13460.3 13509.1 13527.5 13540.4 653.0 799.9 800.2 814.3 816.4 801.8 812.8 813.8 814.0 814.2 860.7 861.9 861.9 862.5 862.7 705.5 843.0 854.0 854.2 856.4 636.2 636.3 636.9 637.2 637.3 14390.4 14402.9 14415.1 14420.9 14424.5 13648.0 13959.2 14036.5 14246.4 14668.8 13316.7 13365.5 13522.3 13522.8 13948.9 4419.3 4448.5 4482.1 4485.0 4524.2 80490.0 83249.0 83611.6 83766.6 84651.6 11570.5 11672.2 11810.0 11940.6 12008.3 22394.4 22410.3 22457.8 22496.4 22584.0 7744.4 7844.9 8250.3 8271.1 8441.4 4844.8 4860.2 4868.2 4907.2 4999.6 3336.2 3471.1 3475.6 3479.0 3488.4 585.7 605.1 605.3 605.5 606.0 525.3 557.5 586.6 668.6 707.9 9650.9 10095.7 10181.8 10185.8 10204.1 628.9 670.5 713.1 716.2 716.9 4619.3 4769.9 4785.2 4790.2 4796.7 123326.4 127752.0 128427.0 132631.0 135542.3 107621.5 108355.5 108933.0 109574.0 112521.0 59419.7 60676.4 61911.7 96212.0 99498.0 8611.7 9033.4 9085.6 9123.9 9180.0 50287.7 52779.5 53335.7 54448.2 57807.4 72687.0 74377.6 80179.6 82555.6 82786.6 11554.8 11943.8 12143.7 12168.1 12248.1 15068.9 15504.3 15694.3 15832.2 16004.2 14745.4 14806.6 15049.2 15061.0 15109.2 14428.9 14432.8 14528.4 14645.9 14703.1 14208.2 14386.1 14412.3 14482.5 14685.9 11775.6 11783.9 12024.5 12031.8 12138.9 11374.5 12266.3 12453.3 12463.5 12613.2 13:40:48 INFO - PROCESS | 10468 | -------- Summary: end -------- 13:40:48 INFO - PROCESS | 10468 | 13:40:49 INFO - TEST-INFO | 10468: exit 0 13:40:49 INFO - TEST-OK | dromaeo_css | took 1115650ms 13:40:49 INFO - TEST-START | kraken 13:40:49 INFO - operating with platform_type : linux_ 13:40:49 INFO - Initialising browser for kraken test... 13:40:49 INFO - TEST-INFO | started process 10771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdatjWQ/profile http://localhost:44137/getInfo.html) 13:40:53 INFO - PROCESS | 10771 | __metrics Screen width/height:1600/1200 13:40:53 INFO - PROCESS | 10771 | colorDepth:24 13:40:53 INFO - PROCESS | 10771 | Browser inner width/height: 1024/697 13:40:53 INFO - PROCESS | 10771 | __metrics 13:40:54 INFO - PROCESS | 10771 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:40:54 INFO - PROCESS | 10771 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:55 INFO - TEST-INFO | 10771: exit 0 13:40:55 INFO - Browser initialized. 13:40:55 INFO - Running cycle 1/1 for kraken test... 13:40:55 INFO - TEST-INFO | started process 10855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdatjWQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:07 INFO - PROCESS | 10855 | RSS: Main: 155795456 13:41:07 INFO - PROCESS | 10855 | 13:41:09 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection) 13:41:10 INFO - PROCESS | 10855 | RSS: Main: 203939840 13:41:10 INFO - PROCESS | 10855 | 13:41:13 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-dft) 13:41:13 INFO - PROCESS | 10855 | RSS: Main: 191655936 13:41:13 INFO - PROCESS | 10855 | 13:41:16 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-fft) 13:41:17 INFO - PROCESS | 10855 | RSS: Main: 276168704 13:41:17 INFO - PROCESS | 10855 | 13:41:19 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator) 13:41:20 INFO - PROCESS | 10855 | RSS: Main: 186089472 13:41:20 INFO - PROCESS | 10855 | 13:41:22 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:41:22 INFO - PROCESS | 10855 | RSS: Main: 190783488 13:41:22 INFO - PROCESS | 10855 | 13:41:25 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom) 13:41:26 INFO - PROCESS | 10855 | RSS: Main: 225857536 13:41:26 INFO - PROCESS | 10855 | 13:41:29 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate) 13:41:30 INFO - PROCESS | 10855 | RSS: Main: 226734080 13:41:30 INFO - PROCESS | 10855 | 13:41:33 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial) 13:41:33 INFO - PROCESS | 10855 | RSS: Main: 226615296 13:41:33 INFO - PROCESS | 10855 | 13:41:35 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:41:36 INFO - PROCESS | 10855 | RSS: Main: 188784640 13:41:36 INFO - PROCESS | 10855 | 13:41:37 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:38 INFO - PROCESS | 10855 | RSS: Main: 196366336 13:41:38 INFO - PROCESS | 10855 | 13:41:40 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:41 INFO - PROCESS | 10855 | RSS: Main: 194039808 13:41:41 INFO - PROCESS | 10855 | 13:41:43 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:41:44 INFO - PROCESS | 10855 | RSS: Main: 187908096 13:41:44 INFO - PROCESS | 10855 | 13:41:46 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:41:47 INFO - PROCESS | 10855 | RSS: Main: 191881216 13:41:47 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | Cycle 1(1): loaded http://localhost:44137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44137/tests/kraken/driver.html?testName=ai-astar) 13:41:49 INFO - PROCESS | 10855 | RSS: Main: 243052544 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | __start_tp_report 13:41:49 INFO - PROCESS | 10855 | _x_x_mozilla_page_load 13:41:49 INFO - PROCESS | 10855 | _x_x_mozilla_page_load_details 13:41:49 INFO - PROCESS | 10855 | |i|pagename|runs| 13:41:49 INFO - PROCESS | 10855 | |0;ai-astar;102;111;111;111;106;112;109;111;112;110 13:41:49 INFO - PROCESS | 10855 | |1;audio-beat-detection;150;117;123;182;117;125;156;138;158;119 13:41:49 INFO - PROCESS | 10855 | |2;audio-dft;159;162;163;161;160;160;161;160;160;160 13:41:49 INFO - PROCESS | 10855 | |3;audio-fft;75;77;75;102;77;75;74;74;103;75 13:41:49 INFO - PROCESS | 10855 | |4;audio-oscillator;84;85;123;86;84;86;115;84;86;122 13:41:49 INFO - PROCESS | 10855 | |5;imaging-gaussian-blur;116;118;117;117;117;116;117;117;117;117 13:41:49 INFO - PROCESS | 10855 | |6;imaging-darkroom;145;146;146;146;146;145;146;145;145;146 13:41:49 INFO - PROCESS | 10855 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;96 13:41:49 INFO - PROCESS | 10855 | |8;json-parse-financial;53;51;52;51;52;54;51;50;53;51 13:41:49 INFO - PROCESS | 10855 | |9;json-stringify-tinderbox;61;62;70;61;61;62;62;62;62;62 13:41:49 INFO - PROCESS | 10855 | |10;stanford-crypto-aes;79;84;77;82;78;78;81;81;77;78 13:41:49 INFO - PROCESS | 10855 | |11;stanford-crypto-ccm;132;139;124;123;123;128;121;125;145;140 13:41:49 INFO - PROCESS | 10855 | |12;stanford-crypto-pbkdf2;159;165;160;162;161;162;162;165;163;160 13:41:49 INFO - PROCESS | 10855 | |13;stanford-crypto-sha256-iterative;65;63;64;63;64;63;64;63;65;62 13:41:49 INFO - PROCESS | 10855 | __end_tp_report 13:41:49 INFO - PROCESS | 10855 | __start_cc_report 13:41:49 INFO - PROCESS | 10855 | _x_x_mozilla_cycle_collect,1676 13:41:49 INFO - PROCESS | 10855 | __end_cc_report 13:41:49 INFO - PROCESS | 10855 | __startTimestamp1471552909479__endTimestamp 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | ------- Summary: start ------- 13:41:49 INFO - PROCESS | 10855 | Number of tests: 14 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.17 (2.9%) stddev-sans-first:1.87 13:41:49 INFO - PROCESS | 10855 | Values: 102.0 111.0 111.0 111.0 106.0 112.0 109.0 111.0 112.0 110.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:144.00 stddev:22.21 (15.4%) stddev-sans-first:23.16 13:41:49 INFO - PROCESS | 10855 | Values: 150.0 117.0 123.0 182.0 117.0 125.0 156.0 138.0 158.0 119.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.09 13:41:49 INFO - PROCESS | 10855 | Values: 159.0 162.0 163.0 161.0 160.0 160.0 161.0 160.0 160.0 160.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.54 (15.4%) stddev-sans-first:12.05 13:41:49 INFO - PROCESS | 10855 | Values: 75.0 77.0 75.0 102.0 77.0 75.0 74.0 74.0 103.0 75.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.50 stddev:17.05 (20.2%) stddev-sans-first:17.57 13:41:49 INFO - PROCESS | 10855 | Values: 84.0 85.0 123.0 86.0 84.0 86.0 115.0 84.0 86.0 122.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 13:41:49 INFO - PROCESS | 10855 | Values: 116.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:41:49 INFO - PROCESS | 10855 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:41:49 INFO - PROCESS | 10855 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.23 (2.4%) stddev-sans-first:1.22 13:41:49 INFO - PROCESS | 10855 | Values: 53.0 51.0 52.0 51.0 52.0 54.0 51.0 50.0 53.0 51.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:2.68 (4.3%) stddev-sans-first:2.78 13:41:49 INFO - PROCESS | 10855 | Values: 61.0 62.0 70.0 61.0 61.0 62.0 62.0 62.0 62.0 62.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:2.37 (3.0%) stddev-sans-first:2.51 13:41:49 INFO - PROCESS | 10855 | Values: 79.0 84.0 77.0 82.0 78.0 78.0 81.0 81.0 77.0 78.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:130.00 stddev:8.52 (6.6%) stddev-sans-first:9.01 13:41:49 INFO - PROCESS | 10855 | Values: 132.0 139.0 124.0 123.0 123.0 128.0 121.0 125.0 145.0 140.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:2.02 (1.2%) stddev-sans-first:1.86 13:41:49 INFO - PROCESS | 10855 | Values: 159.0 165.0 160.0 162.0 161.0 162.0 162.0 165.0 163.0 160.0 13:41:49 INFO - PROCESS | 10855 | 13:41:49 INFO - PROCESS | 10855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 13:41:49 INFO - PROCESS | 10855 | Values: 65.0 63.0 64.0 63.0 64.0 63.0 64.0 63.0 65.0 62.0 13:41:49 INFO - PROCESS | 10855 | -------- Summary: end -------- 13:41:49 INFO - PROCESS | 10855 | 13:41:50 INFO - TEST-INFO | 10855: exit 0 13:41:50 INFO - TEST-OK | kraken | took 61270ms 13:41:50 INFO - SUITE-END | took 1176s 13:41:50 INFO - Completed test suite (00:19:37) 13:41:50 INFO - javascript benchmark 13:41:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.0, 3038.0, 3056.0831750474854, 3062.5712400263983, 3067.3865226954613, 5237.580993520519, 5317.388500322464, 5321.733913304334, 5415.350157981043, 5459.754311056007, 5284.392294886089, 5291.28567643368, 5343.679379237248, 5347.518723314891, 5393.865153371158, 4757.0, 4820.493848145929, 4828.56542911138, 4846.539578740032, 4995.700257984533, 4902.730349830758, 4924.113659541281, 4960.553550180483, 4964.106460837066, 4964.726940018298, 4728.858134255944, 4763.642726795487, 4801.903961920777, 4807.158747219258, 4893.168161412551, 4817.205161148407, 4822.927656085161, 4843.07981483517, 4863.440704318978, 4909.386326709161, 4841.394825646794, 4863.562279394871, 4882.609391248691, 4905.337779399807, 4927.211646136601, 5174.61190410717, 5207.218917162418, 5259.316288882459, 5390.973045134789, 5446.0, 5593.52455041322, 5637.605367624268, 5685.687287199203, 5685.834403947181, 5694.202811606378, 5737.512311453532, 5742.770289188427, 5743.827685169452, 5761.020626493464, 5761.625494342854, 5166.328377310963, 5287.048331300402, 5313.760880760375, 5339.332583427072, 5365.03429382711, 5918.23063001807, 5935.1987481690285, 5938.168656388109, 5938.435848594377, 5947.018741907536, 5688.288963879515, 5702.315722113373, 5704.942950570441, 5706.457886500776, 5707.600467967202, 5545.140503222007, 5669.716514174357, 5705.686187259657, 5717.514011309002, 5772.105323674838, 5749.683767392834, 5753.05074662676, 5753.568482363839, 5755.0, 5781.884362312814, 5663.0, 5745.109508026263, 5751.798687045934, 5762.827115186551, 5764.164196191613, 4268.039691069484, 4352.39066530686, 4358.280883654162, 4386.912261754747, 4389.056352884145, 3957.248122856648, 3966.484357033567, 3980.1840622672285, 3980.641742243154, 3981.3231750602467, 5308.203769434538, 5367.329083864517, 5412.269343638637, 5412.702301373462, 5416.512513873691, 5764.74058667361, 5780.653160810365, 5799.33307669615, 5819.5053420459735, 5831.329397119385, 5355.0896347621, 5390.784368625211, 5391.676499409969, 5394.8921021579345, 5397.001554712312, 4824.8793780155775, 4857.732824694675, 4904.60763138948, 4907.656464047483, 4960.305557221992, 5905.143754155623, 5968.343482216953, 6001.789937352259, 6004.279486461653, 6030.0, 5734.569907257056, 5757.222774925332, 5782.855428614318, 5783.421657834183, 5808.448197421239, 5679.37526872052, 5943.910841337297, 5959.344472108151, 5970.223870896755, 5974.701264936649, 5612.7754889803955, 5628.662280263197, 5640.88718225625, 5725.627834190765, 5758.654480731169, 5770.451807078321, 5771.1920331154515, 5799.420057994167, 5801.8549536261935, 5810.883782324415, 5446.509814116748, 5620.0, 5642.971785141048, 5660.150977353265, 5660.801871934463, 5506.834794956158, 5520.613557051129, 5550.27846379968, 5617.775288988395, 5660.20757093999, 5499.312585926759, 5519.0, 5539.944600553943, 5543.528800051879, 5549.139883318092, 5432.375276843213, 5639.887202256014, 5666.178404131296, 5685.857853553694, 5708.4862362387585, 5344.11822049373, 5382.085045542189, 5400.83797486076, 5413.431589683184, 5440.455954404528], "value": 5276.177901241681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9058005429105, 592.5200587524105, 598.1416667082736, 609.8414412252813, 621.7606221604682, 31483.527747083812, 34536.65463345366, 34553.82723086384, 34618.96143115708, 34647.480287795704, 43160.784196079054, 44391.33412998808, 44479.33281000779, 48942.0, 48951.51048489514, 8878.866816997734, 9009.144131307516, 9017.54912254388, 9018.0, 9020.0, 8875.023747387782, 8967.192952634261, 8967.641294348217, 8970.730878073668, 8973.46159230445, 9006.144416280476, 9033.09669033098, 9035.59339829706, 9040.819183616324, 9054.185123338932, 8917.464952102862, 8942.508162051085, 8958.193762561368, 8961.0, 8963.14850089247, 8877.156670116394, 8892.555372231427, 8933.642654293886, 8938.508382038985, 8943.10568943107, 42828.785856070834, 43131.0, 43170.56829431728, 43212.783936080436, 43213.0, 3588.551431071116, 3710.350688629479, 3733.4586484959527, 3738.102855314732, 3755.9812200939095, 31946.0, 32265.51601725976, 32329.0, 32500.512492312635, 32583.185420364443, 4413.757243351614, 4422.601965823059, 4429.667774916894, 4443.37792709021, 4497.730136191806, 334581.99999999756, 337429.0, 337440.0, 338159.0, 338746.0, 57756.26731198071, 57943.420565794644, 58169.41830581725, 58357.416425835196, 58369.41630583725, 60711.39288607146, 61082.38917610767, 61160.0, 61202.0, 61222.20444728822, 14873.479428220176, 16139.838601614068, 16442.260098295606, 16481.34074637025, 16945.237464314134, 12888.80666789999, 12938.870611293954, 12960.675983100498, 13000.544980925622, 13009.804852927213, 16450.012999220085, 16518.917405413136, 16538.917305413637, 16553.83446165547, 16713.582160446087, 4917.254374697002, 5788.942110578924, 6025.276966764016, 6069.51443884497, 6130.601510901866, 929.0198840223629, 1006.6476733143488, 1028.6708253359002, 1031.4430207687915, 1097.1716354152722, 32838.8358058213, 33183.502247466306, 33335.66664333374, 33546.0, 33831.830840845636, 1148.8276758486127, 1149.8792626774236, 1169.9532018719326, 1170.7131752720638, 1187.7980743273665, 17047.14764261782, 17327.306907723803, 17417.546454285246, 17435.302587896596, 17713.645727085644, 478006.0, 486606.0, 500065.0, 502068.0, 728885.0, 55218.72390638021, 55589.0, 55799.0, 55864.16203756947, 56002.43997559972, 1225.1730082194483, 1344.88568471681, 1354.823872896517, 1379.903406761517, 1411.125102436496, 31251.53122703207, 33460.83269583636, 33529.83235083809, 33847.238916427974, 33917.15207119842, 49796.0, 50097.49902500928, 50237.49762502328, 50237.74881125571, 50285.0, 298267.0, 298311.0, 298591.0, 298632.0, 298743.0, 27612.033578824645, 28057.859710701316, 28816.0, 28832.855835720686, 30321.69678303277, 49028.754856226915, 49573.504264956886, 49789.0, 50387.244191336424, 50676.49323506718, 39750.801245993585, 40373.39439908345, 40851.7957410211, 41735.0, 42134.0, 40052.399214012396, 40395.79802100971, 40716.1856762869, 41658.79170604127, 42509.78745106255, 41360.028949442625, 41594.168116636894, 42453.36319955265, 43252.351214732436, 46560.301595476776, 32701.0, 36592.63407365999, 37235.441468378536, 38242.80878595701, 38753.418698718975, 28586.0, 28874.566881496376, 28931.56602651004, 28969.85515072411, 29236.853815730785], "value": 19773.93896290868, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.13065276495985, 386.83172819823363, 389.20407766118285, 398.6133450552964, 409.3634398510317, 16825.0, 19377.515562110937, 19461.513462163417, 19662.311819086335, 20707.689384659203, 16551.50345489634, 16899.831001689978, 16901.661966760657, 19051.714224286614, 20259.290924817633, 5730.942690573103, 5764.2794650668775, 5937.732802023919, 5983.401659834003, 5986.132010858423, 5770.105633626774, 5880.970595147019, 5882.088276317178, 5911.674857882815, 5920.259967504062, 5658.745356458949, 5777.624454410471, 5841.941580584204, 5846.590738648296, 5850.824475265727, 5825.766969321222, 5863.736131874076, 5866.560007999417, 5870.501007414375, 5871.148683440899, 5080.390353157608, 5216.504432078947, 5242.973785131088, 5243.4232234454175, 5249.0, 24356.39109022271, 24424.877875610688, 24449.755502445103, 24470.265892023268, 24515.754842451526, 2335.404471859665, 2992.8627121693835, 3064.6628870824193, 3070.205835470237, 3196.9040928772174, 15031.173285469295, 15218.771718424232, 15429.0, 15519.612009699735, 15947.362105515882, 1938.8351990080719, 1973.6284975616063, 1986.860919735619, 1991.5220347116733, 2068.2864411777914, 80186.19813801846, 83137.0, 83869.58065209696, 84162.15837841605, 85646.57176714139, 10351.948240258751, 10381.532831022621, 10815.945920270506, 10863.34819910792, 10937.56249750017, 14727.116373017654, 14759.77860332096, 14788.852111478962, 14869.925650371895, 14898.702025959421, 8273.172682731678, 8395.53824539644, 8483.363747718946, 8657.956710216535, 8696.739097827076, 8248.670053197924, 8253.752387428387, 8342.207490288412, 8520.0, 8535.573221338907, 6426.935730642634, 6609.801705948829, 6628.900566491507, 6701.128853249046, 6752.5948443093575, 1822.8450581700438, 1860.3023866050232, 1868.5422071592548, 1885.679434496139, 1933.0624647046172, 1019.7705516258783, 1022.8414595737672, 1068.4390694885246, 1074.7581794096423, 1084.1272775415707, 20764.68852967207, 21133.78866211349, 21155.365339039854, 21164.0, 21202.575948480942, 1011.9949400252951, 1015.0255754475638, 1044.4777611194402, 1068.690079876827, 1070.5878236878857, 10998.395088270221, 11740.00209982144, 12038.638840834788, 12149.331786751636, 12181.512739490321, 458845.0, 468210.0, 469836.0, 471333.0, 471531.0, 83461.58269208614, 84022.0, 84199.0, 84604.0, 89589.10410895808, 498.30486471372956, 512.6821370750159, 515.7679044430097, 517.8731210853365, 518.189034161536, 10924.781504370027, 11525.308481491138, 11773.293602383885, 11866.347350895438, 12462.439190236642, 42418.78790606027, 42934.57065429306, 43502.34746478742, 44029.0, 44239.55760442483, 59598.0, 59753.0, 60370.0, 60508.394916052035, 61272.38727612667, 8491.0, 8550.615222314886, 8724.302055835391, 8769.561521923752, 8985.415947963362, 12199.268043917393, 12540.24758514492, 13146.671333216746, 13170.670733231746, 13686.384112715152, 11577.189596728149, 11752.294862308288, 11798.351090690094, 11892.0, 12205.572804952139, 11303.02197115518, 11611.47748351343, 11637.709057273636, 11767.823482647938, 12252.08109391817, 11615.245009074382, 11864.974431519908, 12006.399680016139, 12042.578509752117, 12052.638420847388, 8187.3040791533385, 8263.669453221804, 8476.0, 8599.14008599135, 8780.956095219482, 11207.43962801873, 11303.660890173307, 11534.019608333385, 11684.415779211175, 11823.76352472963], "value": 9274.764249813847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.5395838435747, 1461.3350925328973, 1496.521113243762, 1638.2955329208444, 1781.7060185069465, 8593.226609605133, 9023.0, 9070.274378049757, 9341.252699784001, 9363.0, 9113.863292050624, 9252.167304942554, 9268.814623707522, 9271.953640231806, 9274.118958698913, 2059.5983783162287, 2320.3155069254612, 2378.1914149189315, 2393.078664714089, 2420.3465064432594, 2432.489177272766, 2448.7428819973825, 2451.0930955546473, 2451.7915977141965, 2459.0, 2362.799162071226, 2400.2079313826393, 2422.4670572474115, 2429.161939130997, 2431.3070774829175, 1985.8312043476321, 2050.682144267626, 2321.466062805556, 2326.8371214015024, 2341.2039906431896, 2100.95798084039, 2318.1538738360546, 2382.6783384243076, 2384.0463814474174, 2405.542946840095, 9108.0, 9167.174954254082, 9170.633174673005, 9205.217556507705, 9213.0786921308, 5275.208718692188, 5393.946060539383, 5420.0, 5432.402435732066, 5442.183672449125, 3474.8262586870555, 3492.565894895584, 3512.8946131615835, 3522.137076416269, 3548.503209550665, 1131.852859128308, 1138.3795831271977, 1157.8784227656142, 1169.3393232823428, 2203.7465691445527, 12577.622671319876, 13027.739445211042, 13074.803877941838, 13083.803742943863, 13100.47598096075, 4681.461631912305, 4848.10310092634, 4870.756462176877, 4877.926831097537, 4936.456989731127, 10085.647002354883, 10120.493975301206, 10132.949335253425, 10135.594576216869, 10149.086582207638, 5444.863878403072, 5447.073997420448, 5447.645903016291, 5467.425920278313, 5470.753816078286, 4302.22559939214, 4927.433345165352, 5008.323876276729, 5064.290999260106, 5104.41299250591, 3829.5978922213326, 3897.1231472918366, 3917.3928041153667, 3950.8419663213726, 4003.11931375097, 1167.64970508847, 1168.2639936839737, 1175.4710380328886, 1180.9291442513477, 1185.5020891225706, 868.1188593577524, 868.887044684187, 925.546482223719, 964.1659964130977, 972.1008067537499, 5943.791967281124, 5954.243498168051, 6050.6369617823075, 6229.0967809667345, 6355.173827402408, 478.4641201853876, 480.9182438985381, 481.2636665901107, 483.44645381038515, 503.0643004012534, 4108.260513107669, 4178.791060446965, 4216.852410165629, 4251.9787401062795, 4291.206126866539, 11261.099112071015, 11624.94187529057, 11630.185886987829, 11644.301341919512, 11705.88294117065, 11566.0, 11575.942120289345, 11582.536698531965, 11623.244489108181, 11624.476898539417, 8224.506529608243, 8575.785605359915, 8583.828323433496, 8597.0, 8610.741677749678, 6266.27937787142, 6422.42198202164, 6479.514036447191, 6512.251091124582, 6664.466842652673, 10525.263231573716, 10633.574657013633, 10695.518701658288, 10748.086412655011, 10811.135109191404, 10387.532561034923, 10731.946340268561, 10734.0, 10865.945670271598, 10908.945455272673, 7347.485676002629, 7896.249856263646, 8096.959515202387, 8210.220029097227, 8366.163383661586, 9123.178913897782, 9189.426960451085, 9212.355135140477, 9225.538723063954, 9225.538723063954, 7437.851242975218, 7503.737369192052, 7675.4243431741725, 7753.573553454388, 7754.185810489817, 7241.203467618663, 7698.692052317844, 7703.768886933401, 7766.49517781365, 7940.722074727357, 6695.631740254333, 6797.762078327235, 6808.183018037867, 6814.046033555405, 6814.829629259309, 5135.922961155511, 5173.198154286091, 5221.921671175011, 5261.184516399964, 5531.1426728857095, 4984.8753781155765, 5077.9238311424615, 5107.361579802525, 5253.13323301651, 5365.570754339721], "value": 4674.024564846644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.642000958926, 329.05396983671943, 331.7362696656158, 333.19533327015256, 338.47705295318735, 5311.760970756315, 5320.4679532046775, 5322.0, 5335.173048177529, 5344.652597581165, 5221.791128354861, 5229.555487783543, 5273.8945221095555, 5280.577553795697, 5289.127293996486, 3898.161895192533, 3943.8619648312315, 4018.4976877890263, 4030.9395359069636, 4043.8786836394956, 3784.791836448994, 4104.527979282391, 4104.897377565555, 4113.814878330482, 4116.794160291974, 4065.0, 4113.465249517559, 4115.814788334532, 4115.917681646365, 4125.628693417591, 3967.147063381387, 4134.979325103355, 4137.668986481074, 4156.314208155651, 4168.166366726652, 3656.829814459374, 3666.0, 3706.4810926470313, 3709.7588656737494, 3724.925501489955, 5090.236464530313, 5096.1846104623455, 5104.719240441774, 5108.2848401223855, 5135.408023512723, 4672.859814205579, 4759.619230461555, 4766.73782941938, 4788.976055119702, 4813.975930120327, 5439.129739241703, 5483.75323110461, 5493.478119578634, 5496.80761173361, 5509.752061157217, 4063.349864021742, 4082.326416141333, 4086.264472394968, 4100.938485922714, 4110.815013324408, 5491.588130890159, 5518.862028449281, 5719.026106424636, 5751.0, 5799.159121927297, 3961.603839616073, 4053.9391909121387, 4088.8160032798596, 4102.835886564504, 4105.261053010487, 4127.174565086994, 4138.627523522837, 4140.896477588024, 4144.316187828975, 4186.790660466964, 4568.132054909556, 4741.2888066789565, 4744.359511465908, 4745.383100196952, 4759.286107083896, 5481.287432633732, 5491.540329592332, 5495.258140151029, 5499.257600223918, 5547.306586676666, 1430.5064752660317, 1446.2696338349067, 1452.4480697334945, 1456.6649670575828, 1465.3332733606183, 909.8114567070974, 930.283681565191, 939.1922946266205, 950.7290422229631, 960.9183219426427, 4667.813287468463, 4691.9530804692195, 4702.95297047032, 4715.599174070242, 4723.527647235318, 4952.2819191217795, 4954.801807927714, 4961.5286547777905, 4983.651144419856, 4993.800247990112, 4677.836275730333, 4710.717356958594, 4711.481737008926, 4721.433427988663, 4894.95105048945, 2957.31981644223, 3003.5344521599186, 3007.045420476664, 3013.8643761030808, 3024.123004328764, 5857.941420585825, 5866.677332746654, 5866.853328666817, 5884.352721200665, 5884.617499862496, 5628.409017053151, 5786.0, 5807.68057756819, 5832.212651292106, 5853.336731787027, 5809.593328466966, 5809.82570522885, 5824.563157763269, 5825.854353641108, 5829.679367634821, 5388.541973932103, 5665.178549110438, 5667.943320566907, 5668.914966275592, 5693.259876216065, 5618.410066942912, 5627.352854421794, 5627.380988091389, 5632.802851900327, 5639.0, 5602.635828671123, 5786.189933409242, 5790.334111577223, 5793.507551857971, 5878.3239927408895, 3915.882523524299, 3988.74073185242, 4051.93922091163, 4066.857659982005, 4076.5923407658997, 5626.1560765883805, 5632.0, 5636.633618814764, 5642.65829680678, 5652.830415087554, 5281.551068159096, 5422.457754224546, 5501.377093757271, 5535.616095976006, 5562.3881373048125, 5512.80705175317, 5521.337439507285, 5542.418046105262, 5560.388357280615, 5562.690199331391, 5300.734963251745, 5477.507024367826, 5479.863003424946, 5487.725613719218, 5492.764128071152, 5589.832305030693, 5594.552435805044, 5595.804146854841, 5601.7396085880355, 5604.607677462538, 5472.315960504937, 5478.726063696879, 5480.849021705487, 5500.4499550044675, 5506.1190209566275], "value": 4182.537561690128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.5938215217327, 713.3365969648225, 755.0863455219185, 827.4456114403349, 848.4527479775548, 14614.634634134152, 15050.096994180343, 15166.39334426623, 15170.84829151708, 15234.54296371108, 13436.66408339792, 13460.326983650803, 13509.121907076033, 13527.458901643922, 13540.39068241929, 652.9771457998971, 799.8920145780318, 800.1718221640604, 814.2590242878981, 816.3754727633335, 801.7955421367543, 812.7927378518499, 813.8494378539959, 814.0109766633539, 814.2305521282391, 860.7073594977707, 861.9051904290554, 861.9051904290554, 862.4652715316481, 862.6894318045498, 705.5061456980084, 843.0347252396034, 853.9871901921445, 854.175720429782, 856.4133568505563, 636.2460484326089, 636.290536052303, 636.936306369364, 637.1684951138762, 637.3403527349171, 14390.352434140488, 14402.855971440362, 14415.135091894519, 14420.92789536056, 14424.495142669955, 13648.0, 13959.232242226673, 14036.508722194674, 14246.358913848902, 14668.779968300483, 13316.733665326736, 13365.53220637273, 13522.32388380587, 13522.797158042637, 13948.860511394858, 4419.315006174048, 4448.510663826976, 4482.125985432842, 4484.977575112103, 4524.1630298394575, 80490.0, 83249.0, 83611.5819420899, 83766.58116709438, 84651.57674211651, 11570.479328430241, 11672.241304315192, 11810.0, 11940.582079627171, 12008.339541325311, 22394.424641166148, 22410.32769016932, 22457.775422245893, 22496.437589060406, 22584.0, 7744.380449564022, 7844.921550784419, 8250.339972802161, 8271.13153118926, 8441.409101362968, 4844.806207751721, 4860.1737704590305, 4868.172410690191, 4907.1903135982875, 4999.600031997432, 3336.199312165063, 3471.114865709228, 3475.600305964796, 3478.9652103479148, 3488.4069708149677, 585.689584520205, 605.0923614578132, 605.306923572507, 605.5034871405493, 605.9849751665942, 525.2882344423327, 557.4954666027252, 586.5864565481326, 668.6130514064839, 707.8938159276047, 9650.890147632972, 10095.697129086138, 10181.796364072678, 10185.847212291821, 10204.132648724793, 628.9433950944436, 670.497127154634, 713.134130540143, 716.1656669979519, 716.9318914703094, 4619.284010978304, 4769.856904292877, 4785.234362501983, 4790.185668436374, 4796.736179510161, 123326.38336808259, 127752.0, 128427.0, 132631.0, 135542.32228838792, 107621.46189269003, 108355.45822270839, 108933.0, 109574.0, 112521.0, 59419.702901485216, 60676.393236067954, 61911.69044154751, 96212.0, 99498.00501995032, 8611.6985905493, 9033.412828166149, 9085.591148398205, 9123.908760912305, 9180.0, 50287.74856125696, 52779.472205278995, 53335.733321333144, 54448.18327725008, 57807.4219257802, 72687.0, 74377.6281118591, 80179.59910200411, 82555.5872220635, 82786.58606706928, 11554.826677599674, 11943.761124777282, 12143.696407589881, 12168.148229623841, 12248.142630015813, 15068.924655376653, 15504.302306396014, 15694.2937567812, 15832.208389580705, 16004.199790010685, 14745.410183592536, 14806.555803325487, 15049.172295523851, 15061.0, 15109.244537773287, 14428.855711442751, 14432.783508247594, 14528.418863245775, 14645.926770366506, 14703.060871285255, 14208.218547979961, 14386.136831789707, 14412.279386030446, 14482.452243447256, 14685.85314146845, 11775.587854425054, 11783.882161178279, 12024.458899349725, 12031.766181710984, 12138.87569675321, 11374.488148033193, 12266.32535210572, 12453.315067671365, 12463.5014599415, 12613.243205407705], "value": 7668.869350920839, "unit": "score"}], "name": "dromaeo_css", "value": 7248.872253998287, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 106.0, 112.0, 109.0, 111.0, 112.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 123.0, 182.0, 117.0, 125.0, 156.0, 138.0, 158.0, 119.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 163.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 102.0, 77.0, 75.0, 74.0, 74.0, 103.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 123.0, 86.0, 84.0, 86.0, 115.0, 84.0, 86.0, 122.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 52.0, 54.0, 51.0, 50.0, 53.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 70.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 77.0, 82.0, 78.0, 78.0, 81.0, 81.0, 77.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 124.0, 123.0, 123.0, 128.0, 121.0, 125.0, 145.0, 140.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 160.0, 162.0, 161.0, 162.0, 162.0, 165.0, 163.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 65.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1491.8999999999999, "alertThreshold": 2.0}]} 13:41:50 INFO - Return code: 0 13:41:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:41:50 INFO - # TBPL SUCCESS # 13:41:50 INFO - Running post-action listener: _resource_record_post_action 13:41:50 INFO - [mozharness: 2016-08-18 20:41:50.775293Z] Finished run-tests step (success) 13:41:50 INFO - Running post-run listener: _resource_record_post_run 13:41:50 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407318528; Read time: 12; Write time: 303364 13:41:50 INFO - TinderboxPrint: CPU usage
13.0% 13:41:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:41:50 INFO - TinderboxPrint: I/O write bytes / time
407,318,528 / 303,364 13:41:50 INFO - TinderboxPrint: CPU idle
8,288.5 (87.0%) 13:41:50 INFO - TinderboxPrint: CPU user
1,195.4 (12.5%) 13:41:50 INFO - TinderboxPrint: Swap in / out
0 / 0 13:41:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117833728; Read time: 0; Write time: 103144 13:41:50 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288985088; Read time: 0; Write time: 200216 13:41:51 INFO - Running post-run listener: _upload_blobber_files 13:41:51 INFO - Blob upload gear active. 13:41:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:41:51 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 13:41:51 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'] 13:41:51 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 13:41:51 INFO - (blobuploader) - INFO - Open directory for files ... 13:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:52 INFO - (blobuploader) - INFO - Done attempting. 13:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:56 INFO - (blobuploader) - INFO - Done attempting. 13:41:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:56 INFO - (blobuploader) - INFO - Done attempting. 13:41:56 INFO - (blobuploader) - INFO - Iteration through files over. 13:41:56 INFO - Return code: 0 13:41:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:41:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:41:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89e5bad343d27bd27d3c9f10293503bf215244ffddb9c5af122012ba5f9c2ac8aac85caf8d9a29ae9075da089a5dcaba13dff7a7f6510d15e8550dc2f33d0c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af85f7ce584c7842d88fd9d6cf492865839ac45517860f415d646ee3d8a9dc071623bbbe121f7ee1ad46b63832a8ca4d3830c62ae25361b8d8f9f401398c6a18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6995f9c01fc9855bc3e89afbf8c04c502e8e9f48e50848a99d358a41b60104fe26cea278ccf64d9428a55f1aaeb4a7e5fdb46bcb2cc5aec724ee74f4693c6f"} 13:41:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:41:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:41:56 INFO - Contents: 13:41:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89e5bad343d27bd27d3c9f10293503bf215244ffddb9c5af122012ba5f9c2ac8aac85caf8d9a29ae9075da089a5dcaba13dff7a7f6510d15e8550dc2f33d0c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af85f7ce584c7842d88fd9d6cf492865839ac45517860f415d646ee3d8a9dc071623bbbe121f7ee1ad46b63832a8ca4d3830c62ae25361b8d8f9f401398c6a18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6995f9c01fc9855bc3e89afbf8c04c502e8e9f48e50848a99d358a41b60104fe26cea278ccf64d9428a55f1aaeb4a7e5fdb46bcb2cc5aec724ee74f4693c6f"} 13:41:56 INFO - Running post-run listener: copy_logs_to_upload_dir 13:41:56 INFO - Copying logs to upload dir... 13:41:56 INFO - mkdir: /builds/slave/test/build/upload/logs 13:41:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.936832 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-18 13:41:56.673802) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:41:56.677636) ========= 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=836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89e5bad343d27bd27d3c9f10293503bf215244ffddb9c5af122012ba5f9c2ac8aac85caf8d9a29ae9075da089a5dcaba13dff7a7f6510d15e8550dc2f33d0c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af85f7ce584c7842d88fd9d6cf492865839ac45517860f415d646ee3d8a9dc071623bbbe121f7ee1ad46b63832a8ca4d3830c62ae25361b8d8f9f401398c6a18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6995f9c01fc9855bc3e89afbf8c04c502e8e9f48e50848a99d358a41b60104fe26cea278ccf64d9428a55f1aaeb4a7e5fdb46bcb2cc5aec724ee74f4693c6f"} build_url:https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89e5bad343d27bd27d3c9f10293503bf215244ffddb9c5af122012ba5f9c2ac8aac85caf8d9a29ae9075da089a5dcaba13dff7a7f6510d15e8550dc2f33d0c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af85f7ce584c7842d88fd9d6cf492865839ac45517860f415d646ee3d8a9dc071623bbbe121f7ee1ad46b63832a8ca4d3830c62ae25361b8d8f9f401398c6a18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa6995f9c01fc9855bc3e89afbf8c04c502e8e9f48e50848a99d358a41b60104fe26cea278ccf64d9428a55f1aaeb4a7e5fdb46bcb2cc5aec724ee74f4693c6f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:41:56.703392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:41:56.703741) ========= 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=836cfdc75598d54cb747368e000001a9-1471551677.253267-461715932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:41:56.788651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:41:56.789062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:41:56.789397) ========= ========= Total master_lag: 0.17 =========