builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1476136840.64 results: success (0) buildid: 20161010125223 builduid: 4175ba499ac0455fb788be1a67480bb9 revision: 03fde9f8b44a7ed51f3a2aaf388ae8e2c2222f1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.644935) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.645374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.645662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.659925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.660234) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 15:00:41-- 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% 46.5M=0s 2016-10-10 15:00:41 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128722 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.803126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.803429) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014244 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:40.852796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 15:00:40.853155) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03fde9f8b44a7ed51f3a2aaf388ae8e2c2222f1f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 03fde9f8b44a7ed51f3a2aaf388ae8e2c2222f1f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 15:00:41,993 truncating revision to first 12 chars 2016-10-10 15:00:41,993 Setting DEBUG logging. 2016-10-10 15:00:41,993 attempt 1/10 2016-10-10 15:00:41,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03fde9f8b44a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 15:00:43,387 unpacking tar archive at: fx-team-03fde9f8b44a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.716857 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 15:00:42.583508) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:42.583839) ========= script_repo_revision: 03fde9f8b44a7ed51f3a2aaf388ae8e2c2222f1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:42.584238) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:42.584504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 15:00:42.593532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-10 15:00:42.593857) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:00:43 INFO - MultiFileLogger online at 20161010 15:00:43 in /builds/slave/test 15:00:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:00:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:43 INFO - {'append_to_log': False, 15:00:43 INFO - 'base_work_dir': '/builds/slave/test', 15:00:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:00:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:43 INFO - 'branch': 'Fx-Team-Non-PGO', 15:00:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:43 INFO - 'config_files': ('talos/linux_config.py',), 15:00:43 INFO - 'default_actions': ('clobber', 15:00:43 INFO - 'read-buildbot-config', 15:00:43 INFO - 'download-and-extract', 15:00:43 INFO - 'populate-webroot', 15:00:43 INFO - 'create-virtualenv', 15:00:43 INFO - 'install', 15:00:43 INFO - 'run-tests'), 15:00:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:43 INFO - 'download_minidump_stackwalk': True, 15:00:43 INFO - 'download_symbols': 'ondemand', 15:00:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:43 INFO - 'installer_path': 'installer.exe', 15:00:43 INFO - 'log_level': 'info', 15:00:43 INFO - 'log_name': 'talos', 15:00:43 INFO - 'log_to_console': True, 15:00:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:00:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:00:43 INFO - 'opt_config_files': (), 15:00:43 INFO - 'pip_index': False, 15:00:43 INFO - 'sps_profile': False, 15:00:43 INFO - 'sps_profile_interval': 0, 15:00:43 INFO - 'suite': 'dromaeojs', 15:00:43 INFO - 'system_bits': '32', 15:00:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:43 INFO - 'title': 'talos-linux64-ix-022', 15:00:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:43 INFO - 'use_talos_json': True, 15:00:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:43 INFO - 'work_dir': 'build'} 15:00:43 INFO - [mozharness: 2016-10-10 22:00:43.828434Z] Running clobber step. 15:00:43 INFO - Running pre-action listener: _resource_record_pre_action 15:00:43 INFO - Running main action method: clobber 15:00:43 INFO - rmtree: /builds/slave/test/build 15:00:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:44 INFO - Running post-action listener: _resource_record_post_action 15:00:44 INFO - [mozharness: 2016-10-10 22:00:44.277371Z] Finished clobber step (success) 15:00:44 INFO - [mozharness: 2016-10-10 22:00:44.277472Z] Running read-buildbot-config step. 15:00:44 INFO - Running pre-action listener: _resource_record_pre_action 15:00:44 INFO - Running main action method: read_buildbot_config 15:00:44 INFO - Using buildbot properties: 15:00:44 INFO - { 15:00:44 INFO - "project": "", 15:00:44 INFO - "product": "firefox", 15:00:44 INFO - "script_repo_revision": "production", 15:00:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:00:44 INFO - "repository": "", 15:00:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:00:44 INFO - "buildid": "20161010125223", 15:00:44 INFO - "pgo_build": "False", 15:00:44 INFO - "basedir": "/builds/slave/test", 15:00:44 INFO - "buildnumber": 1973, 15:00:44 INFO - "slavename": "talos-linux64-ix-022", 15:00:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:00:44 INFO - "platform": "ubuntu64_hw", 15:00:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:00:44 INFO - "branch": "fx-team", 15:00:44 INFO - "repo_path": "integration/fx-team", 15:00:44 INFO - "revision": "03fde9f8b44a7ed51f3a2aaf388ae8e2c2222f1f", 15:00:44 INFO - "stage_platform": "linux64", 15:00:44 INFO - "builduid": "4175ba499ac0455fb788be1a67480bb9", 15:00:44 INFO - "slavebuilddir": "test" 15:00:44 INFO - } 15:00:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:00:44 INFO - Running post-action listener: _resource_record_post_action 15:00:44 INFO - [mozharness: 2016-10-10 22:00:44.279875Z] Finished read-buildbot-config step (success) 15:00:44 INFO - [mozharness: 2016-10-10 22:00:44.279963Z] Running download-and-extract step. 15:00:44 INFO - Running pre-action listener: _resource_record_pre_action 15:00:44 INFO - Running main action method: download_and_extract 15:00:44 INFO - mkdir: /builds/slave/test/build/tests 15:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:44 INFO - trying https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:00:44 INFO - Downloading https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:00:44 INFO - Downloaded 1361 bytes. 15:00:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:00:44 INFO - Using the following test package requirements: 15:00:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:00:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:00:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:00:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'jsshell-linux-x86_64.zip'], 15:00:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:00:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:00:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:00:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:00:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:00:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:00:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:00:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:00:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:44 INFO - Fetch https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:00:45 INFO - Http code: 200 15:00:45 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 15:00:45 INFO - x-amz-cf-id: 336n04T24SzEmswSOCcteXH99b6u5E1ezIjV6ldM-PdfWCPymm4r8g== 15:00:45 INFO - x-amz-version-id: kOiTyZidqyp8mCAwa2Uio5zWYCv8kI7q 15:00:45 INFO - Expected file size: 20517733 15:00:45 INFO - Obtained file size: 20517733 15:00:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:00:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:00:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:49 INFO - Fetch https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:00:50 INFO - Http code: 200 15:00:50 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 15:00:50 INFO - x-amz-cf-id: WAZcKw8tOqjrErXyfdnQHrF1Wv-eYQEnHX3g6Xthpt9unK-fgWLFlg== 15:00:50 INFO - x-amz-version-id: kOiTyZidqyp8mCAwa2Uio5zWYCv8kI7q 15:00:50 INFO - Expected file size: 20517733 15:00:50 INFO - Obtained file size: 20517733 15:00:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:00:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:00:55 INFO - Fetch https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:00:55 INFO - Http code: 200 15:00:55 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 15:00:55 INFO - x-amz-cf-id: lG19Q7Z7nMe90QWv3qVhpJcYPtHs-SpYl942BYlWhzHFSJdBSXUeHw== 15:00:55 INFO - x-amz-version-id: RgnCxmyqA2md812g1jxv3l7D87AgXIZu 15:00:56 INFO - Expected file size: 14409006 15:00:56 INFO - Obtained file size: 14409006 15:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:56 INFO - trying https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:00:56 INFO - Downloading https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:00:57 INFO - Downloaded 55824556 bytes. 15:00:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:00:57 INFO - mkdir: /builds/slave/test/properties 15:00:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:00:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:00:57 INFO - Contents: 15:00:57 INFO - build_url:https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:00:58 INFO - Running post-action listener: _resource_record_post_action 15:00:58 INFO - Running post-action listener: set_extra_try_arguments 15:00:58 INFO - [mozharness: 2016-10-10 22:00:58.753360Z] Finished download-and-extract step (success) 15:00:58 INFO - [mozharness: 2016-10-10 22:00:58.753662Z] Running populate-webroot step. 15:00:58 INFO - Running pre-action listener: _resource_record_pre_action 15:00:58 INFO - Running main action method: populate_webroot 15:00:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:00:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:00:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:00:58 INFO - '--tppagecycles', 15:00:58 INFO - '7'], 15:00:58 INFO - 'tests': ['tsvgm']}}, 15:00:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:00:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:00:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:00:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:00:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['damp', 'tps']}, 15:00:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'tests': ['damp', 'tps']}, 15:00:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['dromaeo_dom']}, 15:00:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:00:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['basic_compositor_video']}, 15:00:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:00:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['a11yr', 15:00:58 INFO - 'ts_paint', 15:00:58 INFO - 'tpaint', 15:00:58 INFO - 'sessionrestore', 15:00:58 INFO - 'sessionrestore_no_auto_restore', 15:00:58 INFO - 'tabpaint']}, 15:00:58 INFO - 'other-e10s': {'tests': ['a11yr', 15:00:58 INFO - 'ts_paint', 15:00:58 INFO - 'tpaint', 15:00:58 INFO - 'sessionrestore', 15:00:58 INFO - 'sessionrestore_no_auto_restore', 15:00:58 INFO - 'tabpaint']}, 15:00:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:00:58 INFO - 'ts_paint', 15:00:58 INFO - 'tpaint', 15:00:58 INFO - 'sessionrestore', 15:00:58 INFO - 'sessionrestore_no_auto_restore', 15:00:58 INFO - 'tabpaint']}, 15:00:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:00:58 INFO - 'ts_paint', 15:00:58 INFO - 'tpaint', 15:00:58 INFO - 'sessionrestore', 15:00:58 INFO - 'sessionrestore_no_auto_restore', 15:00:58 INFO - 'tabpaint']}, 15:00:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['a11yr', 15:00:58 INFO - 'ts_paint', 15:00:58 INFO - 'tpaint', 15:00:58 INFO - 'sessionrestore', 15:00:58 INFO - 'sessionrestore_no_auto_restore', 15:00:58 INFO - 'tabpaint']}, 15:00:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['a11yr', 15:00:58 INFO - 'ts_paint', 15:00:58 INFO - 'tpaint', 15:00:58 INFO - 'sessionrestore', 15:00:58 INFO - 'sessionrestore_no_auto_restore', 15:00:58 INFO - 'tabpaint']}, 15:00:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['tsvgx', 15:00:58 INFO - 'tsvgr_opacity', 15:00:58 INFO - 'tart', 15:00:58 INFO - 'tscrollx', 15:00:58 INFO - 'cart']}, 15:00:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:00:58 INFO - 'tsvgr_opacity', 15:00:58 INFO - 'tart', 15:00:58 INFO - 'tscrollx', 15:00:58 INFO - 'cart']}, 15:00:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'talos_options': ['--disable-e10s'], 15:00:58 INFO - 'tests': ['tp5o']}, 15:00:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'tests': ['tp5o']}, 15:00:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'talos_options': ['--disable-e10s', 15:00:58 INFO - '--xperf_path', 15:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:58 INFO - 'tests': ['tp5n']}, 15:00:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:58 INFO - 'talos_options': ['--xperf_path', 15:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:58 INFO - 'tests': ['tp5n']}}, 15:00:58 INFO - 'talos.zip': {'path': '', 15:00:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:00:58 INFO - Running post-action listener: _resource_record_post_action 15:00:58 INFO - [mozharness: 2016-10-10 22:00:58.775480Z] Finished populate-webroot step (success) 15:00:58 INFO - [mozharness: 2016-10-10 22:00:58.775572Z] Running create-virtualenv step. 15:00:58 INFO - Running pre-action listener: _resource_record_pre_action 15:00:58 INFO - Running main action method: create_virtualenv 15:00:58 INFO - Creating virtualenv /builds/slave/test/build/venv 15:00:58 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 15:00:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:00:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:00:58 INFO - Using real prefix '/usr' 15:00:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:00:59 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:01 INFO - Installing pip.................done. 15:01:01 INFO - Return code: 0 15:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:01 INFO - Reading from file tmpfile_stdout 15:01:01 INFO - Output received: 15:01:01 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) 15:01:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:01 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:01 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 15:01:01 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 15:01:01 INFO - Using env: {'DISPLAY': ':0', 15:01:01 INFO - 'HOME': '/home/cltbld', 15:01:01 INFO - 'LANG': 'en_US.UTF-8', 15:01:01 INFO - 'LANGUAGE': 'en_US:en', 15:01:01 INFO - 'LOGNAME': 'cltbld', 15:01:01 INFO - 'MAIL': '/var/mail/cltbld', 15:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:01 INFO - 'MOZ_NO_REMOTE': '1', 15:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:01 INFO - 'NO_EM_RESTART': '1', 15:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:01 INFO - 'PWD': '/builds/slave/test', 15:01:01 INFO - 'SHELL': '/bin/bash', 15:01:01 INFO - 'SHLVL': '1', 15:01:01 INFO - 'TERM': 'linux', 15:01:01 INFO - 'TMOUT': '86400', 15:01:01 INFO - 'USER': 'cltbld', 15:01:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:01 INFO - '_': '/tools/buildbot/bin/python'} 15:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:01 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 15:01:01 INFO - Cleaning up... 15:01:01 INFO - Return code: 0 15:01:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:01 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:01 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 15:01:01 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 15:01:01 INFO - Using env: {'DISPLAY': ':0', 15:01:01 INFO - 'HOME': '/home/cltbld', 15:01:01 INFO - 'LANG': 'en_US.UTF-8', 15:01:01 INFO - 'LANGUAGE': 'en_US:en', 15:01:01 INFO - 'LOGNAME': 'cltbld', 15:01:01 INFO - 'MAIL': '/var/mail/cltbld', 15:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:01 INFO - 'MOZ_NO_REMOTE': '1', 15:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:01 INFO - 'NO_EM_RESTART': '1', 15:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:01 INFO - 'PWD': '/builds/slave/test', 15:01:01 INFO - 'SHELL': '/bin/bash', 15:01:01 INFO - 'SHLVL': '1', 15:01:01 INFO - 'TERM': 'linux', 15:01:01 INFO - 'TMOUT': '86400', 15:01:01 INFO - 'USER': 'cltbld', 15:01:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:01 INFO - '_': '/tools/buildbot/bin/python'} 15:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:01 INFO - Downloading/unpacking psutil>=3.1.1 15:01:01 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 15:01:01 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 15:01:01 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 15:01:01 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 15:01:01 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 15:01:01 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 15:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:04 INFO - Installing collected packages: psutil 15:01:04 INFO - Running setup.py install for psutil 15:01:04 INFO - building 'psutil._psutil_linux' extension 15:01:04 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 15:01:04 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 15:01:04 INFO - building 'psutil._psutil_posix' extension 15:01:04 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 15:01:04 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 15:01:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:04 INFO - Successfully installed psutil 15:01:04 INFO - Cleaning up... 15:01:04 INFO - Return code: 0 15:01:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:04 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')]} 15:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:04 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')]} 15:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:04 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:04 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 15:01:04 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 15:01:04 INFO - Using env: {'DISPLAY': ':0', 15:01:04 INFO - 'HOME': '/home/cltbld', 15:01:04 INFO - 'LANG': 'en_US.UTF-8', 15:01:04 INFO - 'LANGUAGE': 'en_US:en', 15:01:04 INFO - 'LOGNAME': 'cltbld', 15:01:04 INFO - 'MAIL': '/var/mail/cltbld', 15:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:04 INFO - 'MOZ_NO_REMOTE': '1', 15:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:04 INFO - 'NO_EM_RESTART': '1', 15:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:04 INFO - 'PWD': '/builds/slave/test', 15:01:04 INFO - 'SHELL': '/bin/bash', 15:01:04 INFO - 'SHLVL': '1', 15:01:04 INFO - 'TERM': 'linux', 15:01:04 INFO - 'TMOUT': '86400', 15:01:04 INFO - 'USER': 'cltbld', 15:01:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:04 INFO - '_': '/tools/buildbot/bin/python'} 15:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:04 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 15:01:04 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 15:01:04 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 15:01:04 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 15:01:04 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 15:01:04 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 15:01:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:06 INFO - Installing collected packages: mozsystemmonitor 15:01:06 INFO - Running setup.py install for mozsystemmonitor 15:01:06 INFO - Successfully installed mozsystemmonitor 15:01:06 INFO - Cleaning up... 15:01:06 INFO - Return code: 0 15:01:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01:06 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')]} 15:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:06 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')]} 15:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:06 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:06 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 15:01:06 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 15:01:06 INFO - Using env: {'DISPLAY': ':0', 15:01:06 INFO - 'HOME': '/home/cltbld', 15:01:06 INFO - 'LANG': 'en_US.UTF-8', 15:01:06 INFO - 'LANGUAGE': 'en_US:en', 15:01:06 INFO - 'LOGNAME': 'cltbld', 15:01:06 INFO - 'MAIL': '/var/mail/cltbld', 15:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:06 INFO - 'MOZ_NO_REMOTE': '1', 15:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:06 INFO - 'NO_EM_RESTART': '1', 15:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:06 INFO - 'PWD': '/builds/slave/test', 15:01:06 INFO - 'SHELL': '/bin/bash', 15:01:06 INFO - 'SHLVL': '1', 15:01:06 INFO - 'TERM': 'linux', 15:01:06 INFO - 'TMOUT': '86400', 15:01:06 INFO - 'USER': 'cltbld', 15:01:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:06 INFO - '_': '/tools/buildbot/bin/python'} 15:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:07 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:07 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 15:01:07 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 15:01:07 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 15:01:07 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 15:01:07 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 15:01:07 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 15:01:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:09 INFO - warning: no files found matching '*.txt' 15:01:09 INFO - no previously-included directories found matching 'build' 15:01:09 INFO - no previously-included directories found matching 'dist' 15:01:09 INFO - no previously-included directories found matching '.git*' 15:01:09 INFO - Installing collected packages: jsonschema, functools32 15:01:09 INFO - Running setup.py install for functools32 15:01:09 INFO - warning: no files found matching '*.txt' 15:01:09 INFO - no previously-included directories found matching 'build' 15:01:09 INFO - no previously-included directories found matching 'dist' 15:01:09 INFO - no previously-included directories found matching '.git*' 15:01:09 INFO - Successfully installed jsonschema functools32 15:01:09 INFO - Cleaning up... 15:01:09 INFO - Return code: 0 15:01:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01:09 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')]} 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:09 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')]} 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:09 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:09 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 15:01:09 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 15:01:09 INFO - Using env: {'DISPLAY': ':0', 15:01:09 INFO - 'HOME': '/home/cltbld', 15:01:09 INFO - 'LANG': 'en_US.UTF-8', 15:01:09 INFO - 'LANGUAGE': 'en_US:en', 15:01:09 INFO - 'LOGNAME': 'cltbld', 15:01:09 INFO - 'MAIL': '/var/mail/cltbld', 15:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:09 INFO - 'MOZ_NO_REMOTE': '1', 15:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:09 INFO - 'NO_EM_RESTART': '1', 15:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:09 INFO - 'PWD': '/builds/slave/test', 15:01:09 INFO - 'SHELL': '/bin/bash', 15:01:09 INFO - 'SHLVL': '1', 15:01:09 INFO - 'TERM': 'linux', 15:01:09 INFO - 'TMOUT': '86400', 15:01:09 INFO - 'USER': 'cltbld', 15:01:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:09 INFO - '_': '/tools/buildbot/bin/python'} 15:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:09 INFO - Cleaning up... 15:01:09 INFO - Return code: 0 15:01:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:09 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')]} 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:09 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')]} 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:09 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:09 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 15:01:09 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 15:01:09 INFO - Using env: {'DISPLAY': ':0', 15:01:09 INFO - 'HOME': '/home/cltbld', 15:01:09 INFO - 'LANG': 'en_US.UTF-8', 15:01:09 INFO - 'LANGUAGE': 'en_US:en', 15:01:09 INFO - 'LOGNAME': 'cltbld', 15:01:09 INFO - 'MAIL': '/var/mail/cltbld', 15:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:09 INFO - 'MOZ_NO_REMOTE': '1', 15:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:09 INFO - 'NO_EM_RESTART': '1', 15:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:09 INFO - 'PWD': '/builds/slave/test', 15:01:09 INFO - 'SHELL': '/bin/bash', 15:01:09 INFO - 'SHLVL': '1', 15:01:09 INFO - 'TERM': 'linux', 15:01:09 INFO - 'TMOUT': '86400', 15:01:09 INFO - 'USER': 'cltbld', 15:01:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:09 INFO - '_': '/tools/buildbot/bin/python'} 15:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:12 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 15:01:12 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 15:01:12 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 15:01:12 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 15:01:12 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 15:01:12 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 15:01:12 INFO - Downloading docopt-0.6.1.tar.gz 15:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:12 INFO - Running setup.py install for blobuploader 15:01:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:12 INFO - Running setup.py install for requests 15:01:13 INFO - Running setup.py install for docopt 15:01:13 INFO - Successfully installed blobuploader requests docopt 15:01:13 INFO - Cleaning up... 15:01:13 INFO - Return code: 0 15:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:13 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:13 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 15:01:13 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 15:01:13 INFO - Using env: {'DISPLAY': ':0', 15:01:13 INFO - 'HOME': '/home/cltbld', 15:01:13 INFO - 'LANG': 'en_US.UTF-8', 15:01:13 INFO - 'LANGUAGE': 'en_US:en', 15:01:13 INFO - 'LOGNAME': 'cltbld', 15:01:13 INFO - 'MAIL': '/var/mail/cltbld', 15:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:13 INFO - 'MOZ_NO_REMOTE': '1', 15:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:13 INFO - 'NO_EM_RESTART': '1', 15:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:13 INFO - 'PWD': '/builds/slave/test', 15:01:13 INFO - 'SHELL': '/bin/bash', 15:01:13 INFO - 'SHLVL': '1', 15:01:13 INFO - 'TERM': 'linux', 15:01:13 INFO - 'TMOUT': '86400', 15:01:13 INFO - 'USER': 'cltbld', 15:01:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:13 INFO - '_': '/tools/buildbot/bin/python'} 15:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:13 INFO - Running setup.py (path:/tmp/pip-wipTMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:13 INFO - Running setup.py (path:/tmp/pip-PSgXkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:13 INFO - Running setup.py (path:/tmp/pip-VnZnxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:13 INFO - Running setup.py (path:/tmp/pip-ZuUch0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:13 INFO - Running setup.py (path:/tmp/pip-zZ3srQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:13 INFO - Running setup.py (path:/tmp/pip-k0z9cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:13 INFO - Running setup.py (path:/tmp/pip-ZP5j9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:13 INFO - Running setup.py (path:/tmp/pip-xEEReR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:14 INFO - Running setup.py (path:/tmp/pip-U132SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:14 INFO - Running setup.py (path:/tmp/pip-lwRger-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:14 INFO - Running setup.py (path:/tmp/pip-Xl1M6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:14 INFO - Running setup.py (path:/tmp/pip-AYXUsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:14 INFO - Running setup.py (path:/tmp/pip-PPK1_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:14 INFO - Running setup.py (path:/tmp/pip-7Mutpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:14 INFO - Running setup.py (path:/tmp/pip-WTLFM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:14 INFO - Running setup.py (path:/tmp/pip-uh1M1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:14 INFO - Running setup.py (path:/tmp/pip-78CxfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:14 INFO - Running setup.py install for manifestparser 15:01:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:14 INFO - Running setup.py install for mozcrash 15:01:14 INFO - Running setup.py install for mozdebug 15:01:14 INFO - Running setup.py install for mozdevice 15:01:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Running setup.py install for mozfile 15:01:15 INFO - Running setup.py install for mozhttpd 15:01:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Running setup.py install for mozinfo 15:01:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Running setup.py install for mozInstall 15:01:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Running setup.py install for mozleak 15:01:15 INFO - Running setup.py install for mozlog 15:01:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Running setup.py install for moznetwork 15:01:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:15 INFO - Running setup.py install for mozprocess 15:01:15 INFO - Running setup.py install for mozprofile 15:01:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:16 INFO - Running setup.py install for mozrunner 15:01:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:16 INFO - Running setup.py install for mozscreenshot 15:01:16 INFO - Running setup.py install for moztest 15:01:16 INFO - Running setup.py install for mozversion 15:01:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:16 INFO - Cleaning up... 15:01:16 INFO - Return code: 0 15:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:16 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:16 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 15:01:16 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 15:01:16 INFO - Using env: {'DISPLAY': ':0', 15:01:16 INFO - 'HOME': '/home/cltbld', 15:01:16 INFO - 'LANG': 'en_US.UTF-8', 15:01:16 INFO - 'LANGUAGE': 'en_US:en', 15:01:16 INFO - 'LOGNAME': 'cltbld', 15:01:16 INFO - 'MAIL': '/var/mail/cltbld', 15:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:16 INFO - 'MOZ_NO_REMOTE': '1', 15:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:16 INFO - 'NO_EM_RESTART': '1', 15:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:16 INFO - 'PWD': '/builds/slave/test', 15:01:16 INFO - 'SHELL': '/bin/bash', 15:01:16 INFO - 'SHLVL': '1', 15:01:16 INFO - 'TERM': 'linux', 15:01:16 INFO - 'TMOUT': '86400', 15:01:16 INFO - 'USER': 'cltbld', 15:01:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:16 INFO - '_': '/tools/buildbot/bin/python'} 15:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:16 INFO - Running setup.py (path:/tmp/pip-dj24Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:16 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)) 15:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:16 INFO - Running setup.py (path:/tmp/pip-D2qlyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:16 INFO - Running setup.py (path:/tmp/pip-LgLrve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:16 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)) 15:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:16 INFO - Running setup.py (path:/tmp/pip-li1rmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:17 INFO - Running setup.py (path:/tmp/pip-fc2nsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:17 INFO - Running setup.py (path:/tmp/pip-m1mE7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:17 INFO - Running setup.py (path:/tmp/pip-iDgEBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:17 INFO - Running setup.py (path:/tmp/pip-7KlgSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:17 INFO - Running setup.py (path:/tmp/pip-PbovoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:17 INFO - Running setup.py (path:/tmp/pip-H8f7gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:17 INFO - Running setup.py (path:/tmp/pip-EyHNlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:17 INFO - Running setup.py (path:/tmp/pip-TYYUdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:17 INFO - Running setup.py (path:/tmp/pip-BEM7_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:17 INFO - Running setup.py (path:/tmp/pip-dazd99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:17 INFO - Running setup.py (path:/tmp/pip-PKbrYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:17 INFO - Running setup.py (path:/tmp/pip-VXhcvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:17 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)) 15:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:17 INFO - Running setup.py (path:/tmp/pip-w8CHGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:17 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)) 15:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:17 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)) 15:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:19 INFO - Downloading blessings-1.6.tar.gz 15:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:19 INFO - Installing collected packages: blessings 15:01:19 INFO - Running setup.py install for blessings 15:01:20 INFO - Successfully installed blessings 15:01:20 INFO - Cleaning up... 15:01:20 INFO - Return code: 0 15:01:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:20 INFO - Reading from file tmpfile_stdout 15:01:20 INFO - Current package versions: 15:01:20 INFO - argparse == 1.2.1 15:01:20 INFO - blessings == 1.6 15:01:20 INFO - blobuploader == 1.2.4 15:01:20 INFO - docopt == 0.6.1 15:01:20 INFO - functools32 == 3.2.3-2 15:01:20 INFO - jsonschema == 2.5.1 15:01:20 INFO - manifestparser == 1.1 15:01:20 INFO - mozInstall == 1.12 15:01:20 INFO - mozcrash == 0.17 15:01:20 INFO - mozdebug == 0.1 15:01:20 INFO - mozdevice == 0.48 15:01:20 INFO - mozfile == 1.2 15:01:20 INFO - mozhttpd == 0.7 15:01:20 INFO - mozinfo == 0.9 15:01:20 INFO - mozleak == 0.1 15:01:20 INFO - mozlog == 3.4 15:01:20 INFO - moznetwork == 0.27 15:01:20 INFO - mozprocess == 0.23 15:01:20 INFO - mozprofile == 0.28 15:01:20 INFO - mozrunner == 6.12 15:01:20 INFO - mozscreenshot == 0.1 15:01:20 INFO - mozsystemmonitor == 0.3 15:01:20 INFO - moztest == 0.7 15:01:20 INFO - mozversion == 1.4 15:01:20 INFO - psutil == 3.1.1 15:01:20 INFO - requests == 1.2.3 15:01:20 INFO - wsgiref == 0.1.2 15:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:20 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 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:20 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 15:01:20 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 15:01:20 INFO - Using env: {'DISPLAY': ':0', 15:01:20 INFO - 'HOME': '/home/cltbld', 15:01:20 INFO - 'LANG': 'en_US.UTF-8', 15:01:20 INFO - 'LANGUAGE': 'en_US:en', 15:01:20 INFO - 'LOGNAME': 'cltbld', 15:01:20 INFO - 'MAIL': '/var/mail/cltbld', 15:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:20 INFO - 'MOZ_NO_REMOTE': '1', 15:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:20 INFO - 'NO_EM_RESTART': '1', 15:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:20 INFO - 'PWD': '/builds/slave/test', 15:01:20 INFO - 'SHELL': '/bin/bash', 15:01:20 INFO - 'SHLVL': '1', 15:01:20 INFO - 'TERM': 'linux', 15:01:20 INFO - 'TMOUT': '86400', 15:01:20 INFO - 'USER': 'cltbld', 15:01:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:20 INFO - '_': '/tools/buildbot/bin/python'} 15:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 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)) 15:01:20 INFO - Cleaning up... 15:01:20 INFO - Return code: 0 15:01:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab0f845f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', '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 15:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:01:20 INFO - Using env: {'DISPLAY': ':0', 15:01:20 INFO - 'HOME': '/home/cltbld', 15:01:20 INFO - 'LANG': 'en_US.UTF-8', 15:01:20 INFO - 'LANGUAGE': 'en_US:en', 15:01:20 INFO - 'LOGNAME': 'cltbld', 15:01:20 INFO - 'MAIL': '/var/mail/cltbld', 15:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:20 INFO - 'MOZ_NO_REMOTE': '1', 15:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:20 INFO - 'NO_EM_RESTART': '1', 15:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:20 INFO - 'PWD': '/builds/slave/test', 15:01:20 INFO - 'SHELL': '/bin/bash', 15:01:20 INFO - 'SHLVL': '1', 15:01:20 INFO - 'TERM': 'linux', 15:01:20 INFO - 'TMOUT': '86400', 15:01:20 INFO - 'USER': 'cltbld', 15:01:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:20 INFO - '_': '/tools/buildbot/bin/python'} 15:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:20 INFO - Cleaning up... 15:01:20 INFO - Return code: 0 15:01:20 INFO - Running post-action listener: _resource_record_post_action 15:01:20 INFO - Running post-action listener: _start_resource_monitoring 15:01:20 INFO - Starting resource monitoring. 15:01:20 INFO - [mozharness: 2016-10-10 22:01:20.864832Z] Finished create-virtualenv step (success) 15:01:20 INFO - [mozharness: 2016-10-10 22:01:20.865399Z] Running install step. 15:01:20 INFO - Running pre-action listener: _resource_record_pre_action 15:01:20 INFO - Running main action method: install 15:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:21 INFO - Reading from file tmpfile_stdout 15:01:21 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:21 INFO - Reading from file tmpfile_stdout 15:01:21 INFO - Output received: 15:01:21 INFO - Usage: mozinstall [options] installer 15:01:21 INFO - Options: 15:01:21 INFO - -h, --help show this help message and exit 15:01:21 INFO - -d DEST, --destination=DEST 15:01:21 INFO - Directory to install application into. [default: 15:01:21 INFO - "/builds/slave/test"] 15:01:21 INFO - --app=APP Application being installed. [default: firefox] 15:01:21 INFO - mkdir: /builds/slave/test/build/application 15:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:01:37 INFO - Reading from file tmpfile_stdout 15:01:37 INFO - Output received: 15:01:37 INFO - /builds/slave/test/build/application/firefox/firefox 15:01:37 INFO - Running post-action listener: _resource_record_post_action 15:01:37 INFO - [mozharness: 2016-10-10 22:01:37.304655Z] Finished install step (success) 15:01:37 INFO - [mozharness: 2016-10-10 22:01:37.304900Z] Running run-tests step. 15:01:37 INFO - Running pre-action listener: _resource_record_pre_action 15:01:37 INFO - Running main action method: run_tests 15:01:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:01:37 INFO - Python 2.7.3 15:01:37 INFO - Return code: 0 15:01:37 INFO - grabbing minidump binary from tooltool 15:01:37 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')]} 15:01:37 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 0x1128f60>, '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 0x1129d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x112a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:01:37 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 15:01:37 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 15:01:37 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 15:01:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:01:37 INFO - Return code: 0 15:01:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:01:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:01:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:01:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:01:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:01:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:01:37 INFO - Using env: {'DISPLAY': ':0', 15:01:37 INFO - 'HOME': '/home/cltbld', 15:01:37 INFO - 'LANG': 'en_US.UTF-8', 15:01:37 INFO - 'LANGUAGE': 'en_US:en', 15:01:37 INFO - 'LOGNAME': 'cltbld', 15:01:37 INFO - 'MAIL': '/var/mail/cltbld', 15:01:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:01:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:37 INFO - 'MOZ_NO_REMOTE': '1', 15:01:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:37 INFO - 'NO_EM_RESTART': '1', 15:01:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:37 INFO - 'PWD': '/builds/slave/test', 15:01:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:01:37 INFO - 'SHELL': '/bin/bash', 15:01:37 INFO - 'SHLVL': '1', 15:01:37 INFO - 'TERM': 'linux', 15:01:37 INFO - 'TMOUT': '86400', 15:01:37 INFO - 'USER': 'cltbld', 15:01:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163', 15:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:37 INFO - '_': '/tools/buildbot/bin/python'} 15:01:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:01:37 INFO - mozversion application_buildid: 20161010125223 15:01:37 INFO - mozversion application_changeset: 03fde9f8b44a7ed51f3a2aaf388ae8e2c2222f1f 15:01:37 INFO - mozversion application_display_name: Nightly 15:01:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:01:37 INFO - mozversion application_name: Firefox 15:01:37 INFO - mozversion application_remotingname: firefox 15:01:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:01:37 INFO - mozversion application_vendor: Mozilla 15:01:37 INFO - mozversion application_version: 52.0a1 15:01:37 INFO - mozversion platform_buildid: 20161010125223 15:01:37 INFO - mozversion platform_changeset: 03fde9f8b44a7ed51f3a2aaf388ae8e2c2222f1f 15:01:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:01:37 INFO - mozversion platform_version: 52.0a1 15:01:37 INFO - using testdate: 1476136897 15:01:37 INFO - actual date: 1476136897 15:01:37 INFO - starting webserver on 'localhost:49625' 15:01:37 INFO - SUITE-START | Running 2 tests 15:01:37 INFO - TEST-START | dromaeo_css 15:01:37 INFO - operating with platform_type : linux_ 15:01:37 INFO - Initialising browser for dromaeo_css test... 15:01:37 INFO - TEST-INFO | started process 19526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbxohhO/profile http://localhost:49625/getInfo.html) 15:01:42 INFO - PROCESS | 19526 | __metrics Screen width/height:1600/1200 15:01:42 INFO - PROCESS | 19526 | colorDepth:24 15:01:42 INFO - PROCESS | 19526 | Browser inner width/height: 1024/697 15:01:42 INFO - PROCESS | 19526 | __metrics 15:01:42 INFO - PROCESS | 19526 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:01:42 INFO - PROCESS | 19526 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:01:43 INFO - PROCESS | 19526 | console.error: PushService: 15:01:43 INFO - PROCESS | 19526 | stateChangeProcessEnqueue: Error transitioning state 15:01:43 INFO - PROCESS | 19526 | UnknownError 15:01:44 INFO - TEST-INFO | 19526: exit 0 15:01:44 INFO - Browser initialized. 15:01:44 INFO - Running cycle 1/1 for dromaeo_css test... 15:01:44 INFO - TEST-INFO | started process 19607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbxohhO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:56 INFO - PROCESS | 19607 | RSS: Main: 174477312 15:01:56 INFO - PROCESS | 19607 | 15:02:48 INFO - PROCESS | 19607 | 1476136968406 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] 15:05:01 INFO - PROCESS | 19607 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49625/tests/dromaeo/cssquery-ext.html) 15:05:02 INFO - PROCESS | 19607 | RSS: Main: 276901888 15:05:02 INFO - PROCESS | 19607 | 15:08:05 INFO - PROCESS | 19607 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-ext.html (next: http://localhost:49625/tests/dromaeo/cssquery-jquery.html) 15:08:05 INFO - PROCESS | 19607 | RSS: Main: 272384000 15:08:05 INFO - PROCESS | 19607 | 15:11:08 INFO - PROCESS | 19607 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49625/tests/dromaeo/cssquery-mootools.html) 15:11:08 INFO - PROCESS | 19607 | RSS: Main: 243126272 15:11:08 INFO - PROCESS | 19607 | 15:14:11 INFO - PROCESS | 19607 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49625/tests/dromaeo/cssquery-prototype.html) 15:14:11 INFO - PROCESS | 19607 | RSS: Main: 218865664 15:14:11 INFO - PROCESS | 19607 | 15:17:14 INFO - PROCESS | 19607 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49625/tests/dromaeo/cssquery-yui.html) 15:17:15 INFO - PROCESS | 19607 | RSS: Main: 220323840 15:17:15 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-yui.html (next: http://localhost:49625/tests/dromaeo/cssquery-dojo.html) 15:20:18 INFO - PROCESS | 19607 | RSS: Main: 309702656 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | __start_tp_report 15:20:18 INFO - PROCESS | 19607 | _x_x_mozilla_page_load 15:20:18 INFO - PROCESS | 19607 | _x_x_mozilla_page_load_details 15:20:18 INFO - PROCESS | 19607 | |i|pagename|runs| 15:20:18 INFO - PROCESS | 19607 | |0;dojo.html;2545.5163518931404;2555.092942005589;2588.935276618085;2599.7010343810466;2607.5827867541198;4530.184566777979;4613.400257966459;4641.744704041276;4653.720776753393;4663.696859704117;4550.567696068876;4593.609543188824;4606.262997920333;4656.813727450898;4657.743824089674;4264.786760661962;4307.67692423068;4324.956750432487;4345.717528360647;4382.9342559861625;4335.523092459827;4378.912421751563;4389.4513185851765;4389.714668546534;4427.269500532424;4347.804348804311;4377.080813029252;4393.406890069831;4400.031992961543;4435.600795928366;4134.586541345871;4179.477565304337;4180.435641188431;4202.2646036943415;4217.683673724452;4197.601227883346;4199.181159673864;4208.032152604887;4229.830806767725;4331.090471001094;4606.861794146181;4620.445546534404;4638.67529272951;4661.394018777537;4716.38686970695;4828.637852161102;4881.780319885614;4941.851744447672;4966.255061740731;4989.950100499022;4987.650864439491;5008.749562521859;5013.598912087061;5021.548060674557;5062.417821950486;4649.488556258842;4685.4143232095985;4685.437747470257;4687.460941991646;4700.811967521329;4915.9508404916205;4959.851204463872;5040.697558146523;5076.238564215398;5148.794048238028;4884.926726099111;4905.950940490621;4907.754612269372;4946.950530494721;4956.603471722254;4974.0797952378925;4980.676256043345;4986.127427700138;4991.326170966873;5053.494650534917;4809.591184749265;4856.3201151838775;4926.852194434173;4929.728864912393;4997.400311962588;4879.316895634614;4892.315075889378;4892.535209155125;4892.706437613683;4897.3878265216845;4170.291050521419;4171.958280417157;4199.0342221289275;4200.05498762782;4224.218519573888;3693.833777479966;3736.813159342022;3739.5886452490204;3782.829772660237;3792;4252.234597772369;4253.447051883235;4257.148570285955;4260.850870219528;4301.741895486281;4843.515648435199;4849.58778503824;4923.679960802537;4962.851114466572;5014.373203349582;4230.386593943861;4257.233697934402;4260.55264197261;4275.978620106879;4320.740755554614;4468.530804265505;4469.932951005738;4472.44094488189;4477.932831007537;4521.299198624219;4555.908881822279;4641.466231383434;4642.46611639659;4643.976780116078;4694.319323698045;4874.4150701916;4955.2567114933045;5028.974855125701;5031;5078.847634570969;4720.693154944917;4722.952770472251;4728.3380326753595;4730.124926888537;4789.95210047895;4948.950510494993;4955;4956.900861982668;4958.677685950402;5020.748962551931;4839.225723884161;4866.221404575251;4961.231009193581;4968.378952630921;4995.425526064404;4875.7074575525585;4881.194602890483;4886;4929.728864912464;4938.1358262304675;4833;4870.245112007645;4874.366332376769;4879.853604391874;4935.161022626234;4665.696729712694;4710.81156753726;4739.123262196505;4745.098431298043;4820.903581928412;4869.074875773592;4870.7808148632685;4881.194602890483;4925.310456536016;4934.901301974012;4665.930011049905;4691.7184968901975;4765.5949244314625;4780.593649539828;4814.5907597853175 15:20:18 INFO - PROCESS | 19607 | |1;ext.html;558.3578884283074;576.4898065212286;577.9711014449276;580.6951350540966;585.0200913469939;27695;28397.432051358985;30246.395072098545;30312.696873031262;37359.4396084059;35661;39300;39303;39320.60679393205;39362.60637393625;7596.658150383232;7791.532508049507;7794.259545343183;7795;7798.688052477923;7642.9235707642765;7729.574873381962;7735.419843511759;7749.380049596047;7756;7769.611519424035;7810.648520816577;7820.80447988802;7825.334846538022;7827.491213071161;7758.8448231035345;7777.805554861117;7788.0654321481215;7793;7796.14242433329;7682.1549629540705;7732.072151341818;7738.833126724526;7741.806454838617;7742.961285193594;36805;36998;37134;37149.07127321839;37159.81420092909;3077.707617776308;3098.5971823663003;3451.4995325677887;3606.8737594184076;3652.6529979652155;27989;28538.571921421197;28593.85703071492;28653.13468653118;29680.554791678143;3458.3774920514297;3522.6653467920505;3549.733769967237;3677.5035370224946;3695.5380577427823;224843;225957;226476;227399;228420;31416.214594635316;32267.677323226937;32379.00988317169;49970;50304.24543631849;33036.834815826245;33326.00373809375;33367.33265334728;33381.83309083439;33400.659934006406;13496.460141594227;13621.795673064911;13627.456861215956;13641.386137623633;13641.454341826415;11505.367204803817;11609.76780464386;11614.6515604532;11618.76762464763;11623.59317423886;7937;7943.165967573437;7954.960225198837;8046.597670116471;8046.919530804617;3099.8450077496036;3106.39425312062;3114.78196526241;3125.812451252932;3146.7954582952034;798.5089170160426;861.5347712235448;889.439653018607;895.0780695883251;913.3287034029983;25723.74276257251;27465.862670686918;27510.449791004066;27605.447891042066;27929.162125136278;966.3477152921749;982.3221976835961;983.6655537117415;1014.2595904989399;1032.746976990642;13493;14514.419423223164;14608.780868286984;14980.62548436276;15722.213889305718;334593;336137;337070;337582;338512;48982.5101748978;49334.25998610024;49387.75306123446;49403;49420.75289623529;1152.6311580294225;1171.5079666540073;1181.2381014245764;1181.5214837990457;1201.8257352683986;27060.45879082368;28355.43289134247;28502.42995140127;28779.136625901258;29109.563356549246;41546.58453415548;42013.78993105015;42342.78828605837;42344;42424;303452;303932;304440;304830;306049;24051.75948240565;24293.663848487795;25277.747222527538;25296.36759080964;26420.20739377822;39745;40027.59972400355;40468.59531404766;40698.79650601728;41179;34548.30903381868;34966.30067398587;35002;35393.82303088571;35636.287274254886;34442.655573443946;34734.47898281578;34894.30211395809;35020;35074.649253508156;26384.868075660266;30533.847330763205;35241.64758352384;35315.29369412546;35463.29073418466;28417.715822842332;30541.42061919256;30626.84686576553;30653.54019689751;30730.84634576813;24664.876675617226;24985;25395.238142855746;25503;25717.35706607275 15:20:18 INFO - PROCESS | 19607 | |2;jquery.html;336.7558520072946;348.6774733371629;359.2688878133;359.72660777808863;377.28881059203394;12177.391130443475;13194.868051319496;15473.535793926172;15709.135997520132;15788;15978.360865565364;16452.42416515422;16733.995960242362;17292.82707172928;17459.738103928452;4529.388532548097;4957.925631115527;5190.948090519103;5191.662541934762;5195.610329225305;5619.241402410684;5835.474807267345;6033;6060.696965151747;6069.059295809135;5765.077587585987;5948.345681974979;5961.5230781537375;6017.939820601781;6029.879402411949;5961.344252132262;5986.700664966735;5996.700164991777;5999.76000959961;6000.879982400327;5056.721880296583;5179.61152913533;5201.08980928336;5202.895942081137;5283.260343551906;19902.20391184351;20033.699494507593;20129.899350503154;20322;20337.18651253948;1832.5418645338666;1930.0253372047166;2051.2307884543297;2157.996531612792;2259.26573863495;11821.586244481401;11943.820842687366;12044.337561434118;12408.75182496354;12601.117921745481;1478.6525166585843;1496.8128983877016;1498.48302335694;1523.1470376589034;1537.6309685675358;68196;68671;68791.3120868795;69256.6537167316;70097.29902700908;8989.685361012464;9036.81926361469;9244.8613270801;9478.478683672463;9762.170215531618;13287;13327.73344533104;13328.2669453181;13330.400131994083;13332.533361332307;6930.792076237721;7160.749373771997;7173.067501224912;7194.604296763729;7359.558426494427;7017.684204210823;7052.365287124184;7059.647017649097;7255.782326530212;7299.89050164248;5790.334111577138;5835.124731290255;5877.617954832922;6037.366076561985;6065.908136535466;1593.7768712380275;1676.555712736126;1680.7142785726455;1711.4095637005214;1719.0888828920442;860.9956950215334;864.3085531574715;883.3551507399634;911.981760364789;960.4141473701037;16617.91691041537;16951.237194326284;17596.47210583659;17840.643187136186;18085.638287234182;867.509856930832;897.0580890065405;900.7297810656777;903.5256490342491;921.161742814036;9580.041995800504;10236;10269.589216431408;10276.486175691334;10292.39881931113;345569;345828;347086;348159;348534;65424.67287663531;65592.67203663952;65843;67018;67594;885.8936927568604;929.2473096791621;948.3029972969999;954.5322791832091;955.302629080775;11370.658880233606;14500;15358.923205383902;15538.533843984698;16297;37469.81265093657;37566;37755.44755606917;37869.62130378661;37987.620123798406;46346.30480542862;46514.53485465102;48334.758326208146;48663.513364865896;49010;7106.431485481253;7299.270072992871;7457.440691948017;7459.515131516651;7625.313721765067;10561.207909406672;10885.891141088488;11254.60608878718;11332.886671133512;11430.542778289107;9693;9832.836775909289;9834;9889.950550247202;10080.546375412978;9587.568559414982;9737.955029443896;9746.26902982265;9752.219822414048;9968.800623987625;9485.288603354915;9574.521273936414;9939.65211217604;10095.697129086138;10160.491975401348;7318.1949985502615;7322.560646361022;7483.66323515454;7513;7534.736284230025;8887;9408.905910940803;9503.144716975505;9619.615215391306;9690.37012594179 15:20:18 INFO - PROCESS | 19607 | |3;mootools.html;1330.1553513518916;1373.6840526678864;1387.8473367929525;1596.9760453593206;1644.3422630947618;7436.851262974744;8114.229148230916;8121.309688676462;8128.227818357262;8139.959300203505;6665.333466653332;6930.861382772354;7440.144383395911;7670.693172273116;8026.07700114487;2106.5892151030516;2138.4012476506605;2139.12295958657;2144.667576525641;2155.5904378168175;2111.767705552388;2142.73215848019;2156.924507642233;2161.070739581979;2161.729783777028;2127.1385089038886;2147.527543940331;2150.5376344086017;2154.7845215478483;2163.556470923457;2092.2677063027973;2094.3402828109097;2097.769245383014;2098.9790102098937;2103.2638576498257;2040.9693854592044;2111.3876975677035;2112.355731501891;2114.407965769587;2114.4925217947734;7737.57443340616;7789;7836.333911617519;7844.725434609818;7856.725014624518;4356.803943822536;4475.10497900418;4480.731156130642;4485.484169320504;4496.123255965088;2835.5604881243235;2926.4293462774767;2988.6861879502558;2992.640883094021;3001.9099427017222;901.1799262670938;915.6337465013982;927.0636656976435;929.5352323838081;974.0794948773412;10544.947275263652;10572.841407378895;10578;10604.098651614622;10624.575016999388;3833.9424908625833;3951.78265195417;4095.672346212296;4128.3601041838565;4134.607212314825;9128.315376346667;9129.726108216764;9131.452112873249;9133.223675987483;9141.54292285383;4600.95399046012;4610.446746390455;4624.190766615829;4626.1441633297945;4630.83792067276;3781.149241420713;3912.68698504119;4099.877003689894;4195.265828480004;4197.076643138505;3258.5926759155104;3285.227971426713;3386.255023894739;3394.762366634361;3416.914577135542;1150.1603829204728;1170.6839153428527;1172.7947609168532;1186.6202815099086;1190.9404529773476;719.5179229915968;757.1671161722172;808.9878651820227;832.8542505061711;835.7283882738135;4981.775820088033;5128.79484820603;5199.324087868553;5203.386950045422;5221.738913054332;373.66556931546114;383.86372837642796;384.0877914951989;384.6403612622207;392.73490393983946;3382.2389962258785;3415.1632849951425;3430;3463.4458486642015;3584.982075089608;9146.90853091474;9611;9638.614455421844;9638.90361096394;9743.561539730728;9678.128968392879;9679.70960871175;9692.273079519064;9710.514474276259;9724.270679699051;7331.706731730777;7352.63236838156;7390.334869861631;7399.630018499053;7403.481756277009;5121.61587880903;5165.793368265227;5169.893499597243;5171.741412929414;5465.699386533779;8628.482291062557;8749.125087491455;8758.167974042455;8834.734957951272;8926.196642301964;8460.365472589703;9028.413153145024;9048.321375896703;9052.456852588866;9194.35639505255;6061.575689701855;6241.843953901189;6722.865542689216;7079.469039821931;7091.858162836611;6824.18109826824;7041.190263119807;7070.080889484334;7274.636268186676;7293.7811865642;6637.103990961158;6697.564658297195;6739.19129704419;6879.828004299932;6880.65596720152;6544.214694236722;6819.651258790733;6910.481713871379;6928.1339832520935;6994.720211191496;5954.493868021266;6131.96934015327;6138.048602466625;6142.078688196806;6179.104029915727;4329;4414.426124603781;4508.098380323882;4541.886452838706;4605.332226827024;4415.735055896656;4424.690271680952;4574.108048930427;4631.143238500888;4681.250999840009 15:20:18 INFO - PROCESS | 19607 | |4;prototype.html;273.6778434979201;275.90603258081705;285.6186990367858;285.69145323051094;287.78272404334723;4599.999999999992;4755.31047998041;4798.4001999750035;4832;4834.5890599299055;4571.771411429432;4682.742449165295;4723.197056500395;4736.407949006374;4782.0196859643775;3538.7876727396438;3667.0832291927018;3698.445233215012;3721.237146384998;3757.943630845533;3609.8014609196484;3700.9259814803686;3704.1480459494333;3723.6834869036165;3751.1559899022636;3670.5228320318456;3671.6328367163205;3690.2066055798;3694.261147770443;3711.5731690855628;3699.8335074921692;3720.9999999999864;3722.9069273268115;3725;3738.2523495300775;3206.406814739281;3257.9348413031844;3258.1365938026443;3280.9494066208617;3293;4621.537846215385;4634.123180112027;4659.394278743775;4663.347131401607;4664.574421300905;4204.474440694913;4208.494980602317;4210.32634778437;4217.852375166885;4238.118079705799;4769;4929.92942963956;4944.8269310574315;4957;4957.727324997124;3444.534987776643;3462.740294477924;3466.532018177539;3480.9477857832153;3483.8083905385192;5222.242774797671;5249.133892907704;5259.842204733903;5262.868428289324;5275.815346462894;3453.9481907771406;3493.7597153010315;3512.5609298837644;3514.262004978983;3565.769809415747;3564.7185801087326;3568.0901370150964;3570.696490798311;3578.982105089458;3596.5324507813816;4118.402831589403;4129.132882094734;4143.834246630161;4144.79276036197;4170.47869016373;4586.472555656075;4725.1730947084125;4961.660351705092;4971.925421118686;4988.476209997971;1209.3167360441323;1231.1935682128042;1234.481587647199;1235.4008305971597;1235.4131787400913;760.3233122520961;773.8701495816059;797.4457751862516;800.9479383840148;801.6232370785722;3948.940765888514;3951.471058522548;3964.522173641474;3971.543272523639;3971.7219794614675;4479.708818926824;4498.3252512123445;4501.662375321864;4502.729836209773;4566.429196350457;3893.8637147699696;3906.5898080701686;3911.438008104696;3917.5298964124486;3920.725549211528;2307.4194176988817;2383.6210483038276;2395.6765836612185;2411.78293953545;2426.927192184202;4225.767582782976;4237.639800616982;4243.448351714257;4245.47394300397;4267.4025636410925;4506.372370241987;4512.34570987205;4536.886577835515;4591.8392856249875;4600.619814055837;4029.3150164472695;4235.4917409910395;4245.808938597709;4268.551802060801;4276.230278549829;4444.977775111104;4470.418845550058;4477.126960242721;4491.3487544306545;4499.550044995605;4418.7127836690515;4425.159219748238;4432.401625780479;4459.264221403432;4487.890691375049;4104.671626269951;4258.467691538558;4270.316749320218;4273.209456250604;4302.440682711353;3213.5661685672135;3218.468952622791;3228.9163848525072;3229.3864165808423;3249.5450636911323;4493.77531123436;4528.890421846669;4549.203889319422;4591.632669386508;4925.261210818263;4789.568938795525;4909.214525675875;4940.2342636891335;4976.377952755905;4977.253411988231;4928.6057115431395;4970.751462426936;4971.886948046993;4979.302897594413;4982.202847544376;4737.573618374363;4916.49258877982;4944.456109827845;4951.678140920829;4966.130927087817;5018.824341148043;5038.496150384932;5066.518680725325;5068.467810879952;5070.670406423571;4948.777305021355;4955.256711493161;4955.752212389438;4961.5534601886;4985.077760614298 15:20:18 INFO - PROCESS | 19607 | |5;yui.html;686.3479694290422;707.3386383731212;711.7259854955842;724.7246046502328;753.1218836977391;12454.886278430393;13722.45110195591;13757.65605859854;13771.931140344284;13833.515826946046;12793.296368699717;12906.870931290685;12940.74118517629;12943.22340659561;12946.093773435863;606.963582185068;621.0528943361387;746.8879668049782;755.6070843161552;769.9961500192492;767.3400875247282;773.4237992695449;775.2092865277414;775.7246177606925;776.0222120128623;827.0447632983913;829.4857188543082;830.887830142929;830.9418340716152;831.55096248026;631.4695655649231;647.9773207937747;801.5150833745616;819.2503858969036;821.4496287487398;587.1339773833604;591.3022633292713;591.7899145803221;592.6088781404295;594.5540844366725;13136.934315328363;13143.671408214776;13146.4084116215;13152.802707959388;13157.539486118036;13809.171449713049;14208.786868196985;14414;14420.92789536056;14487.420503179965;10270.9486452568;10315.484225788756;10445.875024159608;10537.104346130589;10549.367037977669;3234.87060517579;3242.124626350872;3242.9837850810595;3258.820764857932;3315.7678962472637;63797.68101159511;63946.482943438095;63994.04008939823;64281.67859160721;65081;10165.847512287322;10424.739381515523;10500.842487362695;10580.41807700584;10661.73345666349;20126.993650317425;20237.19051237934;20366.694499582518;21191.8940405297;21201.25795597147;6855.245922948472;6943.79168624942;7095.325944035309;7140;7209.387202087776;3581.4985901973746;3673.228621989412;3727.366347720894;3857.2092720992127;3857.3442514771996;3036.878524858981;3079;3080.7997480163717;3109.378719352519;3155.731762800188;496.3373895849082;498.2128237384923;502.708429111122;506.8656805946427;510.18879980830656;503.63486472307284;520.5627273090546;579.0705917003233;625.0717684238992;634.2484156274829;7801.45389822707;8260.339172866155;8412.747617571482;9185.77035574116;9256.7685807854;555.3225065420181;563.7547666764971;628.1927722876082;631.8799428108645;639.526750204845;3745.6254374562873;3855.7300988930506;4154;4154.120443740131;4299.1831552005015;100526;100785;101849.49075254577;101915.4904225489;101971;51486.74256628768;77251;83581.58209208916;85121;85847;73546.63226683832;74504.62747686227;76338.9999999989;78689;79674;7857.882131768142;8120.14738452454;8239.794005149919;8248.13394593559;8325.750227493185;44146.77926610346;44760;44848.32727509155;45540.544594553634;46378.76810615925;59446.405535945814;59599.40400595938;63709.36290637034;64423;65220.49964254171;10432.7396892079;10938.671839844817;11100.222984391015;11113.555457781598;11489.82765258505;11357.241925896311;11667.533298667959;11703.707407314885;11830.39487684366;11979.940100299442;10094.495275236355;10123.190144788252;10348.689539313833;10421.739456513647;10696;10392.324498907547;10409.739756506147;10734.19493537972;10852.891471085188;10905.509252083517;10537.841932371173;10682;10784.299020563953;11191.440427978405;11289.491972861406;8810.568285151747;8955.328350373618;9015.504147271962;9260.49067301305;9326.72019839406;9145.51037220095;9299;9309.67416140459;9400.482973436254;9653.372530785477 15:20:18 INFO - PROCESS | 19607 | __end_tp_report 15:20:18 INFO - PROCESS | 19607 | __start_cc_report 15:20:18 INFO - PROCESS | 19607 | _x_x_mozilla_cycle_collect,1075 15:20:18 INFO - PROCESS | 19607 | __end_cc_report 15:20:18 INFO - PROCESS | 19607 | __startTimestamp1476138018687__endTimestamp 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | ------- Summary: start ------- 15:20:18 INFO - PROCESS | 19607 | Number of tests: 6 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | [#0] dojo.html Cycles:165 Average:4595.05 Median:4710.81 stddev:477.03 (10.1%) stddev-sans-first:450.58 15:20:18 INFO - PROCESS | 19607 | Values: 2545.5 2555.1 2588.9 2599.7 2607.6 4530.2 4613.4 4641.7 4653.7 4663.7 4550.6 4593.6 4606.3 4656.8 4657.7 4264.8 4307.7 4325.0 4345.7 4382.9 4335.5 4378.9 4389.5 4389.7 4427.3 4347.8 4377.1 4393.4 4400.0 4435.6 4134.6 4179.5 4180.4 4202.3 4217.7 4197.6 4199.2 4208.0 4229.8 4331.1 4606.9 4620.4 4638.7 4661.4 4716.4 4828.6 4881.8 4941.9 4966.3 4990.0 4987.7 5008.7 5013.6 5021.5 5062.4 4649.5 4685.4 4685.4 4687.5 4700.8 4916.0 4959.9 5040.7 5076.2 5148.8 4884.9 4906.0 4907.8 4947.0 4956.6 4974.1 4980.7 4986.1 4991.3 5053.5 4809.6 4856.3 4926.9 4929.7 4997.4 4879.3 4892.3 4892.5 4892.7 4897.4 4170.3 4172.0 4199.0 4200.1 4224.2 3693.8 3736.8 3739.6 3782.8 3792.0 4252.2 4253.4 4257.1 4260.9 4301.7 4843.5 4849.6 4923.7 4962.9 5014.4 4230.4 4257.2 4260.6 4276.0 4320.7 4468.5 4469.9 4472.4 4477.9 4521.3 4555.9 4641.5 4642.5 4644.0 4694.3 4874.4 4955.3 5029.0 5031.0 5078.8 4720.7 4723.0 4728.3 4730.1 4790.0 4949.0 4955.0 4956.9 4958.7 5020.7 4839.2 4866.2 4961.2 4968.4 4995.4 4875.7 4881.2 4886.0 4929.7 4938.1 4833.0 4870.2 4874.4 4879.9 4935.2 4665.7 4710.8 4739.1 4745.1 4820.9 4869.1 4870.8 4881.2 4925.3 4934.9 4665.9 4691.7 4765.6 4780.6 4814.6 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | [#1] ext.html Cycles:180 Average:42958.45 Median:19003.34 stddev:77042.85 (405.4%) stddev-sans-first:77193.20 15:20:18 INFO - PROCESS | 19607 | Values: 558.4 576.5 578.0 580.7 585.0 27695.0 28397.4 30246.4 30312.7 37359.4 35661.0 39300.0 39303.0 39320.6 39362.6 7596.7 7791.5 7794.3 7795.0 7798.7 7642.9 7729.6 7735.4 7749.4 7756.0 7769.6 7810.6 7820.8 7825.3 7827.5 7758.8 7777.8 7788.1 7793.0 7796.1 7682.2 7732.1 7738.8 7741.8 7743.0 36805.0 36998.0 37134.0 37149.1 37159.8 3077.7 3098.6 3451.5 3606.9 3652.7 27989.0 28538.6 28593.9 28653.1 29680.6 3458.4 3522.7 3549.7 3677.5 3695.5 224843.0 225957.0 226476.0 227399.0 228420.0 31416.2 32267.7 32379.0 49970.0 50304.2 33036.8 33326.0 33367.3 33381.8 33400.7 13496.5 13621.8 13627.5 13641.4 13641.5 11505.4 11609.8 11614.7 11618.8 11623.6 7937.0 7943.2 7955.0 8046.6 8046.9 3099.8 3106.4 3114.8 3125.8 3146.8 798.5 861.5 889.4 895.1 913.3 25723.7 27465.9 27510.4 27605.4 27929.2 966.3 982.3 983.7 1014.3 1032.7 13493.0 14514.4 14608.8 14980.6 15722.2 334593.0 336137.0 337070.0 337582.0 338512.0 48982.5 49334.3 49387.8 49403.0 49420.8 1152.6 1171.5 1181.2 1181.5 1201.8 27060.5 28355.4 28502.4 28779.1 29109.6 41546.6 42013.8 42342.8 42344.0 42424.0 303452.0 303932.0 304440.0 304830.0 306049.0 24051.8 24293.7 25277.7 25296.4 26420.2 39745.0 40027.6 40468.6 40698.8 41179.0 34548.3 34966.3 35002.0 35393.8 35636.3 34442.7 34734.5 34894.3 35020.0 35074.6 26384.9 30533.8 35241.6 35315.3 35463.3 28417.7 30541.4 30626.8 30653.5 30730.8 24664.9 24985.0 25395.2 25503.0 25717.4 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | [#2] jquery.html Cycles:180 Average:22710.80 Median:5243.08 stddev:57310.56 (1093.1%) stddev-sans-first:57446.71 15:20:18 INFO - PROCESS | 19607 | Values: 336.8 348.7 359.3 359.7 377.3 12177.4 13194.9 15473.5 15709.1 15788.0 15978.4 16452.4 16734.0 17292.8 17459.7 4529.4 4957.9 5190.9 5191.7 5195.6 5619.2 5835.5 6033.0 6060.7 6069.1 5765.1 5948.3 5961.5 6017.9 6029.9 5961.3 5986.7 5996.7 5999.8 6000.9 5056.7 5179.6 5201.1 5202.9 5283.3 19902.2 20033.7 20129.9 20322.0 20337.2 1832.5 1930.0 2051.2 2158.0 2259.3 11821.6 11943.8 12044.3 12408.8 12601.1 1478.7 1496.8 1498.5 1523.1 1537.6 68196.0 68671.0 68791.3 69256.7 70097.3 8989.7 9036.8 9244.9 9478.5 9762.2 13287.0 13327.7 13328.3 13330.4 13332.5 6930.8 7160.7 7173.1 7194.6 7359.6 7017.7 7052.4 7059.6 7255.8 7299.9 5790.3 5835.1 5877.6 6037.4 6065.9 1593.8 1676.6 1680.7 1711.4 1719.1 861.0 864.3 883.4 912.0 960.4 16617.9 16951.2 17596.5 17840.6 18085.6 867.5 897.1 900.7 903.5 921.2 9580.0 10236.0 10269.6 10276.5 10292.4 345569.0 345828.0 347086.0 348159.0 348534.0 65424.7 65592.7 65843.0 67018.0 67594.0 885.9 929.2 948.3 954.5 955.3 11370.7 14500.0 15358.9 15538.5 16297.0 37469.8 37566.0 37755.4 37869.6 37987.6 46346.3 46514.5 48334.8 48663.5 49010.0 7106.4 7299.3 7457.4 7459.5 7625.3 10561.2 10885.9 11254.6 11332.9 11430.5 9693.0 9832.8 9834.0 9890.0 10080.5 9587.6 9738.0 9746.3 9752.2 9968.8 9485.3 9574.5 9939.7 10095.7 10160.5 7318.2 7322.6 7483.7 7513.0 7534.7 8887.0 9408.9 9503.1 9619.6 9690.4 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | [#3] mootools.html Cycles:180 Average:5065.17 Median:5051.70 stddev:2898.27 (57.4%) stddev-sans-first:2892.81 15:20:18 INFO - PROCESS | 19607 | Values: 1330.2 1373.7 1387.8 1597.0 1644.3 7436.9 8114.2 8121.3 8128.2 8140.0 6665.3 6930.9 7440.1 7670.7 8026.1 2106.6 2138.4 2139.1 2144.7 2155.6 2111.8 2142.7 2156.9 2161.1 2161.7 2127.1 2147.5 2150.5 2154.8 2163.6 2092.3 2094.3 2097.8 2099.0 2103.3 2041.0 2111.4 2112.4 2114.4 2114.5 7737.6 7789.0 7836.3 7844.7 7856.7 4356.8 4475.1 4480.7 4485.5 4496.1 2835.6 2926.4 2988.7 2992.6 3001.9 901.2 915.6 927.1 929.5 974.1 10544.9 10572.8 10578.0 10604.1 10624.6 3833.9 3951.8 4095.7 4128.4 4134.6 9128.3 9129.7 9131.5 9133.2 9141.5 4601.0 4610.4 4624.2 4626.1 4630.8 3781.1 3912.7 4099.9 4195.3 4197.1 3258.6 3285.2 3386.3 3394.8 3416.9 1150.2 1170.7 1172.8 1186.6 1190.9 719.5 757.2 809.0 832.9 835.7 4981.8 5128.8 5199.3 5203.4 5221.7 373.7 383.9 384.1 384.6 392.7 3382.2 3415.2 3430.0 3463.4 3585.0 9146.9 9611.0 9638.6 9638.9 9743.6 9678.1 9679.7 9692.3 9710.5 9724.3 7331.7 7352.6 7390.3 7399.6 7403.5 5121.6 5165.8 5169.9 5171.7 5465.7 8628.5 8749.1 8758.2 8834.7 8926.2 8460.4 9028.4 9048.3 9052.5 9194.4 6061.6 6241.8 6722.9 7079.5 7091.9 6824.2 7041.2 7070.1 7274.6 7293.8 6637.1 6697.6 6739.2 6879.8 6880.7 6544.2 6819.7 6910.5 6928.1 6994.7 5954.5 6132.0 6138.0 6142.1 6179.1 4329.0 4414.4 4508.1 4541.9 4605.3 4415.7 4424.7 4574.1 4631.1 4681.3 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | [#4] prototype.html Cycles:180 Average:3943.22 Median:4269.43 stddev:1151.88 (27.0%) stddev-sans-first:1121.70 15:20:18 INFO - PROCESS | 19607 | Values: 273.7 275.9 285.6 285.7 287.8 4600.0 4755.3 4798.4 4832.0 4834.6 4571.8 4682.7 4723.2 4736.4 4782.0 3538.8 3667.1 3698.4 3721.2 3757.9 3609.8 3700.9 3704.1 3723.7 3751.2 3670.5 3671.6 3690.2 3694.3 3711.6 3699.8 3721.0 3722.9 3725.0 3738.3 3206.4 3257.9 3258.1 3280.9 3293.0 4621.5 4634.1 4659.4 4663.3 4664.6 4204.5 4208.5 4210.3 4217.9 4238.1 4769.0 4929.9 4944.8 4957.0 4957.7 3444.5 3462.7 3466.5 3480.9 3483.8 5222.2 5249.1 5259.8 5262.9 5275.8 3453.9 3493.8 3512.6 3514.3 3565.8 3564.7 3568.1 3570.7 3579.0 3596.5 4118.4 4129.1 4143.8 4144.8 4170.5 4586.5 4725.2 4961.7 4971.9 4988.5 1209.3 1231.2 1234.5 1235.4 1235.4 760.3 773.9 797.4 800.9 801.6 3948.9 3951.5 3964.5 3971.5 3971.7 4479.7 4498.3 4501.7 4502.7 4566.4 3893.9 3906.6 3911.4 3917.5 3920.7 2307.4 2383.6 2395.7 2411.8 2426.9 4225.8 4237.6 4243.4 4245.5 4267.4 4506.4 4512.3 4536.9 4591.8 4600.6 4029.3 4235.5 4245.8 4268.6 4276.2 4445.0 4470.4 4477.1 4491.3 4499.6 4418.7 4425.2 4432.4 4459.3 4487.9 4104.7 4258.5 4270.3 4273.2 4302.4 3213.6 3218.5 3228.9 3229.4 3249.5 4493.8 4528.9 4549.2 4591.6 4925.3 4789.6 4909.2 4940.2 4976.4 4977.3 4928.6 4970.8 4971.9 4979.3 4982.2 4737.6 4916.5 4944.5 4951.7 4966.1 5018.8 5038.5 5066.5 5068.5 5070.7 4948.8 4955.3 4955.8 4961.6 4985.1 15:20:18 INFO - PROCESS | 19607 | 15:20:18 INFO - PROCESS | 19607 | [#5] yui.html Cycles:180 Average:17744.62 Median:497.28 stddev:25518.62 (5131.7%) stddev-sans-first:25558.06 15:20:18 INFO - PROCESS | 19607 | Values: 686.3 707.3 711.7 724.7 753.1 12454.9 13722.5 13757.7 13771.9 13833.5 12793.3 12906.9 12940.7 12943.2 12946.1 607.0 621.1 746.9 755.6 770.0 767.3 773.4 775.2 775.7 776.0 827.0 829.5 830.9 830.9 831.6 631.5 648.0 801.5 819.3 821.4 587.1 591.3 591.8 592.6 594.6 13136.9 13143.7 13146.4 13152.8 13157.5 13809.2 14208.8 14414.0 14420.9 14487.4 10270.9 10315.5 10445.9 10537.1 10549.4 3234.9 3242.1 3243.0 3258.8 3315.8 63797.7 63946.5 63994.0 64281.7 65081.0 10165.8 10424.7 10500.8 10580.4 10661.7 20127.0 20237.2 20366.7 21191.9 21201.3 6855.2 6943.8 7095.3 7140.0 7209.4 3581.5 3673.2 3727.4 3857.2 3857.3 3036.9 3079.0 3080.8 3109.4 3155.7 496.3 498.2 502.7 506.9 510.2 503.6 520.6 579.1 625.1 634.2 7801.5 8260.3 8412.7 9185.8 9256.8 555.3 563.8 628.2 631.9 639.5 3745.6 3855.7 4154.0 4154.1 4299.2 100526.0 100785.0 101849.5 101915.5 101971.0 51486.7 77251.0 83581.6 85121.0 85847.0 73546.6 74504.6 76339.0 78689.0 79674.0 7857.9 8120.1 8239.8 8248.1 8325.8 44146.8 44760.0 44848.3 45540.5 46378.8 59446.4 59599.4 63709.4 64423.0 65220.5 10432.7 10938.7 11100.2 11113.6 11489.8 11357.2 11667.5 11703.7 11830.4 11979.9 10094.5 10123.2 10348.7 10421.7 10696.0 10392.3 10409.7 10734.2 10852.9 10905.5 10537.8 10682.0 10784.3 11191.4 11289.5 8810.6 8955.3 9015.5 9260.5 9326.7 9145.5 9299.0 9309.7 9400.5 9653.4 15:20:18 INFO - PROCESS | 19607 | -------- Summary: end -------- 15:20:18 INFO - PROCESS | 19607 | 15:20:19 INFO - TEST-INFO | 19607: exit 0 15:20:19 INFO - TEST-OK | dromaeo_css | took 1122134ms 15:20:19 INFO - TEST-START | kraken 15:20:19 INFO - operating with platform_type : linux_ 15:20:19 INFO - Initialising browser for kraken test... 15:20:19 INFO - TEST-INFO | started process 19917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7j5Zo/profile http://localhost:49625/getInfo.html) 15:20:24 INFO - PROCESS | 19917 | __metrics Screen width/height:1600/1200 15:20:24 INFO - PROCESS | 19917 | colorDepth:24 15:20:24 INFO - PROCESS | 19917 | Browser inner width/height: 1024/697 15:20:24 INFO - PROCESS | 19917 | __metrics 15:20:24 INFO - PROCESS | 19917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:20:24 INFO - PROCESS | 19917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:25 INFO - PROCESS | 19917 | console.error: PushService: 15:20:25 INFO - PROCESS | 19917 | stateChangeProcessEnqueue: Error transitioning state 15:20:25 INFO - PROCESS | 19917 | UnknownError 15:20:26 INFO - TEST-INFO | 19917: exit 0 15:20:26 INFO - Browser initialized. 15:20:26 INFO - Running cycle 1/1 for kraken test... 15:20:26 INFO - TEST-INFO | started process 19999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7j5Zo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:38 INFO - PROCESS | 19999 | RSS: Main: 174403584 15:20:38 INFO - PROCESS | 19999 | 15:20:41 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-beat-detection) 15:20:42 INFO - PROCESS | 19999 | RSS: Main: 241500160 15:20:42 INFO - PROCESS | 19999 | 15:20:45 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-dft) 15:20:45 INFO - PROCESS | 19999 | RSS: Main: 217993216 15:20:45 INFO - PROCESS | 19999 | 15:20:49 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-fft) 15:20:49 INFO - PROCESS | 19999 | RSS: Main: 300343296 15:20:49 INFO - PROCESS | 19999 | 15:20:51 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-oscillator) 15:20:52 INFO - PROCESS | 19999 | RSS: Main: 208412672 15:20:52 INFO - PROCESS | 19999 | 15:20:54 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:20:55 INFO - PROCESS | 19999 | RSS: Main: 213774336 15:20:55 INFO - PROCESS | 19999 | 15:20:58 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-darkroom) 15:20:59 INFO - PROCESS | 19999 | RSS: Main: 249540608 15:20:59 INFO - PROCESS | 19999 | 15:21:02 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:03 INFO - PROCESS | 19999 | RSS: Main: 243994624 15:21:03 INFO - PROCESS | 19999 | 15:21:06 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49625/tests/kraken/driver.html?testName=json-parse-financial) 15:21:06 INFO - PROCESS | 19999 | RSS: Main: 246784000 15:21:06 INFO - PROCESS | 19999 | 15:21:08 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:09 INFO - PROCESS | 19999 | RSS: Main: 209932288 15:21:09 INFO - PROCESS | 19999 | 15:21:10 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:11 INFO - PROCESS | 19999 | RSS: Main: 217415680 15:21:11 INFO - PROCESS | 19999 | 15:21:13 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:14 INFO - PROCESS | 19999 | RSS: Main: 227090432 15:21:14 INFO - PROCESS | 19999 | 15:21:17 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:17 INFO - PROCESS | 19999 | RSS: Main: 235106304 15:21:17 INFO - PROCESS | 19999 | 15:21:20 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:21 INFO - PROCESS | 19999 | RSS: Main: 231718912 15:21:21 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49625/tests/kraken/driver.html?testName=ai-astar) 15:21:23 INFO - PROCESS | 19999 | RSS: Main: 282624000 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | __start_tp_report 15:21:23 INFO - PROCESS | 19999 | _x_x_mozilla_page_load 15:21:23 INFO - PROCESS | 19999 | _x_x_mozilla_page_load_details 15:21:23 INFO - PROCESS | 19999 | |i|pagename|runs| 15:21:23 INFO - PROCESS | 19999 | |0;ai-astar;112;115;113;115;115;115;113;114;113;114 15:21:23 INFO - PROCESS | 19999 | |1;audio-beat-detection;153;127;131;167;132;131;128;138;173;126 15:21:23 INFO - PROCESS | 19999 | |2;audio-dft;160;160;162;162;161;164;162;163;162;160 15:21:23 INFO - PROCESS | 19999 | |3;audio-fft;76;76;76;124;77;77;76;75;101;76 15:21:23 INFO - PROCESS | 19999 | |4;audio-oscillator;84;84;112;83;85;84;104;84;84;119 15:21:23 INFO - PROCESS | 19999 | |5;imaging-gaussian-blur;117;117;117;116;117;116;118;117;116;117 15:21:23 INFO - PROCESS | 19999 | |6;imaging-darkroom;147;147;148;148;148;148;148;148;148;147 15:21:23 INFO - PROCESS | 19999 | |7;imaging-desaturate;95;94;95;94;94;95;94;95;95;95 15:21:23 INFO - PROCESS | 19999 | |8;json-parse-financial;65;64;66;63;63;64;64;64;64;64 15:21:23 INFO - PROCESS | 19999 | |9;json-stringify-tinderbox;66;67;66;66;66;65;66;71;67;66 15:21:23 INFO - PROCESS | 19999 | |10;stanford-crypto-aes;84;93;86;84;87;83;83;83;85;83 15:21:23 INFO - PROCESS | 19999 | |11;stanford-crypto-ccm;150;140;143;137;142;140;137;148;184;140 15:21:23 INFO - PROCESS | 19999 | |12;stanford-crypto-pbkdf2;177;175;180;179;184;177;176;174;175;174 15:21:23 INFO - PROCESS | 19999 | |13;stanford-crypto-sha256-iterative;73;70;72;70;74;71;69;70;73;68 15:21:23 INFO - PROCESS | 19999 | __end_tp_report 15:21:23 INFO - PROCESS | 19999 | __start_cc_report 15:21:23 INFO - PROCESS | 19999 | _x_x_mozilla_cycle_collect,1960 15:21:23 INFO - PROCESS | 19999 | __end_cc_report 15:21:23 INFO - PROCESS | 19999 | __startTimestamp1476138083614__endTimestamp 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | ------- Summary: start ------- 15:21:23 INFO - PROCESS | 19999 | Number of tests: 14 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.10 (1.0%) stddev-sans-first:0.93 15:21:23 INFO - PROCESS | 19999 | Values: 112.0 115.0 113.0 115.0 115.0 115.0 113.0 114.0 113.0 114.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:135.00 stddev:17.39 (12.9%) stddev-sans-first:17.86 15:21:23 INFO - PROCESS | 19999 | Values: 153.0 127.0 131.0 167.0 132.0 131.0 128.0 138.0 173.0 126.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.30 15:21:23 INFO - PROCESS | 19999 | Values: 160.0 160.0 162.0 162.0 161.0 164.0 162.0 163.0 162.0 160.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:16.28 (21.4%) stddev-sans-first:17.04 15:21:23 INFO - PROCESS | 19999 | Values: 76.0 76.0 76.0 124.0 77.0 77.0 76.0 75.0 101.0 76.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:84.00 stddev:13.83 (16.5%) stddev-sans-first:14.34 15:21:23 INFO - PROCESS | 19999 | Values: 84.0 84.0 112.0 83.0 85.0 84.0 104.0 84.0 84.0 119.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 15:21:23 INFO - PROCESS | 19999 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 118.0 117.0 116.0 117.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 15:21:23 INFO - PROCESS | 19999 | Values: 147.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:21:23 INFO - PROCESS | 19999 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 15:21:23 INFO - PROCESS | 19999 | Values: 65.0 64.0 66.0 63.0 63.0 64.0 64.0 64.0 64.0 64.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.73 15:21:23 INFO - PROCESS | 19999 | Values: 66.0 67.0 66.0 66.0 66.0 65.0 66.0 71.0 67.0 66.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:3.11 (3.7%) stddev-sans-first:3.27 15:21:23 INFO - PROCESS | 19999 | Values: 84.0 93.0 86.0 84.0 87.0 83.0 83.0 83.0 85.0 83.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:142.50 stddev:13.98 (9.8%) stddev-sans-first:14.76 15:21:23 INFO - PROCESS | 19999 | Values: 150.0 140.0 143.0 137.0 142.0 140.0 137.0 148.0 184.0 140.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:177.00 stddev:3.14 (1.8%) stddev-sans-first:3.33 15:21:23 INFO - PROCESS | 19999 | Values: 177.0 175.0 180.0 179.0 184.0 177.0 176.0 174.0 175.0 174.0 15:21:23 INFO - PROCESS | 19999 | 15:21:23 INFO - PROCESS | 19999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.50 stddev:1.94 (2.7%) stddev-sans-first:1.92 15:21:23 INFO - PROCESS | 19999 | Values: 73.0 70.0 72.0 70.0 74.0 71.0 69.0 70.0 73.0 68.0 15:21:23 INFO - PROCESS | 19999 | -------- Summary: end -------- 15:21:23 INFO - PROCESS | 19999 | 15:21:24 INFO - TEST-INFO | 19999: exit 0 15:21:24 INFO - TEST-OK | kraken | took 65182ms 15:21:24 INFO - SUITE-END | took 1187s 15:21:25 INFO - Completed test suite (00:19:47) 15:21:25 INFO - javascript benchmark 15:21:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2545.5163518931404, 2555.092942005589, 2588.935276618085, 2599.7010343810466, 2607.5827867541198, 4530.184566777979, 4613.400257966459, 4641.744704041276, 4653.720776753393, 4663.696859704117, 4550.567696068876, 4593.609543188824, 4606.262997920333, 4656.813727450898, 4657.743824089674, 4264.786760661962, 4307.67692423068, 4324.956750432487, 4345.717528360647, 4382.9342559861625, 4335.523092459827, 4378.912421751563, 4389.4513185851765, 4389.714668546534, 4427.269500532424, 4347.804348804311, 4377.080813029252, 4393.406890069831, 4400.031992961543, 4435.600795928366, 4134.586541345871, 4179.477565304337, 4180.435641188431, 4202.2646036943415, 4217.683673724452, 4197.601227883346, 4199.181159673864, 4208.032152604887, 4229.830806767725, 4331.090471001094, 4606.861794146181, 4620.445546534404, 4638.67529272951, 4661.394018777537, 4716.38686970695, 4828.637852161102, 4881.780319885614, 4941.851744447672, 4966.255061740731, 4989.950100499022, 4987.650864439491, 5008.749562521859, 5013.598912087061, 5021.548060674557, 5062.417821950486, 4649.488556258842, 4685.4143232095985, 4685.437747470257, 4687.460941991646, 4700.811967521329, 4915.9508404916205, 4959.851204463872, 5040.697558146523, 5076.238564215398, 5148.794048238028, 4884.926726099111, 4905.950940490621, 4907.754612269372, 4946.950530494721, 4956.603471722254, 4974.0797952378925, 4980.676256043345, 4986.127427700138, 4991.326170966873, 5053.494650534917, 4809.591184749265, 4856.3201151838775, 4926.852194434173, 4929.728864912393, 4997.400311962588, 4879.316895634614, 4892.315075889378, 4892.535209155125, 4892.706437613683, 4897.3878265216845, 4170.291050521419, 4171.958280417157, 4199.0342221289275, 4200.05498762782, 4224.218519573888, 3693.833777479966, 3736.813159342022, 3739.5886452490204, 3782.829772660237, 3792.0, 4252.234597772369, 4253.447051883235, 4257.148570285955, 4260.850870219528, 4301.741895486281, 4843.515648435199, 4849.58778503824, 4923.679960802537, 4962.851114466572, 5014.373203349582, 4230.386593943861, 4257.233697934402, 4260.55264197261, 4275.978620106879, 4320.740755554614, 4468.530804265505, 4469.932951005738, 4472.44094488189, 4477.932831007537, 4521.299198624219, 4555.908881822279, 4641.466231383434, 4642.46611639659, 4643.976780116078, 4694.319323698045, 4874.4150701916, 4955.2567114933045, 5028.974855125701, 5031.0, 5078.847634570969, 4720.693154944917, 4722.952770472251, 4728.3380326753595, 4730.124926888537, 4789.95210047895, 4948.950510494993, 4955.0, 4956.900861982668, 4958.677685950402, 5020.748962551931, 4839.225723884161, 4866.221404575251, 4961.231009193581, 4968.378952630921, 4995.425526064404, 4875.7074575525585, 4881.194602890483, 4886.0, 4929.728864912464, 4938.1358262304675, 4833.0, 4870.245112007645, 4874.366332376769, 4879.853604391874, 4935.161022626234, 4665.696729712694, 4710.81156753726, 4739.123262196505, 4745.098431298043, 4820.903581928412, 4869.074875773592, 4870.7808148632685, 4881.194602890483, 4925.310456536016, 4934.901301974012, 4665.930011049905, 4691.7184968901975, 4765.5949244314625, 4780.593649539828, 4814.5907597853175], "value": 4564.609330400093, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.3578884283074, 576.4898065212286, 577.9711014449276, 580.6951350540966, 585.0200913469939, 27695.0, 28397.432051358985, 30246.395072098545, 30312.696873031262, 37359.4396084059, 35661.0, 39300.0, 39303.0, 39320.60679393205, 39362.60637393625, 7596.658150383232, 7791.532508049507, 7794.259545343183, 7795.0, 7798.688052477923, 7642.9235707642765, 7729.574873381962, 7735.419843511759, 7749.380049596047, 7756.0, 7769.611519424035, 7810.648520816577, 7820.80447988802, 7825.334846538022, 7827.491213071161, 7758.8448231035345, 7777.805554861117, 7788.0654321481215, 7793.0, 7796.14242433329, 7682.1549629540705, 7732.072151341818, 7738.833126724526, 7741.806454838617, 7742.961285193594, 36805.0, 36998.0, 37134.0, 37149.07127321839, 37159.81420092909, 3077.707617776308, 3098.5971823663003, 3451.4995325677887, 3606.8737594184076, 3652.6529979652155, 27989.0, 28538.571921421197, 28593.85703071492, 28653.13468653118, 29680.554791678143, 3458.3774920514297, 3522.6653467920505, 3549.733769967237, 3677.5035370224946, 3695.5380577427823, 224843.0, 225957.0, 226476.0, 227399.0, 228420.0, 31416.214594635316, 32267.677323226937, 32379.00988317169, 49970.0, 50304.24543631849, 33036.834815826245, 33326.00373809375, 33367.33265334728, 33381.83309083439, 33400.659934006406, 13496.460141594227, 13621.795673064911, 13627.456861215956, 13641.386137623633, 13641.454341826415, 11505.367204803817, 11609.76780464386, 11614.6515604532, 11618.76762464763, 11623.59317423886, 7937.0, 7943.165967573437, 7954.960225198837, 8046.597670116471, 8046.919530804617, 3099.8450077496036, 3106.39425312062, 3114.78196526241, 3125.812451252932, 3146.7954582952034, 798.5089170160426, 861.5347712235448, 889.439653018607, 895.0780695883251, 913.3287034029983, 25723.74276257251, 27465.862670686918, 27510.449791004066, 27605.447891042066, 27929.162125136278, 966.3477152921749, 982.3221976835961, 983.6655537117415, 1014.2595904989399, 1032.746976990642, 13493.0, 14514.419423223164, 14608.780868286984, 14980.62548436276, 15722.213889305718, 334593.0, 336137.0, 337070.0, 337582.0, 338512.0, 48982.5101748978, 49334.25998610024, 49387.75306123446, 49403.0, 49420.75289623529, 1152.6311580294225, 1171.5079666540073, 1181.2381014245764, 1181.5214837990457, 1201.8257352683986, 27060.45879082368, 28355.43289134247, 28502.42995140127, 28779.136625901258, 29109.563356549246, 41546.58453415548, 42013.78993105015, 42342.78828605837, 42344.0, 42424.0, 303452.0, 303932.0, 304440.0, 304830.0, 306049.0, 24051.75948240565, 24293.663848487795, 25277.747222527538, 25296.36759080964, 26420.20739377822, 39745.0, 40027.59972400355, 40468.59531404766, 40698.79650601728, 41179.0, 34548.30903381868, 34966.30067398587, 35002.0, 35393.82303088571, 35636.287274254886, 34442.655573443946, 34734.47898281578, 34894.30211395809, 35020.0, 35074.649253508156, 26384.868075660266, 30533.847330763205, 35241.64758352384, 35315.29369412546, 35463.29073418466, 28417.715822842332, 30541.42061919256, 30626.84686576553, 30653.54019689751, 30730.84634576813, 24664.876675617226, 24985.0, 25395.238142855746, 25503.0, 25717.35706607275], "value": 15994.159073152243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7558520072946, 348.6774733371629, 359.2688878133, 359.72660777808863, 377.28881059203394, 12177.391130443475, 13194.868051319496, 15473.535793926172, 15709.135997520132, 15788.0, 15978.360865565364, 16452.42416515422, 16733.995960242362, 17292.82707172928, 17459.738103928452, 4529.388532548097, 4957.925631115527, 5190.948090519103, 5191.662541934762, 5195.610329225305, 5619.241402410684, 5835.474807267345, 6033.0, 6060.696965151747, 6069.059295809135, 5765.077587585987, 5948.345681974979, 5961.5230781537375, 6017.939820601781, 6029.879402411949, 5961.344252132262, 5986.700664966735, 5996.700164991777, 5999.76000959961, 6000.879982400327, 5056.721880296583, 5179.61152913533, 5201.08980928336, 5202.895942081137, 5283.260343551906, 19902.20391184351, 20033.699494507593, 20129.899350503154, 20322.0, 20337.18651253948, 1832.5418645338666, 1930.0253372047166, 2051.2307884543297, 2157.996531612792, 2259.26573863495, 11821.586244481401, 11943.820842687366, 12044.337561434118, 12408.75182496354, 12601.117921745481, 1478.6525166585843, 1496.8128983877016, 1498.48302335694, 1523.1470376589034, 1537.6309685675358, 68196.0, 68671.0, 68791.3120868795, 69256.6537167316, 70097.29902700908, 8989.685361012464, 9036.81926361469, 9244.8613270801, 9478.478683672463, 9762.170215531618, 13287.0, 13327.73344533104, 13328.2669453181, 13330.400131994083, 13332.533361332307, 6930.792076237721, 7160.749373771997, 7173.067501224912, 7194.604296763729, 7359.558426494427, 7017.684204210823, 7052.365287124184, 7059.647017649097, 7255.782326530212, 7299.89050164248, 5790.334111577138, 5835.124731290255, 5877.617954832922, 6037.366076561985, 6065.908136535466, 1593.7768712380275, 1676.555712736126, 1680.7142785726455, 1711.4095637005214, 1719.0888828920442, 860.9956950215334, 864.3085531574715, 883.3551507399634, 911.981760364789, 960.4141473701037, 16617.91691041537, 16951.237194326284, 17596.47210583659, 17840.643187136186, 18085.638287234182, 867.509856930832, 897.0580890065405, 900.7297810656777, 903.5256490342491, 921.161742814036, 9580.041995800504, 10236.0, 10269.589216431408, 10276.486175691334, 10292.39881931113, 345569.0, 345828.0, 347086.0, 348159.0, 348534.0, 65424.67287663531, 65592.67203663952, 65843.0, 67018.0, 67594.0, 885.8936927568604, 929.2473096791621, 948.3029972969999, 954.5322791832091, 955.302629080775, 11370.658880233606, 14500.0, 15358.923205383902, 15538.533843984698, 16297.0, 37469.81265093657, 37566.0, 37755.44755606917, 37869.62130378661, 37987.620123798406, 46346.30480542862, 46514.53485465102, 48334.758326208146, 48663.513364865896, 49010.0, 7106.431485481253, 7299.270072992871, 7457.440691948017, 7459.515131516651, 7625.313721765067, 10561.207909406672, 10885.891141088488, 11254.60608878718, 11332.886671133512, 11430.542778289107, 9693.0, 9832.836775909289, 9834.0, 9889.950550247202, 10080.546375412978, 9587.568559414982, 9737.955029443896, 9746.26902982265, 9752.219822414048, 9968.800623987625, 9485.288603354915, 9574.521273936414, 9939.65211217604, 10095.697129086138, 10160.491975401348, 7318.1949985502615, 7322.560646361022, 7483.66323515454, 7513.0, 7534.736284230025, 8887.0, 9408.905910940803, 9503.144716975505, 9619.615215391306, 9690.37012594179], "value": 8167.939787604863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.1553513518916, 1373.6840526678864, 1387.8473367929525, 1596.9760453593206, 1644.3422630947618, 7436.851262974744, 8114.229148230916, 8121.309688676462, 8128.227818357262, 8139.959300203505, 6665.333466653332, 6930.861382772354, 7440.144383395911, 7670.693172273116, 8026.07700114487, 2106.5892151030516, 2138.4012476506605, 2139.12295958657, 2144.667576525641, 2155.5904378168175, 2111.767705552388, 2142.73215848019, 2156.924507642233, 2161.070739581979, 2161.729783777028, 2127.1385089038886, 2147.527543940331, 2150.5376344086017, 2154.7845215478483, 2163.556470923457, 2092.2677063027973, 2094.3402828109097, 2097.769245383014, 2098.9790102098937, 2103.2638576498257, 2040.9693854592044, 2111.3876975677035, 2112.355731501891, 2114.407965769587, 2114.4925217947734, 7737.57443340616, 7789.0, 7836.333911617519, 7844.725434609818, 7856.725014624518, 4356.803943822536, 4475.10497900418, 4480.731156130642, 4485.484169320504, 4496.123255965088, 2835.5604881243235, 2926.4293462774767, 2988.6861879502558, 2992.640883094021, 3001.9099427017222, 901.1799262670938, 915.6337465013982, 927.0636656976435, 929.5352323838081, 974.0794948773412, 10544.947275263652, 10572.841407378895, 10578.0, 10604.098651614622, 10624.575016999388, 3833.9424908625833, 3951.78265195417, 4095.672346212296, 4128.3601041838565, 4134.607212314825, 9128.315376346667, 9129.726108216764, 9131.452112873249, 9133.223675987483, 9141.54292285383, 4600.95399046012, 4610.446746390455, 4624.190766615829, 4626.1441633297945, 4630.83792067276, 3781.149241420713, 3912.68698504119, 4099.877003689894, 4195.265828480004, 4197.076643138505, 3258.5926759155104, 3285.227971426713, 3386.255023894739, 3394.762366634361, 3416.914577135542, 1150.1603829204728, 1170.6839153428527, 1172.7947609168532, 1186.6202815099086, 1190.9404529773476, 719.5179229915968, 757.1671161722172, 808.9878651820227, 832.8542505061711, 835.7283882738135, 4981.775820088033, 5128.79484820603, 5199.324087868553, 5203.386950045422, 5221.738913054332, 373.66556931546114, 383.86372837642796, 384.0877914951989, 384.6403612622207, 392.73490393983946, 3382.2389962258785, 3415.1632849951425, 3430.0, 3463.4458486642015, 3584.982075089608, 9146.90853091474, 9611.0, 9638.614455421844, 9638.90361096394, 9743.561539730728, 9678.128968392879, 9679.70960871175, 9692.273079519064, 9710.514474276259, 9724.270679699051, 7331.706731730777, 7352.63236838156, 7390.334869861631, 7399.630018499053, 7403.481756277009, 5121.61587880903, 5165.793368265227, 5169.893499597243, 5171.741412929414, 5465.699386533779, 8628.482291062557, 8749.125087491455, 8758.167974042455, 8834.734957951272, 8926.196642301964, 8460.365472589703, 9028.413153145024, 9048.321375896703, 9052.456852588866, 9194.35639505255, 6061.575689701855, 6241.843953901189, 6722.865542689216, 7079.469039821931, 7091.858162836611, 6824.18109826824, 7041.190263119807, 7070.080889484334, 7274.636268186676, 7293.7811865642, 6637.103990961158, 6697.564658297195, 6739.19129704419, 6879.828004299932, 6880.65596720152, 6544.214694236722, 6819.651258790733, 6910.481713871379, 6928.1339832520935, 6994.720211191496, 5954.493868021266, 6131.96934015327, 6138.048602466625, 6142.078688196806, 6179.104029915727, 4329.0, 4414.426124603781, 4508.098380323882, 4541.886452838706, 4605.332226827024, 4415.735055896656, 4424.690271680952, 4574.108048930427, 4631.143238500888, 4681.250999840009], "value": 3987.0643770922743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.6778434979201, 275.90603258081705, 285.6186990367858, 285.69145323051094, 287.78272404334723, 4599.999999999992, 4755.31047998041, 4798.4001999750035, 4832.0, 4834.5890599299055, 4571.771411429432, 4682.742449165295, 4723.197056500395, 4736.407949006374, 4782.0196859643775, 3538.7876727396438, 3667.0832291927018, 3698.445233215012, 3721.237146384998, 3757.943630845533, 3609.8014609196484, 3700.9259814803686, 3704.1480459494333, 3723.6834869036165, 3751.1559899022636, 3670.5228320318456, 3671.6328367163205, 3690.2066055798, 3694.261147770443, 3711.5731690855628, 3699.8335074921692, 3720.9999999999864, 3722.9069273268115, 3725.0, 3738.2523495300775, 3206.406814739281, 3257.9348413031844, 3258.1365938026443, 3280.9494066208617, 3293.0, 4621.537846215385, 4634.123180112027, 4659.394278743775, 4663.347131401607, 4664.574421300905, 4204.474440694913, 4208.494980602317, 4210.32634778437, 4217.852375166885, 4238.118079705799, 4769.0, 4929.92942963956, 4944.8269310574315, 4957.0, 4957.727324997124, 3444.534987776643, 3462.740294477924, 3466.532018177539, 3480.9477857832153, 3483.8083905385192, 5222.242774797671, 5249.133892907704, 5259.842204733903, 5262.868428289324, 5275.815346462894, 3453.9481907771406, 3493.7597153010315, 3512.5609298837644, 3514.262004978983, 3565.769809415747, 3564.7185801087326, 3568.0901370150964, 3570.696490798311, 3578.982105089458, 3596.5324507813816, 4118.402831589403, 4129.132882094734, 4143.834246630161, 4144.79276036197, 4170.47869016373, 4586.472555656075, 4725.1730947084125, 4961.660351705092, 4971.925421118686, 4988.476209997971, 1209.3167360441323, 1231.1935682128042, 1234.481587647199, 1235.4008305971597, 1235.4131787400913, 760.3233122520961, 773.8701495816059, 797.4457751862516, 800.9479383840148, 801.6232370785722, 3948.940765888514, 3951.471058522548, 3964.522173641474, 3971.543272523639, 3971.7219794614675, 4479.708818926824, 4498.3252512123445, 4501.662375321864, 4502.729836209773, 4566.429196350457, 3893.8637147699696, 3906.5898080701686, 3911.438008104696, 3917.5298964124486, 3920.725549211528, 2307.4194176988817, 2383.6210483038276, 2395.6765836612185, 2411.78293953545, 2426.927192184202, 4225.767582782976, 4237.639800616982, 4243.448351714257, 4245.47394300397, 4267.4025636410925, 4506.372370241987, 4512.34570987205, 4536.886577835515, 4591.8392856249875, 4600.619814055837, 4029.3150164472695, 4235.4917409910395, 4245.808938597709, 4268.551802060801, 4276.230278549829, 4444.977775111104, 4470.418845550058, 4477.126960242721, 4491.3487544306545, 4499.550044995605, 4418.7127836690515, 4425.159219748238, 4432.401625780479, 4459.264221403432, 4487.890691375049, 4104.671626269951, 4258.467691538558, 4270.316749320218, 4273.209456250604, 4302.440682711353, 3213.5661685672135, 3218.468952622791, 3228.9163848525072, 3229.3864165808423, 3249.5450636911323, 4493.77531123436, 4528.890421846669, 4549.203889319422, 4591.632669386508, 4925.261210818263, 4789.568938795525, 4909.214525675875, 4940.2342636891335, 4976.377952755905, 4977.253411988231, 4928.6057115431395, 4970.751462426936, 4971.886948046993, 4979.302897594413, 4982.202847544376, 4737.573618374363, 4916.49258877982, 4944.456109827845, 4951.678140920829, 4966.130927087817, 5018.824341148043, 5038.496150384932, 5066.518680725325, 5068.467810879952, 5070.670406423571, 4948.777305021355, 4955.256711493161, 4955.752212389438, 4961.5534601886, 4985.077760614298], "value": 3576.6012787756395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.3479694290422, 707.3386383731212, 711.7259854955842, 724.7246046502328, 753.1218836977391, 12454.886278430393, 13722.45110195591, 13757.65605859854, 13771.931140344284, 13833.515826946046, 12793.296368699717, 12906.870931290685, 12940.74118517629, 12943.22340659561, 12946.093773435863, 606.963582185068, 621.0528943361387, 746.8879668049782, 755.6070843161552, 769.9961500192492, 767.3400875247282, 773.4237992695449, 775.2092865277414, 775.7246177606925, 776.0222120128623, 827.0447632983913, 829.4857188543082, 830.887830142929, 830.9418340716152, 831.55096248026, 631.4695655649231, 647.9773207937747, 801.5150833745616, 819.2503858969036, 821.4496287487398, 587.1339773833604, 591.3022633292713, 591.7899145803221, 592.6088781404295, 594.5540844366725, 13136.934315328363, 13143.671408214776, 13146.4084116215, 13152.802707959388, 13157.539486118036, 13809.171449713049, 14208.786868196985, 14414.0, 14420.92789536056, 14487.420503179965, 10270.9486452568, 10315.484225788756, 10445.875024159608, 10537.104346130589, 10549.367037977669, 3234.87060517579, 3242.124626350872, 3242.9837850810595, 3258.820764857932, 3315.7678962472637, 63797.68101159511, 63946.482943438095, 63994.04008939823, 64281.67859160721, 65081.0, 10165.847512287322, 10424.739381515523, 10500.842487362695, 10580.41807700584, 10661.73345666349, 20126.993650317425, 20237.19051237934, 20366.694499582518, 21191.8940405297, 21201.25795597147, 6855.245922948472, 6943.79168624942, 7095.325944035309, 7140.0, 7209.387202087776, 3581.4985901973746, 3673.228621989412, 3727.366347720894, 3857.2092720992127, 3857.3442514771996, 3036.878524858981, 3079.0, 3080.7997480163717, 3109.378719352519, 3155.731762800188, 496.3373895849082, 498.2128237384923, 502.708429111122, 506.8656805946427, 510.18879980830656, 503.63486472307284, 520.5627273090546, 579.0705917003233, 625.0717684238992, 634.2484156274829, 7801.45389822707, 8260.339172866155, 8412.747617571482, 9185.77035574116, 9256.7685807854, 555.3225065420181, 563.7547666764971, 628.1927722876082, 631.8799428108645, 639.526750204845, 3745.6254374562873, 3855.7300988930506, 4154.0, 4154.120443740131, 4299.1831552005015, 100526.0, 100785.0, 101849.49075254577, 101915.4904225489, 101971.0, 51486.74256628768, 77251.0, 83581.58209208916, 85121.0, 85847.0, 73546.63226683832, 74504.62747686227, 76338.9999999989, 78689.0, 79674.0, 7857.882131768142, 8120.14738452454, 8239.794005149919, 8248.13394593559, 8325.750227493185, 44146.77926610346, 44760.0, 44848.32727509155, 45540.544594553634, 46378.76810615925, 59446.405535945814, 59599.40400595938, 63709.36290637034, 64423.0, 65220.49964254171, 10432.7396892079, 10938.671839844817, 11100.222984391015, 11113.555457781598, 11489.82765258505, 11357.241925896311, 11667.533298667959, 11703.707407314885, 11830.39487684366, 11979.940100299442, 10094.495275236355, 10123.190144788252, 10348.689539313833, 10421.739456513647, 10696.0, 10392.324498907547, 10409.739756506147, 10734.19493537972, 10852.891471085188, 10905.509252083517, 10537.841932371173, 10682.0, 10784.299020563953, 11191.440427978405, 11289.491972861406, 8810.568285151747, 8955.328350373618, 9015.504147271962, 9260.49067301305, 9326.72019839406, 9145.51037220095, 9299.0, 9309.67416140459, 9400.482973436254, 9653.372530785477], "value": 6510.880638216586, "unit": "score"}], "name": "dromaeo_css", "value": 6173.743510726601, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 113.0, 115.0, 115.0, 115.0, 113.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 131.0, 167.0, 132.0, 131.0, 128.0, 138.0, 173.0, 126.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 164.0, 162.0, 163.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 124.0, 77.0, 77.0, 76.0, 75.0, 101.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 83.0, 85.0, 84.0, 104.0, 84.0, 84.0, 119.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 71.0, 67.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 86.0, 84.0, 87.0, 83.0, 83.0, 83.0, 85.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 140.0, 143.0, 137.0, 142.0, 140.0, 137.0, 148.0, 184.0, 140.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 180.0, 179.0, 184.0, 177.0, 176.0, 174.0, 175.0, 174.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 72.0, 70.0, 74.0, 71.0, 69.0, 70.0, 73.0, 68.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1560.8999999999996, "alertThreshold": 2.0}]} 15:21:25 INFO - Return code: 0 15:21:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:21:25 INFO - # TBPL SUCCESS # 15:21:25 INFO - Running post-action listener: _resource_record_post_action 15:21:25 INFO - [mozharness: 2016-10-10 22:21:25.409453Z] Finished run-tests step (success) 15:21:25 INFO - Running post-run listener: _resource_record_post_run 15:21:25 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 401096704; Read time: 0; Write time: 276208 15:21:25 INFO - TinderboxPrint: CPU usage
13.1% 15:21:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:21:25 INFO - TinderboxPrint: I/O write bytes / time
401,096,704 / 276,208 15:21:25 INFO - TinderboxPrint: CPU idle
8,345.4 (86.9%) 15:21:25 INFO - TinderboxPrint: CPU user
1,211.2 (12.6%) 15:21:25 INFO - TinderboxPrint: Swap in / out
0 / 0 15:21:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99917824; Read time: 0; Write time: 94140 15:21:25 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289775616; Read time: 0; Write time: 179484 15:21:26 INFO - Running post-run listener: _upload_blobber_files 15:21:26 INFO - Blob upload gear active. 15:21:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:21:26 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 15:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:21:26 INFO - (blobuploader) - INFO - Open directory for files ... 15:21:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:21:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:21:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:27 INFO - (blobuploader) - INFO - Done attempting. 15:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:30 INFO - (blobuploader) - INFO - Done attempting. 15:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:31 INFO - (blobuploader) - INFO - Done attempting. 15:21:31 INFO - (blobuploader) - INFO - Iteration through files over. 15:21:31 INFO - Return code: 0 15:21:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:21:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:21:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc52cb490c0b07ab1d9905d458091de02e9ad38e7b28b5d2299ee6da4d92b478107a65634bc86773df76744bba7eac82aaf1157f9a4e81f31e8f52b917f2558b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1584d9cd7e56c3b4bd0200d1d9d2ef46bc3ad25123edad8a53cd14f552a131dfe9fbab4f95211c6025c03f585aaa639d817b83f631cf5dcaaa807200ffb52118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810d65a7a16f16125109be53bd4ca2fa41f26f431fd4c3a049fd916c5d7d3fb6129e08fc52cd43f8c53e82372103fe99841b5d83dc59c5b19b8368a9e8cb5e4d"} 15:21:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:21:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:21:31 INFO - Contents: 15:21:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc52cb490c0b07ab1d9905d458091de02e9ad38e7b28b5d2299ee6da4d92b478107a65634bc86773df76744bba7eac82aaf1157f9a4e81f31e8f52b917f2558b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1584d9cd7e56c3b4bd0200d1d9d2ef46bc3ad25123edad8a53cd14f552a131dfe9fbab4f95211c6025c03f585aaa639d817b83f631cf5dcaaa807200ffb52118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810d65a7a16f16125109be53bd4ca2fa41f26f431fd4c3a049fd916c5d7d3fb6129e08fc52cd43f8c53e82372103fe99841b5d83dc59c5b19b8368a9e8cb5e4d"} 15:21:31 INFO - Running post-run listener: copy_logs_to_upload_dir 15:21:31 INFO - Copying logs to upload dir... 15:21:31 INFO - mkdir: /builds/slave/test/build/upload/logs 15:21:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.685636 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-10 15:21:30.293245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 15:21:30.297098) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc52cb490c0b07ab1d9905d458091de02e9ad38e7b28b5d2299ee6da4d92b478107a65634bc86773df76744bba7eac82aaf1157f9a4e81f31e8f52b917f2558b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1584d9cd7e56c3b4bd0200d1d9d2ef46bc3ad25123edad8a53cd14f552a131dfe9fbab4f95211c6025c03f585aaa639d817b83f631cf5dcaaa807200ffb52118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810d65a7a16f16125109be53bd4ca2fa41f26f431fd4c3a049fd916c5d7d3fb6129e08fc52cd43f8c53e82372103fe99841b5d83dc59c5b19b8368a9e8cb5e4d"} build_url:https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/KoVsKVv0R1O5qX4QWg9iIw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc52cb490c0b07ab1d9905d458091de02e9ad38e7b28b5d2299ee6da4d92b478107a65634bc86773df76744bba7eac82aaf1157f9a4e81f31e8f52b917f2558b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1584d9cd7e56c3b4bd0200d1d9d2ef46bc3ad25123edad8a53cd14f552a131dfe9fbab4f95211c6025c03f585aaa639d817b83f631cf5dcaaa807200ffb52118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/810d65a7a16f16125109be53bd4ca2fa41f26f431fd4c3a049fd916c5d7d3fb6129e08fc52cd43f8c53e82372103fe99841b5d83dc59c5b19b8368a9e8cb5e4d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 15:21:30.322326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:21:30.322642) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476136840.885527-526453163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:21:30.407820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 15:21:30.408120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 15:21:30.408399) ========= ========= Total master_lag: 0.17 =========