builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1472657387.97 results: success (0) buildid: 20160831071821 builduid: 804201f0574d47f18d3bc97227aeab0d revision: 06bf533a2bdd67ad7c4c051a9b96804f7826d378 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:47.973953) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:47.974441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:47.974762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:47.993520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:47.993810) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 08:29:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-08-31 08:29:48 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.083806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.084124) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.134002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.134369) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 06bf533a2bdd67ad7c4c051a9b96804f7826d378 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 06bf533a2bdd67ad7c4c051a9b96804f7826d378 --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=4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 08:29:48,480 truncating revision to first 12 chars 2016-08-31 08:29:48,480 Setting DEBUG logging. 2016-08-31 08:29:48,480 attempt 1/10 2016-08-31 08:29:48,480 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/06bf533a2bdd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 08:29:48,757 unpacking tar archive at: autoland-06bf533a2bdd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560911 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.708859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.709193) ========= script_repo_revision: 06bf533a2bdd67ad7c4c051a9b96804f7826d378 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.709583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.709850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 08:29:48.719455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-31 08:29:48.719854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:49 INFO - MultiFileLogger online at 20160831 08:29:49 in /builds/slave/test 08:29:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 08:29:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:29:49 INFO - {'append_to_log': False, 08:29:49 INFO - 'base_work_dir': '/builds/slave/test', 08:29:49 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:29:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:29:49 INFO - 'branch': 'Autoland-Non-PGO', 08:29:49 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:49 INFO - 'config_files': ('talos/linux_config.py',), 08:29:49 INFO - 'default_actions': ('clobber', 08:29:49 INFO - 'read-buildbot-config', 08:29:49 INFO - 'download-and-extract', 08:29:49 INFO - 'populate-webroot', 08:29:49 INFO - 'create-virtualenv', 08:29:49 INFO - 'install', 08:29:49 INFO - 'run-tests'), 08:29:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:49 INFO - 'download_minidump_stackwalk': True, 08:29:49 INFO - 'download_symbols': 'ondemand', 08:29:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:49 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:49 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:49 INFO - 'installer_path': 'installer.exe', 08:29:49 INFO - 'log_level': 'info', 08:29:49 INFO - 'log_name': 'talos', 08:29:49 INFO - 'log_to_console': True, 08:29:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:49 INFO - 'opt_config_files': (), 08:29:49 INFO - 'pip_index': False, 08:29:49 INFO - 'sps_profile': False, 08:29:49 INFO - 'sps_profile_interval': 0, 08:29:49 INFO - 'suite': 'dromaeojs', 08:29:49 INFO - 'system_bits': '32', 08:29:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:49 INFO - 'title': 'talos-linux64-ix-030', 08:29:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:49 INFO - 'use_talos_json': True, 08:29:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:29:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:49 INFO - 'work_dir': 'build'} 08:29:49 INFO - [mozharness: 2016-08-31 15:29:49.165488Z] Running clobber step. 08:29:49 INFO - Running pre-action listener: _resource_record_pre_action 08:29:49 INFO - Running main action method: clobber 08:29:49 INFO - rmtree: /builds/slave/test/build 08:29:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:29:49 INFO - Running post-action listener: _resource_record_post_action 08:29:49 INFO - [mozharness: 2016-08-31 15:29:49.636560Z] Finished clobber step (success) 08:29:49 INFO - [mozharness: 2016-08-31 15:29:49.636663Z] Running read-buildbot-config step. 08:29:49 INFO - Running pre-action listener: _resource_record_pre_action 08:29:49 INFO - Running main action method: read_buildbot_config 08:29:49 INFO - Using buildbot properties: 08:29:49 INFO - { 08:29:49 INFO - "project": "", 08:29:49 INFO - "product": "firefox", 08:29:49 INFO - "script_repo_revision": "production", 08:29:49 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:29:49 INFO - "repository": "", 08:29:49 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:29:49 INFO - "buildid": "20160831071821", 08:29:49 INFO - "pgo_build": "False", 08:29:49 INFO - "basedir": "/builds/slave/test", 08:29:49 INFO - "buildnumber": 366, 08:29:49 INFO - "slavename": "talos-linux64-ix-030", 08:29:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:29:49 INFO - "platform": "ubuntu64_hw", 08:29:49 INFO - "scheduler": "tests-autoland-linux64-talos", 08:29:49 INFO - "branch": "autoland", 08:29:49 INFO - "repo_path": "integration/autoland", 08:29:49 INFO - "revision": "06bf533a2bdd67ad7c4c051a9b96804f7826d378", 08:29:49 INFO - "stage_platform": "linux64", 08:29:49 INFO - "builduid": "804201f0574d47f18d3bc97227aeab0d", 08:29:49 INFO - "slavebuilddir": "test" 08:29:49 INFO - } 08:29:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:29:49 INFO - Running post-action listener: _resource_record_post_action 08:29:49 INFO - [mozharness: 2016-08-31 15:29:49.639109Z] Finished read-buildbot-config step (success) 08:29:49 INFO - [mozharness: 2016-08-31 15:29:49.639199Z] Running download-and-extract step. 08:29:49 INFO - Running pre-action listener: _resource_record_pre_action 08:29:49 INFO - Running main action method: download_and_extract 08:29:49 INFO - mkdir: /builds/slave/test/build/tests 08:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:49 INFO - trying https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:29:49 INFO - Downloading https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:29:50 INFO - Downloaded 1361 bytes. 08:29:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:29:50 INFO - Using the following test package requirements: 08:29:50 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:29:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:29:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'jsshell-linux-x86_64.zip'], 08:29:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:29:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:29:50 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:29:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:29:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:29:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:50 INFO - trying https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:29:50 INFO - Downloading https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:29:51 INFO - Downloaded 20332247 bytes. 08:29:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:29:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:29: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')]} 08:29:56 INFO - trying https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:29:56 INFO - Downloading https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:29:56 INFO - Downloaded 20332247 bytes. 08:29:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:01 INFO - trying https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:30:01 INFO - Downloading https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:30:03 INFO - Downloaded 14413998 bytes. 08:30:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:03 INFO - trying https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:30:03 INFO - Downloading https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:30:05 INFO - Downloaded 55863296 bytes. 08:30:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:30:05 INFO - mkdir: /builds/slave/test/properties 08:30:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:30:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:30:05 INFO - Contents: 08:30:05 INFO - build_url:https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:30:06 INFO - Running post-action listener: _resource_record_post_action 08:30:06 INFO - Running post-action listener: set_extra_try_arguments 08:30:06 INFO - [mozharness: 2016-08-31 15:30:06.145767Z] Finished download-and-extract step (success) 08:30:06 INFO - [mozharness: 2016-08-31 15:30:06.145996Z] Running populate-webroot step. 08:30:06 INFO - Running pre-action listener: _resource_record_pre_action 08:30:06 INFO - Running main action method: populate_webroot 08:30:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:30:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:30:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:30:06 INFO - '--tppagecycles', 08:30:06 INFO - '7'], 08:30:06 INFO - 'tests': ['tsvgm']}}, 08:30:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:30:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:30:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:30:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:30:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['damp', 'tps']}, 08:30:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'tests': ['damp', 'tps']}, 08:30:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['dromaeo_dom']}, 08:30:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:30:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['basic_compositor_video']}, 08:30:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:30:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['a11yr', 08:30:06 INFO - 'ts_paint', 08:30:06 INFO - 'tpaint', 08:30:06 INFO - 'sessionrestore', 08:30:06 INFO - 'sessionrestore_no_auto_restore', 08:30:06 INFO - 'tabpaint']}, 08:30:06 INFO - 'other-e10s': {'tests': ['a11yr', 08:30:06 INFO - 'ts_paint', 08:30:06 INFO - 'tpaint', 08:30:06 INFO - 'sessionrestore', 08:30:06 INFO - 'sessionrestore_no_auto_restore', 08:30:06 INFO - 'tabpaint']}, 08:30:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:30:06 INFO - 'ts_paint', 08:30:06 INFO - 'tpaint', 08:30:06 INFO - 'sessionrestore', 08:30:06 INFO - 'sessionrestore_no_auto_restore', 08:30:06 INFO - 'tabpaint']}, 08:30:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:30:06 INFO - 'ts_paint', 08:30:06 INFO - 'tpaint', 08:30:06 INFO - 'sessionrestore', 08:30:06 INFO - 'sessionrestore_no_auto_restore', 08:30:06 INFO - 'tabpaint']}, 08:30:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['a11yr', 08:30:06 INFO - 'ts_paint', 08:30:06 INFO - 'tpaint', 08:30:06 INFO - 'sessionrestore', 08:30:06 INFO - 'sessionrestore_no_auto_restore', 08:30:06 INFO - 'tabpaint']}, 08:30:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['a11yr', 08:30:06 INFO - 'ts_paint', 08:30:06 INFO - 'tpaint', 08:30:06 INFO - 'sessionrestore', 08:30:06 INFO - 'sessionrestore_no_auto_restore', 08:30:06 INFO - 'tabpaint']}, 08:30:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['tsvgx', 08:30:06 INFO - 'tsvgr_opacity', 08:30:06 INFO - 'tart', 08:30:06 INFO - 'tscrollx', 08:30:06 INFO - 'cart']}, 08:30:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:30:06 INFO - 'tsvgr_opacity', 08:30:06 INFO - 'tart', 08:30:06 INFO - 'tscrollx', 08:30:06 INFO - 'cart']}, 08:30:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'talos_options': ['--disable-e10s'], 08:30:06 INFO - 'tests': ['tp5o']}, 08:30:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'tests': ['tp5o']}, 08:30:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'talos_options': ['--disable-e10s', 08:30:06 INFO - '--xperf_path', 08:30:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:06 INFO - 'tests': ['tp5n']}, 08:30:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:06 INFO - 'talos_options': ['--xperf_path', 08:30:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:06 INFO - 'tests': ['tp5n']}}, 08:30:06 INFO - 'talos.zip': {'path': '', 08:30:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:30:06 INFO - Running post-action listener: _resource_record_post_action 08:30:06 INFO - [mozharness: 2016-08-31 15:30:06.166405Z] Finished populate-webroot step (success) 08:30:06 INFO - [mozharness: 2016-08-31 15:30:06.166494Z] Running create-virtualenv step. 08:30:06 INFO - Running pre-action listener: _resource_record_pre_action 08:30:06 INFO - Running main action method: create_virtualenv 08:30:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:30:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:30:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:30:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:30:06 INFO - Using real prefix '/usr' 08:30:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:30:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:30:08 INFO - Installing pip.................done. 08:30:08 INFO - Return code: 0 08:30:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:30:08 INFO - Using env: {'DISPLAY': ':0', 08:30:08 INFO - 'HOME': '/home/cltbld', 08:30:08 INFO - 'LANG': 'en_US.UTF-8', 08:30:08 INFO - 'LANGUAGE': 'en_US:en', 08:30:08 INFO - 'LOGNAME': 'cltbld', 08:30:08 INFO - 'MAIL': '/var/mail/cltbld', 08:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:08 INFO - 'MOZ_NO_REMOTE': '1', 08:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:08 INFO - 'NO_EM_RESTART': '1', 08:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:08 INFO - 'PWD': '/builds/slave/test', 08:30:08 INFO - 'SHELL': '/bin/bash', 08:30:08 INFO - 'SHLVL': '1', 08:30:08 INFO - 'TERM': 'linux', 08:30:08 INFO - 'TMOUT': '86400', 08:30:08 INFO - 'USER': 'cltbld', 08:30:08 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:08 INFO - '_': '/tools/buildbot/bin/python'} 08:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:30:08 INFO - Cleaning up... 08:30:08 INFO - Return code: 0 08:30:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:30:08 INFO - Using env: {'DISPLAY': ':0', 08:30:08 INFO - 'HOME': '/home/cltbld', 08:30:08 INFO - 'LANG': 'en_US.UTF-8', 08:30:08 INFO - 'LANGUAGE': 'en_US:en', 08:30:08 INFO - 'LOGNAME': 'cltbld', 08:30:08 INFO - 'MAIL': '/var/mail/cltbld', 08:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:08 INFO - 'MOZ_NO_REMOTE': '1', 08:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:08 INFO - 'NO_EM_RESTART': '1', 08:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:08 INFO - 'PWD': '/builds/slave/test', 08:30:08 INFO - 'SHELL': '/bin/bash', 08:30:08 INFO - 'SHLVL': '1', 08:30:08 INFO - 'TERM': 'linux', 08:30:08 INFO - 'TMOUT': '86400', 08:30:08 INFO - 'USER': 'cltbld', 08:30:08 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:08 INFO - '_': '/tools/buildbot/bin/python'} 08:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:09 INFO - Downloading/unpacking psutil>=3.1.1 08:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:30:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:11 INFO - Installing collected packages: psutil 08:30:11 INFO - Running setup.py install for psutil 08:30:11 INFO - building 'psutil._psutil_linux' extension 08:30:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:30:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:30:11 INFO - building 'psutil._psutil_posix' extension 08:30:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:30:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:30:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:11 INFO - Successfully installed psutil 08:30:11 INFO - Cleaning up... 08:30:11 INFO - Return code: 0 08:30:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:11 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:30:11 INFO - Using env: {'DISPLAY': ':0', 08:30:11 INFO - 'HOME': '/home/cltbld', 08:30:11 INFO - 'LANG': 'en_US.UTF-8', 08:30:11 INFO - 'LANGUAGE': 'en_US:en', 08:30:11 INFO - 'LOGNAME': 'cltbld', 08:30:11 INFO - 'MAIL': '/var/mail/cltbld', 08:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:11 INFO - 'MOZ_NO_REMOTE': '1', 08:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:11 INFO - 'NO_EM_RESTART': '1', 08:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:11 INFO - 'PWD': '/builds/slave/test', 08:30:11 INFO - 'SHELL': '/bin/bash', 08:30:11 INFO - 'SHLVL': '1', 08:30:11 INFO - 'TERM': 'linux', 08:30:11 INFO - 'TMOUT': '86400', 08:30:11 INFO - 'USER': 'cltbld', 08:30:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:11 INFO - '_': '/tools/buildbot/bin/python'} 08:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:30:13 INFO - Installing collected packages: mozsystemmonitor 08:30:13 INFO - Running setup.py install for mozsystemmonitor 08:30:13 INFO - Successfully installed mozsystemmonitor 08:30:13 INFO - Cleaning up... 08:30:14 INFO - Return code: 0 08:30:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:14 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:30:14 INFO - Using env: {'DISPLAY': ':0', 08:30:14 INFO - 'HOME': '/home/cltbld', 08:30:14 INFO - 'LANG': 'en_US.UTF-8', 08:30:14 INFO - 'LANGUAGE': 'en_US:en', 08:30:14 INFO - 'LOGNAME': 'cltbld', 08:30:14 INFO - 'MAIL': '/var/mail/cltbld', 08:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:14 INFO - 'MOZ_NO_REMOTE': '1', 08:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:14 INFO - 'NO_EM_RESTART': '1', 08:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:14 INFO - 'PWD': '/builds/slave/test', 08:30:14 INFO - 'SHELL': '/bin/bash', 08:30:14 INFO - 'SHLVL': '1', 08:30:14 INFO - 'TERM': 'linux', 08:30:14 INFO - 'TMOUT': '86400', 08:30:14 INFO - 'USER': 'cltbld', 08:30:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:14 INFO - '_': '/tools/buildbot/bin/python'} 08:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:14 INFO - Downloading/unpacking jsonschema==2.5.1 08:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:30:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:30:16 INFO - warning: no files found matching '*.txt' 08:30:16 INFO - no previously-included directories found matching 'build' 08:30:16 INFO - no previously-included directories found matching 'dist' 08:30:16 INFO - no previously-included directories found matching '.git*' 08:30:16 INFO - Installing collected packages: jsonschema, functools32 08:30:16 INFO - Running setup.py install for functools32 08:30:16 INFO - warning: no files found matching '*.txt' 08:30:16 INFO - no previously-included directories found matching 'build' 08:30:16 INFO - no previously-included directories found matching 'dist' 08:30:16 INFO - no previously-included directories found matching '.git*' 08:30:16 INFO - Successfully installed jsonschema functools32 08:30:16 INFO - Cleaning up... 08:30:16 INFO - Return code: 0 08:30:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:16 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:30:16 INFO - Using env: {'DISPLAY': ':0', 08:30:16 INFO - 'HOME': '/home/cltbld', 08:30:16 INFO - 'LANG': 'en_US.UTF-8', 08:30:16 INFO - 'LANGUAGE': 'en_US:en', 08:30:16 INFO - 'LOGNAME': 'cltbld', 08:30:16 INFO - 'MAIL': '/var/mail/cltbld', 08:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:16 INFO - 'MOZ_NO_REMOTE': '1', 08:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:16 INFO - 'NO_EM_RESTART': '1', 08:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:16 INFO - 'PWD': '/builds/slave/test', 08:30:16 INFO - 'SHELL': '/bin/bash', 08:30:16 INFO - 'SHLVL': '1', 08:30:16 INFO - 'TERM': 'linux', 08:30:16 INFO - 'TMOUT': '86400', 08:30:16 INFO - 'USER': 'cltbld', 08:30:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:16 INFO - '_': '/tools/buildbot/bin/python'} 08:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:30:16 INFO - Cleaning up... 08:30:16 INFO - Return code: 0 08:30:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:16 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:30:16 INFO - Using env: {'DISPLAY': ':0', 08:30:16 INFO - 'HOME': '/home/cltbld', 08:30:16 INFO - 'LANG': 'en_US.UTF-8', 08:30:16 INFO - 'LANGUAGE': 'en_US:en', 08:30:16 INFO - 'LOGNAME': 'cltbld', 08:30:16 INFO - 'MAIL': '/var/mail/cltbld', 08:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:16 INFO - 'MOZ_NO_REMOTE': '1', 08:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:16 INFO - 'NO_EM_RESTART': '1', 08:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:16 INFO - 'PWD': '/builds/slave/test', 08:30:16 INFO - 'SHELL': '/bin/bash', 08:30:16 INFO - 'SHLVL': '1', 08:30:16 INFO - 'TERM': 'linux', 08:30:16 INFO - 'TMOUT': '86400', 08:30:16 INFO - 'USER': 'cltbld', 08:30:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:16 INFO - '_': '/tools/buildbot/bin/python'} 08:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:18 INFO - Downloading blobuploader-1.2.4.tar.gz 08:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:30:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:30:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30: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 08:30:19 INFO - Downloading docopt-0.6.1.tar.gz 08:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:30:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:30:19 INFO - Running setup.py install for blobuploader 08:30:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:30:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:30:19 INFO - Running setup.py install for requests 08:30:20 INFO - Running setup.py install for docopt 08:30:20 INFO - Successfully installed blobuploader requests docopt 08:30:20 INFO - Cleaning up... 08:30:20 INFO - Return code: 0 08:30:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:20 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:20 INFO - Using env: {'DISPLAY': ':0', 08:30:20 INFO - 'HOME': '/home/cltbld', 08:30:20 INFO - 'LANG': 'en_US.UTF-8', 08:30:20 INFO - 'LANGUAGE': 'en_US:en', 08:30:20 INFO - 'LOGNAME': 'cltbld', 08:30:20 INFO - 'MAIL': '/var/mail/cltbld', 08:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:20 INFO - 'MOZ_NO_REMOTE': '1', 08:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:20 INFO - 'NO_EM_RESTART': '1', 08:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:20 INFO - 'PWD': '/builds/slave/test', 08:30:20 INFO - 'SHELL': '/bin/bash', 08:30:20 INFO - 'SHLVL': '1', 08:30:20 INFO - 'TERM': 'linux', 08:30:20 INFO - 'TMOUT': '86400', 08:30:20 INFO - 'USER': 'cltbld', 08:30:20 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:20 INFO - '_': '/tools/buildbot/bin/python'} 08:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:20 INFO - Running setup.py (path:/tmp/pip-3gC43c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:20 INFO - Running setup.py (path:/tmp/pip-UZaKTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:20 INFO - Running setup.py (path:/tmp/pip-EtLnGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:20 INFO - Running setup.py (path:/tmp/pip-7NQJf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:20 INFO - Running setup.py (path:/tmp/pip-bQUqfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:20 INFO - Running setup.py (path:/tmp/pip-vu40hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:20 INFO - Running setup.py (path:/tmp/pip-KuyxDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:20 INFO - Running setup.py (path:/tmp/pip-Ojb1gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:21 INFO - Running setup.py (path:/tmp/pip-XBPHjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:21 INFO - Running setup.py (path:/tmp/pip-oFJb8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:21 INFO - Running setup.py (path:/tmp/pip-z8L8y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:21 INFO - Running setup.py (path:/tmp/pip-vj02Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:21 INFO - Running setup.py (path:/tmp/pip-o7Qy8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:21 INFO - Running setup.py (path:/tmp/pip-LIHp1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:21 INFO - Running setup.py (path:/tmp/pip-TMPJSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:21 INFO - Running setup.py (path:/tmp/pip-vNitET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:21 INFO - Running setup.py (path:/tmp/pip-L7qPA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:30:21 INFO - Running setup.py install for manifestparser 08:30:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:30:21 INFO - Running setup.py install for mozcrash 08:30:21 INFO - Running setup.py install for mozdebug 08:30:21 INFO - Running setup.py install for mozdevice 08:30:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Running setup.py install for mozfile 08:30:22 INFO - Running setup.py install for mozhttpd 08:30:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Running setup.py install for mozinfo 08:30:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Running setup.py install for mozInstall 08:30:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Running setup.py install for mozleak 08:30:22 INFO - Running setup.py install for mozlog 08:30:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Running setup.py install for moznetwork 08:30:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:30:22 INFO - Running setup.py install for mozprocess 08:30:22 INFO - Running setup.py install for mozprofile 08:30:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:30:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:30:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:30:23 INFO - Running setup.py install for mozrunner 08:30:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:30:23 INFO - Running setup.py install for mozscreenshot 08:30:23 INFO - Running setup.py install for moztest 08:30:23 INFO - Running setup.py install for mozversion 08:30:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:30:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:30:23 INFO - Cleaning up... 08:30:23 INFO - Return code: 0 08:30:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:23 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:23 INFO - Using env: {'DISPLAY': ':0', 08:30:23 INFO - 'HOME': '/home/cltbld', 08:30:23 INFO - 'LANG': 'en_US.UTF-8', 08:30:23 INFO - 'LANGUAGE': 'en_US:en', 08:30:23 INFO - 'LOGNAME': 'cltbld', 08:30:23 INFO - 'MAIL': '/var/mail/cltbld', 08:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:23 INFO - 'MOZ_NO_REMOTE': '1', 08:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:23 INFO - 'NO_EM_RESTART': '1', 08:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:23 INFO - 'PWD': '/builds/slave/test', 08:30:23 INFO - 'SHELL': '/bin/bash', 08:30:23 INFO - 'SHLVL': '1', 08:30:23 INFO - 'TERM': 'linux', 08:30:23 INFO - 'TMOUT': '86400', 08:30:23 INFO - 'USER': 'cltbld', 08:30:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:23 INFO - '_': '/tools/buildbot/bin/python'} 08:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:23 INFO - Running setup.py (path:/tmp/pip-GvBYHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:23 INFO - Running setup.py (path:/tmp/pip-yAkCh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:23 INFO - Running setup.py (path:/tmp/pip-lRg4vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:23 INFO - Running setup.py (path:/tmp/pip-QkSOv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:24 INFO - Running setup.py (path:/tmp/pip-tfpSGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:24 INFO - Running setup.py (path:/tmp/pip-qKrWzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:24 INFO - Running setup.py (path:/tmp/pip-UG4PBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:24 INFO - Running setup.py (path:/tmp/pip-IB93yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:24 INFO - Running setup.py (path:/tmp/pip-i2SInD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:24 INFO - Running setup.py (path:/tmp/pip-B2kWL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:24 INFO - Running setup.py (path:/tmp/pip-YtzJSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:24 INFO - Running setup.py (path:/tmp/pip-r44bpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:24 INFO - Running setup.py (path:/tmp/pip-a_Re21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:24 INFO - Running setup.py (path:/tmp/pip-ogDSw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:24 INFO - Running setup.py (path:/tmp/pip-WHZZEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:24 INFO - Running setup.py (path:/tmp/pip-4dahCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:24 INFO - Running setup.py (path:/tmp/pip-QAnVFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:30:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:26 INFO - Downloading blessings-1.6.tar.gz 08:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:30:26 INFO - Installing collected packages: blessings 08:30:26 INFO - Running setup.py install for blessings 08:30:27 INFO - Successfully installed blessings 08:30:27 INFO - Cleaning up... 08:30:27 INFO - Return code: 0 08:30:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:27 INFO - Reading from file tmpfile_stdout 08:30:27 INFO - Current package versions: 08:30:27 INFO - argparse == 1.2.1 08:30:27 INFO - blessings == 1.6 08:30:27 INFO - blobuploader == 1.2.4 08:30:27 INFO - docopt == 0.6.1 08:30:27 INFO - functools32 == 3.2.3-2 08:30:27 INFO - jsonschema == 2.5.1 08:30:27 INFO - manifestparser == 1.1 08:30:27 INFO - mozInstall == 1.12 08:30:27 INFO - mozcrash == 0.17 08:30:27 INFO - mozdebug == 0.1 08:30:27 INFO - mozdevice == 0.48 08:30:27 INFO - mozfile == 1.2 08:30:27 INFO - mozhttpd == 0.7 08:30:27 INFO - mozinfo == 0.9 08:30:27 INFO - mozleak == 0.1 08:30:27 INFO - mozlog == 3.3 08:30:27 INFO - moznetwork == 0.27 08:30:27 INFO - mozprocess == 0.23 08:30:27 INFO - mozprofile == 0.28 08:30:27 INFO - mozrunner == 6.12 08:30:27 INFO - mozscreenshot == 0.1 08:30:27 INFO - mozsystemmonitor == 0.3 08:30:27 INFO - moztest == 0.7 08:30:27 INFO - mozversion == 1.4 08:30:27 INFO - psutil == 3.1.1 08:30:27 INFO - requests == 1.2.3 08:30:27 INFO - wsgiref == 0.1.2 08:30:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:27 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:30:27 INFO - Using env: {'DISPLAY': ':0', 08:30:27 INFO - 'HOME': '/home/cltbld', 08:30:27 INFO - 'LANG': 'en_US.UTF-8', 08:30:27 INFO - 'LANGUAGE': 'en_US:en', 08:30:27 INFO - 'LOGNAME': 'cltbld', 08:30:27 INFO - 'MAIL': '/var/mail/cltbld', 08:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:27 INFO - 'MOZ_NO_REMOTE': '1', 08:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:27 INFO - 'NO_EM_RESTART': '1', 08:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:27 INFO - 'PWD': '/builds/slave/test', 08:30:27 INFO - 'SHELL': '/bin/bash', 08:30:27 INFO - 'SHLVL': '1', 08:30:27 INFO - 'TERM': 'linux', 08:30:27 INFO - 'TMOUT': '86400', 08:30:27 INFO - 'USER': 'cltbld', 08:30:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:27 INFO - '_': '/tools/buildbot/bin/python'} 08:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:30:27 INFO - Cleaning up... 08:30:27 INFO - Return code: 0 08:30:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:27 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 0x7f1deea02f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, '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': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:30:27 INFO - Using env: {'DISPLAY': ':0', 08:30:27 INFO - 'HOME': '/home/cltbld', 08:30:27 INFO - 'LANG': 'en_US.UTF-8', 08:30:27 INFO - 'LANGUAGE': 'en_US:en', 08:30:27 INFO - 'LOGNAME': 'cltbld', 08:30:27 INFO - 'MAIL': '/var/mail/cltbld', 08:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:27 INFO - 'MOZ_NO_REMOTE': '1', 08:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:27 INFO - 'NO_EM_RESTART': '1', 08:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:27 INFO - 'PWD': '/builds/slave/test', 08:30:27 INFO - 'SHELL': '/bin/bash', 08:30:27 INFO - 'SHLVL': '1', 08:30:27 INFO - 'TERM': 'linux', 08:30:27 INFO - 'TMOUT': '86400', 08:30:27 INFO - 'USER': 'cltbld', 08:30:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:27 INFO - '_': '/tools/buildbot/bin/python'} 08:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:30:27 INFO - Cleaning up... 08:30:27 INFO - Return code: 0 08:30:27 INFO - Running post-action listener: _resource_record_post_action 08:30:27 INFO - Running post-action listener: _start_resource_monitoring 08:30:27 INFO - Starting resource monitoring. 08:30:27 INFO - [mozharness: 2016-08-31 15:30:27.762022Z] Finished create-virtualenv step (success) 08:30:27 INFO - [mozharness: 2016-08-31 15:30:27.762534Z] Running install step. 08:30:27 INFO - Running pre-action listener: _resource_record_pre_action 08:30:27 INFO - Running main action method: install 08:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:27 INFO - Reading from file tmpfile_stdout 08:30:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:30:28 INFO - Reading from file tmpfile_stdout 08:30:28 INFO - Output received: 08:30:28 INFO - Usage: mozinstall [options] installer 08:30:28 INFO - Options: 08:30:28 INFO - -h, --help show this help message and exit 08:30:28 INFO - -d DEST, --destination=DEST 08:30:28 INFO - Directory to install application into. [default: 08:30:28 INFO - "/builds/slave/test"] 08:30:28 INFO - --app=APP Application being installed. [default: firefox] 08:30:28 INFO - mkdir: /builds/slave/test/build/application 08:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:30:44 INFO - Reading from file tmpfile_stdout 08:30:44 INFO - Output received: 08:30:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:30:44 INFO - Running post-action listener: _resource_record_post_action 08:30:44 INFO - [mozharness: 2016-08-31 15:30:44.200157Z] Finished install step (success) 08:30:44 INFO - [mozharness: 2016-08-31 15:30:44.200447Z] Running run-tests step. 08:30:44 INFO - Running pre-action listener: _resource_record_pre_action 08:30:44 INFO - Running main action method: run_tests 08:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:30:44 INFO - Python 2.7.3 08:30:44 INFO - Return code: 0 08:30:44 INFO - grabbing minidump binary from tooltool 08:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:44 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 0x19a2090>, '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 0x19a59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a5e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:30:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:30:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:30:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:30:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:44 INFO - Return code: 0 08:30:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:30:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:30:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:30:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:30:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:30:44 INFO - Using env: {'DISPLAY': ':0', 08:30:44 INFO - 'HOME': '/home/cltbld', 08:30:44 INFO - 'LANG': 'en_US.UTF-8', 08:30:44 INFO - 'LANGUAGE': 'en_US:en', 08:30:44 INFO - 'LOGNAME': 'cltbld', 08:30:44 INFO - 'MAIL': '/var/mail/cltbld', 08:30:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:30:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:44 INFO - 'MOZ_NO_REMOTE': '1', 08:30:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:44 INFO - 'NO_EM_RESTART': '1', 08:30:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:44 INFO - 'PWD': '/builds/slave/test', 08:30:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:30:44 INFO - 'SHELL': '/bin/bash', 08:30:44 INFO - 'SHLVL': '1', 08:30:44 INFO - 'TERM': 'linux', 08:30:44 INFO - 'TMOUT': '86400', 08:30:44 INFO - 'USER': 'cltbld', 08:30:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033', 08:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:44 INFO - '_': '/tools/buildbot/bin/python'} 08:30:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:30:44 INFO - mozversion application_buildid: 20160831071821 08:30:44 INFO - mozversion application_changeset: 06bf533a2bdd67ad7c4c051a9b96804f7826d378 08:30:44 INFO - mozversion application_display_name: Nightly 08:30:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:44 INFO - mozversion application_name: Firefox 08:30:44 INFO - mozversion application_remotingname: firefox 08:30:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:30:44 INFO - mozversion application_vendor: Mozilla 08:30:44 INFO - mozversion application_version: 51.0a1 08:30:44 INFO - mozversion platform_buildid: 20160831071821 08:30:44 INFO - mozversion platform_changeset: 06bf533a2bdd67ad7c4c051a9b96804f7826d378 08:30:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:30:44 INFO - mozversion platform_version: 51.0a1 08:30:44 INFO - using testdate: 1472657444 08:30:44 INFO - actual date: 1472657444 08:30:44 INFO - starting webserver on 'localhost:55908' 08:30:44 INFO - SUITE-START | Running 2 tests 08:30:44 INFO - TEST-START | dromaeo_css 08:30:44 INFO - operating with platform_type : linux_ 08:30:44 INFO - Initialising browser for dromaeo_css test... 08:30:44 INFO - TEST-INFO | started process 19224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpka2bgE/profile http://localhost:55908/getInfo.html) 08:30:49 INFO - PROCESS | 19224 | __metrics Screen width/height:1600/1200 08:30:49 INFO - PROCESS | 19224 | colorDepth:24 08:30:49 INFO - PROCESS | 19224 | Browser inner width/height: 1024/697 08:30:49 INFO - PROCESS | 19224 | __metrics 08:30:49 INFO - PROCESS | 19224 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:30:49 INFO - PROCESS | 19224 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:50 INFO - PROCESS | 19224 | console.error: PushService: 08:30:50 INFO - PROCESS | 19224 | stateChangeProcessEnqueue: Error transitioning state 08:30:50 INFO - PROCESS | 19224 | UnknownError 08:30:50 INFO - TEST-INFO | 19224: exit 0 08:30:50 INFO - Browser initialized. 08:30:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:50 INFO - TEST-INFO | started process 19309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpka2bgE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:03 INFO - PROCESS | 19309 | RSS: Main: 182353920 08:31:03 INFO - PROCESS | 19309 | 08:31:54 INFO - PROCESS | 19309 | 1472657514679 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:34:06 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55908/tests/dromaeo/cssquery-ext.html) 08:34:08 INFO - PROCESS | 19309 | RSS: Main: 329789440 08:34:08 INFO - PROCESS | 19309 | 08:37:11 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55908/tests/dromaeo/cssquery-ext.html (next: http://localhost:55908/tests/dromaeo/cssquery-jquery.html) 08:37:11 INFO - PROCESS | 19309 | RSS: Main: 276590592 08:37:11 INFO - PROCESS | 19309 | 08:40:14 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55908/tests/dromaeo/cssquery-mootools.html) 08:40:14 INFO - PROCESS | 19309 | RSS: Main: 218800128 08:40:14 INFO - PROCESS | 19309 | 08:43:17 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55908/tests/dromaeo/cssquery-prototype.html) 08:43:17 INFO - PROCESS | 19309 | RSS: Main: 224452608 08:43:17 INFO - PROCESS | 19309 | 08:46:20 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55908/tests/dromaeo/cssquery-yui.html) 08:46:21 INFO - PROCESS | 19309 | RSS: Main: 219582464 08:46:21 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55908/tests/dromaeo/cssquery-yui.html (next: http://localhost:55908/tests/dromaeo/cssquery-dojo.html) 08:49:24 INFO - PROCESS | 19309 | RSS: Main: 307888128 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | __start_tp_report 08:49:24 INFO - PROCESS | 19309 | _x_x_mozilla_page_load 08:49:24 INFO - PROCESS | 19309 | _x_x_mozilla_page_load_details 08:49:24 INFO - PROCESS | 19309 | |i|pagename|runs| 08:49:24 INFO - PROCESS | 19309 | |0;dojo.html;2601.505713914357;2605.996691273859;2618.633391325214;2656.203139058282;2673.8128331016824;4607.884802879929;4699.060187962404;4704.600108990731;4738.620910327174;4824.951750482494;4694.248920172773;4731.101090792747;4793;4797.496262892399;4842.8547143585665;4293.914121717564;4312.698111132222;4329.718568293067;4331.631811296028;4487.596116349528;4436.957315030965;4441.5336389679105;4442.267025940716;4449.644028477714;4465.82136714531;4247.5964783345535;4285.035866929947;4290.292101803198;4363.585459381354;4383.736975781463;4313.00800815811;4334.891627709301;4334.9783251083545;4336.132773445292;4388.846390376353;4282;4299.14017196562;4302.505211900609;4408.25059739845;4412;4750.501197374295;4765.523447655241;4766.332713420124;4777.474477807438;4779.307000484945;4960.156773348539;5023.271625614266;5104.744762761847;5111.284420181178;5165.018646457161;5091.770870310808;5110.182370820688;5118.948810511884;5120.359955005624;5147.974260128713;4736.218523943511;4744.264638980963;4758.714477131349;4826.32431459596;4826.855194344175;5073.188289873602;5175.896482070338;5227.26818245446;5235.083860324428;5238.2404551340605;5008.5993120550265;5027.4469808321055;5028.195488721787;5075.289459475676;5084.720340381315;5082.611172748802;5084.3644544431945;5088.77100530477;5094.465081166498;5150.407703114115;4847.61219102478;4993.300937868701;5002.499750024968;5012.724300163453;5031.974840125776;5064.215046667772;5064.34163558735;5067.6452648315;5110.463401342806;5127.564157046693;4261.083866968616;4268.487781466244;4268.551802060801;4318.870433886988;4320.503142138694;3694.9445758313645;3710.220853620716;3714.68425183857;3741.8129093545213;3771.6605505504635;4325.480942286946;4337.82648694055;4348.869533913988;4388.034632380871;4408.977955110268;5076.873078173001;5077.517635824591;5087.211482220262;5088.567471764942;5140.3831540215415;4264.466941632296;4295;4351.608355248043;4353.151135528541;4389.670774691911;4523.638108951276;4523.954760452353;4542.591166795004;4580.862574122782;4597.241455159928;4722.031983443318;4724.480307166277;4724.952750472451;4731.124741922756;4756.881077973078;4927.926081108714;5033.295338652519;5101.974490127525;5108.770105345194;5155.845324640267;4734.33719279308;4749.667523273338;4751.691140075884;4816.54242846929;4830.565249127595;4994.375703037121;5008.499150084962;5024.447310795883;5032.62255330859;5088.821891233937;4953;4988.6757360771435;5089.262057001788;5108.106081435808;5173.974130129325;4907.141250281258;4919.975400122977;4932.8766780830765;4972;4990.276409920469;4921.458639549718;4925.433575138905;4928.802847886188;4930.482299358516;4997.925031124609;4737.407824021997;4790.473047964651;4864;4864.537868902448;4922.507749225048;4921.26181072842;4925.950740492549;4928.975355123202;4944.802207911644;4949.30709700635;4734.431868175841;4780.306855506002;4788.545088216614;4789.736564488987;4793.496682848251 08:49:24 INFO - PROCESS | 19309 | |1;ext.html;569.3623142080869;574.8706541028266;578.0433382751545;583.4777873802943;586.2349633727983;30126.24684382889;31024.224394390152;31061.844690776572;38755.41866871999;40068.59931400685;39668;40174.397384039265;40236.79881600588;40241.19517609646;40338.59661403385;7528.84942301155;7661.195574464685;7669.884951725729;7675.3092221700035;7675.769726908202;7158.892616610755;7619.42854285928;9715.562799673997;9958.651447199349;9994.800103997952;10073.949630251838;10119.190464762838;10125.443100629462;10137.949310253476;10148.716538778752;9936.751581210456;9986.900130998669;9987.75030624233;9994.050565196367;10000.499975001258;9609.807803843954;9819.06718861707;9827.508624568743;9828.11546960777;9830.115289623896;37401;37614.24771504582;37678.623213768056;37684.24631507382;37704;3027.2885871820104;3074.3543855790313;3108.207407111172;3113.2216945763557;3148.0870547541185;27656.308592285153;27785.305367365978;28242.435151297064;28258;28984.565231521545;3343.3480471308103;3507.649235076472;3513.91215219619;3514.876979305712;3547.5033495310677;161613;162586.18706906508;162987;163074;163537;31030.22424439407;53405.465945340824;53585.46414535805;53905;53913;30947.69052309493;32398.35203295921;32523.512147317808;32762.508562371582;32803.34393312121;11669;11703.88296117045;11707.414629268502;11714.824277635842;11719.531218751325;10083.647072352433;10162.593496260215;10235.488225588691;10247.59009639621;10248.333858299187;7489;7730.729424470229;7748.147703752583;7844.843103137905;7903.328217101611;3061.448939190967;3077.1075788390426;3093.2266933266683;3096.4116817804547;3145.025042236914;851.2976794144855;881.8853549038712;895.5925054100369;949.1837020162654;953.5708930981086;26562.86718566395;27217.913871780245;27416.314592134957;27751.722482775316;27932.58101128485;914.4056363363867;934.9252059835333;943.5753910740194;965.5703212070702;1029.9751747011621;14355.78466323006;14609.196494192709;14672.486462973744;14955.925220373829;14968.251587420586;363148;367040;367084;367556;368898;46736.22324762958;47176.7641161792;47195;47245.5275447248;47328.290075648896;1074.0280046557878;1115.4367044642565;1164.4934453512749;1198.6404078776159;1202.4228370382266;26585;27703.861480692467;28314.85842570774;28937.13188604345;29023.41953160967;40250;40866.1826763469;40873;40887.18225635411;40908.18183636251;279462;279497;280354;280717;280927;37709;38563.2287354257;39203.607963919996;40777.184456311305;40977.79511102426;37609.247815044095;38625.2274954505;40582;41044.79477602593;41667.37498937458;34956.65043349534;35124.29751404907;35203.11992200215;35575.46636800398;35892.64107358893;34497.13757156091;34788.82605586956;34991.82504087463;35058.47412288767;35071.64928350786;34696;35049;35109.82445087758;35560.110997225274;36003.45994810132;29813.403731925675;31973;32119.357612848078;32404.675953240167;32764.34471310513;24930.77007667756;24969.37576560528;24970.500589988464;25132.74867251377;25452.872735636203 08:49:24 INFO - PROCESS | 19309 | |2;jquery.html;346.9427544455165;366.3625291991934;367.5130452150899;369.39419352262286;390.08719596145033;12472;15328.540143795675;15497.302621382036;16733.07968061756;16824.07467589282;14407.207603581799;14687.33906974186;14925.179115148663;15416.61458463539;15554.688906221869;4112.773797441139;4572.999999999992;4715.717056976575;4716.693414928036;4741.288806678991;4697.248440249561;4732.881677958044;4733.290006499035;4734.881627959311;4737.952620473786;4492.505824359318;4685.578297953183;4726.409198850144;4728.385309909707;4734.455537613184;4630.791614377361;4684.36761037259;4686.648501362394;4691.413573303337;4693.9061218775605;4565.497795242521;4565.794539245709;4566.931496027562;4567.474740404829;4573.405457290531;18726.438206853818;19355;19499.415017549498;20197.596048079104;20390.08244628995;1793.210987165656;1856.8143185681458;1902.543389586503;2000.2299114840891;2011.87928724277;8788.912110878873;9475.715728528156;9646.324757266993;12285.262884226886;12945.935270323682;1592.132287903084;1721.8192089830513;1732.8786984911062;1761.5508045448328;1777.7777777777778;63532.36467635311;65863;67736.32263677398;68197.27210911557;68231.317686823;10002.349847259904;10227.335223210468;10317.329373590843;10341.793164136825;10387.84418233727;13903.721925561635;13934;13938.23339716305;13955.162690238618;13970.650733731738;6966.9303306967295;7017.087778588853;7046.330598593126;7328.816779580553;7332.910120615599;6628.304028077079;6644.302348253461;6684;6889.793306200822;6890.621015844076;4343.1747967886;4356.9128617428105;4381.890452738643;4395.626371758436;4442.888927776767;1801.765770449833;1837.4671345309978;1855.41554410363;1906.323255244396;1917.2744529923182;650.9544331896816;711.0481727657613;864.8010957479814;892.5492626223845;924.5700749151542;16464;16879.83120168807;17519.124043797758;17830.643387132186;17870.91064544669;789.5736302396641;821.9301359384519;827.3787138021827;856.2935578147928;867.9671191282354;8945.19493245611;9621.759456013655;9645;9684.612615495442;9898.158656514277;283493;287375;393530;397586;398878;48637;65134.67432662806;67958;83188;83963;891.0866361979023;902.5983437370438;926.6571368593528;927.3230541704594;933.7758937854866;11797.52809887595;15935.521934341989;16285.663302734254;16454.83545164533;16600.916995414944;24332.33237227711;26214.606780898685;36824.07939801527;38409.42385864158;38596.80701596474;49096;50702;50934;51445;51762.48237517727;7616.7334143304715;7719.768406947801;7897.13131555517;8000.399970002157;8087.797805054921;10557.736056598647;11860.94069529647;12104.152709310616;12192.695182620151;12489.750204995667;10496.947515262375;10577.524011419351;10674.89325106739;10683.30558513694;10746.785064298827;10296.948515257376;10629.734256643645;10675.626353077605;10695.251332406657;10949.069329107115;5314.070037743457;10362.792744145225;10547.156227501935;10884.129269658566;10940.288881222696;7752.92247077522;7758.7672369829;7799.5320280783335;7934.64294106755;8241.95879020625;10395.58417663285;10459.84310235332;10625.521851516854;10677.305975111592;10934.578504794326 08:49:24 INFO - PROCESS | 19309 | |3;mootools.html;1327.1904138475531;1370.4655184478056;1424.2665027510834;1650.4388507907308;1682.6214101827097;6779.42374898133;7386;7451.552906825587;8064.233897779716;8064.27421532062;7603.65783539742;7735.419843511745;7737;7744.651490682919;7747.070351557807;2185.9234926777567;2209.5801797658473;2214.579229946305;2215.213599172295;2217.756046834847;1878.19237727777;1986.3941497843152;2036.7555893292827;2152.6770984352393;2174.065151984646;2160.7083043789044;2175.3147758456116;2180.90185941633;2184.8907554622283;2186.081845624841;2134.9786502134934;2137.0169721927855;2198.208644887839;2198.8350873684376;2202.196198387593;2129.1376992318137;2139.6362618354915;2139.711138996231;2143.7856214378594;2177.2706143441965;7925.920740792576;7997.640106195236;7999.480033797785;8003.19968003195;8005.999250093738;4453.732776033448;4514.4582650081875;4561.931571026437;4566.063956888863;4570.017446249072;2860.199144239616;2974.776891733107;2985.4775414302626;3010.834404107773;3027.1070034339923;967.911216497246;992.5583115513599;999.5801763259376;1007.153990647852;1011.7622358745689;10763.461826908624;10832.133429325635;10840.67477975662;10860.1311895049;10867.402292873889;4019.979900100481;4063.349864021742;4251.617354438115;4282.250606143974;4287.206866729665;9068.773280667903;9082.727518174466;9086.500242486727;9092.408993415407;9129.543522823833;4590.5638964299005;4602.562756538124;4608.101420223092;4612.285095810154;4613.192691279013;4056.0671045659665;4173.561776013536;4197.8320867164975;4202.474690663667;4213.705040647186;3596.118950857057;3665.413533834627;3739.476473293741;3777.660010599059;3784.110733977513;1057.1595581512715;1142.4744617476053;1183.9940800295944;1190.6368557589844;1223.137687930025;768.4352001279055;796.4305521552118;799.2247519905799;806.1696452653777;819.4100247821559;4989.625778066587;5015.573676237561;5107.208382700687;5131.409887862869;5190.506901844319;819.5082950229934;840.3487297344485;851.6763629820753;877.4910551879894;894.0924961164424;3418.7948723076697;3556.3065202285306;3630.945535816965;3639.654232847928;3685.244524872395;9194.172524472695;9476.431414115175;9590.376625519319;9621.422714637145;9658.613655453844;9331.066893310615;9522.714318570454;9569.856452153223;9570.234381249484;9580.473073980858;6890.621015844176;6988.37104660583;7053.153621565445;7053.576785392893;7056.647167641598;4926.162552366178;4947.40631124253;4981.153203955409;5015.749212539431;5229.084910140787;8634.438761480484;8723.040465548658;8811.33914956368;8853.380263381501;8889.333300002654;8823.382363234512;8940.73177804667;9012.63949442015;9062.093790620886;9063.13900179482;6558.508111891531;6588.308227636029;6630.635315057718;6633.535652504278;6639.402453779183;7132.643367831692;7190;7194.100737407824;7194.820129496805;7197.316254955771;6379.393957574023;6396.040593910764;6431.131797207504;6439.8068057958335;6583.868322633425;6409.198850143732;6424.935750642434;6489.448396886318;6497.610143391223;6513.185851768529;6150.630962142286;6162.291336496181;6201.0388389799655;6213.130161777264;6214.2853571838;4517.638588912945;4553.863384098482;4570.154521413549;4592.862214133581;4598.563136502027;4520.434945631796;4557.726536407826;4558.77206139685;4662.090892275974;4674.322223277673 08:49:24 INFO - PROCESS | 19309 | |4;prototype.html;287.7855997282025;296.810041573393;300.2958063341464;301.3957016182555;307.34842134674494;4621.428714237159;4742.525747425264;4800.807967681293;4801.639877009221;4826.517348265176;4497.325401189823;4736.3842700448895;4736.715797052179;4737.597304229136;4752.857414277569;3780.865740277906;3781.1681430085337;3786.3752480840626;3787.9810600946957;3788.2234142000893;3585.0320413488344;3804.391297392418;3804.7254169852995;3816.694664426839;3840.923181536368;3623.40213864712;3641.908952276188;3744.64425879541;3746.756460830037;3750.2312026034733;3722.3113723960882;3735.084904198475;3735.6451137141926;3747.7189210809297;3748.3815170496837;3300.174956260935;3320.169957510622;3326.434506133963;3335.8832440864453;3352.916177095568;4479.686421950465;4625.1443482955765;4625.8149674013;4633.355158918603;4675.742834144121;4250.04374015847;4252.55348188442;4254.851080212208;4266.84795105323;4310.762908040057;4936.4076310842565;4936.6050715943;4943;4982.153033984231;4985.426675932278;3503.929921401583;3617.2584620152807;3619.7466177367596;3627.691646210049;3643.544556930384;5097.1844504879045;5134.178531434953;5135.3067335909545;5171.4311425743135;5199.4800519948085;3714.7771133732062;3718.8140592970785;3723.343112314994;3729.8321575529167;3768.736188466781;3807.695384369244;3808.200277941608;3813.5423749149722;3814.6948244140403;3815;4186.392973018896;4247.766372849523;4273.273543497613;4290.227759003409;4293.377460268306;4939.147819567662;4947.604191664658;4962.33008543842;4963.081829861487;4968.826091086795;1237.616338934933;1304.2696090189525;1319.162331919219;1319.4326439631052;1323.9669008274677;855.9957200213959;874.9956250218709;875.3916028360355;880.5641207602278;891.7948871759531;4355.930932806955;4366.563343665608;4370.6451000190045;4371.934420983688;4382.663287697219;5032.735269128833;5045.949540504622;5050.797968081309;5060.51925067118;5101.387833460009;4257;4341.15347507233;4369.815092453773;4370.208214631985;4382.320740285261;2677.42435376395;2681.410089780284;2688.6101515280175;2688.623592697024;2708.1469337158733;4732.976335118371;4762.261849413347;4765.499622539653;4780.498047704941;4783.904321913612;4945.480724523945;5151.97424012885;5164.7934082636275;5167.560757335594;5229.738513074331;4637.976810115928;4655.767211639404;4680.010995326905;4741.193997020515;4748.857534273978;5023.1711767557945;5037.748112594429;5043.596512278936;5047.7476126192805;5052.772625231947;4761.500042495488;4947.950520494749;5028.698278103179;5045.738565358661;5051.3433253676785;4808.519148085164;4813.590844778233;4815.759212039314;4827.08285425768;4831.51684831514;3637.563492380931;3639.872604458831;3642.5264715586804;3651.561812582507;3665;5012.7718708916545;5096.9298528092295;5123.873592459087;5150.819721309736;5182.719603374503;4999.150144475375;5007.422661861502;5011.373578302712;5015.824446144367;5024.824131155392;4970.40355157369;4995.700257984533;5012.273220383097;5056.57019153376;5081.822136225214;4721.504242054672;4794.784234709517;4923.778429970732;4959.553640172402;5032.874178145429;4940.604751619933;5028.296038554532;5029.949700502948;5031.974840125776;5041.521055499722;4907.582855457326;4915.705057696549;4922.483139270325;4992.850214493571;5007.424146223231 08:49:24 INFO - PROCESS | 19309 | |5;yui.html;623.4202191961475;628.6185288538885;662.3707477895994;676.7529851604163;713.1976526407791;12456.750864982707;13470.191788492673;13482.797758033637;13485.797713034312;13497.730045399087;12548.560800371988;12725.045621578372;12732.108752387336;12749.235045897252;12752.80870786939;604.7580967612968;711.7153138744518;731.7365748330596;736.8599966006468;743.9739609113682;743.7619961612286;752.3417010116149;752.6462562595572;752.7515919746498;752.8569571781371;800.6917336825306;804.2078552625659;804.4730701390598;804.8671969125087;805.1586092533316;634.5050860328951;770.9383249340095;798.2217338095311;799.8160423102661;804.4328748232482;580.4862696513574;581.1573218832667;581.5434883616341;582.2169182449641;583.1602492410915;12659.050571207104;12708.87291127086;12712.872871271262;12713.17364371313;12733.936330318382;12280.263184208976;12536.310502922335;12779.361031948458;13029.34853257343;13223.669408264774;11754.412279385997;11803.11476639247;11929.522819087226;12229.816552751716;12308.692282693004;4054.695897807647;4065;4098.4876890388705;4227.8097485613225;4267.573242675739;61491.69254153745;61550;61942.38057619456;62088.379116209166;62578;10039.70899971141;10214.693559193236;10217.948910255402;10273.280870339155;10393.48032598367;19022.80977190238;19045.333413330467;19122.139503722086;19133.23467061302;19148.329808456638;6786.728530858809;6786.898196527056;6803.0135630333325;6848.280930502325;7107.253738357502;3709.4064949608473;3816.9236615268096;3843.1929294847837;3844.8077596120083;3914.178022615226;2737.9589306160424;2826.9964162721935;2829.858507074638;2830.801843870909;2836.1066264126734;481.6556162343941;485.03236044091557;487.4832677362008;500.364537037967;506.04105220606743;538.2706432783522;549.8927709096768;556.3768579191332;559.9188117722989;584.3542885111975;7013.824654383579;7357.668904899292;7463.179050304462;7567.091948966159;7627.313541781266;460.1625042422758;531.1103900965867;540.9107497262908;546.0853071105881;563.090608667008;3450.240946991658;3583.7670551414076;3587.264610754841;3689.538807649044;3773.603771603997;59343;102740;103492.48253758834;106200.46899765452;106953;85111.57444212864;86668.56665716632;86853;87630.56184719036;88220.55889720639;46331.5366846334;47217.29174062392;55477.2261386929;64330;75883;6604.5046621502615;6686.732530698718;6856.6228857413325;6898.310168983062;6948.791536253921;33343;45488.31767523423;45642.315365268885;45787.31319030284;47674.76162619165;37030;41166;62252.06621900584;65064;66200;9471.242300616072;9544.856827147738;9571.569279382584;9596.088371604686;10060.547275372479;9710.951445242728;10397.53211105487;10514.369137851754;10985.61550345734;11953.402329883646;10261.692149235534;10461.424621645883;10469.162467002774;10597.841032384675;10768.300060496043;9718.12536871685;10028.29801913859;10044;10082.092611664986;10264.178865690876;10313.432761198206;10416.635417760343;10528.894711052792;10625.628103016357;10785.460726963778;8028.4781489203015;8082.434229603871;8171.7548473545885;8267.669293228204;8723.956380218058;8186.54973976437;8519.275861551838;8581.313494920267;8797.12028797115;8903.866442003504 08:49:24 INFO - PROCESS | 19309 | __end_tp_report 08:49:24 INFO - PROCESS | 19309 | __start_cc_report 08:49:24 INFO - PROCESS | 19309 | _x_x_mozilla_cycle_collect,1380 08:49:24 INFO - PROCESS | 19309 | __end_cc_report 08:49:24 INFO - PROCESS | 19309 | __startTimestamp1472658564510__endTimestamp 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | ------- Summary: start ------- 08:49:24 INFO - PROCESS | 19309 | Number of tests: 6 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | [#0] dojo.html Cycles:165 Average:4681.89 Median:4790.47 stddev:497.71 (10.4%) stddev-sans-first:471.72 08:49:24 INFO - PROCESS | 19309 | Values: 2601.5 2606.0 2618.6 2656.2 2673.8 4607.9 4699.1 4704.6 4738.6 4825.0 4694.2 4731.1 4793.0 4797.5 4842.9 4293.9 4312.7 4329.7 4331.6 4487.6 4437.0 4441.5 4442.3 4449.6 4465.8 4247.6 4285.0 4290.3 4363.6 4383.7 4313.0 4334.9 4335.0 4336.1 4388.8 4282.0 4299.1 4302.5 4408.3 4412.0 4750.5 4765.5 4766.3 4777.5 4779.3 4960.2 5023.3 5104.7 5111.3 5165.0 5091.8 5110.2 5118.9 5120.4 5148.0 4736.2 4744.3 4758.7 4826.3 4826.9 5073.2 5175.9 5227.3 5235.1 5238.2 5008.6 5027.4 5028.2 5075.3 5084.7 5082.6 5084.4 5088.8 5094.5 5150.4 4847.6 4993.3 5002.5 5012.7 5032.0 5064.2 5064.3 5067.6 5110.5 5127.6 4261.1 4268.5 4268.6 4318.9 4320.5 3694.9 3710.2 3714.7 3741.8 3771.7 4325.5 4337.8 4348.9 4388.0 4409.0 5076.9 5077.5 5087.2 5088.6 5140.4 4264.5 4295.0 4351.6 4353.2 4389.7 4523.6 4524.0 4542.6 4580.9 4597.2 4722.0 4724.5 4725.0 4731.1 4756.9 4927.9 5033.3 5102.0 5108.8 5155.8 4734.3 4749.7 4751.7 4816.5 4830.6 4994.4 5008.5 5024.4 5032.6 5088.8 4953.0 4988.7 5089.3 5108.1 5174.0 4907.1 4920.0 4932.9 4972.0 4990.3 4921.5 4925.4 4928.8 4930.5 4997.9 4737.4 4790.5 4864.0 4864.5 4922.5 4921.3 4926.0 4929.0 4944.8 4949.3 4734.4 4780.3 4788.5 4789.7 4793.5 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | [#1] ext.html Cycles:180 Average:42235.74 Median:35090.74 stddev:74510.81 (212.3%) stddev-sans-first:74654.16 08:49:24 INFO - PROCESS | 19309 | Values: 569.4 574.9 578.0 583.5 586.2 30126.2 31024.2 31061.8 38755.4 40068.6 39668.0 40174.4 40236.8 40241.2 40338.6 7528.8 7661.2 7669.9 7675.3 7675.8 7158.9 7619.4 9715.6 9958.7 9994.8 10073.9 10119.2 10125.4 10137.9 10148.7 9936.8 9986.9 9987.8 9994.1 10000.5 9609.8 9819.1 9827.5 9828.1 9830.1 37401.0 37614.2 37678.6 37684.2 37704.0 3027.3 3074.4 3108.2 3113.2 3148.1 27656.3 27785.3 28242.4 28258.0 28984.6 3343.3 3507.6 3513.9 3514.9 3547.5 161613.0 162586.2 162987.0 163074.0 163537.0 31030.2 53405.5 53585.5 53905.0 53913.0 30947.7 32398.4 32523.5 32762.5 32803.3 11669.0 11703.9 11707.4 11714.8 11719.5 10083.6 10162.6 10235.5 10247.6 10248.3 7489.0 7730.7 7748.1 7844.8 7903.3 3061.4 3077.1 3093.2 3096.4 3145.0 851.3 881.9 895.6 949.2 953.6 26562.9 27217.9 27416.3 27751.7 27932.6 914.4 934.9 943.6 965.6 1030.0 14355.8 14609.2 14672.5 14955.9 14968.3 363148.0 367040.0 367084.0 367556.0 368898.0 46736.2 47176.8 47195.0 47245.5 47328.3 1074.0 1115.4 1164.5 1198.6 1202.4 26585.0 27703.9 28314.9 28937.1 29023.4 40250.0 40866.2 40873.0 40887.2 40908.2 279462.0 279497.0 280354.0 280717.0 280927.0 37709.0 38563.2 39203.6 40777.2 40977.8 37609.2 38625.2 40582.0 41044.8 41667.4 34956.7 35124.3 35203.1 35575.5 35892.6 34497.1 34788.8 34991.8 35058.5 35071.6 34696.0 35049.0 35109.8 35560.1 36003.5 29813.4 31973.0 32119.4 32404.7 32764.3 24930.8 24969.4 24970.5 25132.7 25452.9 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | [#2] jquery.html Cycles:180 Average:22735.04 Median:201495.39 stddev:58952.64 (29.3%) stddev-sans-first:59094.05 08:49:24 INFO - PROCESS | 19309 | Values: 346.9 366.4 367.5 369.4 390.1 12472.0 15328.5 15497.3 16733.1 16824.1 14407.2 14687.3 14925.2 15416.6 15554.7 4112.8 4573.0 4715.7 4716.7 4741.3 4697.2 4732.9 4733.3 4734.9 4738.0 4492.5 4685.6 4726.4 4728.4 4734.5 4630.8 4684.4 4686.6 4691.4 4693.9 4565.5 4565.8 4566.9 4567.5 4573.4 18726.4 19355.0 19499.4 20197.6 20390.1 1793.2 1856.8 1902.5 2000.2 2011.9 8788.9 9475.7 9646.3 12285.3 12945.9 1592.1 1721.8 1732.9 1761.6 1777.8 63532.4 65863.0 67736.3 68197.3 68231.3 10002.3 10227.3 10317.3 10341.8 10387.8 13903.7 13934.0 13938.2 13955.2 13970.7 6966.9 7017.1 7046.3 7328.8 7332.9 6628.3 6644.3 6684.0 6889.8 6890.6 4343.2 4356.9 4381.9 4395.6 4442.9 1801.8 1837.5 1855.4 1906.3 1917.3 651.0 711.0 864.8 892.5 924.6 16464.0 16879.8 17519.1 17830.6 17870.9 789.6 821.9 827.4 856.3 868.0 8945.2 9621.8 9645.0 9684.6 9898.2 283493.0 287375.0 393530.0 397586.0 398878.0 48637.0 65134.7 67958.0 83188.0 83963.0 891.1 902.6 926.7 927.3 933.8 11797.5 15935.5 16285.7 16454.8 16600.9 24332.3 26214.6 36824.1 38409.4 38596.8 49096.0 50702.0 50934.0 51445.0 51762.5 7616.7 7719.8 7897.1 8000.4 8087.8 10557.7 11860.9 12104.2 12192.7 12489.8 10496.9 10577.5 10674.9 10683.3 10746.8 10296.9 10629.7 10675.6 10695.3 10949.1 5314.1 10362.8 10547.2 10884.1 10940.3 7752.9 7758.8 7799.5 7934.6 8242.0 10395.6 10459.8 10625.5 10677.3 10934.6 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | [#3] mootools.html Cycles:180 Average:5081.68 Median:5002.60 stddev:2846.20 (56.9%) stddev-sans-first:2840.20 08:49:24 INFO - PROCESS | 19309 | Values: 1327.2 1370.5 1424.3 1650.4 1682.6 6779.4 7386.0 7451.6 8064.2 8064.3 7603.7 7735.4 7737.0 7744.7 7747.1 2185.9 2209.6 2214.6 2215.2 2217.8 1878.2 1986.4 2036.8 2152.7 2174.1 2160.7 2175.3 2180.9 2184.9 2186.1 2135.0 2137.0 2198.2 2198.8 2202.2 2129.1 2139.6 2139.7 2143.8 2177.3 7925.9 7997.6 7999.5 8003.2 8006.0 4453.7 4514.5 4561.9 4566.1 4570.0 2860.2 2974.8 2985.5 3010.8 3027.1 967.9 992.6 999.6 1007.2 1011.8 10763.5 10832.1 10840.7 10860.1 10867.4 4020.0 4063.3 4251.6 4282.3 4287.2 9068.8 9082.7 9086.5 9092.4 9129.5 4590.6 4602.6 4608.1 4612.3 4613.2 4056.1 4173.6 4197.8 4202.5 4213.7 3596.1 3665.4 3739.5 3777.7 3784.1 1057.2 1142.5 1184.0 1190.6 1223.1 768.4 796.4 799.2 806.2 819.4 4989.6 5015.6 5107.2 5131.4 5190.5 819.5 840.3 851.7 877.5 894.1 3418.8 3556.3 3630.9 3639.7 3685.2 9194.2 9476.4 9590.4 9621.4 9658.6 9331.1 9522.7 9569.9 9570.2 9580.5 6890.6 6988.4 7053.2 7053.6 7056.6 4926.2 4947.4 4981.2 5015.7 5229.1 8634.4 8723.0 8811.3 8853.4 8889.3 8823.4 8940.7 9012.6 9062.1 9063.1 6558.5 6588.3 6630.6 6633.5 6639.4 7132.6 7190.0 7194.1 7194.8 7197.3 6379.4 6396.0 6431.1 6439.8 6583.9 6409.2 6424.9 6489.4 6497.6 6513.2 6150.6 6162.3 6201.0 6213.1 6214.3 4517.6 4553.9 4570.2 4592.9 4598.6 4520.4 4557.7 4558.8 4662.1 4674.3 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | [#4] prototype.html Cycles:180 Average:4141.96 Median:4727.24 stddev:1182.66 (25.0%) stddev-sans-first:1150.06 08:49:24 INFO - PROCESS | 19309 | Values: 287.8 296.8 300.3 301.4 307.3 4621.4 4742.5 4800.8 4801.6 4826.5 4497.3 4736.4 4736.7 4737.6 4752.9 3780.9 3781.2 3786.4 3788.0 3788.2 3585.0 3804.4 3804.7 3816.7 3840.9 3623.4 3641.9 3744.6 3746.8 3750.2 3722.3 3735.1 3735.6 3747.7 3748.4 3300.2 3320.2 3326.4 3335.9 3352.9 4479.7 4625.1 4625.8 4633.4 4675.7 4250.0 4252.6 4254.9 4266.8 4310.8 4936.4 4936.6 4943.0 4982.2 4985.4 3503.9 3617.3 3619.7 3627.7 3643.5 5097.2 5134.2 5135.3 5171.4 5199.5 3714.8 3718.8 3723.3 3729.8 3768.7 3807.7 3808.2 3813.5 3814.7 3815.0 4186.4 4247.8 4273.3 4290.2 4293.4 4939.1 4947.6 4962.3 4963.1 4968.8 1237.6 1304.3 1319.2 1319.4 1324.0 856.0 875.0 875.4 880.6 891.8 4355.9 4366.6 4370.6 4371.9 4382.7 5032.7 5045.9 5050.8 5060.5 5101.4 4257.0 4341.2 4369.8 4370.2 4382.3 2677.4 2681.4 2688.6 2688.6 2708.1 4733.0 4762.3 4765.5 4780.5 4783.9 4945.5 5152.0 5164.8 5167.6 5229.7 4638.0 4655.8 4680.0 4741.2 4748.9 5023.2 5037.7 5043.6 5047.7 5052.8 4761.5 4948.0 5028.7 5045.7 5051.3 4808.5 4813.6 4815.8 4827.1 4831.5 3637.6 3639.9 3642.5 3651.6 3665.0 5012.8 5096.9 5123.9 5150.8 5182.7 4999.2 5007.4 5011.4 5015.8 5024.8 4970.4 4995.7 5012.3 5056.6 5081.8 4721.5 4794.8 4923.8 4959.6 5032.9 4940.6 5028.3 5029.9 5032.0 5041.5 4907.6 4915.7 4922.5 4992.9 5007.4 08:49:24 INFO - PROCESS | 19309 | 08:49:24 INFO - PROCESS | 19309 | [#5] yui.html Cycles:180 Average:16742.54 Median:493.92 stddev:24483.04 (4956.8%) stddev-sans-first:24521.81 08:49:24 INFO - PROCESS | 19309 | Values: 623.4 628.6 662.4 676.8 713.2 12456.8 13470.2 13482.8 13485.8 13497.7 12548.6 12725.0 12732.1 12749.2 12752.8 604.8 711.7 731.7 736.9 744.0 743.8 752.3 752.6 752.8 752.9 800.7 804.2 804.5 804.9 805.2 634.5 770.9 798.2 799.8 804.4 580.5 581.2 581.5 582.2 583.2 12659.1 12708.9 12712.9 12713.2 12733.9 12280.3 12536.3 12779.4 13029.3 13223.7 11754.4 11803.1 11929.5 12229.8 12308.7 4054.7 4065.0 4098.5 4227.8 4267.6 61491.7 61550.0 61942.4 62088.4 62578.0 10039.7 10214.7 10217.9 10273.3 10393.5 19022.8 19045.3 19122.1 19133.2 19148.3 6786.7 6786.9 6803.0 6848.3 7107.3 3709.4 3816.9 3843.2 3844.8 3914.2 2738.0 2827.0 2829.9 2830.8 2836.1 481.7 485.0 487.5 500.4 506.0 538.3 549.9 556.4 559.9 584.4 7013.8 7357.7 7463.2 7567.1 7627.3 460.2 531.1 540.9 546.1 563.1 3450.2 3583.8 3587.3 3689.5 3773.6 59343.0 102740.0 103492.5 106200.5 106953.0 85111.6 86668.6 86853.0 87630.6 88220.6 46331.5 47217.3 55477.2 64330.0 75883.0 6604.5 6686.7 6856.6 6898.3 6948.8 33343.0 45488.3 45642.3 45787.3 47674.8 37030.0 41166.0 62252.1 65064.0 66200.0 9471.2 9544.9 9571.6 9596.1 10060.5 9711.0 10397.5 10514.4 10985.6 11953.4 10261.7 10461.4 10469.2 10597.8 10768.3 9718.1 10028.3 10044.0 10082.1 10264.2 10313.4 10416.6 10528.9 10625.6 10785.5 8028.5 8082.4 8171.8 8267.7 8724.0 8186.5 8519.3 8581.3 8797.1 8903.9 08:49:24 INFO - PROCESS | 19309 | -------- Summary: end -------- 08:49:24 INFO - PROCESS | 19309 | 08:49:25 INFO - TEST-INFO | 19309: exit 0 08:49:25 INFO - TEST-OK | dromaeo_css | took 1120997ms 08:49:25 INFO - TEST-START | kraken 08:49:25 INFO - operating with platform_type : linux_ 08:49:25 INFO - Initialising browser for kraken test... 08:49:25 INFO - TEST-INFO | started process 19614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvXoTD0/profile http://localhost:55908/getInfo.html) 08:49:29 INFO - PROCESS | 19614 | __metrics Screen width/height:1600/1200 08:49:29 INFO - PROCESS | 19614 | colorDepth:24 08:49:29 INFO - PROCESS | 19614 | Browser inner width/height: 1024/697 08:49:29 INFO - PROCESS | 19614 | __metrics 08:49:30 INFO - PROCESS | 19614 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:49:30 INFO - PROCESS | 19614 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:30 INFO - PROCESS | 19614 | console.error: PushService: 08:49:30 INFO - PROCESS | 19614 | stateChangeProcessEnqueue: Error transitioning state 08:49:30 INFO - PROCESS | 19614 | UnknownError 08:49:31 INFO - TEST-INFO | 19614: exit 0 08:49:31 INFO - Browser initialized. 08:49:31 INFO - Running cycle 1/1 for kraken test... 08:49:31 INFO - TEST-INFO | started process 19692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvXoTD0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:43 INFO - PROCESS | 19692 | RSS: Main: 182046720 08:49:43 INFO - PROCESS | 19692 | 08:49:46 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55908/tests/kraken/driver.html?testName=audio-beat-detection) 08:49:47 INFO - PROCESS | 19692 | RSS: Main: 243462144 08:49:47 INFO - PROCESS | 19692 | 08:49:50 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55908/tests/kraken/driver.html?testName=audio-dft) 08:49:50 INFO - PROCESS | 19692 | RSS: Main: 225677312 08:49:50 INFO - PROCESS | 19692 | 08:49:54 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55908/tests/kraken/driver.html?testName=audio-fft) 08:49:54 INFO - PROCESS | 19692 | RSS: Main: 304185344 08:49:54 INFO - PROCESS | 19692 | 08:49:56 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55908/tests/kraken/driver.html?testName=audio-oscillator) 08:49:57 INFO - PROCESS | 19692 | RSS: Main: 213078016 08:49:57 INFO - PROCESS | 19692 | 08:49:59 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:50:00 INFO - PROCESS | 19692 | RSS: Main: 215506944 08:50:00 INFO - PROCESS | 19692 | 08:50:03 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55908/tests/kraken/driver.html?testName=imaging-darkroom) 08:50:03 INFO - PROCESS | 19692 | RSS: Main: 253288448 08:50:03 INFO - PROCESS | 19692 | 08:50:07 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55908/tests/kraken/driver.html?testName=imaging-desaturate) 08:50:07 INFO - PROCESS | 19692 | RSS: Main: 246673408 08:50:07 INFO - PROCESS | 19692 | 08:50:10 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55908/tests/kraken/driver.html?testName=json-parse-financial) 08:50:11 INFO - PROCESS | 19692 | RSS: Main: 250101760 08:50:11 INFO - PROCESS | 19692 | 08:50:13 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:50:13 INFO - PROCESS | 19692 | RSS: Main: 214261760 08:50:13 INFO - PROCESS | 19692 | 08:50:15 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:50:16 INFO - PROCESS | 19692 | RSS: Main: 221249536 08:50:16 INFO - PROCESS | 19692 | 08:50:18 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:50:19 INFO - PROCESS | 19692 | RSS: Main: 222691328 08:50:19 INFO - PROCESS | 19692 | 08:50:22 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:50:22 INFO - PROCESS | 19692 | RSS: Main: 223727616 08:50:22 INFO - PROCESS | 19692 | 08:50:25 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:50:26 INFO - PROCESS | 19692 | RSS: Main: 221405184 08:50:26 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | Cycle 1(1): loaded http://localhost:55908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55908/tests/kraken/driver.html?testName=ai-astar) 08:50:28 INFO - PROCESS | 19692 | RSS: Main: 272642048 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | __start_tp_report 08:50:28 INFO - PROCESS | 19692 | _x_x_mozilla_page_load 08:50:28 INFO - PROCESS | 19692 | _x_x_mozilla_page_load_details 08:50:28 INFO - PROCESS | 19692 | |i|pagename|runs| 08:50:28 INFO - PROCESS | 19692 | |0;ai-astar;112;116;133;113;112;114;114;113;113;112 08:50:28 INFO - PROCESS | 19692 | |1;audio-beat-detection;153;126;145;194;126;149;155;125;184;127 08:50:28 INFO - PROCESS | 19692 | |2;audio-dft;164;163;162;162;164;163;160;163;162;162 08:50:28 INFO - PROCESS | 19692 | |3;audio-fft;75;74;76;159;78;75;75;75;156;77 08:50:28 INFO - PROCESS | 19692 | |4;audio-oscillator;84;83;159;84;86;83;137;84;83;142 08:50:28 INFO - PROCESS | 19692 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;117;119;117 08:50:28 INFO - PROCESS | 19692 | |6;imaging-darkroom;147;147;147;147;147;147;147;147;146;147 08:50:28 INFO - PROCESS | 19692 | |7;imaging-desaturate;94;96;94;95;96;95;94;95;95;95 08:50:28 INFO - PROCESS | 19692 | |8;json-parse-financial;64;64;64;65;66;65;65;67;65;65 08:50:28 INFO - PROCESS | 19692 | |9;json-stringify-tinderbox;67;67;67;66;67;66;66;66;67;68 08:50:28 INFO - PROCESS | 19692 | |10;stanford-crypto-aes;86;88;82;81;93;85;89;87;85;83 08:50:28 INFO - PROCESS | 19692 | |11;stanford-crypto-ccm;133;139;129;132;131;142;138;131;176;133 08:50:28 INFO - PROCESS | 19692 | |12;stanford-crypto-pbkdf2;175;175;179;176;176;176;175;170;169;173 08:50:28 INFO - PROCESS | 19692 | |13;stanford-crypto-sha256-iterative;76;72;70;69;69;69;68;68;68;67 08:50:28 INFO - PROCESS | 19692 | __end_tp_report 08:50:28 INFO - PROCESS | 19692 | __start_cc_report 08:50:28 INFO - PROCESS | 19692 | _x_x_mozilla_cycle_collect,2005 08:50:28 INFO - PROCESS | 19692 | __end_cc_report 08:50:28 INFO - PROCESS | 19692 | __startTimestamp1472658628268__endTimestamp 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | ------- Summary: start ------- 08:50:28 INFO - PROCESS | 19692 | Number of tests: 14 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#0] ai-astar Cycles:10 Average:115.20 Median:113.50 stddev:6.37 (5.6%) stddev-sans-first:6.65 08:50:28 INFO - PROCESS | 19692 | Values: 112.0 116.0 133.0 113.0 112.0 114.0 114.0 113.0 113.0 112.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:151.00 stddev:24.57 (16.3%) stddev-sans-first:26.00 08:50:28 INFO - PROCESS | 19692 | Values: 153.0 126.0 145.0 194.0 126.0 149.0 155.0 125.0 184.0 127.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 08:50:28 INFO - PROCESS | 19692 | Values: 164.0 163.0 162.0 162.0 164.0 163.0 160.0 163.0 162.0 162.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.00 stddev:34.55 (46.1%) stddev-sans-first:36.09 08:50:28 INFO - PROCESS | 19692 | Values: 75.0 74.0 76.0 159.0 78.0 75.0 75.0 75.0 156.0 77.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:83.50 stddev:30.52 (36.5%) stddev-sans-first:31.63 08:50:28 INFO - PROCESS | 19692 | Values: 84.0 83.0 159.0 84.0 86.0 83.0 137.0 84.0 83.0 142.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 08:50:28 INFO - PROCESS | 19692 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 119.0 117.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:50:28 INFO - PROCESS | 19692 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 08:50:28 INFO - PROCESS | 19692 | Values: 94.0 96.0 94.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 08:50:28 INFO - PROCESS | 19692 | Values: 64.0 64.0 64.0 65.0 66.0 65.0 65.0 67.0 65.0 65.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:50:28 INFO - PROCESS | 19692 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 66.0 66.0 67.0 68.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.50 stddev:3.57 (4.1%) stddev-sans-first:3.79 08:50:28 INFO - PROCESS | 19692 | Values: 86.0 88.0 82.0 81.0 93.0 85.0 89.0 87.0 85.0 83.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:135.50 stddev:13.84 (10.2%) stddev-sans-first:14.54 08:50:28 INFO - PROCESS | 19692 | Values: 133.0 139.0 129.0 132.0 131.0 142.0 138.0 131.0 176.0 133.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:175.50 stddev:2.99 (1.7%) stddev-sans-first:3.16 08:50:28 INFO - PROCESS | 19692 | Values: 175.0 175.0 179.0 176.0 176.0 176.0 175.0 170.0 169.0 173.0 08:50:28 INFO - PROCESS | 19692 | 08:50:28 INFO - PROCESS | 19692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:2.63 (3.8%) stddev-sans-first:1.45 08:50:28 INFO - PROCESS | 19692 | Values: 76.0 72.0 70.0 69.0 69.0 69.0 68.0 68.0 68.0 67.0 08:50:28 INFO - PROCESS | 19692 | -------- Summary: end -------- 08:50:28 INFO - PROCESS | 19692 | 08:50:29 INFO - TEST-INFO | 19692: exit 0 08:50:29 INFO - TEST-OK | kraken | took 64125ms 08:50:29 INFO - SUITE-END | took 1185s 08:50:29 INFO - Completed test suite (00:19:45) 08:50:29 INFO - javascript benchmark 08:50:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.505713914357, 2605.996691273859, 2618.633391325214, 2656.203139058282, 2673.8128331016824, 4607.884802879929, 4699.060187962404, 4704.600108990731, 4738.620910327174, 4824.951750482494, 4694.248920172773, 4731.101090792747, 4793.0, 4797.496262892399, 4842.8547143585665, 4293.914121717564, 4312.698111132222, 4329.718568293067, 4331.631811296028, 4487.596116349528, 4436.957315030965, 4441.5336389679105, 4442.267025940716, 4449.644028477714, 4465.82136714531, 4247.5964783345535, 4285.035866929947, 4290.292101803198, 4363.585459381354, 4383.736975781463, 4313.00800815811, 4334.891627709301, 4334.9783251083545, 4336.132773445292, 4388.846390376353, 4282.0, 4299.14017196562, 4302.505211900609, 4408.25059739845, 4412.0, 4750.501197374295, 4765.523447655241, 4766.332713420124, 4777.474477807438, 4779.307000484945, 4960.156773348539, 5023.271625614266, 5104.744762761847, 5111.284420181178, 5165.018646457161, 5091.770870310808, 5110.182370820688, 5118.948810511884, 5120.359955005624, 5147.974260128713, 4736.218523943511, 4744.264638980963, 4758.714477131349, 4826.32431459596, 4826.855194344175, 5073.188289873602, 5175.896482070338, 5227.26818245446, 5235.083860324428, 5238.2404551340605, 5008.5993120550265, 5027.4469808321055, 5028.195488721787, 5075.289459475676, 5084.720340381315, 5082.611172748802, 5084.3644544431945, 5088.77100530477, 5094.465081166498, 5150.407703114115, 4847.61219102478, 4993.300937868701, 5002.499750024968, 5012.724300163453, 5031.974840125776, 5064.215046667772, 5064.34163558735, 5067.6452648315, 5110.463401342806, 5127.564157046693, 4261.083866968616, 4268.487781466244, 4268.551802060801, 4318.870433886988, 4320.503142138694, 3694.9445758313645, 3710.220853620716, 3714.68425183857, 3741.8129093545213, 3771.6605505504635, 4325.480942286946, 4337.82648694055, 4348.869533913988, 4388.034632380871, 4408.977955110268, 5076.873078173001, 5077.517635824591, 5087.211482220262, 5088.567471764942, 5140.3831540215415, 4264.466941632296, 4295.0, 4351.608355248043, 4353.151135528541, 4389.670774691911, 4523.638108951276, 4523.954760452353, 4542.591166795004, 4580.862574122782, 4597.241455159928, 4722.031983443318, 4724.480307166277, 4724.952750472451, 4731.124741922756, 4756.881077973078, 4927.926081108714, 5033.295338652519, 5101.974490127525, 5108.770105345194, 5155.845324640267, 4734.33719279308, 4749.667523273338, 4751.691140075884, 4816.54242846929, 4830.565249127595, 4994.375703037121, 5008.499150084962, 5024.447310795883, 5032.62255330859, 5088.821891233937, 4953.0, 4988.6757360771435, 5089.262057001788, 5108.106081435808, 5173.974130129325, 4907.141250281258, 4919.975400122977, 4932.8766780830765, 4972.0, 4990.276409920469, 4921.458639549718, 4925.433575138905, 4928.802847886188, 4930.482299358516, 4997.925031124609, 4737.407824021997, 4790.473047964651, 4864.0, 4864.537868902448, 4922.507749225048, 4921.26181072842, 4925.950740492549, 4928.975355123202, 4944.802207911644, 4949.30709700635, 4734.431868175841, 4780.306855506002, 4788.545088216614, 4789.736564488987, 4793.496682848251], "value": 4649.63144441761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3623142080869, 574.8706541028266, 578.0433382751545, 583.4777873802943, 586.2349633727983, 30126.24684382889, 31024.224394390152, 31061.844690776572, 38755.41866871999, 40068.59931400685, 39668.0, 40174.397384039265, 40236.79881600588, 40241.19517609646, 40338.59661403385, 7528.84942301155, 7661.195574464685, 7669.884951725729, 7675.3092221700035, 7675.769726908202, 7158.892616610755, 7619.42854285928, 9715.562799673997, 9958.651447199349, 9994.800103997952, 10073.949630251838, 10119.190464762838, 10125.443100629462, 10137.949310253476, 10148.716538778752, 9936.751581210456, 9986.900130998669, 9987.75030624233, 9994.050565196367, 10000.499975001258, 9609.807803843954, 9819.06718861707, 9827.508624568743, 9828.11546960777, 9830.115289623896, 37401.0, 37614.24771504582, 37678.623213768056, 37684.24631507382, 37704.0, 3027.2885871820104, 3074.3543855790313, 3108.207407111172, 3113.2216945763557, 3148.0870547541185, 27656.308592285153, 27785.305367365978, 28242.435151297064, 28258.0, 28984.565231521545, 3343.3480471308103, 3507.649235076472, 3513.91215219619, 3514.876979305712, 3547.5033495310677, 161613.0, 162586.18706906508, 162987.0, 163074.0, 163537.0, 31030.22424439407, 53405.465945340824, 53585.46414535805, 53905.0, 53913.0, 30947.69052309493, 32398.35203295921, 32523.512147317808, 32762.508562371582, 32803.34393312121, 11669.0, 11703.88296117045, 11707.414629268502, 11714.824277635842, 11719.531218751325, 10083.647072352433, 10162.593496260215, 10235.488225588691, 10247.59009639621, 10248.333858299187, 7489.0, 7730.729424470229, 7748.147703752583, 7844.843103137905, 7903.328217101611, 3061.448939190967, 3077.1075788390426, 3093.2266933266683, 3096.4116817804547, 3145.025042236914, 851.2976794144855, 881.8853549038712, 895.5925054100369, 949.1837020162654, 953.5708930981086, 26562.86718566395, 27217.913871780245, 27416.314592134957, 27751.722482775316, 27932.58101128485, 914.4056363363867, 934.9252059835333, 943.5753910740194, 965.5703212070702, 1029.9751747011621, 14355.78466323006, 14609.196494192709, 14672.486462973744, 14955.925220373829, 14968.251587420586, 363148.0, 367040.0, 367084.0, 367556.0, 368898.0, 46736.22324762958, 47176.7641161792, 47195.0, 47245.5275447248, 47328.290075648896, 1074.0280046557878, 1115.4367044642565, 1164.4934453512749, 1198.6404078776159, 1202.4228370382266, 26585.0, 27703.861480692467, 28314.85842570774, 28937.13188604345, 29023.41953160967, 40250.0, 40866.1826763469, 40873.0, 40887.18225635411, 40908.18183636251, 279462.0, 279497.0, 280354.0, 280717.0, 280927.0, 37709.0, 38563.2287354257, 39203.607963919996, 40777.184456311305, 40977.79511102426, 37609.247815044095, 38625.2274954505, 40582.0, 41044.79477602593, 41667.37498937458, 34956.65043349534, 35124.29751404907, 35203.11992200215, 35575.46636800398, 35892.64107358893, 34497.13757156091, 34788.82605586956, 34991.82504087463, 35058.47412288767, 35071.64928350786, 34696.0, 35049.0, 35109.82445087758, 35560.110997225274, 36003.45994810132, 29813.403731925675, 31973.0, 32119.357612848078, 32404.675953240167, 32764.34471310513, 24930.77007667756, 24969.37576560528, 24970.500589988464, 25132.74867251377, 25452.872735636203], "value": 16408.32767652205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9427544455165, 366.3625291991934, 367.5130452150899, 369.39419352262286, 390.08719596145033, 12472.0, 15328.540143795675, 15497.302621382036, 16733.07968061756, 16824.07467589282, 14407.207603581799, 14687.33906974186, 14925.179115148663, 15416.61458463539, 15554.688906221869, 4112.773797441139, 4572.999999999992, 4715.717056976575, 4716.693414928036, 4741.288806678991, 4697.248440249561, 4732.881677958044, 4733.290006499035, 4734.881627959311, 4737.952620473786, 4492.505824359318, 4685.578297953183, 4726.409198850144, 4728.385309909707, 4734.455537613184, 4630.791614377361, 4684.36761037259, 4686.648501362394, 4691.413573303337, 4693.9061218775605, 4565.497795242521, 4565.794539245709, 4566.931496027562, 4567.474740404829, 4573.405457290531, 18726.438206853818, 19355.0, 19499.415017549498, 20197.596048079104, 20390.08244628995, 1793.210987165656, 1856.8143185681458, 1902.543389586503, 2000.2299114840891, 2011.87928724277, 8788.912110878873, 9475.715728528156, 9646.324757266993, 12285.262884226886, 12945.935270323682, 1592.132287903084, 1721.8192089830513, 1732.8786984911062, 1761.5508045448328, 1777.7777777777778, 63532.36467635311, 65863.0, 67736.32263677398, 68197.27210911557, 68231.317686823, 10002.349847259904, 10227.335223210468, 10317.329373590843, 10341.793164136825, 10387.84418233727, 13903.721925561635, 13934.0, 13938.23339716305, 13955.162690238618, 13970.650733731738, 6966.9303306967295, 7017.087778588853, 7046.330598593126, 7328.816779580553, 7332.910120615599, 6628.304028077079, 6644.302348253461, 6684.0, 6889.793306200822, 6890.621015844076, 4343.1747967886, 4356.9128617428105, 4381.890452738643, 4395.626371758436, 4442.888927776767, 1801.765770449833, 1837.4671345309978, 1855.41554410363, 1906.323255244396, 1917.2744529923182, 650.9544331896816, 711.0481727657613, 864.8010957479814, 892.5492626223845, 924.5700749151542, 16464.0, 16879.83120168807, 17519.124043797758, 17830.643387132186, 17870.91064544669, 789.5736302396641, 821.9301359384519, 827.3787138021827, 856.2935578147928, 867.9671191282354, 8945.19493245611, 9621.759456013655, 9645.0, 9684.612615495442, 9898.158656514277, 283493.0, 287375.0, 393530.0, 397586.0, 398878.0, 48637.0, 65134.67432662806, 67958.0, 83188.0, 83963.0, 891.0866361979023, 902.5983437370438, 926.6571368593528, 927.3230541704594, 933.7758937854866, 11797.52809887595, 15935.521934341989, 16285.663302734254, 16454.83545164533, 16600.916995414944, 24332.33237227711, 26214.606780898685, 36824.07939801527, 38409.42385864158, 38596.80701596474, 49096.0, 50702.0, 50934.0, 51445.0, 51762.48237517727, 7616.7334143304715, 7719.768406947801, 7897.13131555517, 8000.399970002157, 8087.797805054921, 10557.736056598647, 11860.94069529647, 12104.152709310616, 12192.695182620151, 12489.750204995667, 10496.947515262375, 10577.524011419351, 10674.89325106739, 10683.30558513694, 10746.785064298827, 10296.948515257376, 10629.734256643645, 10675.626353077605, 10695.251332406657, 10949.069329107115, 5314.070037743457, 10362.792744145225, 10547.156227501935, 10884.129269658566, 10940.288881222696, 7752.92247077522, 7758.7672369829, 7799.5320280783335, 7934.64294106755, 8241.95879020625, 10395.58417663285, 10459.84310235332, 10625.521851516854, 10677.305975111592, 10934.578504794326], "value": 7951.146834536582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.1904138475531, 1370.4655184478056, 1424.2665027510834, 1650.4388507907308, 1682.6214101827097, 6779.42374898133, 7386.0, 7451.552906825587, 8064.233897779716, 8064.27421532062, 7603.65783539742, 7735.419843511745, 7737.0, 7744.651490682919, 7747.070351557807, 2185.9234926777567, 2209.5801797658473, 2214.579229946305, 2215.213599172295, 2217.756046834847, 1878.19237727777, 1986.3941497843152, 2036.7555893292827, 2152.6770984352393, 2174.065151984646, 2160.7083043789044, 2175.3147758456116, 2180.90185941633, 2184.8907554622283, 2186.081845624841, 2134.9786502134934, 2137.0169721927855, 2198.208644887839, 2198.8350873684376, 2202.196198387593, 2129.1376992318137, 2139.6362618354915, 2139.711138996231, 2143.7856214378594, 2177.2706143441965, 7925.920740792576, 7997.640106195236, 7999.480033797785, 8003.19968003195, 8005.999250093738, 4453.732776033448, 4514.4582650081875, 4561.931571026437, 4566.063956888863, 4570.017446249072, 2860.199144239616, 2974.776891733107, 2985.4775414302626, 3010.834404107773, 3027.1070034339923, 967.911216497246, 992.5583115513599, 999.5801763259376, 1007.153990647852, 1011.7622358745689, 10763.461826908624, 10832.133429325635, 10840.67477975662, 10860.1311895049, 10867.402292873889, 4019.979900100481, 4063.349864021742, 4251.617354438115, 4282.250606143974, 4287.206866729665, 9068.773280667903, 9082.727518174466, 9086.500242486727, 9092.408993415407, 9129.543522823833, 4590.5638964299005, 4602.562756538124, 4608.101420223092, 4612.285095810154, 4613.192691279013, 4056.0671045659665, 4173.561776013536, 4197.8320867164975, 4202.474690663667, 4213.705040647186, 3596.118950857057, 3665.413533834627, 3739.476473293741, 3777.660010599059, 3784.110733977513, 1057.1595581512715, 1142.4744617476053, 1183.9940800295944, 1190.6368557589844, 1223.137687930025, 768.4352001279055, 796.4305521552118, 799.2247519905799, 806.1696452653777, 819.4100247821559, 4989.625778066587, 5015.573676237561, 5107.208382700687, 5131.409887862869, 5190.506901844319, 819.5082950229934, 840.3487297344485, 851.6763629820753, 877.4910551879894, 894.0924961164424, 3418.7948723076697, 3556.3065202285306, 3630.945535816965, 3639.654232847928, 3685.244524872395, 9194.172524472695, 9476.431414115175, 9590.376625519319, 9621.422714637145, 9658.613655453844, 9331.066893310615, 9522.714318570454, 9569.856452153223, 9570.234381249484, 9580.473073980858, 6890.621015844176, 6988.37104660583, 7053.153621565445, 7053.576785392893, 7056.647167641598, 4926.162552366178, 4947.40631124253, 4981.153203955409, 5015.749212539431, 5229.084910140787, 8634.438761480484, 8723.040465548658, 8811.33914956368, 8853.380263381501, 8889.333300002654, 8823.382363234512, 8940.73177804667, 9012.63949442015, 9062.093790620886, 9063.13900179482, 6558.508111891531, 6588.308227636029, 6630.635315057718, 6633.535652504278, 6639.402453779183, 7132.643367831692, 7190.0, 7194.100737407824, 7194.820129496805, 7197.316254955771, 6379.393957574023, 6396.040593910764, 6431.131797207504, 6439.8068057958335, 6583.868322633425, 6409.198850143732, 6424.935750642434, 6489.448396886318, 6497.610143391223, 6513.185851768529, 6150.630962142286, 6162.291336496181, 6201.0388389799655, 6213.130161777264, 6214.2853571838, 4517.638588912945, 4553.863384098482, 4570.154521413549, 4592.862214133581, 4598.563136502027, 4520.434945631796, 4557.726536407826, 4558.77206139685, 4662.090892275974, 4674.322223277673], "value": 4102.305735792704, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.7855997282025, 296.810041573393, 300.2958063341464, 301.3957016182555, 307.34842134674494, 4621.428714237159, 4742.525747425264, 4800.807967681293, 4801.639877009221, 4826.517348265176, 4497.325401189823, 4736.3842700448895, 4736.715797052179, 4737.597304229136, 4752.857414277569, 3780.865740277906, 3781.1681430085337, 3786.3752480840626, 3787.9810600946957, 3788.2234142000893, 3585.0320413488344, 3804.391297392418, 3804.7254169852995, 3816.694664426839, 3840.923181536368, 3623.40213864712, 3641.908952276188, 3744.64425879541, 3746.756460830037, 3750.2312026034733, 3722.3113723960882, 3735.084904198475, 3735.6451137141926, 3747.7189210809297, 3748.3815170496837, 3300.174956260935, 3320.169957510622, 3326.434506133963, 3335.8832440864453, 3352.916177095568, 4479.686421950465, 4625.1443482955765, 4625.8149674013, 4633.355158918603, 4675.742834144121, 4250.04374015847, 4252.55348188442, 4254.851080212208, 4266.84795105323, 4310.762908040057, 4936.4076310842565, 4936.6050715943, 4943.0, 4982.153033984231, 4985.426675932278, 3503.929921401583, 3617.2584620152807, 3619.7466177367596, 3627.691646210049, 3643.544556930384, 5097.1844504879045, 5134.178531434953, 5135.3067335909545, 5171.4311425743135, 5199.4800519948085, 3714.7771133732062, 3718.8140592970785, 3723.343112314994, 3729.8321575529167, 3768.736188466781, 3807.695384369244, 3808.200277941608, 3813.5423749149722, 3814.6948244140403, 3815.0, 4186.392973018896, 4247.766372849523, 4273.273543497613, 4290.227759003409, 4293.377460268306, 4939.147819567662, 4947.604191664658, 4962.33008543842, 4963.081829861487, 4968.826091086795, 1237.616338934933, 1304.2696090189525, 1319.162331919219, 1319.4326439631052, 1323.9669008274677, 855.9957200213959, 874.9956250218709, 875.3916028360355, 880.5641207602278, 891.7948871759531, 4355.930932806955, 4366.563343665608, 4370.6451000190045, 4371.934420983688, 4382.663287697219, 5032.735269128833, 5045.949540504622, 5050.797968081309, 5060.51925067118, 5101.387833460009, 4257.0, 4341.15347507233, 4369.815092453773, 4370.208214631985, 4382.320740285261, 2677.42435376395, 2681.410089780284, 2688.6101515280175, 2688.623592697024, 2708.1469337158733, 4732.976335118371, 4762.261849413347, 4765.499622539653, 4780.498047704941, 4783.904321913612, 4945.480724523945, 5151.97424012885, 5164.7934082636275, 5167.560757335594, 5229.738513074331, 4637.976810115928, 4655.767211639404, 4680.010995326905, 4741.193997020515, 4748.857534273978, 5023.1711767557945, 5037.748112594429, 5043.596512278936, 5047.7476126192805, 5052.772625231947, 4761.500042495488, 4947.950520494749, 5028.698278103179, 5045.738565358661, 5051.3433253676785, 4808.519148085164, 4813.590844778233, 4815.759212039314, 4827.08285425768, 4831.51684831514, 3637.563492380931, 3639.872604458831, 3642.5264715586804, 3651.561812582507, 3665.0, 5012.7718708916545, 5096.9298528092295, 5123.873592459087, 5150.819721309736, 5182.719603374503, 4999.150144475375, 5007.422661861502, 5011.373578302712, 5015.824446144367, 5024.824131155392, 4970.40355157369, 4995.700257984533, 5012.273220383097, 5056.57019153376, 5081.822136225214, 4721.504242054672, 4794.784234709517, 4923.778429970732, 4959.553640172402, 5032.874178145429, 4940.604751619933, 5028.296038554532, 5029.949700502948, 5031.974840125776, 5041.521055499722, 4907.582855457326, 4915.705057696549, 4922.483139270325, 4992.850214493571, 5007.424146223231], "value": 3768.6621346468905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.4202191961475, 628.6185288538885, 662.3707477895994, 676.7529851604163, 713.1976526407791, 12456.750864982707, 13470.191788492673, 13482.797758033637, 13485.797713034312, 13497.730045399087, 12548.560800371988, 12725.045621578372, 12732.108752387336, 12749.235045897252, 12752.80870786939, 604.7580967612968, 711.7153138744518, 731.7365748330596, 736.8599966006468, 743.9739609113682, 743.7619961612286, 752.3417010116149, 752.6462562595572, 752.7515919746498, 752.8569571781371, 800.6917336825306, 804.2078552625659, 804.4730701390598, 804.8671969125087, 805.1586092533316, 634.5050860328951, 770.9383249340095, 798.2217338095311, 799.8160423102661, 804.4328748232482, 580.4862696513574, 581.1573218832667, 581.5434883616341, 582.2169182449641, 583.1602492410915, 12659.050571207104, 12708.87291127086, 12712.872871271262, 12713.17364371313, 12733.936330318382, 12280.263184208976, 12536.310502922335, 12779.361031948458, 13029.34853257343, 13223.669408264774, 11754.412279385997, 11803.11476639247, 11929.522819087226, 12229.816552751716, 12308.692282693004, 4054.695897807647, 4065.0, 4098.4876890388705, 4227.8097485613225, 4267.573242675739, 61491.69254153745, 61550.0, 61942.38057619456, 62088.379116209166, 62578.0, 10039.70899971141, 10214.693559193236, 10217.948910255402, 10273.280870339155, 10393.48032598367, 19022.80977190238, 19045.333413330467, 19122.139503722086, 19133.23467061302, 19148.329808456638, 6786.728530858809, 6786.898196527056, 6803.0135630333325, 6848.280930502325, 7107.253738357502, 3709.4064949608473, 3816.9236615268096, 3843.1929294847837, 3844.8077596120083, 3914.178022615226, 2737.9589306160424, 2826.9964162721935, 2829.858507074638, 2830.801843870909, 2836.1066264126734, 481.6556162343941, 485.03236044091557, 487.4832677362008, 500.364537037967, 506.04105220606743, 538.2706432783522, 549.8927709096768, 556.3768579191332, 559.9188117722989, 584.3542885111975, 7013.824654383579, 7357.668904899292, 7463.179050304462, 7567.091948966159, 7627.313541781266, 460.1625042422758, 531.1103900965867, 540.9107497262908, 546.0853071105881, 563.090608667008, 3450.240946991658, 3583.7670551414076, 3587.264610754841, 3689.538807649044, 3773.603771603997, 59343.0, 102740.0, 103492.48253758834, 106200.46899765452, 106953.0, 85111.57444212864, 86668.56665716632, 86853.0, 87630.56184719036, 88220.55889720639, 46331.5366846334, 47217.29174062392, 55477.2261386929, 64330.0, 75883.0, 6604.5046621502615, 6686.732530698718, 6856.6228857413325, 6898.310168983062, 6948.791536253921, 33343.0, 45488.31767523423, 45642.315365268885, 45787.31319030284, 47674.76162619165, 37030.0, 41166.0, 62252.06621900584, 65064.0, 66200.0, 9471.242300616072, 9544.856827147738, 9571.569279382584, 9596.088371604686, 10060.547275372479, 9710.951445242728, 10397.53211105487, 10514.369137851754, 10985.61550345734, 11953.402329883646, 10261.692149235534, 10461.424621645883, 10469.162467002774, 10597.841032384675, 10768.300060496043, 9718.12536871685, 10028.29801913859, 10044.0, 10082.092611664986, 10264.178865690876, 10313.432761198206, 10416.635417760343, 10528.894711052792, 10625.628103016357, 10785.460726963778, 8028.4781489203015, 8082.434229603871, 8171.7548473545885, 8267.669293228204, 8723.956380218058, 8186.54973976437, 8519.275861551838, 8581.313494920267, 8797.12028797115, 8903.866442003504], "value": 6219.5839095998645, "unit": "score"}], "name": "dromaeo_css", "value": 6227.628469697267, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 133.0, 113.0, 112.0, 114.0, 114.0, 113.0, 113.0, 112.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 145.0, 194.0, 126.0, 149.0, 155.0, 125.0, 184.0, 127.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 164.0, 163.0, 160.0, 163.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 159.0, 78.0, 75.0, 75.0, 75.0, 156.0, 77.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 159.0, 84.0, 86.0, 83.0, 137.0, 84.0, 83.0, 142.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 119.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 68.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 82.0, 81.0, 93.0, 85.0, 89.0, 87.0, 85.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 139.0, 129.0, 132.0, 131.0, 142.0, 138.0, 131.0, 176.0, 133.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 179.0, 176.0, 176.0, 176.0, 175.0, 170.0, 169.0, 173.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 70.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1579.3000000000002, "alertThreshold": 2.0}]} 08:50:30 INFO - Return code: 0 08:50:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:50:30 INFO - # TBPL SUCCESS # 08:50:30 INFO - Running post-action listener: _resource_record_post_action 08:50:30 INFO - [mozharness: 2016-08-31 15:50:30.079146Z] Finished run-tests step (success) 08:50:30 INFO - Running post-run listener: _resource_record_post_run 08:50:30 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 12288; Write bytes: 408621056; Read time: 176; Write time: 266420 08:50:30 INFO - TinderboxPrint: CPU usage
13.0% 08:50:30 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 176 08:50:30 INFO - TinderboxPrint: I/O write bytes / time
408,621,056 / 266,420 08:50:30 INFO - TinderboxPrint: CPU idle
8,342.1 (87.0%) 08:50:30 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 08:50:30 INFO - TinderboxPrint: Swap in / out
0 / 0 08:50:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114290688; Read time: 0; Write time: 103244 08:50:30 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294330368; Read time: 168; Write time: 163176 08:50:30 INFO - Running post-run listener: _upload_blobber_files 08:50:30 INFO - Blob upload gear active. 08:50:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:50:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:50:30 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:50:30 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:50:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:50:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:31 INFO - (blobuploader) - INFO - Done attempting. 08:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:50:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:32 INFO - (blobuploader) - INFO - Done attempting. 08:50:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:50:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:37 INFO - (blobuploader) - INFO - Done attempting. 08:50:37 INFO - (blobuploader) - INFO - Iteration through files over. 08:50:37 INFO - Return code: 0 08:50:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:50:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:50:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/87b0f223de5609c33fb3995969ae701528ed2f2ebc98a482e17cc5f8a1bcc83ce5df6164f67ee440d7cfe8a1b34b2c66cf988889b30e1c060d4215a218fdda77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ee51f9fceab42d8a5efa90d649bb2ce4c9db905f7779da2a9ed9b5924a1c33c8fce1a5074981745646ca82e7fe66a991241bc48a2ae2d508b22ab7d5a21ba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6a363207c7204be63f0df05c2b78f4bc319c3786dfecef887f19513c58feb74c666f4deb961ce9bbfb581f24c6ae4d480e7e47a7711f50cf30a3b49e761935e"} 08:50:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:50:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:50:37 INFO - Contents: 08:50:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/87b0f223de5609c33fb3995969ae701528ed2f2ebc98a482e17cc5f8a1bcc83ce5df6164f67ee440d7cfe8a1b34b2c66cf988889b30e1c060d4215a218fdda77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ee51f9fceab42d8a5efa90d649bb2ce4c9db905f7779da2a9ed9b5924a1c33c8fce1a5074981745646ca82e7fe66a991241bc48a2ae2d508b22ab7d5a21ba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6a363207c7204be63f0df05c2b78f4bc319c3786dfecef887f19513c58feb74c666f4deb961ce9bbfb581f24c6ae4d480e7e47a7711f50cf30a3b49e761935e"} 08:50:37 INFO - Running post-run listener: copy_logs_to_upload_dir 08:50:37 INFO - Copying logs to upload dir... 08:50:37 INFO - mkdir: /builds/slave/test/build/upload/logs 08:50:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.114910 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-31 08:50:36.867226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 08:50:36.870529) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/87b0f223de5609c33fb3995969ae701528ed2f2ebc98a482e17cc5f8a1bcc83ce5df6164f67ee440d7cfe8a1b34b2c66cf988889b30e1c060d4215a218fdda77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ee51f9fceab42d8a5efa90d649bb2ce4c9db905f7779da2a9ed9b5924a1c33c8fce1a5074981745646ca82e7fe66a991241bc48a2ae2d508b22ab7d5a21ba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6a363207c7204be63f0df05c2b78f4bc319c3786dfecef887f19513c58feb74c666f4deb961ce9bbfb581f24c6ae4d480e7e47a7711f50cf30a3b49e761935e"} build_url:https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/apTrDa7pQ8GqaVF6MX7LBg/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/Autoland-Non-PGO/sha512/87b0f223de5609c33fb3995969ae701528ed2f2ebc98a482e17cc5f8a1bcc83ce5df6164f67ee440d7cfe8a1b34b2c66cf988889b30e1c060d4215a218fdda77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4ee51f9fceab42d8a5efa90d649bb2ce4c9db905f7779da2a9ed9b5924a1c33c8fce1a5074981745646ca82e7fe66a991241bc48a2ae2d508b22ab7d5a21ba2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6a363207c7204be63f0df05c2b78f4bc319c3786dfecef887f19513c58feb74c666f4deb961ce9bbfb581f24c6ae4d480e7e47a7711f50cf30a3b49e761935e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 08:50:36.896001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:50:36.896377) ========= 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=4ac8d263c7293b36a1be1aed000001be-1472657342.229599-2133966033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 08:50:36.981194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 08:50:36.981533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 08:50:36.981862) ========= ========= Total master_lag: 0.19 =========