builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1470364556.98 results: success (0) buildid: 20160804182120 builduid: c1100e1fea4f440da673c991bcbb9523 revision: 0f1333d8cf910d0679bc8a7b6d6673d9bd92ba7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:56.976074) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:56.976616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:56.976914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.010251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.010576) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 19:35:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-08-04 19:35:57 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.122142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.122654) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014891 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.192878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.193483) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0f1333d8cf910d0679bc8a7b6d6673d9bd92ba7b --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 0f1333d8cf910d0679bc8a7b6d6673d9bd92ba7b --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=652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 19:35:57,615 truncating revision to first 12 chars 2016-08-04 19:35:57,615 Setting DEBUG logging. 2016-08-04 19:35:57,615 attempt 1/10 2016-08-04 19:35:57,615 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0f1333d8cf91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 19:35:57,914 unpacking tar archive at: autoland-0f1333d8cf91/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.862094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.862436) ========= script_repo_revision: 0f1333d8cf910d0679bc8a7b6d6673d9bd92ba7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.862871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.863149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 19:35:57.873031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-04 19:35:57.873455) ========= /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=652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:35:58 INFO - MultiFileLogger online at 20160804 19:35:58 in /builds/slave/test 19:35:58 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 19:35:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:35:58 INFO - {'append_to_log': False, 19:35:58 INFO - 'base_work_dir': '/builds/slave/test', 19:35:58 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 19:35:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:35:58 INFO - 'branch': 'Autoland-Non-PGO', 19:35:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:35:58 INFO - 'config_files': ('talos/linux_config.py',), 19:35:58 INFO - 'default_actions': ('clobber', 19:35:58 INFO - 'read-buildbot-config', 19:35:58 INFO - 'download-and-extract', 19:35:58 INFO - 'populate-webroot', 19:35:58 INFO - 'create-virtualenv', 19:35:58 INFO - 'install', 19:35:58 INFO - 'run-tests'), 19:35:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:35:58 INFO - 'download_minidump_stackwalk': True, 19:35:58 INFO - 'download_symbols': 'ondemand', 19:35:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:35:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:35:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:35:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:35:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:35:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:35:58 INFO - 'installer_path': 'installer.exe', 19:35:58 INFO - 'log_level': 'info', 19:35:58 INFO - 'log_name': 'talos', 19:35:58 INFO - 'log_to_console': True, 19:35:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:35:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:35:58 INFO - 'opt_config_files': (), 19:35:58 INFO - 'pip_index': False, 19:35:58 INFO - 'sps_profile': False, 19:35:58 INFO - 'sps_profile_interval': 0, 19:35:58 INFO - 'suite': 'dromaeojs', 19:35:58 INFO - 'system_bits': '32', 19:35:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:35:58 INFO - 'title': 'talos-linux64-ix-046', 19:35:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:35:58 INFO - 'use_talos_json': True, 19:35:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:35:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:35:58 INFO - 'work_dir': 'build'} 19:35:58 INFO - [mozharness: 2016-08-05 02:35:58.386637Z] Running clobber step. 19:35:58 INFO - Running pre-action listener: _resource_record_pre_action 19:35:58 INFO - Running main action method: clobber 19:35:58 INFO - rmtree: /builds/slave/test/build 19:35:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:35:58 INFO - Running post-action listener: _resource_record_post_action 19:35:58 INFO - [mozharness: 2016-08-05 02:35:58.851823Z] Finished clobber step (success) 19:35:58 INFO - [mozharness: 2016-08-05 02:35:58.851924Z] Running read-buildbot-config step. 19:35:58 INFO - Running pre-action listener: _resource_record_pre_action 19:35:58 INFO - Running main action method: read_buildbot_config 19:35:58 INFO - Using buildbot properties: 19:35:58 INFO - { 19:35:58 INFO - "project": "", 19:35:58 INFO - "product": "firefox", 19:35:58 INFO - "script_repo_revision": "production", 19:35:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 19:35:58 INFO - "repository": "", 19:35:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 19:35:58 INFO - "buildid": "20160804182120", 19:35:58 INFO - "pgo_build": "False", 19:35:58 INFO - "basedir": "/builds/slave/test", 19:35:58 INFO - "buildnumber": 219, 19:35:58 INFO - "slavename": "talos-linux64-ix-046", 19:35:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:35:58 INFO - "platform": "ubuntu64_hw", 19:35:58 INFO - "scheduler": "tests-autoland-linux64-talos", 19:35:58 INFO - "branch": "autoland", 19:35:58 INFO - "repo_path": "integration/autoland", 19:35:58 INFO - "revision": "0f1333d8cf910d0679bc8a7b6d6673d9bd92ba7b", 19:35:58 INFO - "stage_platform": "linux64", 19:35:58 INFO - "builduid": "c1100e1fea4f440da673c991bcbb9523", 19:35:58 INFO - "slavebuilddir": "test" 19:35:58 INFO - } 19:35:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:35:58 INFO - Running post-action listener: _resource_record_post_action 19:35:58 INFO - [mozharness: 2016-08-05 02:35:58.854380Z] Finished read-buildbot-config step (success) 19:35:58 INFO - [mozharness: 2016-08-05 02:35:58.854468Z] Running download-and-extract step. 19:35:58 INFO - Running pre-action listener: _resource_record_pre_action 19:35:58 INFO - Running main action method: download_and_extract 19:35:58 INFO - mkdir: /builds/slave/test/build/tests 19:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:58 INFO - trying https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:35:59 INFO - Downloaded 1361 bytes. 19:35:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:35:59 INFO - Using the following test package requirements: 19:35:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:35:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:35:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:35:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'jsshell-linux-x86_64.zip'], 19:35:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:35:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:35:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:35:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:35:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:35:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:35:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:35:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:59 INFO - trying https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:35:59 INFO - Downloading https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:36:01 INFO - Downloaded 20249247 bytes. 19:36:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 19:36:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:05 INFO - trying https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:36:05 INFO - Downloading https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:36:06 INFO - Downloaded 20249247 bytes. 19:36:06 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 19:36: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')]} 19:36:11 INFO - trying https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:11 INFO - Downloading https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:36:12 INFO - Downloaded 14413723 bytes. 19:36:12 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 19:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:13 INFO - trying https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:36:13 INFO - Downloading https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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 19:36:17 INFO - Downloaded 55655051 bytes. 19:36:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:36:17 INFO - mkdir: /builds/slave/test/properties 19:36:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:17 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:17 INFO - Contents: 19:36:17 INFO - build_url:https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:36:18 INFO - Running post-action listener: _resource_record_post_action 19:36:18 INFO - Running post-action listener: set_extra_try_arguments 19:36:18 INFO - [mozharness: 2016-08-05 02:36:18.054647Z] Finished download-and-extract step (success) 19:36:18 INFO - [mozharness: 2016-08-05 02:36:18.054873Z] Running populate-webroot step. 19:36:18 INFO - Running pre-action listener: _resource_record_pre_action 19:36:18 INFO - Running main action method: populate_webroot 19:36:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:18 INFO - '--tppagecycles', 19:36:18 INFO - '7'], 19:36:18 INFO - 'tests': ['tsvgm']}}, 19:36:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:36:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:36:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['damp', 'tps']}, 19:36:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'tests': ['damp', 'tps']}, 19:36:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['dromaeo_dom']}, 19:36:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['basic_compositor_video']}, 19:36:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:36:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other-e10s': {'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['a11yr', 19:36:18 INFO - 'ts_paint', 19:36:18 INFO - 'tpaint', 19:36:18 INFO - 'sessionrestore', 19:36:18 INFO - 'sessionrestore_no_auto_restore', 19:36:18 INFO - 'tabpaint']}, 19:36:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['tsvgx', 19:36:18 INFO - 'tsvgr_opacity', 19:36:18 INFO - 'tart', 19:36:18 INFO - 'tscrollx', 19:36:18 INFO - 'cart']}, 19:36:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:36:18 INFO - 'tsvgr_opacity', 19:36:18 INFO - 'tart', 19:36:18 INFO - 'tscrollx', 19:36:18 INFO - 'cart']}, 19:36:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--disable-e10s'], 19:36:18 INFO - 'tests': ['tp5o']}, 19:36:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'tests': ['tp5o']}, 19:36:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--disable-e10s', 19:36:18 INFO - '--xperf_path', 19:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:18 INFO - 'tests': ['tp5n']}, 19:36:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:18 INFO - 'talos_options': ['--xperf_path', 19:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:18 INFO - 'tests': ['tp5n']}}, 19:36:18 INFO - 'talos.zip': {'path': '', 19:36:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:18 INFO - Running post-action listener: _resource_record_post_action 19:36:18 INFO - [mozharness: 2016-08-05 02:36:18.074811Z] Finished populate-webroot step (success) 19:36:18 INFO - [mozharness: 2016-08-05 02:36:18.074900Z] Running create-virtualenv step. 19:36:18 INFO - Running pre-action listener: _resource_record_pre_action 19:36:18 INFO - Running main action method: create_virtualenv 19:36:18 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:18 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 19:36:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:18 INFO - Using real prefix '/usr' 19:36:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:18 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:20 INFO - Installing pip.................done. 19:36:20 INFO - Return code: 0 19:36:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:20 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 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:20 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 19:36:20 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 19:36:20 INFO - Using env: {'DISPLAY': ':0', 19:36:20 INFO - 'HOME': '/home/cltbld', 19:36:20 INFO - 'LANG': 'en_US.UTF-8', 19:36:20 INFO - 'LANGUAGE': 'en_US:en', 19:36:20 INFO - 'LOGNAME': 'cltbld', 19:36:20 INFO - 'MAIL': '/var/mail/cltbld', 19:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:20 INFO - 'MOZ_NO_REMOTE': '1', 19:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:20 INFO - 'NO_EM_RESTART': '1', 19:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:20 INFO - 'PWD': '/builds/slave/test', 19:36:20 INFO - 'SHELL': '/bin/bash', 19:36:20 INFO - 'SHLVL': '1', 19:36:20 INFO - 'TERM': 'linux', 19:36:20 INFO - 'TMOUT': '86400', 19:36:20 INFO - 'USER': 'cltbld', 19:36:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:20 INFO - '_': '/tools/buildbot/bin/python'} 19:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:20 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 19:36:20 INFO - Cleaning up... 19:36:20 INFO - Return code: 0 19:36:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:20 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 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:20 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 19:36:20 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 19:36:20 INFO - Using env: {'DISPLAY': ':0', 19:36:20 INFO - 'HOME': '/home/cltbld', 19:36:20 INFO - 'LANG': 'en_US.UTF-8', 19:36:20 INFO - 'LANGUAGE': 'en_US:en', 19:36:20 INFO - 'LOGNAME': 'cltbld', 19:36:20 INFO - 'MAIL': '/var/mail/cltbld', 19:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:20 INFO - 'MOZ_NO_REMOTE': '1', 19:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:20 INFO - 'NO_EM_RESTART': '1', 19:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:20 INFO - 'PWD': '/builds/slave/test', 19:36:20 INFO - 'SHELL': '/bin/bash', 19:36:20 INFO - 'SHLVL': '1', 19:36:20 INFO - 'TERM': 'linux', 19:36:20 INFO - 'TMOUT': '86400', 19:36:20 INFO - 'USER': 'cltbld', 19:36:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:20 INFO - '_': '/tools/buildbot/bin/python'} 19:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:21 INFO - Downloading/unpacking psutil>=3.1.1 19:36:21 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 19:36:21 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 19:36:21 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 19:36:21 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 19:36:21 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 19:36:21 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 19:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:23 INFO - Installing collected packages: psutil 19:36:23 INFO - Running setup.py install for psutil 19:36:23 INFO - building 'psutil._psutil_linux' extension 19:36:23 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 19:36:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:36:23 INFO - building 'psutil._psutil_posix' extension 19:36:23 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 19:36:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:36:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:23 INFO - Successfully installed psutil 19:36:23 INFO - Cleaning up... 19:36:23 INFO - Return code: 0 19:36:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:36:23 INFO - Using env: {'DISPLAY': ':0', 19:36:23 INFO - 'HOME': '/home/cltbld', 19:36:23 INFO - 'LANG': 'en_US.UTF-8', 19:36:23 INFO - 'LANGUAGE': 'en_US:en', 19:36:23 INFO - 'LOGNAME': 'cltbld', 19:36:23 INFO - 'MAIL': '/var/mail/cltbld', 19:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:23 INFO - 'MOZ_NO_REMOTE': '1', 19:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:23 INFO - 'NO_EM_RESTART': '1', 19:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:23 INFO - 'PWD': '/builds/slave/test', 19:36:23 INFO - 'SHELL': '/bin/bash', 19:36:23 INFO - 'SHLVL': '1', 19:36:23 INFO - 'TERM': 'linux', 19:36:23 INFO - 'TMOUT': '86400', 19:36:23 INFO - 'USER': 'cltbld', 19:36:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:23 INFO - '_': '/tools/buildbot/bin/python'} 19:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:36:25 INFO - Installing collected packages: mozsystemmonitor 19:36:25 INFO - Running setup.py install for mozsystemmonitor 19:36:25 INFO - Successfully installed mozsystemmonitor 19:36:25 INFO - Cleaning up... 19:36:25 INFO - Return code: 0 19:36:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:36:25 INFO - Using env: {'DISPLAY': ':0', 19:36:25 INFO - 'HOME': '/home/cltbld', 19:36:25 INFO - 'LANG': 'en_US.UTF-8', 19:36:25 INFO - 'LANGUAGE': 'en_US:en', 19:36:25 INFO - 'LOGNAME': 'cltbld', 19:36:25 INFO - 'MAIL': '/var/mail/cltbld', 19:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:25 INFO - 'MOZ_NO_REMOTE': '1', 19:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:25 INFO - 'NO_EM_RESTART': '1', 19:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:25 INFO - 'PWD': '/builds/slave/test', 19:36:25 INFO - 'SHELL': '/bin/bash', 19:36:25 INFO - 'SHLVL': '1', 19:36:25 INFO - 'TERM': 'linux', 19:36:25 INFO - 'TMOUT': '86400', 19:36:25 INFO - 'USER': 'cltbld', 19:36:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:25 INFO - '_': '/tools/buildbot/bin/python'} 19:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:26 INFO - Downloading/unpacking jsonschema==2.5.1 19:36:26 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 19:36:26 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 19:36:26 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 19:36:26 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 19:36:26 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 19:36:26 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 19:36:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:28 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:28 INFO - warning: no files found matching '*.txt' 19:36:28 INFO - no previously-included directories found matching 'build' 19:36:28 INFO - no previously-included directories found matching 'dist' 19:36:28 INFO - no previously-included directories found matching '.git*' 19:36:28 INFO - Installing collected packages: jsonschema, functools32 19:36:28 INFO - Running setup.py install for functools32 19:36:28 INFO - warning: no files found matching '*.txt' 19:36:28 INFO - no previously-included directories found matching 'build' 19:36:28 INFO - no previously-included directories found matching 'dist' 19:36:28 INFO - no previously-included directories found matching '.git*' 19:36:28 INFO - Successfully installed jsonschema functools32 19:36:28 INFO - Cleaning up... 19:36:28 INFO - Return code: 0 19:36:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:36:28 INFO - Using env: {'DISPLAY': ':0', 19:36:28 INFO - 'HOME': '/home/cltbld', 19:36:28 INFO - 'LANG': 'en_US.UTF-8', 19:36:28 INFO - 'LANGUAGE': 'en_US:en', 19:36:28 INFO - 'LOGNAME': 'cltbld', 19:36:28 INFO - 'MAIL': '/var/mail/cltbld', 19:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:28 INFO - 'MOZ_NO_REMOTE': '1', 19:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:28 INFO - 'NO_EM_RESTART': '1', 19:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:28 INFO - 'PWD': '/builds/slave/test', 19:36:28 INFO - 'SHELL': '/bin/bash', 19:36:28 INFO - 'SHLVL': '1', 19:36:28 INFO - 'TERM': 'linux', 19:36:28 INFO - 'TMOUT': '86400', 19:36:28 INFO - 'USER': 'cltbld', 19:36:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:28 INFO - '_': '/tools/buildbot/bin/python'} 19:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:36:28 INFO - Cleaning up... 19:36:28 INFO - Return code: 0 19:36:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:36:28 INFO - Using env: {'DISPLAY': ':0', 19:36:28 INFO - 'HOME': '/home/cltbld', 19:36:28 INFO - 'LANG': 'en_US.UTF-8', 19:36:28 INFO - 'LANGUAGE': 'en_US:en', 19:36:28 INFO - 'LOGNAME': 'cltbld', 19:36:28 INFO - 'MAIL': '/var/mail/cltbld', 19:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:28 INFO - 'MOZ_NO_REMOTE': '1', 19:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:28 INFO - 'NO_EM_RESTART': '1', 19:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:28 INFO - 'PWD': '/builds/slave/test', 19:36:28 INFO - 'SHELL': '/bin/bash', 19:36:28 INFO - 'SHLVL': '1', 19:36:28 INFO - 'TERM': 'linux', 19:36:28 INFO - 'TMOUT': '86400', 19:36:28 INFO - 'USER': 'cltbld', 19:36:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:28 INFO - '_': '/tools/buildbot/bin/python'} 19:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:28 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 INFO - Downloading docopt-0.6.1.tar.gz 19:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:31 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:31 INFO - Running setup.py install for blobuploader 19:36:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:31 INFO - Running setup.py install for requests 19:36:32 INFO - Running setup.py install for docopt 19:36:32 INFO - Successfully installed blobuploader requests docopt 19:36:32 INFO - Cleaning up... 19:36:32 INFO - Return code: 0 19:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:32 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 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:32 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 19:36:32 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 19:36:32 INFO - Using env: {'DISPLAY': ':0', 19:36:32 INFO - 'HOME': '/home/cltbld', 19:36:32 INFO - 'LANG': 'en_US.UTF-8', 19:36:32 INFO - 'LANGUAGE': 'en_US:en', 19:36:32 INFO - 'LOGNAME': 'cltbld', 19:36:32 INFO - 'MAIL': '/var/mail/cltbld', 19:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:32 INFO - 'MOZ_NO_REMOTE': '1', 19:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:32 INFO - 'NO_EM_RESTART': '1', 19:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:32 INFO - 'PWD': '/builds/slave/test', 19:36:32 INFO - 'SHELL': '/bin/bash', 19:36:32 INFO - 'SHLVL': '1', 19:36:32 INFO - 'TERM': 'linux', 19:36:32 INFO - 'TMOUT': '86400', 19:36:32 INFO - 'USER': 'cltbld', 19:36:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:32 INFO - '_': '/tools/buildbot/bin/python'} 19:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:32 INFO - Running setup.py (path:/tmp/pip-Zz9vsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:32 INFO - Running setup.py (path:/tmp/pip-pqhAYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:32 INFO - Running setup.py (path:/tmp/pip-8BgsSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:32 INFO - Running setup.py (path:/tmp/pip-vAM4d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:32 INFO - Running setup.py (path:/tmp/pip-nZ31PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:32 INFO - Running setup.py (path:/tmp/pip-mL2mdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:32 INFO - Running setup.py (path:/tmp/pip-lxcJs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:32 INFO - Running setup.py (path:/tmp/pip-vtolT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:32 INFO - Running setup.py (path:/tmp/pip-c1tBok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:33 INFO - Running setup.py (path:/tmp/pip-PBEds3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:33 INFO - Running setup.py (path:/tmp/pip-8igJT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:33 INFO - Running setup.py (path:/tmp/pip-dSTGEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:33 INFO - Running setup.py (path:/tmp/pip-brZdrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:33 INFO - Running setup.py (path:/tmp/pip-05zd8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:33 INFO - Running setup.py (path:/tmp/pip-uuYVlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:33 INFO - Running setup.py (path:/tmp/pip-yYTx0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:33 INFO - Running setup.py (path:/tmp/pip-dk8kfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:33 INFO - Running setup.py install for manifestparser 19:36:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Running setup.py install for mozcrash 19:36:33 INFO - Running setup.py install for mozdebug 19:36:33 INFO - Running setup.py install for mozdevice 19:36:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozfile 19:36:34 INFO - Running setup.py install for mozhttpd 19:36:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozinfo 19:36:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozInstall 19:36:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozleak 19:36:34 INFO - Running setup.py install for mozlog 19:36:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for moznetwork 19:36:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozprocess 19:36:34 INFO - Running setup.py install for mozprofile 19:36:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozrunner 19:36:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for mozscreenshot 19:36:35 INFO - Running setup.py install for moztest 19:36:35 INFO - Running setup.py install for mozversion 19:36:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:35 INFO - Cleaning up... 19:36:35 INFO - Return code: 0 19:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:35 INFO - Using env: {'DISPLAY': ':0', 19:36:35 INFO - 'HOME': '/home/cltbld', 19:36:35 INFO - 'LANG': 'en_US.UTF-8', 19:36:35 INFO - 'LANGUAGE': 'en_US:en', 19:36:35 INFO - 'LOGNAME': 'cltbld', 19:36:35 INFO - 'MAIL': '/var/mail/cltbld', 19:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:35 INFO - 'MOZ_NO_REMOTE': '1', 19:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:35 INFO - 'NO_EM_RESTART': '1', 19:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:35 INFO - 'PWD': '/builds/slave/test', 19:36:35 INFO - 'SHELL': '/bin/bash', 19:36:35 INFO - 'SHLVL': '1', 19:36:35 INFO - 'TERM': 'linux', 19:36:35 INFO - 'TMOUT': '86400', 19:36:35 INFO - 'USER': 'cltbld', 19:36:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:35 INFO - '_': '/tools/buildbot/bin/python'} 19:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:35 INFO - Running setup.py (path:/tmp/pip-AylIie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:35 INFO - Running setup.py (path:/tmp/pip-xX6x1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:35 INFO - Running setup.py (path:/tmp/pip-uuwVIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:35 INFO - Running setup.py (path:/tmp/pip-m_G95m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:35 INFO - Running setup.py (path:/tmp/pip-xVk_Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:36 INFO - Running setup.py (path:/tmp/pip-518DcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:36 INFO - Running setup.py (path:/tmp/pip-bRnYzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:36 INFO - Running setup.py (path:/tmp/pip-t6MIAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:36 INFO - Running setup.py (path:/tmp/pip-oXHrzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:36 INFO - Running setup.py (path:/tmp/pip-hsvHwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:36 INFO - Running setup.py (path:/tmp/pip-_LBiK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:36 INFO - Running setup.py (path:/tmp/pip-60PmeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:36 INFO - Running setup.py (path:/tmp/pip-8WsqRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:36 INFO - Running setup.py (path:/tmp/pip-Zh30xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:36 INFO - Running setup.py (path:/tmp/pip-CIL8Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:36 INFO - Running setup.py (path:/tmp/pip-EbUFya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:36 INFO - Running setup.py (path:/tmp/pip-5cSVIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:39 INFO - Downloading blessings-1.6.tar.gz 19:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:39 INFO - Installing collected packages: blessings 19:36:39 INFO - Running setup.py install for blessings 19:36:39 INFO - Successfully installed blessings 19:36:39 INFO - Cleaning up... 19:36:40 INFO - Return code: 0 19:36:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:40 INFO - Reading from file tmpfile_stdout 19:36:40 INFO - Current package versions: 19:36:40 INFO - argparse == 1.2.1 19:36:40 INFO - blessings == 1.6 19:36:40 INFO - blobuploader == 1.2.4 19:36:40 INFO - docopt == 0.6.1 19:36:40 INFO - functools32 == 3.2.3-2 19:36:40 INFO - jsonschema == 2.5.1 19:36:40 INFO - manifestparser == 1.1 19:36:40 INFO - mozInstall == 1.12 19:36:40 INFO - mozcrash == 0.17 19:36:40 INFO - mozdebug == 0.1 19:36:40 INFO - mozdevice == 0.48 19:36:40 INFO - mozfile == 1.2 19:36:40 INFO - mozhttpd == 0.7 19:36:40 INFO - mozinfo == 0.9 19:36:40 INFO - mozleak == 0.1 19:36:40 INFO - mozlog == 3.3 19:36:40 INFO - moznetwork == 0.27 19:36:40 INFO - mozprocess == 0.23 19:36:40 INFO - mozprofile == 0.28 19:36:40 INFO - mozrunner == 6.12 19:36:40 INFO - mozscreenshot == 0.1 19:36:40 INFO - mozsystemmonitor == 0.3 19:36:40 INFO - moztest == 0.7 19:36:40 INFO - mozversion == 1.4 19:36:40 INFO - psutil == 3.1.1 19:36:40 INFO - requests == 1.2.3 19:36:40 INFO - wsgiref == 0.1.2 19:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 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 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:40 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 19:36:40 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 19:36:40 INFO - Using env: {'DISPLAY': ':0', 19:36:40 INFO - 'HOME': '/home/cltbld', 19:36:40 INFO - 'LANG': 'en_US.UTF-8', 19:36:40 INFO - 'LANGUAGE': 'en_US:en', 19:36:40 INFO - 'LOGNAME': 'cltbld', 19:36:40 INFO - 'MAIL': '/var/mail/cltbld', 19:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:40 INFO - 'MOZ_NO_REMOTE': '1', 19:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:40 INFO - 'NO_EM_RESTART': '1', 19:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:40 INFO - 'PWD': '/builds/slave/test', 19:36:40 INFO - 'SHELL': '/bin/bash', 19:36:40 INFO - 'SHLVL': '1', 19:36:40 INFO - 'TERM': 'linux', 19:36:40 INFO - 'TMOUT': '86400', 19:36:40 INFO - 'USER': 'cltbld', 19:36:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:40 INFO - '_': '/tools/buildbot/bin/python'} 19:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 INFO - Cleaning up... 19:36:40 INFO - Return code: 0 19:36:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', '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 19:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:36:40 INFO - Using env: {'DISPLAY': ':0', 19:36:40 INFO - 'HOME': '/home/cltbld', 19:36:40 INFO - 'LANG': 'en_US.UTF-8', 19:36:40 INFO - 'LANGUAGE': 'en_US:en', 19:36:40 INFO - 'LOGNAME': 'cltbld', 19:36:40 INFO - 'MAIL': '/var/mail/cltbld', 19:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:40 INFO - 'MOZ_NO_REMOTE': '1', 19:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:40 INFO - 'NO_EM_RESTART': '1', 19:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:40 INFO - 'PWD': '/builds/slave/test', 19:36:40 INFO - 'SHELL': '/bin/bash', 19:36:40 INFO - 'SHLVL': '1', 19:36:40 INFO - 'TERM': 'linux', 19:36:40 INFO - 'TMOUT': '86400', 19:36:40 INFO - 'USER': 'cltbld', 19:36:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:40 INFO - '_': '/tools/buildbot/bin/python'} 19:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:36:40 INFO - Cleaning up... 19:36:40 INFO - Return code: 0 19:36:40 INFO - Running post-action listener: _resource_record_post_action 19:36:40 INFO - Running post-action listener: _start_resource_monitoring 19:36:40 INFO - Starting resource monitoring. 19:36:40 INFO - [mozharness: 2016-08-05 02:36:40.726471Z] Finished create-virtualenv step (success) 19:36:40 INFO - [mozharness: 2016-08-05 02:36:40.726986Z] Running install step. 19:36:40 INFO - Running pre-action listener: _resource_record_pre_action 19:36:40 INFO - Running main action method: install 19:36:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:40 INFO - Reading from file tmpfile_stdout 19:36:40 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:41 INFO - Reading from file tmpfile_stdout 19:36:41 INFO - Output received: 19:36:41 INFO - Usage: mozinstall [options] installer 19:36:41 INFO - Options: 19:36:41 INFO - -h, --help show this help message and exit 19:36:41 INFO - -d DEST, --destination=DEST 19:36:41 INFO - Directory to install application into. [default: 19:36:41 INFO - "/builds/slave/test"] 19:36:41 INFO - --app=APP Application being installed. [default: firefox] 19:36:41 INFO - mkdir: /builds/slave/test/build/application 19:36:41 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'] 19:36:41 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 19:36:57 INFO - Reading from file tmpfile_stdout 19:36:57 INFO - Output received: 19:36:57 INFO - /builds/slave/test/build/application/firefox/firefox 19:36:57 INFO - Running post-action listener: _resource_record_post_action 19:36:57 INFO - [mozharness: 2016-08-05 02:36:57.026662Z] Finished install step (success) 19:36:57 INFO - [mozharness: 2016-08-05 02:36:57.026907Z] Running run-tests step. 19:36:57 INFO - Running pre-action listener: _resource_record_pre_action 19:36:57 INFO - Running main action method: run_tests 19:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:36:57 INFO - Python 2.7.3 19:36:57 INFO - Return code: 0 19:36:57 INFO - grabbing minidump binary from tooltool 19:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:57 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 0x1caa3b0>, '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 0x1cab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cab740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:36:57 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 19:36:57 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 19:36:57 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 19:36:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:36:57 INFO - Return code: 0 19:36:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:36:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:36:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:36:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:36:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:36:57 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/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:36:57 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/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 19:36:57 INFO - Using env: {'DISPLAY': ':0', 19:36:57 INFO - 'HOME': '/home/cltbld', 19:36:57 INFO - 'LANG': 'en_US.UTF-8', 19:36:57 INFO - 'LANGUAGE': 'en_US:en', 19:36:57 INFO - 'LOGNAME': 'cltbld', 19:36:57 INFO - 'MAIL': '/var/mail/cltbld', 19:36:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:36:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:57 INFO - 'MOZ_NO_REMOTE': '1', 19:36:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:57 INFO - 'NO_EM_RESTART': '1', 19:36:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:57 INFO - 'PWD': '/builds/slave/test', 19:36:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:36:57 INFO - 'SHELL': '/bin/bash', 19:36:57 INFO - 'SHLVL': '1', 19:36:57 INFO - 'TERM': 'linux', 19:36:57 INFO - 'TMOUT': '86400', 19:36:57 INFO - 'USER': 'cltbld', 19:36:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947', 19:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:57 INFO - '_': '/tools/buildbot/bin/python'} 19:36:57 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/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:36:57 INFO - mozversion application_buildid: 20160804182120 19:36:57 INFO - mozversion application_changeset: 0f1333d8cf910d0679bc8a7b6d6673d9bd92ba7b 19:36:57 INFO - mozversion application_display_name: Nightly 19:36:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:36:57 INFO - mozversion application_name: Firefox 19:36:57 INFO - mozversion application_remotingname: firefox 19:36:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:36:57 INFO - mozversion application_vendor: Mozilla 19:36:57 INFO - mozversion application_version: 51.0a1 19:36:57 INFO - mozversion platform_buildid: 20160804182120 19:36:57 INFO - mozversion platform_changeset: 0f1333d8cf910d0679bc8a7b6d6673d9bd92ba7b 19:36:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:36:57 INFO - mozversion platform_version: 51.0a1 19:36:57 INFO - using testdate: 1470364617 19:36:57 INFO - actual date: 1470364617 19:36:57 INFO - starting webserver on 'localhost:44121' 19:36:57 INFO - SUITE-START | Running 2 tests 19:36:57 INFO - TEST-START | dromaeo_css 19:36:57 INFO - operating with platform_type : linux_ 19:36:57 INFO - Initialising browser for dromaeo_css test... 19:36:57 INFO - TEST-INFO | started process 6904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpawvQJs/profile http://localhost:44121/getInfo.html) 19:37:01 INFO - PROCESS | 6904 | __metrics Screen width/height:1600/1200 19:37:01 INFO - PROCESS | 6904 | colorDepth:24 19:37:01 INFO - PROCESS | 6904 | Browser inner width/height: 1024/697 19:37:01 INFO - PROCESS | 6904 | __metrics 19:37:02 INFO - PROCESS | 6904 | 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" 19:37:02 INFO - PROCESS | 6904 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:02 INFO - PROCESS | 6904 | console.error: PushService: 19:37:02 INFO - PROCESS | 6904 | stateChangeProcessEnqueue: Error transitioning state 19:37:02 INFO - PROCESS | 6904 | UnknownError 19:37:03 INFO - TEST-INFO | 6904: exit 0 19:37:03 INFO - Browser initialized. 19:37:03 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:03 INFO - TEST-INFO | started process 6987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpawvQJs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:15 INFO - PROCESS | 6987 | RSS: Main: 157851648 19:37:15 INFO - PROCESS | 6987 | 19:38:06 INFO - PROCESS | 6987 | 1470364686454 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] 19:40:19 INFO - PROCESS | 6987 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44121/tests/dromaeo/cssquery-ext.html) 19:40:20 INFO - PROCESS | 6987 | RSS: Main: 251965440 19:40:20 INFO - PROCESS | 6987 | 19:43:23 INFO - PROCESS | 6987 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-ext.html (next: http://localhost:44121/tests/dromaeo/cssquery-jquery.html) 19:43:23 INFO - PROCESS | 6987 | RSS: Main: 239902720 19:43:23 INFO - PROCESS | 6987 | 19:46:26 INFO - PROCESS | 6987 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44121/tests/dromaeo/cssquery-mootools.html) 19:46:26 INFO - PROCESS | 6987 | RSS: Main: 239988736 19:46:26 INFO - PROCESS | 6987 | 19:49:28 INFO - PROCESS | 6987 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44121/tests/dromaeo/cssquery-prototype.html) 19:49:29 INFO - PROCESS | 6987 | RSS: Main: 204992512 19:49:29 INFO - PROCESS | 6987 | 19:52:32 INFO - PROCESS | 6987 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44121/tests/dromaeo/cssquery-yui.html) 19:52:33 INFO - PROCESS | 6987 | RSS: Main: 190709760 19:52:33 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | Cycle 1(1): loaded http://localhost:44121/tests/dromaeo/cssquery-yui.html (next: http://localhost:44121/tests/dromaeo/cssquery-dojo.html) 19:55:36 INFO - PROCESS | 6987 | RSS: Main: 282021888 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | __start_tp_report 19:55:36 INFO - PROCESS | 6987 | _x_x_mozilla_page_load 19:55:36 INFO - PROCESS | 6987 | _x_x_mozilla_page_load_details 19:55:36 INFO - PROCESS | 6987 | |i|pagename|runs| 19:55:36 INFO - PROCESS | 6987 | |0;dojo.html;2578.587426011838;2583.095916429249;2591.4169311904825;2627.802914781391;2627.948820471811;4614.446266448031;4709.411323584552;4749.786259618317;4750.073735621555;4774.7612619369065;4695.929561056579;4707.340972263886;4731.5978141857895;4740.383750112481;4741.454732705732;4283.164782867342;4316.589923957219;4357.41174941382;4413.536578659243;4524.23088075028;4416.205083085043;4481.977590112045;4495.235809912323;4504.572065653758;4513.2101882170655;4243.554426785174;4302.634276086536;4317.97841010796;4322.783860806979;4383.167198232326;4311.245532031882;4334.176506463793;4347.5217726050105;4413.713108647928;4447.733136011817;4358.36803663467;4360.1279744051;4361.389405483234;4394.736315821061;4400.339949007643;4674.088552732219;4686.906261874778;4768.403949506312;4792.904141917142;4832.73419961902;5042.848714538533;5080.822171223989;5130.410002849645;5134.614903882224;5137.845864624067;5091.490850914916;5106.208537676666;5139.974300128512;5142.151544995071;5150.150225212836;4615.515370886009;4701.2242979908615;4748.3114948332295;4784.282357646381;4789.4971028042255;5207.71357575337;5222.686638801684;5261.842144735664;5274.498922602346;5287.814926477632;5000.89998200034;5043.3191519145175;5048.823291184791;5052.3937127544195;5056.266841308064;4939.333190019373;5051.873703157377;5093.439721630618;5111.7699703513435;5140.280360749498;5063.620228482879;5071.847844564669;5072.112380333427;5091.847244582668;5111.028904508132;5061.949380506221;5071.8985620287385;5083.415407228142;5086.949130508721;5119.692818430832;4099.938500922489;4138.379243113557;4160.9375859362135;4240.469941257343;4283.892902677458;3676.17286110623;3684.8710295140077;3703.166787472797;3754.8685795997553;3770.359038963383;4358.21552120615;4360.280553708666;4369.978150109293;4371.256886329332;4417.116576684676;4926.3842019747535;4977.402711674622;5124.15451450514;5125.743712814345;5167.069927413102;4273.97863010683;4308.310670292801;4312.69811113219;4313.460817397825;4377.4528183977;4526.502084770673;4532.32015197723;4534.387857639243;4547.840825571156;4591.517890621437;4577.496475387771;4693.9765301173275;4695.107929493385;4700.9059818803435;4724.763761811896;4954.20732682769;4970.726610036482;4990.600751939909;5006.624503162205;5054.620903432331;4690.484046754923;4712.858614241578;4718.598919091915;4719.811207551659;4773.474917758975;4906.8773280668265;4998.875028124326;5009.298698182184;5011.799528018839;5058.342415485963;5032.6980381177245;5039.445660977216;5103.081445339726;5131.281620573197;5133.050385678662;4967.254911763264;4967.552920237196;4970.155073637563;4970.801167953241;5012.248162775467;4766.380370551945;4960.925586116139;4970.254461830755;4993.525615066563;5046.1926091825135;4826.758662066953;4855.1260773061185;4863.440704319049;4894.119058569491;4932.383452068491;4964.826231081895;4971.925421118758;4980.103581355246;4980.925286120783;5022.0960227158;4705.55297246761;4833.226683730586;4838.806447742051;4852.902941941212;4869.074875773592 19:55:36 INFO - PROCESS | 6987 | |1;ext.html;572.0932322269203;578.2367275196742;585.698365341849;589.99705001475;598.4583951523867;28765.280867978312;31263.68736312639;42238.366424503656;43612.345814812805;43931.560684393226;41303.38044929328;41684;41743;41749.58250417495;41799.79100104495;7651.732189373373;7798.727044553441;7799.883001754978;7801.726939557117;7803.648835802374;7414.443916706242;9610.711678649652;9836.95081524595;9840.70477885661;10143.695689129338;10080.445575493344;10182.694519164437;10186.847197292047;10189.745256368577;10189.745256368613;9905.702828915144;9967.252456065824;9973.052560006789;9981.201503879709;9986.151177149952;9713;9756.07317304855;9779.804403911881;9791.265655075898;9815.067568580973;38217.808910955544;38694.22611547782;38715;38717.419238711445;38747.22505549873;2828.37775689348;2875.8418286994415;2907.86914588844;3086.675899030592;3092.9690703092906;29069.110507816924;29830.70169298301;29942.55086173709;30137.698623013708;30160;3427.4516077427493;3444.896653100411;3452.085197422685;3610.837512311952;3622.873199438033;250059;253216;253699;253859.73070134717;255720;30493;52772.47227527753;53034.20448693273;53056;53086;31494.842525787226;33615.66384336174;33624.663753362154;33658;33674.66325336715;13191.340432978313;13241;13307.534236301683;13336.599902002956;13367.532136375376;8551.059383467813;8697.95651021741;11007.834882476769;11091.057260132819;11115.83326250107;7377.3360397564475;7413;7433.888491672629;7476.514026588255;7696.576688282198;3052.603161588979;3053.8473076346095;3057.8776848925795;3066.3100802319746;3147.4806656901355;869.26112804116;898.8382091223642;919.8206349761866;962.9759256018656;965.8599503072015;27773.583396249072;27883.581746273823;28008.159755207376;28148.859255704;28403.28991775181;908.028409601733;974.64425484699;984.532347135105;984.6799790068256;1058.2274939294205;14840.554783356516;14895.404183832741;15124.39502419913;15197.316120774592;15278.388864445298;394214;398785;399110;399415;401221;47633;48130;48168;48178.518214817406;48181.51818481841;1097.434821067151;1130.6608017594854;1141.937193454368;1148;1188.0673671168092;26134.477310453305;27557.724422756317;27899.721002790524;28322.15033548997;28334.29164270827;42513;42917;42970.35544466898;43018.56981430146;43028.56971430246;328963;329050;329284;329958.00419957814;330148;22201.66697499571;24386.756132439157;24835.130770422948;25145.87427062926;25442;40831.795841020605;41351.7932410336;41908.161836763706;42340.78829605832;42639.7868010658;32147.839260803546;32492.67507324991;32522.67477325291;32712.509312359856;33642.158946026546;35114;35835.462468063524;35872.64127358693;35893;35939.46090808588;34786;35021.64978350286;35202;35648.465273021444;35844;30370.54444183295;32326.19184520406;32601.510977335834;32659;32877;24419.633705494078;24689;25083.49833003366;25238.499203761912;25254.621180682672 19:55:36 INFO - PROCESS | 6987 | |2;jquery.html;361.8823882238273;369.36653639009097;370.3592784482843;370.9165437776501;380.6003696119074;17112.401065962677;17202.48392548224;17484.56288592786;17579.64840703185;17630.471085867444;16127.838721612781;16582.585435364123;17748.64502709945;17826.286948522044;17864.28542858284;4546.158960592293;4776.211925032366;4778.880527986811;4780.4741478437345;4783.28250762385;3495;3577.8211089445554;3790.1472168762084;4626.560476754703;4672.719636821802;5990.101484777275;6100;6107.633541987495;6117.2659280886355;6127.1728316677345;6086.8782624347705;6095.878082438348;6106.45041946227;6111;6112.388761123919;3375.5611770469927;4984.925226121611;5322.760475778599;5423.566114710814;5430;12431.875681243162;12656.050796190322;12692.682682932907;12723;19144;1797.6854050541233;1851.518605162654;1876.953076173093;1895.1661269041715;1920.2415046056728;9126.361154719172;9664.806703865883;9778.51107444632;9976.95011524945;13140.408681609351;1709.6751617192695;1738.8000379956213;1769.1684908093175;1814.682430574644;1825.3063835742466;66198.66900665514;70964.29035709628;72464.6376768118;72675.63662181709;74287.62856185739;9956.153726933147;10135.138513226459;10176.898231017594;10233.74415639615;10600.681979540626;13859.792103118461;13861.722765544835;13869.861301387058;13957.092788968888;13966.930165349311;6564.081028655992;6668.333166683293;6789.558678685869;6802;6934.237233904267;6200.81397558074;6266.811995640138;6413.551051426449;6416.615003099736;6438.967805160944;4271.273883439822;4315.201687687788;4360.324149756792;4408.140412619572;4462.732236065846;1766.311138655925;1820.0899550224888;1847.6489467001227;1849.3249963763399;1857.7770667519985;802.6628815897337;820.2904487618167;822.3996482567759;843.6583183810567;898.5372533145435;16758.58103547421;16883.40908068212;17405.042722650374;17524.211410486303;17620.383286584907;810.6676262732251;829.4525613095328;830.8006078541107;847.902491213506;894.8881389826272;9185.448873067637;9522.238220942309;9543.761405964906;9681.07237107951;9693;425246;427366;427558;431868;437481;78317;79720;79758.6012069936;80793.59603202064;83801.58099209587;876.6405773632907;886.3042511628341;906.8639704044314;907.0430695616056;911.6626848066126;15022.699546009237;15132.621684457976;15481.767773483632;15733.921330393732;15899.046057236603;36060.09849753777;36136.4579531302;36554.63445365619;37093.44359834659;37387.43918841274;53383.73308133434;54108.72945635246;54933.1760023592;54941.72529137329;56398.436015639316;7340.082489688789;7621.923780762121;7624;7646.235376462531;7785.805354866174;5919.171316015675;8345.582720864053;9336;10010.648562443977;12016.399180040788;9987.9973415598;10300.227482938659;10364.844527332247;10435.739106522398;10718;9832.9016709832;9986.201103911815;10082.193424525874;10097.596096156072;10211.591536338463;10161.237907157141;10359.63741269052;10439.739006524898;10607.310524815863;10636.149108071491;7441.144268408986;7556.622168891424;7620.3522700571075;7648.349890259167;7654.387648987956;4582.083583283424;7843.745000799845;9045.140711632648;9942.154916831862;10242.129418999468 19:55:36 INFO - PROCESS | 6987 | |3;mootools.html;1252.6492582077021;1347.723716638089;1419.5812235390558;1431.8568143185682;1679.9328026878934;6134.202553668022;7037.2610875858;7269.127704675433;7288.635568221594;7469.103707555088;7281.817954551138;7320.670569824358;7337.6698048587805;7348.669309881068;7352.742654007097;2124.001719191981;2146.7638559758416;2152.311260396674;2152.8923553822324;2155.622766015949;2072.8549001569895;2115.5345823918715;2146.248812915475;2148.6884401761736;2149.924752633658;2045.4988527810708;2086.248950377863;2090.6550419180894;2092.9790702092937;2121.713568668233;2090.8745475271458;2096.8532202745814;2097.140172529256;2100.1074543319105;2102.36928921323;2007.9698804517943;2086.76002259739;2092.299079808266;2095.1409921932086;2096.2139197800825;7271.418286537064;7308.707651693926;7360.411167106672;7387.926120738777;7411;4226.3026600610865;4407.493138289074;4412.382266482695;4420.40324556184;4421.182081314935;2812.2828678686806;2916.7958242923005;2976.285691434062;2976.776741744378;2977.7915545911796;954.6610953111684;955.507913424587;969.8448248280312;973.3089506450428;981.087588542655;9613.951930240304;9650.179734722557;9663.323567350288;9709.61161553537;9715;3638.927221455609;3696.9815150924073;3782.470454136423;3809.6571308581806;3839.827207775657;7837.647305871249;7874.464479426457;7880.133185349607;7882.5270483771155;7894.763157105296;4244.0663054128045;4245.5542168072525;4246.936295955563;4262.7655478948955;4277.871663850089;3461.1866211440292;3799.297130030953;3974.16542526067;3977.900552486211;3998.5601583825755;3271.5910511186103;3274.1159886830424;3351.1957130288556;3387.4749413840896;3396.932061358759;1016.425719468498;1032.0866033560203;1032.2980373346197;1034.632705389591;1042.1975079188983;646.3794757033301;713.6075158662715;769.284565354226;779.5946108023909;802.7712102050888;4657.790399432034;4966.90066198674;4997.225430058346;5009.699418034929;5147;774.5314084978506;846.5597889097635;868.1795703060548;885.3448448148324;894.9707835988535;3204.5033019881957;3316.950245746316;3345.765796394278;3349.095744149066;3390.8304584770663;8477.95761021191;8848.778780530538;8850.867236991451;8858.379913406;8886.377953543319;8782.42914210587;8785.297176226015;8792.560371981375;8794.60424280909;8807.031226565072;6475.870482590321;6715.093462382613;6722.226943901416;6834.931650683529;6838.658067096625;4652.860414187579;4796.328514008112;4851.223804191312;4993.126202914548;5064.746762661778;8156.918430815853;8189.262966333059;8300.460470069425;8323.500589964622;8333.125021872616;7927;8161.714339998071;8184.263416292562;8201;8341.082480926972;5699.772009119754;6262.686865656608;6334.556581039283;6508.544401891822;6521.4130728232785;6898.103246577913;7091.680874360769;7104.964475177591;7120.252373500708;7129.500934934505;6093;6197.225346831646;6238.781642642667;6419.422251997343;6590;6352.396522330371;6361.268454127835;6363.045543168561;6381.138546296191;6401.487880969605;6020.548458865515;6033.54748393881;6077.969610151921;6092.421219984094;6095.969520152371;4128.752274863517;4170.332746760504;4214.894627634334;4250.702450828412;4324.2648749712;4116.897077573085;4154.563770804143;4200.4959404871615;4220.936685949775;4300.440942677432 19:55:36 INFO - PROCESS | 6987 | |4;prototype.html;291.494257463301;296.28447299771057;304.80949406620863;304.9692040901752;309.7258925850621;4791.137595232856;4825.131476334259;4845.394325709286;4856.757162141892;4890;4558.61251793598;4653.068566802918;4699.365585645945;4730.0303437795255;4819.301201325806;3666.395044817602;3687.907802304937;3697.9815100924593;3765.359888818907;3797.9810100949458;3773.716971227169;3782.9810850945705;3788.049154685339;3815.8473661053663;3825.7704537727827;3673.265346930611;3762.9623703763023;3777.4333849922596;3778.527684039495;3791.090138366786;3735.794531300777;3738.214974855284;3744.7565908216015;3752.9437058444146;3758.4362345648096;3309.8841540545964;3332.6167490738635;3333.1333853198103;3334.1164591383304;3338.61605915318;4682.29765535169;4697.553732395451;4701.660026892319;4717.834875779331;4735.502772208903;4148.170365926827;4269.594388533084;4323.956760432387;4324.351347297899;4325.264705000158;4961.652684312064;4982.252662100714;4985.725785081819;4990.451050384455;4993.6005119590345;3642.344378011957;3642.979965609607;3643.143861192618;3648.945265821015;3671.3942199537046;5029.974850125763;5228.607854410896;5262.657927234717;5265.76304066318;5309.946900530984;3622.728295377857;3652.397354436488;3656.7257455690396;3663.303972245265;3668.798216098087;3715.628437156263;3715.777053376806;3731.962680373216;3733.525257523263;3734.626537346244;4258.978705106455;4269.231538323132;4287.399764033038;4290.2706539888295;4294.549072347421;4740.549647783455;5007.7245751484015;5022;5047.697138171721;5104.851408433073;1327.150623600896;1330.2949436798513;1340.4437158579276;1340.9262490563112;1341.5103487227093;854.6325080215443;868.3964644571962;889.9110088991049;911.5032307392487;927.5315965437411;4417.491988421309;4418.160549495586;4433.179861725591;4433.512313645497;4473.083017981306;5153.639245252796;5175.896482070413;5178.508041736029;5197.246399272084;5224.294720212799;4306.569343065731;4442;4457.108578284291;4484.865454036384;4522.864314070517;2746.752792248707;2746.8214566053143;2753.821001634887;2765.198092553137;2768.944621107607;4831.830885918976;4843.297721830315;4853.611711063107;4855.465898751205;4864.492007477693;5088.516590923857;5310.176922577007;5311.628186026941;5362.383325917492;5364.785408583691;4826.203676393356;4827.61379089672;4829.7585120744525;4834.709917404896;4860.829870954571;5185.611079169002;5195.532402083831;5212.661177023481;5223.216517522402;5232.927249913682;4953.777080031336;5043.9747801260755;5075.1625981712605;5092.898142037065;5095.159298715818;4802.975985120052;4809.470958194526;4812.25410061441;4816.566509014206;4847;3627.401478755976;3663.5603727552866;3665.6884164846288;3684.7420680552104;3691.4647376130847;4990.128701736849;5174.456682048331;5230.503102205436;5232.136697445031;5246.711430871339;5016.372953380827;5045.192769156917;5064.924026139684;5064.924026139684;5064.949350506447;5063.13926632466;5087.592992560512;5088.542031217208;5092.439831618593;5098.41368242642;4864.416270047475;4903.313536104877;4997.125503036881;4997.9750101249265;5036.395632524121;4875.1712208923855;4910.5580497753945;5023.673461225008;5036.186972689902;5086.160783470686;4906.865513501638;4932.3094766731965;4942.406911170682;4967.230079337708;4997.150484417585 19:55:36 INFO - PROCESS | 6987 | |5;yui.html;629.2889035390009;643.4691379611819;646.2697152217996;652.5366989437499;710.83295425575;13221.537246196385;14398.712025759478;14402.063865848739;14423.711525769504;14541.927290363546;13049.67375815605;13101;13135.0805443619;13253.536126235584;13457.461701531927;625.8935980883238;642.1106767127516;753.8680730872103;754.0536626533707;779.1001393390643;763.5609524523394;773.1727052054304;773.5822655765879;773.7446642607925;775.2906090926796;804.3685706720225;806.6249194124731;807.0154411617817;807.261355859388;807.3339494916688;664.7174950646005;781.3085419403811;808.9676412943476;809.7570728781401;809.8582748019073;589.8967680655911;593.1340243244867;593.6794131169163;594.9613275137102;595.3748564007775;12615.180013299107;12626.936865315707;12636.494540218473;12641.43113559892;12654;12313.44589493475;12627.684307892285;12841.29372884491;13158.671033224151;13739.931300343535;12190.634280971584;12260.203086799329;12265.386730663431;12322.568710095193;12755.617331479978;4132.289050978526;4133.545310015896;4181.456410666624;4339.587739164775;4340.175366680321;67648;67793.32206677919;67797.66101169512;68618.31381686169;68633;10333.276670632984;10336.638217662347;10504.579816807394;10594.514854149693;10676.359418434919;19702.423806095478;19753.308634197732;19916.103775330146;19952;19960.50098747543;6751.4261287790105;6862.862742745117;6922.06552115468;6983;6999.790006299819;3890.708196885245;3909.0618251619408;3960.2475529649273;3969.106950936074;3973.940390894139;2803.831770093801;2845.601615773793;2849.045569734162;2871.755900748418;2911.5341545352644;495.24722421918483;500.9448960614329;501.929729837823;506.53398873036895;508.4305577752867;495.39809131904906;514.7966553211461;516.6383531527946;521.2988530426646;540.6377726922971;7157.928420715726;7170.892436613455;7229.060222171084;7586.544807311579;7605.923940760632;452.23120694818937;480.1741005470585;511.7134404733361;522.2401405954328;558.5029323901731;3512.648735126467;3525.8413371397837;3589.066842620885;3644.2529281497227;3790.1093243087853;56353.71823140858;56458.43541564614;58210.126848097316;100852.49573752085;101770.49114754378;24287.75712242855;24542;24611.507769844502;43613;83914.58042709748;52221.7388913053;72420.63789681123;72427;72521;74613;7619.504732192389;7837.843243135219;7925.326347260317;7926.445148839526;7940.523568585903;42967.785161073996;46662.30006549836;46807.76596117134;46981.530184699084;47297;36368.81815590905;44252;61508.391587470454;62172.37827621666;65212.34787652252;10846.566137354417;11218.775624487627;11246.493907774005;11397.943010285228;11614.477348519506;13230.735385292433;13346.733065338833;13850.861491384958;14106.506272280421;14137.36381862798;10610.897192905539;10626.787464250827;10897.182711296526;11042.944785276022;11361.204715669825;11524.769504609692;11541.769164616828;11702;12041.157119001586;12185.87814121883;11284.887151128383;11356.886431135583;11508.136889733136;12073.939630301793;12084.939575302067;10136;10182.898171018194;10284.640037598649;10479.738006549896;10500.264981451224;9823.312368134162;9916.157126644315;10001.449920254165;10167.491625418847;10198.643047493302 19:55:36 INFO - PROCESS | 6987 | __end_tp_report 19:55:36 INFO - PROCESS | 6987 | __start_cc_report 19:55:36 INFO - PROCESS | 6987 | _x_x_mozilla_cycle_collect,1034 19:55:36 INFO - PROCESS | 6987 | __end_cc_report 19:55:36 INFO - PROCESS | 6987 | __startTimestamp1470365736576__endTimestamp 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | ------- Summary: start ------- 19:55:36 INFO - PROCESS | 6987 | Number of tests: 6 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | [#0] dojo.html Cycles:165 Average:4681.59 Median:4774.76 stddev:506.26 (10.6%) stddev-sans-first:480.18 19:55:36 INFO - PROCESS | 6987 | Values: 2578.6 2583.1 2591.4 2627.8 2627.9 4614.4 4709.4 4749.8 4750.1 4774.8 4695.9 4707.3 4731.6 4740.4 4741.5 4283.2 4316.6 4357.4 4413.5 4524.2 4416.2 4482.0 4495.2 4504.6 4513.2 4243.6 4302.6 4318.0 4322.8 4383.2 4311.2 4334.2 4347.5 4413.7 4447.7 4358.4 4360.1 4361.4 4394.7 4400.3 4674.1 4686.9 4768.4 4792.9 4832.7 5042.8 5080.8 5130.4 5134.6 5137.8 5091.5 5106.2 5140.0 5142.2 5150.2 4615.5 4701.2 4748.3 4784.3 4789.5 5207.7 5222.7 5261.8 5274.5 5287.8 5000.9 5043.3 5048.8 5052.4 5056.3 4939.3 5051.9 5093.4 5111.8 5140.3 5063.6 5071.8 5072.1 5091.8 5111.0 5061.9 5071.9 5083.4 5086.9 5119.7 4099.9 4138.4 4160.9 4240.5 4283.9 3676.2 3684.9 3703.2 3754.9 3770.4 4358.2 4360.3 4370.0 4371.3 4417.1 4926.4 4977.4 5124.2 5125.7 5167.1 4274.0 4308.3 4312.7 4313.5 4377.5 4526.5 4532.3 4534.4 4547.8 4591.5 4577.5 4694.0 4695.1 4700.9 4724.8 4954.2 4970.7 4990.6 5006.6 5054.6 4690.5 4712.9 4718.6 4719.8 4773.5 4906.9 4998.9 5009.3 5011.8 5058.3 5032.7 5039.4 5103.1 5131.3 5133.1 4967.3 4967.6 4970.2 4970.8 5012.2 4766.4 4960.9 4970.3 4993.5 5046.2 4826.8 4855.1 4863.4 4894.1 4932.4 4964.8 4971.9 4980.1 4980.9 5022.1 4705.6 4833.2 4838.8 4852.9 4869.1 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | [#1] ext.html Cycles:180 Average:46970.79 Median:19119.04 stddev:87744.34 (458.9%) stddev-sans-first:87921.33 19:55:36 INFO - PROCESS | 6987 | Values: 572.1 578.2 585.7 590.0 598.5 28765.3 31263.7 42238.4 43612.3 43931.6 41303.4 41684.0 41743.0 41749.6 41799.8 7651.7 7798.7 7799.9 7801.7 7803.6 7414.4 9610.7 9837.0 9840.7 10143.7 10080.4 10182.7 10186.8 10189.7 10189.7 9905.7 9967.3 9973.1 9981.2 9986.2 9713.0 9756.1 9779.8 9791.3 9815.1 38217.8 38694.2 38715.0 38717.4 38747.2 2828.4 2875.8 2907.9 3086.7 3093.0 29069.1 29830.7 29942.6 30137.7 30160.0 3427.5 3444.9 3452.1 3610.8 3622.9 250059.0 253216.0 253699.0 253859.7 255720.0 30493.0 52772.5 53034.2 53056.0 53086.0 31494.8 33615.7 33624.7 33658.0 33674.7 13191.3 13241.0 13307.5 13336.6 13367.5 8551.1 8698.0 11007.8 11091.1 11115.8 7377.3 7413.0 7433.9 7476.5 7696.6 3052.6 3053.8 3057.9 3066.3 3147.5 869.3 898.8 919.8 963.0 965.9 27773.6 27883.6 28008.2 28148.9 28403.3 908.0 974.6 984.5 984.7 1058.2 14840.6 14895.4 15124.4 15197.3 15278.4 394214.0 398785.0 399110.0 399415.0 401221.0 47633.0 48130.0 48168.0 48178.5 48181.5 1097.4 1130.7 1141.9 1148.0 1188.1 26134.5 27557.7 27899.7 28322.2 28334.3 42513.0 42917.0 42970.4 43018.6 43028.6 328963.0 329050.0 329284.0 329958.0 330148.0 22201.7 24386.8 24835.1 25145.9 25442.0 40831.8 41351.8 41908.2 42340.8 42639.8 32147.8 32492.7 32522.7 32712.5 33642.2 35114.0 35835.5 35872.6 35893.0 35939.5 34786.0 35021.6 35202.0 35648.5 35844.0 30370.5 32326.2 32601.5 32659.0 32877.0 24419.6 24689.0 25083.5 25238.5 25254.6 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | [#2] jquery.html Cycles:180 Average:25376.98 Median:4604.32 stddev:70957.62 (1541.1%) stddev-sans-first:71131.81 19:55:36 INFO - PROCESS | 6987 | Values: 361.9 369.4 370.4 370.9 380.6 17112.4 17202.5 17484.6 17579.6 17630.5 16127.8 16582.6 17748.6 17826.3 17864.3 4546.2 4776.2 4778.9 4780.5 4783.3 3495.0 3577.8 3790.1 4626.6 4672.7 5990.1 6100.0 6107.6 6117.3 6127.2 6086.9 6095.9 6106.5 6111.0 6112.4 3375.6 4984.9 5322.8 5423.6 5430.0 12431.9 12656.1 12692.7 12723.0 19144.0 1797.7 1851.5 1877.0 1895.2 1920.2 9126.4 9664.8 9778.5 9977.0 13140.4 1709.7 1738.8 1769.2 1814.7 1825.3 66198.7 70964.3 72464.6 72675.6 74287.6 9956.2 10135.1 10176.9 10233.7 10600.7 13859.8 13861.7 13869.9 13957.1 13966.9 6564.1 6668.3 6789.6 6802.0 6934.2 6200.8 6266.8 6413.6 6416.6 6439.0 4271.3 4315.2 4360.3 4408.1 4462.7 1766.3 1820.1 1847.6 1849.3 1857.8 802.7 820.3 822.4 843.7 898.5 16758.6 16883.4 17405.0 17524.2 17620.4 810.7 829.5 830.8 847.9 894.9 9185.4 9522.2 9543.8 9681.1 9693.0 425246.0 427366.0 427558.0 431868.0 437481.0 78317.0 79720.0 79758.6 80793.6 83801.6 876.6 886.3 906.9 907.0 911.7 15022.7 15132.6 15481.8 15733.9 15899.0 36060.1 36136.5 36554.6 37093.4 37387.4 53383.7 54108.7 54933.2 54941.7 56398.4 7340.1 7621.9 7624.0 7646.2 7785.8 5919.2 8345.6 9336.0 10010.6 12016.4 9988.0 10300.2 10364.8 10435.7 10718.0 9832.9 9986.2 10082.2 10097.6 10211.6 10161.2 10359.6 10439.7 10607.3 10636.1 7441.1 7556.6 7620.4 7648.3 7654.4 4582.1 7843.7 9045.1 9942.2 10242.1 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | [#3] mootools.html Cycles:180 Average:4768.69 Median:5860.16 stddev:2608.75 (44.5%) stddev-sans-first:2602.69 19:55:36 INFO - PROCESS | 6987 | Values: 1252.6 1347.7 1419.6 1431.9 1679.9 6134.2 7037.3 7269.1 7288.6 7469.1 7281.8 7320.7 7337.7 7348.7 7352.7 2124.0 2146.8 2152.3 2152.9 2155.6 2072.9 2115.5 2146.2 2148.7 2149.9 2045.5 2086.2 2090.7 2093.0 2121.7 2090.9 2096.9 2097.1 2100.1 2102.4 2008.0 2086.8 2092.3 2095.1 2096.2 7271.4 7308.7 7360.4 7387.9 7411.0 4226.3 4407.5 4412.4 4420.4 4421.2 2812.3 2916.8 2976.3 2976.8 2977.8 954.7 955.5 969.8 973.3 981.1 9614.0 9650.2 9663.3 9709.6 9715.0 3638.9 3697.0 3782.5 3809.7 3839.8 7837.6 7874.5 7880.1 7882.5 7894.8 4244.1 4245.6 4246.9 4262.8 4277.9 3461.2 3799.3 3974.2 3977.9 3998.6 3271.6 3274.1 3351.2 3387.5 3396.9 1016.4 1032.1 1032.3 1034.6 1042.2 646.4 713.6 769.3 779.6 802.8 4657.8 4966.9 4997.2 5009.7 5147.0 774.5 846.6 868.2 885.3 895.0 3204.5 3317.0 3345.8 3349.1 3390.8 8478.0 8848.8 8850.9 8858.4 8886.4 8782.4 8785.3 8792.6 8794.6 8807.0 6475.9 6715.1 6722.2 6834.9 6838.7 4652.9 4796.3 4851.2 4993.1 5064.7 8156.9 8189.3 8300.5 8323.5 8333.1 7927.0 8161.7 8184.3 8201.0 8341.1 5699.8 6262.7 6334.6 6508.5 6521.4 6898.1 7091.7 7105.0 7120.3 7129.5 6093.0 6197.2 6238.8 6419.4 6590.0 6352.4 6361.3 6363.0 6381.1 6401.5 6020.5 6033.5 6078.0 6092.4 6096.0 4128.8 4170.3 4214.9 4250.7 4324.3 4116.9 4154.6 4200.5 4220.9 4300.4 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | [#4] prototype.html Cycles:180 Average:4184.51 Median:4797.06 stddev:1202.99 (25.1%) stddev-sans-first:1170.34 19:55:36 INFO - PROCESS | 6987 | Values: 291.5 296.3 304.8 305.0 309.7 4791.1 4825.1 4845.4 4856.8 4890.0 4558.6 4653.1 4699.4 4730.0 4819.3 3666.4 3687.9 3698.0 3765.4 3798.0 3773.7 3783.0 3788.0 3815.8 3825.8 3673.3 3763.0 3777.4 3778.5 3791.1 3735.8 3738.2 3744.8 3752.9 3758.4 3309.9 3332.6 3333.1 3334.1 3338.6 4682.3 4697.6 4701.7 4717.8 4735.5 4148.2 4269.6 4324.0 4324.4 4325.3 4961.7 4982.3 4985.7 4990.5 4993.6 3642.3 3643.0 3643.1 3648.9 3671.4 5030.0 5228.6 5262.7 5265.8 5309.9 3622.7 3652.4 3656.7 3663.3 3668.8 3715.6 3715.8 3732.0 3733.5 3734.6 4259.0 4269.2 4287.4 4290.3 4294.5 4740.5 5007.7 5022.0 5047.7 5104.9 1327.2 1330.3 1340.4 1340.9 1341.5 854.6 868.4 889.9 911.5 927.5 4417.5 4418.2 4433.2 4433.5 4473.1 5153.6 5175.9 5178.5 5197.2 5224.3 4306.6 4442.0 4457.1 4484.9 4522.9 2746.8 2746.8 2753.8 2765.2 2768.9 4831.8 4843.3 4853.6 4855.5 4864.5 5088.5 5310.2 5311.6 5362.4 5364.8 4826.2 4827.6 4829.8 4834.7 4860.8 5185.6 5195.5 5212.7 5223.2 5232.9 4953.8 5044.0 5075.2 5092.9 5095.2 4803.0 4809.5 4812.3 4816.6 4847.0 3627.4 3663.6 3665.7 3684.7 3691.5 4990.1 5174.5 5230.5 5232.1 5246.7 5016.4 5045.2 5064.9 5064.9 5064.9 5063.1 5087.6 5088.5 5092.4 5098.4 4864.4 4903.3 4997.1 4998.0 5036.4 4875.2 4910.6 5023.7 5036.2 5086.2 4906.9 4932.3 4942.4 4967.2 4997.2 19:55:36 INFO - PROCESS | 6987 | 19:55:36 INFO - PROCESS | 6987 | [#5] yui.html Cycles:180 Average:15829.57 Median:4157.50 stddev:21336.37 (513.2%) stddev-sans-first:21365.70 19:55:36 INFO - PROCESS | 6987 | Values: 629.3 643.5 646.3 652.5 710.8 13221.5 14398.7 14402.1 14423.7 14541.9 13049.7 13101.0 13135.1 13253.5 13457.5 625.9 642.1 753.9 754.1 779.1 763.6 773.2 773.6 773.7 775.3 804.4 806.6 807.0 807.3 807.3 664.7 781.3 809.0 809.8 809.9 589.9 593.1 593.7 595.0 595.4 12615.2 12626.9 12636.5 12641.4 12654.0 12313.4 12627.7 12841.3 13158.7 13739.9 12190.6 12260.2 12265.4 12322.6 12755.6 4132.3 4133.5 4181.5 4339.6 4340.2 67648.0 67793.3 67797.7 68618.3 68633.0 10333.3 10336.6 10504.6 10594.5 10676.4 19702.4 19753.3 19916.1 19952.0 19960.5 6751.4 6862.9 6922.1 6983.0 6999.8 3890.7 3909.1 3960.2 3969.1 3973.9 2803.8 2845.6 2849.0 2871.8 2911.5 495.2 500.9 501.9 506.5 508.4 495.4 514.8 516.6 521.3 540.6 7157.9 7170.9 7229.1 7586.5 7605.9 452.2 480.2 511.7 522.2 558.5 3512.6 3525.8 3589.1 3644.3 3790.1 56353.7 56458.4 58210.1 100852.5 101770.5 24287.8 24542.0 24611.5 43613.0 83914.6 52221.7 72420.6 72427.0 72521.0 74613.0 7619.5 7837.8 7925.3 7926.4 7940.5 42967.8 46662.3 46807.8 46981.5 47297.0 36368.8 44252.0 61508.4 62172.4 65212.3 10846.6 11218.8 11246.5 11397.9 11614.5 13230.7 13346.7 13850.9 14106.5 14137.4 10610.9 10626.8 10897.2 11042.9 11361.2 11524.8 11541.8 11702.0 12041.2 12185.9 11284.9 11356.9 11508.1 12073.9 12084.9 10136.0 10182.9 10284.6 10479.7 10500.3 9823.3 9916.2 10001.4 10167.5 10198.6 19:55:36 INFO - PROCESS | 6987 | -------- Summary: end -------- 19:55:36 INFO - PROCESS | 6987 | 19:55:37 INFO - TEST-INFO | 6987: exit 0 19:55:37 INFO - TEST-OK | dromaeo_css | took 1120148ms 19:55:37 INFO - TEST-START | kraken 19:55:37 INFO - operating with platform_type : linux_ 19:55:37 INFO - Initialising browser for kraken test... 19:55:37 INFO - TEST-INFO | started process 7289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9pdGW/profile http://localhost:44121/getInfo.html) 19:55:41 INFO - PROCESS | 7289 | __metrics Screen width/height:1600/1200 19:55:41 INFO - PROCESS | 7289 | colorDepth:24 19:55:41 INFO - PROCESS | 7289 | Browser inner width/height: 1024/697 19:55:41 INFO - PROCESS | 7289 | __metrics 19:55:42 INFO - PROCESS | 7289 | 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" 19:55:42 INFO - PROCESS | 7289 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:55:43 INFO - PROCESS | 7289 | console.error: PushService: 19:55:43 INFO - PROCESS | 7289 | stateChangeProcessEnqueue: Error transitioning state 19:55:43 INFO - PROCESS | 7289 | UnknownError 19:55:43 INFO - TEST-INFO | 7289: exit 0 19:55:43 INFO - Browser initialized. 19:55:43 INFO - Running cycle 1/1 for kraken test... 19:55:43 INFO - TEST-INFO | started process 7371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9pdGW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:55 INFO - PROCESS | 7371 | RSS: Main: 157704192 19:55:55 INFO - PROCESS | 7371 | 19:55:58 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-beat-detection) 19:55:59 INFO - PROCESS | 7371 | RSS: Main: 213831680 19:55:59 INFO - PROCESS | 7371 | 19:56:02 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-dft) 19:56:02 INFO - PROCESS | 7371 | RSS: Main: 191868928 19:56:02 INFO - PROCESS | 7371 | 19:56:05 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-fft) 19:56:06 INFO - PROCESS | 7371 | RSS: Main: 271753216 19:56:06 INFO - PROCESS | 7371 | 19:56:08 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44121/tests/kraken/driver.html?testName=audio-oscillator) 19:56:09 INFO - PROCESS | 7371 | RSS: Main: 181104640 19:56:09 INFO - PROCESS | 7371 | 19:56:11 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:12 INFO - PROCESS | 7371 | RSS: Main: 185413632 19:56:12 INFO - PROCESS | 7371 | 19:56:15 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44121/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:16 INFO - PROCESS | 7371 | RSS: Main: 221245440 19:56:16 INFO - PROCESS | 7371 | 19:56:19 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44121/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:20 INFO - PROCESS | 7371 | RSS: Main: 215474176 19:56:20 INFO - PROCESS | 7371 | 19:56:23 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44121/tests/kraken/driver.html?testName=json-parse-financial) 19:56:23 INFO - PROCESS | 7371 | RSS: Main: 218652672 19:56:23 INFO - PROCESS | 7371 | 19:56:25 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:26 INFO - PROCESS | 7371 | RSS: Main: 184512512 19:56:26 INFO - PROCESS | 7371 | 19:56:27 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:28 INFO - PROCESS | 7371 | RSS: Main: 189378560 19:56:28 INFO - PROCESS | 7371 | 19:56:30 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:31 INFO - PROCESS | 7371 | RSS: Main: 194502656 19:56:31 INFO - PROCESS | 7371 | 19:56:34 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:34 INFO - PROCESS | 7371 | RSS: Main: 190631936 19:56:34 INFO - PROCESS | 7371 | 19:56:37 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:38 INFO - PROCESS | 7371 | RSS: Main: 193228800 19:56:38 INFO - PROCESS | 7371 | 19:56:39 INFO - PROCESS | 7371 | Cycle 1(1): loaded http://localhost:44121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44121/tests/kraken/driver.html?testName=ai-astar) 19:56:40 INFO - PROCESS | 7371 | RSS: Main: 243945472 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | __start_tp_report 19:56:40 INFO - PROCESS | 7371 | _x_x_mozilla_page_load 19:56:40 INFO - PROCESS | 7371 | _x_x_mozilla_page_load_details 19:56:40 INFO - PROCESS | 7371 | |i|pagename|runs| 19:56:40 INFO - PROCESS | 7371 | |0;ai-astar;104;114;114;116;113;113;115;113;113;115 19:56:40 INFO - PROCESS | 7371 | |1;audio-beat-detection;148;128;125;186;128;129;145;121;153;124 19:56:40 INFO - PROCESS | 7371 | |2;audio-dft;160;164;162;161;162;160;161;162;164;162 19:56:40 INFO - PROCESS | 7371 | |3;audio-fft;77;76;77;122;76;77;76;75;112;77 19:56:40 INFO - PROCESS | 7371 | |4;audio-oscillator;85;85;127;84;85;85;124;84;86;132 19:56:40 INFO - PROCESS | 7371 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 19:56:40 INFO - PROCESS | 7371 | |6;imaging-darkroom;147;147;147;147;146;146;146;146;146;147 19:56:40 INFO - PROCESS | 7371 | |7;imaging-desaturate;94;94;94;95;94;94;95;94;95;95 19:56:40 INFO - PROCESS | 7371 | |8;json-parse-financial;64;63;64;64;64;64;63;62;63;63 19:56:40 INFO - PROCESS | 7371 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;66;66 19:56:40 INFO - PROCESS | 7371 | |10;stanford-crypto-aes;79;90;78;89;88;78;78;91;78;79 19:56:40 INFO - PROCESS | 7371 | |11;stanford-crypto-ccm;133;130;131;128;129;127;129;129;148;137 19:56:40 INFO - PROCESS | 7371 | |12;stanford-crypto-pbkdf2;166;169;165;165;167;165;164;163;164;165 19:56:40 INFO - PROCESS | 7371 | |13;stanford-crypto-sha256-iterative;67;67;68;66;67;67;67;67;65;65 19:56:40 INFO - PROCESS | 7371 | __end_tp_report 19:56:40 INFO - PROCESS | 7371 | __start_cc_report 19:56:40 INFO - PROCESS | 7371 | _x_x_mozilla_cycle_collect,1969 19:56:40 INFO - PROCESS | 7371 | __end_cc_report 19:56:40 INFO - PROCESS | 7371 | __startTimestamp1470365800217__endTimestamp 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | ------- Summary: start ------- 19:56:40 INFO - PROCESS | 7371 | Number of tests: 14 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.33 (2.9%) stddev-sans-first:1.12 19:56:40 INFO - PROCESS | 7371 | Values: 104.0 114.0 114.0 116.0 113.0 113.0 115.0 113.0 113.0 115.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:137.00 stddev:20.02 (14.6%) stddev-sans-first:20.95 19:56:40 INFO - PROCESS | 7371 | Values: 148.0 128.0 125.0 186.0 128.0 129.0 145.0 121.0 153.0 124.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.32 19:56:40 INFO - PROCESS | 7371 | Values: 160.0 164.0 162.0 161.0 162.0 160.0 161.0 162.0 164.0 162.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.50 stddev:17.30 (22.6%) stddev-sans-first:18.14 19:56:40 INFO - PROCESS | 7371 | Values: 77.0 76.0 77.0 122.0 76.0 77.0 76.0 75.0 112.0 77.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.00 stddev:20.77 (24.4%) stddev-sans-first:21.52 19:56:40 INFO - PROCESS | 7371 | Values: 85.0 85.0 127.0 84.0 85.0 85.0 124.0 84.0 86.0 132.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:56:40 INFO - PROCESS | 7371 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:56:40 INFO - PROCESS | 7371 | Values: 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:56:40 INFO - PROCESS | 7371 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 19:56:40 INFO - PROCESS | 7371 | Values: 64.0 63.0 64.0 64.0 64.0 64.0 63.0 62.0 63.0 63.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 19:56:40 INFO - PROCESS | 7371 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:5.83 (7.0%) stddev-sans-first:6.02 19:56:40 INFO - PROCESS | 7371 | Values: 79.0 90.0 78.0 89.0 88.0 78.0 78.0 91.0 78.0 79.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:130.50 stddev:6.28 (4.8%) stddev-sans-first:6.65 19:56:40 INFO - PROCESS | 7371 | Values: 133.0 130.0 131.0 128.0 129.0 127.0 129.0 129.0 148.0 137.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.00 stddev:1.70 (1.0%) stddev-sans-first:1.79 19:56:40 INFO - PROCESS | 7371 | Values: 166.0 169.0 165.0 165.0 167.0 165.0 164.0 163.0 164.0 165.0 19:56:40 INFO - PROCESS | 7371 | 19:56:40 INFO - PROCESS | 7371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 19:56:40 INFO - PROCESS | 7371 | Values: 67.0 67.0 68.0 66.0 67.0 67.0 67.0 67.0 65.0 65.0 19:56:40 INFO - PROCESS | 7371 | -------- Summary: end -------- 19:56:40 INFO - PROCESS | 7371 | 19:56:41 INFO - TEST-INFO | 7371: exit 0 19:56:41 INFO - TEST-OK | kraken | took 63935ms 19:56:41 INFO - SUITE-END | took 1184s 19:56:41 INFO - Completed test suite (00:19:44) 19:56:41 INFO - javascript benchmark 19:56:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.587426011838, 2583.095916429249, 2591.4169311904825, 2627.802914781391, 2627.948820471811, 4614.446266448031, 4709.411323584552, 4749.786259618317, 4750.073735621555, 4774.7612619369065, 4695.929561056579, 4707.340972263886, 4731.5978141857895, 4740.383750112481, 4741.454732705732, 4283.164782867342, 4316.589923957219, 4357.41174941382, 4413.536578659243, 4524.23088075028, 4416.205083085043, 4481.977590112045, 4495.235809912323, 4504.572065653758, 4513.2101882170655, 4243.554426785174, 4302.634276086536, 4317.97841010796, 4322.783860806979, 4383.167198232326, 4311.245532031882, 4334.176506463793, 4347.5217726050105, 4413.713108647928, 4447.733136011817, 4358.36803663467, 4360.1279744051, 4361.389405483234, 4394.736315821061, 4400.339949007643, 4674.088552732219, 4686.906261874778, 4768.403949506312, 4792.904141917142, 4832.73419961902, 5042.848714538533, 5080.822171223989, 5130.410002849645, 5134.614903882224, 5137.845864624067, 5091.490850914916, 5106.208537676666, 5139.974300128512, 5142.151544995071, 5150.150225212836, 4615.515370886009, 4701.2242979908615, 4748.3114948332295, 4784.282357646381, 4789.4971028042255, 5207.71357575337, 5222.686638801684, 5261.842144735664, 5274.498922602346, 5287.814926477632, 5000.89998200034, 5043.3191519145175, 5048.823291184791, 5052.3937127544195, 5056.266841308064, 4939.333190019373, 5051.873703157377, 5093.439721630618, 5111.7699703513435, 5140.280360749498, 5063.620228482879, 5071.847844564669, 5072.112380333427, 5091.847244582668, 5111.028904508132, 5061.949380506221, 5071.8985620287385, 5083.415407228142, 5086.949130508721, 5119.692818430832, 4099.938500922489, 4138.379243113557, 4160.9375859362135, 4240.469941257343, 4283.892902677458, 3676.17286110623, 3684.8710295140077, 3703.166787472797, 3754.8685795997553, 3770.359038963383, 4358.21552120615, 4360.280553708666, 4369.978150109293, 4371.256886329332, 4417.116576684676, 4926.3842019747535, 4977.402711674622, 5124.15451450514, 5125.743712814345, 5167.069927413102, 4273.97863010683, 4308.310670292801, 4312.69811113219, 4313.460817397825, 4377.4528183977, 4526.502084770673, 4532.32015197723, 4534.387857639243, 4547.840825571156, 4591.517890621437, 4577.496475387771, 4693.9765301173275, 4695.107929493385, 4700.9059818803435, 4724.763761811896, 4954.20732682769, 4970.726610036482, 4990.600751939909, 5006.624503162205, 5054.620903432331, 4690.484046754923, 4712.858614241578, 4718.598919091915, 4719.811207551659, 4773.474917758975, 4906.8773280668265, 4998.875028124326, 5009.298698182184, 5011.799528018839, 5058.342415485963, 5032.6980381177245, 5039.445660977216, 5103.081445339726, 5131.281620573197, 5133.050385678662, 4967.254911763264, 4967.552920237196, 4970.155073637563, 4970.801167953241, 5012.248162775467, 4766.380370551945, 4960.925586116139, 4970.254461830755, 4993.525615066563, 5046.1926091825135, 4826.758662066953, 4855.1260773061185, 4863.440704319049, 4894.119058569491, 4932.383452068491, 4964.826231081895, 4971.925421118758, 4980.103581355246, 4980.925286120783, 5022.0960227158, 4705.55297246761, 4833.226683730586, 4838.806447742051, 4852.902941941212, 4869.074875773592], "value": 4648.145461099569, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.0932322269203, 578.2367275196742, 585.698365341849, 589.99705001475, 598.4583951523867, 28765.280867978312, 31263.68736312639, 42238.366424503656, 43612.345814812805, 43931.560684393226, 41303.38044929328, 41684.0, 41743.0, 41749.58250417495, 41799.79100104495, 7651.732189373373, 7798.727044553441, 7799.883001754978, 7801.726939557117, 7803.648835802374, 7414.443916706242, 9610.711678649652, 9836.95081524595, 9840.70477885661, 10143.695689129338, 10080.445575493344, 10182.694519164437, 10186.847197292047, 10189.745256368577, 10189.745256368613, 9905.702828915144, 9967.252456065824, 9973.052560006789, 9981.201503879709, 9986.151177149952, 9713.0, 9756.07317304855, 9779.804403911881, 9791.265655075898, 9815.067568580973, 38217.808910955544, 38694.22611547782, 38715.0, 38717.419238711445, 38747.22505549873, 2828.37775689348, 2875.8418286994415, 2907.86914588844, 3086.675899030592, 3092.9690703092906, 29069.110507816924, 29830.70169298301, 29942.55086173709, 30137.698623013708, 30160.0, 3427.4516077427493, 3444.896653100411, 3452.085197422685, 3610.837512311952, 3622.873199438033, 250059.0, 253216.0, 253699.0, 253859.73070134717, 255720.0, 30493.0, 52772.47227527753, 53034.20448693273, 53056.0, 53086.0, 31494.842525787226, 33615.66384336174, 33624.663753362154, 33658.0, 33674.66325336715, 13191.340432978313, 13241.0, 13307.534236301683, 13336.599902002956, 13367.532136375376, 8551.059383467813, 8697.95651021741, 11007.834882476769, 11091.057260132819, 11115.83326250107, 7377.3360397564475, 7413.0, 7433.888491672629, 7476.514026588255, 7696.576688282198, 3052.603161588979, 3053.8473076346095, 3057.8776848925795, 3066.3100802319746, 3147.4806656901355, 869.26112804116, 898.8382091223642, 919.8206349761866, 962.9759256018656, 965.8599503072015, 27773.583396249072, 27883.581746273823, 28008.159755207376, 28148.859255704, 28403.28991775181, 908.028409601733, 974.64425484699, 984.532347135105, 984.6799790068256, 1058.2274939294205, 14840.554783356516, 14895.404183832741, 15124.39502419913, 15197.316120774592, 15278.388864445298, 394214.0, 398785.0, 399110.0, 399415.0, 401221.0, 47633.0, 48130.0, 48168.0, 48178.518214817406, 48181.51818481841, 1097.434821067151, 1130.6608017594854, 1141.937193454368, 1148.0, 1188.0673671168092, 26134.477310453305, 27557.724422756317, 27899.721002790524, 28322.15033548997, 28334.29164270827, 42513.0, 42917.0, 42970.35544466898, 43018.56981430146, 43028.56971430246, 328963.0, 329050.0, 329284.0, 329958.00419957814, 330148.0, 22201.66697499571, 24386.756132439157, 24835.130770422948, 25145.87427062926, 25442.0, 40831.795841020605, 41351.7932410336, 41908.161836763706, 42340.78829605832, 42639.7868010658, 32147.839260803546, 32492.67507324991, 32522.67477325291, 32712.509312359856, 33642.158946026546, 35114.0, 35835.462468063524, 35872.64127358693, 35893.0, 35939.46090808588, 34786.0, 35021.64978350286, 35202.0, 35648.465273021444, 35844.0, 30370.54444183295, 32326.19184520406, 32601.510977335834, 32659.0, 32877.0, 24419.633705494078, 24689.0, 25083.49833003366, 25238.499203761912, 25254.621180682672], "value": 16731.27402299209, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8823882238273, 369.36653639009097, 370.3592784482843, 370.9165437776501, 380.6003696119074, 17112.401065962677, 17202.48392548224, 17484.56288592786, 17579.64840703185, 17630.471085867444, 16127.838721612781, 16582.585435364123, 17748.64502709945, 17826.286948522044, 17864.28542858284, 4546.158960592293, 4776.211925032366, 4778.880527986811, 4780.4741478437345, 4783.28250762385, 3495.0, 3577.8211089445554, 3790.1472168762084, 4626.560476754703, 4672.719636821802, 5990.101484777275, 6100.0, 6107.633541987495, 6117.2659280886355, 6127.1728316677345, 6086.8782624347705, 6095.878082438348, 6106.45041946227, 6111.0, 6112.388761123919, 3375.5611770469927, 4984.925226121611, 5322.760475778599, 5423.566114710814, 5430.0, 12431.875681243162, 12656.050796190322, 12692.682682932907, 12723.0, 19144.0, 1797.6854050541233, 1851.518605162654, 1876.953076173093, 1895.1661269041715, 1920.2415046056728, 9126.361154719172, 9664.806703865883, 9778.51107444632, 9976.95011524945, 13140.408681609351, 1709.6751617192695, 1738.8000379956213, 1769.1684908093175, 1814.682430574644, 1825.3063835742466, 66198.66900665514, 70964.29035709628, 72464.6376768118, 72675.63662181709, 74287.62856185739, 9956.153726933147, 10135.138513226459, 10176.898231017594, 10233.74415639615, 10600.681979540626, 13859.792103118461, 13861.722765544835, 13869.861301387058, 13957.092788968888, 13966.930165349311, 6564.081028655992, 6668.333166683293, 6789.558678685869, 6802.0, 6934.237233904267, 6200.81397558074, 6266.811995640138, 6413.551051426449, 6416.615003099736, 6438.967805160944, 4271.273883439822, 4315.201687687788, 4360.324149756792, 4408.140412619572, 4462.732236065846, 1766.311138655925, 1820.0899550224888, 1847.6489467001227, 1849.3249963763399, 1857.7770667519985, 802.6628815897337, 820.2904487618167, 822.3996482567759, 843.6583183810567, 898.5372533145435, 16758.58103547421, 16883.40908068212, 17405.042722650374, 17524.211410486303, 17620.383286584907, 810.6676262732251, 829.4525613095328, 830.8006078541107, 847.902491213506, 894.8881389826272, 9185.448873067637, 9522.238220942309, 9543.761405964906, 9681.07237107951, 9693.0, 425246.0, 427366.0, 427558.0, 431868.0, 437481.0, 78317.0, 79720.0, 79758.6012069936, 80793.59603202064, 83801.58099209587, 876.6405773632907, 886.3042511628341, 906.8639704044314, 907.0430695616056, 911.6626848066126, 15022.699546009237, 15132.621684457976, 15481.767773483632, 15733.921330393732, 15899.046057236603, 36060.09849753777, 36136.4579531302, 36554.63445365619, 37093.44359834659, 37387.43918841274, 53383.73308133434, 54108.72945635246, 54933.1760023592, 54941.72529137329, 56398.436015639316, 7340.082489688789, 7621.923780762121, 7624.0, 7646.235376462531, 7785.805354866174, 5919.171316015675, 8345.582720864053, 9336.0, 10010.648562443977, 12016.399180040788, 9987.9973415598, 10300.227482938659, 10364.844527332247, 10435.739106522398, 10718.0, 9832.9016709832, 9986.201103911815, 10082.193424525874, 10097.596096156072, 10211.591536338463, 10161.237907157141, 10359.63741269052, 10439.739006524898, 10607.310524815863, 10636.149108071491, 7441.144268408986, 7556.622168891424, 7620.3522700571075, 7648.349890259167, 7654.387648987956, 4582.083583283424, 7843.745000799845, 9045.140711632648, 9942.154916831862, 10242.129418999468], "value": 8011.420524392576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.6492582077021, 1347.723716638089, 1419.5812235390558, 1431.8568143185682, 1679.9328026878934, 6134.202553668022, 7037.2610875858, 7269.127704675433, 7288.635568221594, 7469.103707555088, 7281.817954551138, 7320.670569824358, 7337.6698048587805, 7348.669309881068, 7352.742654007097, 2124.001719191981, 2146.7638559758416, 2152.311260396674, 2152.8923553822324, 2155.622766015949, 2072.8549001569895, 2115.5345823918715, 2146.248812915475, 2148.6884401761736, 2149.924752633658, 2045.4988527810708, 2086.248950377863, 2090.6550419180894, 2092.9790702092937, 2121.713568668233, 2090.8745475271458, 2096.8532202745814, 2097.140172529256, 2100.1074543319105, 2102.36928921323, 2007.9698804517943, 2086.76002259739, 2092.299079808266, 2095.1409921932086, 2096.2139197800825, 7271.418286537064, 7308.707651693926, 7360.411167106672, 7387.926120738777, 7411.0, 4226.3026600610865, 4407.493138289074, 4412.382266482695, 4420.40324556184, 4421.182081314935, 2812.2828678686806, 2916.7958242923005, 2976.285691434062, 2976.776741744378, 2977.7915545911796, 954.6610953111684, 955.507913424587, 969.8448248280312, 973.3089506450428, 981.087588542655, 9613.951930240304, 9650.179734722557, 9663.323567350288, 9709.61161553537, 9715.0, 3638.927221455609, 3696.9815150924073, 3782.470454136423, 3809.6571308581806, 3839.827207775657, 7837.647305871249, 7874.464479426457, 7880.133185349607, 7882.5270483771155, 7894.763157105296, 4244.0663054128045, 4245.5542168072525, 4246.936295955563, 4262.7655478948955, 4277.871663850089, 3461.1866211440292, 3799.297130030953, 3974.16542526067, 3977.900552486211, 3998.5601583825755, 3271.5910511186103, 3274.1159886830424, 3351.1957130288556, 3387.4749413840896, 3396.932061358759, 1016.425719468498, 1032.0866033560203, 1032.2980373346197, 1034.632705389591, 1042.1975079188983, 646.3794757033301, 713.6075158662715, 769.284565354226, 779.5946108023909, 802.7712102050888, 4657.790399432034, 4966.90066198674, 4997.225430058346, 5009.699418034929, 5147.0, 774.5314084978506, 846.5597889097635, 868.1795703060548, 885.3448448148324, 894.9707835988535, 3204.5033019881957, 3316.950245746316, 3345.765796394278, 3349.095744149066, 3390.8304584770663, 8477.95761021191, 8848.778780530538, 8850.867236991451, 8858.379913406, 8886.377953543319, 8782.42914210587, 8785.297176226015, 8792.560371981375, 8794.60424280909, 8807.031226565072, 6475.870482590321, 6715.093462382613, 6722.226943901416, 6834.931650683529, 6838.658067096625, 4652.860414187579, 4796.328514008112, 4851.223804191312, 4993.126202914548, 5064.746762661778, 8156.918430815853, 8189.262966333059, 8300.460470069425, 8323.500589964622, 8333.125021872616, 7927.0, 8161.714339998071, 8184.263416292562, 8201.0, 8341.082480926972, 5699.772009119754, 6262.686865656608, 6334.556581039283, 6508.544401891822, 6521.4130728232785, 6898.103246577913, 7091.680874360769, 7104.964475177591, 7120.252373500708, 7129.500934934505, 6093.0, 6197.225346831646, 6238.781642642667, 6419.422251997343, 6590.0, 6352.396522330371, 6361.268454127835, 6363.045543168561, 6381.138546296191, 6401.487880969605, 6020.548458865515, 6033.54748393881, 6077.969610151921, 6092.421219984094, 6095.969520152371, 4128.752274863517, 4170.332746760504, 4214.894627634334, 4250.702450828412, 4324.2648749712, 4116.897077573085, 4154.563770804143, 4200.4959404871615, 4220.936685949775, 4300.440942677432], "value": 3876.466040799896, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.494257463301, 296.28447299771057, 304.80949406620863, 304.9692040901752, 309.7258925850621, 4791.137595232856, 4825.131476334259, 4845.394325709286, 4856.757162141892, 4890.0, 4558.61251793598, 4653.068566802918, 4699.365585645945, 4730.0303437795255, 4819.301201325806, 3666.395044817602, 3687.907802304937, 3697.9815100924593, 3765.359888818907, 3797.9810100949458, 3773.716971227169, 3782.9810850945705, 3788.049154685339, 3815.8473661053663, 3825.7704537727827, 3673.265346930611, 3762.9623703763023, 3777.4333849922596, 3778.527684039495, 3791.090138366786, 3735.794531300777, 3738.214974855284, 3744.7565908216015, 3752.9437058444146, 3758.4362345648096, 3309.8841540545964, 3332.6167490738635, 3333.1333853198103, 3334.1164591383304, 3338.61605915318, 4682.29765535169, 4697.553732395451, 4701.660026892319, 4717.834875779331, 4735.502772208903, 4148.170365926827, 4269.594388533084, 4323.956760432387, 4324.351347297899, 4325.264705000158, 4961.652684312064, 4982.252662100714, 4985.725785081819, 4990.451050384455, 4993.6005119590345, 3642.344378011957, 3642.979965609607, 3643.143861192618, 3648.945265821015, 3671.3942199537046, 5029.974850125763, 5228.607854410896, 5262.657927234717, 5265.76304066318, 5309.946900530984, 3622.728295377857, 3652.397354436488, 3656.7257455690396, 3663.303972245265, 3668.798216098087, 3715.628437156263, 3715.777053376806, 3731.962680373216, 3733.525257523263, 3734.626537346244, 4258.978705106455, 4269.231538323132, 4287.399764033038, 4290.2706539888295, 4294.549072347421, 4740.549647783455, 5007.7245751484015, 5022.0, 5047.697138171721, 5104.851408433073, 1327.150623600896, 1330.2949436798513, 1340.4437158579276, 1340.9262490563112, 1341.5103487227093, 854.6325080215443, 868.3964644571962, 889.9110088991049, 911.5032307392487, 927.5315965437411, 4417.491988421309, 4418.160549495586, 4433.179861725591, 4433.512313645497, 4473.083017981306, 5153.639245252796, 5175.896482070413, 5178.508041736029, 5197.246399272084, 5224.294720212799, 4306.569343065731, 4442.0, 4457.108578284291, 4484.865454036384, 4522.864314070517, 2746.752792248707, 2746.8214566053143, 2753.821001634887, 2765.198092553137, 2768.944621107607, 4831.830885918976, 4843.297721830315, 4853.611711063107, 4855.465898751205, 4864.492007477693, 5088.516590923857, 5310.176922577007, 5311.628186026941, 5362.383325917492, 5364.785408583691, 4826.203676393356, 4827.61379089672, 4829.7585120744525, 4834.709917404896, 4860.829870954571, 5185.611079169002, 5195.532402083831, 5212.661177023481, 5223.216517522402, 5232.927249913682, 4953.777080031336, 5043.9747801260755, 5075.1625981712605, 5092.898142037065, 5095.159298715818, 4802.975985120052, 4809.470958194526, 4812.25410061441, 4816.566509014206, 4847.0, 3627.401478755976, 3663.5603727552866, 3665.6884164846288, 3684.7420680552104, 3691.4647376130847, 4990.128701736849, 5174.456682048331, 5230.503102205436, 5232.136697445031, 5246.711430871339, 5016.372953380827, 5045.192769156917, 5064.924026139684, 5064.924026139684, 5064.949350506447, 5063.13926632466, 5087.592992560512, 5088.542031217208, 5092.439831618593, 5098.41368242642, 4864.416270047475, 4903.313536104877, 4997.125503036881, 4997.9750101249265, 5036.395632524121, 4875.1712208923855, 4910.5580497753945, 5023.673461225008, 5036.186972689902, 5086.160783470686, 4906.865513501638, 4932.3094766731965, 4942.406911170682, 4967.230079337708, 4997.150484417585], "value": 3806.742031881266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.2889035390009, 643.4691379611819, 646.2697152217996, 652.5366989437499, 710.83295425575, 13221.537246196385, 14398.712025759478, 14402.063865848739, 14423.711525769504, 14541.927290363546, 13049.67375815605, 13101.0, 13135.0805443619, 13253.536126235584, 13457.461701531927, 625.8935980883238, 642.1106767127516, 753.8680730872103, 754.0536626533707, 779.1001393390643, 763.5609524523394, 773.1727052054304, 773.5822655765879, 773.7446642607925, 775.2906090926796, 804.3685706720225, 806.6249194124731, 807.0154411617817, 807.261355859388, 807.3339494916688, 664.7174950646005, 781.3085419403811, 808.9676412943476, 809.7570728781401, 809.8582748019073, 589.8967680655911, 593.1340243244867, 593.6794131169163, 594.9613275137102, 595.3748564007775, 12615.180013299107, 12626.936865315707, 12636.494540218473, 12641.43113559892, 12654.0, 12313.44589493475, 12627.684307892285, 12841.29372884491, 13158.671033224151, 13739.931300343535, 12190.634280971584, 12260.203086799329, 12265.386730663431, 12322.568710095193, 12755.617331479978, 4132.289050978526, 4133.545310015896, 4181.456410666624, 4339.587739164775, 4340.175366680321, 67648.0, 67793.32206677919, 67797.66101169512, 68618.31381686169, 68633.0, 10333.276670632984, 10336.638217662347, 10504.579816807394, 10594.514854149693, 10676.359418434919, 19702.423806095478, 19753.308634197732, 19916.103775330146, 19952.0, 19960.50098747543, 6751.4261287790105, 6862.862742745117, 6922.06552115468, 6983.0, 6999.790006299819, 3890.708196885245, 3909.0618251619408, 3960.2475529649273, 3969.106950936074, 3973.940390894139, 2803.831770093801, 2845.601615773793, 2849.045569734162, 2871.755900748418, 2911.5341545352644, 495.24722421918483, 500.9448960614329, 501.929729837823, 506.53398873036895, 508.4305577752867, 495.39809131904906, 514.7966553211461, 516.6383531527946, 521.2988530426646, 540.6377726922971, 7157.928420715726, 7170.892436613455, 7229.060222171084, 7586.544807311579, 7605.923940760632, 452.23120694818937, 480.1741005470585, 511.7134404733361, 522.2401405954328, 558.5029323901731, 3512.648735126467, 3525.8413371397837, 3589.066842620885, 3644.2529281497227, 3790.1093243087853, 56353.71823140858, 56458.43541564614, 58210.126848097316, 100852.49573752085, 101770.49114754378, 24287.75712242855, 24542.0, 24611.507769844502, 43613.0, 83914.58042709748, 52221.7388913053, 72420.63789681123, 72427.0, 72521.0, 74613.0, 7619.504732192389, 7837.843243135219, 7925.326347260317, 7926.445148839526, 7940.523568585903, 42967.785161073996, 46662.30006549836, 46807.76596117134, 46981.530184699084, 47297.0, 36368.81815590905, 44252.0, 61508.391587470454, 62172.37827621666, 65212.34787652252, 10846.566137354417, 11218.775624487627, 11246.493907774005, 11397.943010285228, 11614.477348519506, 13230.735385292433, 13346.733065338833, 13850.861491384958, 14106.506272280421, 14137.36381862798, 10610.897192905539, 10626.787464250827, 10897.182711296526, 11042.944785276022, 11361.204715669825, 11524.769504609692, 11541.769164616828, 11702.0, 12041.157119001586, 12185.87814121883, 11284.887151128383, 11356.886431135583, 11508.136889733136, 12073.939630301793, 12084.939575302067, 10136.0, 10182.898171018194, 10284.640037598649, 10479.738006549896, 10500.264981451224, 9823.312368134162, 9916.157126644315, 10001.449920254165, 10167.491625418847, 10198.643047493302], "value": 6352.588573103176, "unit": "score"}], "name": "dromaeo_css", "value": 6228.995618030925, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 116.0, 113.0, 113.0, 115.0, 113.0, 113.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 128.0, 125.0, 186.0, 128.0, 129.0, 145.0, 121.0, 153.0, 124.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 162.0, 161.0, 162.0, 160.0, 161.0, 162.0, 164.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 122.0, 76.0, 77.0, 76.0, 75.0, 112.0, 77.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 127.0, 84.0, 85.0, 85.0, 124.0, 84.0, 86.0, 132.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 62.0, 63.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 90.0, 78.0, 89.0, 88.0, 78.0, 78.0, 91.0, 78.0, 79.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 131.0, 128.0, 129.0, 127.0, 129.0, 129.0, 148.0, 137.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 165.0, 165.0, 167.0, 165.0, 164.0, 163.0, 164.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 67.0, 65.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1528.7999999999997, "alertThreshold": 2.0}]} 19:56:41 INFO - Return code: 0 19:56:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:56:42 INFO - # TBPL SUCCESS # 19:56:42 INFO - Running post-action listener: _resource_record_post_action 19:56:42 INFO - [mozharness: 2016-08-05 02:56:42.025120Z] Finished run-tests step (success) 19:56:42 INFO - Running post-run listener: _resource_record_post_run 19:56:42 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399564800; Read time: 16; Write time: 197940 19:56:42 INFO - TinderboxPrint: CPU usage
13.0% 19:56:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:56:42 INFO - TinderboxPrint: I/O write bytes / time
399,564,800 / 197,940 19:56:42 INFO - TinderboxPrint: CPU idle
8,342.2 (87.0%) 19:56:42 INFO - TinderboxPrint: CPU user
1,201.1 (12.5%) 19:56:42 INFO - TinderboxPrint: Swap in / out
0 / 0 19:56:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113438720; Read time: 0; Write time: 55400 19:56:42 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 284999680; Read time: 0; Write time: 142500 19:56:42 INFO - Running post-run listener: _upload_blobber_files 19:56:42 INFO - Blob upload gear active. 19:56:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:56:42 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 19:56:42 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'] 19:56:42 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 19:56:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:43 INFO - (blobuploader) - INFO - Done attempting. 19:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:44 INFO - (blobuploader) - INFO - Done attempting. 19:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:56:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:47 INFO - (blobuploader) - INFO - Done attempting. 19:56:47 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:47 INFO - Return code: 0 19:56:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:56:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/48220856467eb4f015dee46522540af021e26b87c5c263fc3266e818545fb33a1fe66d1cec22d1f73b84d00a6e6140420bd94729253a03536dc8a25f6f85eb75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb778e4ed9faeda5d57080d152d01d57ff9f8a6b45c21c44874a890e97b7216f09e3cebf3988e2a0a1dc69acbf60f81cd6d8fa0198736808c0bcc8b7046fd5aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8dcb0a2b10888710413412ca68884d6f3c6c2b9a78c7dd25def15c582e5d420d5a8a0332db958eff21715853cdac7096ce15dbb507e7fb3e3cea50c4e2eb8e4e"} 19:56:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:56:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:56:47 INFO - Contents: 19:56:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/48220856467eb4f015dee46522540af021e26b87c5c263fc3266e818545fb33a1fe66d1cec22d1f73b84d00a6e6140420bd94729253a03536dc8a25f6f85eb75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb778e4ed9faeda5d57080d152d01d57ff9f8a6b45c21c44874a890e97b7216f09e3cebf3988e2a0a1dc69acbf60f81cd6d8fa0198736808c0bcc8b7046fd5aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8dcb0a2b10888710413412ca68884d6f3c6c2b9a78c7dd25def15c582e5d420d5a8a0332db958eff21715853cdac7096ce15dbb507e7fb3e3cea50c4e2eb8e4e"} 19:56:47 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:47 INFO - Copying logs to upload dir... 19:56:47 INFO - mkdir: /builds/slave/test/build/upload/logs 19:56:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.544473 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-04 19:56:47.583440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 19:56:47.591852) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947 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/48220856467eb4f015dee46522540af021e26b87c5c263fc3266e818545fb33a1fe66d1cec22d1f73b84d00a6e6140420bd94729253a03536dc8a25f6f85eb75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb778e4ed9faeda5d57080d152d01d57ff9f8a6b45c21c44874a890e97b7216f09e3cebf3988e2a0a1dc69acbf60f81cd6d8fa0198736808c0bcc8b7046fd5aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8dcb0a2b10888710413412ca68884d6f3c6c2b9a78c7dd25def15c582e5d420d5a8a0332db958eff21715853cdac7096ce15dbb507e7fb3e3cea50c4e2eb8e4e"} build_url:https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/VYsTu-WxS0iJQvY7DHn6uA/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/48220856467eb4f015dee46522540af021e26b87c5c263fc3266e818545fb33a1fe66d1cec22d1f73b84d00a6e6140420bd94729253a03536dc8a25f6f85eb75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb778e4ed9faeda5d57080d152d01d57ff9f8a6b45c21c44874a890e97b7216f09e3cebf3988e2a0a1dc69acbf60f81cd6d8fa0198736808c0bcc8b7046fd5aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8dcb0a2b10888710413412ca68884d6f3c6c2b9a78c7dd25def15c582e5d420d5a8a0332db958eff21715853cdac7096ce15dbb507e7fb3e3cea50c4e2eb8e4e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 19:56:47.626373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:56:47.626785) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470363945.583314-1279530947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 19:56:47.681823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 19:56:47.682223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 19:56:47.685708) ========= ========= Total master_lag: 0.34 =========