builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1472862984.59 results: success (0) buildid: 20160902143001 builduid: 90c82e2b2f25485e8621580f6d31fbeb revision: 969397f22187cfd25fca153f0d1624dde9490589 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:24.595223) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:24.595912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:24.596259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:24.666184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:24.666476) ========= 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=af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 17:36:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.1M=0s 2016-09-02 17:36:24 (71.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154319 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:24.851891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:24.852226) ========= 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=af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.136361 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:25.104420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 17:36:25.104934) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 969397f22187cfd25fca153f0d1624dde9490589 --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 969397f22187cfd25fca153f0d1624dde9490589 --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=af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 17:36:25,162 truncating revision to first 12 chars 2016-09-02 17:36:25,162 Setting DEBUG logging. 2016-09-02 17:36:25,162 attempt 1/10 2016-09-02 17:36:25,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/969397f22187?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 17:36:26,223 unpacking tar archive at: fx-team-969397f22187/testing/mozharness/ program finished with exit code 0 elapsedTime=1.385618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 17:36:26.505960) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:26.506612) ========= script_repo_revision: 969397f22187cfd25fca153f0d1624dde9490589 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:26.507372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:26.507746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 17:36:26.518705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-09-02 17:36:26.519074) ========= /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=af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:36:26 INFO - MultiFileLogger online at 20160902 17:36:26 in /builds/slave/test 17:36:26 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 17:36:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:26 INFO - {'append_to_log': False, 17:36:26 INFO - 'base_work_dir': '/builds/slave/test', 17:36:26 INFO - 'blob_upload_branch': 'Fx-Team', 17:36:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:26 INFO - 'branch': 'Fx-Team', 17:36:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:26 INFO - 'config_files': ('talos/linux_config.py',), 17:36:26 INFO - 'default_actions': ('clobber', 17:36:26 INFO - 'read-buildbot-config', 17:36:26 INFO - 'download-and-extract', 17:36:26 INFO - 'populate-webroot', 17:36:26 INFO - 'create-virtualenv', 17:36:26 INFO - 'install', 17:36:26 INFO - 'run-tests'), 17:36:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:26 INFO - 'download_minidump_stackwalk': True, 17:36:26 INFO - 'download_symbols': 'ondemand', 17:36:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:26 INFO - 'installer_path': 'installer.exe', 17:36:26 INFO - 'log_level': 'info', 17:36:26 INFO - 'log_name': 'talos', 17:36:26 INFO - 'log_to_console': True, 17:36:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:36:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:36:26 INFO - 'opt_config_files': (), 17:36:26 INFO - 'pip_index': False, 17:36:26 INFO - 'sps_profile': False, 17:36:26 INFO - 'sps_profile_interval': 0, 17:36:26 INFO - 'suite': 'dromaeojs', 17:36:26 INFO - 'system_bits': '32', 17:36:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:26 INFO - 'title': 'talos-linux64-ix-020', 17:36:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:26 INFO - 'use_talos_json': True, 17:36:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:26 INFO - 'work_dir': 'build'} 17:36:26 INFO - [mozharness: 2016-09-03 00:36:26.803525Z] Running clobber step. 17:36:26 INFO - Running pre-action listener: _resource_record_pre_action 17:36:26 INFO - Running main action method: clobber 17:36:26 INFO - rmtree: /builds/slave/test/build 17:36:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:31 INFO - Running post-action listener: _resource_record_post_action 17:36:31 INFO - [mozharness: 2016-09-03 00:36:31.506891Z] Finished clobber step (success) 17:36:31 INFO - [mozharness: 2016-09-03 00:36:31.507023Z] Running read-buildbot-config step. 17:36:31 INFO - Running pre-action listener: _resource_record_pre_action 17:36:31 INFO - Running main action method: read_buildbot_config 17:36:31 INFO - Using buildbot properties: 17:36:31 INFO - { 17:36:31 INFO - "project": "", 17:36:31 INFO - "product": "firefox", 17:36:31 INFO - "script_repo_revision": "production", 17:36:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:36:31 INFO - "repository": "", 17:36:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:36:31 INFO - "buildid": "20160902143001", 17:36:31 INFO - "pgo_build": "True", 17:36:31 INFO - "basedir": "/builds/slave/test", 17:36:31 INFO - "buildnumber": 419, 17:36:31 INFO - "slavename": "talos-linux64-ix-020", 17:36:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:36:31 INFO - "platform": "ubuntu64_hw", 17:36:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:36:31 INFO - "branch": "fx-team", 17:36:31 INFO - "repo_path": "integration/fx-team", 17:36:31 INFO - "revision": "969397f22187cfd25fca153f0d1624dde9490589", 17:36:31 INFO - "stage_platform": "linux64-pgo", 17:36:31 INFO - "builduid": "90c82e2b2f25485e8621580f6d31fbeb", 17:36:31 INFO - "slavebuilddir": "test" 17:36:31 INFO - } 17:36:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:36:31 INFO - Running post-action listener: _resource_record_post_action 17:36:31 INFO - [mozharness: 2016-09-03 00:36:31.510303Z] Finished read-buildbot-config step (success) 17:36:31 INFO - [mozharness: 2016-09-03 00:36:31.510423Z] Running download-and-extract step. 17:36:31 INFO - Running pre-action listener: _resource_record_pre_action 17:36:31 INFO - Running main action method: download_and_extract 17:36:31 INFO - mkdir: /builds/slave/test/build/tests 17:36: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')]} 17:36:31 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:36:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:32 INFO - Downloaded 1361 bytes. 17:36:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:36:32 INFO - Using the following test package requirements: 17:36:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:36:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:36:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'jsshell-linux-x86_64.zip'], 17:36:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:36:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:36:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:36:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:36:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:36:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:36: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')]} 17:36:32 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:36:32 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:32 INFO - Downloaded 21906324 bytes. 17:36:32 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 17:36:37 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 17:36: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')]} 17:36:37 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:36:37 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:38 INFO - Downloaded 21906324 bytes. 17:36:38 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 17:36: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')]} 17:36:44 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:44 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:45 INFO - Downloaded 14413998 bytes. 17:36:45 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 17:36: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')]} 17:36:45 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:36:45 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:36:46 INFO - Downloaded 59699629 bytes. 17:36:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:36:46 INFO - mkdir: /builds/slave/test/properties 17:36:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:46 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:46 INFO - Contents: 17:36:46 INFO - build_url:https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:36:47 INFO - Running post-action listener: _resource_record_post_action 17:36:47 INFO - Running post-action listener: set_extra_try_arguments 17:36:47 INFO - [mozharness: 2016-09-03 00:36:47.427129Z] Finished download-and-extract step (success) 17:36:47 INFO - [mozharness: 2016-09-03 00:36:47.427358Z] Running populate-webroot step. 17:36:47 INFO - Running pre-action listener: _resource_record_pre_action 17:36:47 INFO - Running main action method: populate_webroot 17:36:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:47 INFO - '--tppagecycles', 17:36:47 INFO - '7'], 17:36:47 INFO - 'tests': ['tsvgm']}}, 17:36:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['damp', 'tps']}, 17:36:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'tests': ['damp', 'tps']}, 17:36:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['dromaeo_dom']}, 17:36:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['basic_compositor_video']}, 17:36:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:36:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['a11yr', 17:36:47 INFO - 'ts_paint', 17:36:47 INFO - 'tpaint', 17:36:47 INFO - 'sessionrestore', 17:36:47 INFO - 'sessionrestore_no_auto_restore', 17:36:47 INFO - 'tabpaint']}, 17:36:47 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:47 INFO - 'ts_paint', 17:36:47 INFO - 'tpaint', 17:36:47 INFO - 'sessionrestore', 17:36:47 INFO - 'sessionrestore_no_auto_restore', 17:36:47 INFO - 'tabpaint']}, 17:36:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:47 INFO - 'ts_paint', 17:36:47 INFO - 'tpaint', 17:36:47 INFO - 'sessionrestore', 17:36:47 INFO - 'sessionrestore_no_auto_restore', 17:36:47 INFO - 'tabpaint']}, 17:36:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:47 INFO - 'ts_paint', 17:36:47 INFO - 'tpaint', 17:36:47 INFO - 'sessionrestore', 17:36:47 INFO - 'sessionrestore_no_auto_restore', 17:36:47 INFO - 'tabpaint']}, 17:36:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['a11yr', 17:36:47 INFO - 'ts_paint', 17:36:47 INFO - 'tpaint', 17:36:47 INFO - 'sessionrestore', 17:36:47 INFO - 'sessionrestore_no_auto_restore', 17:36:47 INFO - 'tabpaint']}, 17:36:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['a11yr', 17:36:47 INFO - 'ts_paint', 17:36:47 INFO - 'tpaint', 17:36:47 INFO - 'sessionrestore', 17:36:47 INFO - 'sessionrestore_no_auto_restore', 17:36:47 INFO - 'tabpaint']}, 17:36:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['tsvgx', 17:36:47 INFO - 'tsvgr_opacity', 17:36:47 INFO - 'tart', 17:36:47 INFO - 'tscrollx', 17:36:47 INFO - 'cart']}, 17:36:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:47 INFO - 'tsvgr_opacity', 17:36:47 INFO - 'tart', 17:36:47 INFO - 'tscrollx', 17:36:47 INFO - 'cart']}, 17:36:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'talos_options': ['--disable-e10s'], 17:36:47 INFO - 'tests': ['tp5o']}, 17:36:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'tests': ['tp5o']}, 17:36:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'talos_options': ['--disable-e10s', 17:36:47 INFO - '--xperf_path', 17:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:47 INFO - 'tests': ['tp5n']}, 17:36:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:47 INFO - 'talos_options': ['--xperf_path', 17:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:47 INFO - 'tests': ['tp5n']}}, 17:36:47 INFO - 'talos.zip': {'path': '', 17:36:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:47 INFO - Running post-action listener: _resource_record_post_action 17:36:47 INFO - [mozharness: 2016-09-03 00:36:47.444473Z] Finished populate-webroot step (success) 17:36:47 INFO - [mozharness: 2016-09-03 00:36:47.444563Z] Running create-virtualenv step. 17:36:47 INFO - Running pre-action listener: _resource_record_pre_action 17:36:47 INFO - Running main action method: create_virtualenv 17:36:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:47 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 17:36:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:47 INFO - Using real prefix '/usr' 17:36:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:50 INFO - Installing pip.................done. 17:36:50 INFO - Return code: 0 17:36:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:50 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:36:50 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 17:36:50 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 17:36:50 INFO - Using env: {'DISPLAY': ':0', 17:36:50 INFO - 'HOME': '/home/cltbld', 17:36:50 INFO - 'LANG': 'en_US.UTF-8', 17:36:50 INFO - 'LANGUAGE': 'en_US:en', 17:36:50 INFO - 'LOGNAME': 'cltbld', 17:36:50 INFO - 'MAIL': '/var/mail/cltbld', 17:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:50 INFO - 'MOZ_NO_REMOTE': '1', 17:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:50 INFO - 'NO_EM_RESTART': '1', 17:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:50 INFO - 'PWD': '/builds/slave/test', 17:36:50 INFO - 'SHELL': '/bin/bash', 17:36:50 INFO - 'SHLVL': '1', 17:36:50 INFO - 'TERM': 'linux', 17:36:50 INFO - 'TMOUT': '86400', 17:36:50 INFO - 'USER': 'cltbld', 17:36:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:50 INFO - '_': '/tools/buildbot/bin/python'} 17:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:50 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 17:36:50 INFO - Cleaning up... 17:36:50 INFO - Return code: 0 17:36:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:50 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:36:50 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 17:36:50 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 17:36:50 INFO - Using env: {'DISPLAY': ':0', 17:36:50 INFO - 'HOME': '/home/cltbld', 17:36:50 INFO - 'LANG': 'en_US.UTF-8', 17:36:50 INFO - 'LANGUAGE': 'en_US:en', 17:36:50 INFO - 'LOGNAME': 'cltbld', 17:36:50 INFO - 'MAIL': '/var/mail/cltbld', 17:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:50 INFO - 'MOZ_NO_REMOTE': '1', 17:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:50 INFO - 'NO_EM_RESTART': '1', 17:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:50 INFO - 'PWD': '/builds/slave/test', 17:36:50 INFO - 'SHELL': '/bin/bash', 17:36:50 INFO - 'SHLVL': '1', 17:36:50 INFO - 'TERM': 'linux', 17:36:50 INFO - 'TMOUT': '86400', 17:36:50 INFO - 'USER': 'cltbld', 17:36:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:50 INFO - '_': '/tools/buildbot/bin/python'} 17:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:51 INFO - Downloading/unpacking psutil>=3.1.1 17:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:53 INFO - Installing collected packages: psutil 17:36:53 INFO - Running setup.py install for psutil 17:36:53 INFO - building 'psutil._psutil_linux' extension 17:36:53 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 17:36:54 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 17:36:54 INFO - building 'psutil._psutil_posix' extension 17:36:54 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 17:36:54 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 17:36:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:54 INFO - Successfully installed psutil 17:36:54 INFO - Cleaning up... 17:36:54 INFO - Return code: 0 17:36:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:36:54 INFO - Using env: {'DISPLAY': ':0', 17:36:54 INFO - 'HOME': '/home/cltbld', 17:36:54 INFO - 'LANG': 'en_US.UTF-8', 17:36:54 INFO - 'LANGUAGE': 'en_US:en', 17:36:54 INFO - 'LOGNAME': 'cltbld', 17:36:54 INFO - 'MAIL': '/var/mail/cltbld', 17:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:54 INFO - 'MOZ_NO_REMOTE': '1', 17:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:54 INFO - 'NO_EM_RESTART': '1', 17:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:54 INFO - 'PWD': '/builds/slave/test', 17:36:54 INFO - 'SHELL': '/bin/bash', 17:36:54 INFO - 'SHLVL': '1', 17:36:54 INFO - 'TERM': 'linux', 17:36:54 INFO - 'TMOUT': '86400', 17:36:54 INFO - 'USER': 'cltbld', 17:36:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:54 INFO - '_': '/tools/buildbot/bin/python'} 17:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:36:55 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 17:36:55 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 17:36:55 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 17:36:55 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 17:36:55 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 17:36:55 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 17:36:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:36:56 INFO - Installing collected packages: mozsystemmonitor 17:36:56 INFO - Running setup.py install for mozsystemmonitor 17:36:57 INFO - Successfully installed mozsystemmonitor 17:36:57 INFO - Cleaning up... 17:36:57 INFO - Return code: 0 17:36:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:36:57 INFO - Using env: {'DISPLAY': ':0', 17:36:57 INFO - 'HOME': '/home/cltbld', 17:36:57 INFO - 'LANG': 'en_US.UTF-8', 17:36:57 INFO - 'LANGUAGE': 'en_US:en', 17:36:57 INFO - 'LOGNAME': 'cltbld', 17:36:57 INFO - 'MAIL': '/var/mail/cltbld', 17:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:57 INFO - 'MOZ_NO_REMOTE': '1', 17:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:57 INFO - 'NO_EM_RESTART': '1', 17:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:57 INFO - 'PWD': '/builds/slave/test', 17:36:57 INFO - 'SHELL': '/bin/bash', 17:36:57 INFO - 'SHLVL': '1', 17:36:57 INFO - 'TERM': 'linux', 17:36:57 INFO - 'TMOUT': '86400', 17:36:57 INFO - 'USER': 'cltbld', 17:36:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:57 INFO - '_': '/tools/buildbot/bin/python'} 17:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:57 INFO - Downloading/unpacking jsonschema==2.5.1 17:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:36:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:36:59 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 17:36:59 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 17:36:59 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 17:36:59 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 17:36:59 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 17:36:59 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 17:36:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:36:59 INFO - warning: no files found matching '*.txt' 17:36:59 INFO - no previously-included directories found matching 'build' 17:36:59 INFO - no previously-included directories found matching 'dist' 17:36:59 INFO - no previously-included directories found matching '.git*' 17:36:59 INFO - Installing collected packages: jsonschema, functools32 17:36:59 INFO - Running setup.py install for functools32 17:36:59 INFO - warning: no files found matching '*.txt' 17:36:59 INFO - no previously-included directories found matching 'build' 17:36:59 INFO - no previously-included directories found matching 'dist' 17:36:59 INFO - no previously-included directories found matching '.git*' 17:36:59 INFO - Successfully installed jsonschema functools32 17:36:59 INFO - Cleaning up... 17:36:59 INFO - Return code: 0 17:36:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:36:59 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 17:36:59 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 17:36:59 INFO - Using env: {'DISPLAY': ':0', 17:36:59 INFO - 'HOME': '/home/cltbld', 17:36:59 INFO - 'LANG': 'en_US.UTF-8', 17:36:59 INFO - 'LANGUAGE': 'en_US:en', 17:36:59 INFO - 'LOGNAME': 'cltbld', 17:36:59 INFO - 'MAIL': '/var/mail/cltbld', 17:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:59 INFO - 'MOZ_NO_REMOTE': '1', 17:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:59 INFO - 'NO_EM_RESTART': '1', 17:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:59 INFO - 'PWD': '/builds/slave/test', 17:36:59 INFO - 'SHELL': '/bin/bash', 17:36:59 INFO - 'SHLVL': '1', 17:36:59 INFO - 'TERM': 'linux', 17:36:59 INFO - 'TMOUT': '86400', 17:36:59 INFO - 'USER': 'cltbld', 17:36:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:59 INFO - '_': '/tools/buildbot/bin/python'} 17:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:36:59 INFO - Cleaning up... 17:36:59 INFO - Return code: 0 17:36:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:59 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:36:59 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 17:36:59 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 17:36:59 INFO - Using env: {'DISPLAY': ':0', 17:36:59 INFO - 'HOME': '/home/cltbld', 17:36:59 INFO - 'LANG': 'en_US.UTF-8', 17:36:59 INFO - 'LANGUAGE': 'en_US:en', 17:36:59 INFO - 'LOGNAME': 'cltbld', 17:36:59 INFO - 'MAIL': '/var/mail/cltbld', 17:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:59 INFO - 'MOZ_NO_REMOTE': '1', 17:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:59 INFO - 'NO_EM_RESTART': '1', 17:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:59 INFO - 'PWD': '/builds/slave/test', 17:36:59 INFO - 'SHELL': '/bin/bash', 17:36:59 INFO - 'SHLVL': '1', 17:36:59 INFO - 'TERM': 'linux', 17:36:59 INFO - 'TMOUT': '86400', 17:36:59 INFO - 'USER': 'cltbld', 17:36:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:59 INFO - '_': '/tools/buildbot/bin/python'} 17:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:37:00 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 17:37:00 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 17:37:00 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 17:37:00 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 17:37:00 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 17:37:00 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 17:37:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:37:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:37:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:02 INFO - Downloading docopt-0.6.1.tar.gz 17:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:37:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:37:02 INFO - Running setup.py install for blobuploader 17:37:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:37:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:37:02 INFO - Running setup.py install for requests 17:37:03 INFO - Running setup.py install for docopt 17:37:03 INFO - Successfully installed blobuploader requests docopt 17:37:03 INFO - Cleaning up... 17:37:03 INFO - Return code: 0 17:37:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:03 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')]} 17:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:03 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')]} 17:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:03 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:37:03 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 17:37:03 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 17:37:03 INFO - Using env: {'DISPLAY': ':0', 17:37:03 INFO - 'HOME': '/home/cltbld', 17:37:03 INFO - 'LANG': 'en_US.UTF-8', 17:37:03 INFO - 'LANGUAGE': 'en_US:en', 17:37:03 INFO - 'LOGNAME': 'cltbld', 17:37:03 INFO - 'MAIL': '/var/mail/cltbld', 17:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:03 INFO - 'MOZ_NO_REMOTE': '1', 17:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:03 INFO - 'NO_EM_RESTART': '1', 17:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:03 INFO - 'PWD': '/builds/slave/test', 17:37:03 INFO - 'SHELL': '/bin/bash', 17:37:03 INFO - 'SHLVL': '1', 17:37:03 INFO - 'TERM': 'linux', 17:37:03 INFO - 'TMOUT': '86400', 17:37:03 INFO - 'USER': 'cltbld', 17:37:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:03 INFO - '_': '/tools/buildbot/bin/python'} 17:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:03 INFO - Running setup.py (path:/tmp/pip-3VkazS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:03 INFO - Running setup.py (path:/tmp/pip-2B207u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:03 INFO - Running setup.py (path:/tmp/pip-ZUUGr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:03 INFO - Running setup.py (path:/tmp/pip-Gs3b2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:03 INFO - Running setup.py (path:/tmp/pip-gXPRVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:03 INFO - Running setup.py (path:/tmp/pip-Am5JNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:03 INFO - Running setup.py (path:/tmp/pip-FGezbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:04 INFO - Running setup.py (path:/tmp/pip-Ne_y_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:04 INFO - Running setup.py (path:/tmp/pip-wpVG5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:04 INFO - Running setup.py (path:/tmp/pip-CGc8IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:04 INFO - Running setup.py (path:/tmp/pip-IQQA6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:04 INFO - Running setup.py (path:/tmp/pip-e3FxxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:04 INFO - Running setup.py (path:/tmp/pip-axwRaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:04 INFO - Running setup.py (path:/tmp/pip-BiZyhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:04 INFO - Running setup.py (path:/tmp/pip-G5JWm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:04 INFO - Running setup.py (path:/tmp/pip-YLHgGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:04 INFO - Running setup.py (path:/tmp/pip-kr9u3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:37:04 INFO - Running setup.py install for manifestparser 17:37:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Running setup.py install for mozcrash 17:37:05 INFO - Running setup.py install for mozdebug 17:37:05 INFO - Running setup.py install for mozdevice 17:37:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for mozfile 17:37:05 INFO - Running setup.py install for mozhttpd 17:37:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for mozinfo 17:37:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for mozInstall 17:37:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for mozleak 17:37:05 INFO - Running setup.py install for mozlog 17:37:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for moznetwork 17:37:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for mozprocess 17:37:06 INFO - Running setup.py install for mozprofile 17:37:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:37:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:37:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:37:06 INFO - Running setup.py install for mozrunner 17:37:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:37:06 INFO - Running setup.py install for mozscreenshot 17:37:06 INFO - Running setup.py install for moztest 17:37:06 INFO - Running setup.py install for mozversion 17:37:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:37:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:37:06 INFO - Cleaning up... 17:37:06 INFO - Return code: 0 17:37:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:06 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')]} 17:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:06 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')]} 17:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:06 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:37:06 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 17:37:06 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 17:37:06 INFO - Using env: {'DISPLAY': ':0', 17:37:06 INFO - 'HOME': '/home/cltbld', 17:37:06 INFO - 'LANG': 'en_US.UTF-8', 17:37:06 INFO - 'LANGUAGE': 'en_US:en', 17:37:06 INFO - 'LOGNAME': 'cltbld', 17:37:06 INFO - 'MAIL': '/var/mail/cltbld', 17:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:06 INFO - 'MOZ_NO_REMOTE': '1', 17:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:06 INFO - 'NO_EM_RESTART': '1', 17:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:06 INFO - 'PWD': '/builds/slave/test', 17:37:06 INFO - 'SHELL': '/bin/bash', 17:37:06 INFO - 'SHLVL': '1', 17:37:06 INFO - 'TERM': 'linux', 17:37:06 INFO - 'TMOUT': '86400', 17:37:06 INFO - 'USER': 'cltbld', 17:37:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:06 INFO - '_': '/tools/buildbot/bin/python'} 17:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:06 INFO - Running setup.py (path:/tmp/pip-_25lCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:06 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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:06 INFO - Running setup.py (path:/tmp/pip-sRvA1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:06 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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:06 INFO - Running setup.py (path:/tmp/pip-0l0kw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:07 INFO - Running setup.py (path:/tmp/pip-e1Pw0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:07 INFO - Running setup.py (path:/tmp/pip-fkUlIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:07 INFO - Running setup.py (path:/tmp/pip-EweAvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:07 INFO - Running setup.py (path:/tmp/pip-XKfiWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:07 INFO - Running setup.py (path:/tmp/pip-hYm4q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:07 INFO - Running setup.py (path:/tmp/pip-ASDFAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:07 INFO - Running setup.py (path:/tmp/pip-BwkT3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:07 INFO - Running setup.py (path:/tmp/pip-wOXzEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:07 INFO - Running setup.py (path:/tmp/pip-k7Wqgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:07 INFO - Running setup.py (path:/tmp/pip-3fhTGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:07 INFO - Running setup.py (path:/tmp/pip-NrzLOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:07 INFO - Running setup.py (path:/tmp/pip-vEEmIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:07 INFO - Running setup.py (path:/tmp/pip-FVq4B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:08 INFO - Running setup.py (path:/tmp/pip-WNT9B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:37:08 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 17:37:08 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 17:37:08 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 17:37:08 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 17:37:08 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 17:37:08 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 17:37:09 INFO - Downloading blessings-1.6.tar.gz 17:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:37:10 INFO - Installing collected packages: blessings 17:37:10 INFO - Running setup.py install for blessings 17:37:10 INFO - Successfully installed blessings 17:37:10 INFO - Cleaning up... 17:37:10 INFO - Return code: 0 17:37:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:10 INFO - Reading from file tmpfile_stdout 17:37:10 INFO - Current package versions: 17:37:10 INFO - argparse == 1.2.1 17:37:10 INFO - blessings == 1.6 17:37:10 INFO - blobuploader == 1.2.4 17:37:10 INFO - docopt == 0.6.1 17:37:10 INFO - functools32 == 3.2.3-2 17:37:10 INFO - jsonschema == 2.5.1 17:37:10 INFO - manifestparser == 1.1 17:37:10 INFO - mozInstall == 1.12 17:37:10 INFO - mozcrash == 0.17 17:37:10 INFO - mozdebug == 0.1 17:37:10 INFO - mozdevice == 0.48 17:37:10 INFO - mozfile == 1.2 17:37:10 INFO - mozhttpd == 0.7 17:37:10 INFO - mozinfo == 0.9 17:37:10 INFO - mozleak == 0.1 17:37:10 INFO - mozlog == 3.3 17:37:10 INFO - moznetwork == 0.27 17:37:10 INFO - mozprocess == 0.23 17:37:10 INFO - mozprofile == 0.28 17:37:10 INFO - mozrunner == 6.12 17:37:10 INFO - mozscreenshot == 0.1 17:37:10 INFO - mozsystemmonitor == 0.3 17:37:10 INFO - moztest == 0.7 17:37:10 INFO - mozversion == 1.4 17:37:10 INFO - psutil == 3.1.1 17:37:10 INFO - requests == 1.2.3 17:37:10 INFO - wsgiref == 0.1.2 17:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:10 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')]} 17:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:10 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')]} 17:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:10 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:37:10 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 17:37:10 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 17:37:10 INFO - Using env: {'DISPLAY': ':0', 17:37:10 INFO - 'HOME': '/home/cltbld', 17:37:10 INFO - 'LANG': 'en_US.UTF-8', 17:37:10 INFO - 'LANGUAGE': 'en_US:en', 17:37:10 INFO - 'LOGNAME': 'cltbld', 17:37:10 INFO - 'MAIL': '/var/mail/cltbld', 17:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:10 INFO - 'MOZ_NO_REMOTE': '1', 17:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:10 INFO - 'NO_EM_RESTART': '1', 17:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:10 INFO - 'PWD': '/builds/slave/test', 17:37:10 INFO - 'SHELL': '/bin/bash', 17:37:10 INFO - 'SHLVL': '1', 17:37:10 INFO - 'TERM': 'linux', 17:37:10 INFO - 'TMOUT': '86400', 17:37:10 INFO - 'USER': 'cltbld', 17:37:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:10 INFO - '_': '/tools/buildbot/bin/python'} 17:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 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)) 17:37:10 INFO - Cleaning up... 17:37:10 INFO - Return code: 0 17:37:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:37:10 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')]} 17:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:10 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')]} 17:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:10 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 0x7f595cf2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1166850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, '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': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', '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 17:37:10 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 17:37:10 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 17:37:10 INFO - Using env: {'DISPLAY': ':0', 17:37:10 INFO - 'HOME': '/home/cltbld', 17:37:10 INFO - 'LANG': 'en_US.UTF-8', 17:37:10 INFO - 'LANGUAGE': 'en_US:en', 17:37:10 INFO - 'LOGNAME': 'cltbld', 17:37:10 INFO - 'MAIL': '/var/mail/cltbld', 17:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:10 INFO - 'MOZ_NO_REMOTE': '1', 17:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:10 INFO - 'NO_EM_RESTART': '1', 17:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:10 INFO - 'PWD': '/builds/slave/test', 17:37:10 INFO - 'SHELL': '/bin/bash', 17:37:10 INFO - 'SHLVL': '1', 17:37:10 INFO - 'TERM': 'linux', 17:37:10 INFO - 'TMOUT': '86400', 17:37:10 INFO - 'USER': 'cltbld', 17:37:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:10 INFO - '_': '/tools/buildbot/bin/python'} 17:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:37:10 INFO - Cleaning up... 17:37:10 INFO - Return code: 0 17:37:10 INFO - Running post-action listener: _resource_record_post_action 17:37:10 INFO - Running post-action listener: _start_resource_monitoring 17:37:10 INFO - Starting resource monitoring. 17:37:10 INFO - [mozharness: 2016-09-03 00:37:10.933723Z] Finished create-virtualenv step (success) 17:37:10 INFO - [mozharness: 2016-09-03 00:37:10.934708Z] Running install step. 17:37:10 INFO - Running pre-action listener: _resource_record_pre_action 17:37:10 INFO - Running main action method: install 17:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:11 INFO - Reading from file tmpfile_stdout 17:37:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:37:11 INFO - Reading from file tmpfile_stdout 17:37:11 INFO - Output received: 17:37:11 INFO - Usage: mozinstall [options] installer 17:37:11 INFO - Options: 17:37:11 INFO - -h, --help show this help message and exit 17:37:11 INFO - -d DEST, --destination=DEST 17:37:11 INFO - Directory to install application into. [default: 17:37:11 INFO - "/builds/slave/test"] 17:37:11 INFO - --app=APP Application being installed. [default: firefox] 17:37:11 INFO - mkdir: /builds/slave/test/build/application 17:37:11 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'] 17:37:11 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 17:37:28 INFO - Reading from file tmpfile_stdout 17:37:28 INFO - Output received: 17:37:28 INFO - /builds/slave/test/build/application/firefox/firefox 17:37:28 INFO - Running post-action listener: _resource_record_post_action 17:37:28 INFO - [mozharness: 2016-09-03 00:37:28.190223Z] Finished install step (success) 17:37:28 INFO - [mozharness: 2016-09-03 00:37:28.190505Z] Running run-tests step. 17:37:28 INFO - Running pre-action listener: _resource_record_pre_action 17:37:28 INFO - Running main action method: run_tests 17:37:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:28 INFO - Python 2.7.3 17:37:28 INFO - Return code: 0 17:37:28 INFO - grabbing minidump binary from tooltool 17:37:28 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')]} 17:37:28 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 0x1161370>, '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 0x11648f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1164d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:28 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 17:37:28 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 17:37:28 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 17:37:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:28 INFO - Return code: 0 17:37:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:37:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:37:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:28 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/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:37:28 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/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 17:37:28 INFO - Using env: {'DISPLAY': ':0', 17:37:28 INFO - 'HOME': '/home/cltbld', 17:37:28 INFO - 'LANG': 'en_US.UTF-8', 17:37:28 INFO - 'LANGUAGE': 'en_US:en', 17:37:28 INFO - 'LOGNAME': 'cltbld', 17:37:28 INFO - 'MAIL': '/var/mail/cltbld', 17:37:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:28 INFO - 'MOZ_NO_REMOTE': '1', 17:37:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:28 INFO - 'NO_EM_RESTART': '1', 17:37:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:28 INFO - 'PWD': '/builds/slave/test', 17:37:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:28 INFO - 'SHELL': '/bin/bash', 17:37:28 INFO - 'SHLVL': '1', 17:37:28 INFO - 'TERM': 'linux', 17:37:28 INFO - 'TMOUT': '86400', 17:37:28 INFO - 'USER': 'cltbld', 17:37:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564', 17:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:28 INFO - '_': '/tools/buildbot/bin/python'} 17:37:28 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/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:37:28 INFO - mozversion application_buildid: 20160902143001 17:37:28 INFO - mozversion application_changeset: 969397f22187cfd25fca153f0d1624dde9490589 17:37:28 INFO - mozversion application_display_name: Nightly 17:37:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:28 INFO - mozversion application_name: Firefox 17:37:28 INFO - mozversion application_remotingname: firefox 17:37:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:37:28 INFO - mozversion application_vendor: Mozilla 17:37:28 INFO - mozversion application_version: 51.0a1 17:37:28 INFO - mozversion platform_buildid: 20160902143001 17:37:28 INFO - mozversion platform_changeset: 969397f22187cfd25fca153f0d1624dde9490589 17:37:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:37:28 INFO - mozversion platform_version: 51.0a1 17:37:28 INFO - using testdate: 1472863048 17:37:28 INFO - actual date: 1472863048 17:37:28 INFO - starting webserver on 'localhost:44448' 17:37:28 INFO - SUITE-START | Running 2 tests 17:37:28 INFO - TEST-START | dromaeo_css 17:37:28 INFO - operating with platform_type : linux_ 17:37:28 INFO - Initialising browser for dromaeo_css test... 17:37:28 INFO - TEST-INFO | started process 3315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4qUucH/profile http://localhost:44448/getInfo.html) 17:37:38 INFO - PROCESS | 3315 | __metrics Screen width/height:1600/1200 17:37:38 INFO - PROCESS | 3315 | colorDepth:24 17:37:38 INFO - PROCESS | 3315 | Browser inner width/height: 1024/697 17:37:38 INFO - PROCESS | 3315 | __metrics 17:37:38 INFO - PROCESS | 3315 | 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" 17:37:38 INFO - PROCESS | 3315 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:39 INFO - PROCESS | 3315 | console.error: PushService: 17:37:39 INFO - PROCESS | 3315 | stateChangeProcessEnqueue: Error transitioning state 17:37:39 INFO - PROCESS | 3315 | UnknownError 17:37:40 INFO - TEST-INFO | 3315: exit 0 17:37:40 INFO - Browser initialized. 17:37:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:40 INFO - TEST-INFO | started process 3396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4qUucH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:52 INFO - PROCESS | 3396 | RSS: Main: 179417088 17:37:52 INFO - PROCESS | 3396 | 17:38:43 INFO - PROCESS | 3396 | 1472863123522 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] 17:40:53 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:44448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44448/tests/dromaeo/cssquery-ext.html) 17:40:54 INFO - PROCESS | 3396 | RSS: Main: 304095232 17:40:54 INFO - PROCESS | 3396 | 17:43:56 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:44448/tests/dromaeo/cssquery-ext.html (next: http://localhost:44448/tests/dromaeo/cssquery-jquery.html) 17:43:57 INFO - PROCESS | 3396 | RSS: Main: 276815872 17:43:57 INFO - PROCESS | 3396 | 17:46:59 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:44448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44448/tests/dromaeo/cssquery-mootools.html) 17:47:00 INFO - PROCESS | 3396 | RSS: Main: 215699456 17:47:00 INFO - PROCESS | 3396 | 17:50:02 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:44448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44448/tests/dromaeo/cssquery-prototype.html) 17:50:02 INFO - PROCESS | 3396 | RSS: Main: 271458304 17:50:02 INFO - PROCESS | 3396 | 17:53:05 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:44448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44448/tests/dromaeo/cssquery-yui.html) 17:53:06 INFO - PROCESS | 3396 | RSS: Main: 215506944 17:53:06 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:44448/tests/dromaeo/cssquery-yui.html (next: http://localhost:44448/tests/dromaeo/cssquery-dojo.html) 17:56:09 INFO - PROCESS | 3396 | RSS: Main: 305598464 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | __start_tp_report 17:56:09 INFO - PROCESS | 3396 | _x_x_mozilla_page_load 17:56:09 INFO - PROCESS | 3396 | _x_x_mozilla_page_load_details 17:56:09 INFO - PROCESS | 3396 | |i|pagename|runs| 17:56:09 INFO - PROCESS | 3396 | |0;dojo.html;2976.8660410281536;2982.4482470742905;2986.9850650746757;3020.199647093519;3042.3915216956616;5117.488251174881;5192.71440070796;5204.063268611649;5259.316288882449;5263.815766448175;5219.686818790875;5232.8691782705355;5282.7358632068335;5308.044551980642;5318.282031925699;4686.109639168547;4709.128811169928;4746.928796068062;4756.548127927841;4911.607071434295;4857.635677324215;4871.415430148387;4894.461609222983;4913.434954980169;4927.162382394984;4757.666963312569;4766.785494652749;4767.451743049559;4796.424429068499;4820.8071677132875;4769.952300476985;4774.140654682155;4782.30656554801;4833.202521583935;4845;4735.15685701983;4739.668223224376;4742.644301677354;4747.572718455355;4821.204501257288;5074.644774865761;5120.1039818031695;5184.092783762864;5189.766460509286;5190.2993095932325;5519.034169020405;5527.198556209327;5529.751161197756;5533.253010843525;5562.193481945135;5547.472990065978;5551.750171242264;5553.77784888608;5560.221568980346;5562.193481945095;5123.846284611468;5124.692518448905;5150.690958542499;5166.095933211673;5172.482751724835;5628.183913332544;5628.71856407178;5685.630434021776;5686.317641883001;5697.3448053474385;5417.6478528895495;5418.593605479605;5420.83737487876;5422.783088676409;5428.511433970962;5484.61607687466;5487.945120548743;5516.586256030814;5526.861828454321;5543.445655434505;5475.825553852591;5499.1476321170285;5504.834854954358;5505.862353441116;5563.777448902079;5494.08508925771;5539.390667026624;5544.390117087117;5551.555875529948;5555.916661250085;4221;4259.680523960716;4263.978680106579;4303.591158839905;4371.191329604034;3861.054041759731;3887.4946256986977;3888.3389823730035;3888.8055597220027;3889.883303500843;5227.947720522746;5237.580993520509;5237.580993520509;5238.869028274324;5241.187615919539;5518.641288316327;5527.419620939824;5540.556755459554;5558.861028474321;5588.161775733673;5220.243064755665;5270.262163297141;5275.261463395128;5281.102212623863;5319.255304257407;4804.2073057945745;4828.155072862305;4831.492693267156;4835.637327200474;4884.242942343943;5647.802326918538;5654.74553645087;5678.432156784371;5716.114002329646;5752.36723960364;5507.146392309199;5512.09050506678;5513.173024046425;5516.586256030733;5569.916451253153;5713.9428605715075;5716.28546431696;5718.285214348207;5726.255586773859;5730.083186690276;5394.568434525307;5400.810971615974;5407.78368865241;5446.836594902159;5459.262999495176;5524.861878453071;5532.336119665666;5532.861678458071;5534.612577119563;5594.38461769197;5418.539424148991;5457.836264912059;5459.972700136474;5464.398916119144;5530.806421775219;5382.434844341445;5416.133418652997;5455.536279416294;5513.035218836607;5518.66887986706;5457.454254574511;5461.644993075437;5462.180672898938;5464.972675136599;5511.889762204813;5486.753096110764;5515.779368825202;5542.140968149944;5558.249636299048;5562.554995600423;5283.709395983258;5288.444713305047;5333.773232156548;5345.1447768356875;5481.123020316731 17:56:09 INFO - PROCESS | 3396 | |1;ext.html;548.7486208698683;591.8194950540085;598.679706357099;604.5707547641175;605.0379895965416;31778.523322150188;32704.836475817618;35189.82405087974;42566;43752.781236093775;45324.093518129615;46136.3079553807;46154;46177.7691111544;46204;8853.203211710945;8990.37067405282;9005.459672419676;9006.099390061006;9008.0541543138;8800.911990880106;8894.555272236395;8899.065598112202;8901.821963560726;8904.376693631448;8908.331875109392;8986.415882967618;9011.774705632346;9012.54937253138;9017.549122543847;8896.0659130791;8941.821163576724;8956.507392093432;8982.550872456351;8988;8872.512011839346;8949.552522373855;8962.14859588338;8962.68630597926;8965.372423930328;42778.1444371114;42831.57168428338;42934.57065429368;42963.35554966678;43179;3413.197898493852;3484.9128771780656;3496.860125594973;3520.4719292106133;3571.535700358963;32498.18754531132;32574.18564535882;32647;32741.83629081839;33201.6679833201;4163.354680024601;4287.528371879091;4312.417823593806;4329.090890912912;4427.291633338683;354254.2287288573;355339;355595;357438;359899;47866.28200576994;48054;48777;52477.7376113117;53984.730076350155;52413.213801793005;57083.429165707814;57409.425905740405;57517;57588;16715;16844.410445634345;16860.494185174466;16870.240839162267;16877.831221687873;12610.558630448073;12641.620751377473;12650.873491265154;12653.557125500563;12658.367081646065;14393.496227631982;15922.60193495172;16360.181990900408;16379.262933168036;16698.499045028668;6432.421082102634;6529.934700652932;6557.852230929181;6579.47364210862;6640.177924382118;908.8091500784909;983.2085171436919;1005.8088963096989;1036.6060896859144;1044.9373037617615;32706;33041.33917321688;33121.83439082837;33130;33667.15832104217;1062.9476817950328;1081.7782354617284;1083.4041277297456;1091.0834898684984;1133.6769020829024;16563.585910352336;17123.22945467457;17163.485095447155;17223.56941076483;17489.387871424693;477612;479998;482373;482505;484246;57818.4218157813;58093.70953145207;58151.70924145352;58286.708566456895;58303.41696583065;1215.9209651372632;1305.614843621134;1336.2984433172662;1356.9796453053016;1360.177092858826;31395.37209255848;32612.673873261912;33432.665673342955;33633.78367575342;34364.65635343615;48854;49103;49300;49450.50549494459;49937;400293;400994;402026;402194;402225;27391;28466.146015619564;28472.017396955864;29111.417771644872;29296.26759331034;47054.294185587925;47747.52252477431;48048;48083.75958120187;49567.50432495629;39661.60338396579;39792.602073980044;39989.80005099956;40785;41487.377689334084;39918.60081399265;41289;41391.58608413878;41401.792991036054;42332.36501452542;40262;40666.79666601648;40696.593034070465;40811.14448948572;40997.795011024755;33531;36049.459258110626;36348;37048.81475592605;37431.62568374391;27936;28006;28035.859820701582;28062.719372806827;28081.297967550974 17:56:09 INFO - PROCESS | 3396 | |2;jquery.html;382.4760078692192;397.4182752644475;411.92791261529237;414.37636357282287;427.25870614483887;15273.847261527382;19070.2371905124;19346.419607411783;19969.500762480908;20144.09351579179;12475;12686.746265074693;12782.296973666467;13674.93162534186;19027.33404330849;5176.715280659562;5355.277037599933;5359.115745901921;5362.8123015694455;5370.275012873251;5076.923846142311;5212.6611770235;5215.921761173586;5244.554212891909;5248.685078895279;5249;5253.3170687810725;5257.080010998079;5258.106121959257;5258.947410525903;5245.26566280721;5309.867253318678;5582.525485333711;5607.691576963286;5636.126400407943;5115.2327150927285;5122.0268149051935;5130.640855140142;5132.897342053176;5133.358330208724;14530.200838953853;17882.642347152985;22161.556768864695;23169.884150579306;23313.883430582908;2320.5706944215376;2400.459896523268;2441.987790061056;2448.8285819992607;2919.8394088325135;10505;10796.082333001705;13186.736265274641;14547.127172369692;15383.61540961485;1846.3076346370112;1930.4884205685505;1930.710393440981;1967.616314818611;1969.8818070915647;67339.66330168318;75686;81167.5941620294;83225.16774832235;85424;9884.950575247078;10341.689749307532;10390.220733445021;10809.729756756144;10881.619143329945;14603.269836508345;14637.92681036588;14642.85357146415;14657.853421465863;14688.55934321972;7607.35337496319;7818.335441487424;7832.373410127176;8025.117237103914;8027.598620068973;7529.698812047457;7599.924000760032;7721.189275126143;7721.420893433015;7792.454528182972;4509.954900450954;4520.570545798144;4554.7039442436135;4555.339475775994;4697.553732395417;1950.5806251655963;1952.7851936286997;2045.6805360542664;2064.9380518584467;2091.7280753501946;893.6112790935964;957.674390707163;1004.492731170754;1008.6318493749728;1034.8913364096811;19848.206071757257;19937.800621993883;20049.799502005084;20056.09747561363;20071.59856802856;946.6402766948653;974.780674348266;976.1653786012856;1023.8668973033458;1055.4775386183887;10346.586136554604;10950.507227174796;11036.061934735477;11059.447027648584;11088.33469991803;441733;448970;461056;465399;471760;88120.55939720389;89259.55370223107;90503;95105.52447237719;99726;497.5546885537424;518.3494714133737;518.7924830068004;519.5791408958755;520.0768635671637;11027.228094033662;11411.372374519482;11675.416229188677;11878.881211188123;12024.639260822189;40726;42358.36462453004;42811.78594107134;43397.349039763794;43680.94233403759;56858;57593;58358.4164158353;60035.099473507056;61403.385966141555;8467.703630372907;8578.356623253156;8590.484570925764;8920.063393343606;9001.549922503718;12881.098323117292;13659.931700341434;13728.45086196541;13730;13735.313234338442;11828.526858925547;11949.76100478003;11985.520579177084;12153.756924861631;12215.877841221474;11596.652100437;11700.531978720755;11890.34603096838;11981;12313.13808033465;11808.94095529517;11867.347295898808;12043.578474753342;12203.267803931793;12219.633410997685;8761.729549215455;9058.592363343534;9061.456312621263;9223.169914707709;9295.814083718424;11686.357250351311;11886;12014.75970480568;12077.51689932393;12389.814152787896 17:56:09 INFO - PROCESS | 3396 | |3;mootools.html;1316.2365827819865;1466.9119852808828;1489.1586253766623;1639.1804097951024;1767.5846176148596;8682.479051256922;9168.633254669814;9179.816403671932;9479.81040379192;9482.715518534438;9267.351285410025;9380.812383752322;9391.859122113174;9393.060693930604;9397.201237894787;2385.5944489436793;2399.9640005399933;2402.267308470916;2413.8913748881255;2415.625578035407;2350.7766762157653;2401.9759802402014;2403.843750156243;2419.8790060496995;2422.8546287222734;2389.749076346976;2394.030417680842;2402.003168684994;2439.4633180700216;2456.520978409211;2346.0967527502034;2347.2840783561005;2364.160722943356;2364.207990323235;2383.165891937808;2297.184499502669;2337.076854642407;2341.2156927429332;2343.871087090209;2350.2361732436857;9205.171534561854;9223.123803238681;9241.815163696689;9372.8594071089;9390.060993900624;5355.892882142335;5637.943620563783;5640.041192997201;5642.7742890284335;5643.520300774439;3505.8071806050657;3520.7535472516934;3558.3594952908466;3576.5529308836394;3577.5706915170344;1179.204037274836;1211.7818792617325;1216.3700641140913;1228.8955438787714;1229.4221715793562;13093.607191784262;13111.803322950163;13216.867831321755;13280.468781248836;13298.800517992238;4576.336431217454;4653.534646535387;4819.831305904277;4821.63837712173;4911.877203069952;10288.228382871315;10298.073173414428;10308.484575771181;10318.48407579633;10319.122874555596;5538.418466061086;5542.944570554324;5562.833115006556;5564.387917329091;5570.248016517799;4569.497355290915;4808.831690890872;4987.600991920638;5027.723475208899;5164.070467315919;4065.1869626074904;4090.734102283342;4258.850940217078;4279.786010699452;4301.462317210348;1306.4969986555054;1365.180891465113;1367.548708926052;1378.641553196156;1383.688670049231;766.5822126940831;863.4430792139035;902.700629200261;932.2914584915513;952.5284983932997;6209.068639704081;6252.468540174045;6344.333844946306;6362.681865906686;6559.8360040998405;971.7910649210454;990.277097718655;1003.3628645809963;1017.2014968249888;1023.457567489217;4193.077522944947;4205.3902184183125;4222.05003874132;4314.848980285675;4318.956810431919;11208.327500350006;11365;11517.424128793527;11680.357580332993;11898.762024759457;11585.594504192313;11609.535618575332;11623.88376116245;11630.185886987829;11633.127515436207;8436.45163064399;8639.265662418638;8718.258947989365;8763;8771.079036701181;6033.849153771191;6050.394960503914;6169.105479705508;6191.442770150708;6259.061140828912;9877;10655.733606659896;10740.516676749721;10751.516181771683;10880.727981800519;10390.688279351632;10621.468926553487;10710.464476775975;10778.730531736455;10779.461026948778;7096.645167741489;7213.278672132745;7772.222777722182;7950.4832185907735;8116.553589552631;8798.604062817316;8980.101989800967;8986.68546600866;8993.235574975939;8994.055624159631;7688.615569221628;7924.524528528307;8077.192280771876;8125.959370203112;8149.307308878811;7706.922930770845;7763.4953728007495;7979.321757650665;7993.360531157377;8135.633896474555;7084.397826184832;7276.527025743521;7349.669264882986;7371.373433258019;7372.336489715952;5225.634205605723;5348.893022139613;5461.590380721383;5522.502974732293;5684.289463817023;5350.117230656898;5574.219609254626;5590.664560126405;5609.158626206102;5647.531641773086 17:56:09 INFO - PROCESS | 3396 | |4;prototype.html;331.69728056302006;335.41135307535274;340.09365042162636;344.693223031502;348.0585017527588;5199.296365889735;5226.346706661668;5242.423333433319;5262.526372626463;5312.654677445973;5190.662606930547;5211.739413029343;5212.921806172911;5231.764570594323;5241.39723931748;4145.502539695241;4158.896027599311;4160.188763191179;4203.117345357478;4221.05026369066;3744.6068162842917;3918.490596222487;4103.871435355271;4120.217158739845;4140.896477588054;4069.267531844267;4077.7757223352705;4093.1199792044704;4102.261592913274;4115.053537686334;3939.7439166454374;4131.863737472189;4137.379393091031;4145.440365550642;4158.91868114291;3604.540161234704;3652.0687224757517;3661.4507823826375;3682.5212722345923;3683.650053244964;5035.974820125876;5047.772850221712;5050.267711181895;5058.544730974193;5096.1846104623455;4705.317728929286;4711.717296962159;4730.5032971538185;4749.311349854286;4752.4297084349755;5149.356330458692;5346.6524675896335;5362.329708786402;5375.301210842605;5418.864528386822;3871.8644847430205;3884.7950440886384;3885.698291072494;3886.6113388661192;3926.4110383442426;5361.437049109826;5534.335879694422;5591.860203494904;5630.577706672016;5651.9152212716845;3936.9606303937167;3940.2907476654477;3943.290207762573;3969.960300397017;4023;4002.239014833464;4005.399190121505;4011.618896204856;4019.879403617896;4023.8472417256626;4502.392177056121;4560.543945605479;4592.357070010201;4606.447226332862;4626.884327891829;5379.65032272901;5384.784608615611;5396.298481197419;5414.377346605112;5438.83683489496;1371.9314034298245;1385.25888649572;1391.4276867140068;1393.4565519447424;1395.1907893421792;862.2972277593741;891.2691592893894;908.497741207635;919.6643225222746;927.4759760735298;4527.411436513298;4602.102589994919;4614.907701845944;4632.911265852522;4654;4796.832110876103;4869.561739443397;4878.243872199815;4901;4908.779104940286;4346.348047792793;4625.884352891205;4655.976720116446;4663.580277775017;4675.2052151134385;2547.210364786922;2549.464612431373;2578.265194419619;2579.9742002579733;2587.3790290330185;4949.65352425334;4953.900921981613;5004.324416203839;5013.523715247045;5061.519155680205;4760.59534939534;4861.586765124934;4953.405591328991;4986.706115187055;5011.84964451067;4988.451270360258;5019.745063734066;5042.495750424928;5043.9747801260755;5045.571126454292;4824.348712923851;4889.87290528607;4904.632152588499;4909.7545122743;4963.461326988645;4488.932666009947;4785.449673287477;4796.8081276748535;4815.879603009813;4837.427835953259;4938.358013458371;4957.95926320048;5419.972900135474;5508.834734957958;5647.915281270702;4012.177503611694;4015.297322968527;4020.83916643331;4030.5364883038824;4045.777482238505;5497.587680924026;5542.861428464321;5551.361593416647;5565.636419077352;5599.160125981135;5187.299714538489;5362.168863826113;5369.496540968535;5386.865328366822;5472.589555783253;5340.679559226459;5351.59863010268;5356.785728570813;5359.866003349947;5363.785448582013;5357.598180136583;5360.92781443705;5367.087595108919;5374.973125134349;5376.489233522809;5140.228965655182;5407.78368865241;5412.242286080031;5414.377346605033;5440.292761940922;5275.973620131875;5282.630215884851;5320.574354051744;5329.733513324396;5366.785328586813 17:56:09 INFO - PROCESS | 3396 | |5;yui.html;705.3193668110273;733.2264460993649;740.2116745665866;774.2721841469017;792.184050428059;14076.64808379791;14732;14743.77884331736;14817.851821481781;14831.629209269773;12587.307698076625;13664.72670546591;13766.105203161813;13796.931015344935;13829.585112446617;771.1671394893501;777.4713195027379;778.3034184404954;779.5322806316193;792.7265093542718;813.4753084260649;815.2866242038217;815.2906970935295;815.3599424451806;815.592203898051;860.9053004169537;861.452977359375;862.038826708219;862.6894318045498;863.0506442912778;853.8335024670192;856.4518708026868;856.5417501636625;856.644492535597;856.9614367353453;627.1345543150469;627.4791922704145;627.6641996531879;627.8775638750445;627.9748810047593;12894.484220631164;12916.289604071771;12940.741185176244;12965.870341296655;13705.383257753425;13587.734648425045;14448.205348705817;14650.560483185522;14676.779848302178;14711.63220919475;11613.361265130414;11708.297502149899;11790.17468777186;12158.088143389192;12596.307203103826;3759.2293579816346;3774.9056273593105;3871.7870517121546;3983.1237127831832;3984.402339649047;85169;87094.56452717696;87265.56367218123;87369.56315218384;87566.56216718875;10623.20325975555;10910.399928003877;10918.617848375268;11013.559457621606;11485.770284594262;21982;22149.446263843533;22252.221172258895;22304.330870073925;22310.21914232994;7959.129868127208;7987.361011119213;8203.8359232815;8317.085120636724;8318.584070796436;4394.956050439519;4466.977665111654;4570.360149579062;4592.471865735416;4597.103564804831;3695.7782533048103;3785.5078839750654;3806.1436176859984;3813.084859633723;3813.866514671973;603.9939600604025;607.4472230270521;612.0390986151699;612.9877402451926;648.9123968264319;531.4578335394629;546.592788372657;568.9715514224355;615.258613370896;656.8817612829641;9043.547822608843;10075;10083.697489075194;10102.949485252526;10104.696859094092;574.9511291540266;665.3712241931426;675.6385333846368;679.4835924697167;731.2285538756663;4269.596199524965;4538.977305113453;4603.769811509411;4727.479977202505;4818.831340903122;100238.4988075055;122820.38589806994;130348;133038;134069.32965335305;107628;109358;109691.9999999984;111205;115968.42015789867;50283.49716502788;55196.44803551913;56745;66477;78809;9113.225375843127;9737.734591782935;9759.892184357059;9782.028713764965;9879.654212102541;50741.492585073676;52659.21011184912;53236.73381633067;53271.4672853282;54134.72932635312;72165.64935486951;73920;74785.6260718693;75884.24115758772;77486.2251377479;12719.872801272239;13494.460221591418;13507.459701612219;13680.726385472433;13820.792688109485;13421.328933553088;13506.189628622315;14406.135631862122;14619.85380146185;14729.705405892037;12714.300713460478;12748.4263208154;12784.296863672587;13228;13725.519606814112;12902.741945160857;13530.864691352961;13662.385192666155;13686.589402317946;13732.725345493234;12359.567415140427;12509.87490125087;12678.302693351954;12770.106092573431;12970.156939798882;10934.835977460503;11066.490392739852;11256.606018789304;11378.203525753117;11735.941320293345;10629.473810140993;11358.54565817358;11474.25417347903;11521.308721476738;11523.423828808694 17:56:09 INFO - PROCESS | 3396 | __end_tp_report 17:56:09 INFO - PROCESS | 3396 | __start_cc_report 17:56:09 INFO - PROCESS | 3396 | _x_x_mozilla_cycle_collect,1063 17:56:09 INFO - PROCESS | 3396 | __end_cc_report 17:56:09 INFO - PROCESS | 3396 | __startTimestamp1472864169512__endTimestamp 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | ------- Summary: start ------- 17:56:09 INFO - PROCESS | 3396 | Number of tests: 6 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | [#0] dojo.html Cycles:165 Average:5174.13 Median:5407.78 stddev:564.32 (10.4%) stddev-sans-first:539.08 17:56:09 INFO - PROCESS | 3396 | Values: 2976.9 2982.4 2987.0 3020.2 3042.4 5117.5 5192.7 5204.1 5259.3 5263.8 5219.7 5232.9 5282.7 5308.0 5318.3 4686.1 4709.1 4746.9 4756.5 4911.6 4857.6 4871.4 4894.5 4913.4 4927.2 4757.7 4766.8 4767.5 4796.4 4820.8 4770.0 4774.1 4782.3 4833.2 4845.0 4735.2 4739.7 4742.6 4747.6 4821.2 5074.6 5120.1 5184.1 5189.8 5190.3 5519.0 5527.2 5529.8 5533.3 5562.2 5547.5 5551.8 5553.8 5560.2 5562.2 5123.8 5124.7 5150.7 5166.1 5172.5 5628.2 5628.7 5685.6 5686.3 5697.3 5417.6 5418.6 5420.8 5422.8 5428.5 5484.6 5487.9 5516.6 5526.9 5543.4 5475.8 5499.1 5504.8 5505.9 5563.8 5494.1 5539.4 5544.4 5551.6 5555.9 4221.0 4259.7 4264.0 4303.6 4371.2 3861.1 3887.5 3888.3 3888.8 3889.9 5227.9 5237.6 5237.6 5238.9 5241.2 5518.6 5527.4 5540.6 5558.9 5588.2 5220.2 5270.3 5275.3 5281.1 5319.3 4804.2 4828.2 4831.5 4835.6 4884.2 5647.8 5654.7 5678.4 5716.1 5752.4 5507.1 5512.1 5513.2 5516.6 5569.9 5713.9 5716.3 5718.3 5726.3 5730.1 5394.6 5400.8 5407.8 5446.8 5459.3 5524.9 5532.3 5532.9 5534.6 5594.4 5418.5 5457.8 5460.0 5464.4 5530.8 5382.4 5416.1 5455.5 5513.0 5518.7 5457.5 5461.6 5462.2 5465.0 5511.9 5486.8 5515.8 5542.1 5558.2 5562.6 5283.7 5288.4 5333.8 5345.1 5481.1 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | [#1] ext.html Cycles:180 Average:57423.54 Median:41143.40 stddev:109998.45 (267.4%) stddev-sans-first:110224.14 17:56:09 INFO - PROCESS | 3396 | Values: 548.7 591.8 598.7 604.6 605.0 31778.5 32704.8 35189.8 42566.0 43752.8 45324.1 46136.3 46154.0 46177.8 46204.0 8853.2 8990.4 9005.5 9006.1 9008.1 8800.9 8894.6 8899.1 8901.8 8904.4 8908.3 8986.4 9011.8 9012.5 9017.5 8896.1 8941.8 8956.5 8982.6 8988.0 8872.5 8949.6 8962.1 8962.7 8965.4 42778.1 42831.6 42934.6 42963.4 43179.0 3413.2 3484.9 3496.9 3520.5 3571.5 32498.2 32574.2 32647.0 32741.8 33201.7 4163.4 4287.5 4312.4 4329.1 4427.3 354254.2 355339.0 355595.0 357438.0 359899.0 47866.3 48054.0 48777.0 52477.7 53984.7 52413.2 57083.4 57409.4 57517.0 57588.0 16715.0 16844.4 16860.5 16870.2 16877.8 12610.6 12641.6 12650.9 12653.6 12658.4 14393.5 15922.6 16360.2 16379.3 16698.5 6432.4 6529.9 6557.9 6579.5 6640.2 908.8 983.2 1005.8 1036.6 1044.9 32706.0 33041.3 33121.8 33130.0 33667.2 1062.9 1081.8 1083.4 1091.1 1133.7 16563.6 17123.2 17163.5 17223.6 17489.4 477612.0 479998.0 482373.0 482505.0 484246.0 57818.4 58093.7 58151.7 58286.7 58303.4 1215.9 1305.6 1336.3 1357.0 1360.2 31395.4 32612.7 33432.7 33633.8 34364.7 48854.0 49103.0 49300.0 49450.5 49937.0 400293.0 400994.0 402026.0 402194.0 402225.0 27391.0 28466.1 28472.0 29111.4 29296.3 47054.3 47747.5 48048.0 48083.8 49567.5 39661.6 39792.6 39989.8 40785.0 41487.4 39918.6 41289.0 41391.6 41401.8 42332.4 40262.0 40666.8 40696.6 40811.1 40997.8 33531.0 36049.5 36348.0 37048.8 37431.6 27936.0 28006.0 28035.9 28062.7 28081.3 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | [#2] jquery.html Cycles:180 Average:27751.81 Median:20561.71 stddev:75742.57 (368.4%) stddev-sans-first:75927.17 17:56:09 INFO - PROCESS | 3396 | Values: 382.5 397.4 411.9 414.4 427.3 15273.8 19070.2 19346.4 19969.5 20144.1 12475.0 12686.7 12782.3 13674.9 19027.3 5176.7 5355.3 5359.1 5362.8 5370.3 5076.9 5212.7 5215.9 5244.6 5248.7 5249.0 5253.3 5257.1 5258.1 5258.9 5245.3 5309.9 5582.5 5607.7 5636.1 5115.2 5122.0 5130.6 5132.9 5133.4 14530.2 17882.6 22161.6 23169.9 23313.9 2320.6 2400.5 2442.0 2448.8 2919.8 10505.0 10796.1 13186.7 14547.1 15383.6 1846.3 1930.5 1930.7 1967.6 1969.9 67339.7 75686.0 81167.6 83225.2 85424.0 9885.0 10341.7 10390.2 10809.7 10881.6 14603.3 14637.9 14642.9 14657.9 14688.6 7607.4 7818.3 7832.4 8025.1 8027.6 7529.7 7599.9 7721.2 7721.4 7792.5 4510.0 4520.6 4554.7 4555.3 4697.6 1950.6 1952.8 2045.7 2064.9 2091.7 893.6 957.7 1004.5 1008.6 1034.9 19848.2 19937.8 20049.8 20056.1 20071.6 946.6 974.8 976.2 1023.9 1055.5 10346.6 10950.5 11036.1 11059.4 11088.3 441733.0 448970.0 461056.0 465399.0 471760.0 88120.6 89259.6 90503.0 95105.5 99726.0 497.6 518.3 518.8 519.6 520.1 11027.2 11411.4 11675.4 11878.9 12024.6 40726.0 42358.4 42811.8 43397.3 43680.9 56858.0 57593.0 58358.4 60035.1 61403.4 8467.7 8578.4 8590.5 8920.1 9001.5 12881.1 13659.9 13728.5 13730.0 13735.3 11828.5 11949.8 11985.5 12153.8 12215.9 11596.7 11700.5 11890.3 11981.0 12313.1 11808.9 11867.3 12043.6 12203.3 12219.6 8761.7 9058.6 9061.5 9223.2 9295.8 11686.4 11886.0 12014.8 12077.5 12389.8 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | [#3] mootools.html Cycles:180 Average:6066.54 Median:4814.33 stddev:3477.61 (72.2%) stddev-sans-first:3469.04 17:56:09 INFO - PROCESS | 3396 | Values: 1316.2 1466.9 1489.2 1639.2 1767.6 8682.5 9168.6 9179.8 9479.8 9482.7 9267.4 9380.8 9391.9 9393.1 9397.2 2385.6 2400.0 2402.3 2413.9 2415.6 2350.8 2402.0 2403.8 2419.9 2422.9 2389.7 2394.0 2402.0 2439.5 2456.5 2346.1 2347.3 2364.2 2364.2 2383.2 2297.2 2337.1 2341.2 2343.9 2350.2 9205.2 9223.1 9241.8 9372.9 9390.1 5355.9 5637.9 5640.0 5642.8 5643.5 3505.8 3520.8 3558.4 3576.6 3577.6 1179.2 1211.8 1216.4 1228.9 1229.4 13093.6 13111.8 13216.9 13280.5 13298.8 4576.3 4653.5 4819.8 4821.6 4911.9 10288.2 10298.1 10308.5 10318.5 10319.1 5538.4 5542.9 5562.8 5564.4 5570.2 4569.5 4808.8 4987.6 5027.7 5164.1 4065.2 4090.7 4258.9 4279.8 4301.5 1306.5 1365.2 1367.5 1378.6 1383.7 766.6 863.4 902.7 932.3 952.5 6209.1 6252.5 6344.3 6362.7 6559.8 971.8 990.3 1003.4 1017.2 1023.5 4193.1 4205.4 4222.1 4314.8 4319.0 11208.3 11365.0 11517.4 11680.4 11898.8 11585.6 11609.5 11623.9 11630.2 11633.1 8436.5 8639.3 8718.3 8763.0 8771.1 6033.8 6050.4 6169.1 6191.4 6259.1 9877.0 10655.7 10740.5 10751.5 10880.7 10390.7 10621.5 10710.5 10778.7 10779.5 7096.6 7213.3 7772.2 7950.5 8116.6 8798.6 8980.1 8986.7 8993.2 8994.1 7688.6 7924.5 8077.2 8126.0 8149.3 7706.9 7763.5 7979.3 7993.4 8135.6 7084.4 7276.5 7349.7 7371.4 7372.3 5225.6 5348.9 5461.6 5522.5 5684.3 5350.1 5574.2 5590.7 5609.2 5647.5 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | [#4] prototype.html Cycles:180 Average:4402.71 Median:4884.06 stddev:1256.82 (25.7%) stddev-sans-first:1222.63 17:56:09 INFO - PROCESS | 3396 | Values: 331.7 335.4 340.1 344.7 348.1 5199.3 5226.3 5242.4 5262.5 5312.7 5190.7 5211.7 5212.9 5231.8 5241.4 4145.5 4158.9 4160.2 4203.1 4221.1 3744.6 3918.5 4103.9 4120.2 4140.9 4069.3 4077.8 4093.1 4102.3 4115.1 3939.7 4131.9 4137.4 4145.4 4158.9 3604.5 3652.1 3661.5 3682.5 3683.7 5036.0 5047.8 5050.3 5058.5 5096.2 4705.3 4711.7 4730.5 4749.3 4752.4 5149.4 5346.7 5362.3 5375.3 5418.9 3871.9 3884.8 3885.7 3886.6 3926.4 5361.4 5534.3 5591.9 5630.6 5651.9 3937.0 3940.3 3943.3 3970.0 4023.0 4002.2 4005.4 4011.6 4019.9 4023.8 4502.4 4560.5 4592.4 4606.4 4626.9 5379.7 5384.8 5396.3 5414.4 5438.8 1371.9 1385.3 1391.4 1393.5 1395.2 862.3 891.3 908.5 919.7 927.5 4527.4 4602.1 4614.9 4632.9 4654.0 4796.8 4869.6 4878.2 4901.0 4908.8 4346.3 4625.9 4656.0 4663.6 4675.2 2547.2 2549.5 2578.3 2580.0 2587.4 4949.7 4953.9 5004.3 5013.5 5061.5 4760.6 4861.6 4953.4 4986.7 5011.8 4988.5 5019.7 5042.5 5044.0 5045.6 4824.3 4889.9 4904.6 4909.8 4963.5 4488.9 4785.4 4796.8 4815.9 4837.4 4938.4 4958.0 5420.0 5508.8 5647.9 4012.2 4015.3 4020.8 4030.5 4045.8 5497.6 5542.9 5551.4 5565.6 5599.2 5187.3 5362.2 5369.5 5386.9 5472.6 5340.7 5351.6 5356.8 5359.9 5363.8 5357.6 5360.9 5367.1 5375.0 5376.5 5140.2 5407.8 5412.2 5414.4 5440.3 5276.0 5282.6 5320.6 5329.7 5366.8 17:56:09 INFO - PROCESS | 3396 | 17:56:09 INFO - PROCESS | 3396 | [#5] yui.html Cycles:180 Average:20892.74 Median:3842.83 stddev:31254.76 (813.3%) stddev-sans-first:31305.68 17:56:09 INFO - PROCESS | 3396 | Values: 705.3 733.2 740.2 774.3 792.2 14076.6 14732.0 14743.8 14817.9 14831.6 12587.3 13664.7 13766.1 13796.9 13829.6 771.2 777.5 778.3 779.5 792.7 813.5 815.3 815.3 815.4 815.6 860.9 861.5 862.0 862.7 863.1 853.8 856.5 856.5 856.6 857.0 627.1 627.5 627.7 627.9 628.0 12894.5 12916.3 12940.7 12965.9 13705.4 13587.7 14448.2 14650.6 14676.8 14711.6 11613.4 11708.3 11790.2 12158.1 12596.3 3759.2 3774.9 3871.8 3983.1 3984.4 85169.0 87094.6 87265.6 87369.6 87566.6 10623.2 10910.4 10918.6 11013.6 11485.8 21982.0 22149.4 22252.2 22304.3 22310.2 7959.1 7987.4 8203.8 8317.1 8318.6 4395.0 4467.0 4570.4 4592.5 4597.1 3695.8 3785.5 3806.1 3813.1 3813.9 604.0 607.4 612.0 613.0 648.9 531.5 546.6 569.0 615.3 656.9 9043.5 10075.0 10083.7 10102.9 10104.7 575.0 665.4 675.6 679.5 731.2 4269.6 4539.0 4603.8 4727.5 4818.8 100238.5 122820.4 130348.0 133038.0 134069.3 107628.0 109358.0 109692.0 111205.0 115968.4 50283.5 55196.4 56745.0 66477.0 78809.0 9113.2 9737.7 9759.9 9782.0 9879.7 50741.5 52659.2 53236.7 53271.5 54134.7 72165.6 73920.0 74785.6 75884.2 77486.2 12719.9 13494.5 13507.5 13680.7 13820.8 13421.3 13506.2 14406.1 14619.9 14729.7 12714.3 12748.4 12784.3 13228.0 13725.5 12902.7 13530.9 13662.4 13686.6 13732.7 12359.6 12509.9 12678.3 12770.1 12970.2 10934.8 11066.5 11256.6 11378.2 11735.9 10629.5 11358.5 11474.3 11521.3 11523.4 17:56:09 INFO - PROCESS | 3396 | -------- Summary: end -------- 17:56:09 INFO - PROCESS | 3396 | 17:56:10 INFO - TEST-INFO | 3396: exit 0 17:56:10 INFO - TEST-OK | dromaeo_css | took 1121828ms 17:56:10 INFO - TEST-START | kraken 17:56:10 INFO - operating with platform_type : linux_ 17:56:10 INFO - Initialising browser for kraken test... 17:56:10 INFO - TEST-INFO | started process 3701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZFo1r/profile http://localhost:44448/getInfo.html) 17:56:15 INFO - PROCESS | 3701 | __metrics Screen width/height:1600/1200 17:56:15 INFO - PROCESS | 3701 | colorDepth:24 17:56:15 INFO - PROCESS | 3701 | Browser inner width/height: 1024/697 17:56:15 INFO - PROCESS | 3701 | __metrics 17:56:15 INFO - PROCESS | 3701 | 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" 17:56:15 INFO - PROCESS | 3701 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:56:16 INFO - PROCESS | 3701 | console.error: PushService: 17:56:16 INFO - PROCESS | 3701 | stateChangeProcessEnqueue: Error transitioning state 17:56:16 INFO - PROCESS | 3701 | UnknownError 17:56:17 INFO - TEST-INFO | 3701: exit 0 17:56:17 INFO - Browser initialized. 17:56:17 INFO - Running cycle 1/1 for kraken test... 17:56:17 INFO - TEST-INFO | started process 3784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZFo1r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:29 INFO - PROCESS | 3784 | RSS: Main: 178462720 17:56:29 INFO - PROCESS | 3784 | 17:56:31 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44448/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:32 INFO - PROCESS | 3784 | RSS: Main: 232972288 17:56:32 INFO - PROCESS | 3784 | 17:56:35 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44448/tests/kraken/driver.html?testName=audio-dft) 17:56:35 INFO - PROCESS | 3784 | RSS: Main: 223432704 17:56:35 INFO - PROCESS | 3784 | 17:56:38 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44448/tests/kraken/driver.html?testName=audio-fft) 17:56:39 INFO - PROCESS | 3784 | RSS: Main: 300670976 17:56:39 INFO - PROCESS | 3784 | 17:56:41 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44448/tests/kraken/driver.html?testName=audio-oscillator) 17:56:42 INFO - PROCESS | 3784 | RSS: Main: 211148800 17:56:42 INFO - PROCESS | 3784 | 17:56:44 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:44 INFO - PROCESS | 3784 | RSS: Main: 213921792 17:56:44 INFO - PROCESS | 3784 | 17:56:47 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44448/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:48 INFO - PROCESS | 3784 | RSS: Main: 252321792 17:56:48 INFO - PROCESS | 3784 | 17:56:51 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44448/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:52 INFO - PROCESS | 3784 | RSS: Main: 251092992 17:56:52 INFO - PROCESS | 3784 | 17:56:55 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44448/tests/kraken/driver.html?testName=json-parse-financial) 17:56:55 INFO - PROCESS | 3784 | RSS: Main: 251355136 17:56:55 INFO - PROCESS | 3784 | 17:56:57 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:57 INFO - PROCESS | 3784 | RSS: Main: 213671936 17:56:57 INFO - PROCESS | 3784 | 17:56:59 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:57:00 INFO - PROCESS | 3784 | RSS: Main: 221728768 17:57:00 INFO - PROCESS | 3784 | 17:57:02 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:57:03 INFO - PROCESS | 3784 | RSS: Main: 222507008 17:57:03 INFO - PROCESS | 3784 | 17:57:05 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:57:06 INFO - PROCESS | 3784 | RSS: Main: 223567872 17:57:06 INFO - PROCESS | 3784 | 17:57:09 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:57:09 INFO - PROCESS | 3784 | RSS: Main: 222003200 17:57:09 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:44448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44448/tests/kraken/driver.html?testName=ai-astar) 17:57:11 INFO - PROCESS | 3784 | RSS: Main: 272064512 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | __start_tp_report 17:57:11 INFO - PROCESS | 3784 | _x_x_mozilla_page_load 17:57:11 INFO - PROCESS | 3784 | _x_x_mozilla_page_load_details 17:57:11 INFO - PROCESS | 3784 | |i|pagename|runs| 17:57:11 INFO - PROCESS | 3784 | |0;ai-astar;110;111;116;111;112;113;111;110;110;125 17:57:11 INFO - PROCESS | 3784 | |1;audio-beat-detection;156;118;147;175;123;147;153;123;195;119 17:57:11 INFO - PROCESS | 3784 | |2;audio-dft;162;161;159;159;161;162;162;161;160;161 17:57:11 INFO - PROCESS | 3784 | |3;audio-fft;74;75;76;164;77;75;74;76;180;74 17:57:11 INFO - PROCESS | 3784 | |4;audio-oscillator;82;82;138;82;82;82;138;82;82;134 17:57:11 INFO - PROCESS | 3784 | |5;imaging-gaussian-blur;117;118;116;116;117;117;116;116;116;117 17:57:11 INFO - PROCESS | 3784 | |6;imaging-darkroom;145;146;145;145;145;146;146;145;145;145 17:57:11 INFO - PROCESS | 3784 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;96 17:57:11 INFO - PROCESS | 3784 | |8;json-parse-financial;50;50;51;52;52;51;52;51;52;51 17:57:11 INFO - PROCESS | 3784 | |9;json-stringify-tinderbox;63;62;62;62;62;62;62;61;62;61 17:57:11 INFO - PROCESS | 3784 | |10;stanford-crypto-aes;86;87;79;78;80;79;78;83;77;79 17:57:11 INFO - PROCESS | 3784 | |11;stanford-crypto-ccm;123;126;121;125;124;123;133;126;165;128 17:57:11 INFO - PROCESS | 3784 | |12;stanford-crypto-pbkdf2;169;163;167;169;167;163;166;166;172;162 17:57:11 INFO - PROCESS | 3784 | |13;stanford-crypto-sha256-iterative;64;67;66;66;65;68;68;68;64;63 17:57:11 INFO - PROCESS | 3784 | __end_tp_report 17:57:11 INFO - PROCESS | 3784 | __start_cc_report 17:57:11 INFO - PROCESS | 3784 | _x_x_mozilla_cycle_collect,1710 17:57:11 INFO - PROCESS | 3784 | __end_cc_report 17:57:11 INFO - PROCESS | 3784 | __startTimestamp1472864231655__endTimestamp 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | ------- Summary: start ------- 17:57:11 INFO - PROCESS | 3784 | Number of tests: 14 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#0] ai-astar Cycles:10 Average:112.90 Median:111.50 stddev:4.63 (4.2%) stddev-sans-first:4.79 17:57:11 INFO - PROCESS | 3784 | Values: 110.0 111.0 116.0 111.0 112.0 113.0 111.0 110.0 110.0 125.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.00 stddev:25.74 (17.2%) stddev-sans-first:27.02 17:57:11 INFO - PROCESS | 3784 | Values: 156.0 118.0 147.0 175.0 123.0 147.0 153.0 123.0 195.0 119.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 17:57:11 INFO - PROCESS | 3784 | Values: 162.0 161.0 159.0 159.0 161.0 162.0 162.0 161.0 160.0 161.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:41.03 (54.7%) stddev-sans-first:42.85 17:57:11 INFO - PROCESS | 3784 | Values: 74.0 75.0 76.0 164.0 77.0 75.0 74.0 76.0 180.0 74.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:82.00 stddev:26.43 (32.2%) stddev-sans-first:27.36 17:57:11 INFO - PROCESS | 3784 | Values: 82.0 82.0 138.0 82.0 82.0 82.0 138.0 82.0 82.0 134.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:57:11 INFO - PROCESS | 3784 | Values: 117.0 118.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 117.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:57:11 INFO - PROCESS | 3784 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:57:11 INFO - PROCESS | 3784 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:0.79 (1.5%) stddev-sans-first:0.71 17:57:11 INFO - PROCESS | 3784 | Values: 50.0 50.0 51.0 52.0 52.0 51.0 52.0 51.0 52.0 51.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 17:57:11 INFO - PROCESS | 3784 | Values: 63.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 61.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:3.50 (4.4%) stddev-sans-first:3.12 17:57:11 INFO - PROCESS | 3784 | Values: 86.0 87.0 79.0 78.0 80.0 79.0 78.0 83.0 77.0 79.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:126.00 stddev:12.94 (10.3%) stddev-sans-first:13.51 17:57:11 INFO - PROCESS | 3784 | Values: 123.0 126.0 121.0 125.0 124.0 123.0 133.0 126.0 165.0 128.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:3.13 (1.9%) stddev-sans-first:3.18 17:57:11 INFO - PROCESS | 3784 | Values: 169.0 163.0 167.0 169.0 167.0 163.0 166.0 166.0 172.0 162.0 17:57:11 INFO - PROCESS | 3784 | 17:57:11 INFO - PROCESS | 3784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.85 (2.8%) stddev-sans-first:1.83 17:57:11 INFO - PROCESS | 3784 | Values: 64.0 67.0 66.0 66.0 65.0 68.0 68.0 68.0 64.0 63.0 17:57:11 INFO - PROCESS | 3784 | -------- Summary: end -------- 17:57:11 INFO - PROCESS | 3784 | 17:57:12 INFO - TEST-INFO | 3784: exit 0 17:57:12 INFO - TEST-OK | kraken | took 62421ms 17:57:12 INFO - SUITE-END | took 1184s 17:57:13 INFO - Completed test suite (00:19:44) 17:57:13 INFO - javascript benchmark 17:57:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2976.8660410281536, 2982.4482470742905, 2986.9850650746757, 3020.199647093519, 3042.3915216956616, 5117.488251174881, 5192.71440070796, 5204.063268611649, 5259.316288882449, 5263.815766448175, 5219.686818790875, 5232.8691782705355, 5282.7358632068335, 5308.044551980642, 5318.282031925699, 4686.109639168547, 4709.128811169928, 4746.928796068062, 4756.548127927841, 4911.607071434295, 4857.635677324215, 4871.415430148387, 4894.461609222983, 4913.434954980169, 4927.162382394984, 4757.666963312569, 4766.785494652749, 4767.451743049559, 4796.424429068499, 4820.8071677132875, 4769.952300476985, 4774.140654682155, 4782.30656554801, 4833.202521583935, 4845.0, 4735.15685701983, 4739.668223224376, 4742.644301677354, 4747.572718455355, 4821.204501257288, 5074.644774865761, 5120.1039818031695, 5184.092783762864, 5189.766460509286, 5190.2993095932325, 5519.034169020405, 5527.198556209327, 5529.751161197756, 5533.253010843525, 5562.193481945135, 5547.472990065978, 5551.750171242264, 5553.77784888608, 5560.221568980346, 5562.193481945095, 5123.846284611468, 5124.692518448905, 5150.690958542499, 5166.095933211673, 5172.482751724835, 5628.183913332544, 5628.71856407178, 5685.630434021776, 5686.317641883001, 5697.3448053474385, 5417.6478528895495, 5418.593605479605, 5420.83737487876, 5422.783088676409, 5428.511433970962, 5484.61607687466, 5487.945120548743, 5516.586256030814, 5526.861828454321, 5543.445655434505, 5475.825553852591, 5499.1476321170285, 5504.834854954358, 5505.862353441116, 5563.777448902079, 5494.08508925771, 5539.390667026624, 5544.390117087117, 5551.555875529948, 5555.916661250085, 4221.0, 4259.680523960716, 4263.978680106579, 4303.591158839905, 4371.191329604034, 3861.054041759731, 3887.4946256986977, 3888.3389823730035, 3888.8055597220027, 3889.883303500843, 5227.947720522746, 5237.580993520509, 5237.580993520509, 5238.869028274324, 5241.187615919539, 5518.641288316327, 5527.419620939824, 5540.556755459554, 5558.861028474321, 5588.161775733673, 5220.243064755665, 5270.262163297141, 5275.261463395128, 5281.102212623863, 5319.255304257407, 4804.2073057945745, 4828.155072862305, 4831.492693267156, 4835.637327200474, 4884.242942343943, 5647.802326918538, 5654.74553645087, 5678.432156784371, 5716.114002329646, 5752.36723960364, 5507.146392309199, 5512.09050506678, 5513.173024046425, 5516.586256030733, 5569.916451253153, 5713.9428605715075, 5716.28546431696, 5718.285214348207, 5726.255586773859, 5730.083186690276, 5394.568434525307, 5400.810971615974, 5407.78368865241, 5446.836594902159, 5459.262999495176, 5524.861878453071, 5532.336119665666, 5532.861678458071, 5534.612577119563, 5594.38461769197, 5418.539424148991, 5457.836264912059, 5459.972700136474, 5464.398916119144, 5530.806421775219, 5382.434844341445, 5416.133418652997, 5455.536279416294, 5513.035218836607, 5518.66887986706, 5457.454254574511, 5461.644993075437, 5462.180672898938, 5464.972675136599, 5511.889762204813, 5486.753096110764, 5515.779368825202, 5542.140968149944, 5558.249636299048, 5562.554995600423, 5283.709395983258, 5288.444713305047, 5333.773232156548, 5345.1447768356875, 5481.123020316731], "value": 5136.981040810744, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7486208698683, 591.8194950540085, 598.679706357099, 604.5707547641175, 605.0379895965416, 31778.523322150188, 32704.836475817618, 35189.82405087974, 42566.0, 43752.781236093775, 45324.093518129615, 46136.3079553807, 46154.0, 46177.7691111544, 46204.0, 8853.203211710945, 8990.37067405282, 9005.459672419676, 9006.099390061006, 9008.0541543138, 8800.911990880106, 8894.555272236395, 8899.065598112202, 8901.821963560726, 8904.376693631448, 8908.331875109392, 8986.415882967618, 9011.774705632346, 9012.54937253138, 9017.549122543847, 8896.0659130791, 8941.821163576724, 8956.507392093432, 8982.550872456351, 8988.0, 8872.512011839346, 8949.552522373855, 8962.14859588338, 8962.68630597926, 8965.372423930328, 42778.1444371114, 42831.57168428338, 42934.57065429368, 42963.35554966678, 43179.0, 3413.197898493852, 3484.9128771780656, 3496.860125594973, 3520.4719292106133, 3571.535700358963, 32498.18754531132, 32574.18564535882, 32647.0, 32741.83629081839, 33201.6679833201, 4163.354680024601, 4287.528371879091, 4312.417823593806, 4329.090890912912, 4427.291633338683, 354254.2287288573, 355339.0, 355595.0, 357438.0, 359899.0, 47866.28200576994, 48054.0, 48777.0, 52477.7376113117, 53984.730076350155, 52413.213801793005, 57083.429165707814, 57409.425905740405, 57517.0, 57588.0, 16715.0, 16844.410445634345, 16860.494185174466, 16870.240839162267, 16877.831221687873, 12610.558630448073, 12641.620751377473, 12650.873491265154, 12653.557125500563, 12658.367081646065, 14393.496227631982, 15922.60193495172, 16360.181990900408, 16379.262933168036, 16698.499045028668, 6432.421082102634, 6529.934700652932, 6557.852230929181, 6579.47364210862, 6640.177924382118, 908.8091500784909, 983.2085171436919, 1005.8088963096989, 1036.6060896859144, 1044.9373037617615, 32706.0, 33041.33917321688, 33121.83439082837, 33130.0, 33667.15832104217, 1062.9476817950328, 1081.7782354617284, 1083.4041277297456, 1091.0834898684984, 1133.6769020829024, 16563.585910352336, 17123.22945467457, 17163.485095447155, 17223.56941076483, 17489.387871424693, 477612.0, 479998.0, 482373.0, 482505.0, 484246.0, 57818.4218157813, 58093.70953145207, 58151.70924145352, 58286.708566456895, 58303.41696583065, 1215.9209651372632, 1305.614843621134, 1336.2984433172662, 1356.9796453053016, 1360.177092858826, 31395.37209255848, 32612.673873261912, 33432.665673342955, 33633.78367575342, 34364.65635343615, 48854.0, 49103.0, 49300.0, 49450.50549494459, 49937.0, 400293.0, 400994.0, 402026.0, 402194.0, 402225.0, 27391.0, 28466.146015619564, 28472.017396955864, 29111.417771644872, 29296.26759331034, 47054.294185587925, 47747.52252477431, 48048.0, 48083.75958120187, 49567.50432495629, 39661.60338396579, 39792.602073980044, 39989.80005099956, 40785.0, 41487.377689334084, 39918.60081399265, 41289.0, 41391.58608413878, 41401.792991036054, 42332.36501452542, 40262.0, 40666.79666601648, 40696.593034070465, 40811.14448948572, 40997.795011024755, 33531.0, 36049.459258110626, 36348.0, 37048.81475592605, 37431.62568374391, 27936.0, 28006.0, 28035.859820701582, 28062.719372806827, 28081.297967550974], "value": 19681.481136371698, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4760078692192, 397.4182752644475, 411.92791261529237, 414.37636357282287, 427.25870614483887, 15273.847261527382, 19070.2371905124, 19346.419607411783, 19969.500762480908, 20144.09351579179, 12475.0, 12686.746265074693, 12782.296973666467, 13674.93162534186, 19027.33404330849, 5176.715280659562, 5355.277037599933, 5359.115745901921, 5362.8123015694455, 5370.275012873251, 5076.923846142311, 5212.6611770235, 5215.921761173586, 5244.554212891909, 5248.685078895279, 5249.0, 5253.3170687810725, 5257.080010998079, 5258.106121959257, 5258.947410525903, 5245.26566280721, 5309.867253318678, 5582.525485333711, 5607.691576963286, 5636.126400407943, 5115.2327150927285, 5122.0268149051935, 5130.640855140142, 5132.897342053176, 5133.358330208724, 14530.200838953853, 17882.642347152985, 22161.556768864695, 23169.884150579306, 23313.883430582908, 2320.5706944215376, 2400.459896523268, 2441.987790061056, 2448.8285819992607, 2919.8394088325135, 10505.0, 10796.082333001705, 13186.736265274641, 14547.127172369692, 15383.61540961485, 1846.3076346370112, 1930.4884205685505, 1930.710393440981, 1967.616314818611, 1969.8818070915647, 67339.66330168318, 75686.0, 81167.5941620294, 83225.16774832235, 85424.0, 9884.950575247078, 10341.689749307532, 10390.220733445021, 10809.729756756144, 10881.619143329945, 14603.269836508345, 14637.92681036588, 14642.85357146415, 14657.853421465863, 14688.55934321972, 7607.35337496319, 7818.335441487424, 7832.373410127176, 8025.117237103914, 8027.598620068973, 7529.698812047457, 7599.924000760032, 7721.189275126143, 7721.420893433015, 7792.454528182972, 4509.954900450954, 4520.570545798144, 4554.7039442436135, 4555.339475775994, 4697.553732395417, 1950.5806251655963, 1952.7851936286997, 2045.6805360542664, 2064.9380518584467, 2091.7280753501946, 893.6112790935964, 957.674390707163, 1004.492731170754, 1008.6318493749728, 1034.8913364096811, 19848.206071757257, 19937.800621993883, 20049.799502005084, 20056.09747561363, 20071.59856802856, 946.6402766948653, 974.780674348266, 976.1653786012856, 1023.8668973033458, 1055.4775386183887, 10346.586136554604, 10950.507227174796, 11036.061934735477, 11059.447027648584, 11088.33469991803, 441733.0, 448970.0, 461056.0, 465399.0, 471760.0, 88120.55939720389, 89259.55370223107, 90503.0, 95105.52447237719, 99726.0, 497.5546885537424, 518.3494714133737, 518.7924830068004, 519.5791408958755, 520.0768635671637, 11027.228094033662, 11411.372374519482, 11675.416229188677, 11878.881211188123, 12024.639260822189, 40726.0, 42358.36462453004, 42811.78594107134, 43397.349039763794, 43680.94233403759, 56858.0, 57593.0, 58358.4164158353, 60035.099473507056, 61403.385966141555, 8467.703630372907, 8578.356623253156, 8590.484570925764, 8920.063393343606, 9001.549922503718, 12881.098323117292, 13659.931700341434, 13728.45086196541, 13730.0, 13735.313234338442, 11828.526858925547, 11949.76100478003, 11985.520579177084, 12153.756924861631, 12215.877841221474, 11596.652100437, 11700.531978720755, 11890.34603096838, 11981.0, 12313.13808033465, 11808.94095529517, 11867.347295898808, 12043.578474753342, 12203.267803931793, 12219.633410997685, 8761.729549215455, 9058.592363343534, 9061.456312621263, 9223.169914707709, 9295.814083718424, 11686.357250351311, 11886.0, 12014.75970480568, 12077.51689932393, 12389.814152787896], "value": 8826.36053712566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.2365827819865, 1466.9119852808828, 1489.1586253766623, 1639.1804097951024, 1767.5846176148596, 8682.479051256922, 9168.633254669814, 9179.816403671932, 9479.81040379192, 9482.715518534438, 9267.351285410025, 9380.812383752322, 9391.859122113174, 9393.060693930604, 9397.201237894787, 2385.5944489436793, 2399.9640005399933, 2402.267308470916, 2413.8913748881255, 2415.625578035407, 2350.7766762157653, 2401.9759802402014, 2403.843750156243, 2419.8790060496995, 2422.8546287222734, 2389.749076346976, 2394.030417680842, 2402.003168684994, 2439.4633180700216, 2456.520978409211, 2346.0967527502034, 2347.2840783561005, 2364.160722943356, 2364.207990323235, 2383.165891937808, 2297.184499502669, 2337.076854642407, 2341.2156927429332, 2343.871087090209, 2350.2361732436857, 9205.171534561854, 9223.123803238681, 9241.815163696689, 9372.8594071089, 9390.060993900624, 5355.892882142335, 5637.943620563783, 5640.041192997201, 5642.7742890284335, 5643.520300774439, 3505.8071806050657, 3520.7535472516934, 3558.3594952908466, 3576.5529308836394, 3577.5706915170344, 1179.204037274836, 1211.7818792617325, 1216.3700641140913, 1228.8955438787714, 1229.4221715793562, 13093.607191784262, 13111.803322950163, 13216.867831321755, 13280.468781248836, 13298.800517992238, 4576.336431217454, 4653.534646535387, 4819.831305904277, 4821.63837712173, 4911.877203069952, 10288.228382871315, 10298.073173414428, 10308.484575771181, 10318.48407579633, 10319.122874555596, 5538.418466061086, 5542.944570554324, 5562.833115006556, 5564.387917329091, 5570.248016517799, 4569.497355290915, 4808.831690890872, 4987.600991920638, 5027.723475208899, 5164.070467315919, 4065.1869626074904, 4090.734102283342, 4258.850940217078, 4279.786010699452, 4301.462317210348, 1306.4969986555054, 1365.180891465113, 1367.548708926052, 1378.641553196156, 1383.688670049231, 766.5822126940831, 863.4430792139035, 902.700629200261, 932.2914584915513, 952.5284983932997, 6209.068639704081, 6252.468540174045, 6344.333844946306, 6362.681865906686, 6559.8360040998405, 971.7910649210454, 990.277097718655, 1003.3628645809963, 1017.2014968249888, 1023.457567489217, 4193.077522944947, 4205.3902184183125, 4222.05003874132, 4314.848980285675, 4318.956810431919, 11208.327500350006, 11365.0, 11517.424128793527, 11680.357580332993, 11898.762024759457, 11585.594504192313, 11609.535618575332, 11623.88376116245, 11630.185886987829, 11633.127515436207, 8436.45163064399, 8639.265662418638, 8718.258947989365, 8763.0, 8771.079036701181, 6033.849153771191, 6050.394960503914, 6169.105479705508, 6191.442770150708, 6259.061140828912, 9877.0, 10655.733606659896, 10740.516676749721, 10751.516181771683, 10880.727981800519, 10390.688279351632, 10621.468926553487, 10710.464476775975, 10778.730531736455, 10779.461026948778, 7096.645167741489, 7213.278672132745, 7772.222777722182, 7950.4832185907735, 8116.553589552631, 8798.604062817316, 8980.101989800967, 8986.68546600866, 8993.235574975939, 8994.055624159631, 7688.615569221628, 7924.524528528307, 8077.192280771876, 8125.959370203112, 8149.307308878811, 7706.922930770845, 7763.4953728007495, 7979.321757650665, 7993.360531157377, 8135.633896474555, 7084.397826184832, 7276.527025743521, 7349.669264882986, 7371.373433258019, 7372.336489715952, 5225.634205605723, 5348.893022139613, 5461.590380721383, 5522.502974732293, 5684.289463817023, 5350.117230656898, 5574.219609254626, 5590.664560126405, 5609.158626206102, 5647.531641773086], "value": 4830.219662734759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.69728056302006, 335.41135307535274, 340.09365042162636, 344.693223031502, 348.0585017527588, 5199.296365889735, 5226.346706661668, 5242.423333433319, 5262.526372626463, 5312.654677445973, 5190.662606930547, 5211.739413029343, 5212.921806172911, 5231.764570594323, 5241.39723931748, 4145.502539695241, 4158.896027599311, 4160.188763191179, 4203.117345357478, 4221.05026369066, 3744.6068162842917, 3918.490596222487, 4103.871435355271, 4120.217158739845, 4140.896477588054, 4069.267531844267, 4077.7757223352705, 4093.1199792044704, 4102.261592913274, 4115.053537686334, 3939.7439166454374, 4131.863737472189, 4137.379393091031, 4145.440365550642, 4158.91868114291, 3604.540161234704, 3652.0687224757517, 3661.4507823826375, 3682.5212722345923, 3683.650053244964, 5035.974820125876, 5047.772850221712, 5050.267711181895, 5058.544730974193, 5096.1846104623455, 4705.317728929286, 4711.717296962159, 4730.5032971538185, 4749.311349854286, 4752.4297084349755, 5149.356330458692, 5346.6524675896335, 5362.329708786402, 5375.301210842605, 5418.864528386822, 3871.8644847430205, 3884.7950440886384, 3885.698291072494, 3886.6113388661192, 3926.4110383442426, 5361.437049109826, 5534.335879694422, 5591.860203494904, 5630.577706672016, 5651.9152212716845, 3936.9606303937167, 3940.2907476654477, 3943.290207762573, 3969.960300397017, 4023.0, 4002.239014833464, 4005.399190121505, 4011.618896204856, 4019.879403617896, 4023.8472417256626, 4502.392177056121, 4560.543945605479, 4592.357070010201, 4606.447226332862, 4626.884327891829, 5379.65032272901, 5384.784608615611, 5396.298481197419, 5414.377346605112, 5438.83683489496, 1371.9314034298245, 1385.25888649572, 1391.4276867140068, 1393.4565519447424, 1395.1907893421792, 862.2972277593741, 891.2691592893894, 908.497741207635, 919.6643225222746, 927.4759760735298, 4527.411436513298, 4602.102589994919, 4614.907701845944, 4632.911265852522, 4654.0, 4796.832110876103, 4869.561739443397, 4878.243872199815, 4901.0, 4908.779104940286, 4346.348047792793, 4625.884352891205, 4655.976720116446, 4663.580277775017, 4675.2052151134385, 2547.210364786922, 2549.464612431373, 2578.265194419619, 2579.9742002579733, 2587.3790290330185, 4949.65352425334, 4953.900921981613, 5004.324416203839, 5013.523715247045, 5061.519155680205, 4760.59534939534, 4861.586765124934, 4953.405591328991, 4986.706115187055, 5011.84964451067, 4988.451270360258, 5019.745063734066, 5042.495750424928, 5043.9747801260755, 5045.571126454292, 4824.348712923851, 4889.87290528607, 4904.632152588499, 4909.7545122743, 4963.461326988645, 4488.932666009947, 4785.449673287477, 4796.8081276748535, 4815.879603009813, 4837.427835953259, 4938.358013458371, 4957.95926320048, 5419.972900135474, 5508.834734957958, 5647.915281270702, 4012.177503611694, 4015.297322968527, 4020.83916643331, 4030.5364883038824, 4045.777482238505, 5497.587680924026, 5542.861428464321, 5551.361593416647, 5565.636419077352, 5599.160125981135, 5187.299714538489, 5362.168863826113, 5369.496540968535, 5386.865328366822, 5472.589555783253, 5340.679559226459, 5351.59863010268, 5356.785728570813, 5359.866003349947, 5363.785448582013, 5357.598180136583, 5360.92781443705, 5367.087595108919, 5374.973125134349, 5376.489233522809, 5140.228965655182, 5407.78368865241, 5412.242286080031, 5414.377346605033, 5440.292761940922, 5275.973620131875, 5282.630215884851, 5320.574354051744, 5329.733513324396, 5366.785328586813], "value": 4009.1972817065653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.3193668110273, 733.2264460993649, 740.2116745665866, 774.2721841469017, 792.184050428059, 14076.64808379791, 14732.0, 14743.77884331736, 14817.851821481781, 14831.629209269773, 12587.307698076625, 13664.72670546591, 13766.105203161813, 13796.931015344935, 13829.585112446617, 771.1671394893501, 777.4713195027379, 778.3034184404954, 779.5322806316193, 792.7265093542718, 813.4753084260649, 815.2866242038217, 815.2906970935295, 815.3599424451806, 815.592203898051, 860.9053004169537, 861.452977359375, 862.038826708219, 862.6894318045498, 863.0506442912778, 853.8335024670192, 856.4518708026868, 856.5417501636625, 856.644492535597, 856.9614367353453, 627.1345543150469, 627.4791922704145, 627.6641996531879, 627.8775638750445, 627.9748810047593, 12894.484220631164, 12916.289604071771, 12940.741185176244, 12965.870341296655, 13705.383257753425, 13587.734648425045, 14448.205348705817, 14650.560483185522, 14676.779848302178, 14711.63220919475, 11613.361265130414, 11708.297502149899, 11790.17468777186, 12158.088143389192, 12596.307203103826, 3759.2293579816346, 3774.9056273593105, 3871.7870517121546, 3983.1237127831832, 3984.402339649047, 85169.0, 87094.56452717696, 87265.56367218123, 87369.56315218384, 87566.56216718875, 10623.20325975555, 10910.399928003877, 10918.617848375268, 11013.559457621606, 11485.770284594262, 21982.0, 22149.446263843533, 22252.221172258895, 22304.330870073925, 22310.21914232994, 7959.129868127208, 7987.361011119213, 8203.8359232815, 8317.085120636724, 8318.584070796436, 4394.956050439519, 4466.977665111654, 4570.360149579062, 4592.471865735416, 4597.103564804831, 3695.7782533048103, 3785.5078839750654, 3806.1436176859984, 3813.084859633723, 3813.866514671973, 603.9939600604025, 607.4472230270521, 612.0390986151699, 612.9877402451926, 648.9123968264319, 531.4578335394629, 546.592788372657, 568.9715514224355, 615.258613370896, 656.8817612829641, 9043.547822608843, 10075.0, 10083.697489075194, 10102.949485252526, 10104.696859094092, 574.9511291540266, 665.3712241931426, 675.6385333846368, 679.4835924697167, 731.2285538756663, 4269.596199524965, 4538.977305113453, 4603.769811509411, 4727.479977202505, 4818.831340903122, 100238.4988075055, 122820.38589806994, 130348.0, 133038.0, 134069.32965335305, 107628.0, 109358.0, 109691.9999999984, 111205.0, 115968.42015789867, 50283.49716502788, 55196.44803551913, 56745.0, 66477.0, 78809.0, 9113.225375843127, 9737.734591782935, 9759.892184357059, 9782.028713764965, 9879.654212102541, 50741.492585073676, 52659.21011184912, 53236.73381633067, 53271.4672853282, 54134.72932635312, 72165.64935486951, 73920.0, 74785.6260718693, 75884.24115758772, 77486.2251377479, 12719.872801272239, 13494.460221591418, 13507.459701612219, 13680.726385472433, 13820.792688109485, 13421.328933553088, 13506.189628622315, 14406.135631862122, 14619.85380146185, 14729.705405892037, 12714.300713460478, 12748.4263208154, 12784.296863672587, 13228.0, 13725.519606814112, 12902.741945160857, 13530.864691352961, 13662.385192666155, 13686.589402317946, 13732.725345493234, 12359.567415140427, 12509.87490125087, 12678.302693351954, 12770.106092573431, 12970.156939798882, 10934.835977460503, 11066.490392739852, 11256.606018789304, 11378.203525753117, 11735.941320293345, 10629.473810140993, 11358.54565817358, 11474.25417347903, 11521.308721476738, 11523.423828808694], "value": 7420.367274643061, "unit": "score"}], "name": "dromaeo_css", "value": 7101.342454588389, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 116.0, 111.0, 112.0, 113.0, 111.0, 110.0, 110.0, 125.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 118.0, 147.0, 175.0, 123.0, 147.0, 153.0, 123.0, 195.0, 119.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 159.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 164.0, 77.0, 75.0, 74.0, 76.0, 180.0, 74.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 138.0, 82.0, 82.0, 82.0, 138.0, 82.0, 82.0, 134.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "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, 94.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 52.0, 52.0, 51.0, 52.0, 51.0, 52.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 79.0, 78.0, 80.0, 79.0, 78.0, 83.0, 77.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 121.0, 125.0, 124.0, 123.0, 133.0, 126.0, 165.0, 128.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 167.0, 169.0, 167.0, 163.0, 166.0, 166.0, 172.0, 162.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 66.0, 65.0, 68.0, 68.0, 68.0, 64.0, 63.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1524.5000000000002, "alertThreshold": 2.0}]} 17:57:13 INFO - Return code: 0 17:57:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:57:13 INFO - # TBPL SUCCESS # 17:57:13 INFO - Running post-action listener: _resource_record_post_action 17:57:13 INFO - [mozharness: 2016-09-03 00:57:13.486384Z] Finished run-tests step (success) 17:57:13 INFO - Running post-run listener: _resource_record_post_run 17:57:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7913472; Write bytes: 294846464; Read time: 2064; Write time: 360336 17:57:13 INFO - TinderboxPrint: CPU usage
13.1% 17:57:13 INFO - TinderboxPrint: I/O read bytes / time
7,913,472 / 2,064 17:57:13 INFO - TinderboxPrint: I/O write bytes / time
294,846,464 / 360,336 17:57:13 INFO - TinderboxPrint: CPU idle
8,331.6 (86.9%) 17:57:13 INFO - TinderboxPrint: CPU user
1,203.0 (12.5%) 17:57:13 INFO - TinderboxPrint: Swap in / out
0 / 0 17:57:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4718592; Read time: 0; Write time: 312 17:57:13 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5537792; Write bytes: 290127872; Read time: 1508; Write time: 360024 17:57:14 INFO - Running post-run listener: _upload_blobber_files 17:57:14 INFO - Blob upload gear active. 17:57:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:57:14 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 17:57:14 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'] 17:57:14 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 17:57:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:57:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:57:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:19 INFO - (blobuploader) - INFO - Done attempting. 17:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:19 INFO - (blobuploader) - INFO - Done attempting. 17:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:57:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:20 INFO - (blobuploader) - INFO - Done attempting. 17:57:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:57:20 INFO - Return code: 0 17:57:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:57:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:57:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e7245ecdb3b1f643abc2d218fba1004dc966267a68fda9ad0723afbc2f84b4502d5d01530b37ccecf7ad46130834fe8ffbbf943f58bb2087700b460e46578f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5041bc9fd0661f777f9afd9923f9776899d2cc4ab97b86cb36a21e7bd854d46a8d322c3eb6def9d1b9096b9e25045858ef557570f11f3aa4da2c3635033cf76a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9283ce9bed07762c5fe248cb720bca0589b25314763ba8bb1fba4603529f2caefe13862b598c31fa3d7a39dca55d09bac3b766aef1c85e5f6dde544ff122f8cb"} 17:57:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:57:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:57:20 INFO - Contents: 17:57:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e7245ecdb3b1f643abc2d218fba1004dc966267a68fda9ad0723afbc2f84b4502d5d01530b37ccecf7ad46130834fe8ffbbf943f58bb2087700b460e46578f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5041bc9fd0661f777f9afd9923f9776899d2cc4ab97b86cb36a21e7bd854d46a8d322c3eb6def9d1b9096b9e25045858ef557570f11f3aa4da2c3635033cf76a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9283ce9bed07762c5fe248cb720bca0589b25314763ba8bb1fba4603529f2caefe13862b598c31fa3d7a39dca55d09bac3b766aef1c85e5f6dde544ff122f8cb"} 17:57:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:57:20 INFO - Copying logs to upload dir... 17:57:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:57:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.194127 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-09-02 17:57:20.727497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 17:57:20.731576) ========= 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=af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564 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/4e7245ecdb3b1f643abc2d218fba1004dc966267a68fda9ad0723afbc2f84b4502d5d01530b37ccecf7ad46130834fe8ffbbf943f58bb2087700b460e46578f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5041bc9fd0661f777f9afd9923f9776899d2cc4ab97b86cb36a21e7bd854d46a8d322c3eb6def9d1b9096b9e25045858ef557570f11f3aa4da2c3635033cf76a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9283ce9bed07762c5fe248cb720bca0589b25314763ba8bb1fba4603529f2caefe13862b598c31fa3d7a39dca55d09bac3b766aef1c85e5f6dde544ff122f8cb"} build_url:https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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/4e7245ecdb3b1f643abc2d218fba1004dc966267a68fda9ad0723afbc2f84b4502d5d01530b37ccecf7ad46130834fe8ffbbf943f58bb2087700b460e46578f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5041bc9fd0661f777f9afd9923f9776899d2cc4ab97b86cb36a21e7bd854d46a8d322c3eb6def9d1b9096b9e25045858ef557570f11f3aa4da2c3635033cf76a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9283ce9bed07762c5fe248cb720bca0589b25314763ba8bb1fba4603529f2caefe13862b598c31fa3d7a39dca55d09bac3b766aef1c85e5f6dde544ff122f8cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 17:57:20.757542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:57:20.757924) ========= 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=af724c981e2a0f424dbabf99000001e7-1472862932.361847-43142564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004360 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:57:20.841308) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 17:57:20.841675) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 17:57:20.842006) ========= ========= Total master_lag: 0.27 =========