builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1470405896.91 results: success (0) buildid: 20160805053003 builduid: b912b5eb103b48ca98fb4e37afe31fa2 revision: 2c234f5a191673f6a4b0490435851e61852a54e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:56.914458) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:56.914896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:56.915180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:56.972842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:56.973220) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 07:04:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-08-05 07:04:57 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.210080 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.218479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.218856) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021757 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.274226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.274562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c234f5a191673f6a4b0490435851e61852a54e8 --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 2c234f5a191673f6a4b0490435851e61852a54e8 --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=934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 07:04:57,357 truncating revision to first 12 chars 2016-08-05 07:04:57,357 Setting DEBUG logging. 2016-08-05 07:04:57,357 attempt 1/10 2016-08-05 07:04:57,357 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c234f5a1916?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 07:04:57,664 unpacking tar archive at: fx-team-2c234f5a1916/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.952144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.952552) ========= script_repo_revision: 2c234f5a191673f6a4b0490435851e61852a54e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.952991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.953282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 07:04:57.964127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-05 07:04:57.964606) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:04:58 INFO - MultiFileLogger online at 20160805 07:04:58 in /builds/slave/test 07:04:58 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 07:04:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:04:58 INFO - {'append_to_log': False, 07:04:58 INFO - 'base_work_dir': '/builds/slave/test', 07:04:58 INFO - 'blob_upload_branch': 'Fx-Team', 07:04:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:04:58 INFO - 'branch': 'Fx-Team', 07:04:58 INFO - 'buildbot_json_path': 'buildprops.json', 07:04:58 INFO - 'config_files': ('talos/linux_config.py',), 07:04:58 INFO - 'default_actions': ('clobber', 07:04:58 INFO - 'read-buildbot-config', 07:04:58 INFO - 'download-and-extract', 07:04:58 INFO - 'populate-webroot', 07:04:58 INFO - 'create-virtualenv', 07:04:58 INFO - 'install', 07:04:58 INFO - 'run-tests'), 07:04:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:04:58 INFO - 'download_minidump_stackwalk': True, 07:04:58 INFO - 'download_symbols': 'ondemand', 07:04:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:04:58 INFO - 'tooltool.py': '/tools/tooltool.py', 07:04:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:04:58 INFO - '/tools/misc-python/virtualenv.py')}, 07:04:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:04:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:04:58 INFO - 'installer_path': 'installer.exe', 07:04:58 INFO - 'log_level': 'info', 07:04:58 INFO - 'log_name': 'talos', 07:04:58 INFO - 'log_to_console': True, 07:04:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:04:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:04:58 INFO - 'opt_config_files': (), 07:04:58 INFO - 'pip_index': False, 07:04:58 INFO - 'sps_profile': False, 07:04:58 INFO - 'sps_profile_interval': 0, 07:04:58 INFO - 'suite': 'dromaeojs', 07:04:58 INFO - 'system_bits': '32', 07:04:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:04:58 INFO - 'title': 'talos-linux64-ix-057', 07:04:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:04:58 INFO - 'use_talos_json': True, 07:04:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:04:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:04:58 INFO - 'work_dir': 'build'} 07:04:58 INFO - [mozharness: 2016-08-05 14:04:58.234649Z] Running clobber step. 07:04:58 INFO - Running pre-action listener: _resource_record_pre_action 07:04:58 INFO - Running main action method: clobber 07:04:58 INFO - rmtree: /builds/slave/test/build 07:04:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:04:58 INFO - Running post-action listener: _resource_record_post_action 07:04:58 INFO - [mozharness: 2016-08-05 14:04:58.949414Z] Finished clobber step (success) 07:04:58 INFO - [mozharness: 2016-08-05 14:04:58.949514Z] Running read-buildbot-config step. 07:04:58 INFO - Running pre-action listener: _resource_record_pre_action 07:04:58 INFO - Running main action method: read_buildbot_config 07:04:58 INFO - Using buildbot properties: 07:04:58 INFO - { 07:04:58 INFO - "project": "", 07:04:58 INFO - "product": "firefox", 07:04:58 INFO - "script_repo_revision": "production", 07:04:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:04:58 INFO - "repository": "", 07:04:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:04:58 INFO - "buildid": "20160805053003", 07:04:58 INFO - "pgo_build": "True", 07:04:58 INFO - "basedir": "/builds/slave/test", 07:04:58 INFO - "buildnumber": 1424, 07:04:58 INFO - "slavename": "talos-linux64-ix-057", 07:04:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:04:58 INFO - "platform": "ubuntu64_hw", 07:04:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:04:58 INFO - "branch": "fx-team", 07:04:58 INFO - "repo_path": "integration/fx-team", 07:04:58 INFO - "revision": "2c234f5a191673f6a4b0490435851e61852a54e8", 07:04:58 INFO - "stage_platform": "linux64-pgo", 07:04:58 INFO - "builduid": "b912b5eb103b48ca98fb4e37afe31fa2", 07:04:58 INFO - "slavebuilddir": "test" 07:04:58 INFO - } 07:04:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:04:58 INFO - Running post-action listener: _resource_record_post_action 07:04:58 INFO - [mozharness: 2016-08-05 14:04:58.951919Z] Finished read-buildbot-config step (success) 07:04:58 INFO - [mozharness: 2016-08-05 14:04:58.952006Z] Running download-and-extract step. 07:04:58 INFO - Running pre-action listener: _resource_record_pre_action 07:04:58 INFO - Running main action method: download_and_extract 07:04:58 INFO - mkdir: /builds/slave/test/build/tests 07:04: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')]} 07:04:58 INFO - trying https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:04:58 INFO - Downloading https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:04:59 INFO - Downloaded 1361 bytes. 07:04:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:04:59 INFO - Using the following test package requirements: 07:04:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:04:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:04:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:04:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'jsshell-linux-x86_64.zip'], 07:04:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:04:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:04:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:04:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:04:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:04:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:04:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:59 INFO - trying https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:05:01 INFO - Downloaded 21825798 bytes. 07:05:01 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 07:05:05 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 07:05: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')]} 07:05:05 INFO - trying https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:05:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:05:07 INFO - Downloaded 21825798 bytes. 07:05:07 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 07:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:12 INFO - trying https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:12 INFO - Downloading https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:05:13 INFO - Downloaded 14413723 bytes. 07:05:13 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 07:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:13 INFO - trying https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:05:13 INFO - Downloading https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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 07:05:15 INFO - Downloaded 59381363 bytes. 07:05:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:05:15 INFO - mkdir: /builds/slave/test/properties 07:05:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:05:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:05:15 INFO - Contents: 07:05:15 INFO - build_url:https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:05:16 INFO - Running post-action listener: _resource_record_post_action 07:05:16 INFO - Running post-action listener: set_extra_try_arguments 07:05:16 INFO - [mozharness: 2016-08-05 14:05:16.241534Z] Finished download-and-extract step (success) 07:05:16 INFO - [mozharness: 2016-08-05 14:05:16.241765Z] Running populate-webroot step. 07:05:16 INFO - Running pre-action listener: _resource_record_pre_action 07:05:16 INFO - Running main action method: populate_webroot 07:05:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:16 INFO - '--tppagecycles', 07:05:16 INFO - '7'], 07:05:16 INFO - 'tests': ['tsvgm']}}, 07:05:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:05:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:05:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['damp', 'tps']}, 07:05:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'tests': ['damp', 'tps']}, 07:05:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['dromaeo_dom']}, 07:05:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['basic_compositor_video']}, 07:05:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:05:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['a11yr', 07:05:16 INFO - 'ts_paint', 07:05:16 INFO - 'tpaint', 07:05:16 INFO - 'sessionrestore', 07:05:16 INFO - 'sessionrestore_no_auto_restore', 07:05:16 INFO - 'tabpaint']}, 07:05:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:05:16 INFO - 'ts_paint', 07:05:16 INFO - 'tpaint', 07:05:16 INFO - 'sessionrestore', 07:05:16 INFO - 'sessionrestore_no_auto_restore', 07:05:16 INFO - 'tabpaint']}, 07:05:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:05:16 INFO - 'ts_paint', 07:05:16 INFO - 'tpaint', 07:05:16 INFO - 'sessionrestore', 07:05:16 INFO - 'sessionrestore_no_auto_restore', 07:05:16 INFO - 'tabpaint']}, 07:05:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:05:16 INFO - 'ts_paint', 07:05:16 INFO - 'tpaint', 07:05:16 INFO - 'sessionrestore', 07:05:16 INFO - 'sessionrestore_no_auto_restore', 07:05:16 INFO - 'tabpaint']}, 07:05:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['a11yr', 07:05:16 INFO - 'ts_paint', 07:05:16 INFO - 'tpaint', 07:05:16 INFO - 'sessionrestore', 07:05:16 INFO - 'sessionrestore_no_auto_restore', 07:05:16 INFO - 'tabpaint']}, 07:05:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['a11yr', 07:05:16 INFO - 'ts_paint', 07:05:16 INFO - 'tpaint', 07:05:16 INFO - 'sessionrestore', 07:05:16 INFO - 'sessionrestore_no_auto_restore', 07:05:16 INFO - 'tabpaint']}, 07:05:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['tsvgx', 07:05:16 INFO - 'tsvgr_opacity', 07:05:16 INFO - 'tart', 07:05:16 INFO - 'tscrollx', 07:05:16 INFO - 'cart']}, 07:05:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:05:16 INFO - 'tsvgr_opacity', 07:05:16 INFO - 'tart', 07:05:16 INFO - 'tscrollx', 07:05:16 INFO - 'cart']}, 07:05:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'talos_options': ['--disable-e10s'], 07:05:16 INFO - 'tests': ['tp5o']}, 07:05:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'tests': ['tp5o']}, 07:05:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'talos_options': ['--disable-e10s', 07:05:16 INFO - '--xperf_path', 07:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:16 INFO - 'tests': ['tp5n']}, 07:05:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:16 INFO - 'talos_options': ['--xperf_path', 07:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:16 INFO - 'tests': ['tp5n']}}, 07:05:16 INFO - 'talos.zip': {'path': '', 07:05:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:16 INFO - Running post-action listener: _resource_record_post_action 07:05:16 INFO - [mozharness: 2016-08-05 14:05:16.257322Z] Finished populate-webroot step (success) 07:05:16 INFO - [mozharness: 2016-08-05 14:05:16.257412Z] Running create-virtualenv step. 07:05:16 INFO - Running pre-action listener: _resource_record_pre_action 07:05:16 INFO - Running main action method: create_virtualenv 07:05:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:05:16 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 07:05:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:05:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:16 INFO - Using real prefix '/usr' 07:05:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:05:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:18 INFO - Installing pip.................done. 07:05:18 INFO - Return code: 0 07:05:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:05:18 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')]} 07:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:18 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')]} 07:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:18 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:18 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 07:05:18 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 07:05:18 INFO - Using env: {'DISPLAY': ':0', 07:05:18 INFO - 'HOME': '/home/cltbld', 07:05:18 INFO - 'LANG': 'en_US.UTF-8', 07:05:18 INFO - 'LANGUAGE': 'en_US:en', 07:05:18 INFO - 'LOGNAME': 'cltbld', 07:05:18 INFO - 'MAIL': '/var/mail/cltbld', 07:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:18 INFO - 'MOZ_NO_REMOTE': '1', 07:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:18 INFO - 'NO_EM_RESTART': '1', 07:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:18 INFO - 'PWD': '/builds/slave/test', 07:05:18 INFO - 'SHELL': '/bin/bash', 07:05:18 INFO - 'SHLVL': '1', 07:05:18 INFO - 'TERM': 'linux', 07:05:18 INFO - 'TMOUT': '86400', 07:05:18 INFO - 'USER': 'cltbld', 07:05:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:18 INFO - '_': '/tools/buildbot/bin/python'} 07:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:19 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 07:05:19 INFO - Cleaning up... 07:05:19 INFO - Return code: 0 07:05:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:19 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:19 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 07:05:19 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 07:05:19 INFO - Using env: {'DISPLAY': ':0', 07:05:19 INFO - 'HOME': '/home/cltbld', 07:05:19 INFO - 'LANG': 'en_US.UTF-8', 07:05:19 INFO - 'LANGUAGE': 'en_US:en', 07:05:19 INFO - 'LOGNAME': 'cltbld', 07:05:19 INFO - 'MAIL': '/var/mail/cltbld', 07:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:19 INFO - 'MOZ_NO_REMOTE': '1', 07:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:19 INFO - 'NO_EM_RESTART': '1', 07:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:19 INFO - 'PWD': '/builds/slave/test', 07:05:19 INFO - 'SHELL': '/bin/bash', 07:05:19 INFO - 'SHLVL': '1', 07:05:19 INFO - 'TERM': 'linux', 07:05:19 INFO - 'TMOUT': '86400', 07:05:19 INFO - 'USER': 'cltbld', 07:05:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:19 INFO - '_': '/tools/buildbot/bin/python'} 07:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:19 INFO - Downloading/unpacking psutil>=3.1.1 07:05:19 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 07:05:19 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 07:05:19 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 07:05:19 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 07:05:19 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 07:05:19 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 07:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:21 INFO - Installing collected packages: psutil 07:05:21 INFO - Running setup.py install for psutil 07:05:21 INFO - building 'psutil._psutil_linux' extension 07:05:21 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 07:05:22 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 07:05:22 INFO - building 'psutil._psutil_posix' extension 07:05:22 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 07:05:23 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 07:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:23 INFO - Successfully installed psutil 07:05:23 INFO - Cleaning up... 07:05:23 INFO - Return code: 0 07:05:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:23 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:23 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 07:05:23 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 07:05:23 INFO - Using env: {'DISPLAY': ':0', 07:05:23 INFO - 'HOME': '/home/cltbld', 07:05:23 INFO - 'LANG': 'en_US.UTF-8', 07:05:23 INFO - 'LANGUAGE': 'en_US:en', 07:05:23 INFO - 'LOGNAME': 'cltbld', 07:05:23 INFO - 'MAIL': '/var/mail/cltbld', 07:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:23 INFO - 'MOZ_NO_REMOTE': '1', 07:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:23 INFO - 'NO_EM_RESTART': '1', 07:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:23 INFO - 'PWD': '/builds/slave/test', 07:05:23 INFO - 'SHELL': '/bin/bash', 07:05:23 INFO - 'SHLVL': '1', 07:05:23 INFO - 'TERM': 'linux', 07:05:23 INFO - 'TMOUT': '86400', 07:05:23 INFO - 'USER': 'cltbld', 07:05:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:23 INFO - '_': '/tools/buildbot/bin/python'} 07:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:05:23 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 07:05:23 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 07:05:23 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 07:05:23 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 07:05:23 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 07:05:23 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 07:05:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:05:25 INFO - Installing collected packages: mozsystemmonitor 07:05:25 INFO - Running setup.py install for mozsystemmonitor 07:05:25 INFO - Successfully installed mozsystemmonitor 07:05:25 INFO - Cleaning up... 07:05:25 INFO - Return code: 0 07:05:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:05:25 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')]} 07:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:25 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')]} 07:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:25 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:25 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 07:05:25 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 07:05:25 INFO - Using env: {'DISPLAY': ':0', 07:05:25 INFO - 'HOME': '/home/cltbld', 07:05:25 INFO - 'LANG': 'en_US.UTF-8', 07:05:25 INFO - 'LANGUAGE': 'en_US:en', 07:05:25 INFO - 'LOGNAME': 'cltbld', 07:05:25 INFO - 'MAIL': '/var/mail/cltbld', 07:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:25 INFO - 'MOZ_NO_REMOTE': '1', 07:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:25 INFO - 'NO_EM_RESTART': '1', 07:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:25 INFO - 'PWD': '/builds/slave/test', 07:05:25 INFO - 'SHELL': '/bin/bash', 07:05:25 INFO - 'SHLVL': '1', 07:05:25 INFO - 'TERM': 'linux', 07:05:25 INFO - 'TMOUT': '86400', 07:05:25 INFO - 'USER': 'cltbld', 07:05:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:25 INFO - '_': '/tools/buildbot/bin/python'} 07:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:05:25 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 07:05:25 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 07:05:25 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 07:05:25 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 07:05:25 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 07:05:25 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 07:05:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:05:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:05:27 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 07:05:27 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 07:05:27 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 07:05:27 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 07:05:27 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 07:05:27 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 07:05:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:05:27 INFO - warning: no files found matching '*.txt' 07:05:27 INFO - no previously-included directories found matching 'build' 07:05:27 INFO - no previously-included directories found matching 'dist' 07:05:27 INFO - no previously-included directories found matching '.git*' 07:05:27 INFO - Installing collected packages: jsonschema, functools32 07:05:27 INFO - Running setup.py install for functools32 07:05:28 INFO - warning: no files found matching '*.txt' 07:05:28 INFO - no previously-included directories found matching 'build' 07:05:28 INFO - no previously-included directories found matching 'dist' 07:05:28 INFO - no previously-included directories found matching '.git*' 07:05:28 INFO - Successfully installed jsonschema functools32 07:05:28 INFO - Cleaning up... 07:05:28 INFO - Return code: 0 07:05:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:28 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:28 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 07:05:28 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 07:05:28 INFO - Using env: {'DISPLAY': ':0', 07:05:28 INFO - 'HOME': '/home/cltbld', 07:05:28 INFO - 'LANG': 'en_US.UTF-8', 07:05:28 INFO - 'LANGUAGE': 'en_US:en', 07:05:28 INFO - 'LOGNAME': 'cltbld', 07:05:28 INFO - 'MAIL': '/var/mail/cltbld', 07:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:28 INFO - 'MOZ_NO_REMOTE': '1', 07:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:28 INFO - 'NO_EM_RESTART': '1', 07:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:28 INFO - 'PWD': '/builds/slave/test', 07:05:28 INFO - 'SHELL': '/bin/bash', 07:05:28 INFO - 'SHLVL': '1', 07:05:28 INFO - 'TERM': 'linux', 07:05:28 INFO - 'TMOUT': '86400', 07:05:28 INFO - 'USER': 'cltbld', 07:05:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:28 INFO - '_': '/tools/buildbot/bin/python'} 07:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:05:28 INFO - Cleaning up... 07:05:28 INFO - Return code: 0 07:05:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:28 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:28 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 07:05:28 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 07:05:28 INFO - Using env: {'DISPLAY': ':0', 07:05:28 INFO - 'HOME': '/home/cltbld', 07:05:28 INFO - 'LANG': 'en_US.UTF-8', 07:05:28 INFO - 'LANGUAGE': 'en_US:en', 07:05:28 INFO - 'LOGNAME': 'cltbld', 07:05:28 INFO - 'MAIL': '/var/mail/cltbld', 07:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:28 INFO - 'MOZ_NO_REMOTE': '1', 07:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:28 INFO - 'NO_EM_RESTART': '1', 07:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:28 INFO - 'PWD': '/builds/slave/test', 07:05:28 INFO - 'SHELL': '/bin/bash', 07:05:28 INFO - 'SHLVL': '1', 07:05:28 INFO - 'TERM': 'linux', 07:05:28 INFO - 'TMOUT': '86400', 07:05:28 INFO - 'USER': 'cltbld', 07:05:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:28 INFO - '_': '/tools/buildbot/bin/python'} 07:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:05:28 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 07:05:28 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 07:05:28 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 07:05:28 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 07:05:28 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 07:05:28 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 07:05:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:05:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:05:30 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 07:05:30 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 07:05:30 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 07:05:30 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 07:05:30 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 07:05:30 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 07:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:05:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:05:30 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 07:05:30 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 07:05:30 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 07:05:30 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 07:05:30 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 07:05:30 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 07:05:31 INFO - Downloading docopt-0.6.1.tar.gz 07:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:05:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:05:31 INFO - Running setup.py install for blobuploader 07:05:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:05:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:05:31 INFO - Running setup.py install for requests 07:05:31 INFO - Running setup.py install for docopt 07:05:31 INFO - Successfully installed blobuploader requests docopt 07:05:31 INFO - Cleaning up... 07:05:31 INFO - Return code: 0 07:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:31 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:31 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 07:05:31 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 07:05:31 INFO - Using env: {'DISPLAY': ':0', 07:05:31 INFO - 'HOME': '/home/cltbld', 07:05:31 INFO - 'LANG': 'en_US.UTF-8', 07:05:31 INFO - 'LANGUAGE': 'en_US:en', 07:05:31 INFO - 'LOGNAME': 'cltbld', 07:05:31 INFO - 'MAIL': '/var/mail/cltbld', 07:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:31 INFO - 'MOZ_NO_REMOTE': '1', 07:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:31 INFO - 'NO_EM_RESTART': '1', 07:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:31 INFO - 'PWD': '/builds/slave/test', 07:05:31 INFO - 'SHELL': '/bin/bash', 07:05:31 INFO - 'SHLVL': '1', 07:05:31 INFO - 'TERM': 'linux', 07:05:31 INFO - 'TMOUT': '86400', 07:05:31 INFO - 'USER': 'cltbld', 07:05:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:31 INFO - '_': '/tools/buildbot/bin/python'} 07:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:05:31 INFO - Running setup.py (path:/tmp/pip-_S4Qrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:05:32 INFO - Running setup.py (path:/tmp/pip-P3ImqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:05:32 INFO - Running setup.py (path:/tmp/pip-Sqk2JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:05:32 INFO - Running setup.py (path:/tmp/pip-4ADh6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:05:32 INFO - Running setup.py (path:/tmp/pip-b4otPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:05:32 INFO - Running setup.py (path:/tmp/pip-t4otam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:05:32 INFO - Running setup.py (path:/tmp/pip-Ou1o6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:05:32 INFO - Running setup.py (path:/tmp/pip-Oo_NJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:05:32 INFO - Running setup.py (path:/tmp/pip-MDJ4ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:05:32 INFO - Running setup.py (path:/tmp/pip-mSM10d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:05:32 INFO - Running setup.py (path:/tmp/pip-uOq7Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:05:32 INFO - Running setup.py (path:/tmp/pip-tYLaoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:05:32 INFO - Running setup.py (path:/tmp/pip-Jbrr7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:05:32 INFO - Running setup.py (path:/tmp/pip-g3SrSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:32 INFO - Running setup.py (path:/tmp/pip-RyJ5rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:05:33 INFO - Running setup.py (path:/tmp/pip-3b4usU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:05:33 INFO - Running setup.py (path:/tmp/pip-dY0Bx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:05:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:05:33 INFO - Running setup.py install for manifestparser 07:05:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:05:33 INFO - Running setup.py install for mozcrash 07:05:33 INFO - Running setup.py install for mozdebug 07:05:33 INFO - Running setup.py install for mozdevice 07:05:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:05:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:05:33 INFO - Running setup.py install for mozfile 07:05:33 INFO - Running setup.py install for mozhttpd 07:05:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:05:33 INFO - Running setup.py install for mozinfo 07:05:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:05:33 INFO - Running setup.py install for mozInstall 07:05:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Running setup.py install for mozleak 07:05:34 INFO - Running setup.py install for mozlog 07:05:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Running setup.py install for moznetwork 07:05:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Running setup.py install for mozprocess 07:05:34 INFO - Running setup.py install for mozprofile 07:05:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Running setup.py install for mozrunner 07:05:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Running setup.py install for mozscreenshot 07:05:34 INFO - Running setup.py install for moztest 07:05:34 INFO - Running setup.py install for mozversion 07:05:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:05:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:05:34 INFO - Cleaning up... 07:05:35 INFO - Return code: 0 07:05:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:35 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:35 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 07:05:35 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 07:05:35 INFO - Using env: {'DISPLAY': ':0', 07:05:35 INFO - 'HOME': '/home/cltbld', 07:05:35 INFO - 'LANG': 'en_US.UTF-8', 07:05:35 INFO - 'LANGUAGE': 'en_US:en', 07:05:35 INFO - 'LOGNAME': 'cltbld', 07:05:35 INFO - 'MAIL': '/var/mail/cltbld', 07:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:35 INFO - 'MOZ_NO_REMOTE': '1', 07:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:35 INFO - 'NO_EM_RESTART': '1', 07:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:35 INFO - 'PWD': '/builds/slave/test', 07:05:35 INFO - 'SHELL': '/bin/bash', 07:05:35 INFO - 'SHLVL': '1', 07:05:35 INFO - 'TERM': 'linux', 07:05:35 INFO - 'TMOUT': '86400', 07:05:35 INFO - 'USER': 'cltbld', 07:05:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:35 INFO - '_': '/tools/buildbot/bin/python'} 07:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:05:35 INFO - Running setup.py (path:/tmp/pip-OboLGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:05:35 INFO - Running setup.py (path:/tmp/pip-uLtLOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:05:35 INFO - Running setup.py (path:/tmp/pip-koVgfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:05:35 INFO - Running setup.py (path:/tmp/pip-WgFpVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:05:35 INFO - Running setup.py (path:/tmp/pip-foFomI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:05:35 INFO - Running setup.py (path:/tmp/pip-VDMyTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:05:35 INFO - Running setup.py (path:/tmp/pip-RmZFVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:05:35 INFO - Running setup.py (path:/tmp/pip-9UE3z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:05:35 INFO - Running setup.py (path:/tmp/pip-scQa6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:05:35 INFO - Running setup.py (path:/tmp/pip-aQ67Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:05:35 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)) 07:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:05:35 INFO - Running setup.py (path:/tmp/pip-8ctqZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:05:36 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)) 07:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:05:36 INFO - Running setup.py (path:/tmp/pip-qKtD0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:05:36 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)) 07:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:05:36 INFO - Running setup.py (path:/tmp/pip-o8Y1nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:05:36 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)) 07:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:05:36 INFO - Running setup.py (path:/tmp/pip-0saE3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:05:36 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)) 07:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:36 INFO - Running setup.py (path:/tmp/pip-bWsiaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:05:36 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)) 07:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:05:36 INFO - Running setup.py (path:/tmp/pip-eZZD1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:05:36 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)) 07:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:05:36 INFO - Running setup.py (path:/tmp/pip-ROBoBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:05:36 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)) 07:05:36 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)) 07:05:36 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)) 07:05:36 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)) 07:05:36 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)) 07:05:36 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)) 07:05:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:38 INFO - Downloading blessings-1.6.tar.gz 07:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:05:38 INFO - Installing collected packages: blessings 07:05:38 INFO - Running setup.py install for blessings 07:05:38 INFO - Successfully installed blessings 07:05:38 INFO - Cleaning up... 07:05:38 INFO - Return code: 0 07:05:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:38 INFO - Reading from file tmpfile_stdout 07:05:38 INFO - Current package versions: 07:05:38 INFO - argparse == 1.2.1 07:05:38 INFO - blessings == 1.6 07:05:38 INFO - blobuploader == 1.2.4 07:05:38 INFO - docopt == 0.6.1 07:05:38 INFO - functools32 == 3.2.3-2 07:05:38 INFO - jsonschema == 2.5.1 07:05:38 INFO - manifestparser == 1.1 07:05:38 INFO - mozInstall == 1.12 07:05:38 INFO - mozcrash == 0.17 07:05:38 INFO - mozdebug == 0.1 07:05:38 INFO - mozdevice == 0.48 07:05:38 INFO - mozfile == 1.2 07:05:38 INFO - mozhttpd == 0.7 07:05:38 INFO - mozinfo == 0.9 07:05:38 INFO - mozleak == 0.1 07:05:38 INFO - mozlog == 3.3 07:05:38 INFO - moznetwork == 0.27 07:05:38 INFO - mozprocess == 0.23 07:05:38 INFO - mozprofile == 0.28 07:05:38 INFO - mozrunner == 6.12 07:05:38 INFO - mozscreenshot == 0.1 07:05:38 INFO - mozsystemmonitor == 0.3 07:05:38 INFO - moztest == 0.7 07:05:38 INFO - mozversion == 1.4 07:05:38 INFO - psutil == 3.1.1 07:05:38 INFO - requests == 1.2.3 07:05:38 INFO - wsgiref == 0.1.2 07:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:05:38 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')]} 07:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:38 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')]} 07:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:38 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 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:38 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 07:05:38 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 07:05:38 INFO - Using env: {'DISPLAY': ':0', 07:05:38 INFO - 'HOME': '/home/cltbld', 07:05:38 INFO - 'LANG': 'en_US.UTF-8', 07:05:38 INFO - 'LANGUAGE': 'en_US:en', 07:05:38 INFO - 'LOGNAME': 'cltbld', 07:05:38 INFO - 'MAIL': '/var/mail/cltbld', 07:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:38 INFO - 'MOZ_NO_REMOTE': '1', 07:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:38 INFO - 'NO_EM_RESTART': '1', 07:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:38 INFO - 'PWD': '/builds/slave/test', 07:05:38 INFO - 'SHELL': '/bin/bash', 07:05:38 INFO - 'SHLVL': '1', 07:05:38 INFO - 'TERM': 'linux', 07:05:38 INFO - 'TMOUT': '86400', 07:05:38 INFO - 'USER': 'cltbld', 07:05:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:38 INFO - '_': '/tools/buildbot/bin/python'} 07:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 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)) 07:05:39 INFO - Cleaning up... 07:05:39 INFO - Return code: 0 07:05:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1852030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b13180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', '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 07:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:05:39 INFO - Using env: {'DISPLAY': ':0', 07:05:39 INFO - 'HOME': '/home/cltbld', 07:05:39 INFO - 'LANG': 'en_US.UTF-8', 07:05:39 INFO - 'LANGUAGE': 'en_US:en', 07:05:39 INFO - 'LOGNAME': 'cltbld', 07:05:39 INFO - 'MAIL': '/var/mail/cltbld', 07:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:39 INFO - 'MOZ_NO_REMOTE': '1', 07:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:39 INFO - 'NO_EM_RESTART': '1', 07:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:39 INFO - 'PWD': '/builds/slave/test', 07:05:39 INFO - 'SHELL': '/bin/bash', 07:05:39 INFO - 'SHLVL': '1', 07:05:39 INFO - 'TERM': 'linux', 07:05:39 INFO - 'TMOUT': '86400', 07:05:39 INFO - 'USER': 'cltbld', 07:05:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:39 INFO - '_': '/tools/buildbot/bin/python'} 07:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:05:39 INFO - Cleaning up... 07:05:39 INFO - Return code: 0 07:05:39 INFO - Running post-action listener: _resource_record_post_action 07:05:39 INFO - Running post-action listener: _start_resource_monitoring 07:05:39 INFO - Starting resource monitoring. 07:05:39 INFO - [mozharness: 2016-08-05 14:05:39.291644Z] Finished create-virtualenv step (success) 07:05:39 INFO - [mozharness: 2016-08-05 14:05:39.292633Z] Running install step. 07:05:39 INFO - Running pre-action listener: _resource_record_pre_action 07:05:39 INFO - Running main action method: install 07:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:05:39 INFO - Reading from file tmpfile_stdout 07:05:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:05:39 INFO - Reading from file tmpfile_stdout 07:05:39 INFO - Output received: 07:05:39 INFO - Usage: mozinstall [options] installer 07:05:39 INFO - Options: 07:05:39 INFO - -h, --help show this help message and exit 07:05:39 INFO - -d DEST, --destination=DEST 07:05:39 INFO - Directory to install application into. [default: 07:05:39 INFO - "/builds/slave/test"] 07:05:39 INFO - --app=APP Application being installed. [default: firefox] 07:05:39 INFO - mkdir: /builds/slave/test/build/application 07:05:39 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'] 07:05:39 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 07:05:56 INFO - Reading from file tmpfile_stdout 07:05:56 INFO - Output received: 07:05:56 INFO - /builds/slave/test/build/application/firefox/firefox 07:05:56 INFO - Running post-action listener: _resource_record_post_action 07:05:56 INFO - [mozharness: 2016-08-05 14:05:56.450354Z] Finished install step (success) 07:05:56 INFO - [mozharness: 2016-08-05 14:05:56.450604Z] Running run-tests step. 07:05:56 INFO - Running pre-action listener: _resource_record_pre_action 07:05:56 INFO - Running main action method: run_tests 07:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:05:56 INFO - Python 2.7.3 07:05:56 INFO - Return code: 0 07:05:56 INFO - grabbing minidump binary from tooltool 07:05:56 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')]} 07:05:56 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 0x1b113b0>, '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 0x1b122b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b12740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:05:56 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 07:05:56 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 07:05:56 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 07:05:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:05:56 INFO - Return code: 0 07:05:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:05:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:05:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:05:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:05:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:05:56 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/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:05:56 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/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 07:05:56 INFO - Using env: {'DISPLAY': ':0', 07:05:56 INFO - 'HOME': '/home/cltbld', 07:05:56 INFO - 'LANG': 'en_US.UTF-8', 07:05:56 INFO - 'LANGUAGE': 'en_US:en', 07:05:56 INFO - 'LOGNAME': 'cltbld', 07:05:56 INFO - 'MAIL': '/var/mail/cltbld', 07:05:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:05:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:56 INFO - 'MOZ_NO_REMOTE': '1', 07:05:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:56 INFO - 'NO_EM_RESTART': '1', 07:05:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:56 INFO - 'PWD': '/builds/slave/test', 07:05:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:05:56 INFO - 'SHELL': '/bin/bash', 07:05:56 INFO - 'SHLVL': '1', 07:05:56 INFO - 'TERM': 'linux', 07:05:56 INFO - 'TMOUT': '86400', 07:05:56 INFO - 'USER': 'cltbld', 07:05:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020', 07:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:56 INFO - '_': '/tools/buildbot/bin/python'} 07:05:56 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/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 07:05:56 INFO - mozversion application_buildid: 20160805053003 07:05:56 INFO - mozversion application_changeset: 2c234f5a191673f6a4b0490435851e61852a54e8 07:05:56 INFO - mozversion application_display_name: Nightly 07:05:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:05:56 INFO - mozversion application_name: Firefox 07:05:56 INFO - mozversion application_remotingname: firefox 07:05:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:05:56 INFO - mozversion application_vendor: Mozilla 07:05:56 INFO - mozversion application_version: 51.0a1 07:05:56 INFO - mozversion platform_buildid: 20160805053003 07:05:56 INFO - mozversion platform_changeset: 2c234f5a191673f6a4b0490435851e61852a54e8 07:05:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:05:56 INFO - mozversion platform_version: 51.0a1 07:05:56 INFO - using testdate: 1470405956 07:05:56 INFO - actual date: 1470405956 07:05:56 INFO - starting webserver on 'localhost:54060' 07:05:56 INFO - SUITE-START | Running 2 tests 07:05:56 INFO - TEST-START | dromaeo_css 07:05:56 INFO - operating with platform_type : linux_ 07:05:56 INFO - Initialising browser for dromaeo_css test... 07:05:56 INFO - TEST-INFO | started process 3355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprb06a0/profile http://localhost:54060/getInfo.html) 07:06:02 INFO - PROCESS | 3355 | __metrics Screen width/height:1600/1200 07:06:02 INFO - PROCESS | 3355 | colorDepth:24 07:06:02 INFO - PROCESS | 3355 | Browser inner width/height: 1024/697 07:06:02 INFO - PROCESS | 3355 | __metrics 07:06:03 INFO - PROCESS | 3355 | 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" 07:06:03 INFO - PROCESS | 3355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:05 INFO - PROCESS | 3355 | console.error: PushService: 07:06:05 INFO - PROCESS | 3355 | stateChangeProcessEnqueue: Error transitioning state 07:06:05 INFO - PROCESS | 3355 | UnknownError 07:06:05 INFO - TEST-INFO | 3355: exit 0 07:06:05 INFO - Browser initialized. 07:06:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:05 INFO - TEST-INFO | started process 3439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprb06a0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:17 INFO - PROCESS | 3439 | RSS: Main: 156393472 07:06:17 INFO - PROCESS | 3439 | 07:07:09 INFO - PROCESS | 3439 | 1470406029325 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] 07:09:18 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:54060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54060/tests/dromaeo/cssquery-ext.html) 07:09:19 INFO - PROCESS | 3439 | RSS: Main: 290934784 07:09:19 INFO - PROCESS | 3439 | 07:12:22 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:54060/tests/dromaeo/cssquery-ext.html (next: http://localhost:54060/tests/dromaeo/cssquery-jquery.html) 07:12:23 INFO - PROCESS | 3439 | RSS: Main: 246321152 07:12:23 INFO - PROCESS | 3439 | 07:15:25 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:54060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54060/tests/dromaeo/cssquery-mootools.html) 07:15:25 INFO - PROCESS | 3439 | RSS: Main: 184004608 07:15:25 INFO - PROCESS | 3439 | 07:18:27 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:54060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54060/tests/dromaeo/cssquery-prototype.html) 07:18:28 INFO - PROCESS | 3439 | RSS: Main: 236593152 07:18:28 INFO - PROCESS | 3439 | 07:21:31 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:54060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54060/tests/dromaeo/cssquery-yui.html) 07:21:31 INFO - PROCESS | 3439 | RSS: Main: 185593856 07:21:31 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | Cycle 1(1): loaded http://localhost:54060/tests/dromaeo/cssquery-yui.html (next: http://localhost:54060/tests/dromaeo/cssquery-dojo.html) 07:24:34 INFO - PROCESS | 3439 | RSS: Main: 277438464 07:24:34 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | __start_tp_report 07:24:34 INFO - PROCESS | 3439 | _x_x_mozilla_page_load 07:24:34 INFO - PROCESS | 3439 | _x_x_mozilla_page_load_details 07:24:34 INFO - PROCESS | 3439 | |i|pagename|runs| 07:24:34 INFO - PROCESS | 3439 | |0;dojo.html;3036.954445683315;3077.1999280187147;3083.352495975845;3116.3144108296196;3128.9687103128977;5233.3981592116825;5281.366236051679;5308;5393.919091213635;5402.135658294674;5281.656692314997;5292.3913749918775;5305.8938821223555;5338.412774594792;5353.7590808413615;4776.044791041797;4848.7090774553635;4862.367892174012;4873.171560834667;5006.349174607296;4927.260910863363;4951.084049450845;4978.55193032627;4991.850244492671;5001.949980500185;4779.880502987436;4854.320395144648;4886.804527818883;4896.069746748107;4960.801567937297;4847.054824309261;4867.780949857265;4873.31773551703;4941.654084214107;4982;4855.465898751135;4907.607391408679;4919.065377578248;4955.801767929279;4993.625478089158;5215.426303106655;5263.921041184385;5324.281222035014;5376.91934620981;5395.5953303502;5684.602077854552;5746.597738158331;5798.768049278024;5800.622959507661;5802.97098514509;5758.165066065439;5775.27809023872;5811.331696854873;5823.2138661280605;5827.854303642401;5259.316288882459;5313.335833020834;5364.061289274361;5374.086405311106;5414.91877621836;5932.644041357532;5970.402959703995;5977.372375900555;5981.551383646244;5983;5727.427257274239;5737.426257374313;5748.626339287933;5749.827505174768;5753.424657534213;5555.861103472364;5579.525740312038;5617.129344951539;5626.943730562723;5809.88380232393;5633.492985631231;5635.126555383922;5636.436356364413;5641.661500309994;5686.658800471985;5571.526420254243;5616.775328986795;5617.185508101385;5625.184348269478;5631.633943793722;4324.891877703019;4342.5006124296115;4347.021920068023;4368.322909948963;4419.823207071746;3962.5443074046852;3970.3250447424007;3986.4219688145636;3987.3420885554137;3988.8205030773684;5402.216678581583;5409.702466364388;5448.237246785453;5448.754806033738;5495.697736624444;5818.301803783488;5820.505257053198;5822.097574875901;5825.621334613236;5869.06095024794;5442.482964118402;5478.972605136949;5485.0949593317455;5486.890262194734;5491.560675146058;4772.809087636456;4891.364122664031;4913.877153071202;4921.5078492151215;4933.136701077297;5952.166696662471;5953.672548009815;5959.910601340984;5960.046392577166;5997.250343707036;5674.971625142013;5773.22061521706;5790.7973220937065;5791.420857914175;5794.855128621818;5722.799702010409;5897.469227769521;5954.821355359346;5969.880602388015;5976.402359764163;5686.857828554319;5690.544756419559;5708.686022268815;5711.057675483498;5763.106718458645;5799.101139323411;5802.390748971297;5804.883902322014;5810.796622118206;5813.302403711582;5401.864953376197;5581.665100094007;5610.579206559442;5633.352164501135;5653.434656534314;5674.886502270014;5676.9432305678065;5676.9716151420635;5687.630304030225;5727.713614319184;5594.86012849682;5675.205471233948;5676;5676.262085928968;5680.602357834912;5401.081816091195;5559.72201389937;5617.775288988558;5627.606067575231;5757.91363129545;5524.723763811713;5527.613067085265;5529.529989950899;5536.7231638418725;5566.749496272597 07:24:34 INFO - PROCESS | 3439 | |1;ext.html;566.6656672563187;567.9403662615425;585.2304219950767;591.2874985642302;618.1500436899264;43512.34731479026;45090.09819803606;45096.3235551467;45136;49162;47992.52007479924;48444;48455.51544484554;48492.51507484924;48499.75750121244;9006.774830629238;9129.22401595865;9146.908530914705;9147.862782058275;9155.633774649006;9056.909430905705;9148.817023659523;9150;9152.588133533975;9158.313126515504;9154.404963677373;9190.035046320107;9193.816123677523;9196.908030919705;9200.769980750501;9156.130167634064;9169.312301577409;9195.494247816367;9196;9202.03378645246;9049.321300902393;9093.499857507835;9107.043760405195;9114.270858331318;9117.407368521091;43827.12345753067;43886.56113438857;44044;44186.779066104464;44231;3720.21875406165;3723.7951912644794;3732.216234590739;3806.9809650951843;4138.089620283563;33212.50181247283;33770.662293377;34046;34164.48753268703;34687.30625387478;4374.9781251093855;4385.320275357325;4532.252178390561;4597.977010114928;4601.7699115044115;371920;371980;373248;374095.99999999726;374367;59166.70416647889;59191;59413.405865941655;59483.70258148682;59515.40484595099;54344.65242780568;55261.44738552644;60212.69893650504;61448.692756536824;61510.38489615046;16435.26041328143;16597.58506037359;16613;16669.33322667104;16706.49880503587;12975.675608109685;13097.148685335613;13108.606741797761;13135.802962955564;13138.146020508637;14911.478098266509;16315;16546.7661865649;16876.15619219034;16997.150142493072;6102.328743838174;6351.333110023381;6412.23053233615;6500.627271046129;6516.902246466307;928.972130836076;999.575180548264;1008.8436292374694;1073.903348698621;1112.6662001399548;33625.49561756527;34006.48990265148;34238.82880585581;35062.82468587641;35610.465843012375;1036.891126431729;1056.6143357674548;1082.6427278997912;1102.509383324413;1180.9763804723857;17049.48851534456;17064.31742730277;17176.711746619054;17178.914105429394;17198.74201886973;509004;512689;513337;515198;515751;58561.41438585645;58587.70706146442;58609.41390586125;58703;58874;1308.3458270864567;1351.8445378781566;1352.4387379237703;1364.9181049137082;1370.294298436306;30894.53658195084;31887.52168717425;32581.18547036343;32632.83683581567;32933.50599741054;52667;53019.20471193012;53023.73488132535;53240;53338;416970;417749;418664;418858;418923;24758.628620571068;27459;28282.71717282883;28308;28556.572691320638;46374.53625463837;47130.528694712615;47228.291575625706;48182.75908620434;48230;39125.08749125065;40166.598334016286;41024.08167131153;41284;41578;39613.40579891361;39684;40032;40502.1899562013;41156.58843411528;40687.38968915409;40928.79535602303;41120;42076.78961605173;42725.1454970905;34865;37300;37571.812140940216;38393;38699.806500967316;28873.85563072171;29422;29431;29516.409671806014;35575.46636800502 07:24:34 INFO - PROCESS | 3439 | |2;jquery.html;375.5549673636739;382.2526959793604;395.3516233377261;396.67869026088863;420.47440699126093;14303.713925721479;17249.482515524523;18754.812451875478;20481.487962800937;20488.975551222436;16207.675846483064;17054.74417883733;19557.706634400496;19656;20483.283085092025;5677.517411020068;5847.830433913213;5861.267341582302;5881.147233651118;5883.705814709268;5623.99999999998;5747.080467125261;5761.596688231825;5840.795572154975;5854.941450585482;5773.191753154561;5773.451522105393;5774.7401366938375;5775.624584402021;5776.653400795965;5563.693996830152;5757.712114394284;5757.769689212427;5758.251427314464;5801.274840644919;5184.11869982104;5191.0656081905245;5194.792208311663;5196.142636464979;5196.792128314863;23881.164159254517;24065;24337.269881903572;24487.265382038568;24763.25710228678;2125.061673635581;2294.9311520654405;2476.913308034228;2488.0669748844184;2683.436478339551;9962.850557241647;10590.31162974412;10726.624568140078;11049.668509944715;11200.439978001148;1881.2851116575614;1923.249932526316;1942.4755316064725;1987.2349145579055;2057.9382618521468;82074.58962705208;87318.56340718319;90540.54729726375;90601.54699226527;91234.5438272811;10831.512581933832;11160.883911608775;11183.888161118448;11188.832167517494;11396.658100257006;16246;16257.67484650324;16288.348466061461;16289.755653665205;16313.592160195853;8125.187481251827;8166;8344.66621335152;8401.495910245405;8417.410781245377;7996.160403157701;8014.15851335613;8023.558704271204;8242.670293188205;8263.173682631808;4393.1872603568445;4596.8161273548685;4776.164171270014;4908.239222920453;4921.680090794087;1900.7624046994126;1951.9121639526256;1968.094676448821;2000.619882222373;2018.3339497965635;911.284641556375;995.915347195482;1038.1953985661023;1066.2163309967168;1091.0177850844323;19529.414117576496;20058.39824805258;20210.39368818938;20976.26583069585;21108.82833705752;985.074030411411;987.4026214140341;1009.137187704502;1022.437659287389;1086.1202426034938;10634.946825265824;11581.826272605918;11597.942010289895;11615.593454229062;11641;506088;510380;511020;511360;511786;90856.54571727231;92013.53993229991;93062;93111.53444232735;94395.52802236083;963.330485312701;989.9455529945922;994.865693131418;1005.4470041477158;1014.1126514299988;17657.470275891745;18152.90923545374;18521.444356669323;18552.536186595444;18575.25698972026;44598;45001.12480315997;45261.54738452574;46826;47277;62961.68519157375;62981.370186299384;63738;63823.36176638174;64563.67718161379;8508.361872859436;8721.171488708562;8935.463872167691;8941.955290223506;9155.771105722144;9793.579930909837;13285.870700990137;14044.578662640137;14129.152250864981;14137.717245655234;11700;11841.23032002917;11867.347295898464;11910.940445298065;12442.626721198378;11606.361650109326;11896.5406203401;11912.225705329125;12010.09924255667;12103;12129.150959432754;12210.63368098923;12222.327771972272;12249.510019599116;12518.186317889307;8717.171868672465;8820.514871681862;8997.595108220277;12128.575499857463;12527.498900043896;11677.474513646737;12075.637730868088;12345.629631111082;12368.257904525757;12595.433205505591 07:24:34 INFO - PROCESS | 3439 | |3;mootools.html;1338.4779935825036;1443.8339590947037;1518.5975716435146;1635.517522330913;1781.8307260810218;8631.438956467833;8896.199342059213;8961.775955601113;9195.264378849693;9200;8965.237954773853;9095.272378209744;9100.226480749128;9101.63593456261;9101.90898091019;2076;2318.142287353673;2400.7239167495745;2429.161939130997;2430.586800243963;2425.369403954967;2461.2985299189736;2461.852288862674;2463.9014439422403;2464.2237695125978;2327.2669109230624;2329.24299602629;2330.9184178553755;2335.019291897407;2342.9765702343016;2321.93034208974;2385.940351491209;2396.628522579003;2396.6405039244078;2408.4701365699516;2429.27121863442;2454.312792418108;2454.447749256403;2454.619533972237;2454.950900981988;9403.529823508865;9492.905070949271;9503.382280151767;9503.667371642028;9505.334626576143;5330.147176451749;5442.836714898559;5456.563474921997;5466.9179962300595;5467.45325467454;3261.983690081558;3306.504024396336;3403.421418358885;3411.556497655289;3418.06003349081;1118.776244751045;1135.5117299561186;1148.5233628044434;1165.9650210493699;1202.0443747220893;12886.097973141885;12913;12976.02679799019;12980.740385192243;13048.412821423059;4505.752183629932;4659.207934651117;4682.321063445849;4815.855524334275;4818.951810481921;10132.493375331203;10147.543360548792;10149.695509134737;10161.593536258466;10166.085052345325;5343.519083282523;5354.089804733205;5361.463853614685;5363.088274993261;5365.812196573102;4451;4936.75316234194;4965.255211718199;4966.875828104254;5069.518395752398;3797.7531460454984;3871.535415750128;3981.820818063194;3987.322155233617;4074.3481043033566;1084.3981590217347;1092.1754075672816;1112.2547892911607;1159.6579009192308;1160.5299853559322;936.5925822267335;951.833429149896;956.9043095690514;968.6754937096151;980.9754756131011;6072.210612620331;6085.756569737249;6151.046587778901;6252.937470625327;6330.905036424458;466.97898594563327;467.0332411907387;470.1326053431482;474.40462219913786;475.78114067528634;4297.162053399557;4344.304911214191;4468.285074388083;4509.6392288616835;4620.930686039712;11475.942620286845;11584.189106762615;11719.941400292944;11722.355270460035;11749.706257343634;11615.128865335133;11653.41732913351;11653.708657283636;11670.474828632732;11674.591389301333;8153.918460815435;8462.492250464991;8481.194286542768;8486;8489.95755021221;6310.337414571588;6375.330590288138;6423.389777971085;6464.838379040561;6617.94843598486;10309;10382.42896640692;10598.576056957636;10833.133349331876;10843.295185812896;10572.471376430994;10764.730881728019;10781.867903869981;10884;10993.120550356112;7193.244709305657;7560.168381478143;8190.180981901762;8395.034571024411;8406.411551191359;8514;8841.955790221007;8845.557722113997;8886.200241978253;8886.777830554287;7682.884756728766;7821.061472623322;7903.84192316139;8061.314788243065;8227.259546640831;7810.414218933489;7854.4894581851995;8198.795030124294;8211.58942052907;8247.711330103417;7050.612216328152;7196.388306993964;7201.459890508128;7213.314735100157;7214.098237720285;5281.181416880389;5364.892702145858;5478.80824171168;5551.472610102034;5627.634203776742;5563.666180029211;5673.34756502991;5684.545236380997;5706.514946229617;5784.8553786154 07:24:34 INFO - PROCESS | 3439 | |4;prototype.html;316.2583741127056;335.43479237484837;339.31627770043366;341.1097036734122;341.61056395708897;5110.8977820443615;5197.168453047513;5213.895722085556;5234;5252.579793616511;5139.841266667999;5155.922661160085;5164.561012313958;5171.250168725533;5172.172452407615;4135.855245066423;4143.399207114967;4154.688398370119;4155.958440415602;4174.893653181909;3915.530136383638;3924.489816323888;4123.773192474413;4138.855140070098;4160.3135482645475;4106.77412742299;4113.753174809506;4130.772807495587;4131.421600975851;4135.441715368417;4050.10897602527;4107.350758760613;4108.404281379198;4113.1568028554075;4138.358554424069;3427.725781937439;3529.29414117175;3604.567451905762;3618.4572314152824;3622.6920711739535;5036.84889453317;5047.747612619354;5052.898942021139;5070.366204224472;5110.207917772751;4603.8158473661015;4647.279671650899;4671.346011558385;4683.250679891201;4686.835960741392;5250.369955605352;5358.2498450217;5377.489138531833;5387.299651045379;5402.189671549259;3974.6224108709625;3987.6610488108545;3998.960010399917;4000.179963107556;4004.0990777075217;5618.7805816702585;5659.943400566024;5686.147077938301;5711.314642242916;5726.3414707308775;3913.158670885773;4003.819828107742;4063.227986682521;4082.1631565528996;4085.9591404086173;4143.4199212110325;4144.129732756155;4157.443172448922;4160.812763425653;4170.854020109342;4703.412073490814;4704.717716936994;4715.976420117878;4716.127516409407;4723.574878260973;5319.696674314818;5420.24116623673;5428.6199966002005;5434;5434.901450168493;1408.1551069358304;1420.6448387903024;1429.1925062339744;1429.5568373804153;1432.2337549411016;906.3700727994112;936.8173206224857;947.6872632031414;953.3279038277998;957.3394357893031;4727.220008698595;4730.8711080013445;4760.619150467955;5090.669106508065;5168.173092305213;5499.587530935196;5516.641418307797;5517.36550296713;5561;5567.860803479864;5309.301023672465;5329.9467005330225;5334.8933021340135;5335;5345.786168553214;2838.4465029319085;2924.903161314507;2928.5607158925905;2952.660444048962;2958.763298936123;5766.250387449605;5771.163181338767;5775.21723271258;5777.220075289866;5791.507721843606;5480.588955828329;5707.029804933171;5723.341815691166;5746.138079288056;5750.568707346965;5802.883942321215;5804.912926306109;5811.79658711943;5845.590808643524;5847.970760146172;5626.324841019104;5627.352854421794;5644.109223410203;5663.801766938137;5693.9715301424885;5394.433584473731;5519.31008623922;5543.113101903676;5560.36055853582;5564.387917329172;5795.536357091507;5825.300963884361;5830.883382332415;5837.270341207349;5859.9121013183985;3973.4238535412783;4003.499562554681;4006.459128017797;4026.416169655325;4028.274910516135;5566.805161819317;5628.380878103487;5688.715564221855;5698.0598201296325;5715.342735585461;5442.972785136049;5465.781368745205;5492.313460817398;5527;5543;5298.549623282064;5472.50747432733;5490.835274941758;5495.807646732345;5496.615236933376;5411.972940135274;5459.535939445032;5472.808451704172;5478.972605136949;5479.424660410599;5312.787488500417;5417.239397195848;5483.654970467932;5505.697186654773;5526.849695673428;4878.707277563216;5271.288376069335;5287.312649355559;5399.190121481809;5406 07:24:34 INFO - PROCESS | 3439 | |5;yui.html;746.5371469688794;755.9659815308307;756.6254703921558;810.4407958508625;883.748131782442;15448.845511544881;16553.33786648534;16687.499375018768;16812.32750689974;16861.156942152887;14629.122252664822;14902.776458353133;15386;15511;15569.143697096655;797.9481333713304;821.080389963242;823.5470491229829;823.6869989404018;824.1428913929506;667.6528205333248;794.6265255330014;818.8730746734266;821.9342452603777;827.3215962910416;862.525610913998;865.7013330401033;865.7922098696331;866.4757821517985;866.7183165471215;843.3843294395065;849.587949844325;855.8844555984956;856.9485830850138;859.5315553023618;509.38110196111904;518.9662671926312;519.6803965561153;612.5099920063931;625.5027253333566;15169.848301516953;15174.924125379413;15217;15225.771613425808;15227.314770835339;13764.967627427983;13945.093568917988;14199.361028753627;14312.928435357757;14662.780058299135;13437.395317210749;13600.591982240549;13646.181229126285;13698.315084245747;14356.497522586764;4352.185820973684;4378.62781663559;4394.143142087294;4445.066536027438;4451.421315228999;65127.3487265126;68068.3193168067;68506.65746671284;85168;86506.5674671629;11778.646640600795;11888.881111188777;11965.940170299093;12391.946684531735;12779.361031948365;21370.358889233346;21407.143714251255;21465;21517.246896358552;21626.459338516663;8828.51443170619;8933.240674542607;8956;9060.411073280347;9282.582283797245;4477.1362264564805;4630.6758526902795;4686.343911852344;4931.457539670633;5057.519535644108;3571.910702232413;3701.925961480755;3708.1100535871738;3711.31340701971;3724.776513409204;522.6944947133464;620.9037599172135;629.3957800511561;630.0360448513782;630.7949916277229;649.143131066987;652.4682383857141;693.7883945396702;695.9478039147084;705.3933617089299;8579.613917373734;9305.302102342352;9900.752481188028;10007.749806254902;10177.643782467578;545.2067242162723;580.94771470567;591.3111225422421;601.9345758008388;606.9802731411271;4568.383268258809;4646.4191976003;4668.136394766979;4754.453237877619;4805.8558243252055;98618;99776.5011174954;100819;130686;135274.3236283832;91601;97074;97664.51167744258;97783.51108244414;98913.50543247382;83589.58205209057;84500;88377;93254.53372733093;95579.52210239043;9563.426194428357;9920.20638348916;10318.17454603645;10634.840477393;10825.56697732082;40124;42553.787231063645;43509.564904350555;46896.531034689215;47574.76212618915;52663.21005184849;75186;77309;78864.60567697124;79514.60242698749;12322.81515777282;12605.49578016869;12677.556285529961;12852.485900563872;13738.793918091436;14800.62998425048;15276.770848437505;15307.923460383072;15492.612684682974;15689.764653529977;14500.709985800437;14809.562298244255;14919.701605968037;15135;15338;7223;13746.793798092836;13960.441582336593;14279.857201428269;14568.198749068903;14008.869509204216;14267.64330891736;14547.490837820626;14835.480758173844;15314.923425382802;11667.299962002307;11884.108691847972;12155.878441215475;12162.209456385306;12677.936610316889;12699.174553653984;12743.299118548568;12767.170133941636;13117.540886068942;13207.537736179187 07:24:34 INFO - PROCESS | 3439 | __end_tp_report 07:24:34 INFO - PROCESS | 3439 | __start_cc_report 07:24:34 INFO - PROCESS | 3439 | _x_x_mozilla_cycle_collect,1183 07:24:34 INFO - PROCESS | 3439 | __end_cc_report 07:24:34 INFO - PROCESS | 3439 | __startTimestamp1470407074986__endTimestamp 07:24:34 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | ------- Summary: start ------- 07:24:34 INFO - PROCESS | 3439 | Number of tests: 6 07:24:34 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | [#0] dojo.html Cycles:165 Average:5342.21 Median:5559.72 stddev:610.10 (11.0%) stddev-sans-first:584.55 07:24:34 INFO - PROCESS | 3439 | Values: 3037.0 3077.2 3083.4 3116.3 3129.0 5233.4 5281.4 5308.0 5393.9 5402.1 5281.7 5292.4 5305.9 5338.4 5353.8 4776.0 4848.7 4862.4 4873.2 5006.3 4927.3 4951.1 4978.6 4991.9 5001.9 4779.9 4854.3 4886.8 4896.1 4960.8 4847.1 4867.8 4873.3 4941.7 4982.0 4855.5 4907.6 4919.1 4955.8 4993.6 5215.4 5263.9 5324.3 5376.9 5395.6 5684.6 5746.6 5798.8 5800.6 5803.0 5758.2 5775.3 5811.3 5823.2 5827.9 5259.3 5313.3 5364.1 5374.1 5414.9 5932.6 5970.4 5977.4 5981.6 5983.0 5727.4 5737.4 5748.6 5749.8 5753.4 5555.9 5579.5 5617.1 5626.9 5809.9 5633.5 5635.1 5636.4 5641.7 5686.7 5571.5 5616.8 5617.2 5625.2 5631.6 4324.9 4342.5 4347.0 4368.3 4419.8 3962.5 3970.3 3986.4 3987.3 3988.8 5402.2 5409.7 5448.2 5448.8 5495.7 5818.3 5820.5 5822.1 5825.6 5869.1 5442.5 5479.0 5485.1 5486.9 5491.6 4772.8 4891.4 4913.9 4921.5 4933.1 5952.2 5953.7 5959.9 5960.0 5997.3 5675.0 5773.2 5790.8 5791.4 5794.9 5722.8 5897.5 5954.8 5969.9 5976.4 5686.9 5690.5 5708.7 5711.1 5763.1 5799.1 5802.4 5804.9 5810.8 5813.3 5401.9 5581.7 5610.6 5633.4 5653.4 5674.9 5676.9 5677.0 5687.6 5727.7 5594.9 5675.2 5676.0 5676.3 5680.6 5401.1 5559.7 5617.8 5627.6 5757.9 5524.7 5527.6 5529.5 5536.7 5566.7 07:24:34 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | [#1] ext.html Cycles:180 Average:60157.44 Median:230499.89 stddev:116038.08 (50.3%) stddev-sans-first:116277.34 07:24:34 INFO - PROCESS | 3439 | Values: 566.7 567.9 585.2 591.3 618.2 43512.3 45090.1 45096.3 45136.0 49162.0 47992.5 48444.0 48455.5 48492.5 48499.8 9006.8 9129.2 9146.9 9147.9 9155.6 9056.9 9148.8 9150.0 9152.6 9158.3 9154.4 9190.0 9193.8 9196.9 9200.8 9156.1 9169.3 9195.5 9196.0 9202.0 9049.3 9093.5 9107.0 9114.3 9117.4 43827.1 43886.6 44044.0 44186.8 44231.0 3720.2 3723.8 3732.2 3807.0 4138.1 33212.5 33770.7 34046.0 34164.5 34687.3 4375.0 4385.3 4532.3 4598.0 4601.8 371920.0 371980.0 373248.0 374096.0 374367.0 59166.7 59191.0 59413.4 59483.7 59515.4 54344.7 55261.4 60212.7 61448.7 61510.4 16435.3 16597.6 16613.0 16669.3 16706.5 12975.7 13097.1 13108.6 13135.8 13138.1 14911.5 16315.0 16546.8 16876.2 16997.2 6102.3 6351.3 6412.2 6500.6 6516.9 929.0 999.6 1008.8 1073.9 1112.7 33625.5 34006.5 34238.8 35062.8 35610.5 1036.9 1056.6 1082.6 1102.5 1181.0 17049.5 17064.3 17176.7 17178.9 17198.7 509004.0 512689.0 513337.0 515198.0 515751.0 58561.4 58587.7 58609.4 58703.0 58874.0 1308.3 1351.8 1352.4 1364.9 1370.3 30894.5 31887.5 32581.2 32632.8 32933.5 52667.0 53019.2 53023.7 53240.0 53338.0 416970.0 417749.0 418664.0 418858.0 418923.0 24758.6 27459.0 28282.7 28308.0 28556.6 46374.5 47130.5 47228.3 48182.8 48230.0 39125.1 40166.6 41024.1 41284.0 41578.0 39613.4 39684.0 40032.0 40502.2 41156.6 40687.4 40928.8 41120.0 42076.8 42725.1 34865.0 37300.0 37571.8 38393.0 38699.8 28873.9 29422.0 29431.0 29516.4 35575.5 07:24:34 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | [#2] jquery.html Cycles:180 Average:30267.51 Median:13625.66 stddev:84190.24 (617.9%) stddev-sans-first:84396.50 07:24:34 INFO - PROCESS | 3439 | Values: 375.6 382.3 395.4 396.7 420.5 14303.7 17249.5 18754.8 20481.5 20489.0 16207.7 17054.7 19557.7 19656.0 20483.3 5677.5 5847.8 5861.3 5881.1 5883.7 5624.0 5747.1 5761.6 5840.8 5854.9 5773.2 5773.5 5774.7 5775.6 5776.7 5563.7 5757.7 5757.8 5758.3 5801.3 5184.1 5191.1 5194.8 5196.1 5196.8 23881.2 24065.0 24337.3 24487.3 24763.3 2125.1 2294.9 2476.9 2488.1 2683.4 9962.9 10590.3 10726.6 11049.7 11200.4 1881.3 1923.2 1942.5 1987.2 2057.9 82074.6 87318.6 90540.5 90601.5 91234.5 10831.5 11160.9 11183.9 11188.8 11396.7 16246.0 16257.7 16288.3 16289.8 16313.6 8125.2 8166.0 8344.7 8401.5 8417.4 7996.2 8014.2 8023.6 8242.7 8263.2 4393.2 4596.8 4776.2 4908.2 4921.7 1900.8 1951.9 1968.1 2000.6 2018.3 911.3 995.9 1038.2 1066.2 1091.0 19529.4 20058.4 20210.4 20976.3 21108.8 985.1 987.4 1009.1 1022.4 1086.1 10634.9 11581.8 11597.9 11615.6 11641.0 506088.0 510380.0 511020.0 511360.0 511786.0 90856.5 92013.5 93062.0 93111.5 94395.5 963.3 989.9 994.9 1005.4 1014.1 17657.5 18152.9 18521.4 18552.5 18575.3 44598.0 45001.1 45261.5 46826.0 47277.0 62961.7 62981.4 63738.0 63823.4 64563.7 8508.4 8721.2 8935.5 8942.0 9155.8 9793.6 13285.9 14044.6 14129.2 14137.7 11700.0 11841.2 11867.3 11910.9 12442.6 11606.4 11896.5 11912.2 12010.1 12103.0 12129.2 12210.6 12222.3 12249.5 12518.2 8717.2 8820.5 8997.6 12128.6 12527.5 11677.5 12075.6 12345.6 12368.3 12595.4 07:24:34 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | [#3] mootools.html Cycles:180 Average:6020.95 Median:2576.23 stddev:3497.14 (135.7%) stddev-sans-first:3489.25 07:24:34 INFO - PROCESS | 3439 | Values: 1338.5 1443.8 1518.6 1635.5 1781.8 8631.4 8896.2 8961.8 9195.3 9200.0 8965.2 9095.3 9100.2 9101.6 9101.9 2076.0 2318.1 2400.7 2429.2 2430.6 2425.4 2461.3 2461.9 2463.9 2464.2 2327.3 2329.2 2330.9 2335.0 2343.0 2321.9 2385.9 2396.6 2396.6 2408.5 2429.3 2454.3 2454.4 2454.6 2455.0 9403.5 9492.9 9503.4 9503.7 9505.3 5330.1 5442.8 5456.6 5466.9 5467.5 3262.0 3306.5 3403.4 3411.6 3418.1 1118.8 1135.5 1148.5 1166.0 1202.0 12886.1 12913.0 12976.0 12980.7 13048.4 4505.8 4659.2 4682.3 4815.9 4819.0 10132.5 10147.5 10149.7 10161.6 10166.1 5343.5 5354.1 5361.5 5363.1 5365.8 4451.0 4936.8 4965.3 4966.9 5069.5 3797.8 3871.5 3981.8 3987.3 4074.3 1084.4 1092.2 1112.3 1159.7 1160.5 936.6 951.8 956.9 968.7 981.0 6072.2 6085.8 6151.0 6252.9 6330.9 467.0 467.0 470.1 474.4 475.8 4297.2 4344.3 4468.3 4509.6 4620.9 11475.9 11584.2 11719.9 11722.4 11749.7 11615.1 11653.4 11653.7 11670.5 11674.6 8153.9 8462.5 8481.2 8486.0 8490.0 6310.3 6375.3 6423.4 6464.8 6617.9 10309.0 10382.4 10598.6 10833.1 10843.3 10572.5 10764.7 10781.9 10884.0 10993.1 7193.2 7560.2 8190.2 8395.0 8406.4 8514.0 8842.0 8845.6 8886.2 8886.8 7682.9 7821.1 7903.8 8061.3 8227.3 7810.4 7854.5 8198.8 8211.6 8247.7 7050.6 7196.4 7201.5 7213.3 7214.1 5281.2 5364.9 5478.8 5551.5 5627.6 5563.7 5673.3 5684.5 5706.5 5784.9 07:24:34 INFO - PROCESS | 3439 | 07:24:34 INFO - PROCESS | 3439 | [#4] prototype.html Cycles:180 Average:4606.63 Median:5251.47 stddev:1344.90 (25.6%) stddev-sans-first:1309.55 07:24:35 INFO - PROCESS | 3439 | Values: 316.3 335.4 339.3 341.1 341.6 5110.9 5197.2 5213.9 5234.0 5252.6 5139.8 5155.9 5164.6 5171.3 5172.2 4135.9 4143.4 4154.7 4156.0 4174.9 3915.5 3924.5 4123.8 4138.9 4160.3 4106.8 4113.8 4130.8 4131.4 4135.4 4050.1 4107.4 4108.4 4113.2 4138.4 3427.7 3529.3 3604.6 3618.5 3622.7 5036.8 5047.7 5052.9 5070.4 5110.2 4603.8 4647.3 4671.3 4683.3 4686.8 5250.4 5358.2 5377.5 5387.3 5402.2 3974.6 3987.7 3999.0 4000.2 4004.1 5618.8 5659.9 5686.1 5711.3 5726.3 3913.2 4003.8 4063.2 4082.2 4086.0 4143.4 4144.1 4157.4 4160.8 4170.9 4703.4 4704.7 4716.0 4716.1 4723.6 5319.7 5420.2 5428.6 5434.0 5434.9 1408.2 1420.6 1429.2 1429.6 1432.2 906.4 936.8 947.7 953.3 957.3 4727.2 4730.9 4760.6 5090.7 5168.2 5499.6 5516.6 5517.4 5561.0 5567.9 5309.3 5329.9 5334.9 5335.0 5345.8 2838.4 2924.9 2928.6 2952.7 2958.8 5766.3 5771.2 5775.2 5777.2 5791.5 5480.6 5707.0 5723.3 5746.1 5750.6 5802.9 5804.9 5811.8 5845.6 5848.0 5626.3 5627.4 5644.1 5663.8 5694.0 5394.4 5519.3 5543.1 5560.4 5564.4 5795.5 5825.3 5830.9 5837.3 5859.9 3973.4 4003.5 4006.5 4026.4 4028.3 5566.8 5628.4 5688.7 5698.1 5715.3 5443.0 5465.8 5492.3 5527.0 5543.0 5298.5 5472.5 5490.8 5495.8 5496.6 5412.0 5459.5 5472.8 5479.0 5479.4 5312.8 5417.2 5483.7 5505.7 5526.8 4878.7 5271.3 5287.3 5399.2 5406.0 07:24:35 INFO - PROCESS | 3439 | 07:24:35 INFO - PROCESS | 3439 | [#5] yui.html Cycles:180 Average:20751.37 Median:4522.76 stddev:29547.88 (653.3%) stddev-sans-first:29592.59 07:24:35 INFO - PROCESS | 3439 | Values: 746.5 756.0 756.6 810.4 883.7 15448.8 16553.3 16687.5 16812.3 16861.2 14629.1 14902.8 15386.0 15511.0 15569.1 797.9 821.1 823.5 823.7 824.1 667.7 794.6 818.9 821.9 827.3 862.5 865.7 865.8 866.5 866.7 843.4 849.6 855.9 856.9 859.5 509.4 519.0 519.7 612.5 625.5 15169.8 15174.9 15217.0 15225.8 15227.3 13765.0 13945.1 14199.4 14312.9 14662.8 13437.4 13600.6 13646.2 13698.3 14356.5 4352.2 4378.6 4394.1 4445.1 4451.4 65127.3 68068.3 68506.7 85168.0 86506.6 11778.6 11888.9 11965.9 12391.9 12779.4 21370.4 21407.1 21465.0 21517.2 21626.5 8828.5 8933.2 8956.0 9060.4 9282.6 4477.1 4630.7 4686.3 4931.5 5057.5 3571.9 3701.9 3708.1 3711.3 3724.8 522.7 620.9 629.4 630.0 630.8 649.1 652.5 693.8 695.9 705.4 8579.6 9305.3 9900.8 10007.7 10177.6 545.2 580.9 591.3 601.9 607.0 4568.4 4646.4 4668.1 4754.5 4805.9 98618.0 99776.5 100819.0 130686.0 135274.3 91601.0 97074.0 97664.5 97783.5 98913.5 83589.6 84500.0 88377.0 93254.5 95579.5 9563.4 9920.2 10318.2 10634.8 10825.6 40124.0 42553.8 43509.6 46896.5 47574.8 52663.2 75186.0 77309.0 78864.6 79514.6 12322.8 12605.5 12677.6 12852.5 13738.8 14800.6 15276.8 15307.9 15492.6 15689.8 14500.7 14809.6 14919.7 15135.0 15338.0 7223.0 13746.8 13960.4 14279.9 14568.2 14008.9 14267.6 14547.5 14835.5 15314.9 11667.3 11884.1 12155.9 12162.2 12677.9 12699.2 12743.3 12767.2 13117.5 13207.5 07:24:35 INFO - PROCESS | 3439 | -------- Summary: end -------- 07:24:35 INFO - PROCESS | 3439 | 07:24:35 INFO - TEST-INFO | 3439: exit 0 07:24:35 INFO - TEST-OK | dromaeo_css | took 1119015ms 07:24:35 INFO - TEST-START | kraken 07:24:35 INFO - operating with platform_type : linux_ 07:24:35 INFO - Initialising browser for kraken test... 07:24:35 INFO - TEST-INFO | started process 3749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo77LWq/profile http://localhost:54060/getInfo.html) 07:24:39 INFO - PROCESS | 3749 | __metrics Screen width/height:1600/1200 07:24:39 INFO - PROCESS | 3749 | colorDepth:24 07:24:39 INFO - PROCESS | 3749 | Browser inner width/height: 1024/697 07:24:39 INFO - PROCESS | 3749 | __metrics 07:24:40 INFO - PROCESS | 3749 | 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" 07:24:40 INFO - PROCESS | 3749 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:41 INFO - TEST-INFO | 3749: exit 0 07:24:41 INFO - Browser initialized. 07:24:41 INFO - Running cycle 1/1 for kraken test... 07:24:41 INFO - TEST-INFO | started process 3830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo77LWq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:53 INFO - PROCESS | 3830 | RSS: Main: 156241920 07:24:53 INFO - PROCESS | 3830 | 07:24:55 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54060/tests/kraken/driver.html?testName=audio-beat-detection) 07:24:56 INFO - PROCESS | 3830 | RSS: Main: 212963328 07:24:56 INFO - PROCESS | 3830 | 07:24:59 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54060/tests/kraken/driver.html?testName=audio-dft) 07:24:59 INFO - PROCESS | 3830 | RSS: Main: 191963136 07:24:59 INFO - PROCESS | 3830 | 07:25:03 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54060/tests/kraken/driver.html?testName=audio-fft) 07:25:03 INFO - PROCESS | 3830 | RSS: Main: 269574144 07:25:03 INFO - PROCESS | 3830 | 07:25:05 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54060/tests/kraken/driver.html?testName=audio-oscillator) 07:25:06 INFO - PROCESS | 3830 | RSS: Main: 179654656 07:25:06 INFO - PROCESS | 3830 | 07:25:08 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:09 INFO - PROCESS | 3830 | RSS: Main: 184668160 07:25:09 INFO - PROCESS | 3830 | 07:25:12 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54060/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:12 INFO - PROCESS | 3830 | RSS: Main: 219426816 07:25:12 INFO - PROCESS | 3830 | 07:25:16 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54060/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:16 INFO - PROCESS | 3830 | RSS: Main: 220082176 07:25:16 INFO - PROCESS | 3830 | 07:25:19 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54060/tests/kraken/driver.html?testName=json-parse-financial) 07:25:20 INFO - PROCESS | 3830 | RSS: Main: 219717632 07:25:20 INFO - PROCESS | 3830 | 07:25:21 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:25:22 INFO - PROCESS | 3830 | RSS: Main: 184582144 07:25:22 INFO - PROCESS | 3830 | 07:25:24 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:25:24 INFO - PROCESS | 3830 | RSS: Main: 190099456 07:25:24 INFO - PROCESS | 3830 | 07:25:26 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:25:27 INFO - PROCESS | 3830 | RSS: Main: 194539520 07:25:27 INFO - PROCESS | 3830 | 07:25:29 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:25:30 INFO - PROCESS | 3830 | RSS: Main: 188207104 07:25:30 INFO - PROCESS | 3830 | 07:25:33 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:25:33 INFO - PROCESS | 3830 | RSS: Main: 193286144 07:25:33 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | Cycle 1(1): loaded http://localhost:54060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54060/tests/kraken/driver.html?testName=ai-astar) 07:25:35 INFO - PROCESS | 3830 | RSS: Main: 243986432 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | __start_tp_report 07:25:35 INFO - PROCESS | 3830 | _x_x_mozilla_page_load 07:25:35 INFO - PROCESS | 3830 | _x_x_mozilla_page_load_details 07:25:35 INFO - PROCESS | 3830 | |i|pagename|runs| 07:25:35 INFO - PROCESS | 3830 | |0;ai-astar;101;113;111;110;113;112;111;111;111;110 07:25:35 INFO - PROCESS | 3830 | |1;audio-beat-detection;143;117;119;188;118;120;147;116;158;119 07:25:35 INFO - PROCESS | 3830 | |2;audio-dft;160;160;160;161;161;160;161;160;161;161 07:25:35 INFO - PROCESS | 3830 | |3;audio-fft;75;77;73;109;77;76;75;75;102;75 07:25:35 INFO - PROCESS | 3830 | |4;audio-oscillator;84;84;114;83;84;84;129;85;85;131 07:25:35 INFO - PROCESS | 3830 | |5;imaging-gaussian-blur;117;117;117;117;116;117;118;117;117;116 07:25:35 INFO - PROCESS | 3830 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;145 07:25:35 INFO - PROCESS | 3830 | |7;imaging-desaturate;96;96;96;96;95;95;95;96;96;96 07:25:35 INFO - PROCESS | 3830 | |8;json-parse-financial;50;51;50;50;51;61;50;51;50;51 07:25:35 INFO - PROCESS | 3830 | |9;json-stringify-tinderbox;59;59;59;60;60;59;60;63;61;60 07:25:35 INFO - PROCESS | 3830 | |10;stanford-crypto-aes;77;86;79;76;76;76;75;77;75;82 07:25:35 INFO - PROCESS | 3830 | |11;stanford-crypto-ccm;132;132;136;136;128;123;120;138;138;124 07:25:35 INFO - PROCESS | 3830 | |12;stanford-crypto-pbkdf2;164;165;161;161;161;161;162;159;158;161 07:25:35 INFO - PROCESS | 3830 | |13;stanford-crypto-sha256-iterative;66;64;66;67;70;64;63;65;63;64 07:25:35 INFO - PROCESS | 3830 | __end_tp_report 07:25:35 INFO - PROCESS | 3830 | __start_cc_report 07:25:35 INFO - PROCESS | 3830 | _x_x_mozilla_cycle_collect,1668 07:25:35 INFO - PROCESS | 3830 | __end_cc_report 07:25:35 INFO - PROCESS | 3830 | __startTimestamp1470407135794__endTimestamp 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | ------- Summary: start ------- 07:25:35 INFO - PROCESS | 3830 | Number of tests: 14 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:1.12 07:25:35 INFO - PROCESS | 3830 | Values: 101.0 113.0 111.0 110.0 113.0 112.0 111.0 111.0 111.0 110.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:131.50 stddev:24.16 (18.4%) stddev-sans-first:25.43 07:25:35 INFO - PROCESS | 3830 | Values: 143.0 117.0 119.0 188.0 118.0 120.0 147.0 116.0 158.0 119.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 07:25:35 INFO - PROCESS | 3830 | Values: 160.0 160.0 160.0 161.0 161.0 160.0 161.0 160.0 161.0 161.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:12.86 (17.1%) stddev-sans-first:13.43 07:25:35 INFO - PROCESS | 3830 | Values: 75.0 77.0 73.0 109.0 77.0 76.0 75.0 75.0 102.0 75.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.00 stddev:20.07 (23.9%) stddev-sans-first:20.78 07:25:35 INFO - PROCESS | 3830 | Values: 84.0 84.0 114.0 83.0 84.0 84.0 129.0 85.0 85.0 131.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:25:35 INFO - PROCESS | 3830 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 116.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 07:25:35 INFO - PROCESS | 3830 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:25:35 INFO - PROCESS | 3830 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:3.37 (6.6%) stddev-sans-first:3.54 07:25:35 INFO - PROCESS | 3830 | Values: 50.0 51.0 50.0 50.0 51.0 61.0 50.0 51.0 50.0 51.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.25 (2.1%) stddev-sans-first:1.27 07:25:35 INFO - PROCESS | 3830 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 60.0 63.0 61.0 60.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.00 stddev:3.54 (4.6%) stddev-sans-first:3.74 07:25:35 INFO - PROCESS | 3830 | Values: 77.0 86.0 79.0 76.0 76.0 76.0 75.0 77.0 75.0 82.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:134.00 stddev:6.60 (4.9%) stddev-sans-first:6.98 07:25:35 INFO - PROCESS | 3830 | Values: 132.0 132.0 136.0 136.0 128.0 123.0 120.0 138.0 138.0 124.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:2.06 (1.3%) stddev-sans-first:1.94 07:25:35 INFO - PROCESS | 3830 | Values: 164.0 165.0 161.0 161.0 161.0 161.0 162.0 159.0 158.0 161.0 07:25:35 INFO - PROCESS | 3830 | 07:25:35 INFO - PROCESS | 3830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:2.15 (3.3%) stddev-sans-first:2.26 07:25:35 INFO - PROCESS | 3830 | Values: 66.0 64.0 66.0 67.0 70.0 64.0 63.0 65.0 63.0 64.0 07:25:35 INFO - PROCESS | 3830 | -------- Summary: end -------- 07:25:35 INFO - PROCESS | 3830 | 07:25:36 INFO - TEST-INFO | 3830: exit 0 07:25:36 INFO - TEST-OK | kraken | took 60992ms 07:25:36 INFO - SUITE-END | took 1180s 07:25:36 INFO - Completed test suite (00:19:40) 07:25:36 INFO - javascript benchmark 07:25:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.954445683315, 3077.1999280187147, 3083.352495975845, 3116.3144108296196, 3128.9687103128977, 5233.3981592116825, 5281.366236051679, 5308.0, 5393.919091213635, 5402.135658294674, 5281.656692314997, 5292.3913749918775, 5305.8938821223555, 5338.412774594792, 5353.7590808413615, 4776.044791041797, 4848.7090774553635, 4862.367892174012, 4873.171560834667, 5006.349174607296, 4927.260910863363, 4951.084049450845, 4978.55193032627, 4991.850244492671, 5001.949980500185, 4779.880502987436, 4854.320395144648, 4886.804527818883, 4896.069746748107, 4960.801567937297, 4847.054824309261, 4867.780949857265, 4873.31773551703, 4941.654084214107, 4982.0, 4855.465898751135, 4907.607391408679, 4919.065377578248, 4955.801767929279, 4993.625478089158, 5215.426303106655, 5263.921041184385, 5324.281222035014, 5376.91934620981, 5395.5953303502, 5684.602077854552, 5746.597738158331, 5798.768049278024, 5800.622959507661, 5802.97098514509, 5758.165066065439, 5775.27809023872, 5811.331696854873, 5823.2138661280605, 5827.854303642401, 5259.316288882459, 5313.335833020834, 5364.061289274361, 5374.086405311106, 5414.91877621836, 5932.644041357532, 5970.402959703995, 5977.372375900555, 5981.551383646244, 5983.0, 5727.427257274239, 5737.426257374313, 5748.626339287933, 5749.827505174768, 5753.424657534213, 5555.861103472364, 5579.525740312038, 5617.129344951539, 5626.943730562723, 5809.88380232393, 5633.492985631231, 5635.126555383922, 5636.436356364413, 5641.661500309994, 5686.658800471985, 5571.526420254243, 5616.775328986795, 5617.185508101385, 5625.184348269478, 5631.633943793722, 4324.891877703019, 4342.5006124296115, 4347.021920068023, 4368.322909948963, 4419.823207071746, 3962.5443074046852, 3970.3250447424007, 3986.4219688145636, 3987.3420885554137, 3988.8205030773684, 5402.216678581583, 5409.702466364388, 5448.237246785453, 5448.754806033738, 5495.697736624444, 5818.301803783488, 5820.505257053198, 5822.097574875901, 5825.621334613236, 5869.06095024794, 5442.482964118402, 5478.972605136949, 5485.0949593317455, 5486.890262194734, 5491.560675146058, 4772.809087636456, 4891.364122664031, 4913.877153071202, 4921.5078492151215, 4933.136701077297, 5952.166696662471, 5953.672548009815, 5959.910601340984, 5960.046392577166, 5997.250343707036, 5674.971625142013, 5773.22061521706, 5790.7973220937065, 5791.420857914175, 5794.855128621818, 5722.799702010409, 5897.469227769521, 5954.821355359346, 5969.880602388015, 5976.402359764163, 5686.857828554319, 5690.544756419559, 5708.686022268815, 5711.057675483498, 5763.106718458645, 5799.101139323411, 5802.390748971297, 5804.883902322014, 5810.796622118206, 5813.302403711582, 5401.864953376197, 5581.665100094007, 5610.579206559442, 5633.352164501135, 5653.434656534314, 5674.886502270014, 5676.9432305678065, 5676.9716151420635, 5687.630304030225, 5727.713614319184, 5594.86012849682, 5675.205471233948, 5676.0, 5676.262085928968, 5680.602357834912, 5401.081816091195, 5559.72201389937, 5617.775288988558, 5627.606067575231, 5757.91363129545, 5524.723763811713, 5527.613067085265, 5529.529989950899, 5536.7231638418725, 5566.749496272597], "value": 5300.759153236728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6656672563187, 567.9403662615425, 585.2304219950767, 591.2874985642302, 618.1500436899264, 43512.34731479026, 45090.09819803606, 45096.3235551467, 45136.0, 49162.0, 47992.52007479924, 48444.0, 48455.51544484554, 48492.51507484924, 48499.75750121244, 9006.774830629238, 9129.22401595865, 9146.908530914705, 9147.862782058275, 9155.633774649006, 9056.909430905705, 9148.817023659523, 9150.0, 9152.588133533975, 9158.313126515504, 9154.404963677373, 9190.035046320107, 9193.816123677523, 9196.908030919705, 9200.769980750501, 9156.130167634064, 9169.312301577409, 9195.494247816367, 9196.0, 9202.03378645246, 9049.321300902393, 9093.499857507835, 9107.043760405195, 9114.270858331318, 9117.407368521091, 43827.12345753067, 43886.56113438857, 44044.0, 44186.779066104464, 44231.0, 3720.21875406165, 3723.7951912644794, 3732.216234590739, 3806.9809650951843, 4138.089620283563, 33212.50181247283, 33770.662293377, 34046.0, 34164.48753268703, 34687.30625387478, 4374.9781251093855, 4385.320275357325, 4532.252178390561, 4597.977010114928, 4601.7699115044115, 371920.0, 371980.0, 373248.0, 374095.99999999726, 374367.0, 59166.70416647889, 59191.0, 59413.405865941655, 59483.70258148682, 59515.40484595099, 54344.65242780568, 55261.44738552644, 60212.69893650504, 61448.692756536824, 61510.38489615046, 16435.26041328143, 16597.58506037359, 16613.0, 16669.33322667104, 16706.49880503587, 12975.675608109685, 13097.148685335613, 13108.606741797761, 13135.802962955564, 13138.146020508637, 14911.478098266509, 16315.0, 16546.7661865649, 16876.15619219034, 16997.150142493072, 6102.328743838174, 6351.333110023381, 6412.23053233615, 6500.627271046129, 6516.902246466307, 928.972130836076, 999.575180548264, 1008.8436292374694, 1073.903348698621, 1112.6662001399548, 33625.49561756527, 34006.48990265148, 34238.82880585581, 35062.82468587641, 35610.465843012375, 1036.891126431729, 1056.6143357674548, 1082.6427278997912, 1102.509383324413, 1180.9763804723857, 17049.48851534456, 17064.31742730277, 17176.711746619054, 17178.914105429394, 17198.74201886973, 509004.0, 512689.0, 513337.0, 515198.0, 515751.0, 58561.41438585645, 58587.70706146442, 58609.41390586125, 58703.0, 58874.0, 1308.3458270864567, 1351.8445378781566, 1352.4387379237703, 1364.9181049137082, 1370.294298436306, 30894.53658195084, 31887.52168717425, 32581.18547036343, 32632.83683581567, 32933.50599741054, 52667.0, 53019.20471193012, 53023.73488132535, 53240.0, 53338.0, 416970.0, 417749.0, 418664.0, 418858.0, 418923.0, 24758.628620571068, 27459.0, 28282.71717282883, 28308.0, 28556.572691320638, 46374.53625463837, 47130.528694712615, 47228.291575625706, 48182.75908620434, 48230.0, 39125.08749125065, 40166.598334016286, 41024.08167131153, 41284.0, 41578.0, 39613.40579891361, 39684.0, 40032.0, 40502.1899562013, 41156.58843411528, 40687.38968915409, 40928.79535602303, 41120.0, 42076.78961605173, 42725.1454970905, 34865.0, 37300.0, 37571.812140940216, 38393.0, 38699.806500967316, 28873.85563072171, 29422.0, 29431.0, 29516.409671806014, 35575.46636800502], "value": 20318.72292206462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.5549673636739, 382.2526959793604, 395.3516233377261, 396.67869026088863, 420.47440699126093, 14303.713925721479, 17249.482515524523, 18754.812451875478, 20481.487962800937, 20488.975551222436, 16207.675846483064, 17054.74417883733, 19557.706634400496, 19656.0, 20483.283085092025, 5677.517411020068, 5847.830433913213, 5861.267341582302, 5881.147233651118, 5883.705814709268, 5623.99999999998, 5747.080467125261, 5761.596688231825, 5840.795572154975, 5854.941450585482, 5773.191753154561, 5773.451522105393, 5774.7401366938375, 5775.624584402021, 5776.653400795965, 5563.693996830152, 5757.712114394284, 5757.769689212427, 5758.251427314464, 5801.274840644919, 5184.11869982104, 5191.0656081905245, 5194.792208311663, 5196.142636464979, 5196.792128314863, 23881.164159254517, 24065.0, 24337.269881903572, 24487.265382038568, 24763.25710228678, 2125.061673635581, 2294.9311520654405, 2476.913308034228, 2488.0669748844184, 2683.436478339551, 9962.850557241647, 10590.31162974412, 10726.624568140078, 11049.668509944715, 11200.439978001148, 1881.2851116575614, 1923.249932526316, 1942.4755316064725, 1987.2349145579055, 2057.9382618521468, 82074.58962705208, 87318.56340718319, 90540.54729726375, 90601.54699226527, 91234.5438272811, 10831.512581933832, 11160.883911608775, 11183.888161118448, 11188.832167517494, 11396.658100257006, 16246.0, 16257.67484650324, 16288.348466061461, 16289.755653665205, 16313.592160195853, 8125.187481251827, 8166.0, 8344.66621335152, 8401.495910245405, 8417.410781245377, 7996.160403157701, 8014.15851335613, 8023.558704271204, 8242.670293188205, 8263.173682631808, 4393.1872603568445, 4596.8161273548685, 4776.164171270014, 4908.239222920453, 4921.680090794087, 1900.7624046994126, 1951.9121639526256, 1968.094676448821, 2000.619882222373, 2018.3339497965635, 911.284641556375, 995.915347195482, 1038.1953985661023, 1066.2163309967168, 1091.0177850844323, 19529.414117576496, 20058.39824805258, 20210.39368818938, 20976.26583069585, 21108.82833705752, 985.074030411411, 987.4026214140341, 1009.137187704502, 1022.437659287389, 1086.1202426034938, 10634.946825265824, 11581.826272605918, 11597.942010289895, 11615.593454229062, 11641.0, 506088.0, 510380.0, 511020.0, 511360.0, 511786.0, 90856.54571727231, 92013.53993229991, 93062.0, 93111.53444232735, 94395.52802236083, 963.330485312701, 989.9455529945922, 994.865693131418, 1005.4470041477158, 1014.1126514299988, 17657.470275891745, 18152.90923545374, 18521.444356669323, 18552.536186595444, 18575.25698972026, 44598.0, 45001.12480315997, 45261.54738452574, 46826.0, 47277.0, 62961.68519157375, 62981.370186299384, 63738.0, 63823.36176638174, 64563.67718161379, 8508.361872859436, 8721.171488708562, 8935.463872167691, 8941.955290223506, 9155.771105722144, 9793.579930909837, 13285.870700990137, 14044.578662640137, 14129.152250864981, 14137.717245655234, 11700.0, 11841.23032002917, 11867.347295898464, 11910.940445298065, 12442.626721198378, 11606.361650109326, 11896.5406203401, 11912.225705329125, 12010.09924255667, 12103.0, 12129.150959432754, 12210.63368098923, 12222.327771972272, 12249.510019599116, 12518.186317889307, 8717.171868672465, 8820.514871681862, 8997.595108220277, 12128.575499857463, 12527.498900043896, 11677.474513646737, 12075.637730868088, 12345.629631111082, 12368.257904525757, 12595.433205505591], "value": 9479.940100273248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.4779935825036, 1443.8339590947037, 1518.5975716435146, 1635.517522330913, 1781.8307260810218, 8631.438956467833, 8896.199342059213, 8961.775955601113, 9195.264378849693, 9200.0, 8965.237954773853, 9095.272378209744, 9100.226480749128, 9101.63593456261, 9101.90898091019, 2076.0, 2318.142287353673, 2400.7239167495745, 2429.161939130997, 2430.586800243963, 2425.369403954967, 2461.2985299189736, 2461.852288862674, 2463.9014439422403, 2464.2237695125978, 2327.2669109230624, 2329.24299602629, 2330.9184178553755, 2335.019291897407, 2342.9765702343016, 2321.93034208974, 2385.940351491209, 2396.628522579003, 2396.6405039244078, 2408.4701365699516, 2429.27121863442, 2454.312792418108, 2454.447749256403, 2454.619533972237, 2454.950900981988, 9403.529823508865, 9492.905070949271, 9503.382280151767, 9503.667371642028, 9505.334626576143, 5330.147176451749, 5442.836714898559, 5456.563474921997, 5466.9179962300595, 5467.45325467454, 3261.983690081558, 3306.504024396336, 3403.421418358885, 3411.556497655289, 3418.06003349081, 1118.776244751045, 1135.5117299561186, 1148.5233628044434, 1165.9650210493699, 1202.0443747220893, 12886.097973141885, 12913.0, 12976.02679799019, 12980.740385192243, 13048.412821423059, 4505.752183629932, 4659.207934651117, 4682.321063445849, 4815.855524334275, 4818.951810481921, 10132.493375331203, 10147.543360548792, 10149.695509134737, 10161.593536258466, 10166.085052345325, 5343.519083282523, 5354.089804733205, 5361.463853614685, 5363.088274993261, 5365.812196573102, 4451.0, 4936.75316234194, 4965.255211718199, 4966.875828104254, 5069.518395752398, 3797.7531460454984, 3871.535415750128, 3981.820818063194, 3987.322155233617, 4074.3481043033566, 1084.3981590217347, 1092.1754075672816, 1112.2547892911607, 1159.6579009192308, 1160.5299853559322, 936.5925822267335, 951.833429149896, 956.9043095690514, 968.6754937096151, 980.9754756131011, 6072.210612620331, 6085.756569737249, 6151.046587778901, 6252.937470625327, 6330.905036424458, 466.97898594563327, 467.0332411907387, 470.1326053431482, 474.40462219913786, 475.78114067528634, 4297.162053399557, 4344.304911214191, 4468.285074388083, 4509.6392288616835, 4620.930686039712, 11475.942620286845, 11584.189106762615, 11719.941400292944, 11722.355270460035, 11749.706257343634, 11615.128865335133, 11653.41732913351, 11653.708657283636, 11670.474828632732, 11674.591389301333, 8153.918460815435, 8462.492250464991, 8481.194286542768, 8486.0, 8489.95755021221, 6310.337414571588, 6375.330590288138, 6423.389777971085, 6464.838379040561, 6617.94843598486, 10309.0, 10382.42896640692, 10598.576056957636, 10833.133349331876, 10843.295185812896, 10572.471376430994, 10764.730881728019, 10781.867903869981, 10884.0, 10993.120550356112, 7193.244709305657, 7560.168381478143, 8190.180981901762, 8395.034571024411, 8406.411551191359, 8514.0, 8841.955790221007, 8845.557722113997, 8886.200241978253, 8886.777830554287, 7682.884756728766, 7821.061472623322, 7903.84192316139, 8061.314788243065, 8227.259546640831, 7810.414218933489, 7854.4894581851995, 8198.795030124294, 8211.58942052907, 8247.711330103417, 7050.612216328152, 7196.388306993964, 7201.459890508128, 7213.314735100157, 7214.098237720285, 5281.181416880389, 5364.892702145858, 5478.80824171168, 5551.472610102034, 5627.634203776742, 5563.666180029211, 5673.34756502991, 5684.545236380997, 5706.514946229617, 5784.8553786154], "value": 4690.6529595433385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.2583741127056, 335.43479237484837, 339.31627770043366, 341.1097036734122, 341.61056395708897, 5110.8977820443615, 5197.168453047513, 5213.895722085556, 5234.0, 5252.579793616511, 5139.841266667999, 5155.922661160085, 5164.561012313958, 5171.250168725533, 5172.172452407615, 4135.855245066423, 4143.399207114967, 4154.688398370119, 4155.958440415602, 4174.893653181909, 3915.530136383638, 3924.489816323888, 4123.773192474413, 4138.855140070098, 4160.3135482645475, 4106.77412742299, 4113.753174809506, 4130.772807495587, 4131.421600975851, 4135.441715368417, 4050.10897602527, 4107.350758760613, 4108.404281379198, 4113.1568028554075, 4138.358554424069, 3427.725781937439, 3529.29414117175, 3604.567451905762, 3618.4572314152824, 3622.6920711739535, 5036.84889453317, 5047.747612619354, 5052.898942021139, 5070.366204224472, 5110.207917772751, 4603.8158473661015, 4647.279671650899, 4671.346011558385, 4683.250679891201, 4686.835960741392, 5250.369955605352, 5358.2498450217, 5377.489138531833, 5387.299651045379, 5402.189671549259, 3974.6224108709625, 3987.6610488108545, 3998.960010399917, 4000.179963107556, 4004.0990777075217, 5618.7805816702585, 5659.943400566024, 5686.147077938301, 5711.314642242916, 5726.3414707308775, 3913.158670885773, 4003.819828107742, 4063.227986682521, 4082.1631565528996, 4085.9591404086173, 4143.4199212110325, 4144.129732756155, 4157.443172448922, 4160.812763425653, 4170.854020109342, 4703.412073490814, 4704.717716936994, 4715.976420117878, 4716.127516409407, 4723.574878260973, 5319.696674314818, 5420.24116623673, 5428.6199966002005, 5434.0, 5434.901450168493, 1408.1551069358304, 1420.6448387903024, 1429.1925062339744, 1429.5568373804153, 1432.2337549411016, 906.3700727994112, 936.8173206224857, 947.6872632031414, 953.3279038277998, 957.3394357893031, 4727.220008698595, 4730.8711080013445, 4760.619150467955, 5090.669106508065, 5168.173092305213, 5499.587530935196, 5516.641418307797, 5517.36550296713, 5561.0, 5567.860803479864, 5309.301023672465, 5329.9467005330225, 5334.8933021340135, 5335.0, 5345.786168553214, 2838.4465029319085, 2924.903161314507, 2928.5607158925905, 2952.660444048962, 2958.763298936123, 5766.250387449605, 5771.163181338767, 5775.21723271258, 5777.220075289866, 5791.507721843606, 5480.588955828329, 5707.029804933171, 5723.341815691166, 5746.138079288056, 5750.568707346965, 5802.883942321215, 5804.912926306109, 5811.79658711943, 5845.590808643524, 5847.970760146172, 5626.324841019104, 5627.352854421794, 5644.109223410203, 5663.801766938137, 5693.9715301424885, 5394.433584473731, 5519.31008623922, 5543.113101903676, 5560.36055853582, 5564.387917329172, 5795.536357091507, 5825.300963884361, 5830.883382332415, 5837.270341207349, 5859.9121013183985, 3973.4238535412783, 4003.499562554681, 4006.459128017797, 4026.416169655325, 4028.274910516135, 5566.805161819317, 5628.380878103487, 5688.715564221855, 5698.0598201296325, 5715.342735585461, 5442.972785136049, 5465.781368745205, 5492.313460817398, 5527.0, 5543.0, 5298.549623282064, 5472.50747432733, 5490.835274941758, 5495.807646732345, 5496.615236933376, 5411.972940135274, 5459.535939445032, 5472.808451704172, 5478.972605136949, 5479.424660410599, 5312.787488500417, 5417.239397195848, 5483.654970467932, 5505.697186654773, 5526.849695673428, 4878.707277563216, 5271.288376069335, 5287.312649355559, 5399.190121481809, 5406.0], "value": 4181.062781898388, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.5371469688794, 755.9659815308307, 756.6254703921558, 810.4407958508625, 883.748131782442, 15448.845511544881, 16553.33786648534, 16687.499375018768, 16812.32750689974, 16861.156942152887, 14629.122252664822, 14902.776458353133, 15386.0, 15511.0, 15569.143697096655, 797.9481333713304, 821.080389963242, 823.5470491229829, 823.6869989404018, 824.1428913929506, 667.6528205333248, 794.6265255330014, 818.8730746734266, 821.9342452603777, 827.3215962910416, 862.525610913998, 865.7013330401033, 865.7922098696331, 866.4757821517985, 866.7183165471215, 843.3843294395065, 849.587949844325, 855.8844555984956, 856.9485830850138, 859.5315553023618, 509.38110196111904, 518.9662671926312, 519.6803965561153, 612.5099920063931, 625.5027253333566, 15169.848301516953, 15174.924125379413, 15217.0, 15225.771613425808, 15227.314770835339, 13764.967627427983, 13945.093568917988, 14199.361028753627, 14312.928435357757, 14662.780058299135, 13437.395317210749, 13600.591982240549, 13646.181229126285, 13698.315084245747, 14356.497522586764, 4352.185820973684, 4378.62781663559, 4394.143142087294, 4445.066536027438, 4451.421315228999, 65127.3487265126, 68068.3193168067, 68506.65746671284, 85168.0, 86506.5674671629, 11778.646640600795, 11888.881111188777, 11965.940170299093, 12391.946684531735, 12779.361031948365, 21370.358889233346, 21407.143714251255, 21465.0, 21517.246896358552, 21626.459338516663, 8828.51443170619, 8933.240674542607, 8956.0, 9060.411073280347, 9282.582283797245, 4477.1362264564805, 4630.6758526902795, 4686.343911852344, 4931.457539670633, 5057.519535644108, 3571.910702232413, 3701.925961480755, 3708.1100535871738, 3711.31340701971, 3724.776513409204, 522.6944947133464, 620.9037599172135, 629.3957800511561, 630.0360448513782, 630.7949916277229, 649.143131066987, 652.4682383857141, 693.7883945396702, 695.9478039147084, 705.3933617089299, 8579.613917373734, 9305.302102342352, 9900.752481188028, 10007.749806254902, 10177.643782467578, 545.2067242162723, 580.94771470567, 591.3111225422421, 601.9345758008388, 606.9802731411271, 4568.383268258809, 4646.4191976003, 4668.136394766979, 4754.453237877619, 4805.8558243252055, 98618.0, 99776.5011174954, 100819.0, 130686.0, 135274.3236283832, 91601.0, 97074.0, 97664.51167744258, 97783.51108244414, 98913.50543247382, 83589.58205209057, 84500.0, 88377.0, 93254.53372733093, 95579.52210239043, 9563.426194428357, 9920.20638348916, 10318.17454603645, 10634.840477393, 10825.56697732082, 40124.0, 42553.787231063645, 43509.564904350555, 46896.531034689215, 47574.76212618915, 52663.21005184849, 75186.0, 77309.0, 78864.60567697124, 79514.60242698749, 12322.81515777282, 12605.49578016869, 12677.556285529961, 12852.485900563872, 13738.793918091436, 14800.62998425048, 15276.770848437505, 15307.923460383072, 15492.612684682974, 15689.764653529977, 14500.709985800437, 14809.562298244255, 14919.701605968037, 15135.0, 15338.0, 7223.0, 13746.793798092836, 13960.441582336593, 14279.857201428269, 14568.198749068903, 14008.869509204216, 14267.64330891736, 14547.490837820626, 14835.480758173844, 15314.923425382802, 11667.299962002307, 11884.108691847972, 12155.878441215475, 12162.209456385306, 12677.936610316889, 12699.174553653984, 12743.299118548568, 12767.170133941636, 13117.540886068942, 13207.537736179187], "value": 7644.291524880356, "unit": "score"}], "name": "dromaeo_css", "value": 7314.038388939372, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 110.0, 113.0, 112.0, 111.0, 111.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 119.0, 188.0, 118.0, 120.0, 147.0, 116.0, 158.0, 119.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 73.0, 109.0, 77.0, 76.0, 75.0, 75.0, 102.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 83.0, 84.0, 84.0, 129.0, 85.0, 85.0, 131.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 51.0, 61.0, 50.0, 51.0, 50.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 63.0, 61.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 79.0, 76.0, 76.0, 76.0, 75.0, 77.0, 75.0, 82.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 136.0, 136.0, 128.0, 123.0, 120.0, 138.0, 138.0, 124.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 161.0, 161.0, 161.0, 161.0, 162.0, 159.0, 158.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 67.0, 70.0, 64.0, 63.0, 65.0, 63.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1488.0000000000002, "alertThreshold": 2.0}]} 07:25:37 INFO - Return code: 0 07:25:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:25:37 INFO - # TBPL SUCCESS # 07:25:37 INFO - Running post-action listener: _resource_record_post_action 07:25:37 INFO - [mozharness: 2016-08-05 14:25:37.094231Z] Finished run-tests step (success) 07:25:37 INFO - Running post-run listener: _resource_record_post_run 07:25:37 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7630848; Write bytes: 424562688; Read time: 816; Write time: 377256 07:25:37 INFO - TinderboxPrint: CPU usage
13.0% 07:25:37 INFO - TinderboxPrint: I/O read bytes / time
7,630,848 / 816 07:25:37 INFO - TinderboxPrint: I/O write bytes / time
424,562,688 / 377,256 07:25:37 INFO - TinderboxPrint: CPU idle
8,311.4 (87.0%) 07:25:37 INFO - TinderboxPrint: CPU user
1,194.6 (12.5%) 07:25:37 INFO - TinderboxPrint: Swap in / out
0 / 0 07:25:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4939776; Read time: 0; Write time: 556 07:25:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 5390336; Write bytes: 419622912; Read time: 660; Write time: 376700 07:25:37 INFO - Running post-run listener: _upload_blobber_files 07:25:37 INFO - Blob upload gear active. 07:25:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:25:37 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 07:25:37 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'] 07:25:37 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 07:25:38 INFO - (blobuploader) - INFO - Open directory for files ... 07:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:38 INFO - (blobuploader) - INFO - Done attempting. 07:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:42 INFO - (blobuploader) - INFO - Done attempting. 07:25:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:25:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:25:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:43 INFO - (blobuploader) - INFO - Done attempting. 07:25:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:25:43 INFO - Return code: 0 07:25:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:25:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:25:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccf0d4b123f915b6d6737a28597f5555cb391962efd3855b9e9dc9c6c2443c1891a68b475b0f63df0ec64cc6a878eaede6e0132a201a14f81c831a68e48e80af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b784e142a23fa06297e8bd4d28bbde75ed7fb4d2b539537480517899e472ab2fab9088523ccea5d2c435a3a5e16024db312b632b94735efd2ce0124a3d52124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2527ecbacaa1b2832c4a5dbbf066a648c0466160d364d61ac00edc85e49c90e30a95ce7415d161fc3f2911c9b66666c327d6a6681fdeaa886ecafaa16e282954"} 07:25:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:25:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:25:43 INFO - Contents: 07:25:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccf0d4b123f915b6d6737a28597f5555cb391962efd3855b9e9dc9c6c2443c1891a68b475b0f63df0ec64cc6a878eaede6e0132a201a14f81c831a68e48e80af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b784e142a23fa06297e8bd4d28bbde75ed7fb4d2b539537480517899e472ab2fab9088523ccea5d2c435a3a5e16024db312b632b94735efd2ce0124a3d52124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2527ecbacaa1b2832c4a5dbbf066a648c0466160d364d61ac00edc85e49c90e30a95ce7415d161fc3f2911c9b66666c327d6a6681fdeaa886ecafaa16e282954"} 07:25:43 INFO - Running post-run listener: copy_logs_to_upload_dir 07:25:43 INFO - Copying logs to upload dir... 07:25:43 INFO - mkdir: /builds/slave/test/build/upload/logs 07:25:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.441891 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-05 07:25:43.418898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 07:25:43.422767) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020 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/ccf0d4b123f915b6d6737a28597f5555cb391962efd3855b9e9dc9c6c2443c1891a68b475b0f63df0ec64cc6a878eaede6e0132a201a14f81c831a68e48e80af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b784e142a23fa06297e8bd4d28bbde75ed7fb4d2b539537480517899e472ab2fab9088523ccea5d2c435a3a5e16024db312b632b94735efd2ce0124a3d52124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2527ecbacaa1b2832c4a5dbbf066a648c0466160d364d61ac00edc85e49c90e30a95ce7415d161fc3f2911c9b66666c327d6a6681fdeaa886ecafaa16e282954"} build_url:https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/NNCW-myGQSO7ojJCu9U8HQ/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/ccf0d4b123f915b6d6737a28597f5555cb391962efd3855b9e9dc9c6c2443c1891a68b475b0f63df0ec64cc6a878eaede6e0132a201a14f81c831a68e48e80af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b784e142a23fa06297e8bd4d28bbde75ed7fb4d2b539537480517899e472ab2fab9088523ccea5d2c435a3a5e16024db312b632b94735efd2ce0124a3d52124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2527ecbacaa1b2832c4a5dbbf066a648c0466160d364d61ac00edc85e49c90e30a95ce7415d161fc3f2911c9b66666c327d6a6681fdeaa886ecafaa16e282954"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 07:25:43.447892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:25:43.448218) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470399448.6616-1866580020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004340 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 07:25:43.531072) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 07:25:43.531775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 07:25:43.532133) ========= ========= Total master_lag: 0.19 =========