builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1472570728.1 results: success (0) buildid: 20160830053002 builduid: 09fc6f46d3ef465b943dea9855e3c94f revision: 444b23193a56cec7f47763e4afb3d4881e40632e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.098568) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.108998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.109515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.137645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.137928) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 08:25:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.3M=0s 2016-08-30 08:25:28 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.253538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.253828) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019222 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.303090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:28.303395) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 444b23193a56cec7f47763e4afb3d4881e40632e --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 444b23193a56cec7f47763e4afb3d4881e40632e --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=9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 08:25:28,945 truncating revision to first 12 chars 2016-08-30 08:25:28,945 Setting DEBUG logging. 2016-08-30 08:25:28,946 attempt 1/10 2016-08-30 08:25:28,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/444b23193a56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 08:25:29,630 unpacking tar archive at: fx-team-444b23193a56/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:29.296910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:29.297246) ========= script_repo_revision: 444b23193a56cec7f47763e4afb3d4881e40632e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:29.297677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:29.297994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:25:29.307691) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-30 08:25:29.308078) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:25:30 INFO - MultiFileLogger online at 20160830 08:25:30 in /builds/slave/test 08:25:30 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 08:25:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:25:30 INFO - {'append_to_log': False, 08:25:30 INFO - 'base_work_dir': '/builds/slave/test', 08:25:30 INFO - 'blob_upload_branch': 'Fx-Team', 08:25:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:25:30 INFO - 'branch': 'Fx-Team', 08:25:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:25:30 INFO - 'config_files': ('talos/linux_config.py',), 08:25:30 INFO - 'default_actions': ('clobber', 08:25:30 INFO - 'read-buildbot-config', 08:25:30 INFO - 'download-and-extract', 08:25:30 INFO - 'populate-webroot', 08:25:30 INFO - 'create-virtualenv', 08:25:30 INFO - 'install', 08:25:30 INFO - 'run-tests'), 08:25:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:25:30 INFO - 'download_minidump_stackwalk': True, 08:25:30 INFO - 'download_symbols': 'ondemand', 08:25:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:25:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:25:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:25:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:25:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:25:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:25:30 INFO - 'installer_path': 'installer.exe', 08:25:30 INFO - 'log_level': 'info', 08:25:30 INFO - 'log_name': 'talos', 08:25:30 INFO - 'log_to_console': True, 08:25:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:25:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:25:30 INFO - 'opt_config_files': (), 08:25:30 INFO - 'pip_index': False, 08:25:30 INFO - 'sps_profile': False, 08:25:30 INFO - 'sps_profile_interval': 0, 08:25:30 INFO - 'suite': 'dromaeojs', 08:25:30 INFO - 'system_bits': '32', 08:25:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:25:30 INFO - 'title': 'talos-linux64-ix-022', 08:25:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:25:30 INFO - 'use_talos_json': True, 08:25:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:25:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:25:30 INFO - 'work_dir': 'build'} 08:25:30 INFO - [mozharness: 2016-08-30 15:25:30.045823Z] Running clobber step. 08:25:30 INFO - Running pre-action listener: _resource_record_pre_action 08:25:30 INFO - Running main action method: clobber 08:25:30 INFO - rmtree: /builds/slave/test/build 08:25:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:25:30 INFO - Running post-action listener: _resource_record_post_action 08:25:30 INFO - [mozharness: 2016-08-30 15:25:30.508716Z] Finished clobber step (success) 08:25:30 INFO - [mozharness: 2016-08-30 15:25:30.508817Z] Running read-buildbot-config step. 08:25:30 INFO - Running pre-action listener: _resource_record_pre_action 08:25:30 INFO - Running main action method: read_buildbot_config 08:25:30 INFO - Using buildbot properties: 08:25:30 INFO - { 08:25:30 INFO - "project": "", 08:25:30 INFO - "product": "firefox", 08:25:30 INFO - "script_repo_revision": "production", 08:25:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:25:30 INFO - "repository": "", 08:25:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:25:30 INFO - "buildid": "20160830053002", 08:25:30 INFO - "pgo_build": "True", 08:25:30 INFO - "basedir": "/builds/slave/test", 08:25:30 INFO - "buildnumber": 1503, 08:25:30 INFO - "slavename": "talos-linux64-ix-022", 08:25:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:25:30 INFO - "platform": "ubuntu64_hw", 08:25:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:25:30 INFO - "branch": "fx-team", 08:25:30 INFO - "repo_path": "integration/fx-team", 08:25:30 INFO - "revision": "444b23193a56cec7f47763e4afb3d4881e40632e", 08:25:30 INFO - "stage_platform": "linux64-pgo", 08:25:30 INFO - "builduid": "09fc6f46d3ef465b943dea9855e3c94f", 08:25:30 INFO - "slavebuilddir": "test" 08:25:30 INFO - } 08:25:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:25:30 INFO - Running post-action listener: _resource_record_post_action 08:25:30 INFO - [mozharness: 2016-08-30 15:25:30.511263Z] Finished read-buildbot-config step (success) 08:25:30 INFO - [mozharness: 2016-08-30 15:25:30.511354Z] Running download-and-extract step. 08:25:30 INFO - Running pre-action listener: _resource_record_pre_action 08:25:30 INFO - Running main action method: download_and_extract 08:25:30 INFO - mkdir: /builds/slave/test/build/tests 08:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:30 INFO - trying https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:25:31 INFO - Downloaded 1361 bytes. 08:25:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:25:31 INFO - Using the following test package requirements: 08:25:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:25:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:25:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:25:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'jsshell-linux-x86_64.zip'], 08:25:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:25:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:25:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:25:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:25:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:25:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:25:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:25:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:25: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')]} 08:25:31 INFO - trying https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:25:31 INFO - Downloading https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:25:31 INFO - Downloaded 21885904 bytes. 08:25:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:25:36 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:36 INFO - trying https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:25:36 INFO - Downloading https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:25:37 INFO - Downloaded 21885904 bytes. 08:25:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:41 INFO - trying https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:41 INFO - Downloading https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:25:42 INFO - Downloaded 14413998 bytes. 08:25:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:42 INFO - trying https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:25:43 INFO - Downloaded 59743879 bytes. 08:25:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:43 INFO - mkdir: /builds/slave/test/properties 08:25:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:43 INFO - Contents: 08:25:43 INFO - build_url:https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:25:44 INFO - Running post-action listener: _resource_record_post_action 08:25:44 INFO - Running post-action listener: set_extra_try_arguments 08:25:44 INFO - [mozharness: 2016-08-30 15:25:44.502432Z] Finished download-and-extract step (success) 08:25:44 INFO - [mozharness: 2016-08-30 15:25:44.502659Z] Running populate-webroot step. 08:25:44 INFO - Running pre-action listener: _resource_record_pre_action 08:25:44 INFO - Running main action method: populate_webroot 08:25:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:44 INFO - '--tppagecycles', 08:25:44 INFO - '7'], 08:25:44 INFO - 'tests': ['tsvgm']}}, 08:25:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:25:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:25:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:25:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['damp', 'tps']}, 08:25:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'tests': ['damp', 'tps']}, 08:25:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['dromaeo_dom']}, 08:25:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['basic_compositor_video']}, 08:25:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:25:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['a11yr', 08:25:44 INFO - 'ts_paint', 08:25:44 INFO - 'tpaint', 08:25:44 INFO - 'sessionrestore', 08:25:44 INFO - 'sessionrestore_no_auto_restore', 08:25:44 INFO - 'tabpaint']}, 08:25:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:25:44 INFO - 'ts_paint', 08:25:44 INFO - 'tpaint', 08:25:44 INFO - 'sessionrestore', 08:25:44 INFO - 'sessionrestore_no_auto_restore', 08:25:44 INFO - 'tabpaint']}, 08:25:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:25:44 INFO - 'ts_paint', 08:25:44 INFO - 'tpaint', 08:25:44 INFO - 'sessionrestore', 08:25:44 INFO - 'sessionrestore_no_auto_restore', 08:25:44 INFO - 'tabpaint']}, 08:25:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:25:44 INFO - 'ts_paint', 08:25:44 INFO - 'tpaint', 08:25:44 INFO - 'sessionrestore', 08:25:44 INFO - 'sessionrestore_no_auto_restore', 08:25:44 INFO - 'tabpaint']}, 08:25:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['a11yr', 08:25:44 INFO - 'ts_paint', 08:25:44 INFO - 'tpaint', 08:25:44 INFO - 'sessionrestore', 08:25:44 INFO - 'sessionrestore_no_auto_restore', 08:25:44 INFO - 'tabpaint']}, 08:25:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['a11yr', 08:25:44 INFO - 'ts_paint', 08:25:44 INFO - 'tpaint', 08:25:44 INFO - 'sessionrestore', 08:25:44 INFO - 'sessionrestore_no_auto_restore', 08:25:44 INFO - 'tabpaint']}, 08:25:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['tsvgx', 08:25:44 INFO - 'tsvgr_opacity', 08:25:44 INFO - 'tart', 08:25:44 INFO - 'tscrollx', 08:25:44 INFO - 'cart']}, 08:25:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:25:44 INFO - 'tsvgr_opacity', 08:25:44 INFO - 'tart', 08:25:44 INFO - 'tscrollx', 08:25:44 INFO - 'cart']}, 08:25:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'talos_options': ['--disable-e10s'], 08:25:44 INFO - 'tests': ['tp5o']}, 08:25:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'tests': ['tp5o']}, 08:25:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'talos_options': ['--disable-e10s', 08:25:44 INFO - '--xperf_path', 08:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:44 INFO - 'tests': ['tp5n']}, 08:25:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:44 INFO - 'talos_options': ['--xperf_path', 08:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:44 INFO - 'tests': ['tp5n']}}, 08:25:44 INFO - 'talos.zip': {'path': '', 08:25:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:44 INFO - Running post-action listener: _resource_record_post_action 08:25:44 INFO - [mozharness: 2016-08-30 15:25:44.525079Z] Finished populate-webroot step (success) 08:25:44 INFO - [mozharness: 2016-08-30 15:25:44.525179Z] Running create-virtualenv step. 08:25:44 INFO - Running pre-action listener: _resource_record_pre_action 08:25:44 INFO - Running main action method: create_virtualenv 08:25:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:25:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:44 INFO - Using real prefix '/usr' 08:25:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:47 INFO - Installing pip.................done. 08:25:47 INFO - Return code: 0 08:25:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:47 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 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:25:47 INFO - Using env: {'DISPLAY': ':0', 08:25:47 INFO - 'HOME': '/home/cltbld', 08:25:47 INFO - 'LANG': 'en_US.UTF-8', 08:25:47 INFO - 'LANGUAGE': 'en_US:en', 08:25:47 INFO - 'LOGNAME': 'cltbld', 08:25:47 INFO - 'MAIL': '/var/mail/cltbld', 08:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:47 INFO - 'MOZ_NO_REMOTE': '1', 08:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:47 INFO - 'NO_EM_RESTART': '1', 08:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:47 INFO - 'PWD': '/builds/slave/test', 08:25:47 INFO - 'SHELL': '/bin/bash', 08:25:47 INFO - 'SHLVL': '1', 08:25:47 INFO - 'TERM': 'linux', 08:25:47 INFO - 'TMOUT': '86400', 08:25:47 INFO - 'USER': 'cltbld', 08:25:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:47 INFO - '_': '/tools/buildbot/bin/python'} 08:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:25:47 INFO - Cleaning up... 08:25:47 INFO - Return code: 0 08:25:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:47 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 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:25:47 INFO - Using env: {'DISPLAY': ':0', 08:25:47 INFO - 'HOME': '/home/cltbld', 08:25:47 INFO - 'LANG': 'en_US.UTF-8', 08:25:47 INFO - 'LANGUAGE': 'en_US:en', 08:25:47 INFO - 'LOGNAME': 'cltbld', 08:25:47 INFO - 'MAIL': '/var/mail/cltbld', 08:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:47 INFO - 'MOZ_NO_REMOTE': '1', 08:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:47 INFO - 'NO_EM_RESTART': '1', 08:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:47 INFO - 'PWD': '/builds/slave/test', 08:25:47 INFO - 'SHELL': '/bin/bash', 08:25:47 INFO - 'SHLVL': '1', 08:25:47 INFO - 'TERM': 'linux', 08:25:47 INFO - 'TMOUT': '86400', 08:25:47 INFO - 'USER': 'cltbld', 08:25:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:47 INFO - '_': '/tools/buildbot/bin/python'} 08:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:47 INFO - Downloading/unpacking psutil>=3.1.1 08:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:49 INFO - Installing collected packages: psutil 08:25:49 INFO - Running setup.py install for psutil 08:25:49 INFO - building 'psutil._psutil_linux' extension 08:25:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:25:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:25:49 INFO - building 'psutil._psutil_posix' extension 08:25:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:25:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:25:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:49 INFO - Successfully installed psutil 08:25:49 INFO - Cleaning up... 08:25:50 INFO - Return code: 0 08:25:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:25: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 mozsystemmonitor==0.3 08:25:50 INFO - Using env: {'DISPLAY': ':0', 08:25:50 INFO - 'HOME': '/home/cltbld', 08:25:50 INFO - 'LANG': 'en_US.UTF-8', 08:25:50 INFO - 'LANGUAGE': 'en_US:en', 08:25:50 INFO - 'LOGNAME': 'cltbld', 08:25:50 INFO - 'MAIL': '/var/mail/cltbld', 08:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:50 INFO - 'MOZ_NO_REMOTE': '1', 08:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:50 INFO - 'NO_EM_RESTART': '1', 08:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:50 INFO - 'PWD': '/builds/slave/test', 08:25:50 INFO - 'SHELL': '/bin/bash', 08:25:50 INFO - 'SHLVL': '1', 08:25:50 INFO - 'TERM': 'linux', 08:25:50 INFO - 'TMOUT': '86400', 08:25:50 INFO - 'USER': 'cltbld', 08:25:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:50 INFO - '_': '/tools/buildbot/bin/python'} 08:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:25:52 INFO - Installing collected packages: mozsystemmonitor 08:25:52 INFO - Running setup.py install for mozsystemmonitor 08:25:52 INFO - Successfully installed mozsystemmonitor 08:25:52 INFO - Cleaning up... 08:25:52 INFO - Return code: 0 08:25:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:52 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 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:25:52 INFO - Using env: {'DISPLAY': ':0', 08:25:52 INFO - 'HOME': '/home/cltbld', 08:25:52 INFO - 'LANG': 'en_US.UTF-8', 08:25:52 INFO - 'LANGUAGE': 'en_US:en', 08:25:52 INFO - 'LOGNAME': 'cltbld', 08:25:52 INFO - 'MAIL': '/var/mail/cltbld', 08:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:52 INFO - 'MOZ_NO_REMOTE': '1', 08:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:52 INFO - 'NO_EM_RESTART': '1', 08:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:52 INFO - 'PWD': '/builds/slave/test', 08:25:52 INFO - 'SHELL': '/bin/bash', 08:25:52 INFO - 'SHLVL': '1', 08:25:52 INFO - 'TERM': 'linux', 08:25:52 INFO - 'TMOUT': '86400', 08:25:52 INFO - 'USER': 'cltbld', 08:25:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:52 INFO - '_': '/tools/buildbot/bin/python'} 08:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:52 INFO - Downloading/unpacking jsonschema==2.5.1 08:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:54 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:54 INFO - warning: no files found matching '*.txt' 08:25:54 INFO - no previously-included directories found matching 'build' 08:25:54 INFO - no previously-included directories found matching 'dist' 08:25:54 INFO - no previously-included directories found matching '.git*' 08:25:54 INFO - Installing collected packages: jsonschema, functools32 08:25:54 INFO - Running setup.py install for functools32 08:25:54 INFO - warning: no files found matching '*.txt' 08:25:54 INFO - no previously-included directories found matching 'build' 08:25:54 INFO - no previously-included directories found matching 'dist' 08:25:54 INFO - no previously-included directories found matching '.git*' 08:25:54 INFO - Successfully installed jsonschema functools32 08:25:54 INFO - Cleaning up... 08:25:54 INFO - Return code: 0 08:25:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:25:54 INFO - Using env: {'DISPLAY': ':0', 08:25:54 INFO - 'HOME': '/home/cltbld', 08:25:54 INFO - 'LANG': 'en_US.UTF-8', 08:25:54 INFO - 'LANGUAGE': 'en_US:en', 08:25:54 INFO - 'LOGNAME': 'cltbld', 08:25:54 INFO - 'MAIL': '/var/mail/cltbld', 08:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:54 INFO - 'MOZ_NO_REMOTE': '1', 08:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:54 INFO - 'NO_EM_RESTART': '1', 08:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:54 INFO - 'PWD': '/builds/slave/test', 08:25:54 INFO - 'SHELL': '/bin/bash', 08:25:54 INFO - 'SHLVL': '1', 08:25:54 INFO - 'TERM': 'linux', 08:25:54 INFO - 'TMOUT': '86400', 08:25:54 INFO - 'USER': 'cltbld', 08:25:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:54 INFO - '_': '/tools/buildbot/bin/python'} 08:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:25:55 INFO - Cleaning up... 08:25:55 INFO - Return code: 0 08:25:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:25:55 INFO - Using env: {'DISPLAY': ':0', 08:25:55 INFO - 'HOME': '/home/cltbld', 08:25:55 INFO - 'LANG': 'en_US.UTF-8', 08:25:55 INFO - 'LANGUAGE': 'en_US:en', 08:25:55 INFO - 'LOGNAME': 'cltbld', 08:25:55 INFO - 'MAIL': '/var/mail/cltbld', 08:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:55 INFO - 'MOZ_NO_REMOTE': '1', 08:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:55 INFO - 'NO_EM_RESTART': '1', 08:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:55 INFO - 'PWD': '/builds/slave/test', 08:25:55 INFO - 'SHELL': '/bin/bash', 08:25:55 INFO - 'SHLVL': '1', 08:25:55 INFO - 'TERM': 'linux', 08:25:55 INFO - 'TMOUT': '86400', 08:25:55 INFO - 'USER': 'cltbld', 08:25:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:55 INFO - '_': '/tools/buildbot/bin/python'} 08:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:57 INFO - Downloading docopt-0.6.1.tar.gz 08:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:57 INFO - Running setup.py install for blobuploader 08:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:58 INFO - Running setup.py install for requests 08:25:58 INFO - Running setup.py install for docopt 08:25:58 INFO - Successfully installed blobuploader requests docopt 08:25:58 INFO - Cleaning up... 08:25:58 INFO - Return code: 0 08:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:58 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 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:58 INFO - Using env: {'DISPLAY': ':0', 08:25:58 INFO - 'HOME': '/home/cltbld', 08:25:58 INFO - 'LANG': 'en_US.UTF-8', 08:25:58 INFO - 'LANGUAGE': 'en_US:en', 08:25:58 INFO - 'LOGNAME': 'cltbld', 08:25:58 INFO - 'MAIL': '/var/mail/cltbld', 08:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:58 INFO - 'MOZ_NO_REMOTE': '1', 08:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:58 INFO - 'NO_EM_RESTART': '1', 08:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:58 INFO - 'PWD': '/builds/slave/test', 08:25:58 INFO - 'SHELL': '/bin/bash', 08:25:58 INFO - 'SHLVL': '1', 08:25:58 INFO - 'TERM': 'linux', 08:25:58 INFO - 'TMOUT': '86400', 08:25:58 INFO - 'USER': 'cltbld', 08:25:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:58 INFO - '_': '/tools/buildbot/bin/python'} 08:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:58 INFO - Running setup.py (path:/tmp/pip-Uz6DGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:58 INFO - Running setup.py (path:/tmp/pip-Dl93P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:58 INFO - Running setup.py (path:/tmp/pip-zNUiHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:59 INFO - Running setup.py (path:/tmp/pip-fhrxH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:59 INFO - Running setup.py (path:/tmp/pip-zqIq5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:59 INFO - Running setup.py (path:/tmp/pip-BFUKun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:59 INFO - Running setup.py (path:/tmp/pip-UOATP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:59 INFO - Running setup.py (path:/tmp/pip-TGlaEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:59 INFO - Running setup.py (path:/tmp/pip-Zzk0lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:59 INFO - Running setup.py (path:/tmp/pip-iipqxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:59 INFO - Running setup.py (path:/tmp/pip-LggHdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:59 INFO - Running setup.py (path:/tmp/pip-LqaWps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:59 INFO - Running setup.py (path:/tmp/pip-FPfUkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:59 INFO - Running setup.py (path:/tmp/pip-F0KLga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:59 INFO - Running setup.py (path:/tmp/pip-PsDq12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:59 INFO - Running setup.py (path:/tmp/pip-lxTBTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:59 INFO - Running setup.py (path:/tmp/pip-hbN9dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:00 INFO - Running setup.py install for manifestparser 08:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Running setup.py install for mozcrash 08:26:00 INFO - Running setup.py install for mozdebug 08:26:00 INFO - Running setup.py install for mozdevice 08:26:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Running setup.py install for mozfile 08:26:00 INFO - Running setup.py install for mozhttpd 08:26:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Running setup.py install for mozinfo 08:26:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Running setup.py install for mozInstall 08:26:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:00 INFO - Running setup.py install for mozleak 08:26:00 INFO - Running setup.py install for mozlog 08:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for moznetwork 08:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozprocess 08:26:01 INFO - Running setup.py install for mozprofile 08:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozrunner 08:26:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Running setup.py install for mozscreenshot 08:26:01 INFO - Running setup.py install for moztest 08:26:01 INFO - Running setup.py install for mozversion 08:26:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:01 INFO - Cleaning up... 08:26:01 INFO - Return code: 0 08:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:26:01 INFO - Using env: {'DISPLAY': ':0', 08:26:01 INFO - 'HOME': '/home/cltbld', 08:26:01 INFO - 'LANG': 'en_US.UTF-8', 08:26:01 INFO - 'LANGUAGE': 'en_US:en', 08:26:01 INFO - 'LOGNAME': 'cltbld', 08:26:01 INFO - 'MAIL': '/var/mail/cltbld', 08:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:01 INFO - 'MOZ_NO_REMOTE': '1', 08:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:01 INFO - 'NO_EM_RESTART': '1', 08:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:01 INFO - 'PWD': '/builds/slave/test', 08:26:01 INFO - 'SHELL': '/bin/bash', 08:26:01 INFO - 'SHLVL': '1', 08:26:01 INFO - 'TERM': 'linux', 08:26:01 INFO - 'TMOUT': '86400', 08:26:01 INFO - 'USER': 'cltbld', 08:26:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:01 INFO - '_': '/tools/buildbot/bin/python'} 08:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:02 INFO - Running setup.py (path:/tmp/pip-8WUdW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:02 INFO - Running setup.py (path:/tmp/pip-wo7vFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:02 INFO - Running setup.py (path:/tmp/pip-uIXA1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:02 INFO - Running setup.py (path:/tmp/pip-F82fZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:02 INFO - Running setup.py (path:/tmp/pip-pFdarG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:02 INFO - Running setup.py (path:/tmp/pip-TBI2py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:02 INFO - Running setup.py (path:/tmp/pip-ZIUeDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:02 INFO - Running setup.py (path:/tmp/pip-3Qdo6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:02 INFO - Running setup.py (path:/tmp/pip-R1kOus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:02 INFO - Running setup.py (path:/tmp/pip-bHrY_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:02 INFO - Running setup.py (path:/tmp/pip-NddGiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:02 INFO - Running setup.py (path:/tmp/pip-Z6m2vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:02 INFO - Running setup.py (path:/tmp/pip-NZN7b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:02 INFO - Running setup.py (path:/tmp/pip-8D1QtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:03 INFO - Running setup.py (path:/tmp/pip-Ltexz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:03 INFO - Running setup.py (path:/tmp/pip-8TknuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:03 INFO - Running setup.py (path:/tmp/pip-Y0zRLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:05 INFO - Downloading blessings-1.6.tar.gz 08:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:26:05 INFO - Installing collected packages: blessings 08:26:05 INFO - Running setup.py install for blessings 08:26:05 INFO - Successfully installed blessings 08:26:05 INFO - Cleaning up... 08:26:05 INFO - Return code: 0 08:26:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:05 INFO - Reading from file tmpfile_stdout 08:26:05 INFO - Current package versions: 08:26:05 INFO - argparse == 1.2.1 08:26:05 INFO - blessings == 1.6 08:26:05 INFO - blobuploader == 1.2.4 08:26:05 INFO - docopt == 0.6.1 08:26:05 INFO - functools32 == 3.2.3-2 08:26:05 INFO - jsonschema == 2.5.1 08:26:05 INFO - manifestparser == 1.1 08:26:05 INFO - mozInstall == 1.12 08:26:05 INFO - mozcrash == 0.17 08:26:05 INFO - mozdebug == 0.1 08:26:05 INFO - mozdevice == 0.48 08:26:05 INFO - mozfile == 1.2 08:26:05 INFO - mozhttpd == 0.7 08:26:05 INFO - mozinfo == 0.9 08:26:05 INFO - mozleak == 0.1 08:26:05 INFO - mozlog == 3.3 08:26:05 INFO - moznetwork == 0.27 08:26:05 INFO - mozprocess == 0.23 08:26:05 INFO - mozprofile == 0.28 08:26:05 INFO - mozrunner == 6.12 08:26:05 INFO - mozscreenshot == 0.1 08:26:05 INFO - mozsystemmonitor == 0.3 08:26:05 INFO - moztest == 0.7 08:26:05 INFO - mozversion == 1.4 08:26:05 INFO - psutil == 3.1.1 08:26:05 INFO - requests == 1.2.3 08:26:05 INFO - wsgiref == 0.1.2 08:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:26:05 INFO - Using env: {'DISPLAY': ':0', 08:26:05 INFO - 'HOME': '/home/cltbld', 08:26:05 INFO - 'LANG': 'en_US.UTF-8', 08:26:05 INFO - 'LANGUAGE': 'en_US:en', 08:26:05 INFO - 'LOGNAME': 'cltbld', 08:26:05 INFO - 'MAIL': '/var/mail/cltbld', 08:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:05 INFO - 'MOZ_NO_REMOTE': '1', 08:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:05 INFO - 'NO_EM_RESTART': '1', 08:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:05 INFO - 'PWD': '/builds/slave/test', 08:26:05 INFO - 'SHELL': '/bin/bash', 08:26:05 INFO - 'SHLVL': '1', 08:26:05 INFO - 'TERM': 'linux', 08:26:05 INFO - 'TMOUT': '86400', 08:26:05 INFO - 'USER': 'cltbld', 08:26:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:05 INFO - '_': '/tools/buildbot/bin/python'} 08:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:26:05 INFO - Cleaning up... 08:26:05 INFO - Return code: 0 08:26:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd147018f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:26:05 INFO - Using env: {'DISPLAY': ':0', 08:26:05 INFO - 'HOME': '/home/cltbld', 08:26:05 INFO - 'LANG': 'en_US.UTF-8', 08:26:05 INFO - 'LANGUAGE': 'en_US:en', 08:26:05 INFO - 'LOGNAME': 'cltbld', 08:26:05 INFO - 'MAIL': '/var/mail/cltbld', 08:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:05 INFO - 'MOZ_NO_REMOTE': '1', 08:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:05 INFO - 'NO_EM_RESTART': '1', 08:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:05 INFO - 'PWD': '/builds/slave/test', 08:26:05 INFO - 'SHELL': '/bin/bash', 08:26:05 INFO - 'SHLVL': '1', 08:26:05 INFO - 'TERM': 'linux', 08:26:05 INFO - 'TMOUT': '86400', 08:26:05 INFO - 'USER': 'cltbld', 08:26:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:05 INFO - '_': '/tools/buildbot/bin/python'} 08:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:26:06 INFO - Cleaning up... 08:26:06 INFO - Return code: 0 08:26:06 INFO - Running post-action listener: _resource_record_post_action 08:26:06 INFO - Running post-action listener: _start_resource_monitoring 08:26:06 INFO - Starting resource monitoring. 08:26:06 INFO - [mozharness: 2016-08-30 15:26:06.058661Z] Finished create-virtualenv step (success) 08:26:06 INFO - [mozharness: 2016-08-30 15:26:06.059166Z] Running install step. 08:26:06 INFO - Running pre-action listener: _resource_record_pre_action 08:26:06 INFO - Running main action method: install 08:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:26:06 INFO - Reading from file tmpfile_stdout 08:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:26:06 INFO - Reading from file tmpfile_stdout 08:26:06 INFO - Output received: 08:26:06 INFO - Usage: mozinstall [options] installer 08:26:06 INFO - Options: 08:26:06 INFO - -h, --help show this help message and exit 08:26:06 INFO - -d DEST, --destination=DEST 08:26:06 INFO - Directory to install application into. [default: 08:26:06 INFO - "/builds/slave/test"] 08:26:06 INFO - --app=APP Application being installed. [default: firefox] 08:26:06 INFO - mkdir: /builds/slave/test/build/application 08:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:26:23 INFO - Reading from file tmpfile_stdout 08:26:23 INFO - Output received: 08:26:23 INFO - /builds/slave/test/build/application/firefox/firefox 08:26:23 INFO - Running post-action listener: _resource_record_post_action 08:26:23 INFO - [mozharness: 2016-08-30 15:26:23.383208Z] Finished install step (success) 08:26:23 INFO - [mozharness: 2016-08-30 15:26:23.383555Z] Running run-tests step. 08:26:23 INFO - Running pre-action listener: _resource_record_pre_action 08:26:23 INFO - Running main action method: run_tests 08:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:26:23 INFO - Python 2.7.3 08:26:23 INFO - Return code: 0 08:26:23 INFO - grabbing minidump binary from tooltool 08:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:23 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 0x22be370>, '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 0x22c18f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c1d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:26:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:26:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:26:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:26:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:26:23 INFO - Return code: 0 08:26:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:26:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:26:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:26:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:26:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:26:23 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/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:26:23 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/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:26:23 INFO - Using env: {'DISPLAY': ':0', 08:26:23 INFO - 'HOME': '/home/cltbld', 08:26:23 INFO - 'LANG': 'en_US.UTF-8', 08:26:23 INFO - 'LANGUAGE': 'en_US:en', 08:26:23 INFO - 'LOGNAME': 'cltbld', 08:26:23 INFO - 'MAIL': '/var/mail/cltbld', 08:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:23 INFO - 'MOZ_NO_REMOTE': '1', 08:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:26:23 INFO - 'NO_EM_RESTART': '1', 08:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:23 INFO - 'PWD': '/builds/slave/test', 08:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:26:23 INFO - 'SHELL': '/bin/bash', 08:26:23 INFO - 'SHLVL': '1', 08:26:23 INFO - 'TERM': 'linux', 08:26:23 INFO - 'TMOUT': '86400', 08:26:23 INFO - 'USER': 'cltbld', 08:26:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182', 08:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:23 INFO - '_': '/tools/buildbot/bin/python'} 08:26:23 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/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:26:23 INFO - mozversion application_buildid: 20160830053002 08:26:23 INFO - mozversion application_changeset: 444b23193a56cec7f47763e4afb3d4881e40632e 08:26:23 INFO - mozversion application_display_name: Nightly 08:26:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:26:23 INFO - mozversion application_name: Firefox 08:26:23 INFO - mozversion application_remotingname: firefox 08:26:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:26:23 INFO - mozversion application_vendor: Mozilla 08:26:23 INFO - mozversion application_version: 51.0a1 08:26:23 INFO - mozversion platform_buildid: 20160830053002 08:26:23 INFO - mozversion platform_changeset: 444b23193a56cec7f47763e4afb3d4881e40632e 08:26:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:26:23 INFO - mozversion platform_version: 51.0a1 08:26:23 INFO - using testdate: 1472570783 08:26:23 INFO - actual date: 1472570783 08:26:23 INFO - starting webserver on 'localhost:58844' 08:26:23 INFO - SUITE-START | Running 2 tests 08:26:23 INFO - TEST-START | dromaeo_css 08:26:23 INFO - operating with platform_type : linux_ 08:26:23 INFO - Initialising browser for dromaeo_css test... 08:26:23 INFO - TEST-INFO | started process 19866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0x1r_4/profile http://localhost:58844/getInfo.html) 08:26:27 INFO - PROCESS | 19866 | __metrics Screen width/height:1600/1200 08:26:27 INFO - PROCESS | 19866 | colorDepth:24 08:26:27 INFO - PROCESS | 19866 | Browser inner width/height: 1024/697 08:26:27 INFO - PROCESS | 19866 | __metrics 08:26:28 INFO - PROCESS | 19866 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:26:28 INFO - PROCESS | 19866 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:26:29 INFO - PROCESS | 19866 | console.error: PushService: 08:26:29 INFO - PROCESS | 19866 | stateChangeProcessEnqueue: Error transitioning state 08:26:29 INFO - PROCESS | 19866 | UnknownError 08:26:29 INFO - TEST-INFO | 19866: exit 0 08:26:29 INFO - Browser initialized. 08:26:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:26:29 INFO - TEST-INFO | started process 19949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0x1r_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:41 INFO - PROCESS | 19949 | RSS: Main: 180617216 08:26:41 INFO - PROCESS | 19949 | 08:27:33 INFO - PROCESS | 19949 | 1472570853365 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:29:41 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:58844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58844/tests/dromaeo/cssquery-ext.html) 08:29:43 INFO - PROCESS | 19949 | RSS: Main: 381411328 08:29:43 INFO - PROCESS | 19949 | 08:32:46 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:58844/tests/dromaeo/cssquery-ext.html (next: http://localhost:58844/tests/dromaeo/cssquery-jquery.html) 08:32:47 INFO - PROCESS | 19949 | RSS: Main: 280264704 08:32:47 INFO - PROCESS | 19949 | 08:35:49 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:58844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58844/tests/dromaeo/cssquery-mootools.html) 08:35:49 INFO - PROCESS | 19949 | RSS: Main: 221007872 08:35:49 INFO - PROCESS | 19949 | 08:38:51 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:58844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58844/tests/dromaeo/cssquery-prototype.html) 08:38:52 INFO - PROCESS | 19949 | RSS: Main: 220360704 08:38:52 INFO - PROCESS | 19949 | 08:41:55 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:58844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58844/tests/dromaeo/cssquery-yui.html) 08:41:55 INFO - PROCESS | 19949 | RSS: Main: 221327360 08:41:55 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:58844/tests/dromaeo/cssquery-yui.html (next: http://localhost:58844/tests/dromaeo/cssquery-dojo.html) 08:44:58 INFO - PROCESS | 19949 | RSS: Main: 309313536 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | __start_tp_report 08:44:58 INFO - PROCESS | 19949 | _x_x_mozilla_page_load 08:44:58 INFO - PROCESS | 19949 | _x_x_mozilla_page_load_details 08:44:58 INFO - PROCESS | 19949 | |i|pagename|runs| 08:44:58 INFO - PROCESS | 19949 | |0;dojo.html;3005.7745669074816;3029.818210907346;3031.3482601240735;3066.325408410149;3088.4903990841512;5192.039472697554;5194.610404219679;5273.604479664031;5284.788608455662;5328.280682107914;5257.7108259045735;5313.309269794921;5338.199270109486;5353.223782551528;5420.539254163391;4716.127516409458;4777.28340748887;4791.784369703371;4798.328234047236;4971.080350135218;4855.5559436895255;4887.364642596457;4924.532169443897;4940.654154209206;4961.107000739866;4679;4759.190937540592;4796.856094317176;4825.565699087064;4869.70781753096;4731.526847315241;4753.453352864431;4760.166970780099;4807.038592281558;4860.6111511079025;4761.500042495522;4773.140834649762;4788.738023159391;4790.688605240648;4805.111054454937;5084.923726144111;5111.9776044790815;5176.844694659128;5177.068127737006;5185.403678576974;5498.697571633558;5513.917291240635;5524.309461317335;5547.029269877755;5548;5403.918941215885;5533.1976863354585;5536.390996990328;5538.390777014525;5584.385717571064;5224.294720212761;5256.579473642138;5257.342832145981;5322.0952438085615;5337.226102215157;5769.624974376652;5775.711214439261;5780.6820624865195;5788.27646544182;5824;5406.2701535292235;5478.287822583039;5480.534154596824;5507.917381239285;5532.917006244909;5603.719814009283;5668.631538949955;5674.773009079673;5711.743416448375;5776.711164441761;5683.2895888014;5698.7435565399655;5699.658020518699;5701.173329867146;5705.486506214377;5455.481729235717;5702.258706368146;5706.885862282731;5710.172025056427;5718.571107166979;4386.539413361615;4423.049044455393;4426.159029784395;4428.424304840414;4483.887902802456;3884.2019186661128;3909.198614284065;3910.2570511602703;3954.406838974177;3957.920841583152;5156.381234251914;5376.542993845489;5411.350637923474;5434.402215756264;5438.564914806806;5667.433256674382;5733.082706766897;5740.598158128974;5749.13762935563;5818.5636077294375;5392.838214853482;5401.567874570025;5402.189671549299;5405.378381486101;5407.513323800877;4752.572268495852;4928.457869634337;4936.827211047596;4940.802367905244;4996.200607902718;5783.334916484574;5825.94174058254;5829.387914269026;5842.094475356326;5910.231669882974;5667.858303542444;5672.60291779588;5680.857978550569;5680.971595142163;5686.09022556389;5660.801871934463;5819.621724587888;5829.8251052468495;5835.79574714883;5860.912086318624;5467.425920278313;5489.972550137224;5549.889002219852;5555.611107222456;5558.44415558441;5615.101583746581;5646.520045795989;5653.915191272216;5661.773529058792;5662.405447427961;5501.504864562208;5510.118381059011;5511.779528818803;5512.889742205213;5513.338399392099;5498.092814685692;5498.395176530658;5507.008738427122;5509.421510741315;5510.228568000563;5517.337919449692;5531.363893152178;5539.307586551681;5540.667559946416;5543.057680194296;5561.6384934980715;5619.325680918316;5621.325440947113;5718.370979192202;5724.713764311685;5530.668159910419;5534.916976245279;5539;5540.86147846291;5546.029444847216 08:44:58 INFO - PROCESS | 19949 | |1;ext.html;607.4714997951781;627.6140173793116;632.1213513216629;644.5649186798912;648.7891435283534;34229;34960.42678079489;35296.82351588245;41788.791056044756;42895.35656965148;44259.11481770362;44856.775716121454;44895.326570101395;44959.10081798362;44979.77510112453;8918.643254269839;9055.637774489045;9064.274858011377;9075.546222688872;9076.546172691338;8858.822823543525;8923.464592124461;8943.060978597252;8944.284457243437;8949.105089491064;9003.864942025875;9013;9037.774055648595;9057.95471022644;9068.183863452288;8950.462972221687;8982.281417486618;9019.098090190993;9021.233195178418;9030;8901.643934242622;8952.597133129026;8970.416922900056;8971.102889711043;8973.955130224373;42161.57838421638;42169.57830421687;42268.36597451041;42394;42424.36363454551;3591.1560783215923;3596.5504311961004;3622.963770362289;3723.0878434783654;3741.382671859167;29327.853360733272;29409.264768380748;32312.676873231438;32423.351532969446;32953;4372.825086996516;4408.933865992013;4466.12910482456;4564.977175114136;4568.269076947672;358397;359303;360730.9999999974;364203;364790;54551.72724136354;62201;63344.36655633384;63396.68301658462;63480;63825;64401.67799161068;64613.35386646167;69618;70777;17470.47588572345;17823.376181833573;17824.732629010574;17840.55398615019;17887.463376098738;12612.11715179947;12624.242545447303;12624.81062784059;12627.621171364874;12627.810582841264;17599.29602815873;19486.512837179183;19595.706064409045;19911.701324480146;20074.19703211855;7310.634468276565;7413.88879166813;7426.702931882664;7433.888491672629;7515.699372025167;932.6455946740195;965.165132160676;1025.661531694539;1029.25893356783;1120.9775804483866;32334.676653233168;32369.67630323714;32655.510167347507;32708;33435.331293373994;1054.5939813171983;1098.0885864732413;1158.467105131632;1169.3101070368523;1173.3370645585387;16430;17169.48491545256;17171.141442927805;17182.914085429493;17425;556301;561499;562035;562289;562527;57526.50812615872;58050.41949580535;58086.12870806941;58086.7095664519;58094.7095264521;1264.9051321150766;1348.8583698711493;1356.409961666678;1357.606294174698;1357.830271216098;30318.84840575783;30930.98948568336;31977;31985.520217196296;32390.83804580962;51799.2230116541;51983.2202516955;52000;52076;52078.218826716875;435180;435718;436015;436253;436327;35813.28373432569;37784;42317.576824232594;44617.33074003828;45126.09747805091;41659.77961432531;46895.531044690484;47340.52659473361;48194.518054819004;48806.267905982146;37676.2464750709;40099.86080909055;40211.39682904817;42198.57801422069;42568.14863702647;39078.6092139075;40412.59587404088;40823;40911.38632920449;42814.78592607017;40894.38658420066;41289.1742165149;42218;42257.154856902074;42374;33588.328233435685;37335.2262218373;37622.43566346452;37636.62363376441;37992.810035949646;28053.579196311664;28496.857515713116;28580.42839143164;28635.856820715762;28647.14058578246 08:44:58 INFO - PROCESS | 19949 | |2;jquery.html;373.40441995017954;382.3709997054845;383.9808009599519;388.68128134929367;402.77444631006637;16184.99999999997;16185.028898266113;17564.91217543912;20316.69524957127;20659.173633054677;18516.44450666479;19680.85106382979;19682.311119110833;19701.31045413411;19741;5604.99110160171;5653.1237658162945;5722.313322401297;5893.20441740366;5896.911546326808;5634.352049514297;5677.290338707661;5694.886102277952;5708.543316534688;5728.427157284259;4088.1414902870433;6044.304904935944;6302.054691796245;6307.621542707429;6398.616083035009;6333.176687030703;6394.904076438857;6403.8399040023905;6404.615723056609;6443.871122577522;5557.888842223133;5686.630369026;5691.089425691911;5692.800751973661;5693.28833895763;22544.66183007256;23042.423939401648;23195.304140875633;23287.18494852672;23615.409614759596;2336.1122773346187;2388.964165537501;2389.880505974694;2424.248482970285;2998.610180676498;13631.250281234528;14311.284435778274;14379.35292911811;14767.502298988411;14893.627659308495;1832.404468547714;1859.2934684819681;1884.0862181841796;1890.8392786613153;1933.6271247414352;53322.73338633321;75225;76195.23804761992;79814;83106.58446707728;10510.789784204273;10675.25273230882;10754.354738715701;10799.298045627009;10869.293495922899;14640.707185856223;14724.852751472348;14791.630209244855;14857;14860.851391485947;7962.880556791652;8141.5982285226;8309.335253179732;8404.663813447516;8441.113683063313;7908.130105688369;7929.484583502054;7959;8192.18078192188;8197.918020819834;6288.245410550763;6446.355364463516;6513.706883190268;6521.934780652133;6598.571092879043;1830.0758117150754;1840.8987505687317;1874.175362840346;1890.5084677983548;1901.087478010535;964.2816102004052;976.1312431935582;976.7069879036261;1002.5037606384886;1004.1264100232844;20116.497087572927;20237.696434553494;20378.49053773638;20433;20462.488437788877;970.2432102959702;989.1098011789303;1004.5328922051282;1044.4412239452008;1088.3905013192636;10773.62292319765;11168;11403.771924561463;11537.711557211136;11564.537418503334;455149;459062;461334;474741;477008;91762;97368;97835.51082244543;98185.50907245418;98504.50747746216;979.0943377375899;984.8079624473302;1026.2662196529518;1026.697124348319;1047.3297089862494;17247.827521725125;17497.737533936746;17983.910080449514;18122.45632631023;18306;40646;40877.59122408857;41524.37713434362;41999.370009449274;43046;54753.45246547643;57283.42716572781;57886;59464;60363.39636603578;8369.49783013021;8496;8719.476831390137;8783.959378685877;8823.911760882309;9696.9030309696;12087.214331068453;12951.805722913976;13200.537981170613;13840.86159138436;11712.88287117118;11769.234999724991;12141.15011949155;12248.387580620754;12283.263004219418;11562.76874462523;11645.184837061324;11656.683441145356;11702.648920532398;11882.76234475323;11797.29216247028;11959.103067270164;12107.757844842878;12367.134300598871;12487.687807804878;8342.416030877781;8645.610947507252;8783;8834.204921557091;8946.329025322997;10270.818855831674;11829.526818927146;11907.642770716893;12191.878081219074;12267.386630668252 08:44:58 INFO - PROCESS | 19949 | |3;mootools.html;1357.2942070123543;1466.8533146685334;1510.3580978084312;1629.5844559637292;1802.9008404537753;8402.747917562476;8792.69225577105;8810.427322224059;9012.95493522533;9021.684241051564;8880.555972201397;8988.191062804346;9000.099990000997;9002.594883230255;9014.774630634238;2131.179495894084;2381.285614315703;2384.6899903012586;2407.843490173133;2409.3374322061486;2450.387403149213;2477.331120597438;2482.2801387597665;2484.763947424992;2484.950300993979;2407.434252950555;2431.294924471901;2476.4799392127675;2476.863772492512;2476.938076548092;2357.4224315042925;2382.106709983756;2388.3909603051197;2413.7706917842775;2436.0377650828;2414.9275521734376;2440.1581454398206;2448.2165706973774;2451.705795304575;2452.558539462896;9260.166585007315;9298.860517092182;9300.162985331353;9303.906960930371;9333.486658233795;5299.2845965794895;5506.421825708283;5529.170624406331;5530.170474428827;5535.6955367454775;3388.6441923597913;3498.5626796650417;3555.4311310190506;3556.8577256909953;3598.118460977051;1136.4885801389407;1171.7187874910046;1176.4000359816555;1198.3828328410875;1204.2292932523192;12496.125271231018;12631.305278209788;12641.051921105862;12682.112252142353;12686;4287.678424118204;4576.588107070313;4595.747233902101;4774.928376074362;4782.52174782519;9979;9987.400755954666;9988.950055249677;9992.600295988079;10000.549975251131;5287.339082614673;5306.495882891119;5312.5484333832055;5313.867153321198;5316.883454474603;4314.546972567898;4750.8337208197545;4849.854504364875;4885.658003939761;4955.529224723646;3820.369639009588;3869.8258578364043;3963.385675220288;4000.6199411055904;4007.939880901789;1178.9056875449944;1190.6190019193948;1200.4837919694442;1206.324458303353;1214.4959841665786;914.401067300919;984.2372161574693;1001.5593139018808;1006.9043440873105;1010.166612544639;6082.665453400105;6238.781642642486;6267.2479302484;6284.528660350492;6409;972.3436680240809;989.3082828363436;1006.5470538257813;1012.1295685710284;1037.901399367074;4106.815193316308;4236.2374772540625;4271.487421509439;4300.80646370914;4336.262835317941;11014.284071535325;11415;11438.370889601152;11440.313581185155;11466.656000320003;11283.830742538868;11298.887011129947;11299;11299.717507062225;11314.943425282821;7806.336461400844;8131.512109273344;8142.389320800845;8202.015758109064;8336.291415229653;6297.244330680164;6375.489960803217;6505.31694172124;6524.869502609827;6577.901331479936;10445.373277603368;10506.684799456028;10600;10722.356658600509;10722.410267435365;10499.68500944973;10726.302790318916;10876;10877.51051202682;10896.182786291218;7836.882446763189;7975.80060498469;8067.959660201662;8143.389245806707;8291.543965081979;9041.728748137566;9046.185843274137;9107.726768196964;9111.088891110836;9132.863007054766;8012;8028.558429286211;8059.637316320897;8132.67469301245;8180.550069746221;7688.961555192188;7709.807254818675;7730;7876.921230787619;7982.241687039722;6964.616946068015;7096.680649370687;7146.3568278855155;7166.140063192451;7214.422846172189;5217.713025783467;5220.660657057279;5242.213667949685;5319.973400132974;5489.698066606375;5364.329458817648;5384.326959130109;5422.132458806572;5468.316460442445;5579.2746942897165 08:44:58 INFO - PROCESS | 19949 | |4;prototype.html;308.80853870600225;315.689046289405;320.90854106579616;335.2741315052912;336.7205219667676;5162.38051433828;5169.663971841837;5170.276161337406;5173.508516690913;5229.8169564065265;5105.846824595268;5141.768620412081;5141.794328226866;5151.227315902616;5157.819476318329;3862.2661694278136;3986.342253528179;3999.860004899829;4005.619466150711;4010.2981978153853;3584.390653588896;4076.1847630473876;4093.713440059197;4113.1568028554075;4119.537564164723;4054.513458384998;4063.9796801015955;4076.1440097579543;4092.85675001375;4108.897277568055;3908.4009133925906;4065.918681626351;4079.714419990602;4103.4460347852955;4111.280525907969;3486.1110416843794;3610;3614.409659749702;3618.7466877318598;3634.83643236055;5001.3998320201445;5008.84973450797;5011.098002359574;5033.798648054073;5059.773699572213;4683;4705.764711764432;4717.103750287434;4729.408823897013;4733.976330118362;5105.897882042338;5334.879675268198;5360.624756267063;5369.275147855029;5370.113931201387;3876.8836934891997;3913.334733095352;3937.1535119949062;3943.211357728466;3954.406838974177;5326.813561525328;5374.677519348813;5614.9157762633595;5637.577181711388;5643.830685079454;3928.823202955874;3966.781826999543;3971.1660551283976;3973.264945984944;3977.5879562755385;4025.456563363967;4035.3543433050572;4038.4749982502676;4051.3517837145914;4053.5946405359227;4495.955040449554;4613.677042606985;4621.630269578425;4637.188492013884;4649.488556258809;5365.302510673666;5365.517103460707;5375.139977603565;5385.5960802939935;5401.3518377794135;1371.5885234429632;1390.1381143690976;1392.9024968252124;1394.874461298488;1398.9860101399058;860.9913900860911;901.3600343756007;906.7823722306599;907.5371560504191;918.1277786103095;4574.6340292776495;4615.746133962664;4619.3994780678295;4620.630349572026;4626.791794369262;4797.232442809134;4855.393075865517;4869.634777391639;4874.293227481995;4906.239532872411;4356.3683265926265;4626.583607475276;4640.47094333589;4650.720956742606;4674.293882732778;2552.9361765956;2565.5125526149973;2566.242958327298;2577.6004719268544;2597.6881674754127;4960.627952903546;4986.551210391082;5003.949960500421;5027.673201241908;5030.195168772979;4634.37435946143;4766.4280286365165;4919.77860996256;4932.42162507994;4948.628852836052;4921.3356196912955;4947.282644016525;4964.950350496521;4965.255211718271;4972.154733695208;4819.180739274261;4825.6139508839915;4879.829205977774;4934.333864928189;4964.429090654477;4592.770361481846;4685.320628508915;4766.713997160182;4783.986088764195;4827.300041493893;4977.402711674622;4983.775730092082;5430.995265875826;5466.34403871538;5643.435656434323;3965.2862484753023;3976.4035394691027;3987.920241595094;3999.3001224784966;4035.1324465240114;5597.720113994365;5603.859903502445;5606.6636001840025;5618.803341883178;5635.6618602883955;5137.2037334213255;5347.075052980846;5348.919766203588;5366.409694933633;5471.781128754806;5292.259083728358;5293.311869456946;5299.311089558333;5353.544948679406;5359.785608575613;5358.008768377863;5374.704391258519;5378.435264297193;5388.353397592157;5396.163594642837;5137.460566640599;5380.574147850744;5474.178873169057;5478;5478.753456094406;5327.840164795062;5336.653117547347;5346.278252435872;5355.30381050461;5403.972980135074 08:44:58 INFO - PROCESS | 19949 | |5;yui.html;732.6007326007325;767.7696690992701;802.5412155877057;824.6948629007268;831.2477208126647;15276.312565934531;16328.673426531463;16366.181690915466;16377.13400154974;16391.426300079514;14374.856251437508;14746.115233085995;15080;15635.06189628623;15664.686706265868;802.7551596763;818.7707441916273;819.5533434278333;819.635262308273;819.6680344460503;665.933406659335;793.3256731778;820.5692011693878;821.4742564758529;826.9917300827005;852.8550146475114;860.4020205956863;860.9225169734723;861.2464093917822;863.6286396849353;859.0979471554842;859.2953777902122;860.3375400941271;860.4536119564091;860.7848037990502;503.3657591434782;605.6124080588427;618.9845253868644;622.2315440431064;624.2945471617089;15487.5353739388;15488.99321544096;15608.609784755472;15621.843781562153;15669.921650391789;14536.491222807257;14843.183624900626;15013.099214047083;15169.848301516953;15445.922770386076;13413.195208287436;13458.183145275361;13485.393157307944;13741.725165496635;13793;4496.213162696515;4571.085782843445;4590.586847183769;4626.144163329761;4792.616590672737;86586.56706716426;87041;87307.12692873053;87755.55965259354;88360.55819720861;11799.410029498491;11839.11206659504;11859.525618975144;11913.22564033335;11998;22348.664770028463;22604.095836166696;22651.546969060855;22666.546669066527;22713.659295110585;8261.17388261181;8332.875006874901;8449.408541402043;8650.221480066824;8916.331275154389;4633.235516139866;4661.603763680057;4697.580844969859;4734.692245004133;4822.348982887265;3638.7816730996224;3900.570937196906;3904.511936007999;3948.368261078214;3950.1309711863346;654.312971380049;654.780648482754;660.3297652882328;665.3246954341347;666.2171947961126;665.7736369634348;727.9454040946845;762.1121393576421;768.2356055724479;768.6579472134958;9340.20608248293;9803.754906127404;9940.155086817556;10182.745431364276;10361.533730982124;677.9355961183778;739.6264886232526;752.3003606645763;757.814335487809;767;4488.438945131858;4942.736588306246;5013.774380152902;5053.140966035783;5073.137566613685;128104;130083.34958325147;131024.34487827691;131226;135674;107551.46224268829;112039.4398028021;112876;112932.43533782278;115940;93841;96209;98390.50804746074;98935;100614.49692751489;9344.299177561574;9528.618855245713;9644.132028117503;9690.515474226402;9755.56099975517;56777.71611141918;57148.428515715976;57353;57841.13238301513;58615.12077318929;77817.61091194508;83135;83185;86604.1339586596;86952;13174.60476185716;13268.734625307246;13389.263590502227;13675.79486307726;13763.31183440844;13788.157960261104;14593.562193134223;14697.485588004369;14881;15164.469243576423;12528.436220369922;12849;12915.741685166056;13310.600681979557;13709;13050.355788064213;13182.60452186436;13250.46998120103;13768.311584420539;14135.929320353333;13840;14443.638909027359;14535.709285814435;14559.92720036393;14691;11350.842876980263;11678.941605291919;11771.587994420153;11955;12048.397580120783;10882.250261832454;10951.014408703255;11033.37297978021;12311.322877241837;12512.874871251171 08:44:58 INFO - PROCESS | 19949 | __end_tp_report 08:44:58 INFO - PROCESS | 19949 | __start_cc_report 08:44:58 INFO - PROCESS | 19949 | _x_x_mozilla_cycle_collect,2067 08:44:58 INFO - PROCESS | 19949 | __end_cc_report 08:44:58 INFO - PROCESS | 19949 | __startTimestamp1472571898934__endTimestamp 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | ------- Summary: start ------- 08:44:58 INFO - PROCESS | 19949 | Number of tests: 6 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | [#0] dojo.html Cycles:165 Average:5257.40 Median:5498.09 stddev:587.39 (10.7%) stddev-sans-first:562.01 08:44:58 INFO - PROCESS | 19949 | Values: 3005.8 3029.8 3031.3 3066.3 3088.5 5192.0 5194.6 5273.6 5284.8 5328.3 5257.7 5313.3 5338.2 5353.2 5420.5 4716.1 4777.3 4791.8 4798.3 4971.1 4855.6 4887.4 4924.5 4940.7 4961.1 4679.0 4759.2 4796.9 4825.6 4869.7 4731.5 4753.5 4760.2 4807.0 4860.6 4761.5 4773.1 4788.7 4790.7 4805.1 5084.9 5112.0 5176.8 5177.1 5185.4 5498.7 5513.9 5524.3 5547.0 5548.0 5403.9 5533.2 5536.4 5538.4 5584.4 5224.3 5256.6 5257.3 5322.1 5337.2 5769.6 5775.7 5780.7 5788.3 5824.0 5406.3 5478.3 5480.5 5507.9 5532.9 5603.7 5668.6 5674.8 5711.7 5776.7 5683.3 5698.7 5699.7 5701.2 5705.5 5455.5 5702.3 5706.9 5710.2 5718.6 4386.5 4423.0 4426.2 4428.4 4483.9 3884.2 3909.2 3910.3 3954.4 3957.9 5156.4 5376.5 5411.4 5434.4 5438.6 5667.4 5733.1 5740.6 5749.1 5818.6 5392.8 5401.6 5402.2 5405.4 5407.5 4752.6 4928.5 4936.8 4940.8 4996.2 5783.3 5825.9 5829.4 5842.1 5910.2 5667.9 5672.6 5680.9 5681.0 5686.1 5660.8 5819.6 5829.8 5835.8 5860.9 5467.4 5490.0 5549.9 5555.6 5558.4 5615.1 5646.5 5653.9 5661.8 5662.4 5501.5 5510.1 5511.8 5512.9 5513.3 5498.1 5498.4 5507.0 5509.4 5510.2 5517.3 5531.4 5539.3 5540.7 5543.1 5561.6 5619.3 5621.3 5718.4 5724.7 5530.7 5534.9 5539.0 5540.9 5546.0 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | [#1] ext.html Cycles:180 Average:61787.24 Median:42345.79 stddev:122043.86 (288.2%) stddev-sans-first:122299.78 08:44:58 INFO - PROCESS | 19949 | Values: 607.5 627.6 632.1 644.6 648.8 34229.0 34960.4 35296.8 41788.8 42895.4 44259.1 44856.8 44895.3 44959.1 44979.8 8918.6 9055.6 9064.3 9075.5 9076.5 8858.8 8923.5 8943.1 8944.3 8949.1 9003.9 9013.0 9037.8 9058.0 9068.2 8950.5 8982.3 9019.1 9021.2 9030.0 8901.6 8952.6 8970.4 8971.1 8974.0 42161.6 42169.6 42268.4 42394.0 42424.4 3591.2 3596.6 3623.0 3723.1 3741.4 29327.9 29409.3 32312.7 32423.4 32953.0 4372.8 4408.9 4466.1 4565.0 4568.3 358397.0 359303.0 360731.0 364203.0 364790.0 54551.7 62201.0 63344.4 63396.7 63480.0 63825.0 64401.7 64613.4 69618.0 70777.0 17470.5 17823.4 17824.7 17840.6 17887.5 12612.1 12624.2 12624.8 12627.6 12627.8 17599.3 19486.5 19595.7 19911.7 20074.2 7310.6 7413.9 7426.7 7433.9 7515.7 932.6 965.2 1025.7 1029.3 1121.0 32334.7 32369.7 32655.5 32708.0 33435.3 1054.6 1098.1 1158.5 1169.3 1173.3 16430.0 17169.5 17171.1 17182.9 17425.0 556301.0 561499.0 562035.0 562289.0 562527.0 57526.5 58050.4 58086.1 58086.7 58094.7 1264.9 1348.9 1356.4 1357.6 1357.8 30318.8 30931.0 31977.0 31985.5 32390.8 51799.2 51983.2 52000.0 52076.0 52078.2 435180.0 435718.0 436015.0 436253.0 436327.0 35813.3 37784.0 42317.6 44617.3 45126.1 41659.8 46895.5 47340.5 48194.5 48806.3 37676.2 40099.9 40211.4 42198.6 42568.1 39078.6 40412.6 40823.0 40911.4 42814.8 40894.4 41289.2 42218.0 42257.2 42374.0 33588.3 37335.2 37622.4 37636.6 37992.8 28053.6 28496.9 28580.4 28635.9 28647.1 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | [#2] jquery.html Cycles:180 Average:28456.39 Median:2711.43 stddev:76850.83 (2834.3%) stddev-sans-first:77037.49 08:44:58 INFO - PROCESS | 19949 | Values: 373.4 382.4 384.0 388.7 402.8 16185.0 16185.0 17564.9 20316.7 20659.2 18516.4 19680.9 19682.3 19701.3 19741.0 5605.0 5653.1 5722.3 5893.2 5896.9 5634.4 5677.3 5694.9 5708.5 5728.4 4088.1 6044.3 6302.1 6307.6 6398.6 6333.2 6394.9 6403.8 6404.6 6443.9 5557.9 5686.6 5691.1 5692.8 5693.3 22544.7 23042.4 23195.3 23287.2 23615.4 2336.1 2389.0 2389.9 2424.2 2998.6 13631.3 14311.3 14379.4 14767.5 14893.6 1832.4 1859.3 1884.1 1890.8 1933.6 53322.7 75225.0 76195.2 79814.0 83106.6 10510.8 10675.3 10754.4 10799.3 10869.3 14640.7 14724.9 14791.6 14857.0 14860.9 7962.9 8141.6 8309.3 8404.7 8441.1 7908.1 7929.5 7959.0 8192.2 8197.9 6288.2 6446.4 6513.7 6521.9 6598.6 1830.1 1840.9 1874.2 1890.5 1901.1 964.3 976.1 976.7 1002.5 1004.1 20116.5 20237.7 20378.5 20433.0 20462.5 970.2 989.1 1004.5 1044.4 1088.4 10773.6 11168.0 11403.8 11537.7 11564.5 455149.0 459062.0 461334.0 474741.0 477008.0 91762.0 97368.0 97835.5 98185.5 98504.5 979.1 984.8 1026.3 1026.7 1047.3 17247.8 17497.7 17983.9 18122.5 18306.0 40646.0 40877.6 41524.4 41999.4 43046.0 54753.5 57283.4 57886.0 59464.0 60363.4 8369.5 8496.0 8719.5 8784.0 8823.9 9696.9 12087.2 12951.8 13200.5 13840.9 11712.9 11769.2 12141.2 12248.4 12283.3 11562.8 11645.2 11656.7 11702.6 11882.8 11797.3 11959.1 12107.8 12367.1 12487.7 8342.4 8645.6 8783.0 8834.2 8946.3 10270.8 11829.5 11907.6 12191.9 12267.4 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | [#3] mootools.html Cycles:180 Average:5981.33 Median:4673.29 stddev:3403.70 (72.8%) stddev-sans-first:3395.51 08:44:58 INFO - PROCESS | 19949 | Values: 1357.3 1466.9 1510.4 1629.6 1802.9 8402.7 8792.7 8810.4 9013.0 9021.7 8880.6 8988.2 9000.1 9002.6 9014.8 2131.2 2381.3 2384.7 2407.8 2409.3 2450.4 2477.3 2482.3 2484.8 2485.0 2407.4 2431.3 2476.5 2476.9 2476.9 2357.4 2382.1 2388.4 2413.8 2436.0 2414.9 2440.2 2448.2 2451.7 2452.6 9260.2 9298.9 9300.2 9303.9 9333.5 5299.3 5506.4 5529.2 5530.2 5535.7 3388.6 3498.6 3555.4 3556.9 3598.1 1136.5 1171.7 1176.4 1198.4 1204.2 12496.1 12631.3 12641.1 12682.1 12686.0 4287.7 4576.6 4595.7 4774.9 4782.5 9979.0 9987.4 9989.0 9992.6 10000.5 5287.3 5306.5 5312.5 5313.9 5316.9 4314.5 4750.8 4849.9 4885.7 4955.5 3820.4 3869.8 3963.4 4000.6 4007.9 1178.9 1190.6 1200.5 1206.3 1214.5 914.4 984.2 1001.6 1006.9 1010.2 6082.7 6238.8 6267.2 6284.5 6409.0 972.3 989.3 1006.5 1012.1 1037.9 4106.8 4236.2 4271.5 4300.8 4336.3 11014.3 11415.0 11438.4 11440.3 11466.7 11283.8 11298.9 11299.0 11299.7 11314.9 7806.3 8131.5 8142.4 8202.0 8336.3 6297.2 6375.5 6505.3 6524.9 6577.9 10445.4 10506.7 10600.0 10722.4 10722.4 10499.7 10726.3 10876.0 10877.5 10896.2 7836.9 7975.8 8068.0 8143.4 8291.5 9041.7 9046.2 9107.7 9111.1 9132.9 8012.0 8028.6 8059.6 8132.7 8180.6 7689.0 7709.8 7730.0 7876.9 7982.2 6964.6 7096.7 7146.4 7166.1 7214.4 5217.7 5220.7 5242.2 5320.0 5489.7 5364.3 5384.3 5422.1 5468.3 5579.3 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | [#4] prototype.html Cycles:180 Average:4384.27 Median:4862.51 stddev:1256.36 (25.8%) stddev-sans-first:1222.07 08:44:58 INFO - PROCESS | 19949 | Values: 308.8 315.7 320.9 335.3 336.7 5162.4 5169.7 5170.3 5173.5 5229.8 5105.8 5141.8 5141.8 5151.2 5157.8 3862.3 3986.3 3999.9 4005.6 4010.3 3584.4 4076.2 4093.7 4113.2 4119.5 4054.5 4064.0 4076.1 4092.9 4108.9 3908.4 4065.9 4079.7 4103.4 4111.3 3486.1 3610.0 3614.4 3618.7 3634.8 5001.4 5008.8 5011.1 5033.8 5059.8 4683.0 4705.8 4717.1 4729.4 4734.0 5105.9 5334.9 5360.6 5369.3 5370.1 3876.9 3913.3 3937.2 3943.2 3954.4 5326.8 5374.7 5614.9 5637.6 5643.8 3928.8 3966.8 3971.2 3973.3 3977.6 4025.5 4035.4 4038.5 4051.4 4053.6 4496.0 4613.7 4621.6 4637.2 4649.5 5365.3 5365.5 5375.1 5385.6 5401.4 1371.6 1390.1 1392.9 1394.9 1399.0 861.0 901.4 906.8 907.5 918.1 4574.6 4615.7 4619.4 4620.6 4626.8 4797.2 4855.4 4869.6 4874.3 4906.2 4356.4 4626.6 4640.5 4650.7 4674.3 2552.9 2565.5 2566.2 2577.6 2597.7 4960.6 4986.6 5003.9 5027.7 5030.2 4634.4 4766.4 4919.8 4932.4 4948.6 4921.3 4947.3 4965.0 4965.3 4972.2 4819.2 4825.6 4879.8 4934.3 4964.4 4592.8 4685.3 4766.7 4784.0 4827.3 4977.4 4983.8 5431.0 5466.3 5643.4 3965.3 3976.4 3987.9 3999.3 4035.1 5597.7 5603.9 5606.7 5618.8 5635.7 5137.2 5347.1 5348.9 5366.4 5471.8 5292.3 5293.3 5299.3 5353.5 5359.8 5358.0 5374.7 5378.4 5388.4 5396.2 5137.5 5380.6 5474.2 5478.0 5478.8 5327.8 5336.7 5346.3 5355.3 5404.0 08:44:58 INFO - PROCESS | 19949 | 08:44:58 INFO - PROCESS | 19949 | [#5] yui.html Cycles:180 Average:22910.92 Median:4580.84 stddev:34164.26 (745.8%) stddev-sans-first:34219.51 08:44:58 INFO - PROCESS | 19949 | Values: 732.6 767.8 802.5 824.7 831.2 15276.3 16328.7 16366.2 16377.1 16391.4 14374.9 14746.1 15080.0 15635.1 15664.7 802.8 818.8 819.6 819.6 819.7 665.9 793.3 820.6 821.5 827.0 852.9 860.4 860.9 861.2 863.6 859.1 859.3 860.3 860.5 860.8 503.4 605.6 619.0 622.2 624.3 15487.5 15489.0 15608.6 15621.8 15669.9 14536.5 14843.2 15013.1 15169.8 15445.9 13413.2 13458.2 13485.4 13741.7 13793.0 4496.2 4571.1 4590.6 4626.1 4792.6 86586.6 87041.0 87307.1 87755.6 88360.6 11799.4 11839.1 11859.5 11913.2 11998.0 22348.7 22604.1 22651.5 22666.5 22713.7 8261.2 8332.9 8449.4 8650.2 8916.3 4633.2 4661.6 4697.6 4734.7 4822.3 3638.8 3900.6 3904.5 3948.4 3950.1 654.3 654.8 660.3 665.3 666.2 665.8 727.9 762.1 768.2 768.7 9340.2 9803.8 9940.2 10182.7 10361.5 677.9 739.6 752.3 757.8 767.0 4488.4 4942.7 5013.8 5053.1 5073.1 128104.0 130083.3 131024.3 131226.0 135674.0 107551.5 112039.4 112876.0 112932.4 115940.0 93841.0 96209.0 98390.5 98935.0 100614.5 9344.3 9528.6 9644.1 9690.5 9755.6 56777.7 57148.4 57353.0 57841.1 58615.1 77817.6 83135.0 83185.0 86604.1 86952.0 13174.6 13268.7 13389.3 13675.8 13763.3 13788.2 14593.6 14697.5 14881.0 15164.5 12528.4 12849.0 12915.7 13310.6 13709.0 13050.4 13182.6 13250.5 13768.3 14135.9 13840.0 14443.6 14535.7 14559.9 14691.0 11350.8 11678.9 11771.6 11955.0 12048.4 10882.3 10951.0 11033.4 12311.3 12512.9 08:44:58 INFO - PROCESS | 19949 | -------- Summary: end -------- 08:44:58 INFO - PROCESS | 19949 | 08:44:59 INFO - TEST-INFO | 19949: exit 0 08:44:59 INFO - TEST-OK | dromaeo_css | took 1116260ms 08:44:59 INFO - TEST-START | kraken 08:44:59 INFO - operating with platform_type : linux_ 08:44:59 INFO - Initialising browser for kraken test... 08:44:59 INFO - TEST-INFO | started process 20252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyKd9eW/profile http://localhost:58844/getInfo.html) 08:45:04 INFO - PROCESS | 20252 | __metrics Screen width/height:1600/1200 08:45:04 INFO - PROCESS | 20252 | colorDepth:24 08:45:04 INFO - PROCESS | 20252 | Browser inner width/height: 1024/697 08:45:04 INFO - PROCESS | 20252 | __metrics 08:45:04 INFO - PROCESS | 20252 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:45:04 INFO - PROCESS | 20252 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:05 INFO - PROCESS | 20252 | console.error: PushService: 08:45:05 INFO - PROCESS | 20252 | stateChangeProcessEnqueue: Error transitioning state 08:45:05 INFO - PROCESS | 20252 | UnknownError 08:45:05 INFO - TEST-INFO | 20252: exit 0 08:45:05 INFO - Browser initialized. 08:45:05 INFO - Running cycle 1/1 for kraken test... 08:45:05 INFO - TEST-INFO | started process 20331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyKd9eW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:17 INFO - PROCESS | 20331 | RSS: Main: 180043776 08:45:17 INFO - PROCESS | 20331 | 08:45:20 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58844/tests/kraken/driver.html?testName=audio-beat-detection) 08:45:21 INFO - PROCESS | 20331 | RSS: Main: 238010368 08:45:21 INFO - PROCESS | 20331 | 08:45:23 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58844/tests/kraken/driver.html?testName=audio-dft) 08:45:24 INFO - PROCESS | 20331 | RSS: Main: 224223232 08:45:24 INFO - PROCESS | 20331 | 08:45:27 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58844/tests/kraken/driver.html?testName=audio-fft) 08:45:28 INFO - PROCESS | 20331 | RSS: Main: 302129152 08:45:28 INFO - PROCESS | 20331 | 08:45:30 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58844/tests/kraken/driver.html?testName=audio-oscillator) 08:45:30 INFO - PROCESS | 20331 | RSS: Main: 211881984 08:45:30 INFO - PROCESS | 20331 | 08:45:32 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:45:33 INFO - PROCESS | 20331 | RSS: Main: 213110784 08:45:33 INFO - PROCESS | 20331 | 08:45:36 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58844/tests/kraken/driver.html?testName=imaging-darkroom) 08:45:37 INFO - PROCESS | 20331 | RSS: Main: 252055552 08:45:37 INFO - PROCESS | 20331 | 08:45:40 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58844/tests/kraken/driver.html?testName=imaging-desaturate) 08:45:41 INFO - PROCESS | 20331 | RSS: Main: 251432960 08:45:41 INFO - PROCESS | 20331 | 08:45:43 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58844/tests/kraken/driver.html?testName=json-parse-financial) 08:45:44 INFO - PROCESS | 20331 | RSS: Main: 251588608 08:45:44 INFO - PROCESS | 20331 | 08:45:45 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:46 INFO - PROCESS | 20331 | RSS: Main: 213753856 08:45:46 INFO - PROCESS | 20331 | 08:45:48 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:48 INFO - PROCESS | 20331 | RSS: Main: 221659136 08:45:48 INFO - PROCESS | 20331 | 08:45:50 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:51 INFO - PROCESS | 20331 | RSS: Main: 221978624 08:45:51 INFO - PROCESS | 20331 | 08:45:54 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:54 INFO - PROCESS | 20331 | RSS: Main: 223227904 08:45:54 INFO - PROCESS | 20331 | 08:45:57 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:58 INFO - PROCESS | 20331 | RSS: Main: 220942336 08:45:58 INFO - PROCESS | 20331 | 08:45:59 INFO - PROCESS | 20331 | Cycle 1(1): loaded http://localhost:58844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58844/tests/kraken/driver.html?testName=ai-astar) 08:46:00 INFO - PROCESS | 20331 | RSS: Main: 271409152 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | __start_tp_report 08:46:00 INFO - PROCESS | 20331 | _x_x_mozilla_page_load 08:46:00 INFO - PROCESS | 20331 | _x_x_mozilla_page_load_details 08:46:00 INFO - PROCESS | 20331 | |i|pagename|runs| 08:46:00 INFO - PROCESS | 20331 | |0;ai-astar;113;111;130;111;115;111;116;113;112;113 08:46:00 INFO - PROCESS | 20331 | |1;audio-beat-detection;152;117;155;177;124;141;147;119;176;120 08:46:00 INFO - PROCESS | 20331 | |2;audio-dft;163;161;161;160;161;163;161;161;160;162 08:46:00 INFO - PROCESS | 20331 | |3;audio-fft;76;76;76;175;76;77;74;76;175;75 08:46:00 INFO - PROCESS | 20331 | |4;audio-oscillator;82;82;158;82;81;82;150;81;81;141 08:46:00 INFO - PROCESS | 20331 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;117;118;117 08:46:00 INFO - PROCESS | 20331 | |6;imaging-darkroom;145;146;146;145;145;145;145;145;146;145 08:46:00 INFO - PROCESS | 20331 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 08:46:00 INFO - PROCESS | 20331 | |8;json-parse-financial;51;51;52;51;53;52;52;51;53;52 08:46:00 INFO - PROCESS | 20331 | |9;json-stringify-tinderbox;60;60;60;61;61;62;62;61;64;61 08:46:00 INFO - PROCESS | 20331 | |10;stanford-crypto-aes;80;80;79;87;86;79;87;83;81;80 08:46:00 INFO - PROCESS | 20331 | |11;stanford-crypto-ccm;135;138;137;133;131;132;137;128;162;126 08:46:00 INFO - PROCESS | 20331 | |12;stanford-crypto-pbkdf2;169;167;169;168;167;165;177;165;167;165 08:46:00 INFO - PROCESS | 20331 | |13;stanford-crypto-sha256-iterative;67;71;68;68;68;66;66;64;64;65 08:46:00 INFO - PROCESS | 20331 | __end_tp_report 08:46:00 INFO - PROCESS | 20331 | __start_cc_report 08:46:00 INFO - PROCESS | 20331 | _x_x_mozilla_cycle_collect,1721 08:46:00 INFO - PROCESS | 20331 | __end_cc_report 08:46:00 INFO - PROCESS | 20331 | __startTimestamp1472571960231__endTimestamp 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | ------- Summary: start ------- 08:46:00 INFO - PROCESS | 20331 | Number of tests: 14 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#0] ai-astar Cycles:10 Average:114.50 Median:113.00 stddev:5.70 (5.0%) stddev-sans-first:6.02 08:46:00 INFO - PROCESS | 20331 | Values: 113.0 111.0 130.0 111.0 115.0 111.0 116.0 113.0 112.0 113.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.50 stddev:22.69 (15.2%) stddev-sans-first:23.82 08:46:00 INFO - PROCESS | 20331 | Values: 152.0 117.0 155.0 177.0 124.0 141.0 147.0 119.0 176.0 120.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 08:46:00 INFO - PROCESS | 20331 | Values: 163.0 161.0 161.0 160.0 161.0 163.0 161.0 161.0 160.0 162.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.85 (55.1%) stddev-sans-first:43.79 08:46:00 INFO - PROCESS | 20331 | Values: 76.0 76.0 76.0 175.0 76.0 77.0 74.0 76.0 175.0 75.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:81.50 stddev:33.14 (40.7%) stddev-sans-first:34.35 08:46:00 INFO - PROCESS | 20331 | Values: 82.0 82.0 158.0 82.0 81.0 82.0 150.0 81.0 81.0 141.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 08:46:00 INFO - PROCESS | 20331 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:46:00 INFO - PROCESS | 20331 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:46:00 INFO - PROCESS | 20331 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 08:46:00 INFO - PROCESS | 20331 | Values: 51.0 51.0 52.0 51.0 53.0 52.0 52.0 51.0 53.0 52.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:1.23 (2.0%) stddev-sans-first:1.22 08:46:00 INFO - PROCESS | 20331 | Values: 60.0 60.0 60.0 61.0 61.0 62.0 62.0 61.0 64.0 61.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:3.29 (4.0%) stddev-sans-first:3.40 08:46:00 INFO - PROCESS | 20331 | Values: 80.0 80.0 79.0 87.0 86.0 79.0 87.0 83.0 81.0 80.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:136.00 stddev:9.98 (7.3%) stddev-sans-first:10.58 08:46:00 INFO - PROCESS | 20331 | Values: 135.0 138.0 137.0 133.0 131.0 132.0 137.0 128.0 162.0 126.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:167.50 stddev:3.54 (2.1%) stddev-sans-first:3.73 08:46:00 INFO - PROCESS | 20331 | Values: 169.0 167.0 169.0 168.0 167.0 165.0 177.0 165.0 167.0 165.0 08:46:00 INFO - PROCESS | 20331 | 08:46:00 INFO - PROCESS | 20331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.50 stddev:2.16 (3.2%) stddev-sans-first:2.29 08:46:00 INFO - PROCESS | 20331 | Values: 67.0 71.0 68.0 68.0 68.0 66.0 66.0 64.0 64.0 65.0 08:46:00 INFO - PROCESS | 20331 | -------- Summary: end -------- 08:46:00 INFO - PROCESS | 20331 | 08:46:01 INFO - TEST-INFO | 20331: exit 0 08:46:01 INFO - TEST-OK | kraken | took 61547ms 08:46:01 INFO - SUITE-END | took 1177s 08:46:01 INFO - Completed test suite (00:19:38) 08:46:01 INFO - javascript benchmark 08:46:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.7745669074816, 3029.818210907346, 3031.3482601240735, 3066.325408410149, 3088.4903990841512, 5192.039472697554, 5194.610404219679, 5273.604479664031, 5284.788608455662, 5328.280682107914, 5257.7108259045735, 5313.309269794921, 5338.199270109486, 5353.223782551528, 5420.539254163391, 4716.127516409458, 4777.28340748887, 4791.784369703371, 4798.328234047236, 4971.080350135218, 4855.5559436895255, 4887.364642596457, 4924.532169443897, 4940.654154209206, 4961.107000739866, 4679.0, 4759.190937540592, 4796.856094317176, 4825.565699087064, 4869.70781753096, 4731.526847315241, 4753.453352864431, 4760.166970780099, 4807.038592281558, 4860.6111511079025, 4761.500042495522, 4773.140834649762, 4788.738023159391, 4790.688605240648, 4805.111054454937, 5084.923726144111, 5111.9776044790815, 5176.844694659128, 5177.068127737006, 5185.403678576974, 5498.697571633558, 5513.917291240635, 5524.309461317335, 5547.029269877755, 5548.0, 5403.918941215885, 5533.1976863354585, 5536.390996990328, 5538.390777014525, 5584.385717571064, 5224.294720212761, 5256.579473642138, 5257.342832145981, 5322.0952438085615, 5337.226102215157, 5769.624974376652, 5775.711214439261, 5780.6820624865195, 5788.27646544182, 5824.0, 5406.2701535292235, 5478.287822583039, 5480.534154596824, 5507.917381239285, 5532.917006244909, 5603.719814009283, 5668.631538949955, 5674.773009079673, 5711.743416448375, 5776.711164441761, 5683.2895888014, 5698.7435565399655, 5699.658020518699, 5701.173329867146, 5705.486506214377, 5455.481729235717, 5702.258706368146, 5706.885862282731, 5710.172025056427, 5718.571107166979, 4386.539413361615, 4423.049044455393, 4426.159029784395, 4428.424304840414, 4483.887902802456, 3884.2019186661128, 3909.198614284065, 3910.2570511602703, 3954.406838974177, 3957.920841583152, 5156.381234251914, 5376.542993845489, 5411.350637923474, 5434.402215756264, 5438.564914806806, 5667.433256674382, 5733.082706766897, 5740.598158128974, 5749.13762935563, 5818.5636077294375, 5392.838214853482, 5401.567874570025, 5402.189671549299, 5405.378381486101, 5407.513323800877, 4752.572268495852, 4928.457869634337, 4936.827211047596, 4940.802367905244, 4996.200607902718, 5783.334916484574, 5825.94174058254, 5829.387914269026, 5842.094475356326, 5910.231669882974, 5667.858303542444, 5672.60291779588, 5680.857978550569, 5680.971595142163, 5686.09022556389, 5660.801871934463, 5819.621724587888, 5829.8251052468495, 5835.79574714883, 5860.912086318624, 5467.425920278313, 5489.972550137224, 5549.889002219852, 5555.611107222456, 5558.44415558441, 5615.101583746581, 5646.520045795989, 5653.915191272216, 5661.773529058792, 5662.405447427961, 5501.504864562208, 5510.118381059011, 5511.779528818803, 5512.889742205213, 5513.338399392099, 5498.092814685692, 5498.395176530658, 5507.008738427122, 5509.421510741315, 5510.228568000563, 5517.337919449692, 5531.363893152178, 5539.307586551681, 5540.667559946416, 5543.057680194296, 5561.6384934980715, 5619.325680918316, 5621.325440947113, 5718.370979192202, 5724.713764311685, 5530.668159910419, 5534.916976245279, 5539.0, 5540.86147846291, 5546.029444847216], "value": 5218.211562215996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.4714997951781, 627.6140173793116, 632.1213513216629, 644.5649186798912, 648.7891435283534, 34229.0, 34960.42678079489, 35296.82351588245, 41788.791056044756, 42895.35656965148, 44259.11481770362, 44856.775716121454, 44895.326570101395, 44959.10081798362, 44979.77510112453, 8918.643254269839, 9055.637774489045, 9064.274858011377, 9075.546222688872, 9076.546172691338, 8858.822823543525, 8923.464592124461, 8943.060978597252, 8944.284457243437, 8949.105089491064, 9003.864942025875, 9013.0, 9037.774055648595, 9057.95471022644, 9068.183863452288, 8950.462972221687, 8982.281417486618, 9019.098090190993, 9021.233195178418, 9030.0, 8901.643934242622, 8952.597133129026, 8970.416922900056, 8971.102889711043, 8973.955130224373, 42161.57838421638, 42169.57830421687, 42268.36597451041, 42394.0, 42424.36363454551, 3591.1560783215923, 3596.5504311961004, 3622.963770362289, 3723.0878434783654, 3741.382671859167, 29327.853360733272, 29409.264768380748, 32312.676873231438, 32423.351532969446, 32953.0, 4372.825086996516, 4408.933865992013, 4466.12910482456, 4564.977175114136, 4568.269076947672, 358397.0, 359303.0, 360730.9999999974, 364203.0, 364790.0, 54551.72724136354, 62201.0, 63344.36655633384, 63396.68301658462, 63480.0, 63825.0, 64401.67799161068, 64613.35386646167, 69618.0, 70777.0, 17470.47588572345, 17823.376181833573, 17824.732629010574, 17840.55398615019, 17887.463376098738, 12612.11715179947, 12624.242545447303, 12624.81062784059, 12627.621171364874, 12627.810582841264, 17599.29602815873, 19486.512837179183, 19595.706064409045, 19911.701324480146, 20074.19703211855, 7310.634468276565, 7413.88879166813, 7426.702931882664, 7433.888491672629, 7515.699372025167, 932.6455946740195, 965.165132160676, 1025.661531694539, 1029.25893356783, 1120.9775804483866, 32334.676653233168, 32369.67630323714, 32655.510167347507, 32708.0, 33435.331293373994, 1054.5939813171983, 1098.0885864732413, 1158.467105131632, 1169.3101070368523, 1173.3370645585387, 16430.0, 17169.48491545256, 17171.141442927805, 17182.914085429493, 17425.0, 556301.0, 561499.0, 562035.0, 562289.0, 562527.0, 57526.50812615872, 58050.41949580535, 58086.12870806941, 58086.7095664519, 58094.7095264521, 1264.9051321150766, 1348.8583698711493, 1356.409961666678, 1357.606294174698, 1357.830271216098, 30318.84840575783, 30930.98948568336, 31977.0, 31985.520217196296, 32390.83804580962, 51799.2230116541, 51983.2202516955, 52000.0, 52076.0, 52078.218826716875, 435180.0, 435718.0, 436015.0, 436253.0, 436327.0, 35813.28373432569, 37784.0, 42317.576824232594, 44617.33074003828, 45126.09747805091, 41659.77961432531, 46895.531044690484, 47340.52659473361, 48194.518054819004, 48806.267905982146, 37676.2464750709, 40099.86080909055, 40211.39682904817, 42198.57801422069, 42568.14863702647, 39078.6092139075, 40412.59587404088, 40823.0, 40911.38632920449, 42814.78592607017, 40894.38658420066, 41289.1742165149, 42218.0, 42257.154856902074, 42374.0, 33588.328233435685, 37335.2262218373, 37622.43566346452, 37636.62363376441, 37992.810035949646, 28053.579196311664, 28496.857515713116, 28580.42839143164, 28635.856820715762, 28647.14058578246], "value": 20542.506397780886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.40441995017954, 382.3709997054845, 383.9808009599519, 388.68128134929367, 402.77444631006637, 16184.99999999997, 16185.028898266113, 17564.91217543912, 20316.69524957127, 20659.173633054677, 18516.44450666479, 19680.85106382979, 19682.311119110833, 19701.31045413411, 19741.0, 5604.99110160171, 5653.1237658162945, 5722.313322401297, 5893.20441740366, 5896.911546326808, 5634.352049514297, 5677.290338707661, 5694.886102277952, 5708.543316534688, 5728.427157284259, 4088.1414902870433, 6044.304904935944, 6302.054691796245, 6307.621542707429, 6398.616083035009, 6333.176687030703, 6394.904076438857, 6403.8399040023905, 6404.615723056609, 6443.871122577522, 5557.888842223133, 5686.630369026, 5691.089425691911, 5692.800751973661, 5693.28833895763, 22544.66183007256, 23042.423939401648, 23195.304140875633, 23287.18494852672, 23615.409614759596, 2336.1122773346187, 2388.964165537501, 2389.880505974694, 2424.248482970285, 2998.610180676498, 13631.250281234528, 14311.284435778274, 14379.35292911811, 14767.502298988411, 14893.627659308495, 1832.404468547714, 1859.2934684819681, 1884.0862181841796, 1890.8392786613153, 1933.6271247414352, 53322.73338633321, 75225.0, 76195.23804761992, 79814.0, 83106.58446707728, 10510.789784204273, 10675.25273230882, 10754.354738715701, 10799.298045627009, 10869.293495922899, 14640.707185856223, 14724.852751472348, 14791.630209244855, 14857.0, 14860.851391485947, 7962.880556791652, 8141.5982285226, 8309.335253179732, 8404.663813447516, 8441.113683063313, 7908.130105688369, 7929.484583502054, 7959.0, 8192.18078192188, 8197.918020819834, 6288.245410550763, 6446.355364463516, 6513.706883190268, 6521.934780652133, 6598.571092879043, 1830.0758117150754, 1840.8987505687317, 1874.175362840346, 1890.5084677983548, 1901.087478010535, 964.2816102004052, 976.1312431935582, 976.7069879036261, 1002.5037606384886, 1004.1264100232844, 20116.497087572927, 20237.696434553494, 20378.49053773638, 20433.0, 20462.488437788877, 970.2432102959702, 989.1098011789303, 1004.5328922051282, 1044.4412239452008, 1088.3905013192636, 10773.62292319765, 11168.0, 11403.771924561463, 11537.711557211136, 11564.537418503334, 455149.0, 459062.0, 461334.0, 474741.0, 477008.0, 91762.0, 97368.0, 97835.51082244543, 98185.50907245418, 98504.50747746216, 979.0943377375899, 984.8079624473302, 1026.2662196529518, 1026.697124348319, 1047.3297089862494, 17247.827521725125, 17497.737533936746, 17983.910080449514, 18122.45632631023, 18306.0, 40646.0, 40877.59122408857, 41524.37713434362, 41999.370009449274, 43046.0, 54753.45246547643, 57283.42716572781, 57886.0, 59464.0, 60363.39636603578, 8369.49783013021, 8496.0, 8719.476831390137, 8783.959378685877, 8823.911760882309, 9696.9030309696, 12087.214331068453, 12951.805722913976, 13200.537981170613, 13840.86159138436, 11712.88287117118, 11769.234999724991, 12141.15011949155, 12248.387580620754, 12283.263004219418, 11562.76874462523, 11645.184837061324, 11656.683441145356, 11702.648920532398, 11882.76234475323, 11797.29216247028, 11959.103067270164, 12107.757844842878, 12367.134300598871, 12487.687807804878, 8342.416030877781, 8645.610947507252, 8783.0, 8834.204921557091, 8946.329025322997, 10270.818855831674, 11829.526818927146, 11907.642770716893, 12191.878081219074, 12267.386630668252], "value": 9421.17281421537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.2942070123543, 1466.8533146685334, 1510.3580978084312, 1629.5844559637292, 1802.9008404537753, 8402.747917562476, 8792.69225577105, 8810.427322224059, 9012.95493522533, 9021.684241051564, 8880.555972201397, 8988.191062804346, 9000.099990000997, 9002.594883230255, 9014.774630634238, 2131.179495894084, 2381.285614315703, 2384.6899903012586, 2407.843490173133, 2409.3374322061486, 2450.387403149213, 2477.331120597438, 2482.2801387597665, 2484.763947424992, 2484.950300993979, 2407.434252950555, 2431.294924471901, 2476.4799392127675, 2476.863772492512, 2476.938076548092, 2357.4224315042925, 2382.106709983756, 2388.3909603051197, 2413.7706917842775, 2436.0377650828, 2414.9275521734376, 2440.1581454398206, 2448.2165706973774, 2451.705795304575, 2452.558539462896, 9260.166585007315, 9298.860517092182, 9300.162985331353, 9303.906960930371, 9333.486658233795, 5299.2845965794895, 5506.421825708283, 5529.170624406331, 5530.170474428827, 5535.6955367454775, 3388.6441923597913, 3498.5626796650417, 3555.4311310190506, 3556.8577256909953, 3598.118460977051, 1136.4885801389407, 1171.7187874910046, 1176.4000359816555, 1198.3828328410875, 1204.2292932523192, 12496.125271231018, 12631.305278209788, 12641.051921105862, 12682.112252142353, 12686.0, 4287.678424118204, 4576.588107070313, 4595.747233902101, 4774.928376074362, 4782.52174782519, 9979.0, 9987.400755954666, 9988.950055249677, 9992.600295988079, 10000.549975251131, 5287.339082614673, 5306.495882891119, 5312.5484333832055, 5313.867153321198, 5316.883454474603, 4314.546972567898, 4750.8337208197545, 4849.854504364875, 4885.658003939761, 4955.529224723646, 3820.369639009588, 3869.8258578364043, 3963.385675220288, 4000.6199411055904, 4007.939880901789, 1178.9056875449944, 1190.6190019193948, 1200.4837919694442, 1206.324458303353, 1214.4959841665786, 914.401067300919, 984.2372161574693, 1001.5593139018808, 1006.9043440873105, 1010.166612544639, 6082.665453400105, 6238.781642642486, 6267.2479302484, 6284.528660350492, 6409.0, 972.3436680240809, 989.3082828363436, 1006.5470538257813, 1012.1295685710284, 1037.901399367074, 4106.815193316308, 4236.2374772540625, 4271.487421509439, 4300.80646370914, 4336.262835317941, 11014.284071535325, 11415.0, 11438.370889601152, 11440.313581185155, 11466.656000320003, 11283.830742538868, 11298.887011129947, 11299.0, 11299.717507062225, 11314.943425282821, 7806.336461400844, 8131.512109273344, 8142.389320800845, 8202.015758109064, 8336.291415229653, 6297.244330680164, 6375.489960803217, 6505.31694172124, 6524.869502609827, 6577.901331479936, 10445.373277603368, 10506.684799456028, 10600.0, 10722.356658600509, 10722.410267435365, 10499.68500944973, 10726.302790318916, 10876.0, 10877.51051202682, 10896.182786291218, 7836.882446763189, 7975.80060498469, 8067.959660201662, 8143.389245806707, 8291.543965081979, 9041.728748137566, 9046.185843274137, 9107.726768196964, 9111.088891110836, 9132.863007054766, 8012.0, 8028.558429286211, 8059.637316320897, 8132.67469301245, 8180.550069746221, 7688.961555192188, 7709.807254818675, 7730.0, 7876.921230787619, 7982.241687039722, 6964.616946068015, 7096.680649370687, 7146.3568278855155, 7166.140063192451, 7214.422846172189, 5217.713025783467, 5220.660657057279, 5242.213667949685, 5319.973400132974, 5489.698066606375, 5364.329458817648, 5384.326959130109, 5422.132458806572, 5468.316460442445, 5579.2746942897165], "value": 4778.948802332733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.80853870600225, 315.689046289405, 320.90854106579616, 335.2741315052912, 336.7205219667676, 5162.38051433828, 5169.663971841837, 5170.276161337406, 5173.508516690913, 5229.8169564065265, 5105.846824595268, 5141.768620412081, 5141.794328226866, 5151.227315902616, 5157.819476318329, 3862.2661694278136, 3986.342253528179, 3999.860004899829, 4005.619466150711, 4010.2981978153853, 3584.390653588896, 4076.1847630473876, 4093.713440059197, 4113.1568028554075, 4119.537564164723, 4054.513458384998, 4063.9796801015955, 4076.1440097579543, 4092.85675001375, 4108.897277568055, 3908.4009133925906, 4065.918681626351, 4079.714419990602, 4103.4460347852955, 4111.280525907969, 3486.1110416843794, 3610.0, 3614.409659749702, 3618.7466877318598, 3634.83643236055, 5001.3998320201445, 5008.84973450797, 5011.098002359574, 5033.798648054073, 5059.773699572213, 4683.0, 4705.764711764432, 4717.103750287434, 4729.408823897013, 4733.976330118362, 5105.897882042338, 5334.879675268198, 5360.624756267063, 5369.275147855029, 5370.113931201387, 3876.8836934891997, 3913.334733095352, 3937.1535119949062, 3943.211357728466, 3954.406838974177, 5326.813561525328, 5374.677519348813, 5614.9157762633595, 5637.577181711388, 5643.830685079454, 3928.823202955874, 3966.781826999543, 3971.1660551283976, 3973.264945984944, 3977.5879562755385, 4025.456563363967, 4035.3543433050572, 4038.4749982502676, 4051.3517837145914, 4053.5946405359227, 4495.955040449554, 4613.677042606985, 4621.630269578425, 4637.188492013884, 4649.488556258809, 5365.302510673666, 5365.517103460707, 5375.139977603565, 5385.5960802939935, 5401.3518377794135, 1371.5885234429632, 1390.1381143690976, 1392.9024968252124, 1394.874461298488, 1398.9860101399058, 860.9913900860911, 901.3600343756007, 906.7823722306599, 907.5371560504191, 918.1277786103095, 4574.6340292776495, 4615.746133962664, 4619.3994780678295, 4620.630349572026, 4626.791794369262, 4797.232442809134, 4855.393075865517, 4869.634777391639, 4874.293227481995, 4906.239532872411, 4356.3683265926265, 4626.583607475276, 4640.47094333589, 4650.720956742606, 4674.293882732778, 2552.9361765956, 2565.5125526149973, 2566.242958327298, 2577.6004719268544, 2597.6881674754127, 4960.627952903546, 4986.551210391082, 5003.949960500421, 5027.673201241908, 5030.195168772979, 4634.37435946143, 4766.4280286365165, 4919.77860996256, 4932.42162507994, 4948.628852836052, 4921.3356196912955, 4947.282644016525, 4964.950350496521, 4965.255211718271, 4972.154733695208, 4819.180739274261, 4825.6139508839915, 4879.829205977774, 4934.333864928189, 4964.429090654477, 4592.770361481846, 4685.320628508915, 4766.713997160182, 4783.986088764195, 4827.300041493893, 4977.402711674622, 4983.775730092082, 5430.995265875826, 5466.34403871538, 5643.435656434323, 3965.2862484753023, 3976.4035394691027, 3987.920241595094, 3999.3001224784966, 4035.1324465240114, 5597.720113994365, 5603.859903502445, 5606.6636001840025, 5618.803341883178, 5635.6618602883955, 5137.2037334213255, 5347.075052980846, 5348.919766203588, 5366.409694933633, 5471.781128754806, 5292.259083728358, 5293.311869456946, 5299.311089558333, 5353.544948679406, 5359.785608575613, 5358.008768377863, 5374.704391258519, 5378.435264297193, 5388.353397592157, 5396.163594642837, 5137.460566640599, 5380.574147850744, 5474.178873169057, 5478.0, 5478.753456094406, 5327.840164795062, 5336.653117547347, 5346.278252435872, 5355.30381050461, 5403.972980135074], "value": 3987.529776494477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.6007326007325, 767.7696690992701, 802.5412155877057, 824.6948629007268, 831.2477208126647, 15276.312565934531, 16328.673426531463, 16366.181690915466, 16377.13400154974, 16391.426300079514, 14374.856251437508, 14746.115233085995, 15080.0, 15635.06189628623, 15664.686706265868, 802.7551596763, 818.7707441916273, 819.5533434278333, 819.635262308273, 819.6680344460503, 665.933406659335, 793.3256731778, 820.5692011693878, 821.4742564758529, 826.9917300827005, 852.8550146475114, 860.4020205956863, 860.9225169734723, 861.2464093917822, 863.6286396849353, 859.0979471554842, 859.2953777902122, 860.3375400941271, 860.4536119564091, 860.7848037990502, 503.3657591434782, 605.6124080588427, 618.9845253868644, 622.2315440431064, 624.2945471617089, 15487.5353739388, 15488.99321544096, 15608.609784755472, 15621.843781562153, 15669.921650391789, 14536.491222807257, 14843.183624900626, 15013.099214047083, 15169.848301516953, 15445.922770386076, 13413.195208287436, 13458.183145275361, 13485.393157307944, 13741.725165496635, 13793.0, 4496.213162696515, 4571.085782843445, 4590.586847183769, 4626.144163329761, 4792.616590672737, 86586.56706716426, 87041.0, 87307.12692873053, 87755.55965259354, 88360.55819720861, 11799.410029498491, 11839.11206659504, 11859.525618975144, 11913.22564033335, 11998.0, 22348.664770028463, 22604.095836166696, 22651.546969060855, 22666.546669066527, 22713.659295110585, 8261.17388261181, 8332.875006874901, 8449.408541402043, 8650.221480066824, 8916.331275154389, 4633.235516139866, 4661.603763680057, 4697.580844969859, 4734.692245004133, 4822.348982887265, 3638.7816730996224, 3900.570937196906, 3904.511936007999, 3948.368261078214, 3950.1309711863346, 654.312971380049, 654.780648482754, 660.3297652882328, 665.3246954341347, 666.2171947961126, 665.7736369634348, 727.9454040946845, 762.1121393576421, 768.2356055724479, 768.6579472134958, 9340.20608248293, 9803.754906127404, 9940.155086817556, 10182.745431364276, 10361.533730982124, 677.9355961183778, 739.6264886232526, 752.3003606645763, 757.814335487809, 767.0, 4488.438945131858, 4942.736588306246, 5013.774380152902, 5053.140966035783, 5073.137566613685, 128104.0, 130083.34958325147, 131024.34487827691, 131226.0, 135674.0, 107551.46224268829, 112039.4398028021, 112876.0, 112932.43533782278, 115940.0, 93841.0, 96209.0, 98390.50804746074, 98935.0, 100614.49692751489, 9344.299177561574, 9528.618855245713, 9644.132028117503, 9690.515474226402, 9755.56099975517, 56777.71611141918, 57148.428515715976, 57353.0, 57841.13238301513, 58615.12077318929, 77817.61091194508, 83135.0, 83185.0, 86604.1339586596, 86952.0, 13174.60476185716, 13268.734625307246, 13389.263590502227, 13675.79486307726, 13763.31183440844, 13788.157960261104, 14593.562193134223, 14697.485588004369, 14881.0, 15164.469243576423, 12528.436220369922, 12849.0, 12915.741685166056, 13310.600681979557, 13709.0, 13050.355788064213, 13182.60452186436, 13250.46998120103, 13768.311584420539, 14135.929320353333, 13840.0, 14443.638909027359, 14535.709285814435, 14559.92720036393, 14691.0, 11350.842876980263, 11678.941605291919, 11771.587994420153, 11955.0, 12048.397580120783, 10882.250261832454, 10951.014408703255, 11033.37297978021, 12311.322877241837, 12512.874871251171], "value": 7925.430323035859, "unit": "score"}], "name": "dromaeo_css", "value": 7309.673325802152, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 130.0, 111.0, 115.0, 111.0, 116.0, 113.0, 112.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 155.0, 177.0, 124.0, 141.0, 147.0, 119.0, 176.0, 120.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 161.0, 163.0, 161.0, 161.0, 160.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 175.0, 76.0, 77.0, 74.0, 76.0, 175.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 158.0, 82.0, 81.0, 82.0, 150.0, 81.0, 81.0, 141.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 53.0, 52.0, 52.0, 51.0, 53.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 62.0, 62.0, 61.0, 64.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 87.0, 86.0, 79.0, 87.0, 83.0, 81.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 137.0, 133.0, 131.0, 132.0, 137.0, 128.0, 162.0, 126.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 169.0, 168.0, 167.0, 165.0, 177.0, 165.0, 167.0, 165.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 68.0, 68.0, 66.0, 66.0, 64.0, 64.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1539.3000000000004, "alertThreshold": 2.0}]} 08:46:01 INFO - Return code: 0 08:46:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:46:02 INFO - # TBPL SUCCESS # 08:46:02 INFO - Running post-action listener: _resource_record_post_action 08:46:02 INFO - [mozharness: 2016-08-30 15:46:02.027417Z] Finished run-tests step (success) 08:46:02 INFO - Running post-run listener: _resource_record_post_run 08:46:02 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418406400; Read time: 12; Write time: 303524 08:46:02 INFO - TinderboxPrint: CPU usage
13.1% 08:46:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:46:02 INFO - TinderboxPrint: I/O write bytes / time
418,406,400 / 303,524 08:46:02 INFO - TinderboxPrint: CPU idle
8,281.3 (86.9%) 08:46:02 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 08:46:02 INFO - TinderboxPrint: Swap in / out
0 / 0 08:46:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128839680; Read time: 0; Write time: 92452 08:46:02 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288444416; Read time: 0; Write time: 211040 08:46:02 INFO - Running post-run listener: _upload_blobber_files 08:46:02 INFO - Blob upload gear active. 08:46:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:46:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:46:02 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'] 08:46:02 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 08:46:03 INFO - (blobuploader) - INFO - Open directory for files ... 08:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:03 INFO - (blobuploader) - INFO - Done attempting. 08:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:07 INFO - (blobuploader) - INFO - Done attempting. 08:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:46:09 INFO - (blobuploader) - INFO - Done attempting. 08:46:09 INFO - (blobuploader) - INFO - Iteration through files over. 08:46:09 INFO - Return code: 0 08:46:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:46:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:46:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/731e711140992f88bb133c925330ad4508ce9216daf62958e1c8af43ca0d97d184cb915fd129df0f5cff794d037a88ff84bcbc2d901528e7400e0ca39152ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/068cb27a176f1cbee3290b92f605afc5e2fa04e9d3dd2d8ceb062ab9f00065d6c81ff499e08599af0323faaa90fb9c37e9e77a34647a29bf073472fe3feb57d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8e45b2da9b3bec67bf3aa5c4e6b3b05fefdf7a24c95394c455de8fc137d07bf15eb741bf0ded4d10ffb5904bfd5aabf6ac214c0856a66f52c578b5b58f6875f"} 08:46:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:46:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:46:09 INFO - Contents: 08:46:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/731e711140992f88bb133c925330ad4508ce9216daf62958e1c8af43ca0d97d184cb915fd129df0f5cff794d037a88ff84bcbc2d901528e7400e0ca39152ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/068cb27a176f1cbee3290b92f605afc5e2fa04e9d3dd2d8ceb062ab9f00065d6c81ff499e08599af0323faaa90fb9c37e9e77a34647a29bf073472fe3feb57d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8e45b2da9b3bec67bf3aa5c4e6b3b05fefdf7a24c95394c455de8fc137d07bf15eb741bf0ded4d10ffb5904bfd5aabf6ac214c0856a66f52c578b5b58f6875f"} 08:46:09 INFO - Running post-run listener: copy_logs_to_upload_dir 08:46:09 INFO - Copying logs to upload dir... 08:46:09 INFO - mkdir: /builds/slave/test/build/upload/logs 08:46:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.380091 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-30 08:46:08.707553) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:08.711155) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182 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/731e711140992f88bb133c925330ad4508ce9216daf62958e1c8af43ca0d97d184cb915fd129df0f5cff794d037a88ff84bcbc2d901528e7400e0ca39152ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/068cb27a176f1cbee3290b92f605afc5e2fa04e9d3dd2d8ceb062ab9f00065d6c81ff499e08599af0323faaa90fb9c37e9e77a34647a29bf073472fe3feb57d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8e45b2da9b3bec67bf3aa5c4e6b3b05fefdf7a24c95394c455de8fc137d07bf15eb741bf0ded4d10ffb5904bfd5aabf6ac214c0856a66f52c578b5b58f6875f"} build_url:https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/XQZXGTJmSSGjc85gWqo68Q/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/731e711140992f88bb133c925330ad4508ce9216daf62958e1c8af43ca0d97d184cb915fd129df0f5cff794d037a88ff84bcbc2d901528e7400e0ca39152ad3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/068cb27a176f1cbee3290b92f605afc5e2fa04e9d3dd2d8ceb062ab9f00065d6c81ff499e08599af0323faaa90fb9c37e9e77a34647a29bf073472fe3feb57d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8e45b2da9b3bec67bf3aa5c4e6b3b05fefdf7a24c95394c455de8fc137d07bf15eb741bf0ded4d10ffb5904bfd5aabf6ac214c0856a66f52c578b5b58f6875f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:08.736577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:08.736925) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1472569556.972337-2004024182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:08.822427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 08:46:08.822749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 08:46:08.823036) ========= ========= Total master_lag: 0.17 =========