builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1480304164.37 results: success (0) buildid: 20161127184057 builduid: e1b454a675c745b78de74372b7b011d4 revision: fa40a7b4f05f6066572872bd0ddc7a7243a862f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.370989) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.371530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.371813) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.394744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.394984) ========= 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=db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-27 19:36:06-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-11-27 19:36:06 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.395131 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.804341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.804720) ========= 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=db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016891 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.854591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:04.854947) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev fa40a7b4f05f6066572872bd0ddc7a7243a862f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev fa40a7b4f05f6066572872bd0ddc7a7243a862f4 --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=db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-27 19:36:06,886 truncating revision to first 12 chars 2016-11-27 19:36:06,886 Setting DEBUG logging. 2016-11-27 19:36:06,886 attempt 1/10 2016-11-27 19:36:06,886 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/fa40a7b4f05f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 19:36:07,197 unpacking tar archive at: graphics-fa40a7b4f05f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:05.568227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:05.568554) ========= script_repo_revision: fa40a7b4f05f6066572872bd0ddc7a7243a862f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:05.568952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:05.569211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 19:36:05.578928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-27 19:36:05.579264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:36:07 INFO - MultiFileLogger online at 20161127 19:36:07 in /builds/slave/test 19:36:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:36:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:36:07 INFO - {'append_to_log': False, 19:36:07 INFO - 'base_work_dir': '/builds/slave/test', 19:36:07 INFO - 'blob_upload_branch': 'Graphics', 19:36:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:36:07 INFO - 'branch': 'Graphics', 19:36:07 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:07 INFO - 'config_files': ('talos/linux_config.py',), 19:36:07 INFO - 'default_actions': ('clobber', 19:36:07 INFO - 'read-buildbot-config', 19:36:07 INFO - 'download-and-extract', 19:36:07 INFO - 'populate-webroot', 19:36:07 INFO - 'create-virtualenv', 19:36:07 INFO - 'install', 19:36:07 INFO - 'run-tests'), 19:36:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:07 INFO - 'download_minidump_stackwalk': True, 19:36:07 INFO - 'download_symbols': 'ondemand', 19:36:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:07 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:07 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:07 INFO - 'installer_path': 'installer.exe', 19:36:07 INFO - 'log_level': 'info', 19:36:07 INFO - 'log_name': 'talos', 19:36:07 INFO - 'log_to_console': True, 19:36:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:36:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:36:07 INFO - 'opt_config_files': (), 19:36:07 INFO - 'pip_index': False, 19:36:07 INFO - 'sps_profile': False, 19:36:07 INFO - 'sps_profile_interval': 0, 19:36:07 INFO - 'suite': 'dromaeojs-e10s', 19:36:07 INFO - 'system_bits': '32', 19:36:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:07 INFO - 'title': 'talos-linux64-ix-049', 19:36:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:07 INFO - 'use_talos_json': True, 19:36:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:07 INFO - 'work_dir': 'build'} 19:36:07 INFO - [mozharness: 2016-11-28 03:36:07.716730Z] Running clobber step. 19:36:07 INFO - Running pre-action listener: _resource_record_pre_action 19:36:07 INFO - Running main action method: clobber 19:36:07 INFO - rmtree: /builds/slave/test/build 19:36:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:08 INFO - Running post-action listener: _resource_record_post_action 19:36:08 INFO - [mozharness: 2016-11-28 03:36:08.177865Z] Finished clobber step (success) 19:36:08 INFO - [mozharness: 2016-11-28 03:36:08.177962Z] Running read-buildbot-config step. 19:36:08 INFO - Running pre-action listener: _resource_record_pre_action 19:36:08 INFO - Running main action method: read_buildbot_config 19:36:08 INFO - Using buildbot properties: 19:36:08 INFO - { 19:36:08 INFO - "project": "", 19:36:08 INFO - "product": "firefox", 19:36:08 INFO - "script_repo_revision": "default", 19:36:08 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 19:36:08 INFO - "repository": "", 19:36:08 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 19:36:08 INFO - "buildid": "20161127184057", 19:36:08 INFO - "pgo_build": "False", 19:36:08 INFO - "basedir": "/builds/slave/test", 19:36:08 INFO - "buildnumber": 18, 19:36:08 INFO - "slavename": "talos-linux64-ix-049", 19:36:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:36:08 INFO - "platform": "ubuntu64_hw", 19:36:08 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 19:36:08 INFO - "branch": "graphics", 19:36:08 INFO - "repo_path": "projects/graphics", 19:36:08 INFO - "revision": "fa40a7b4f05f6066572872bd0ddc7a7243a862f4", 19:36:08 INFO - "stage_platform": "linux64", 19:36:08 INFO - "builduid": "e1b454a675c745b78de74372b7b011d4", 19:36:08 INFO - "slavebuilddir": "test" 19:36:08 INFO - } 19:36:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:36:08 INFO - Running post-action listener: _resource_record_post_action 19:36:08 INFO - [mozharness: 2016-11-28 03:36:08.180378Z] Finished read-buildbot-config step (success) 19:36:08 INFO - [mozharness: 2016-11-28 03:36:08.180466Z] Running download-and-extract step. 19:36:08 INFO - Running pre-action listener: _resource_record_pre_action 19:36:08 INFO - Running main action method: download_and_extract 19:36:08 INFO - mkdir: /builds/slave/test/build/tests 19:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:08 INFO - trying https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:36:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:36:08 INFO - Downloaded 1361 bytes. 19:36:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:36:08 INFO - Using the following test package requirements: 19:36:08 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:08 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:36:08 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:36:08 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'jsshell-linux-x86_64.zip'], 19:36:08 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:36:08 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:08 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:36:08 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:36:08 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:36:08 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:36:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:36:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:36:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:36:09 INFO - Http code: 200 19:36:09 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 19:36:09 INFO - x-amz-cf-id: kU-c_J2wdpAM1T-Cl_nII4IKjqIiLB5dq823MazVGn9wJFafNOXz9A== 19:36:09 INFO - x-amz-version-id: vO6we.c8ZIb4y_9rhwgFG4.hc7qYYUM1 19:36:09 INFO - Expected file size: 20202451 19:36:09 INFO - Obtained file size: 20202451 19:36:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:36:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:36:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:36:14 INFO - Http code: 200 19:36:14 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 19:36:14 INFO - x-amz-cf-id: pAs7lfRxlaV_XUT0TgJJH4y6O1uL2VPSU74RDphVJGL_R_ChYRCfPg== 19:36:14 INFO - x-amz-version-id: vO6we.c8ZIb4y_9rhwgFG4.hc7qYYUM1 19:36:14 INFO - Expected file size: 20202451 19:36:14 INFO - Obtained file size: 20202451 19:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:36:19 INFO - Http code: 200 19:36:19 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 19:36:19 INFO - x-amz-cf-id: 3ko3PhOXZCQ15CB78UgKX-pfcOv4o5sf32qzOM-RiMT61zdpa9F9Cw== 19:36:19 INFO - x-amz-version-id: ht__89nOWXtCmLVCRLE5JjYb6ftuhJym 19:36:19 INFO - Expected file size: 14409506 19:36:19 INFO - Obtained file size: 14409506 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 - trying https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:36:21 INFO - Downloaded 55603878 bytes. 19:36:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:21 INFO - mkdir: /builds/slave/test/properties 19:36:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:21 INFO - Contents: 19:36:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:21 INFO - Running post-action listener: _resource_record_post_action 19:36:21 INFO - Running post-action listener: set_extra_try_arguments 19:36:21 INFO - [mozharness: 2016-11-28 03:36:21.806145Z] Finished download-and-extract step (success) 19:36:21 INFO - [mozharness: 2016-11-28 03:36:21.806440Z] Running populate-webroot step. 19:36:21 INFO - Running pre-action listener: _resource_record_pre_action 19:36:21 INFO - Running main action method: populate_webroot 19:36:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:21 INFO - '--tppagecycles', 19:36:21 INFO - '7'], 19:36:21 INFO - 'tests': ['tsvgm']}}, 19:36:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:36:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:36:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:36:21 INFO - 'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:36:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:36:21 INFO - 'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['damp', 'tps']}, 19:36:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:36:21 INFO - 'tests': ['damp', 'tps']}, 19:36:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['dromaeo_dom']}, 19:36:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['basic_compositor_video']}, 19:36:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:36:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['a11yr', 19:36:21 INFO - 'ts_paint', 19:36:21 INFO - 'tpaint', 19:36:21 INFO - 'sessionrestore', 19:36:21 INFO - 'sessionrestore_no_auto_restore', 19:36:21 INFO - 'tabpaint']}, 19:36:21 INFO - 'other-e10s': {'tests': ['a11yr', 19:36:21 INFO - 'ts_paint', 19:36:21 INFO - 'tpaint', 19:36:21 INFO - 'sessionrestore', 19:36:21 INFO - 'sessionrestore_no_auto_restore', 19:36:21 INFO - 'tabpaint']}, 19:36:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:36:21 INFO - 'ts_paint', 19:36:21 INFO - 'tpaint', 19:36:21 INFO - 'sessionrestore', 19:36:21 INFO - 'sessionrestore_no_auto_restore', 19:36:21 INFO - 'tabpaint']}, 19:36:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:36:21 INFO - 'ts_paint', 19:36:21 INFO - 'tpaint', 19:36:21 INFO - 'sessionrestore', 19:36:21 INFO - 'sessionrestore_no_auto_restore', 19:36:21 INFO - 'tabpaint']}, 19:36:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['a11yr', 19:36:21 INFO - 'ts_paint', 19:36:21 INFO - 'tpaint', 19:36:21 INFO - 'sessionrestore', 19:36:21 INFO - 'sessionrestore_no_auto_restore', 19:36:21 INFO - 'tabpaint']}, 19:36:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['a11yr', 19:36:21 INFO - 'ts_paint', 19:36:21 INFO - 'tpaint', 19:36:21 INFO - 'sessionrestore', 19:36:21 INFO - 'sessionrestore_no_auto_restore', 19:36:21 INFO - 'tabpaint']}, 19:36:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['tsvgx', 19:36:21 INFO - 'tsvgr_opacity', 19:36:21 INFO - 'tart', 19:36:21 INFO - 'tscrollx', 19:36:21 INFO - 'cart']}, 19:36:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:36:21 INFO - 'tsvgr_opacity', 19:36:21 INFO - 'tart', 19:36:21 INFO - 'tscrollx', 19:36:21 INFO - 'cart']}, 19:36:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:36:21 INFO - 'talos_options': ['--disable-e10s'], 19:36:21 INFO - 'tests': ['tp5o']}, 19:36:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:36:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:36:21 INFO - 'talos_options': ['--disable-e10s', 19:36:21 INFO - '--xperf_path', 19:36:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:21 INFO - 'tests': ['tp5n']}, 19:36:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:36:21 INFO - 'talos_options': ['--xperf_path', 19:36:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:21 INFO - 'tests': ['tp5n']}}, 19:36:21 INFO - 'talos.zip': {'path': '', 19:36:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:21 INFO - Running post-action listener: _resource_record_post_action 19:36:21 INFO - [mozharness: 2016-11-28 03:36:21.825606Z] Finished populate-webroot step (success) 19:36:21 INFO - [mozharness: 2016-11-28 03:36:21.825699Z] Running create-virtualenv step. 19:36:21 INFO - Running pre-action listener: _resource_record_pre_action 19:36:21 INFO - Running main action method: create_virtualenv 19:36:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:21 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:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:21 INFO - Using real prefix '/usr' 19:36:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:24 INFO - Installing pip.................done. 19:36:24 INFO - Return code: 0 19:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:36:24 INFO - Reading from file tmpfile_stdout 19:36:24 INFO - Output received: 19:36:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:36:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:24 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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 19:36:24 INFO - 'HOME': '/home/cltbld', 19:36:24 INFO - 'LANG': 'en_US.UTF-8', 19:36:24 INFO - 'LANGUAGE': 'en_US:en', 19:36:24 INFO - 'LOGNAME': 'cltbld', 19:36:24 INFO - 'MAIL': '/var/mail/cltbld', 19:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:24 INFO - 'MOZ_NO_REMOTE': '1', 19:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:24 INFO - 'NO_EM_RESTART': '1', 19:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:24 INFO - 'PWD': '/builds/slave/test', 19:36:24 INFO - 'SHELL': '/bin/bash', 19:36:24 INFO - 'SHLVL': '1', 19:36:24 INFO - 'TERM': 'linux', 19:36:24 INFO - 'TMOUT': '86400', 19:36:24 INFO - 'USER': 'cltbld', 19:36:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:24 INFO - '_': '/tools/buildbot/bin/python'} 19:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:24 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:24 INFO - Cleaning up... 19:36:24 INFO - Return code: 0 19:36:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:36:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:24 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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 19:36:24 INFO - 'HOME': '/home/cltbld', 19:36:24 INFO - 'LANG': 'en_US.UTF-8', 19:36:24 INFO - 'LANGUAGE': 'en_US:en', 19:36:24 INFO - 'LOGNAME': 'cltbld', 19:36:24 INFO - 'MAIL': '/var/mail/cltbld', 19:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:24 INFO - 'MOZ_NO_REMOTE': '1', 19:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:24 INFO - 'NO_EM_RESTART': '1', 19:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:24 INFO - 'PWD': '/builds/slave/test', 19:36:24 INFO - 'SHELL': '/bin/bash', 19:36:24 INFO - 'SHLVL': '1', 19:36:24 INFO - 'TERM': 'linux', 19:36:24 INFO - 'TMOUT': '86400', 19:36:24 INFO - 'USER': 'cltbld', 19:36:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:24 INFO - '_': '/tools/buildbot/bin/python'} 19:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:25 INFO - Downloading/unpacking psutil>=3.1.1 19:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:27 INFO - Installing collected packages: psutil 19:36:27 INFO - Running setup.py install for psutil 19:36:27 INFO - building 'psutil._psutil_linux' extension 19:36:27 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:27 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:27 INFO - building 'psutil._psutil_posix' extension 19:36:27 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:27 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:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:27 INFO - Successfully installed psutil 19:36:27 INFO - Cleaning up... 19:36:27 INFO - Return code: 0 19:36:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:36:27 INFO - Using env: {'DISPLAY': ':0', 19:36:27 INFO - 'HOME': '/home/cltbld', 19:36:27 INFO - 'LANG': 'en_US.UTF-8', 19:36:27 INFO - 'LANGUAGE': 'en_US:en', 19:36:27 INFO - 'LOGNAME': 'cltbld', 19:36:27 INFO - 'MAIL': '/var/mail/cltbld', 19:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:27 INFO - 'MOZ_NO_REMOTE': '1', 19:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:27 INFO - 'NO_EM_RESTART': '1', 19:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:27 INFO - 'PWD': '/builds/slave/test', 19:36:27 INFO - 'SHELL': '/bin/bash', 19:36:27 INFO - 'SHLVL': '1', 19:36:27 INFO - 'TERM': 'linux', 19:36:27 INFO - 'TMOUT': '86400', 19:36:27 INFO - 'USER': 'cltbld', 19:36:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:27 INFO - '_': '/tools/buildbot/bin/python'} 19:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:29 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:29 INFO - Installing collected packages: mozsystemmonitor 19:36:29 INFO - Running setup.py install for mozsystemmonitor 19:36:29 INFO - Successfully installed mozsystemmonitor 19:36:29 INFO - Cleaning up... 19:36:30 INFO - Return code: 0 19:36:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:30 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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 19:36:30 INFO - 'HOME': '/home/cltbld', 19:36:30 INFO - 'LANG': 'en_US.UTF-8', 19:36:30 INFO - 'LANGUAGE': 'en_US:en', 19:36:30 INFO - 'LOGNAME': 'cltbld', 19:36:30 INFO - 'MAIL': '/var/mail/cltbld', 19:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:30 INFO - 'MOZ_NO_REMOTE': '1', 19:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:30 INFO - 'NO_EM_RESTART': '1', 19:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:30 INFO - 'PWD': '/builds/slave/test', 19:36:30 INFO - 'SHELL': '/bin/bash', 19:36:30 INFO - 'SHLVL': '1', 19:36:30 INFO - 'TERM': 'linux', 19:36:30 INFO - 'TMOUT': '86400', 19:36:30 INFO - 'USER': 'cltbld', 19:36:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:30 INFO - '_': '/tools/buildbot/bin/python'} 19:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:30 INFO - Downloading/unpacking jsonschema==2.5.1 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:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:36:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:32 INFO - warning: no files found matching '*.txt' 19:36:32 INFO - no previously-included directories found matching 'build' 19:36:32 INFO - no previously-included directories found matching 'dist' 19:36:32 INFO - no previously-included directories found matching '.git*' 19:36:32 INFO - Installing collected packages: jsonschema, functools32 19:36:32 INFO - Running setup.py install for functools32 19:36:32 INFO - warning: no files found matching '*.txt' 19:36:32 INFO - no previously-included directories found matching 'build' 19:36:32 INFO - no previously-included directories found matching 'dist' 19:36:32 INFO - no previously-included directories found matching '.git*' 19:36:32 INFO - Successfully installed jsonschema functools32 19:36:32 INFO - Cleaning up... 19:36:32 INFO - Return code: 0 19:36:32 INFO - Installing functools32==3.2.3-2 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', '--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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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', '--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:32 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: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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:36:32 INFO - Cleaning up... 19:36:32 INFO - Return code: 0 19:36:32 INFO - Installing blobuploader==1.2.4 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', '--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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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', '--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:32 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: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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:32 INFO - '_': '/tools/buildbot/bin/python'} 19:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:33 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:33 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:33 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:33 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:33 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:33 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:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Downloading docopt-0.6.1.tar.gz 19:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:35 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:35 INFO - Running setup.py install for blobuploader 19:36:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:35 INFO - Running setup.py install for requests 19:36:36 INFO - Running setup.py install for docopt 19:36:36 INFO - Successfully installed blobuploader requests docopt 19:36:36 INFO - Cleaning up... 19:36:36 INFO - Return code: 0 19:36:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:36 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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:36 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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 19:36:36 INFO - 'HOME': '/home/cltbld', 19:36:36 INFO - 'LANG': 'en_US.UTF-8', 19:36:36 INFO - 'LANGUAGE': 'en_US:en', 19:36:36 INFO - 'LOGNAME': 'cltbld', 19:36:36 INFO - 'MAIL': '/var/mail/cltbld', 19:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:36 INFO - 'MOZ_NO_REMOTE': '1', 19:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:36 INFO - 'NO_EM_RESTART': '1', 19:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:36 INFO - 'PWD': '/builds/slave/test', 19:36:36 INFO - 'SHELL': '/bin/bash', 19:36:36 INFO - 'SHLVL': '1', 19:36:36 INFO - 'TERM': 'linux', 19:36:36 INFO - 'TMOUT': '86400', 19:36:36 INFO - 'USER': 'cltbld', 19:36:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:36 INFO - '_': '/tools/buildbot/bin/python'} 19:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:36 INFO - Running setup.py (path:/tmp/pip-0nE0IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:36 INFO - Running setup.py (path:/tmp/pip-mJy5Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:36 INFO - Running setup.py (path:/tmp/pip-Qlxqhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:36 INFO - Running setup.py (path:/tmp/pip-IJr9i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:37 INFO - Running setup.py (path:/tmp/pip-NET78n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:37 INFO - Running setup.py (path:/tmp/pip-HoaWGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:37 INFO - Running setup.py (path:/tmp/pip-oeUml3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:37 INFO - Running setup.py (path:/tmp/pip-zYGFWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:37 INFO - Running setup.py (path:/tmp/pip-0gpSvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:37 INFO - Running setup.py (path:/tmp/pip-VchPwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:37 INFO - Running setup.py (path:/tmp/pip-l1MUf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:37 INFO - Running setup.py (path:/tmp/pip-JcGz6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:37 INFO - Running setup.py (path:/tmp/pip-oJxDkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:37 INFO - Running setup.py (path:/tmp/pip-69GLZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:37 INFO - Running setup.py (path:/tmp/pip-55EnsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:37 INFO - Running setup.py (path:/tmp/pip-cmy2ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:37 INFO - Running setup.py (path:/tmp/pip-hpHq2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:37 INFO - Running setup.py install for manifestparser 19:36:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozcrash 19:36:38 INFO - Running setup.py install for mozdebug 19:36:38 INFO - Running setup.py install for mozdevice 19:36:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozfile 19:36:38 INFO - Running setup.py install for mozhttpd 19:36:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozinfo 19:36:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozInstall 19:36:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:38 INFO - Running setup.py install for mozleak 19:36:38 INFO - Running setup.py install for mozlog 19:36:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Running setup.py install for moznetwork 19:36:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Running setup.py install for mozprocess 19:36:39 INFO - Running setup.py install for mozprofile 19:36:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Running setup.py install for mozrunner 19:36:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Running setup.py install for mozscreenshot 19:36:39 INFO - Running setup.py install for moztest 19:36:39 INFO - Running setup.py install for mozversion 19:36:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:39 INFO - Cleaning up... 19:36:39 INFO - Return code: 0 19:36:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 19:36:39 INFO - 'HOME': '/home/cltbld', 19:36:39 INFO - 'LANG': 'en_US.UTF-8', 19:36:39 INFO - 'LANGUAGE': 'en_US:en', 19:36:39 INFO - 'LOGNAME': 'cltbld', 19:36:39 INFO - 'MAIL': '/var/mail/cltbld', 19:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:39 INFO - 'MOZ_NO_REMOTE': '1', 19:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:39 INFO - 'NO_EM_RESTART': '1', 19:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:39 INFO - 'PWD': '/builds/slave/test', 19:36:39 INFO - 'SHELL': '/bin/bash', 19:36:39 INFO - 'SHLVL': '1', 19:36:39 INFO - 'TERM': 'linux', 19:36:39 INFO - 'TMOUT': '86400', 19:36:39 INFO - 'USER': 'cltbld', 19:36:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:39 INFO - '_': '/tools/buildbot/bin/python'} 19:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:39 INFO - Running setup.py (path:/tmp/pip-hJHQjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:40 INFO - Running setup.py (path:/tmp/pip-myX2Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:40 INFO - Running setup.py (path:/tmp/pip-2HaeV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:40 INFO - Running setup.py (path:/tmp/pip-1_uKGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:40 INFO - Running setup.py (path:/tmp/pip-oD60du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:40 INFO - Running setup.py (path:/tmp/pip-pTd9SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:40 INFO - Running setup.py (path:/tmp/pip-qschMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:40 INFO - Running setup.py (path:/tmp/pip-SuZ11h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:40 INFO - Running setup.py (path:/tmp/pip-iQngbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:40 INFO - Running setup.py (path:/tmp/pip-W8oVtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:40 INFO - Running setup.py (path:/tmp/pip-F1bcy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:40 INFO - Running setup.py (path:/tmp/pip-WEpPqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:40 INFO - Running setup.py (path:/tmp/pip-L4SxMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:40 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:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:40 INFO - Running setup.py (path:/tmp/pip-BRnBcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:41 INFO - Running setup.py (path:/tmp/pip-E5n5KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:41 INFO - Running setup.py (path:/tmp/pip-qt8vWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:41 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:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:41 INFO - Running setup.py (path:/tmp/pip-_vUe0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:41 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:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:41 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:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:41 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:41 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:41 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:41 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:41 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:41 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:43 INFO - Downloading blessings-1.6.tar.gz 19:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:43 INFO - Installing collected packages: blessings 19:36:43 INFO - Running setup.py install for blessings 19:36:43 INFO - Successfully installed blessings 19:36:43 INFO - Cleaning up... 19:36:43 INFO - Return code: 0 19:36:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:43 INFO - Reading from file tmpfile_stdout 19:36:43 INFO - Current package versions: 19:36:43 INFO - argparse == 1.2.1 19:36:43 INFO - blessings == 1.6 19:36:43 INFO - blobuploader == 1.2.4 19:36:43 INFO - docopt == 0.6.1 19:36:43 INFO - functools32 == 3.2.3-2 19:36:43 INFO - jsonschema == 2.5.1 19:36:43 INFO - manifestparser == 1.1 19:36:43 INFO - mozInstall == 1.12 19:36:43 INFO - mozcrash == 1.0 19:36:43 INFO - mozdebug == 0.1 19:36:43 INFO - mozdevice == 0.49 19:36:43 INFO - mozfile == 1.2 19:36:43 INFO - mozhttpd == 0.7 19:36:43 INFO - mozinfo == 0.9 19:36:43 INFO - mozleak == 0.1 19:36:43 INFO - mozlog == 3.4 19:36:43 INFO - moznetwork == 0.27 19:36:43 INFO - mozprocess == 0.23 19:36:43 INFO - mozprofile == 0.28 19:36:43 INFO - mozrunner == 6.13 19:36:43 INFO - mozscreenshot == 0.1 19:36:43 INFO - mozsystemmonitor == 0.3 19:36:43 INFO - moztest == 0.7 19:36:43 INFO - mozversion == 1.4 19:36:43 INFO - psutil == 3.1.1 19:36:43 INFO - requests == 1.2.3 19:36:43 INFO - wsgiref == 0.1.2 19:36:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:43 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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 19:36:43 INFO - 'HOME': '/home/cltbld', 19:36:43 INFO - 'LANG': 'en_US.UTF-8', 19:36:43 INFO - 'LANGUAGE': 'en_US:en', 19:36:43 INFO - 'LOGNAME': 'cltbld', 19:36:43 INFO - 'MAIL': '/var/mail/cltbld', 19:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:43 INFO - 'MOZ_NO_REMOTE': '1', 19:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:43 INFO - 'NO_EM_RESTART': '1', 19:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:43 INFO - 'PWD': '/builds/slave/test', 19:36:43 INFO - 'SHELL': '/bin/bash', 19:36:43 INFO - 'SHLVL': '1', 19:36:43 INFO - 'TERM': 'linux', 19:36:43 INFO - 'TMOUT': '86400', 19:36:43 INFO - 'USER': 'cltbld', 19:36:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:43 INFO - '_': '/tools/buildbot/bin/python'} 19:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:43 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:43 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:43 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:43 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:43 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:43 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:43 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:43 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:43 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:43 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:43 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:43 INFO - Cleaning up... 19:36:43 INFO - Return code: 0 19:36:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:43 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 0x7f4d5f5b2e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2030b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 19:36:43 INFO - 'HOME': '/home/cltbld', 19:36:43 INFO - 'LANG': 'en_US.UTF-8', 19:36:43 INFO - 'LANGUAGE': 'en_US:en', 19:36:43 INFO - 'LOGNAME': 'cltbld', 19:36:43 INFO - 'MAIL': '/var/mail/cltbld', 19:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:43 INFO - 'MOZ_NO_REMOTE': '1', 19:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:43 INFO - 'NO_EM_RESTART': '1', 19:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:43 INFO - 'PWD': '/builds/slave/test', 19:36:43 INFO - 'SHELL': '/bin/bash', 19:36:43 INFO - 'SHLVL': '1', 19:36:43 INFO - 'TERM': 'linux', 19:36:43 INFO - 'TMOUT': '86400', 19:36:43 INFO - 'USER': 'cltbld', 19:36:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:43 INFO - '_': '/tools/buildbot/bin/python'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:36:44 INFO - Cleaning up... 19:36:44 INFO - Return code: 0 19:36:44 INFO - Running post-action listener: _resource_record_post_action 19:36:44 INFO - Running post-action listener: _start_resource_monitoring 19:36:44 INFO - Starting resource monitoring. 19:36:44 INFO - [mozharness: 2016-11-28 03:36:44.149354Z] Finished create-virtualenv step (success) 19:36:44 INFO - [mozharness: 2016-11-28 03:36:44.149876Z] Running install step. 19:36:44 INFO - Running pre-action listener: _resource_record_pre_action 19:36:44 INFO - Running main action method: install 19:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:44 INFO - Reading from file tmpfile_stdout 19:36:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:44 INFO - Reading from file tmpfile_stdout 19:36:44 INFO - Output received: 19:36:44 INFO - Usage: mozinstall [options] installer 19:36:44 INFO - Options: 19:36:44 INFO - -h, --help show this help message and exit 19:36:44 INFO - -d DEST, --destination=DEST 19:36:44 INFO - Directory to install application into. [default: 19:36:44 INFO - "/builds/slave/test"] 19:36:44 INFO - --app=APP Application being installed. [default: firefox] 19:36:44 INFO - mkdir: /builds/slave/test/build/application 19:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:37:00 INFO - Reading from file tmpfile_stdout 19:37:00 INFO - Output received: 19:37:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:37:00 INFO - Running post-action listener: _resource_record_post_action 19:37:00 INFO - [mozharness: 2016-11-28 03:37:00.472574Z] Finished install step (success) 19:37:00 INFO - [mozharness: 2016-11-28 03:37:00.472826Z] Running run-tests step. 19:37:00 INFO - Running pre-action listener: _resource_record_pre_action 19:37:00 INFO - Running main action method: run_tests 19:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:37:00 INFO - Python 2.7.3 19:37:00 INFO - Return code: 0 19:37:00 INFO - grabbing minidump binary from tooltool 19:37:00 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:37:00 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 0x225afc0>, '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 0x225bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:37:00 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:37:00 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:37:00 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:37:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:00 INFO - Return code: 0 19:37:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:37:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:37:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:37:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:37:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:37:00 INFO - Using env: {'DISPLAY': ':0', 19:37:00 INFO - 'HOME': '/home/cltbld', 19:37:00 INFO - 'LANG': 'en_US.UTF-8', 19:37:00 INFO - 'LANGUAGE': 'en_US:en', 19:37:00 INFO - 'LOGNAME': 'cltbld', 19:37:00 INFO - 'MAIL': '/var/mail/cltbld', 19:37:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:37:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:00 INFO - 'MOZ_NO_REMOTE': '1', 19:37:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:00 INFO - 'NO_EM_RESTART': '1', 19:37:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:00 INFO - 'PWD': '/builds/slave/test', 19:37:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:37:00 INFO - 'SHELL': '/bin/bash', 19:37:00 INFO - 'SHLVL': '1', 19:37:00 INFO - 'TERM': 'linux', 19:37:00 INFO - 'TMOUT': '86400', 19:37:00 INFO - 'USER': 'cltbld', 19:37:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391', 19:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:00 INFO - '_': '/tools/buildbot/bin/python'} 19:37:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:37:00 INFO - mozversion application_buildid: 20161127184057 19:37:00 INFO - mozversion application_changeset: fa40a7b4f05f6066572872bd0ddc7a7243a862f4 19:37:00 INFO - mozversion application_display_name: Nightly 19:37:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:00 INFO - mozversion application_name: Firefox 19:37:00 INFO - mozversion application_remotingname: firefox 19:37:00 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:37:00 INFO - mozversion application_vendor: Mozilla 19:37:00 INFO - mozversion application_version: 53.0a1 19:37:00 INFO - mozversion platform_buildid: 20161127184057 19:37:00 INFO - mozversion platform_changeset: fa40a7b4f05f6066572872bd0ddc7a7243a862f4 19:37:00 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:37:00 INFO - mozversion platform_version: 53.0a1 19:37:00 INFO - using testdate: 1480304220 19:37:00 INFO - actual date: 1480304220 19:37:00 INFO - starting webserver on 'localhost:33247' 19:37:00 INFO - SUITE-START | Running 2 tests 19:37:00 INFO - TEST-START | dromaeo_css 19:37:00 INFO - operating with platform_type : linux_ 19:37:00 INFO - Initialising browser for dromaeo_css test... 19:37:00 INFO - TEST-INFO | started process 12969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW9CEUg/profile http://localhost:33247/getInfo.html) 19:37:05 INFO - PROCESS | 12969 | __metrics Screen width/height:1600/1200 19:37:05 INFO - PROCESS | 12969 | colorDepth:24 19:37:05 INFO - PROCESS | 12969 | Browser inner width/height: 1024/697 19:37:05 INFO - PROCESS | 12969 | __metrics 19:37:06 ERROR - PROCESS | 12969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 19:37:07 INFO - TEST-INFO | 12969: exit 0 19:37:07 INFO - Browser initialized. 19:37:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:07 INFO - TEST-INFO | started process 13094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW9CEUg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:19 INFO - PROCESS | 13094 | RSS: Main: 186171392 19:37:19 INFO - PROCESS | 13094 | 19:38:09 INFO - PROCESS | 13094 | 1480304289424 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:23 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:33247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33247/tests/dromaeo/cssquery-ext.html) 19:40:25 INFO - PROCESS | 13094 | RSS: Main: 195821568 19:40:25 INFO - PROCESS | 13094 | 19:43:27 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:33247/tests/dromaeo/cssquery-ext.html (next: http://localhost:33247/tests/dromaeo/cssquery-jquery.html) 19:43:28 INFO - PROCESS | 13094 | RSS: Main: 197181440 19:43:28 INFO - PROCESS | 13094 | 19:46:30 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:33247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33247/tests/dromaeo/cssquery-mootools.html) 19:46:30 INFO - PROCESS | 13094 | RSS: Main: 198537216 19:46:30 INFO - PROCESS | 13094 | 19:49:33 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:33247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33247/tests/dromaeo/cssquery-prototype.html) 19:49:33 INFO - PROCESS | 13094 | RSS: Main: 195158016 19:49:33 INFO - PROCESS | 13094 | 19:52:36 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:33247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33247/tests/dromaeo/cssquery-yui.html) 19:52:37 INFO - PROCESS | 13094 | RSS: Main: 198975488 19:52:37 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:33247/tests/dromaeo/cssquery-yui.html (next: http://localhost:33247/tests/dromaeo/cssquery-dojo.html) 19:55:40 INFO - PROCESS | 13094 | RSS: Main: 198893568 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | __start_tp_report 19:55:40 INFO - PROCESS | 13094 | _x_x_mozilla_page_load 19:55:40 INFO - PROCESS | 13094 | _x_x_mozilla_page_load_details 19:55:40 INFO - PROCESS | 13094 | |i|pagename|runs| 19:55:40 INFO - PROCESS | 13094 | |0;dojo.html;2624.160268714011;2657.641218435511;2658.787297016239;2669;2672.8529930853806;4635.374224479702;4762.1428142934255;4792.808287668489;4795.0649623323425;4822.807087716487;4660.836870709526;4743;4766.690165139264;4785.497522760113;4848.466668666444;4334.176506463769;4387.100644367897;4395.692301538894;4468.664850136237;4507.6619253555955;4056.290149223889;4487.46150461945;4492.989077457562;4516.774161291939;4519.548045195487;4271.188474189894;4451.577100175478;4455;4480.52954439784;4545.909081818361;4286.03564198056;4346.282863327548;4346.369776382438;4351.151525452538;4358.5205627380965;4319.654427645813;4329.19909816685;4341.7394956302405;4367.606915377632;4432.22436073689;4729.59798417135;4743.620510359163;4784.354112194844;4789.353437285957;4808.158572249878;4885.071836351118;5132;5132;5136.43499215086;5167.121589329823;4961.156603377399;5021.447640759514;5037.319961805183;5039.218921067204;5048.873778155539;4706.670533062687;4752.263399173134;4764.904701905943;4801.039792041605;4808.110499557593;5183.766730497136;5184.274201611777;5184.844454666366;5185.533302002762;5233.528982391603;4800;4894.1679914414635;5006.899862002812;5008.574271186917;5019.347484826949;4881.194602890483;5048.520390562964;5053.090443720165;5092.10888094582;5157.4584668610005;4865.221564549655;4992.026554821848;5046.772895219724;5048.848534543969;5132.794688212504;4982.7259500727805;5012.624053196025;5013.724245166551;5024.070546948826;5077.26379674945;4233.576642335742;4315.913681726411;4350.825966961349;4354.4992325882295;4370.672199585044;3734.8692795752017;3756.1736417988;3784.148566572499;3802.296575133609;3840.6543411093135;4383.7808109595035;4385.495667998157;4407.184670835905;4418;4422.579854913778;4942.752862356868;5113.1563292057135;5116.616253780981;5117.130087885069;5121.257417674491;4280.464941882265;4359.673024523174;4375.146846364928;4389.40742999691;4429.822807087745;4529.411176547093;4567.314902764612;4572.428446444194;4573.56551127649;4628.213203755369;4764.571188593043;4770.833020844254;4773.832915847928;4781.139394908881;4793.520647935178;4909.803607855789;4938.30863679078;4940;4988.226824842155;5005.649604527648;4619.93070103942;4662.603678687214;4665.393498845128;4673;4684.6486513510945;4997.250412438163;5011.423686275979;5030.044291584587;5050.444451110448;5113.284140220447;5126.154184559506;5128.615353848401;5133.948660513347;5148.971946808917;5180.378354597472;4805.231163013901;4990.276409920469;4992.350994370854;4995.2507123930245;4998.4251811042195;4878.878028049327;4923.040007198562;4965.925511117264;4973.229149481692;4980.402351717817;4840.709557426425;4892.461829198856;4910.852674419773;4915.827946021872;4916.508349165055;4978.626603004716;5017.924731128963;5019.824306149268;5029.773660185374;5069.493050694901;4752.192127338291;4786.353842231254;4898.779554919965;4904.803807847788;4947.060058588857 19:55:40 INFO - PROCESS | 13094 | |1;ext.html;523.9318888544489;541.1044720986766;541.9078756611376;548.626933685094;559.4657102467145;36103;37688;37793.433098503476;37841.81079094604;41224.58775412245;37945.24109517808;38389.232215355674;38538.61461385385;38539;38589.614103858956;7502.8124296892465;7700.345470635003;7701.306882380584;9625;9959.203263738884;9761.951190244039;9828.901710982871;9831.164351030171;9836.803263934717;9852;9814.901850981505;9896.90103098967;9898.15865651417;9898.653547125852;9910.9504452478;9700.854487182698;9863.063009014133;9867.309288349818;9881.209503239723;9909.900900991042;9729.659461918798;9800.264980126447;9812.313138080337;9815.509224538815;9821;36109;36398.27203455916;36484.63515364839;36533.63466365329;36535.81732091349;2950.7639388849057;3074.6925307469296;3178.300773829777;3229.9677003229904;3328.0182346207926;26056.218313450627;27300.590491142648;27402;27906.3023424414;28016.159515214575;3257.9348413031844;3269.3788180245915;3312.8509217085048;3335.149536868083;3335.332933413327;255764;256988;258493;258697.70651146813;259126;51640;52098.47901521012;52259;52300.476995230325;52405.7379713099;54887;55039.724801375734;55177.448225518034;55210.723946380014;55309.170362444595;13465.528706495226;13556;13586.456541738418;13605.115667481581;13622;9348.859767103499;9563.521823908777;9575.904240957501;9596.328257022082;9596.952015240018;16966.660666786844;16976;16989.281714925553;17042.573935651708;17116;6667.43326817226;6714.328567143344;6738.797836064926;6753;6794.675038367471;750.339701063061;751.5640928261595;831.0609011816608;846.5217152308926;954.9686338754129;25777;26065.600774709896;26552;26590.202293931212;26651.600225996626;900.7117722328923;905.1898550797;909.4543274035526;926.4348747264163;1058.4284486377423;13904.58286251414;13970.650733731738;14123.794252374064;14206.147631141957;14292.78412357232;363439;366167;367894.5684345246;368529;368759;47499;47619.285710714365;47694.28458573124;47849.282260766115;48112.27831582529;1120.5685810962839;1163.3310846263432;1175.5356634129641;1175.905927525796;1186.442372085136;24911.87544062268;25430;25690.743092568835;25893.352666183495;25938.092166774073;39564.2087158261;40195.19609607733;40219.597804021585;40248;40322.59677403306;339500;339850;340337;340988;345476;22634.434139145993;23349;23619.27614477146;24266.63600046036;24285;38430;38947.2210555793;38983;39354;40679.7966010168;33721;33981.49027764635;34468.31063378769;34812;34845;33541.66458335386;33917.66082339145;33989.83005084959;34196;34237.48643770296;33746.32507349888;33817.15457113592;33989.32021359509;34308.48537271893;34614.65385346215;29144;31320;31342.529862052543;31439.585218664757;31454.21364465815;24092;24109.51780964336;24109.879450602635;24565.701002324164;24629 19:55:40 INFO - PROCESS | 13094 | |2;jquery.html;356.7128461588422;361.14769144818234;364.51883513761834;375.7895578476052;380.56425392925104;15388.538343849688;16856.915715421404;16876.324947002122;17206.397776077854;17286.56783580411;15848.920755396235;16639.91680041598;16765.832341676578;16900;16915.492535223933;4748.786304616283;5022.0709168803705;5028.673136246132;5032.773525191357;5045.293658887758;4920.483349248331;6310.716017779211;6726.562773419712;6757.256701762803;6773.187217533903;6389.968050159743;6704.061431399584;6769.69536370862;6831.692573834164;6872;6606.8017959461295;6808.2170550386845;6817.454603631747;6819.181698196224;6820.079289295931;6172.105044768528;6566.080748695186;6569.605823650596;6584.30864759203;6709.463242940553;22847.42881427961;23199.652005219934;23660.7633923662;23699;23871;1909.6658084835237;1941.4369832748487;2089.613421517009;2129.1909074551727;2632.4866651003063;13949;14004.326426927119;14043;14575.416983320654;14900.180490073042;1786.1337251433044;1790.9552261193444;1830.2130084063847;1835.1008006077059;1843.8709290349682;73732;77577.22422775757;79249.20750792476;79668.99999999942;83008.58495707483;15445.30496127677;15688.529344119695;16265.268062937197;16340.75488867668;16357.672846543002;28255.0110746127;28289.292767680974;28299.71700283012;28355.432891342058;28634;7972.6412311444965;8146.14465481116;8256.1331060239;8489.151084891462;8535.061143274235;6517.576357536745;6605.042268870987;6675.232348279913;6771.052052712625;6822.863542729117;7931.801704957422;8013.4791238569305;8124.918750812534;8280.91877197805;8475.830483390298;1459.8175228096488;1500.9624759380883;1518.111904535859;1528.083150109925;3194.3611277744544;759.0322339017686;801.6072124658991;835.5362773660555;841.3059226138461;865.2213008292587;15930;16237.077326081419;16378.508644740677;16776.580585485215;16904.915475422546;752.4883079505879;759.4683721394936;798.5448294472095;819.2585709932521;831.6216121664748;7861.842763144705;9328.300377471716;9390.10793974585;9390.812183756287;9547.379420337656;363528;365816;381178;384465;386842;71948;79316.6034169837;80235;80852.59573702094;83683;866.1122349591593;882.2500874256958;925.9583318750672;929.7396728915915;935.6584846530967;15464.304106315018;15492.845071549591;15741.291641876373;15964.521064367624;16019.439319623758;23950.8345858714;25493.3626659335;34177;34368.82815585906;36254.8187259062;47156;49122.75438622784;49215;49386.506134938194;49408;6953.687084081127;7095.396891264094;7164.928350716635;7251.021112149792;7313.780586582411;6156.969215154075;10144.797104058025;11037.889621103686;11163.944180279046;11936.104792140797;6051.606645568024;9813.460259685786;9860.16188623975;10250.641227557298;10373.740656483647;9695;9791.951040245038;10084.092431681183;10086.89913100889;10201.97980201974;9822;9845.803083938425;10053;10085.243606729378;10373.533191006574;7025.227225005143;7131.679074441558;7190;7192.280771922975;7213.927860721536;9066.637334506546;9408.670696525589;9469.66856160031;9526.809463810547;10237.488125593542 19:55:40 INFO - PROCESS | 13094 | |3;mootools.html;1322.3916998180832;1351;1399.3982587487376;1624.3583784405153;1632.542887991363;6055.273367195942;6221.875562488747;6683.331666833315;7073.681684324211;7150.427965762739;6623.304553021935;6799.42204912583;6858.451323894089;7031.085958825358;7039.648017599113;2082.156726525756;2122.066290832037;2124.681297805334;2125.798049185325;2127.361791462555;2080.4902798814237;2116.0795054151417;2158.190678495564;2163.0590693048493;2165.317924853674;2054.209129485144;2059.804318589739;2070.7722150563427;2076.771555128935;2077.6156411063926;2040.8673436226672;2057.814796668307;2068.069368784038;2068.4415207893935;2068.813806757384;1992.1533348326902;2006.0571531380228;2014.63736527425;2031.89840507974;2043.4993426610426;7000.719971201197;7160.2481739417135;7270.345668889772;7276.599787011713;7286.453515986323;4332.67504937131;4441.178381999341;4445.044315472189;4447.533009034038;4452.977735111336;2621.5936529837904;2707.7292270772964;2791.4556661451024;2839.375337425763;2842.9004984825433;822.2312138150849;865.0484467086218;870.4646642314995;907.1880666803174;909.8453262945249;9272.490013049279;9294.302927280482;9318.25453963688;9336.953315233448;9349.39228950116;3838.980805095957;4057.6145266199665;4116.0533077392365;4129.112240868228;4145.2124096421585;8243.546604936666;8261.421700480909;8265.173482651808;8266.214709602578;8266.875996860052;4503.954960450419;4508.233600287959;4512.2329204035395;4515.390422292949;4521.367008618796;3457.0665920201404;3567.6075631680496;3937.409388591734;4097.672186225095;4104.794760262034;3378.6790254926236;3441.5525981622227;3515.9296814064087;3557.5019497270405;3560.1989552350515;1163.1044096045998;1200.771853347861;1201.8077107662732;1202.3988005997;1204.1931905623078;848.7326492154951;851.1190917400461;858.1418581418457;868.7437206024238;887.2059506741431;4978.800847966113;4994.700317980933;5045.8738531537;5062.265971434122;5101.336826212569;409.4206697523031;409.7009183296151;417.93522004089414;421.4289637541149;427.4934202969491;3396.847141878621;3458.9135271617906;3477.0438129514587;3552.0409489437707;3554.5556805399324;8075.798105047421;8415.831683366298;8430.789230269293;8448.197421244971;8504.064552899175;8231.259186673109;8262.339012878956;8308.335333173332;8398.832023359499;8412.663493460193;6532.08550802888;6602.372774586406;6605.207375114921;6618.768343107968;6628.767993120314;4889.291052797395;4939.60483161339;4951.628627852853;4985.4266759323145;5131.204663277198;7671.347935425551;7853.175416581176;7935.523868567673;8025.839483210187;8029.598520073856;8139.104698483044;8153.79615509617;8185.30424913889;8206.548639824867;8271.751847444586;5484.970560892495;5639.746211420578;6275.748970041147;6401.199850018747;6404.071409645669;6600.339966003553;6841.17905851301;6850.657467126524;6980.127484064492;6985.1967023790885;6059.969700151471;6214.9689251553455;6227.221597300338;6288.65412402304;6398.616083035033;6225.533085018732;6228.252609686867;6234.9688251558455;6235.376462353728;6255.96872015637;5793.826185214451;5936.762529498945;5936.8812623748145;5937.881242375215;5942.762289508371;4392.714473559208;4487.551244875486;4533.682642215013;4539.591436770706;4572.199865023674;4277.572242775697;4380.62764665007;4430.867073987785;4436.866893993185;4440.888977775452 19:55:40 INFO - PROCESS | 13094 | |4;prototype.html;292.38598942221336;296.1574321056593;296.56553149635783;296.7077428732699;303.45378319025747;4994.901121753213;5010.398752149743;5016.523430274127;5031.34592502975;5043.218301163321;4921.16149403465;4940.283658869462;4949.8020079196785;4954.736542181748;4961.702297862131;3685.870994515186;3764.6047165047685;3773.5471743390694;3829.9617003829885;3831.2337532493475;3846.442265871461;3851.133494963625;3852.749571277858;3855.306044911915;3861.3435715928217;3848.2495913296916;3849.2109117630957;3855.363864962278;3859.864904728335;3871.9806400968096;3727.0226521147556;3861.826217820191;3863.613638636142;3864.8840534784003;3871.7676939383728;3381.661833816623;3406.914827129317;3407.386670399327;3410.539577157077;3415.6072051714123;4817.735024573647;4819;4822.204336284509;4838.6371022173125;4874.488178741217;4392.648588112943;4402.92128428537;4428.535003824616;4440.955590444119;4442.267025940716;5015.197568389077;5110.386753589556;5121.00140472608;5146.639735218536;5159.432462429129;3674.7978861162624;3688.704903607705;3698.130939229279;3735.0662334416397;3750.2312026034597;5435.918461223085;5441.238226648233;5457.481539253765;5482.369527504348;5503;3741.7006639469323;3756.4643865390753;3810.6951443884423;3812.5234345706785;3813.1696785543095;3835.232953409329;3839.6352346527037;3850.6919446444217;3878.4764056852528;3884.320243957353;4377.474703035592;4444.40001599424;4454;4460.375547423363;4463.375127482155;5021.648484606116;5207.29701490294;5269.657472264291;5274.630775845731;5295.947040529622;1295.799151131576;1305.8704220848897;1307.6338625184962;1307.8822905938512;1311.475409836054;872.5244741615835;895.3687650206589;914.1863741270275;914.492456686532;923.3121324613206;4434.312681534303;4453.977730111329;4588.197065513522;4609.838655647036;4629.282461218517;5464.754086066137;5481.7657582026795;5490.396056433789;5492.176173573996;5500.6424582402815;4588.174128656807;4615.730674064659;4618.745968971672;4633.073385322881;4639;2684.6644169478814;2730.617713520069;2742.75315221631;2748.4503099380204;2763.6130941668184;4767.332573439721;4769.904601907942;4771.71369717818;4779.832705855279;4878.365747474636;5375.569954403638;5411.188321751769;5427.507435455282;5441.80280338325;5445.237666726662;4819.180739274332;5001.599872010231;5004.749762511859;5006.299118123538;5038.370203724535;5365.356157261153;5402.432744561765;5456;5459.099248623933;5544.362398324083;5190.325257716473;5336.744585802735;5344.305240318734;5358.74069593653;5392.272043274108;5025.84922452327;5028.296038554532;5035.974820125876;5042.546170844495;5079.619028572945;3709.2025214577916;3732.197577520846;3736.2153947671295;3736.5614238517824;3756.830942607644;5356.196570514454;5397.649152805055;5503.752331145028;5521.775841481351;5529.364123125892;5225.817096401608;5274.547335489016;5275.0745977718625;5278.498542638443;5281.705982034427;5136.30659860914;5179.1454410021925;5281.181416880389;5284.471552844685;5289.973550132225;4919.852404427873;5113.846584602468;5114.795408183631;5183.98912212115;5191.480851914778;5083.5678967288195;5251.973740131275;5279.656822306538;5290.153575427913;5327.254184414108;5110.97444512775;5150.510701483353;5152;5166.586673066221;5180.766865490987 19:55:40 INFO - PROCESS | 13094 | |5;yui.html;643.3245092652714;650.5511197273884;739.6190961654748;742.1354122447349;745.4036770583532;11469.827952580717;12214.877851221507;12251.754964900707;12286.201396909217;12389.62831115067;11606.36165010924;12057.216280941733;12106.334151621679;12228.44971976261;12243.693907652314;750.6284389227327;767.5663250263611;770.2490072179636;770.8650986077442;770.8766597344426;745.4036770583539;760.7983884270645;783.3772151139857;784.7331907151568;785.7132146766446;812.9065157506903;813.4590497319275;813.4875028731891;814.0597609760706;814.975550733476;801.9518828870257;802.8875957365973;803.1286054630733;803.6222975201675;804.5615139748821;595.9165716799652;596.0373995996478;596.4155127974609;596.582392325374;597.5697497801576;11776.411179440993;11815.468303926344;11885.524579016828;11896.702582435422;11917.940410297893;12138.696532586757;12180.634580962585;12412.193207441487;12470.625881223577;12579.811302830465;9617.56720947559;9657.661981830603;9875.111239988364;9995.400275983464;10005.899941000642;3214.694604012615;3240.173755692307;3258.462353711635;3271.460209065501;3297.472404415306;46529.28470590572;47481.76259118682;47599.28601070987;48444.51555484435;48873.51126488725;9448.480333581581;9527.38072025316;9623.951880240555;9640.566174522164;9640.662576809778;16747;16876.409325673543;16885.32458701638;16905.408310709066;17099.914500427418;6224.134419046018;6395.104685344056;6411.455026322721;6420.967895160495;6671.266160722414;3424.0412684448393;3432.5709286339206;3467.9769468007;3478.147853775841;3483.303339332144;2693.8922443102447;2768.29408500831;2786.4009238013923;2789.902353417621;2793.5669971154502;468.2110643565603;472.5817651378486;480.9014152098811;487.8560824556764;493.8123513065012;498.37453995235745;552.215853488048;561.719140429785;567.2059117235821;633.7179954920108;7688.346490548254;7857.803554911173;7887.684492620346;7897.17079706634;8179.345652347798;583.9474447299764;597.5966222799593;619.0775744141287;622.2905887288495;634.8222497700651;3787.3561494545993;3861.575226725058;3960.20795840833;4091.0999580092334;4169.499660040815;40189.799051005146;43248;69541;70433.6478317605;70501.64749176221;36579.634203658155;36811.26377472489;58833;59234.703826481455;60232.69883650554;33660;45497;52297;53205.73397132989;54511.454885450636;7621.542707437571;7805.2194780521495;7805.258500442449;7806.57063861493;7881.802954926173;27614.171574852786;33585.83207083949;38138.618613814615;38808.6119138805;39961.60038399695;51055.744721276154;52278.47721522736;52352.73823630858;52521.47478525166;53747.46252537581;8815.603297851483;9348.392354496937;9447.952760236154;9470.19503342196;9471.810563788547;9178.311626627896;9563.378380405251;9800.313978021755;10039.397636141855;10198.490075496047;9547.761305967406;9606.711798646053;9768.169705575106;9821.459819709984;9986.900130998887;8767.56162191875;8866.822663546563;8888.288936884905;9137.77155571116;10163.7459063524;9194.632214711337;9197.172254497127;9566.9043309566;9695.70912872615;10840.186985975926;8507.447015943944;8762.518061506424;8945.59744811498;9144.314176436661;9234.215091717278;8892.911070889208;9116.726498205064;9165.862512062458;9338.906610934075;9343.29925255595 19:55:40 INFO - PROCESS | 13094 | __end_tp_report 19:55:40 INFO - PROCESS | 13094 | __start_cc_report 19:55:40 INFO - PROCESS | 13094 | _x_x_mozilla_cycle_collect,347 19:55:40 INFO - PROCESS | 13094 | __end_cc_report 19:55:40 INFO - PROCESS | 13094 | __startTimestamp1480305340435__endTimestamp 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | ------- Summary: start ------- 19:55:40 INFO - PROCESS | 13094 | Number of tests: 6 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | [#0] dojo.html Cycles:165 Average:4691.37 Median:4800.00 stddev:484.39 (10.1%) stddev-sans-first:457.92 19:55:40 INFO - PROCESS | 13094 | Values: 2624.2 2657.6 2658.8 2669.0 2672.9 4635.4 4762.1 4792.8 4795.1 4822.8 4660.8 4743.0 4766.7 4785.5 4848.5 4334.2 4387.1 4395.7 4468.7 4507.7 4056.3 4487.5 4493.0 4516.8 4519.5 4271.2 4451.6 4455.0 4480.5 4545.9 4286.0 4346.3 4346.4 4351.2 4358.5 4319.7 4329.2 4341.7 4367.6 4432.2 4729.6 4743.6 4784.4 4789.4 4808.2 4885.1 5132.0 5132.0 5136.4 5167.1 4961.2 5021.4 5037.3 5039.2 5048.9 4706.7 4752.3 4764.9 4801.0 4808.1 5183.8 5184.3 5184.8 5185.5 5233.5 4800.0 4894.2 5006.9 5008.6 5019.3 4881.2 5048.5 5053.1 5092.1 5157.5 4865.2 4992.0 5046.8 5048.8 5132.8 4982.7 5012.6 5013.7 5024.1 5077.3 4233.6 4315.9 4350.8 4354.5 4370.7 3734.9 3756.2 3784.1 3802.3 3840.7 4383.8 4385.5 4407.2 4418.0 4422.6 4942.8 5113.2 5116.6 5117.1 5121.3 4280.5 4359.7 4375.1 4389.4 4429.8 4529.4 4567.3 4572.4 4573.6 4628.2 4764.6 4770.8 4773.8 4781.1 4793.5 4909.8 4938.3 4940.0 4988.2 5005.6 4619.9 4662.6 4665.4 4673.0 4684.6 4997.3 5011.4 5030.0 5050.4 5113.3 5126.2 5128.6 5133.9 5149.0 5180.4 4805.2 4990.3 4992.4 4995.3 4998.4 4878.9 4923.0 4965.9 4973.2 4980.4 4840.7 4892.5 4910.9 4915.8 4916.5 4978.6 5017.9 5019.8 5029.8 5069.5 4752.2 4786.4 4898.8 4904.8 4947.1 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | [#1] ext.html Cycles:180 Average:47017.41 Median:36509.13 stddev:85618.52 (234.5%) stddev-sans-first:85787.54 19:55:40 INFO - PROCESS | 13094 | Values: 523.9 541.1 541.9 548.6 559.5 36103.0 37688.0 37793.4 37841.8 41224.6 37945.2 38389.2 38538.6 38539.0 38589.6 7502.8 7700.3 7701.3 9625.0 9959.2 9762.0 9828.9 9831.2 9836.8 9852.0 9814.9 9896.9 9898.2 9898.7 9911.0 9700.9 9863.1 9867.3 9881.2 9909.9 9729.7 9800.3 9812.3 9815.5 9821.0 36109.0 36398.3 36484.6 36533.6 36535.8 2950.8 3074.7 3178.3 3230.0 3328.0 26056.2 27300.6 27402.0 27906.3 28016.2 3257.9 3269.4 3312.9 3335.1 3335.3 255764.0 256988.0 258493.0 258697.7 259126.0 51640.0 52098.5 52259.0 52300.5 52405.7 54887.0 55039.7 55177.4 55210.7 55309.2 13465.5 13556.0 13586.5 13605.1 13622.0 9348.9 9563.5 9575.9 9596.3 9597.0 16966.7 16976.0 16989.3 17042.6 17116.0 6667.4 6714.3 6738.8 6753.0 6794.7 750.3 751.6 831.1 846.5 955.0 25777.0 26065.6 26552.0 26590.2 26651.6 900.7 905.2 909.5 926.4 1058.4 13904.6 13970.7 14123.8 14206.1 14292.8 363439.0 366167.0 367894.6 368529.0 368759.0 47499.0 47619.3 47694.3 47849.3 48112.3 1120.6 1163.3 1175.5 1175.9 1186.4 24911.9 25430.0 25690.7 25893.4 25938.1 39564.2 40195.2 40219.6 40248.0 40322.6 339500.0 339850.0 340337.0 340988.0 345476.0 22634.4 23349.0 23619.3 24266.6 24285.0 38430.0 38947.2 38983.0 39354.0 40679.8 33721.0 33981.5 34468.3 34812.0 34845.0 33541.7 33917.7 33989.8 34196.0 34237.5 33746.3 33817.2 33989.3 34308.5 34614.7 29144.0 31320.0 31342.5 31439.6 31454.2 24092.0 24109.5 24109.9 24565.7 24629.0 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | [#2] jquery.html Cycles:180 Average:24916.41 Median:5025.37 stddev:62355.99 (1240.8%) stddev-sans-first:62503.65 19:55:40 INFO - PROCESS | 13094 | Values: 356.7 361.1 364.5 375.8 380.6 15388.5 16856.9 16876.3 17206.4 17286.6 15848.9 16639.9 16765.8 16900.0 16915.5 4748.8 5022.1 5028.7 5032.8 5045.3 4920.5 6310.7 6726.6 6757.3 6773.2 6390.0 6704.1 6769.7 6831.7 6872.0 6606.8 6808.2 6817.5 6819.2 6820.1 6172.1 6566.1 6569.6 6584.3 6709.5 22847.4 23199.7 23660.8 23699.0 23871.0 1909.7 1941.4 2089.6 2129.2 2632.5 13949.0 14004.3 14043.0 14575.4 14900.2 1786.1 1791.0 1830.2 1835.1 1843.9 73732.0 77577.2 79249.2 79669.0 83008.6 15445.3 15688.5 16265.3 16340.8 16357.7 28255.0 28289.3 28299.7 28355.4 28634.0 7972.6 8146.1 8256.1 8489.2 8535.1 6517.6 6605.0 6675.2 6771.1 6822.9 7931.8 8013.5 8124.9 8280.9 8475.8 1459.8 1501.0 1518.1 1528.1 3194.4 759.0 801.6 835.5 841.3 865.2 15930.0 16237.1 16378.5 16776.6 16904.9 752.5 759.5 798.5 819.3 831.6 7861.8 9328.3 9390.1 9390.8 9547.4 363528.0 365816.0 381178.0 384465.0 386842.0 71948.0 79316.6 80235.0 80852.6 83683.0 866.1 882.3 926.0 929.7 935.7 15464.3 15492.8 15741.3 15964.5 16019.4 23950.8 25493.4 34177.0 34368.8 36254.8 47156.0 49122.8 49215.0 49386.5 49408.0 6953.7 7095.4 7164.9 7251.0 7313.8 6157.0 10144.8 11037.9 11163.9 11936.1 6051.6 9813.5 9860.2 10250.6 10373.7 9695.0 9792.0 10084.1 10086.9 10202.0 9822.0 9845.8 10053.0 10085.2 10373.5 7025.2 7131.7 7190.0 7192.3 7213.9 9066.6 9408.7 9469.7 9526.8 10237.5 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | [#3] mootools.html Cycles:180 Average:4712.27 Median:5020.29 stddev:2521.70 (50.2%) stddev-sans-first:2515.91 19:55:40 INFO - PROCESS | 13094 | Values: 1322.4 1351.0 1399.4 1624.4 1632.5 6055.3 6221.9 6683.3 7073.7 7150.4 6623.3 6799.4 6858.5 7031.1 7039.6 2082.2 2122.1 2124.7 2125.8 2127.4 2080.5 2116.1 2158.2 2163.1 2165.3 2054.2 2059.8 2070.8 2076.8 2077.6 2040.9 2057.8 2068.1 2068.4 2068.8 1992.2 2006.1 2014.6 2031.9 2043.5 7000.7 7160.2 7270.3 7276.6 7286.5 4332.7 4441.2 4445.0 4447.5 4453.0 2621.6 2707.7 2791.5 2839.4 2842.9 822.2 865.0 870.5 907.2 909.8 9272.5 9294.3 9318.3 9337.0 9349.4 3839.0 4057.6 4116.1 4129.1 4145.2 8243.5 8261.4 8265.2 8266.2 8266.9 4504.0 4508.2 4512.2 4515.4 4521.4 3457.1 3567.6 3937.4 4097.7 4104.8 3378.7 3441.6 3515.9 3557.5 3560.2 1163.1 1200.8 1201.8 1202.4 1204.2 848.7 851.1 858.1 868.7 887.2 4978.8 4994.7 5045.9 5062.3 5101.3 409.4 409.7 417.9 421.4 427.5 3396.8 3458.9 3477.0 3552.0 3554.6 8075.8 8415.8 8430.8 8448.2 8504.1 8231.3 8262.3 8308.3 8398.8 8412.7 6532.1 6602.4 6605.2 6618.8 6628.8 4889.3 4939.6 4951.6 4985.4 5131.2 7671.3 7853.2 7935.5 8025.8 8029.6 8139.1 8153.8 8185.3 8206.5 8271.8 5485.0 5639.7 6275.7 6401.2 6404.1 6600.3 6841.2 6850.7 6980.1 6985.2 6060.0 6215.0 6227.2 6288.7 6398.6 6225.5 6228.3 6235.0 6235.4 6256.0 5793.8 5936.8 5936.9 5937.9 5942.8 4392.7 4487.6 4533.7 4539.6 4572.2 4277.6 4380.6 4430.9 4436.9 4440.9 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | [#4] prototype.html Cycles:180 Average:4322.84 Median:4899.11 stddev:1270.72 (25.9%) stddev-sans-first:1237.75 19:55:40 INFO - PROCESS | 13094 | Values: 292.4 296.2 296.6 296.7 303.5 4994.9 5010.4 5016.5 5031.3 5043.2 4921.2 4940.3 4949.8 4954.7 4961.7 3685.9 3764.6 3773.5 3830.0 3831.2 3846.4 3851.1 3852.7 3855.3 3861.3 3848.2 3849.2 3855.4 3859.9 3872.0 3727.0 3861.8 3863.6 3864.9 3871.8 3381.7 3406.9 3407.4 3410.5 3415.6 4817.7 4819.0 4822.2 4838.6 4874.5 4392.6 4402.9 4428.5 4441.0 4442.3 5015.2 5110.4 5121.0 5146.6 5159.4 3674.8 3688.7 3698.1 3735.1 3750.2 5435.9 5441.2 5457.5 5482.4 5503.0 3741.7 3756.5 3810.7 3812.5 3813.2 3835.2 3839.6 3850.7 3878.5 3884.3 4377.5 4444.4 4454.0 4460.4 4463.4 5021.6 5207.3 5269.7 5274.6 5295.9 1295.8 1305.9 1307.6 1307.9 1311.5 872.5 895.4 914.2 914.5 923.3 4434.3 4454.0 4588.2 4609.8 4629.3 5464.8 5481.8 5490.4 5492.2 5500.6 4588.2 4615.7 4618.7 4633.1 4639.0 2684.7 2730.6 2742.8 2748.5 2763.6 4767.3 4769.9 4771.7 4779.8 4878.4 5375.6 5411.2 5427.5 5441.8 5445.2 4819.2 5001.6 5004.7 5006.3 5038.4 5365.4 5402.4 5456.0 5459.1 5544.4 5190.3 5336.7 5344.3 5358.7 5392.3 5025.8 5028.3 5036.0 5042.5 5079.6 3709.2 3732.2 3736.2 3736.6 3756.8 5356.2 5397.6 5503.8 5521.8 5529.4 5225.8 5274.5 5275.1 5278.5 5281.7 5136.3 5179.1 5281.2 5284.5 5290.0 4919.9 5113.8 5114.8 5184.0 5191.5 5083.6 5252.0 5279.7 5290.2 5327.3 5111.0 5150.5 5152.0 5166.6 5180.8 19:55:40 INFO - PROCESS | 13094 | 19:55:40 INFO - PROCESS | 13094 | [#5] yui.html Cycles:180 Average:13469.21 Median:597.58 stddev:16994.09 (2843.8%) stddev-sans-first:17014.47 19:55:40 INFO - PROCESS | 13094 | Values: 643.3 650.6 739.6 742.1 745.4 11469.8 12214.9 12251.8 12286.2 12389.6 11606.4 12057.2 12106.3 12228.4 12243.7 750.6 767.6 770.2 770.9 770.9 745.4 760.8 783.4 784.7 785.7 812.9 813.5 813.5 814.1 815.0 802.0 802.9 803.1 803.6 804.6 595.9 596.0 596.4 596.6 597.6 11776.4 11815.5 11885.5 11896.7 11917.9 12138.7 12180.6 12412.2 12470.6 12579.8 9617.6 9657.7 9875.1 9995.4 10005.9 3214.7 3240.2 3258.5 3271.5 3297.5 46529.3 47481.8 47599.3 48444.5 48873.5 9448.5 9527.4 9624.0 9640.6 9640.7 16747.0 16876.4 16885.3 16905.4 17099.9 6224.1 6395.1 6411.5 6421.0 6671.3 3424.0 3432.6 3468.0 3478.1 3483.3 2693.9 2768.3 2786.4 2789.9 2793.6 468.2 472.6 480.9 487.9 493.8 498.4 552.2 561.7 567.2 633.7 7688.3 7857.8 7887.7 7897.2 8179.3 583.9 597.6 619.1 622.3 634.8 3787.4 3861.6 3960.2 4091.1 4169.5 40189.8 43248.0 69541.0 70433.6 70501.6 36579.6 36811.3 58833.0 59234.7 60232.7 33660.0 45497.0 52297.0 53205.7 54511.5 7621.5 7805.2 7805.3 7806.6 7881.8 27614.2 33585.8 38138.6 38808.6 39961.6 51055.7 52278.5 52352.7 52521.5 53747.5 8815.6 9348.4 9448.0 9470.2 9471.8 9178.3 9563.4 9800.3 10039.4 10198.5 9547.8 9606.7 9768.2 9821.5 9986.9 8767.6 8866.8 8888.3 9137.8 10163.7 9194.6 9197.2 9566.9 9695.7 10840.2 8507.4 8762.5 8945.6 9144.3 9234.2 8892.9 9116.7 9165.9 9338.9 9343.3 19:55:40 INFO - PROCESS | 13094 | -------- Summary: end -------- 19:55:40 INFO - PROCESS | 13094 | 19:55:41 INFO - TEST-INFO | 13094: exit 0 19:55:41 INFO - TEST-OK | dromaeo_css | took 1120773ms 19:55:41 INFO - TEST-START | kraken 19:55:41 INFO - operating with platform_type : linux_ 19:55:41 INFO - Initialising browser for kraken test... 19:55:41 INFO - TEST-INFO | started process 13448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLnifL/profile http://localhost:33247/getInfo.html) 19:55:46 INFO - PROCESS | 13448 | __metrics Screen width/height:1600/1200 19:55:46 INFO - PROCESS | 13448 | colorDepth:24 19:55:46 INFO - PROCESS | 13448 | Browser inner width/height: 1024/697 19:55:46 INFO - PROCESS | 13448 | __metrics 19:55:47 ERROR - PROCESS | 13448 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 19:55:48 INFO - TEST-INFO | 13448: exit 0 19:55:48 INFO - Browser initialized. 19:55:48 INFO - Running cycle 1/1 for kraken test... 19:55:48 INFO - TEST-INFO | started process 13571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLnifL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:00 INFO - PROCESS | 13571 | RSS: Main: 187105280 19:56:00 INFO - PROCESS | 13571 | 19:56:03 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33247/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:04 INFO - PROCESS | 13571 | RSS: Main: 199745536 19:56:04 INFO - PROCESS | 13571 | 19:56:07 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33247/tests/kraken/driver.html?testName=audio-dft) 19:56:07 INFO - PROCESS | 13571 | RSS: Main: 197947392 19:56:07 INFO - PROCESS | 13571 | 19:56:10 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33247/tests/kraken/driver.html?testName=audio-fft) 19:56:11 INFO - PROCESS | 13571 | RSS: Main: 194572288 19:56:11 INFO - PROCESS | 13571 | 19:56:13 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33247/tests/kraken/driver.html?testName=audio-oscillator) 19:56:14 INFO - PROCESS | 13571 | RSS: Main: 194482176 19:56:14 INFO - PROCESS | 13571 | 19:56:16 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:16 INFO - PROCESS | 13571 | RSS: Main: 194740224 19:56:16 INFO - PROCESS | 13571 | 19:56:20 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33247/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:20 INFO - PROCESS | 13571 | RSS: Main: 199970816 19:56:20 INFO - PROCESS | 13571 | 19:56:24 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33247/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:24 INFO - PROCESS | 13571 | RSS: Main: 196194304 19:56:24 INFO - PROCESS | 13571 | 19:56:27 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33247/tests/kraken/driver.html?testName=json-parse-financial) 19:56:28 INFO - PROCESS | 13571 | RSS: Main: 197726208 19:56:28 INFO - PROCESS | 13571 | 19:56:30 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:30 INFO - PROCESS | 13571 | RSS: Main: 197636096 19:56:30 INFO - PROCESS | 13571 | 19:56:32 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:33 INFO - PROCESS | 13571 | RSS: Main: 197779456 19:56:33 INFO - PROCESS | 13571 | 19:56:35 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:36 INFO - PROCESS | 13571 | RSS: Main: 197689344 19:56:36 INFO - PROCESS | 13571 | 19:56:39 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:40 INFO - PROCESS | 13571 | RSS: Main: 197996544 19:56:40 INFO - PROCESS | 13571 | 19:56:43 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:43 INFO - PROCESS | 13571 | RSS: Main: 202342400 19:56:43 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:33247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33247/tests/kraken/driver.html?testName=ai-astar) 19:56:45 INFO - PROCESS | 13571 | RSS: Main: 204394496 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | __start_tp_report 19:56:45 INFO - PROCESS | 13571 | _x_x_mozilla_page_load 19:56:45 INFO - PROCESS | 13571 | _x_x_mozilla_page_load_details 19:56:45 INFO - PROCESS | 13571 | |i|pagename|runs| 19:56:45 INFO - PROCESS | 13571 | |0;ai-astar;109;119;118;117;119;119;119;121;120;119 19:56:45 INFO - PROCESS | 13571 | |1;audio-beat-detection;153;133;132;168;138;130;132;136;164;133 19:56:45 INFO - PROCESS | 13571 | |2;audio-dft;166;175;164;163;164;165;166;166;164;164 19:56:45 INFO - PROCESS | 13571 | |3;audio-fft;77;81;76;101;77;78;77;78;97;78 19:56:45 INFO - PROCESS | 13571 | |4;audio-oscillator;87;86;111;84;84;83;96;84;84;112 19:56:45 INFO - PROCESS | 13571 | |5;imaging-gaussian-blur;123;117;118;123;119;119;118;117;118;118 19:56:45 INFO - PROCESS | 13571 | |6;imaging-darkroom;147;149;149;148;148;150;149;149;148;151 19:56:45 INFO - PROCESS | 13571 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;97 19:56:45 INFO - PROCESS | 13571 | |8;json-parse-financial;65;65;67;67;74;65;66;66;65;66 19:56:45 INFO - PROCESS | 13571 | |9;json-stringify-tinderbox;65;66;65;66;66;66;67;66;66;67 19:56:45 INFO - PROCESS | 13571 | |10;stanford-crypto-aes;85;85;85;89;85;87;87;86;90;86 19:56:45 INFO - PROCESS | 13571 | |11;stanford-crypto-ccm;158;152;151;142;167;146;148;168;195;153 19:56:45 INFO - PROCESS | 13571 | |12;stanford-crypto-pbkdf2;185;181;188;184;183;186;181;196;181;185 19:56:45 INFO - PROCESS | 13571 | |13;stanford-crypto-sha256-iterative;72;70;70;70;74;73;71;73;74;73 19:56:45 INFO - PROCESS | 13571 | __end_tp_report 19:56:45 INFO - PROCESS | 13571 | __start_cc_report 19:56:45 INFO - PROCESS | 13571 | _x_x_mozilla_cycle_collect,874 19:56:45 INFO - PROCESS | 13571 | __end_cc_report 19:56:45 INFO - PROCESS | 13571 | __startTimestamp1480305405762__endTimestamp 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | ------- Summary: start ------- 19:56:45 INFO - PROCESS | 13571 | Number of tests: 14 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#0] ai-astar Cycles:10 Average:118.00 Median:119.00 stddev:3.33 (2.8%) stddev-sans-first:1.12 19:56:45 INFO - PROCESS | 13571 | Values: 109.0 119.0 118.0 117.0 119.0 119.0 119.0 121.0 120.0 119.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:137.00 stddev:14.29 (10.4%) stddev-sans-first:14.59 19:56:45 INFO - PROCESS | 13571 | Values: 153.0 133.0 132.0 168.0 138.0 130.0 132.0 136.0 164.0 133.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.50 stddev:3.43 (2.1%) stddev-sans-first:3.64 19:56:45 INFO - PROCESS | 13571 | Values: 166.0 175.0 164.0 163.0 164.0 165.0 166.0 166.0 164.0 164.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#3] audio-fft Cycles:10 Average:82.00 Median:78.00 stddev:9.10 (11.7%) stddev-sans-first:9.48 19:56:45 INFO - PROCESS | 13571 | Values: 77.0 81.0 76.0 101.0 77.0 78.0 77.0 78.0 97.0 78.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:84.00 stddev:11.39 (13.6%) stddev-sans-first:11.98 19:56:45 INFO - PROCESS | 13571 | Values: 87.0 86.0 111.0 84.0 84.0 83.0 96.0 84.0 84.0 112.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:118.50 stddev:2.21 (1.9%) stddev-sans-first:1.81 19:56:45 INFO - PROCESS | 13571 | Values: 123.0 117.0 118.0 123.0 119.0 119.0 118.0 117.0 118.0 118.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.14 (0.8%) stddev-sans-first:1.00 19:56:45 INFO - PROCESS | 13571 | Values: 147.0 149.0 149.0 148.0 148.0 150.0 149.0 149.0 148.0 151.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 19:56:45 INFO - PROCESS | 13571 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:2.72 (4.1%) stddev-sans-first:2.82 19:56:45 INFO - PROCESS | 13571 | Values: 65.0 65.0 67.0 67.0 74.0 65.0 66.0 66.0 65.0 66.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 19:56:45 INFO - PROCESS | 13571 | Values: 65.0 66.0 65.0 66.0 66.0 66.0 67.0 66.0 66.0 67.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:1.78 (2.1%) stddev-sans-first:1.80 19:56:45 INFO - PROCESS | 13571 | Values: 85.0 85.0 85.0 89.0 85.0 87.0 87.0 86.0 90.0 86.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#11] stanford-crypto-ccm Cycles:10 Average:158.00 Median:155.50 stddev:15.49 (10.0%) stddev-sans-first:16.43 19:56:45 INFO - PROCESS | 13571 | Values: 158.0 152.0 151.0 142.0 167.0 146.0 148.0 168.0 195.0 153.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:185.00 stddev:4.52 (2.4%) stddev-sans-first:4.80 19:56:45 INFO - PROCESS | 13571 | Values: 185.0 181.0 188.0 184.0 183.0 186.0 181.0 196.0 181.0 185.0 19:56:45 INFO - PROCESS | 13571 | 19:56:45 INFO - PROCESS | 13571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:73.00 stddev:1.63 (2.2%) stddev-sans-first:1.73 19:56:45 INFO - PROCESS | 13571 | Values: 72.0 70.0 70.0 70.0 74.0 73.0 71.0 73.0 74.0 73.0 19:56:45 INFO - PROCESS | 13571 | -------- Summary: end -------- 19:56:45 INFO - PROCESS | 13571 | 19:56:47 INFO - TEST-INFO | 13571: exit 0 19:56:47 INFO - TEST-OK | kraken | took 65531ms 19:56:47 INFO - SUITE-END | took 1186s 19:56:47 INFO - Completed test suite (00:19:46) 19:56:47 INFO - javascript benchmark 19:56:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6290.769561796511, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2624.160268714011, 2657.641218435511, 2658.787297016239, 2669.0, 2672.8529930853806, 4635.374224479702, 4762.1428142934255, 4792.808287668489, 4795.0649623323425, 4822.807087716487, 4660.836870709526, 4743.0, 4766.690165139264, 4785.497522760113, 4848.466668666444, 4334.176506463769, 4387.100644367897, 4395.692301538894, 4468.664850136237, 4507.6619253555955, 4056.290149223889, 4487.46150461945, 4492.989077457562, 4516.774161291939, 4519.548045195487, 4271.188474189894, 4451.577100175478, 4455.0, 4480.52954439784, 4545.909081818361, 4286.03564198056, 4346.282863327548, 4346.369776382438, 4351.151525452538, 4358.5205627380965, 4319.654427645813, 4329.19909816685, 4341.7394956302405, 4367.606915377632, 4432.22436073689, 4729.59798417135, 4743.620510359163, 4784.354112194844, 4789.353437285957, 4808.158572249878, 4885.071836351118, 5132.0, 5132.0, 5136.43499215086, 5167.121589329823, 4961.156603377399, 5021.447640759514, 5037.319961805183, 5039.218921067204, 5048.873778155539, 4706.670533062687, 4752.263399173134, 4764.904701905943, 4801.039792041605, 4808.110499557593, 5183.766730497136, 5184.274201611777, 5184.844454666366, 5185.533302002762, 5233.528982391603, 4800.0, 4894.1679914414635, 5006.899862002812, 5008.574271186917, 5019.347484826949, 4881.194602890483, 5048.520390562964, 5053.090443720165, 5092.10888094582, 5157.4584668610005, 4865.221564549655, 4992.026554821848, 5046.772895219724, 5048.848534543969, 5132.794688212504, 4982.7259500727805, 5012.624053196025, 5013.724245166551, 5024.070546948826, 5077.26379674945, 4233.576642335742, 4315.913681726411, 4350.825966961349, 4354.4992325882295, 4370.672199585044, 3734.8692795752017, 3756.1736417988, 3784.148566572499, 3802.296575133609, 3840.6543411093135, 4383.7808109595035, 4385.495667998157, 4407.184670835905, 4418.0, 4422.579854913778, 4942.752862356868, 5113.1563292057135, 5116.616253780981, 5117.130087885069, 5121.257417674491, 4280.464941882265, 4359.673024523174, 4375.146846364928, 4389.40742999691, 4429.822807087745, 4529.411176547093, 4567.314902764612, 4572.428446444194, 4573.56551127649, 4628.213203755369, 4764.571188593043, 4770.833020844254, 4773.832915847928, 4781.139394908881, 4793.520647935178, 4909.803607855789, 4938.30863679078, 4940.0, 4988.226824842155, 5005.649604527648, 4619.93070103942, 4662.603678687214, 4665.393498845128, 4673.0, 4684.6486513510945, 4997.250412438163, 5011.423686275979, 5030.044291584587, 5050.444451110448, 5113.284140220447, 5126.154184559506, 5128.615353848401, 5133.948660513347, 5148.971946808917, 5180.378354597472, 4805.231163013901, 4990.276409920469, 4992.350994370854, 4995.2507123930245, 4998.4251811042195, 4878.878028049327, 4923.040007198562, 4965.925511117264, 4973.229149481692, 4980.402351717817, 4840.709557426425, 4892.461829198856, 4910.852674419773, 4915.827946021872, 4916.508349165055, 4978.626603004716, 5017.924731128963, 5019.824306149268, 5029.773660185374, 5069.493050694901, 4752.192127338291, 4786.353842231254, 4898.779554919965, 4904.803807847788, 4947.060058588857], "value": 4660.971458585174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.9318888544489, 541.1044720986766, 541.9078756611376, 548.626933685094, 559.4657102467145, 36103.0, 37688.0, 37793.433098503476, 37841.81079094604, 41224.58775412245, 37945.24109517808, 38389.232215355674, 38538.61461385385, 38539.0, 38589.614103858956, 7502.8124296892465, 7700.345470635003, 7701.306882380584, 9625.0, 9959.203263738884, 9761.951190244039, 9828.901710982871, 9831.164351030171, 9836.803263934717, 9852.0, 9814.901850981505, 9896.90103098967, 9898.15865651417, 9898.653547125852, 9910.9504452478, 9700.854487182698, 9863.063009014133, 9867.309288349818, 9881.209503239723, 9909.900900991042, 9729.659461918798, 9800.264980126447, 9812.313138080337, 9815.509224538815, 9821.0, 36109.0, 36398.27203455916, 36484.63515364839, 36533.63466365329, 36535.81732091349, 2950.7639388849057, 3074.6925307469296, 3178.300773829777, 3229.9677003229904, 3328.0182346207926, 26056.218313450627, 27300.590491142648, 27402.0, 27906.3023424414, 28016.159515214575, 3257.9348413031844, 3269.3788180245915, 3312.8509217085048, 3335.149536868083, 3335.332933413327, 255764.0, 256988.0, 258493.0, 258697.70651146813, 259126.0, 51640.0, 52098.47901521012, 52259.0, 52300.476995230325, 52405.7379713099, 54887.0, 55039.724801375734, 55177.448225518034, 55210.723946380014, 55309.170362444595, 13465.528706495226, 13556.0, 13586.456541738418, 13605.115667481581, 13622.0, 9348.859767103499, 9563.521823908777, 9575.904240957501, 9596.328257022082, 9596.952015240018, 16966.660666786844, 16976.0, 16989.281714925553, 17042.573935651708, 17116.0, 6667.43326817226, 6714.328567143344, 6738.797836064926, 6753.0, 6794.675038367471, 750.339701063061, 751.5640928261595, 831.0609011816608, 846.5217152308926, 954.9686338754129, 25777.0, 26065.600774709896, 26552.0, 26590.202293931212, 26651.600225996626, 900.7117722328923, 905.1898550797, 909.4543274035526, 926.4348747264163, 1058.4284486377423, 13904.58286251414, 13970.650733731738, 14123.794252374064, 14206.147631141957, 14292.78412357232, 363439.0, 366167.0, 367894.5684345246, 368529.0, 368759.0, 47499.0, 47619.285710714365, 47694.28458573124, 47849.282260766115, 48112.27831582529, 1120.5685810962839, 1163.3310846263432, 1175.5356634129641, 1175.905927525796, 1186.442372085136, 24911.87544062268, 25430.0, 25690.743092568835, 25893.352666183495, 25938.092166774073, 39564.2087158261, 40195.19609607733, 40219.597804021585, 40248.0, 40322.59677403306, 339500.0, 339850.0, 340337.0, 340988.0, 345476.0, 22634.434139145993, 23349.0, 23619.27614477146, 24266.63600046036, 24285.0, 38430.0, 38947.2210555793, 38983.0, 39354.0, 40679.7966010168, 33721.0, 33981.49027764635, 34468.31063378769, 34812.0, 34845.0, 33541.66458335386, 33917.66082339145, 33989.83005084959, 34196.0, 34237.48643770296, 33746.32507349888, 33817.15457113592, 33989.32021359509, 34308.48537271893, 34614.65385346215, 29144.0, 31320.0, 31342.529862052543, 31439.585218664757, 31454.21364465815, 24092.0, 24109.51780964336, 24109.879450602635, 24565.701002324164, 24629.0], "value": 17352.813101183052, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7128461588422, 361.14769144818234, 364.51883513761834, 375.7895578476052, 380.56425392925104, 15388.538343849688, 16856.915715421404, 16876.324947002122, 17206.397776077854, 17286.56783580411, 15848.920755396235, 16639.91680041598, 16765.832341676578, 16900.0, 16915.492535223933, 4748.786304616283, 5022.0709168803705, 5028.673136246132, 5032.773525191357, 5045.293658887758, 4920.483349248331, 6310.716017779211, 6726.562773419712, 6757.256701762803, 6773.187217533903, 6389.968050159743, 6704.061431399584, 6769.69536370862, 6831.692573834164, 6872.0, 6606.8017959461295, 6808.2170550386845, 6817.454603631747, 6819.181698196224, 6820.079289295931, 6172.105044768528, 6566.080748695186, 6569.605823650596, 6584.30864759203, 6709.463242940553, 22847.42881427961, 23199.652005219934, 23660.7633923662, 23699.0, 23871.0, 1909.6658084835237, 1941.4369832748487, 2089.613421517009, 2129.1909074551727, 2632.4866651003063, 13949.0, 14004.326426927119, 14043.0, 14575.416983320654, 14900.180490073042, 1786.1337251433044, 1790.9552261193444, 1830.2130084063847, 1835.1008006077059, 1843.8709290349682, 73732.0, 77577.22422775757, 79249.20750792476, 79668.99999999942, 83008.58495707483, 15445.30496127677, 15688.529344119695, 16265.268062937197, 16340.75488867668, 16357.672846543002, 28255.0110746127, 28289.292767680974, 28299.71700283012, 28355.432891342058, 28634.0, 7972.6412311444965, 8146.14465481116, 8256.1331060239, 8489.151084891462, 8535.061143274235, 6517.576357536745, 6605.042268870987, 6675.232348279913, 6771.052052712625, 6822.863542729117, 7931.801704957422, 8013.4791238569305, 8124.918750812534, 8280.91877197805, 8475.830483390298, 1459.8175228096488, 1500.9624759380883, 1518.111904535859, 1528.083150109925, 3194.3611277744544, 759.0322339017686, 801.6072124658991, 835.5362773660555, 841.3059226138461, 865.2213008292587, 15930.0, 16237.077326081419, 16378.508644740677, 16776.580585485215, 16904.915475422546, 752.4883079505879, 759.4683721394936, 798.5448294472095, 819.2585709932521, 831.6216121664748, 7861.842763144705, 9328.300377471716, 9390.10793974585, 9390.812183756287, 9547.379420337656, 363528.0, 365816.0, 381178.0, 384465.0, 386842.0, 71948.0, 79316.6034169837, 80235.0, 80852.59573702094, 83683.0, 866.1122349591593, 882.2500874256958, 925.9583318750672, 929.7396728915915, 935.6584846530967, 15464.304106315018, 15492.845071549591, 15741.291641876373, 15964.521064367624, 16019.439319623758, 23950.8345858714, 25493.3626659335, 34177.0, 34368.82815585906, 36254.8187259062, 47156.0, 49122.75438622784, 49215.0, 49386.506134938194, 49408.0, 6953.687084081127, 7095.396891264094, 7164.928350716635, 7251.021112149792, 7313.780586582411, 6156.969215154075, 10144.797104058025, 11037.889621103686, 11163.944180279046, 11936.104792140797, 6051.606645568024, 9813.460259685786, 9860.16188623975, 10250.641227557298, 10373.740656483647, 9695.0, 9791.951040245038, 10084.092431681183, 10086.89913100889, 10201.97980201974, 9822.0, 9845.803083938425, 10053.0, 10085.243606729378, 10373.533191006574, 7025.227225005143, 7131.679074441558, 7190.0, 7192.280771922975, 7213.927860721536, 9066.637334506546, 9408.670696525589, 9469.66856160031, 9526.809463810547, 10237.488125593542], "value": 8812.659192753154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.3916998180832, 1351.0, 1399.3982587487376, 1624.3583784405153, 1632.542887991363, 6055.273367195942, 6221.875562488747, 6683.331666833315, 7073.681684324211, 7150.427965762739, 6623.304553021935, 6799.42204912583, 6858.451323894089, 7031.085958825358, 7039.648017599113, 2082.156726525756, 2122.066290832037, 2124.681297805334, 2125.798049185325, 2127.361791462555, 2080.4902798814237, 2116.0795054151417, 2158.190678495564, 2163.0590693048493, 2165.317924853674, 2054.209129485144, 2059.804318589739, 2070.7722150563427, 2076.771555128935, 2077.6156411063926, 2040.8673436226672, 2057.814796668307, 2068.069368784038, 2068.4415207893935, 2068.813806757384, 1992.1533348326902, 2006.0571531380228, 2014.63736527425, 2031.89840507974, 2043.4993426610426, 7000.719971201197, 7160.2481739417135, 7270.345668889772, 7276.599787011713, 7286.453515986323, 4332.67504937131, 4441.178381999341, 4445.044315472189, 4447.533009034038, 4452.977735111336, 2621.5936529837904, 2707.7292270772964, 2791.4556661451024, 2839.375337425763, 2842.9004984825433, 822.2312138150849, 865.0484467086218, 870.4646642314995, 907.1880666803174, 909.8453262945249, 9272.490013049279, 9294.302927280482, 9318.25453963688, 9336.953315233448, 9349.39228950116, 3838.980805095957, 4057.6145266199665, 4116.0533077392365, 4129.112240868228, 4145.2124096421585, 8243.546604936666, 8261.421700480909, 8265.173482651808, 8266.214709602578, 8266.875996860052, 4503.954960450419, 4508.233600287959, 4512.2329204035395, 4515.390422292949, 4521.367008618796, 3457.0665920201404, 3567.6075631680496, 3937.409388591734, 4097.672186225095, 4104.794760262034, 3378.6790254926236, 3441.5525981622227, 3515.9296814064087, 3557.5019497270405, 3560.1989552350515, 1163.1044096045998, 1200.771853347861, 1201.8077107662732, 1202.3988005997, 1204.1931905623078, 848.7326492154951, 851.1190917400461, 858.1418581418457, 868.7437206024238, 887.2059506741431, 4978.800847966113, 4994.700317980933, 5045.8738531537, 5062.265971434122, 5101.336826212569, 409.4206697523031, 409.7009183296151, 417.93522004089414, 421.4289637541149, 427.4934202969491, 3396.847141878621, 3458.9135271617906, 3477.0438129514587, 3552.0409489437707, 3554.5556805399324, 8075.798105047421, 8415.831683366298, 8430.789230269293, 8448.197421244971, 8504.064552899175, 8231.259186673109, 8262.339012878956, 8308.335333173332, 8398.832023359499, 8412.663493460193, 6532.08550802888, 6602.372774586406, 6605.207375114921, 6618.768343107968, 6628.767993120314, 4889.291052797395, 4939.60483161339, 4951.628627852853, 4985.4266759323145, 5131.204663277198, 7671.347935425551, 7853.175416581176, 7935.523868567673, 8025.839483210187, 8029.598520073856, 8139.104698483044, 8153.79615509617, 8185.30424913889, 8206.548639824867, 8271.751847444586, 5484.970560892495, 5639.746211420578, 6275.748970041147, 6401.199850018747, 6404.071409645669, 6600.339966003553, 6841.17905851301, 6850.657467126524, 6980.127484064492, 6985.1967023790885, 6059.969700151471, 6214.9689251553455, 6227.221597300338, 6288.65412402304, 6398.616083035033, 6225.533085018732, 6228.252609686867, 6234.9688251558455, 6235.376462353728, 6255.96872015637, 5793.826185214451, 5936.762529498945, 5936.8812623748145, 5937.881242375215, 5942.762289508371, 4392.714473559208, 4487.551244875486, 4533.682642215013, 4539.591436770706, 4572.199865023674, 4277.572242775697, 4380.62764665007, 4430.867073987785, 4436.866893993185, 4440.888977775452], "value": 3807.2039463607543, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.38598942221336, 296.1574321056593, 296.56553149635783, 296.7077428732699, 303.45378319025747, 4994.901121753213, 5010.398752149743, 5016.523430274127, 5031.34592502975, 5043.218301163321, 4921.16149403465, 4940.283658869462, 4949.8020079196785, 4954.736542181748, 4961.702297862131, 3685.870994515186, 3764.6047165047685, 3773.5471743390694, 3829.9617003829885, 3831.2337532493475, 3846.442265871461, 3851.133494963625, 3852.749571277858, 3855.306044911915, 3861.3435715928217, 3848.2495913296916, 3849.2109117630957, 3855.363864962278, 3859.864904728335, 3871.9806400968096, 3727.0226521147556, 3861.826217820191, 3863.613638636142, 3864.8840534784003, 3871.7676939383728, 3381.661833816623, 3406.914827129317, 3407.386670399327, 3410.539577157077, 3415.6072051714123, 4817.735024573647, 4819.0, 4822.204336284509, 4838.6371022173125, 4874.488178741217, 4392.648588112943, 4402.92128428537, 4428.535003824616, 4440.955590444119, 4442.267025940716, 5015.197568389077, 5110.386753589556, 5121.00140472608, 5146.639735218536, 5159.432462429129, 3674.7978861162624, 3688.704903607705, 3698.130939229279, 3735.0662334416397, 3750.2312026034597, 5435.918461223085, 5441.238226648233, 5457.481539253765, 5482.369527504348, 5503.0, 3741.7006639469323, 3756.4643865390753, 3810.6951443884423, 3812.5234345706785, 3813.1696785543095, 3835.232953409329, 3839.6352346527037, 3850.6919446444217, 3878.4764056852528, 3884.320243957353, 4377.474703035592, 4444.40001599424, 4454.0, 4460.375547423363, 4463.375127482155, 5021.648484606116, 5207.29701490294, 5269.657472264291, 5274.630775845731, 5295.947040529622, 1295.799151131576, 1305.8704220848897, 1307.6338625184962, 1307.8822905938512, 1311.475409836054, 872.5244741615835, 895.3687650206589, 914.1863741270275, 914.492456686532, 923.3121324613206, 4434.312681534303, 4453.977730111329, 4588.197065513522, 4609.838655647036, 4629.282461218517, 5464.754086066137, 5481.7657582026795, 5490.396056433789, 5492.176173573996, 5500.6424582402815, 4588.174128656807, 4615.730674064659, 4618.745968971672, 4633.073385322881, 4639.0, 2684.6644169478814, 2730.617713520069, 2742.75315221631, 2748.4503099380204, 2763.6130941668184, 4767.332573439721, 4769.904601907942, 4771.71369717818, 4779.832705855279, 4878.365747474636, 5375.569954403638, 5411.188321751769, 5427.507435455282, 5441.80280338325, 5445.237666726662, 4819.180739274332, 5001.599872010231, 5004.749762511859, 5006.299118123538, 5038.370203724535, 5365.356157261153, 5402.432744561765, 5456.0, 5459.099248623933, 5544.362398324083, 5190.325257716473, 5336.744585802735, 5344.305240318734, 5358.74069593653, 5392.272043274108, 5025.84922452327, 5028.296038554532, 5035.974820125876, 5042.546170844495, 5079.619028572945, 3709.2025214577916, 3732.197577520846, 3736.2153947671295, 3736.5614238517824, 3756.830942607644, 5356.196570514454, 5397.649152805055, 5503.752331145028, 5521.775841481351, 5529.364123125892, 5225.817096401608, 5274.547335489016, 5275.0745977718625, 5278.498542638443, 5281.705982034427, 5136.30659860914, 5179.1454410021925, 5281.181416880389, 5284.471552844685, 5289.973550132225, 4919.852404427873, 5113.846584602468, 5114.795408183631, 5183.98912212115, 5191.480851914778, 5083.5678967288195, 5251.973740131275, 5279.656822306538, 5290.153575427913, 5327.254184414108, 5110.97444512775, 5150.510701483353, 5152.0, 5166.586673066221, 5180.766865490987], "value": 3916.6506339150556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.3245092652714, 650.5511197273884, 739.6190961654748, 742.1354122447349, 745.4036770583532, 11469.827952580717, 12214.877851221507, 12251.754964900707, 12286.201396909217, 12389.62831115067, 11606.36165010924, 12057.216280941733, 12106.334151621679, 12228.44971976261, 12243.693907652314, 750.6284389227327, 767.5663250263611, 770.2490072179636, 770.8650986077442, 770.8766597344426, 745.4036770583539, 760.7983884270645, 783.3772151139857, 784.7331907151568, 785.7132146766446, 812.9065157506903, 813.4590497319275, 813.4875028731891, 814.0597609760706, 814.975550733476, 801.9518828870257, 802.8875957365973, 803.1286054630733, 803.6222975201675, 804.5615139748821, 595.9165716799652, 596.0373995996478, 596.4155127974609, 596.582392325374, 597.5697497801576, 11776.411179440993, 11815.468303926344, 11885.524579016828, 11896.702582435422, 11917.940410297893, 12138.696532586757, 12180.634580962585, 12412.193207441487, 12470.625881223577, 12579.811302830465, 9617.56720947559, 9657.661981830603, 9875.111239988364, 9995.400275983464, 10005.899941000642, 3214.694604012615, 3240.173755692307, 3258.462353711635, 3271.460209065501, 3297.472404415306, 46529.28470590572, 47481.76259118682, 47599.28601070987, 48444.51555484435, 48873.51126488725, 9448.480333581581, 9527.38072025316, 9623.951880240555, 9640.566174522164, 9640.662576809778, 16747.0, 16876.409325673543, 16885.32458701638, 16905.408310709066, 17099.914500427418, 6224.134419046018, 6395.104685344056, 6411.455026322721, 6420.967895160495, 6671.266160722414, 3424.0412684448393, 3432.5709286339206, 3467.9769468007, 3478.147853775841, 3483.303339332144, 2693.8922443102447, 2768.29408500831, 2786.4009238013923, 2789.902353417621, 2793.5669971154502, 468.2110643565603, 472.5817651378486, 480.9014152098811, 487.8560824556764, 493.8123513065012, 498.37453995235745, 552.215853488048, 561.719140429785, 567.2059117235821, 633.7179954920108, 7688.346490548254, 7857.803554911173, 7887.684492620346, 7897.17079706634, 8179.345652347798, 583.9474447299764, 597.5966222799593, 619.0775744141287, 622.2905887288495, 634.8222497700651, 3787.3561494545993, 3861.575226725058, 3960.20795840833, 4091.0999580092334, 4169.499660040815, 40189.799051005146, 43248.0, 69541.0, 70433.6478317605, 70501.64749176221, 36579.634203658155, 36811.26377472489, 58833.0, 59234.703826481455, 60232.69883650554, 33660.0, 45497.0, 52297.0, 53205.73397132989, 54511.454885450636, 7621.542707437571, 7805.2194780521495, 7805.258500442449, 7806.57063861493, 7881.802954926173, 27614.171574852786, 33585.83207083949, 38138.618613814615, 38808.6119138805, 39961.60038399695, 51055.744721276154, 52278.47721522736, 52352.73823630858, 52521.47478525166, 53747.46252537581, 8815.603297851483, 9348.392354496937, 9447.952760236154, 9470.19503342196, 9471.810563788547, 9178.311626627896, 9563.378380405251, 9800.313978021755, 10039.397636141855, 10198.490075496047, 9547.761305967406, 9606.711798646053, 9768.169705575106, 9821.459819709984, 9986.900130998887, 8767.56162191875, 8866.822663546563, 8888.288936884905, 9137.77155571116, 10163.7459063524, 9194.632214711337, 9197.172254497127, 9566.9043309566, 9695.70912872615, 10840.186985975926, 8507.447015943944, 8762.518061506424, 8945.59744811498, 9144.314176436661, 9234.215091717278, 8892.911070889208, 9116.726498205064, 9165.862512062458, 9338.906610934075, 9343.29925255595], "value": 5830.364197859298, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 119.0, 118.0, 117.0, 119.0, 119.0, 119.0, 121.0, 120.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 133.0, 132.0, 168.0, 138.0, 130.0, 132.0, 136.0, 164.0, 133.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 175.0, 164.0, 163.0, 164.0, 165.0, 166.0, 166.0, 164.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 101.0, 77.0, 78.0, 77.0, 78.0, 97.0, 78.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 111.0, 84.0, 84.0, 83.0, 96.0, 84.0, 84.0, 112.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 117.0, 118.0, 123.0, 119.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 149.0, 148.0, 148.0, 150.0, 149.0, 149.0, 148.0, 151.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 67.0, 74.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 89.0, 85.0, 87.0, 87.0, 86.0, 90.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 152.0, 151.0, 142.0, 167.0, 146.0, 148.0, 168.0, 195.0, 153.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 188.0, 184.0, 183.0, 186.0, 181.0, 196.0, 181.0, 185.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 70.0, 74.0, 73.0, 71.0, 73.0, 74.0, 73.0], "value": 72.0, "unit": "score"}]}]} 19:56:47 INFO - Return code: 0 19:56:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:56:47 ERROR - # TBPL SUCCESS # 19:56:47 INFO - Running post-action listener: _resource_record_post_action 19:56:47 INFO - [mozharness: 2016-11-28 03:56:47.572586Z] Finished run-tests step (success) 19:56:47 INFO - Running post-run listener: _resource_record_post_run 19:56:47 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402087936; Read time: 8; Write time: 267012 19:56:47 INFO - TinderboxPrint: CPU usage
13.4% 19:56:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:56:47 INFO - TinderboxPrint: I/O write bytes / time
402,087,936 / 267,012 19:56:47 INFO - TinderboxPrint: CPU idle
8,304.9 (86.6%) 19:56:47 INFO - TinderboxPrint: CPU user
1,225.7 (12.8%) 19:56:47 INFO - TinderboxPrint: Swap in / out
0 / 0 19:56:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110276608; Read time: 0; Write time: 62952 19:56:47 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291811328; Read time: 0; Write time: 204060 19:56:48 INFO - Running post-run listener: _upload_blobber_files 19:56:48 INFO - Blob upload gear active. 19:56:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:56:48 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:48 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:56:48 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:56:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:56:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:56:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:56:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:49 INFO - (blobuploader) - INFO - Done attempting. 19:56:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:56:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:50 INFO - (blobuploader) - INFO - Done attempting. 19:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:56:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:53 INFO - (blobuploader) - INFO - Done attempting. 19:56:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:53 INFO - Return code: 0 19:56:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:56:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/461301ac7880ba00ded0caeb51d167169b153badbc06954e042ff6e4395d8fea4eaaf1a5c442839690e8945bbcd339902a68c16ce0cdf53ea6aeae313af937fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1e26fd5efb45becb804ddfe443eae3aefce64ed759bbc58f9766910a8782742fcec9db29fef03626f9076a61e0d0be285b1883154ba1283df44366de33e9fee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cc7ae07a5c4a586175dccbf5141225b425ba3e4f99c8240ad2b0fd324df8518ca0dae6389e040a17ec92522c9cd7562f608dc926fc12583c1eaabf07b6b6ed2"} 19:56:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:56:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:56:53 INFO - Contents: 19:56:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/461301ac7880ba00ded0caeb51d167169b153badbc06954e042ff6e4395d8fea4eaaf1a5c442839690e8945bbcd339902a68c16ce0cdf53ea6aeae313af937fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1e26fd5efb45becb804ddfe443eae3aefce64ed759bbc58f9766910a8782742fcec9db29fef03626f9076a61e0d0be285b1883154ba1283df44366de33e9fee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cc7ae07a5c4a586175dccbf5141225b425ba3e4f99c8240ad2b0fd324df8518ca0dae6389e040a17ec92522c9cd7562f608dc926fc12583c1eaabf07b6b6ed2"} 19:56:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:53 INFO - Copying logs to upload dir... 19:56:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:56:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.056165 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-27 19:56:51.642907) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 19:56:51.646069) ========= 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=db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/461301ac7880ba00ded0caeb51d167169b153badbc06954e042ff6e4395d8fea4eaaf1a5c442839690e8945bbcd339902a68c16ce0cdf53ea6aeae313af937fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1e26fd5efb45becb804ddfe443eae3aefce64ed759bbc58f9766910a8782742fcec9db29fef03626f9076a61e0d0be285b1883154ba1283df44366de33e9fee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cc7ae07a5c4a586175dccbf5141225b425ba3e4f99c8240ad2b0fd324df8518ca0dae6389e040a17ec92522c9cd7562f608dc926fc12583c1eaabf07b6b6ed2"} build_url:https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011705 build_url: 'https://queue.taskcluster.net/v1/task/Jj8kixPHSAKYlKFErR9N0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/461301ac7880ba00ded0caeb51d167169b153badbc06954e042ff6e4395d8fea4eaaf1a5c442839690e8945bbcd339902a68c16ce0cdf53ea6aeae313af937fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1e26fd5efb45becb804ddfe443eae3aefce64ed759bbc58f9766910a8782742fcec9db29fef03626f9076a61e0d0be285b1883154ba1283df44366de33e9fee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cc7ae07a5c4a586175dccbf5141225b425ba3e4f99c8240ad2b0fd324df8518ca0dae6389e040a17ec92522c9cd7562f608dc926fc12583c1eaabf07b6b6ed2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 19:56:51.671586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:56:51.671909) ========= 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=db7e7c15f3ca076d53731445000001ba-1480301970.429441-1366150391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 19:56:51.757652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 19:56:51.758010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 19:56:51.758341) ========= ========= Total master_lag: 0.16 =========