builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1481905373.67 results: success (0) buildid: 20161216062349 builduid: e22b0ae9dc934263bbd4e58670e869d7 revision: ae98ffdc57822f068c011e305ea8a9662dd11e01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.666126) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.666798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.667291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.684351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.684671) ========= 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=8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-16 08:22:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-12-16 08:22:53 (211 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199456 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.897673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.897983) ========= 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=8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016014 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.947863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:53.948255) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae98ffdc57822f068c011e305ea8a9662dd11e01 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae98ffdc57822f068c011e305ea8a9662dd11e01 --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=8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-16 08:22:54,030 truncating revision to first 12 chars 2016-12-16 08:22:54,030 Setting DEBUG logging. 2016-12-16 08:22:54,030 attempt 1/10 2016-12-16 08:22:54,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae98ffdc5782?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 08:22:54,336 unpacking tar archive at: mozilla-aurora-ae98ffdc5782/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:54.581668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:54.581982) ========= script_repo_revision: ae98ffdc57822f068c011e305ea8a9662dd11e01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:54.582524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:54.583135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 08:22:54.593664) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-16 08:22:54.594045) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:54 INFO - MultiFileLogger online at 20161216 08:22:54 in /builds/slave/test 08:22:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:22:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:54 INFO - {'append_to_log': False, 08:22:54 INFO - 'base_work_dir': '/builds/slave/test', 08:22:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:22:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:54 INFO - 'branch': 'Mozilla-Aurora', 08:22:54 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:54 INFO - 'config_files': ('talos/linux_config.py',), 08:22:54 INFO - 'default_actions': ('clobber', 08:22:54 INFO - 'read-buildbot-config', 08:22:54 INFO - 'download-and-extract', 08:22:54 INFO - 'populate-webroot', 08:22:54 INFO - 'create-virtualenv', 08:22:54 INFO - 'install', 08:22:54 INFO - 'run-tests'), 08:22:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:54 INFO - 'download_minidump_stackwalk': True, 08:22:54 INFO - 'download_symbols': 'ondemand', 08:22:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:54 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:54 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:54 INFO - 'installer_path': 'installer.exe', 08:22:54 INFO - 'log_level': 'info', 08:22:54 INFO - 'log_name': 'talos', 08:22:54 INFO - 'log_to_console': True, 08:22:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:54 INFO - 'opt_config_files': (), 08:22:54 INFO - 'pip_index': False, 08:22:54 INFO - 'sps_profile': False, 08:22:54 INFO - 'sps_profile_interval': 0, 08:22:54 INFO - 'suite': 'dromaeojs', 08:22:54 INFO - 'system_bits': '32', 08:22:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:54 INFO - 'title': 'talos-linux64-ix-001', 08:22:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:54 INFO - 'use_talos_json': True, 08:22:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:54 INFO - 'work_dir': 'build'} 08:22:54 INFO - [mozharness: 2016-12-16 16:22:54.769158Z] Running clobber step. 08:22:54 INFO - Running pre-action listener: _resource_record_pre_action 08:22:54 INFO - Running main action method: clobber 08:22:54 INFO - rmtree: /builds/slave/test/build 08:22:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:55 INFO - Running post-action listener: _resource_record_post_action 08:22:55 INFO - [mozharness: 2016-12-16 16:22:55.727631Z] Finished clobber step (success) 08:22:55 INFO - [mozharness: 2016-12-16 16:22:55.727729Z] Running read-buildbot-config step. 08:22:55 INFO - Running pre-action listener: _resource_record_pre_action 08:22:55 INFO - Running main action method: read_buildbot_config 08:22:55 INFO - Using buildbot properties: 08:22:55 INFO - { 08:22:55 INFO - "project": "", 08:22:55 INFO - "product": "firefox", 08:22:55 INFO - "script_repo_revision": "production", 08:22:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:22:55 INFO - "repository": "", 08:22:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:22:55 INFO - "buildid": "20161216062349", 08:22:55 INFO - "pgo_build": "True", 08:22:55 INFO - "basedir": "/builds/slave/test", 08:22:55 INFO - "buildnumber": 683, 08:22:55 INFO - "slavename": "talos-linux64-ix-001", 08:22:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:22:55 INFO - "platform": "ubuntu64_hw", 08:22:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:22:55 INFO - "branch": "mozilla-aurora", 08:22:55 INFO - "repo_path": "releases/mozilla-aurora", 08:22:55 INFO - "revision": "ae98ffdc57822f068c011e305ea8a9662dd11e01", 08:22:55 INFO - "stage_platform": "linux64-pgo", 08:22:55 INFO - "builduid": "e22b0ae9dc934263bbd4e58670e869d7", 08:22:55 INFO - "slavebuilddir": "test" 08:22:55 INFO - } 08:22:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:22:55 INFO - Running post-action listener: _resource_record_post_action 08:22:55 INFO - [mozharness: 2016-12-16 16:22:55.730144Z] Finished read-buildbot-config step (success) 08:22:55 INFO - [mozharness: 2016-12-16 16:22:55.730233Z] Running download-and-extract step. 08:22:55 INFO - Running pre-action listener: _resource_record_pre_action 08:22:55 INFO - Running main action method: download_and_extract 08:22:55 INFO - mkdir: /builds/slave/test/build/tests 08:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:55 INFO - trying https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:22:55 INFO - Downloading https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:22:56 INFO - Downloaded 1361 bytes. 08:22:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:22:56 INFO - Using the following test package requirements: 08:22:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:22:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:22:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'jsshell-linux-x86_64.zip'], 08:22:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:22:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:22:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:22:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:22:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:22:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:56 INFO - Fetch https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:22:56 INFO - Http code: 200 08:22:56 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:22:56 INFO - x-amz-cf-id: tbUpZirzN6GHByCUJm7g5eT-9hljwSPiAKvU7DqbRN0uJop_hWnzlg== 08:22:56 INFO - x-amz-version-id: 7AjCK.IqfFD3ZWoNmPYZAy4eYArBzPRG 08:22:57 INFO - Expected file size: 21952346 08:22:57 INFO - Obtained file size: 21952346 08:23:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:23:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:23:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:01 INFO - Fetch https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:23:02 INFO - Http code: 200 08:23:02 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:23:02 INFO - x-amz-cf-id: 6lgsMah3v0H_qGNFAL8lC9msPmkDOfGEj2YQyzJrhKKRtbOnlhm1ZQ== 08:23:02 INFO - x-amz-version-id: 7AjCK.IqfFD3ZWoNmPYZAy4eYArBzPRG 08:23:02 INFO - Expected file size: 21952346 08:23:02 INFO - Obtained file size: 21952346 08:23:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:23:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:07 INFO - Fetch https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:23:07 INFO - Http code: 200 08:23:07 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 08:23:07 INFO - x-amz-cf-id: vT8PFVlKYgnBAlSbbJXwJMQa1wAlzq2PKHwDLrXgnHaSUj44GPIytw== 08:23:07 INFO - x-amz-version-id: 2dAJyPQ86InCJamGBrABOwGrBqeJYEGJ 08:23:08 INFO - Expected file size: 14409038 08:23:08 INFO - Obtained file size: 14409038 08:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:08 INFO - trying https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:23:08 INFO - Downloading https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:23:11 INFO - Downloaded 63957312 bytes. 08:23:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:23:11 INFO - mkdir: /builds/slave/test/properties 08:23:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:11 INFO - Contents: 08:23:11 INFO - build_url:https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:23:11 INFO - Running post-action listener: _resource_record_post_action 08:23:11 INFO - Running post-action listener: set_extra_try_arguments 08:23:11 INFO - [mozharness: 2016-12-16 16:23:11.979202Z] Finished download-and-extract step (success) 08:23:11 INFO - [mozharness: 2016-12-16 16:23:11.979426Z] Running populate-webroot step. 08:23:11 INFO - Running pre-action listener: _resource_record_pre_action 08:23:11 INFO - Running main action method: populate_webroot 08:23:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:11 INFO - '--tppagecycles', 08:23:11 INFO - '7'], 08:23:11 INFO - 'tests': ['tsvgm']}}, 08:23:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['damp', 'tps']}, 08:23:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'tests': ['damp', 'tps']}, 08:23:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['dromaeo_dom']}, 08:23:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['basic_compositor_video']}, 08:23:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:23:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['a11yr', 08:23:11 INFO - 'ts_paint', 08:23:11 INFO - 'tpaint', 08:23:11 INFO - 'sessionrestore', 08:23:11 INFO - 'sessionrestore_no_auto_restore', 08:23:11 INFO - 'tabpaint']}, 08:23:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:11 INFO - 'ts_paint', 08:23:11 INFO - 'tpaint', 08:23:11 INFO - 'sessionrestore', 08:23:11 INFO - 'sessionrestore_no_auto_restore', 08:23:11 INFO - 'tabpaint']}, 08:23:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:11 INFO - 'ts_paint', 08:23:11 INFO - 'tpaint', 08:23:11 INFO - 'sessionrestore', 08:23:11 INFO - 'sessionrestore_no_auto_restore', 08:23:11 INFO - 'tabpaint']}, 08:23:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:11 INFO - 'ts_paint', 08:23:11 INFO - 'tpaint', 08:23:11 INFO - 'sessionrestore', 08:23:11 INFO - 'sessionrestore_no_auto_restore', 08:23:11 INFO - 'tabpaint']}, 08:23:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['a11yr', 08:23:11 INFO - 'ts_paint', 08:23:11 INFO - 'tpaint', 08:23:11 INFO - 'sessionrestore', 08:23:11 INFO - 'sessionrestore_no_auto_restore', 08:23:11 INFO - 'tabpaint']}, 08:23:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['a11yr', 08:23:11 INFO - 'ts_paint', 08:23:11 INFO - 'tpaint', 08:23:11 INFO - 'sessionrestore', 08:23:11 INFO - 'sessionrestore_no_auto_restore', 08:23:11 INFO - 'tabpaint']}, 08:23:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['tsvgx', 08:23:11 INFO - 'tsvgr_opacity', 08:23:11 INFO - 'tart', 08:23:11 INFO - 'tscrollx', 08:23:11 INFO - 'cart']}, 08:23:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:11 INFO - 'tsvgr_opacity', 08:23:11 INFO - 'tart', 08:23:11 INFO - 'tscrollx', 08:23:11 INFO - 'cart']}, 08:23:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'talos_options': ['--disable-e10s'], 08:23:11 INFO - 'tests': ['tp5o']}, 08:23:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'tests': ['tp5o']}, 08:23:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'talos_options': ['--disable-e10s', 08:23:11 INFO - '--xperf_path', 08:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:11 INFO - 'tests': ['tp5n']}, 08:23:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:11 INFO - 'talos_options': ['--xperf_path', 08:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:11 INFO - 'tests': ['tp5n']}}, 08:23:11 INFO - 'talos.zip': {'path': '', 08:23:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:11 INFO - Running post-action listener: _resource_record_post_action 08:23:11 INFO - [mozharness: 2016-12-16 16:23:11.996392Z] Finished populate-webroot step (success) 08:23:11 INFO - [mozharness: 2016-12-16 16:23:11.996479Z] Running create-virtualenv step. 08:23:11 INFO - Running pre-action listener: _resource_record_pre_action 08:23:11 INFO - Running main action method: create_virtualenv 08:23:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:23:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:12 INFO - Using real prefix '/usr' 08:23:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:14 INFO - Installing pip.................done. 08:23:14 INFO - Return code: 0 08:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:23:14 INFO - Reading from file tmpfile_stdout 08:23:14 INFO - Output received: 08:23:14 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) 08:23:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:14 INFO - Using env: {'DISPLAY': ':0', 08:23:14 INFO - 'HOME': '/home/cltbld', 08:23:14 INFO - 'LANG': 'en_US.UTF-8', 08:23:14 INFO - 'LANGUAGE': 'en_US:en', 08:23:14 INFO - 'LOGNAME': 'cltbld', 08:23:14 INFO - 'MAIL': '/var/mail/cltbld', 08:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:14 INFO - 'MOZ_NO_REMOTE': '1', 08:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:14 INFO - 'NO_EM_RESTART': '1', 08:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:14 INFO - 'PWD': '/builds/slave/test', 08:23:14 INFO - 'SHELL': '/bin/bash', 08:23:14 INFO - 'SHLVL': '1', 08:23:14 INFO - 'TERM': 'linux', 08:23:14 INFO - 'TMOUT': '86400', 08:23:14 INFO - 'USER': 'cltbld', 08:23:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:14 INFO - '_': '/tools/buildbot/bin/python'} 08:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:23:14 INFO - Cleaning up... 08:23:14 INFO - Return code: 0 08:23:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:15 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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:23:15 INFO - Using env: {'DISPLAY': ':0', 08:23:15 INFO - 'HOME': '/home/cltbld', 08:23:15 INFO - 'LANG': 'en_US.UTF-8', 08:23:15 INFO - 'LANGUAGE': 'en_US:en', 08:23:15 INFO - 'LOGNAME': 'cltbld', 08:23:15 INFO - 'MAIL': '/var/mail/cltbld', 08:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:15 INFO - 'MOZ_NO_REMOTE': '1', 08:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:15 INFO - 'NO_EM_RESTART': '1', 08:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:15 INFO - 'PWD': '/builds/slave/test', 08:23:15 INFO - 'SHELL': '/bin/bash', 08:23:15 INFO - 'SHLVL': '1', 08:23:15 INFO - 'TERM': 'linux', 08:23:15 INFO - 'TMOUT': '86400', 08:23:15 INFO - 'USER': 'cltbld', 08:23:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:15 INFO - '_': '/tools/buildbot/bin/python'} 08:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:15 INFO - Downloading/unpacking psutil>=3.1.1 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:17 INFO - Installing collected packages: psutil 08:23:17 INFO - Running setup.py install for psutil 08:23:17 INFO - building 'psutil._psutil_linux' extension 08:23:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:23:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:23:17 INFO - building 'psutil._psutil_posix' extension 08:23:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:23:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:23:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:17 INFO - Successfully installed psutil 08:23:17 INFO - Cleaning up... 08:23:17 INFO - Return code: 0 08:23:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:17 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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:17 INFO - Using env: {'DISPLAY': ':0', 08:23:17 INFO - 'HOME': '/home/cltbld', 08:23:17 INFO - 'LANG': 'en_US.UTF-8', 08:23:17 INFO - 'LANGUAGE': 'en_US:en', 08:23:17 INFO - 'LOGNAME': 'cltbld', 08:23:17 INFO - 'MAIL': '/var/mail/cltbld', 08:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:17 INFO - 'MOZ_NO_REMOTE': '1', 08:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:17 INFO - 'NO_EM_RESTART': '1', 08:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:17 INFO - 'PWD': '/builds/slave/test', 08:23:17 INFO - 'SHELL': '/bin/bash', 08:23:17 INFO - 'SHLVL': '1', 08:23:17 INFO - 'TERM': 'linux', 08:23:17 INFO - 'TMOUT': '86400', 08:23:17 INFO - 'USER': 'cltbld', 08:23:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:17 INFO - '_': '/tools/buildbot/bin/python'} 08:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:20 INFO - Installing collected packages: mozsystemmonitor 08:23:20 INFO - Running setup.py install for mozsystemmonitor 08:23:20 INFO - Successfully installed mozsystemmonitor 08:23:20 INFO - Cleaning up... 08:23:20 INFO - Return code: 0 08:23:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23: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==2.5.1'] in /builds/slave/test/build 08:23: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==2.5.1 08:23:20 INFO - Using env: {'DISPLAY': ':0', 08:23:20 INFO - 'HOME': '/home/cltbld', 08:23:20 INFO - 'LANG': 'en_US.UTF-8', 08:23:20 INFO - 'LANGUAGE': 'en_US:en', 08:23:20 INFO - 'LOGNAME': 'cltbld', 08:23:20 INFO - 'MAIL': '/var/mail/cltbld', 08:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:20 INFO - 'MOZ_NO_REMOTE': '1', 08:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:20 INFO - 'NO_EM_RESTART': '1', 08:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:20 INFO - 'PWD': '/builds/slave/test', 08:23:20 INFO - 'SHELL': '/bin/bash', 08:23:20 INFO - 'SHLVL': '1', 08:23:20 INFO - 'TERM': 'linux', 08:23:20 INFO - 'TMOUT': '86400', 08:23:20 INFO - 'USER': 'cltbld', 08:23:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:20 INFO - '_': '/tools/buildbot/bin/python'} 08:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:22 INFO - warning: no files found matching '*.txt' 08:23:22 INFO - no previously-included directories found matching 'build' 08:23:22 INFO - no previously-included directories found matching 'dist' 08:23:22 INFO - no previously-included directories found matching '.git*' 08:23:22 INFO - Installing collected packages: jsonschema, functools32 08:23:22 INFO - Running setup.py install for functools32 08:23:22 INFO - warning: no files found matching '*.txt' 08:23:22 INFO - no previously-included directories found matching 'build' 08:23:22 INFO - no previously-included directories found matching 'dist' 08:23:22 INFO - no previously-included directories found matching '.git*' 08:23:22 INFO - Successfully installed jsonschema functools32 08:23:22 INFO - Cleaning up... 08:23:22 INFO - Return code: 0 08:23:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:22 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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:23:22 INFO - Using env: {'DISPLAY': ':0', 08:23:22 INFO - 'HOME': '/home/cltbld', 08:23:22 INFO - 'LANG': 'en_US.UTF-8', 08:23:22 INFO - 'LANGUAGE': 'en_US:en', 08:23:22 INFO - 'LOGNAME': 'cltbld', 08:23:22 INFO - 'MAIL': '/var/mail/cltbld', 08:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:22 INFO - 'MOZ_NO_REMOTE': '1', 08:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:22 INFO - 'NO_EM_RESTART': '1', 08:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:22 INFO - 'PWD': '/builds/slave/test', 08:23:22 INFO - 'SHELL': '/bin/bash', 08:23:22 INFO - 'SHLVL': '1', 08:23:22 INFO - 'TERM': 'linux', 08:23:22 INFO - 'TMOUT': '86400', 08:23:22 INFO - 'USER': 'cltbld', 08:23:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:22 INFO - '_': '/tools/buildbot/bin/python'} 08:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:23:23 INFO - Cleaning up... 08:23:23 INFO - Return code: 0 08:23:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:23:23 INFO - Using env: {'DISPLAY': ':0', 08:23:23 INFO - 'HOME': '/home/cltbld', 08:23:23 INFO - 'LANG': 'en_US.UTF-8', 08:23:23 INFO - 'LANGUAGE': 'en_US:en', 08:23:23 INFO - 'LOGNAME': 'cltbld', 08:23:23 INFO - 'MAIL': '/var/mail/cltbld', 08:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:23 INFO - 'MOZ_NO_REMOTE': '1', 08:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:23 INFO - 'NO_EM_RESTART': '1', 08:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:23 INFO - 'PWD': '/builds/slave/test', 08:23:23 INFO - 'SHELL': '/bin/bash', 08:23:23 INFO - 'SHLVL': '1', 08:23:23 INFO - 'TERM': 'linux', 08:23:23 INFO - 'TMOUT': '86400', 08:23:23 INFO - 'USER': 'cltbld', 08:23:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:23 INFO - '_': '/tools/buildbot/bin/python'} 08:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:26 INFO - Downloading docopt-0.6.1.tar.gz 08:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:26 INFO - Running setup.py install for blobuploader 08:23:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:26 INFO - Running setup.py install for requests 08:23:26 INFO - Running setup.py install for docopt 08:23:26 INFO - Successfully installed blobuploader requests docopt 08:23:26 INFO - Cleaning up... 08:23:26 INFO - Return code: 0 08:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:26 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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:26 INFO - Using env: {'DISPLAY': ':0', 08:23:26 INFO - 'HOME': '/home/cltbld', 08:23:26 INFO - 'LANG': 'en_US.UTF-8', 08:23:26 INFO - 'LANGUAGE': 'en_US:en', 08:23:26 INFO - 'LOGNAME': 'cltbld', 08:23:26 INFO - 'MAIL': '/var/mail/cltbld', 08:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:26 INFO - 'MOZ_NO_REMOTE': '1', 08:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:26 INFO - 'NO_EM_RESTART': '1', 08:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:26 INFO - 'PWD': '/builds/slave/test', 08:23:26 INFO - 'SHELL': '/bin/bash', 08:23:26 INFO - 'SHLVL': '1', 08:23:26 INFO - 'TERM': 'linux', 08:23:26 INFO - 'TMOUT': '86400', 08:23:26 INFO - 'USER': 'cltbld', 08:23:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:26 INFO - '_': '/tools/buildbot/bin/python'} 08:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:26 INFO - Running setup.py (path:/tmp/pip-eXUNsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:26 INFO - Running setup.py (path:/tmp/pip-zkQWo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:27 INFO - Running setup.py (path:/tmp/pip-vmcK9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:27 INFO - Running setup.py (path:/tmp/pip-7_aXDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:27 INFO - Running setup.py (path:/tmp/pip-ScrJfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:27 INFO - Running setup.py (path:/tmp/pip-YhjHVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:27 INFO - Running setup.py (path:/tmp/pip-9PSkDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:27 INFO - Running setup.py (path:/tmp/pip-ame8Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:27 INFO - Running setup.py (path:/tmp/pip-YjdahQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:27 INFO - Running setup.py (path:/tmp/pip-BK0FWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:27 INFO - Running setup.py (path:/tmp/pip-AzgtAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:27 INFO - Running setup.py (path:/tmp/pip-WWblhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:27 INFO - Running setup.py (path:/tmp/pip-niyflA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:27 INFO - Running setup.py (path:/tmp/pip-zGMiiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:27 INFO - Running setup.py (path:/tmp/pip-dTmA45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:28 INFO - Running setup.py (path:/tmp/pip-nVGoya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:28 INFO - Running setup.py (path:/tmp/pip-2l_284-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:28 INFO - Running setup.py install for manifestparser 08:23:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Running setup.py install for mozcrash 08:23:28 INFO - Running setup.py install for mozdebug 08:23:28 INFO - Running setup.py install for mozdevice 08:23:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Running setup.py install for mozfile 08:23:28 INFO - Running setup.py install for mozhttpd 08:23:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Running setup.py install for mozinfo 08:23:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Running setup.py install for mozInstall 08:23:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:28 INFO - Running setup.py install for mozleak 08:23:29 INFO - Running setup.py install for mozlog 08:23:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Running setup.py install for moznetwork 08:23:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Running setup.py install for mozprocess 08:23:29 INFO - Running setup.py install for mozprofile 08:23:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Running setup.py install for mozrunner 08:23:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Running setup.py install for mozscreenshot 08:23:29 INFO - Running setup.py install for moztest 08:23:29 INFO - Running setup.py install for mozversion 08:23:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:29 INFO - Cleaning up... 08:23:29 INFO - Return code: 0 08:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:29 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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:29 INFO - Using env: {'DISPLAY': ':0', 08:23:29 INFO - 'HOME': '/home/cltbld', 08:23:29 INFO - 'LANG': 'en_US.UTF-8', 08:23:29 INFO - 'LANGUAGE': 'en_US:en', 08:23:29 INFO - 'LOGNAME': 'cltbld', 08:23:29 INFO - 'MAIL': '/var/mail/cltbld', 08:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:29 INFO - 'MOZ_NO_REMOTE': '1', 08:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:29 INFO - 'NO_EM_RESTART': '1', 08:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:29 INFO - 'PWD': '/builds/slave/test', 08:23:29 INFO - 'SHELL': '/bin/bash', 08:23:29 INFO - 'SHLVL': '1', 08:23:29 INFO - 'TERM': 'linux', 08:23:29 INFO - 'TMOUT': '86400', 08:23:29 INFO - 'USER': 'cltbld', 08:23:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:29 INFO - '_': '/tools/buildbot/bin/python'} 08:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:30 INFO - Running setup.py (path:/tmp/pip-KXmUDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:30 INFO - Running setup.py (path:/tmp/pip-1lJpsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:30 INFO - Running setup.py (path:/tmp/pip-DZ5ssa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:30 INFO - Running setup.py (path:/tmp/pip-_Vte_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:30 INFO - Running setup.py (path:/tmp/pip-WZmL35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:30 INFO - Running setup.py (path:/tmp/pip-MLnBsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:30 INFO - Running setup.py (path:/tmp/pip-a29Jpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:30 INFO - Running setup.py (path:/tmp/pip-Pmhiuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:30 INFO - Running setup.py (path:/tmp/pip-BGHkWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:30 INFO - Running setup.py (path:/tmp/pip-5YHYXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:30 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)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:30 INFO - Running setup.py (path:/tmp/pip-ulf3H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:30 INFO - Running setup.py (path:/tmp/pip-Y76Pt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:31 INFO - Running setup.py (path:/tmp/pip-oyv4HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:31 INFO - Running setup.py (path:/tmp/pip-zmoMje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:31 INFO - Running setup.py (path:/tmp/pip-aN9ypM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:31 INFO - Running setup.py (path:/tmp/pip-6egq7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:31 INFO - Running setup.py (path:/tmp/pip-wQlyfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:33 INFO - Downloading blessings-1.6.tar.gz 08:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:33 INFO - Installing collected packages: blessings 08:23:33 INFO - Running setup.py install for blessings 08:23:33 INFO - Successfully installed blessings 08:23:33 INFO - Cleaning up... 08:23:33 INFO - Return code: 0 08:23:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:33 INFO - Reading from file tmpfile_stdout 08:23:33 INFO - Current package versions: 08:23:33 INFO - argparse == 1.2.1 08:23:33 INFO - blessings == 1.6 08:23:33 INFO - blobuploader == 1.2.4 08:23:33 INFO - docopt == 0.6.1 08:23:33 INFO - functools32 == 3.2.3-2 08:23:33 INFO - jsonschema == 2.5.1 08:23:33 INFO - manifestparser == 1.1 08:23:33 INFO - mozInstall == 1.12 08:23:33 INFO - mozcrash == 1.0 08:23:33 INFO - mozdebug == 0.1 08:23:33 INFO - mozdevice == 0.48 08:23:33 INFO - mozfile == 1.2 08:23:33 INFO - mozhttpd == 0.7 08:23:33 INFO - mozinfo == 0.9 08:23:33 INFO - mozleak == 0.1 08:23:33 INFO - mozlog == 3.4 08:23:33 INFO - moznetwork == 0.27 08:23:33 INFO - mozprocess == 0.23 08:23:33 INFO - mozprofile == 0.28 08:23:33 INFO - mozrunner == 6.13 08:23:33 INFO - mozscreenshot == 0.1 08:23:33 INFO - mozsystemmonitor == 0.3 08:23:33 INFO - moztest == 0.7 08:23:33 INFO - mozversion == 1.4 08:23:33 INFO - psutil == 3.1.1 08:23:33 INFO - requests == 1.2.3 08:23:33 INFO - wsgiref == 0.1.2 08:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:33 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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:33 INFO - Using env: {'DISPLAY': ':0', 08:23:33 INFO - 'HOME': '/home/cltbld', 08:23:33 INFO - 'LANG': 'en_US.UTF-8', 08:23:33 INFO - 'LANGUAGE': 'en_US:en', 08:23:33 INFO - 'LOGNAME': 'cltbld', 08:23:33 INFO - 'MAIL': '/var/mail/cltbld', 08:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:33 INFO - 'MOZ_NO_REMOTE': '1', 08:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:33 INFO - 'NO_EM_RESTART': '1', 08:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:33 INFO - 'PWD': '/builds/slave/test', 08:23:33 INFO - 'SHELL': '/bin/bash', 08:23:33 INFO - 'SHLVL': '1', 08:23:33 INFO - 'TERM': 'linux', 08:23:33 INFO - 'TMOUT': '86400', 08:23:33 INFO - 'USER': 'cltbld', 08:23:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:33 INFO - '_': '/tools/buildbot/bin/python'} 08:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:34 INFO - Cleaning up... 08:23:34 INFO - Return code: 0 08:23:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:34 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 0x7ff3c3514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:23:34 INFO - Using env: {'DISPLAY': ':0', 08:23:34 INFO - 'HOME': '/home/cltbld', 08:23:34 INFO - 'LANG': 'en_US.UTF-8', 08:23:34 INFO - 'LANGUAGE': 'en_US:en', 08:23:34 INFO - 'LOGNAME': 'cltbld', 08:23:34 INFO - 'MAIL': '/var/mail/cltbld', 08:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:34 INFO - 'MOZ_NO_REMOTE': '1', 08:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:34 INFO - 'NO_EM_RESTART': '1', 08:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:34 INFO - 'PWD': '/builds/slave/test', 08:23:34 INFO - 'SHELL': '/bin/bash', 08:23:34 INFO - 'SHLVL': '1', 08:23:34 INFO - 'TERM': 'linux', 08:23:34 INFO - 'TMOUT': '86400', 08:23:34 INFO - 'USER': 'cltbld', 08:23:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:34 INFO - '_': '/tools/buildbot/bin/python'} 08:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:34 INFO - Cleaning up... 08:23:34 INFO - Return code: 0 08:23:34 INFO - Running post-action listener: _resource_record_post_action 08:23:34 INFO - Running post-action listener: _start_resource_monitoring 08:23:34 INFO - Starting resource monitoring. 08:23:34 INFO - [mozharness: 2016-12-16 16:23:34.319546Z] Finished create-virtualenv step (success) 08:23:34 INFO - [mozharness: 2016-12-16 16:23:34.320040Z] Running install step. 08:23:34 INFO - Running pre-action listener: _resource_record_pre_action 08:23:34 INFO - Running main action method: install 08:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:34 INFO - Reading from file tmpfile_stdout 08:23:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:34 INFO - Reading from file tmpfile_stdout 08:23:34 INFO - Output received: 08:23:34 INFO - Usage: mozinstall [options] installer 08:23:34 INFO - Options: 08:23:34 INFO - -h, --help show this help message and exit 08:23:34 INFO - -d DEST, --destination=DEST 08:23:34 INFO - Directory to install application into. [default: 08:23:34 INFO - "/builds/slave/test"] 08:23:34 INFO - --app=APP Application being installed. [default: firefox] 08:23:34 INFO - mkdir: /builds/slave/test/build/application 08:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:23:50 INFO - Reading from file tmpfile_stdout 08:23:50 INFO - Output received: 08:23:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:50 INFO - Running post-action listener: _resource_record_post_action 08:23:50 INFO - [mozharness: 2016-12-16 16:23:50.528223Z] Finished install step (success) 08:23:50 INFO - [mozharness: 2016-12-16 16:23:50.528553Z] Running run-tests step. 08:23:50 INFO - Running pre-action listener: _resource_record_pre_action 08:23:50 INFO - Running main action method: run_tests 08:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:50 INFO - Python 2.7.3 08:23:50 INFO - Return code: 0 08:23:50 INFO - grabbing minidump binary from tooltool 08:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:50 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 0x27adf60>, '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 0x27aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27af1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:23:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:23:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:23:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:50 INFO - Return code: 0 08:23:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:23:50 INFO - Using env: {'DISPLAY': ':0', 08:23:50 INFO - 'HOME': '/home/cltbld', 08:23:50 INFO - 'LANG': 'en_US.UTF-8', 08:23:50 INFO - 'LANGUAGE': 'en_US:en', 08:23:50 INFO - 'LOGNAME': 'cltbld', 08:23:50 INFO - 'MAIL': '/var/mail/cltbld', 08:23:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:50 INFO - 'MOZ_NO_REMOTE': '1', 08:23:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:50 INFO - 'NO_EM_RESTART': '1', 08:23:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:50 INFO - 'PWD': '/builds/slave/test', 08:23:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:50 INFO - 'SHELL': '/bin/bash', 08:23:50 INFO - 'SHLVL': '1', 08:23:50 INFO - 'TERM': 'linux', 08:23:50 INFO - 'TMOUT': '86400', 08:23:50 INFO - 'USER': 'cltbld', 08:23:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299', 08:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:50 INFO - '_': '/tools/buildbot/bin/python'} 08:23:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:23:50 INFO - mozversion application_buildid: 20161216062349 08:23:50 INFO - mozversion application_changeset: ae98ffdc57822f068c011e305ea8a9662dd11e01 08:23:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:23:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:50 INFO - mozversion application_name: Firefox 08:23:50 INFO - mozversion application_remotingname: firefox-dev 08:23:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:23:50 INFO - mozversion application_vendor: Mozilla 08:23:50 INFO - mozversion application_version: 52.0a2 08:23:50 INFO - mozversion platform_buildid: 20161216062349 08:23:50 INFO - mozversion platform_changeset: ae98ffdc57822f068c011e305ea8a9662dd11e01 08:23:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:23:50 INFO - mozversion platform_version: 52.0a2 08:23:50 INFO - using testdate: 1481905430 08:23:50 INFO - actual date: 1481905430 08:23:50 INFO - starting webserver on 'localhost:38376' 08:23:50 INFO - SUITE-START | Running 2 tests 08:23:50 INFO - TEST-START | dromaeo_css 08:23:50 INFO - operating with platform_type : linux_ 08:23:50 INFO - Initialising browser for dromaeo_css test... 08:23:50 INFO - TEST-INFO | started process 11270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QUe7F/profile http://localhost:38376/getInfo.html) 08:23:54 INFO - PROCESS | 11270 | __metrics Screen width/height:1600/1200 08:23:54 INFO - PROCESS | 11270 | colorDepth:24 08:23:54 INFO - PROCESS | 11270 | Browser inner width/height: 1024/697 08:23:54 INFO - PROCESS | 11270 | __metrics 08:23:55 INFO - PROCESS | 11270 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:23:55 INFO - PROCESS | 11270 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:55 INFO - PROCESS | 11270 | console.error: PushService: 08:23:55 INFO - PROCESS | 11270 | stateChangeProcessEnqueue: Error transitioning state 08:23:55 INFO - PROCESS | 11270 | UnknownError 08:23:56 INFO - TEST-INFO | 11270: exit 0 08:23:56 INFO - Browser initialized. 08:23:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:56 INFO - TEST-INFO | started process 11362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QUe7F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:08 INFO - PROCESS | 11362 | RSS: Main: 144240640 08:24:08 INFO - PROCESS | 11362 | 08:25:05 INFO - PROCESS | 11362 | 1481905505306 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:27:10 INFO - PROCESS | 11362 | Cycle 1(1): loaded http://localhost:38376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38376/tests/dromaeo/cssquery-ext.html) 08:27:11 INFO - PROCESS | 11362 | RSS: Main: 264208384 08:27:11 INFO - PROCESS | 11362 | 08:30:13 INFO - PROCESS | 11362 | Cycle 1(1): loaded http://localhost:38376/tests/dromaeo/cssquery-ext.html (next: http://localhost:38376/tests/dromaeo/cssquery-jquery.html) 08:30:14 INFO - PROCESS | 11362 | RSS: Main: 225206272 08:30:14 INFO - PROCESS | 11362 | 08:33:16 INFO - PROCESS | 11362 | Cycle 1(1): loaded http://localhost:38376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38376/tests/dromaeo/cssquery-mootools.html) 08:33:16 INFO - PROCESS | 11362 | RSS: Main: 178413568 08:33:16 INFO - PROCESS | 11362 | 08:36:18 INFO - PROCESS | 11362 | Cycle 1(1): loaded http://localhost:38376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38376/tests/dromaeo/cssquery-prototype.html) 08:36:19 INFO - PROCESS | 11362 | RSS: Main: 226463744 08:36:19 INFO - PROCESS | 11362 | 08:39:22 INFO - PROCESS | 11362 | Cycle 1(1): loaded http://localhost:38376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38376/tests/dromaeo/cssquery-yui.html) 08:39:22 INFO - PROCESS | 11362 | RSS: Main: 173457408 08:39:22 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | Cycle 1(1): loaded http://localhost:38376/tests/dromaeo/cssquery-yui.html (next: http://localhost:38376/tests/dromaeo/cssquery-dojo.html) 08:42:25 INFO - PROCESS | 11362 | RSS: Main: 271863808 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | __start_tp_report 08:42:25 INFO - PROCESS | 11362 | _x_x_mozilla_page_load 08:42:25 INFO - PROCESS | 11362 | _x_x_mozilla_page_load_details 08:42:25 INFO - PROCESS | 11362 | |i|pagename|runs| 08:42:25 INFO - PROCESS | 11362 | |0;dojo.html;3164.7626428017898;3209.2458272306003;3229.4025605263014;3230.660780618035;3258.136593802641;5492.4782145696145;5539.667619942801;5554.888902221953;5565.387807341189;5571.665700057989;5491.368492623339;5494.066008778507;5494.0934745767;5497.697626630534;5513.972430137854;4931.901361972749;4953.603711703073;5007.273945277932;5014.774335154927;5034.924476132861;4927.531884470969;4953.356063711731;4981.5516603505675;5012.874678133039;5024.045431368047;4985.551300382965;5044.4955504449445;5050.217216331456;5053.519915608012;5055.140626093555;4998.10034193845;5035.018171456568;5060.620453466005;5060.7722652480725;5063.594912407036;4890.530282207498;4943.357363542752;4977.7262250576205;5003.649744517885;5006.173981293082;5425.294711687495;5488.765027868738;5551.472610102034;5556.277683901108;5569.693666848321;5674.687892165929;5869.266341707286;5872.500837428824;5886;5920.407959204088;5782.797602083949;5915.852103697442;5923.763049478016;5928.584999050068;5933.851653708649;5564.443555644403;5571.804986825442;5637.210790489335;5650.886982260414;5655.547556195576;5825.330087040044;6084.878302433926;6093.086037094383;6117.082437634391;6117.265928088658;5674.687892165888;5695.5443564514735;5713.485786279255;5755.913661295084;5769.336526299446;5824.796132135355;5847.912281315784;5850.385709500526;5852.941470585325;5862.706864656835;5758.280214973129;5803.361630220672;5808.912866307009;5819.214406055213;5825.1844741736195;5786.942130578725;5903.881922361528;5970.373110823301;5971.313298970674;5976.551758618121;4623.283391074322;4624.560666736655;4625.468071171791;4641.651876109306;4653.464851542049;4056.918861622751;4089.672826173899;4104.138130992465;4122.40225167349;4138.958610413918;5487.506124448819;5536.307961504812;5544.556435485151;5568.6101972862325;5712.485876271156;5953.166556682068;5997.940020599825;6046.637201767908;6060.757569697251;6060.878782424415;5684.232628595169;5685.4883060523925;5686.5735069869925;5690.6870122142855;5697.401772813878;4930.457649658535;4990.4011518618;5085.338905942203;5087.16061849798;5088.6946783193125;6047.395260473917;6118.357572455006;6129.325774164839;6136.978641397139;6138.32709113608;5967.9701601491715;6061.212042434456;6071.058985857199;6072.14989901423;6088.4215999479975;5919.4080591940465;6247.0629405589525;6249.906251406142;6258.937410625836;6261.373862613885;5686.943130568807;5798.478136967693;5844.590878638454;5853.414658534112;5971.343152253336;5971.91042134377;6021.87956240864;6039.033754599243;6040.063790112539;6041.969790151021;5898.439648233411;5900.5574581907385;5904.350521442552;5913.201717768046;5917.704114794329;5597.5521958242425;5640.746166422603;5705.058665320342;5733.054046082517;5750.741216645178;5737.56968227393;5760.683162426107;5764.971175144097;5772.04761214395;5785.971070144622;5833.329167145663;5835.358110607915;5843.707814609167;5845.41545845412;5852.970735146297;5507.7246137692155;5521.558275337883;5657.830265092054;5674.177244299636;5703.315602127771 08:42:25 INFO - PROCESS | 11362 | |1;ext.html;585.5432762445291;619.6437048697;645.2708439463407;654.9574277671954;662.324429082336;34209.65790342096;34811.825940870294;44102.55897441028;44874.551254487444;45097.32354014692;43392.132157356835;46931.76534117333;46988;47018;47032.52967470324;8857.645694172226;8993.955030224839;9003.684871029514;9004.819903601923;9005.50469724165;8379.874301885477;8568;10619.41593212373;10859.67420977368;10868.076213521821;10892.128629709605;10894.945525272402;10938.234323597351;11029.227954043221;11033.944830275837;10592.41741704206;10625.84061239082;10655.094316983066;10663.733406664856;10779.67660970172;10620.362778233331;10694.78610427795;10700.785984280348;10703.678889633324;10704.090152337061;44042;44231;44354;44399.77800111011;44435;3754.455603937441;3785.8296376662843;3807.067268519203;3893.6885049196;3939.172773717523;32150.83924580362;32809.835950820096;33201.501977470354;33975.6602433975;34340.313193736234;3538.486919396673;3621.5835178954494;3644.726645501598;3660.3045421369857;3665.505156803824;375629;375907;376451;376454;376728.1163594192;37824;38660;38721.41917871234;64974.67512662501;65473;41167.794161029;41342.793286033375;41355.58644413578;41369.37945930813;41370;15330.156841373608;15563.299651515708;15568.688626227413;15574;15578.06531608107;11509.654710358702;11755.177137600456;12606.117571770072;12802.679933001564;12813.93593032029;9327.626894924128;9641.084097010773;9649.083337082966;9697.224222062217;9788;3562.7149828014217;3658.8657516170074;3682.5212722345923;3695.667389934919;3731.440283957428;991.667791289926;1046.68076236747;1136.1933027550367;1142.868570114431;1172.648205538335;33621.49567756485;34158.82920585381;34480.482792757626;34485.310293794486;34746.652533474844;1114.3759494683004;1149.1209224942925;1167.311286341063;1188.9643310700692;1202.1193952552665;15728.05631662104;17933.701822676423;18036.458906232834;18593.53516162107;18624.534386640444;561531;562453;566110;566853;566950;62424.375756241854;62922.685386572775;62992.370076299565;63005.36994630087;63099.36900631027;1313.6847156682327;1334.9065565410328;1337.2979185927466;1364.36557000995;1403.9227842468763;26542.734572654026;35342;36643.63356366402;36856.81571592125;37176.62823371732;60177.69911150416;60983.695081526086;60992.695036524536;61063;61133.08300375409;481389;483553;483585;483865;485382;27278.318042049108;28022.85988570044;30300;31214;31280.68719312778;47398.763006184745;47946;49047.26429103638;52858.471415285356;53428.46571534235;41233.11368204317;41692;41984.370234445894;42005.36991945062;42844.57155428531;41911.161776763685;42005;42262;43138.35292470553;43616.78191609149;42784.786076069424;43074.353884692384;43920.34119488274;43983.12033759371;46030.76984615056;35681.46477802783;38426.42360364653;44112;44603.330950035124;44945.775271123435;33641.66358336385;35936.82031589825;36023.45964810478;36104;36147.45778813267 08:42:25 INFO - PROCESS | 11362 | |2;jquery.html;403.4795114302548;405.118866465438;409.9979500102499;411.3788179848429;431.417586258551;17130;18895.149718262677;19450.90274548627;20308.796912030874;20313.187472501082;19271.421857344267;19584.902075489637;19614.509637259074;20004.59990800183;20027.899860500715;5455.754491047913;5674.631148975303;5750.7412166452405;5760.452756988079;5760.596758226926;5576.442355764431;5680.233168522259;5750.1949727038245;5759.395263497336;5762.53899688026;5660.60375773694;5732.111522713986;5735.569832262597;5737.913931291034;5738.598298119134;5510.862228444281;5693.28833895763;5732.996725573008;5735.799247026334;5737.483626473617;5175.508326708994;5177.275181474596;5183.403908550527;5183.455737147583;5186.7147306898105;23601.763982360128;23768.881155594285;23792.048318067256;23978.640320395207;24022.15922442706;2510.071273628769;2559.36015996001;2714.8506832124226;3124.718775310233;3295.8516866740815;14815.407383704638;15064.472743453927;15104.848951510454;15228.238588070551;15423.22883855814;1905.3712274949235;1997.500624843789;1999.7801341181867;2007.7590689117253;2021.413790000898;81052.18947810505;84178;84650;85644.14355856425;86143;10940.890591094147;10994.670159895057;11098.944505277423;11508.136889733303;11945.343006134572;15218.16300103505;15296.235188240544;15340.846591534166;15360.385584576716;15370.923145384426;8033.477823941425;8172.18278172178;8204.261616454429;8426.578671066422;8435.198656127657;7876.448648594544;7881.802954926173;8010.79973000668;8103.513789172551;8124.146964568753;6682.532222744361;6941.167059952838;6977.581345119309;6987.755428559976;6989;1963.2834015584208;1994.16245177026;2005.1578337098454;2014.3554062700089;2032.5121970726918;979.485769970771;1016.3698506925754;1045.4668119259081;1062.5402193921047;1110.9723505757142;20518.281860134823;20840.013785456187;20848.270310539363;20989.895050524956;21015.579688406146;1002.2783595811004;1028.1928685981468;1029.0789743179812;1038.3043360948184;1068.108129711684;11354.829677554842;11718.589849355232;11747.353895535656;11995.460204290828;12067.456964436446;462400;466814;473644;494581;496291;89283;91053;91389.54305228431;92292;92375;1012.2054187462807;1024.5952848624752;1041.671873359889;1046.8482070099944;1076.4617691154422;17813.376531821323;18054.368097116538;18448.074562672482;18608.7208691867;18657.440276791716;41348.58651413448;41658.79170604127;42578;42768.1446371077;43281.35077973896;53183;53718;54703.452965469834;55258.44741552533;56362.43637563736;8883.911160888309;8970;8979.14698103679;9089.091090890857;9320.720378388389;13483.258420786951;13989.650258743613;14053.859461405254;14081.366338514996;14156.646083847987;11995;12171.14801963854;12304.384780760747;12468;12715.237085774883;11035.668929932115;11910.583129590423;11986.580469683518;12215.755684886075;12472.937635311766;12141.939290303491;12168.695782605506;12326.876731232573;12346;12824.422900969292;8271.54506502148;8776.341774367076;8886.600102995251;8914.509701966454;9106.817863642822;10918.062096415773;11903.988161006411;11988.280703157838;12141.332226727614;12250.509979600716 08:42:25 INFO - PROCESS | 11362 | |3;mootools.html;1330;1468.838427772945;1497.9026363286387;1625.8943168694034;1782.1801971093305;7462.477626566142;8038;8364.916350836489;8377.371697122724;8558.14418558144;8324.667013319475;8412.873806892901;8416.116307787686;8416.957915210416;8423.831523369528;2414.6257330113817;2437.341917682225;2440.7925326347195;2442.1574556777973;2443.035001174535;2424.636304554322;2478.033566908907;2489.0666000249817;2493.139866745979;2494.650748895156;2400.725800823499;2412.3124909400826;2440.255722004788;2443.7189723181796;2446.4740080882607;2341.9648705269433;2379.2267513058327;2402.5435167318155;2403.3390817525146;2418.903243870243;2398.0887262840183;2398.424378149249;2408.7109546854313;2417.214405318261;2418.830681852271;8385.119562445916;8589;8659.956700216459;8675.956620216859;8684.826303473958;5147.871303217412;5357.116075847481;5396.1366181410785;5400.405955344909;5401.891962160774;3353.832308384571;3433.210361616842;3491;3503.316853213624;3523.6476352364557;1093.3603841752504;1095.6603452929617;1095.687728997232;1107.7064577886786;1141.1840534018218;11397.943010284978;11432.256903301259;11479.827802582884;11491.712707182303;11496.310221386744;4303.397524346594;4467.218236808546;4543.4093567836635;4549.249373853278;4561.475430325489;9386.85919711205;9410.058994100535;9422.858657120012;9423.717288481357;9435.858462123073;5145.073886700355;5222.477752224747;5223.112070947948;5226.216067589892;5231.136862417658;4322.891927701832;4323.373110898902;4336.653067754635;4438.644908407384;4895.730734809548;3838.980805095957;3920.2355540669864;3947.921041579152;3977.801109944549;3978.3236849735613;1191.523390643732;1210.3766560221493;1211.1885037025038;1223.174357308813;1227.1164761371797;980.3921568627496;1004.8442491413842;1023.2530252915413;1030.304544432505;1033.1837848099917;5948.4943779779205;5977.22296101504;6029.487493563009;6176.289726681399;6214.130021796952;477.9928301075487;496.86832989257874;497.14987371594975;499.8000799680157;987.9506024698736;3950.111224974358;4110.671146308288;4130.235906357333;4130.256553820341;4232.30167022444;9543.952280238555;9742.879568849532;9849.655262065793;10059.446730429896;10200.38797672142;9936.701898943043;10065.949670251603;10081.69754907354;10089.798204036026;10091.69724908254;7941.96754421933;8206;8210.425270231026;8212.425130240945;8221.671133154727;5901.911471327848;6003.579749417673;6063;6103.511719062376;6158.938410615837;9684.32209745311;9828.803423931338;9833.60665573369;9906.950465247628;9936.254780891317;8809.251213646912;9013.549322533978;10114;10237.74405639865;10259.640912568024;7571.697132114654;7695.961520192587;7751.7674469766;7797;7887.9605601971625;8389.412741108064;8428.410011299395;8430.325573953945;8443.95778021106;8466.068732439304;7038.612876291853;7368.815779605553;7446.627668616439;7461.925380746123;7495.625218738932;7097.680604372712;7251.456140789356;7386.482946193715;7407.518511296964;7487.925120748723;6758.290379510081;6947.895781563179;6948.478864085113;6954.652267386509;6960.965195173992;5064.645474816727;5145.151050076695;5176.559992400688;5297.5232229099565;5324.6006549508165;5295.682259064469;5425.267588875451;5434.945650543602;5507.697076660822;5513.3108361454815 08:42:25 INFO - PROCESS | 11362 | |4;prototype.html;335.9445691460909;345.9567554055743;350.52153810049276;350.5407915630526;356.83050550988276;5258.52673259407;5259.973700131499;5334.1732031535175;5374.6506477078965;5386.010764025964;5254.527092561669;5254.635414063677;5268.603819987707;5269.920951185735;5276.525112739852;4023.074692820653;4207.684423668222;4207.957920420802;4221.978890105545;4236.766977816219;4016.072285303056;4127.690423218271;4157.046188291498;4180.51924028736;4182.22628813669;4144.668426525871;4147.129102888397;4155.709100362976;4158.251514727348;4173.478315210598;4006.8380169750735;4169.3954376615375;4206.684498662582;4211.831526738912;4230.661547076226;3515.1212196950764;3720.2373513429684;3735.320709101533;3746.119661879456;3755.267722794056;5054.570361519239;5119.539241468248;5123.820666276662;5128.230765385185;5160.716160611165;4634.420697412824;4771.570558649703;4802.375691160162;4804.927926081112;4805;5480.287562616874;5493.285872836505;5517.862053448655;5526.585506087019;5554.805581804618;4098.7130900836955;4120.278951183561;4127.4015267786;4131.091159944807;4137.54487006429;5524.33707955048;5773.892529226844;5790.276215473066;5794.275715535558;5802.535797136219;4122.793860306972;4177.540470548237;4184.409924228774;4206.831726730958;4221.598948099987;4235.512916014636;4260.848271622873;4269.807858646368;4290.4636920384955;4297.59172878576;4793.209120495149;4815.831445899376;4825.806967721252;4828.975855120702;4830.661853670209;5413.729313534308;5524.309461317335;5542.722863856791;5559.471850174308;5578;1424.3619837187111;1435.4904009076836;1436.3392839293833;1443.595793177912;1455.6215384000025;971.6696323250129;1003.814294355532;1008.8902207571759;1010.8180527504973;1017.31839667423;5148.794048238028;5208.5312321891215;5214.817481388133;5216.191490319006;5221.347331583552;5529.806456774074;5534.7786088556;5710.314762228559;5721.141828725725;5722.456366645162;5399.057513655068;5402.37872644643;5424.484673955968;5432.29380180574;5476.370217424967;2843.283839864203;2872.6696429910826;2894.623698919127;2923.766098712098;2931.0620601407772;5646.20953066571;5665.518430933417;5680.460356266148;5699.857503562444;5706.600537962303;5426.67439953604;5562.805301814498;5571.467846342207;5586.91619625706;5590.505933791381;5643.576731745217;5679.602427830012;5681.204631351614;5703.515201207861;5773.845230953826;5482.506574408163;5492.725363731877;5499.560035197254;5528;5579.442055794388;5303.416624171416;5367.651102678314;5444.6188766785945;5453.927507547107;5646.576506761927;5923.970380148072;5940.762369505172;5955.553333500092;5972.25346831646;5973.342932277533;4143.606357396043;4169.332906734908;4174.895627609334;4185.121124563754;4208.242516346964;5621.803236886853;5678.858028549319;5717.171010203414;5718.199452076796;5872.618279811799;5561.916571251353;5586.217929489793;5599.692016939108;5607.915881261702;5609.186667933209;5454.445483037315;5589.441055894378;5598.692071936082;5600.411956744646;5609.158626206102;5511;5533.2253484513;5535.640183388067;5562.888742225052;5564.638298510584;5345.812896548602;5600.355959064596;5603.859903502282;5617.859658412507;5636.182753500638;5332.626716129834;5381.461853814587;5448.046591846491;5460.26286451324;5497.312835895513 08:42:25 INFO - PROCESS | 11362 | |5;yui.html;763.8892360607712;772.2316295286188;797.5693125712115;836.9581520923953;882.2589025218823;13735.79396309055;14497.782533262009;15011.32449039793;15431.537053888373;15640.687186256268;14712.190829504372;14981.850181498181;15858.52424427269;15951.521454356387;15953.282102305395;716.1012928774381;835.2649668291895;852.5183271451641;853.2193043365313;854.4787679515522;732.9193788683241;738.918718940916;739.7447880481226;825.6202147012382;856.5075081827943;888.942218755782;891.2869704236617;891.4873947480224;892.054422312351;892.2282225874604;880.5949263338872;884.6284560484612;885.154677283193;886.016521660959;886.8049029213563;547.4443439908496;560.0814663951123;628.9622622642656;653.8855700252436;654.0548906829633;13617.455301788015;14107.083039602392;14148.292585370691;14305.642358941006;14345;12817.615471535775;12961.481540738454;13257.867421325856;13400.865991340157;13411.731765364735;12998.740025199442;13071.346432678423;13311.267880266581;13385.598432047054;13482.325883705873;4421.646268298528;4424.911501769979;4451.910961780779;4468.419105516295;4523.479799822997;60753;61874.69062654703;62176.68911655458;74415.62792186059;74551.25448745498;11525.366104864313;11661.76676466483;11818.586349477728;11948.163628545919;12012.03903687703;21026.579468410546;21093.789062109183;21096.261630842848;21110.261140859995;21173.894130529556;8530.14698530142;8566.742997710078;8574.742757717278;8589.785255368666;8651.178138076873;4453.3320001999955;4658.161530924466;4716.646251531149;4757.548032936866;4929.359183306147;3422.435298175773;3567.304375646724;3595.406757884972;3596.9820150899077;3606.2607165531003;618.935011823761;621.561798931752;623.2116372788427;623.5074291309814;630.6752022708309;698.6925752668911;739.6671497826;758.829263415727;762.2491845532146;770.6609091999502;9729.854052189223;9915.256355773347;10094.596216151418;10117.59529618807;10668.519916603771;802.1497212954287;813.8372325534916;815.4169768615468;819.8934138562068;846.1834329871704;4564.178447879413;4709.693869898446;4835.516448355207;4851.417829860368;4891.266310053449;78515.21484785079;83042.58478707568;83437;84967;86113.56943215244;47478.52521474741;61924.69037654873;63754.36245637577;73343.63328183324;73728.26271737322;64536.354636453034;67485;67632;68271;69356.999999999;9929.40423574559;10248.282620216512;10370.429150279482;10513.579456821948;10601.575936962436;47166;47185;47698.52301476941;47919.5208047929;48969;55805.441945581646;63463.682681586295;63694.36305636884;64088.67955660192;65585.67207163933;12304.384780761106;12658.416209915136;12758.61724148277;13058;13596.320183990958;13694.794578081137;14160.150390976574;14332.283385830875;14359.353829077507;15363.462278820187;13220.867791321964;13349.265790381622;13910.652233694238;13987.580372588838;14107.858921411065;13371.866281337452;14014.534331610885;14033.29833508341;14797.556073317817;14977.625559361104;12563.560275390317;12833.807492887801;12867.22796632205;12871.485140594272;13100.541481048118;10333.74165645865;10337;10399.792004160026;10652.733681658021;11166.441677916235;10722.624708135178;10936.014060873847;10950.616728414467;11013.669589912315;11072.224944254147 08:42:25 INFO - PROCESS | 11362 | __end_tp_report 08:42:25 INFO - PROCESS | 11362 | __start_cc_report 08:42:25 INFO - PROCESS | 11362 | _x_x_mozilla_cycle_collect,1150 08:42:25 INFO - PROCESS | 11362 | __end_cc_report 08:42:25 INFO - PROCESS | 11362 | __startTimestamp1481906545497__endTimestamp 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | ------- Summary: start ------- 08:42:25 INFO - PROCESS | 11362 | Number of tests: 6 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | [#0] dojo.html Cycles:165 Average:5502.05 Median:5695.54 stddev:623.35 (10.9%) stddev-sans-first:597.69 08:42:25 INFO - PROCESS | 11362 | Values: 3164.8 3209.2 3229.4 3230.7 3258.1 5492.5 5539.7 5554.9 5565.4 5571.7 5491.4 5494.1 5494.1 5497.7 5514.0 4931.9 4953.6 5007.3 5014.8 5034.9 4927.5 4953.4 4981.6 5012.9 5024.0 4985.6 5044.5 5050.2 5053.5 5055.1 4998.1 5035.0 5060.6 5060.8 5063.6 4890.5 4943.4 4977.7 5003.6 5006.2 5425.3 5488.8 5551.5 5556.3 5569.7 5674.7 5869.3 5872.5 5886.0 5920.4 5782.8 5915.9 5923.8 5928.6 5933.9 5564.4 5571.8 5637.2 5650.9 5655.5 5825.3 6084.9 6093.1 6117.1 6117.3 5674.7 5695.5 5713.5 5755.9 5769.3 5824.8 5847.9 5850.4 5852.9 5862.7 5758.3 5803.4 5808.9 5819.2 5825.2 5786.9 5903.9 5970.4 5971.3 5976.6 4623.3 4624.6 4625.5 4641.7 4653.5 4056.9 4089.7 4104.1 4122.4 4139.0 5487.5 5536.3 5544.6 5568.6 5712.5 5953.2 5997.9 6046.6 6060.8 6060.9 5684.2 5685.5 5686.6 5690.7 5697.4 4930.5 4990.4 5085.3 5087.2 5088.7 6047.4 6118.4 6129.3 6137.0 6138.3 5968.0 6061.2 6071.1 6072.1 6088.4 5919.4 6247.1 6249.9 6258.9 6261.4 5686.9 5798.5 5844.6 5853.4 5971.3 5971.9 6021.9 6039.0 6040.1 6042.0 5898.4 5900.6 5904.4 5913.2 5917.7 5597.6 5640.7 5705.1 5733.1 5750.7 5737.6 5760.7 5765.0 5772.0 5786.0 5833.3 5835.4 5843.7 5845.4 5853.0 5507.7 5521.6 5657.8 5674.2 5703.3 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | [#1] ext.html Cycles:180 Average:63310.64 Median:207276.06 stddev:127785.36 (61.6%) stddev-sans-first:128057.05 08:42:25 INFO - PROCESS | 11362 | Values: 585.5 619.6 645.3 655.0 662.3 34209.7 34811.8 44102.6 44874.6 45097.3 43392.1 46931.8 46988.0 47018.0 47032.5 8857.6 8994.0 9003.7 9004.8 9005.5 8379.9 8568.0 10619.4 10859.7 10868.1 10892.1 10894.9 10938.2 11029.2 11033.9 10592.4 10625.8 10655.1 10663.7 10779.7 10620.4 10694.8 10700.8 10703.7 10704.1 44042.0 44231.0 44354.0 44399.8 44435.0 3754.5 3785.8 3807.1 3893.7 3939.2 32150.8 32809.8 33201.5 33975.7 34340.3 3538.5 3621.6 3644.7 3660.3 3665.5 375629.0 375907.0 376451.0 376454.0 376728.1 37824.0 38660.0 38721.4 64974.7 65473.0 41167.8 41342.8 41355.6 41369.4 41370.0 15330.2 15563.3 15568.7 15574.0 15578.1 11509.7 11755.2 12606.1 12802.7 12813.9 9327.6 9641.1 9649.1 9697.2 9788.0 3562.7 3658.9 3682.5 3695.7 3731.4 991.7 1046.7 1136.2 1142.9 1172.6 33621.5 34158.8 34480.5 34485.3 34746.7 1114.4 1149.1 1167.3 1189.0 1202.1 15728.1 17933.7 18036.5 18593.5 18624.5 561531.0 562453.0 566110.0 566853.0 566950.0 62424.4 62922.7 62992.4 63005.4 63099.4 1313.7 1334.9 1337.3 1364.4 1403.9 26542.7 35342.0 36643.6 36856.8 37176.6 60177.7 60983.7 60992.7 61063.0 61133.1 481389.0 483553.0 483585.0 483865.0 485382.0 27278.3 28022.9 30300.0 31214.0 31280.7 47398.8 47946.0 49047.3 52858.5 53428.5 41233.1 41692.0 41984.4 42005.4 42844.6 41911.2 42005.0 42262.0 43138.4 43616.8 42784.8 43074.4 43920.3 43983.1 46030.8 35681.5 38426.4 44112.0 44603.3 44945.8 33641.7 35936.8 36023.5 36104.0 36147.5 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | [#2] jquery.html Cycles:180 Average:29125.23 Median:23780.46 stddev:78961.74 (332.0%) stddev-sans-first:79153.80 08:42:25 INFO - PROCESS | 11362 | Values: 403.5 405.1 410.0 411.4 431.4 17130.0 18895.1 19450.9 20308.8 20313.2 19271.4 19584.9 19614.5 20004.6 20027.9 5455.8 5674.6 5750.7 5760.5 5760.6 5576.4 5680.2 5750.2 5759.4 5762.5 5660.6 5732.1 5735.6 5737.9 5738.6 5510.9 5693.3 5733.0 5735.8 5737.5 5175.5 5177.3 5183.4 5183.5 5186.7 23601.8 23768.9 23792.0 23978.6 24022.2 2510.1 2559.4 2714.9 3124.7 3295.9 14815.4 15064.5 15104.8 15228.2 15423.2 1905.4 1997.5 1999.8 2007.8 2021.4 81052.2 84178.0 84650.0 85644.1 86143.0 10940.9 10994.7 11098.9 11508.1 11945.3 15218.2 15296.2 15340.8 15360.4 15370.9 8033.5 8172.2 8204.3 8426.6 8435.2 7876.4 7881.8 8010.8 8103.5 8124.1 6682.5 6941.2 6977.6 6987.8 6989.0 1963.3 1994.2 2005.2 2014.4 2032.5 979.5 1016.4 1045.5 1062.5 1111.0 20518.3 20840.0 20848.3 20989.9 21015.6 1002.3 1028.2 1029.1 1038.3 1068.1 11354.8 11718.6 11747.4 11995.5 12067.5 462400.0 466814.0 473644.0 494581.0 496291.0 89283.0 91053.0 91389.5 92292.0 92375.0 1012.2 1024.6 1041.7 1046.8 1076.5 17813.4 18054.4 18448.1 18608.7 18657.4 41348.6 41658.8 42578.0 42768.1 43281.4 53183.0 53718.0 54703.5 55258.4 56362.4 8883.9 8970.0 8979.1 9089.1 9320.7 13483.3 13989.7 14053.9 14081.4 14156.6 11995.0 12171.1 12304.4 12468.0 12715.2 11035.7 11910.6 11986.6 12215.8 12472.9 12141.9 12168.7 12326.9 12346.0 12824.4 8271.5 8776.3 8886.6 8914.5 9106.8 10918.1 11904.0 11988.3 12141.3 12250.5 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | [#3] mootools.html Cycles:180 Average:5632.89 Median:5162.22 stddev:3073.51 (59.5%) stddev-sans-first:3065.12 08:42:25 INFO - PROCESS | 11362 | Values: 1330.0 1468.8 1497.9 1625.9 1782.2 7462.5 8038.0 8364.9 8377.4 8558.1 8324.7 8412.9 8416.1 8417.0 8423.8 2414.6 2437.3 2440.8 2442.2 2443.0 2424.6 2478.0 2489.1 2493.1 2494.7 2400.7 2412.3 2440.3 2443.7 2446.5 2342.0 2379.2 2402.5 2403.3 2418.9 2398.1 2398.4 2408.7 2417.2 2418.8 8385.1 8589.0 8660.0 8676.0 8684.8 5147.9 5357.1 5396.1 5400.4 5401.9 3353.8 3433.2 3491.0 3503.3 3523.6 1093.4 1095.7 1095.7 1107.7 1141.2 11397.9 11432.3 11479.8 11491.7 11496.3 4303.4 4467.2 4543.4 4549.2 4561.5 9386.9 9410.1 9422.9 9423.7 9435.9 5145.1 5222.5 5223.1 5226.2 5231.1 4322.9 4323.4 4336.7 4438.6 4895.7 3839.0 3920.2 3947.9 3977.8 3978.3 1191.5 1210.4 1211.2 1223.2 1227.1 980.4 1004.8 1023.3 1030.3 1033.2 5948.5 5977.2 6029.5 6176.3 6214.1 478.0 496.9 497.1 499.8 988.0 3950.1 4110.7 4130.2 4130.3 4232.3 9544.0 9742.9 9849.7 10059.4 10200.4 9936.7 10065.9 10081.7 10089.8 10091.7 7942.0 8206.0 8210.4 8212.4 8221.7 5901.9 6003.6 6063.0 6103.5 6158.9 9684.3 9828.8 9833.6 9907.0 9936.3 8809.3 9013.5 10114.0 10237.7 10259.6 7571.7 7696.0 7751.8 7797.0 7888.0 8389.4 8428.4 8430.3 8444.0 8466.1 7038.6 7368.8 7446.6 7461.9 7495.6 7097.7 7251.5 7386.5 7407.5 7487.9 6758.3 6947.9 6948.5 6954.7 6961.0 5064.6 5145.2 5176.6 5297.5 5324.6 5295.7 5425.3 5434.9 5507.7 5513.3 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | [#4] prototype.html Cycles:180 Average:4676.28 Median:5289.97 stddev:1346.06 (25.4%) stddev-sans-first:1309.82 08:42:25 INFO - PROCESS | 11362 | Values: 335.9 346.0 350.5 350.5 356.8 5258.5 5260.0 5334.2 5374.7 5386.0 5254.5 5254.6 5268.6 5269.9 5276.5 4023.1 4207.7 4208.0 4222.0 4236.8 4016.1 4127.7 4157.0 4180.5 4182.2 4144.7 4147.1 4155.7 4158.3 4173.5 4006.8 4169.4 4206.7 4211.8 4230.7 3515.1 3720.2 3735.3 3746.1 3755.3 5054.6 5119.5 5123.8 5128.2 5160.7 4634.4 4771.6 4802.4 4804.9 4805.0 5480.3 5493.3 5517.9 5526.6 5554.8 4098.7 4120.3 4127.4 4131.1 4137.5 5524.3 5773.9 5790.3 5794.3 5802.5 4122.8 4177.5 4184.4 4206.8 4221.6 4235.5 4260.8 4269.8 4290.5 4297.6 4793.2 4815.8 4825.8 4829.0 4830.7 5413.7 5524.3 5542.7 5559.5 5578.0 1424.4 1435.5 1436.3 1443.6 1455.6 971.7 1003.8 1008.9 1010.8 1017.3 5148.8 5208.5 5214.8 5216.2 5221.3 5529.8 5534.8 5710.3 5721.1 5722.5 5399.1 5402.4 5424.5 5432.3 5476.4 2843.3 2872.7 2894.6 2923.8 2931.1 5646.2 5665.5 5680.5 5699.9 5706.6 5426.7 5562.8 5571.5 5586.9 5590.5 5643.6 5679.6 5681.2 5703.5 5773.8 5482.5 5492.7 5499.6 5528.0 5579.4 5303.4 5367.7 5444.6 5453.9 5646.6 5924.0 5940.8 5955.6 5972.3 5973.3 4143.6 4169.3 4174.9 4185.1 4208.2 5621.8 5678.9 5717.2 5718.2 5872.6 5561.9 5586.2 5599.7 5607.9 5609.2 5454.4 5589.4 5598.7 5600.4 5609.2 5511.0 5533.2 5535.6 5562.9 5564.6 5345.8 5600.4 5603.9 5617.9 5636.2 5332.6 5381.5 5448.0 5460.3 5497.3 08:42:25 INFO - PROCESS | 11362 | 08:42:25 INFO - PROCESS | 11362 | [#5] yui.html Cycles:180 Average:17739.72 Median:4713.17 stddev:22529.77 (478.0%) stddev-sans-first:22556.91 08:42:25 INFO - PROCESS | 11362 | Values: 763.9 772.2 797.6 837.0 882.3 13735.8 14497.8 15011.3 15431.5 15640.7 14712.2 14981.9 15858.5 15951.5 15953.3 716.1 835.3 852.5 853.2 854.5 732.9 738.9 739.7 825.6 856.5 888.9 891.3 891.5 892.1 892.2 880.6 884.6 885.2 886.0 886.8 547.4 560.1 629.0 653.9 654.1 13617.5 14107.1 14148.3 14305.6 14345.0 12817.6 12961.5 13257.9 13400.9 13411.7 12998.7 13071.3 13311.3 13385.6 13482.3 4421.6 4424.9 4451.9 4468.4 4523.5 60753.0 61874.7 62176.7 74415.6 74551.3 11525.4 11661.8 11818.6 11948.2 12012.0 21026.6 21093.8 21096.3 21110.3 21173.9 8530.1 8566.7 8574.7 8589.8 8651.2 4453.3 4658.2 4716.6 4757.5 4929.4 3422.4 3567.3 3595.4 3597.0 3606.3 618.9 621.6 623.2 623.5 630.7 698.7 739.7 758.8 762.2 770.7 9729.9 9915.3 10094.6 10117.6 10668.5 802.1 813.8 815.4 819.9 846.2 4564.2 4709.7 4835.5 4851.4 4891.3 78515.2 83042.6 83437.0 84967.0 86113.6 47478.5 61924.7 63754.4 73343.6 73728.3 64536.4 67485.0 67632.0 68271.0 69357.0 9929.4 10248.3 10370.4 10513.6 10601.6 47166.0 47185.0 47698.5 47919.5 48969.0 55805.4 63463.7 63694.4 64088.7 65585.7 12304.4 12658.4 12758.6 13058.0 13596.3 13694.8 14160.2 14332.3 14359.4 15363.5 13220.9 13349.3 13910.7 13987.6 14107.9 13371.9 14014.5 14033.3 14797.6 14977.6 12563.6 12833.8 12867.2 12871.5 13100.5 10333.7 10337.0 10399.8 10652.7 11166.4 10722.6 10936.0 10950.6 11013.7 11072.2 08:42:25 INFO - PROCESS | 11362 | -------- Summary: end -------- 08:42:25 INFO - PROCESS | 11362 | 08:42:26 INFO - TEST-INFO | 11362: exit 0 08:42:26 INFO - TEST-OK | dromaeo_css | took 1115443ms 08:42:26 INFO - TEST-START | kraken 08:42:26 INFO - operating with platform_type : linux_ 08:42:26 INFO - Initialising browser for kraken test... 08:42:26 INFO - TEST-INFO | started process 11679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi1DtuJ/profile http://localhost:38376/getInfo.html) 08:42:30 INFO - PROCESS | 11679 | __metrics Screen width/height:1600/1200 08:42:30 INFO - PROCESS | 11679 | colorDepth:24 08:42:30 INFO - PROCESS | 11679 | Browser inner width/height: 1024/697 08:42:30 INFO - PROCESS | 11679 | __metrics 08:42:30 INFO - PROCESS | 11679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:42:30 INFO - PROCESS | 11679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:31 INFO - PROCESS | 11679 | console.error: PushService: 08:42:31 INFO - PROCESS | 11679 | stateChangeProcessEnqueue: Error transitioning state 08:42:31 INFO - PROCESS | 11679 | UnknownError 08:42:31 INFO - TEST-INFO | 11679: exit 0 08:42:31 INFO - Browser initialized. 08:42:31 INFO - Running cycle 1/1 for kraken test... 08:42:31 INFO - TEST-INFO | started process 11770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi1DtuJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:43 INFO - PROCESS | 11770 | RSS: Main: 144699392 08:42:43 INFO - PROCESS | 11770 | 08:42:46 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38376/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:47 INFO - PROCESS | 11770 | RSS: Main: 186146816 08:42:47 INFO - PROCESS | 11770 | 08:42:49 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38376/tests/kraken/driver.html?testName=audio-dft) 08:42:50 INFO - PROCESS | 11770 | RSS: Main: 175632384 08:42:50 INFO - PROCESS | 11770 | 08:42:52 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38376/tests/kraken/driver.html?testName=audio-fft) 08:42:53 INFO - PROCESS | 11770 | RSS: Main: 266551296 08:42:53 INFO - PROCESS | 11770 | 08:42:55 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38376/tests/kraken/driver.html?testName=audio-oscillator) 08:42:56 INFO - PROCESS | 11770 | RSS: Main: 172531712 08:42:56 INFO - PROCESS | 11770 | 08:42:58 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:59 INFO - PROCESS | 11770 | RSS: Main: 175525888 08:42:59 INFO - PROCESS | 11770 | 08:43:01 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38376/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:02 INFO - PROCESS | 11770 | RSS: Main: 213966848 08:43:02 INFO - PROCESS | 11770 | 08:43:05 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38376/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:06 INFO - PROCESS | 11770 | RSS: Main: 212758528 08:43:06 INFO - PROCESS | 11770 | 08:43:09 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38376/tests/kraken/driver.html?testName=json-parse-financial) 08:43:09 INFO - PROCESS | 11770 | RSS: Main: 211591168 08:43:09 INFO - PROCESS | 11770 | 08:43:11 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:11 INFO - PROCESS | 11770 | RSS: Main: 173158400 08:43:11 INFO - PROCESS | 11770 | 08:43:13 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:14 INFO - PROCESS | 11770 | RSS: Main: 180322304 08:43:14 INFO - PROCESS | 11770 | 08:43:16 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:16 INFO - PROCESS | 11770 | RSS: Main: 189739008 08:43:16 INFO - PROCESS | 11770 | 08:43:19 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:19 INFO - PROCESS | 11770 | RSS: Main: 199049216 08:43:19 INFO - PROCESS | 11770 | 08:43:22 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:23 INFO - PROCESS | 11770 | RSS: Main: 195018752 08:43:23 INFO - PROCESS | 11770 | 08:43:24 INFO - PROCESS | 11770 | Cycle 1(1): loaded http://localhost:38376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38376/tests/kraken/driver.html?testName=ai-astar) 08:43:25 INFO - PROCESS | 11770 | RSS: Main: 244928512 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | __start_tp_report 08:43:25 INFO - PROCESS | 11770 | _x_x_mozilla_page_load 08:43:25 INFO - PROCESS | 11770 | _x_x_mozilla_page_load_details 08:43:25 INFO - PROCESS | 11770 | |i|pagename|runs| 08:43:25 INFO - PROCESS | 11770 | |0;ai-astar;100;110;110;111;111;111;110;111;110;110 08:43:25 INFO - PROCESS | 11770 | |1;audio-beat-detection;143;119;124;155;124;119;118;118;155;117 08:43:25 INFO - PROCESS | 11770 | |2;audio-dft;161;161;159;160;161;160;160;161;160;160 08:43:25 INFO - PROCESS | 11770 | |3;audio-fft;76;77;76;108;76;76;75;78;117;77 08:43:25 INFO - PROCESS | 11770 | |4;audio-oscillator;82;82;117;81;82;81;97;82;81;111 08:43:25 INFO - PROCESS | 11770 | |5;imaging-gaussian-blur;117;117;118;117;117;116;116;117;116;116 08:43:25 INFO - PROCESS | 11770 | |6;imaging-darkroom;145;145;146;146;146;146;146;146;146;145 08:43:25 INFO - PROCESS | 11770 | |7;imaging-desaturate;85;84;84;85;85;85;84;84;84;84 08:43:25 INFO - PROCESS | 11770 | |8;json-parse-financial;50;49;49;49;49;62;50;50;49;49 08:43:25 INFO - PROCESS | 11770 | |9;json-stringify-tinderbox;58;59;58;58;59;59;58;58;59;59 08:43:25 INFO - PROCESS | 11770 | |10;stanford-crypto-aes;74;83;74;75;79;76;76;74;74;74 08:43:25 INFO - PROCESS | 11770 | |11;stanford-crypto-ccm;127;130;135;122;125;123;120;121;162;128 08:43:25 INFO - PROCESS | 11770 | |12;stanford-crypto-pbkdf2;155;151;152;152;152;153;153;151;155;165 08:43:25 INFO - PROCESS | 11770 | |13;stanford-crypto-sha256-iterative;63;67;64;63;67;63;62;66;62;61 08:43:25 INFO - PROCESS | 11770 | __end_tp_report 08:43:25 INFO - PROCESS | 11770 | __start_cc_report 08:43:25 INFO - PROCESS | 11770 | _x_x_mozilla_cycle_collect,1596 08:43:25 INFO - PROCESS | 11770 | __end_cc_report 08:43:25 INFO - PROCESS | 11770 | __startTimestamp1481906605131__endTimestamp 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | ------- Summary: start ------- 08:43:25 INFO - PROCESS | 11770 | Number of tests: 14 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:3.34 (3.0%) stddev-sans-first:0.53 08:43:25 INFO - PROCESS | 11770 | Values: 100.0 110.0 110.0 111.0 111.0 111.0 110.0 111.0 110.0 110.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:124.00 stddev:15.58 (12.6%) stddev-sans-first:15.70 08:43:25 INFO - PROCESS | 11770 | Values: 143.0 119.0 124.0 155.0 124.0 119.0 118.0 118.0 155.0 117.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 08:43:25 INFO - PROCESS | 11770 | Values: 161.0 161.0 159.0 160.0 161.0 160.0 160.0 161.0 160.0 160.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:15.40 (20.3%) stddev-sans-first:16.09 08:43:25 INFO - PROCESS | 11770 | Values: 76.0 77.0 76.0 108.0 76.0 76.0 75.0 78.0 117.0 77.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:82.00 stddev:13.81 (16.8%) stddev-sans-first:14.37 08:43:25 INFO - PROCESS | 11770 | Values: 82.0 82.0 117.0 81.0 82.0 81.0 97.0 82.0 81.0 111.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:43:25 INFO - PROCESS | 11770 | Values: 117.0 117.0 118.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:43:25 INFO - PROCESS | 11770 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 08:43:25 INFO - PROCESS | 11770 | Values: 85.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 84.0 84.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:49.50 stddev:4.03 (8.1%) stddev-sans-first:4.27 08:43:25 INFO - PROCESS | 11770 | Values: 50.0 49.0 49.0 49.0 49.0 62.0 50.0 50.0 49.0 49.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:43:25 INFO - PROCESS | 11770 | Values: 58.0 59.0 58.0 58.0 59.0 59.0 58.0 58.0 59.0 59.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:2.96 (3.9%) stddev-sans-first:3.06 08:43:25 INFO - PROCESS | 11770 | Values: 74.0 83.0 74.0 75.0 79.0 76.0 76.0 74.0 74.0 74.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:127.50 stddev:12.37 (9.7%) stddev-sans-first:13.09 08:43:25 INFO - PROCESS | 11770 | Values: 127.0 130.0 135.0 122.0 125.0 123.0 120.0 121.0 162.0 128.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:153.00 stddev:4.15 (2.7%) stddev-sans-first:4.38 08:43:25 INFO - PROCESS | 11770 | Values: 155.0 151.0 152.0 152.0 152.0 153.0 153.0 151.0 155.0 165.0 08:43:25 INFO - PROCESS | 11770 | 08:43:25 INFO - PROCESS | 11770 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:2.15 (3.4%) stddev-sans-first:2.26 08:43:25 INFO - PROCESS | 11770 | Values: 63.0 67.0 64.0 63.0 67.0 63.0 62.0 66.0 62.0 61.0 08:43:25 INFO - PROCESS | 11770 | -------- Summary: end -------- 08:43:25 INFO - PROCESS | 11770 | 08:43:26 INFO - TEST-INFO | 11770: exit 0 08:43:26 INFO - TEST-OK | kraken | took 59938ms 08:43:26 INFO - SUITE-END | took 1175s 08:43:26 INFO - Completed test suite (00:19:35) 08:43:26 INFO - javascript benchmark 08:43:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.7626428017898, 3209.2458272306003, 3229.4025605263014, 3230.660780618035, 3258.136593802641, 5492.4782145696145, 5539.667619942801, 5554.888902221953, 5565.387807341189, 5571.665700057989, 5491.368492623339, 5494.066008778507, 5494.0934745767, 5497.697626630534, 5513.972430137854, 4931.901361972749, 4953.603711703073, 5007.273945277932, 5014.774335154927, 5034.924476132861, 4927.531884470969, 4953.356063711731, 4981.5516603505675, 5012.874678133039, 5024.045431368047, 4985.551300382965, 5044.4955504449445, 5050.217216331456, 5053.519915608012, 5055.140626093555, 4998.10034193845, 5035.018171456568, 5060.620453466005, 5060.7722652480725, 5063.594912407036, 4890.530282207498, 4943.357363542752, 4977.7262250576205, 5003.649744517885, 5006.173981293082, 5425.294711687495, 5488.765027868738, 5551.472610102034, 5556.277683901108, 5569.693666848321, 5674.687892165929, 5869.266341707286, 5872.500837428824, 5886.0, 5920.407959204088, 5782.797602083949, 5915.852103697442, 5923.763049478016, 5928.584999050068, 5933.851653708649, 5564.443555644403, 5571.804986825442, 5637.210790489335, 5650.886982260414, 5655.547556195576, 5825.330087040044, 6084.878302433926, 6093.086037094383, 6117.082437634391, 6117.265928088658, 5674.687892165888, 5695.5443564514735, 5713.485786279255, 5755.913661295084, 5769.336526299446, 5824.796132135355, 5847.912281315784, 5850.385709500526, 5852.941470585325, 5862.706864656835, 5758.280214973129, 5803.361630220672, 5808.912866307009, 5819.214406055213, 5825.1844741736195, 5786.942130578725, 5903.881922361528, 5970.373110823301, 5971.313298970674, 5976.551758618121, 4623.283391074322, 4624.560666736655, 4625.468071171791, 4641.651876109306, 4653.464851542049, 4056.918861622751, 4089.672826173899, 4104.138130992465, 4122.40225167349, 4138.958610413918, 5487.506124448819, 5536.307961504812, 5544.556435485151, 5568.6101972862325, 5712.485876271156, 5953.166556682068, 5997.940020599825, 6046.637201767908, 6060.757569697251, 6060.878782424415, 5684.232628595169, 5685.4883060523925, 5686.5735069869925, 5690.6870122142855, 5697.401772813878, 4930.457649658535, 4990.4011518618, 5085.338905942203, 5087.16061849798, 5088.6946783193125, 6047.395260473917, 6118.357572455006, 6129.325774164839, 6136.978641397139, 6138.32709113608, 5967.9701601491715, 6061.212042434456, 6071.058985857199, 6072.14989901423, 6088.4215999479975, 5919.4080591940465, 6247.0629405589525, 6249.906251406142, 6258.937410625836, 6261.373862613885, 5686.943130568807, 5798.478136967693, 5844.590878638454, 5853.414658534112, 5971.343152253336, 5971.91042134377, 6021.87956240864, 6039.033754599243, 6040.063790112539, 6041.969790151021, 5898.439648233411, 5900.5574581907385, 5904.350521442552, 5913.201717768046, 5917.704114794329, 5597.5521958242425, 5640.746166422603, 5705.058665320342, 5733.054046082517, 5750.741216645178, 5737.56968227393, 5760.683162426107, 5764.971175144097, 5772.04761214395, 5785.971070144622, 5833.329167145663, 5835.358110607915, 5843.707814609167, 5845.41545845412, 5852.970735146297, 5507.7246137692155, 5521.558275337883, 5657.830265092054, 5674.177244299636, 5703.315602127771], "value": 5460.3906790597275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.5432762445291, 619.6437048697, 645.2708439463407, 654.9574277671954, 662.324429082336, 34209.65790342096, 34811.825940870294, 44102.55897441028, 44874.551254487444, 45097.32354014692, 43392.132157356835, 46931.76534117333, 46988.0, 47018.0, 47032.52967470324, 8857.645694172226, 8993.955030224839, 9003.684871029514, 9004.819903601923, 9005.50469724165, 8379.874301885477, 8568.0, 10619.41593212373, 10859.67420977368, 10868.076213521821, 10892.128629709605, 10894.945525272402, 10938.234323597351, 11029.227954043221, 11033.944830275837, 10592.41741704206, 10625.84061239082, 10655.094316983066, 10663.733406664856, 10779.67660970172, 10620.362778233331, 10694.78610427795, 10700.785984280348, 10703.678889633324, 10704.090152337061, 44042.0, 44231.0, 44354.0, 44399.77800111011, 44435.0, 3754.455603937441, 3785.8296376662843, 3807.067268519203, 3893.6885049196, 3939.172773717523, 32150.83924580362, 32809.835950820096, 33201.501977470354, 33975.6602433975, 34340.313193736234, 3538.486919396673, 3621.5835178954494, 3644.726645501598, 3660.3045421369857, 3665.505156803824, 375629.0, 375907.0, 376451.0, 376454.0, 376728.1163594192, 37824.0, 38660.0, 38721.41917871234, 64974.67512662501, 65473.0, 41167.794161029, 41342.793286033375, 41355.58644413578, 41369.37945930813, 41370.0, 15330.156841373608, 15563.299651515708, 15568.688626227413, 15574.0, 15578.06531608107, 11509.654710358702, 11755.177137600456, 12606.117571770072, 12802.679933001564, 12813.93593032029, 9327.626894924128, 9641.084097010773, 9649.083337082966, 9697.224222062217, 9788.0, 3562.7149828014217, 3658.8657516170074, 3682.5212722345923, 3695.667389934919, 3731.440283957428, 991.667791289926, 1046.68076236747, 1136.1933027550367, 1142.868570114431, 1172.648205538335, 33621.49567756485, 34158.82920585381, 34480.482792757626, 34485.310293794486, 34746.652533474844, 1114.3759494683004, 1149.1209224942925, 1167.311286341063, 1188.9643310700692, 1202.1193952552665, 15728.05631662104, 17933.701822676423, 18036.458906232834, 18593.53516162107, 18624.534386640444, 561531.0, 562453.0, 566110.0, 566853.0, 566950.0, 62424.375756241854, 62922.685386572775, 62992.370076299565, 63005.36994630087, 63099.36900631027, 1313.6847156682327, 1334.9065565410328, 1337.2979185927466, 1364.36557000995, 1403.9227842468763, 26542.734572654026, 35342.0, 36643.63356366402, 36856.81571592125, 37176.62823371732, 60177.69911150416, 60983.695081526086, 60992.695036524536, 61063.0, 61133.08300375409, 481389.0, 483553.0, 483585.0, 483865.0, 485382.0, 27278.318042049108, 28022.85988570044, 30300.0, 31214.0, 31280.68719312778, 47398.763006184745, 47946.0, 49047.26429103638, 52858.471415285356, 53428.46571534235, 41233.11368204317, 41692.0, 41984.370234445894, 42005.36991945062, 42844.57155428531, 41911.161776763685, 42005.0, 42262.0, 43138.35292470553, 43616.78191609149, 42784.786076069424, 43074.353884692384, 43920.34119488274, 43983.12033759371, 46030.76984615056, 35681.46477802783, 38426.42360364653, 44112.0, 44603.330950035124, 44945.775271123435, 33641.66358336385, 35936.82031589825, 36023.45964810478, 36104.0, 36147.45778813267], "value": 20158.45524485122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.4795114302548, 405.118866465438, 409.9979500102499, 411.3788179848429, 431.417586258551, 17130.0, 18895.149718262677, 19450.90274548627, 20308.796912030874, 20313.187472501082, 19271.421857344267, 19584.902075489637, 19614.509637259074, 20004.59990800183, 20027.899860500715, 5455.754491047913, 5674.631148975303, 5750.7412166452405, 5760.452756988079, 5760.596758226926, 5576.442355764431, 5680.233168522259, 5750.1949727038245, 5759.395263497336, 5762.53899688026, 5660.60375773694, 5732.111522713986, 5735.569832262597, 5737.913931291034, 5738.598298119134, 5510.862228444281, 5693.28833895763, 5732.996725573008, 5735.799247026334, 5737.483626473617, 5175.508326708994, 5177.275181474596, 5183.403908550527, 5183.455737147583, 5186.7147306898105, 23601.763982360128, 23768.881155594285, 23792.048318067256, 23978.640320395207, 24022.15922442706, 2510.071273628769, 2559.36015996001, 2714.8506832124226, 3124.718775310233, 3295.8516866740815, 14815.407383704638, 15064.472743453927, 15104.848951510454, 15228.238588070551, 15423.22883855814, 1905.3712274949235, 1997.500624843789, 1999.7801341181867, 2007.7590689117253, 2021.413790000898, 81052.18947810505, 84178.0, 84650.0, 85644.14355856425, 86143.0, 10940.890591094147, 10994.670159895057, 11098.944505277423, 11508.136889733303, 11945.343006134572, 15218.16300103505, 15296.235188240544, 15340.846591534166, 15360.385584576716, 15370.923145384426, 8033.477823941425, 8172.18278172178, 8204.261616454429, 8426.578671066422, 8435.198656127657, 7876.448648594544, 7881.802954926173, 8010.79973000668, 8103.513789172551, 8124.146964568753, 6682.532222744361, 6941.167059952838, 6977.581345119309, 6987.755428559976, 6989.0, 1963.2834015584208, 1994.16245177026, 2005.1578337098454, 2014.3554062700089, 2032.5121970726918, 979.485769970771, 1016.3698506925754, 1045.4668119259081, 1062.5402193921047, 1110.9723505757142, 20518.281860134823, 20840.013785456187, 20848.270310539363, 20989.895050524956, 21015.579688406146, 1002.2783595811004, 1028.1928685981468, 1029.0789743179812, 1038.3043360948184, 1068.108129711684, 11354.829677554842, 11718.589849355232, 11747.353895535656, 11995.460204290828, 12067.456964436446, 462400.0, 466814.0, 473644.0, 494581.0, 496291.0, 89283.0, 91053.0, 91389.54305228431, 92292.0, 92375.0, 1012.2054187462807, 1024.5952848624752, 1041.671873359889, 1046.8482070099944, 1076.4617691154422, 17813.376531821323, 18054.368097116538, 18448.074562672482, 18608.7208691867, 18657.440276791716, 41348.58651413448, 41658.79170604127, 42578.0, 42768.1446371077, 43281.35077973896, 53183.0, 53718.0, 54703.452965469834, 55258.44741552533, 56362.43637563736, 8883.911160888309, 8970.0, 8979.14698103679, 9089.091090890857, 9320.720378388389, 13483.258420786951, 13989.650258743613, 14053.859461405254, 14081.366338514996, 14156.646083847987, 11995.0, 12171.14801963854, 12304.384780760747, 12468.0, 12715.237085774883, 11035.668929932115, 11910.583129590423, 11986.580469683518, 12215.755684886075, 12472.937635311766, 12141.939290303491, 12168.695782605506, 12326.876731232573, 12346.0, 12824.422900969292, 8271.54506502148, 8776.341774367076, 8886.600102995251, 8914.509701966454, 9106.817863642822, 10918.062096415773, 11903.988161006411, 11988.280703157838, 12141.332226727614, 12250.509979600716], "value": 9655.430954062944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.0, 1468.838427772945, 1497.9026363286387, 1625.8943168694034, 1782.1801971093305, 7462.477626566142, 8038.0, 8364.916350836489, 8377.371697122724, 8558.14418558144, 8324.667013319475, 8412.873806892901, 8416.116307787686, 8416.957915210416, 8423.831523369528, 2414.6257330113817, 2437.341917682225, 2440.7925326347195, 2442.1574556777973, 2443.035001174535, 2424.636304554322, 2478.033566908907, 2489.0666000249817, 2493.139866745979, 2494.650748895156, 2400.725800823499, 2412.3124909400826, 2440.255722004788, 2443.7189723181796, 2446.4740080882607, 2341.9648705269433, 2379.2267513058327, 2402.5435167318155, 2403.3390817525146, 2418.903243870243, 2398.0887262840183, 2398.424378149249, 2408.7109546854313, 2417.214405318261, 2418.830681852271, 8385.119562445916, 8589.0, 8659.956700216459, 8675.956620216859, 8684.826303473958, 5147.871303217412, 5357.116075847481, 5396.1366181410785, 5400.405955344909, 5401.891962160774, 3353.832308384571, 3433.210361616842, 3491.0, 3503.316853213624, 3523.6476352364557, 1093.3603841752504, 1095.6603452929617, 1095.687728997232, 1107.7064577886786, 1141.1840534018218, 11397.943010284978, 11432.256903301259, 11479.827802582884, 11491.712707182303, 11496.310221386744, 4303.397524346594, 4467.218236808546, 4543.4093567836635, 4549.249373853278, 4561.475430325489, 9386.85919711205, 9410.058994100535, 9422.858657120012, 9423.717288481357, 9435.858462123073, 5145.073886700355, 5222.477752224747, 5223.112070947948, 5226.216067589892, 5231.136862417658, 4322.891927701832, 4323.373110898902, 4336.653067754635, 4438.644908407384, 4895.730734809548, 3838.980805095957, 3920.2355540669864, 3947.921041579152, 3977.801109944549, 3978.3236849735613, 1191.523390643732, 1210.3766560221493, 1211.1885037025038, 1223.174357308813, 1227.1164761371797, 980.3921568627496, 1004.8442491413842, 1023.2530252915413, 1030.304544432505, 1033.1837848099917, 5948.4943779779205, 5977.22296101504, 6029.487493563009, 6176.289726681399, 6214.130021796952, 477.9928301075487, 496.86832989257874, 497.14987371594975, 499.8000799680157, 987.9506024698736, 3950.111224974358, 4110.671146308288, 4130.235906357333, 4130.256553820341, 4232.30167022444, 9543.952280238555, 9742.879568849532, 9849.655262065793, 10059.446730429896, 10200.38797672142, 9936.701898943043, 10065.949670251603, 10081.69754907354, 10089.798204036026, 10091.69724908254, 7941.96754421933, 8206.0, 8210.425270231026, 8212.425130240945, 8221.671133154727, 5901.911471327848, 6003.579749417673, 6063.0, 6103.511719062376, 6158.938410615837, 9684.32209745311, 9828.803423931338, 9833.60665573369, 9906.950465247628, 9936.254780891317, 8809.251213646912, 9013.549322533978, 10114.0, 10237.74405639865, 10259.640912568024, 7571.697132114654, 7695.961520192587, 7751.7674469766, 7797.0, 7887.9605601971625, 8389.412741108064, 8428.410011299395, 8430.325573953945, 8443.95778021106, 8466.068732439304, 7038.612876291853, 7368.815779605553, 7446.627668616439, 7461.925380746123, 7495.625218738932, 7097.680604372712, 7251.456140789356, 7386.482946193715, 7407.518511296964, 7487.925120748723, 6758.290379510081, 6947.895781563179, 6948.478864085113, 6954.652267386509, 6960.965195173992, 5064.645474816727, 5145.151050076695, 5176.559992400688, 5297.5232229099565, 5324.6006549508165, 5295.682259064469, 5425.267588875451, 5434.945650543602, 5507.697076660822, 5513.3108361454815], "value": 4526.71827469212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.9445691460909, 345.9567554055743, 350.52153810049276, 350.5407915630526, 356.83050550988276, 5258.52673259407, 5259.973700131499, 5334.1732031535175, 5374.6506477078965, 5386.010764025964, 5254.527092561669, 5254.635414063677, 5268.603819987707, 5269.920951185735, 5276.525112739852, 4023.074692820653, 4207.684423668222, 4207.957920420802, 4221.978890105545, 4236.766977816219, 4016.072285303056, 4127.690423218271, 4157.046188291498, 4180.51924028736, 4182.22628813669, 4144.668426525871, 4147.129102888397, 4155.709100362976, 4158.251514727348, 4173.478315210598, 4006.8380169750735, 4169.3954376615375, 4206.684498662582, 4211.831526738912, 4230.661547076226, 3515.1212196950764, 3720.2373513429684, 3735.320709101533, 3746.119661879456, 3755.267722794056, 5054.570361519239, 5119.539241468248, 5123.820666276662, 5128.230765385185, 5160.716160611165, 4634.420697412824, 4771.570558649703, 4802.375691160162, 4804.927926081112, 4805.0, 5480.287562616874, 5493.285872836505, 5517.862053448655, 5526.585506087019, 5554.805581804618, 4098.7130900836955, 4120.278951183561, 4127.4015267786, 4131.091159944807, 4137.54487006429, 5524.33707955048, 5773.892529226844, 5790.276215473066, 5794.275715535558, 5802.535797136219, 4122.793860306972, 4177.540470548237, 4184.409924228774, 4206.831726730958, 4221.598948099987, 4235.512916014636, 4260.848271622873, 4269.807858646368, 4290.4636920384955, 4297.59172878576, 4793.209120495149, 4815.831445899376, 4825.806967721252, 4828.975855120702, 4830.661853670209, 5413.729313534308, 5524.309461317335, 5542.722863856791, 5559.471850174308, 5578.0, 1424.3619837187111, 1435.4904009076836, 1436.3392839293833, 1443.595793177912, 1455.6215384000025, 971.6696323250129, 1003.814294355532, 1008.8902207571759, 1010.8180527504973, 1017.31839667423, 5148.794048238028, 5208.5312321891215, 5214.817481388133, 5216.191490319006, 5221.347331583552, 5529.806456774074, 5534.7786088556, 5710.314762228559, 5721.141828725725, 5722.456366645162, 5399.057513655068, 5402.37872644643, 5424.484673955968, 5432.29380180574, 5476.370217424967, 2843.283839864203, 2872.6696429910826, 2894.623698919127, 2923.766098712098, 2931.0620601407772, 5646.20953066571, 5665.518430933417, 5680.460356266148, 5699.857503562444, 5706.600537962303, 5426.67439953604, 5562.805301814498, 5571.467846342207, 5586.91619625706, 5590.505933791381, 5643.576731745217, 5679.602427830012, 5681.204631351614, 5703.515201207861, 5773.845230953826, 5482.506574408163, 5492.725363731877, 5499.560035197254, 5528.0, 5579.442055794388, 5303.416624171416, 5367.651102678314, 5444.6188766785945, 5453.927507547107, 5646.576506761927, 5923.970380148072, 5940.762369505172, 5955.553333500092, 5972.25346831646, 5973.342932277533, 4143.606357396043, 4169.332906734908, 4174.895627609334, 4185.121124563754, 4208.242516346964, 5621.803236886853, 5678.858028549319, 5717.171010203414, 5718.199452076796, 5872.618279811799, 5561.916571251353, 5586.217929489793, 5599.692016939108, 5607.915881261702, 5609.186667933209, 5454.445483037315, 5589.441055894378, 5598.692071936082, 5600.411956744646, 5609.158626206102, 5511.0, 5533.2253484513, 5535.640183388067, 5562.888742225052, 5564.638298510584, 5345.812896548602, 5600.355959064596, 5603.859903502282, 5617.859658412507, 5636.182753500638, 5332.626716129834, 5381.461853814587, 5448.046591846491, 5460.26286451324, 5497.312835895513], "value": 4254.092347696747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.8892360607712, 772.2316295286188, 797.5693125712115, 836.9581520923953, 882.2589025218823, 13735.79396309055, 14497.782533262009, 15011.32449039793, 15431.537053888373, 15640.687186256268, 14712.190829504372, 14981.850181498181, 15858.52424427269, 15951.521454356387, 15953.282102305395, 716.1012928774381, 835.2649668291895, 852.5183271451641, 853.2193043365313, 854.4787679515522, 732.9193788683241, 738.918718940916, 739.7447880481226, 825.6202147012382, 856.5075081827943, 888.942218755782, 891.2869704236617, 891.4873947480224, 892.054422312351, 892.2282225874604, 880.5949263338872, 884.6284560484612, 885.154677283193, 886.016521660959, 886.8049029213563, 547.4443439908496, 560.0814663951123, 628.9622622642656, 653.8855700252436, 654.0548906829633, 13617.455301788015, 14107.083039602392, 14148.292585370691, 14305.642358941006, 14345.0, 12817.615471535775, 12961.481540738454, 13257.867421325856, 13400.865991340157, 13411.731765364735, 12998.740025199442, 13071.346432678423, 13311.267880266581, 13385.598432047054, 13482.325883705873, 4421.646268298528, 4424.911501769979, 4451.910961780779, 4468.419105516295, 4523.479799822997, 60753.0, 61874.69062654703, 62176.68911655458, 74415.62792186059, 74551.25448745498, 11525.366104864313, 11661.76676466483, 11818.586349477728, 11948.163628545919, 12012.03903687703, 21026.579468410546, 21093.789062109183, 21096.261630842848, 21110.261140859995, 21173.894130529556, 8530.14698530142, 8566.742997710078, 8574.742757717278, 8589.785255368666, 8651.178138076873, 4453.3320001999955, 4658.161530924466, 4716.646251531149, 4757.548032936866, 4929.359183306147, 3422.435298175773, 3567.304375646724, 3595.406757884972, 3596.9820150899077, 3606.2607165531003, 618.935011823761, 621.561798931752, 623.2116372788427, 623.5074291309814, 630.6752022708309, 698.6925752668911, 739.6671497826, 758.829263415727, 762.2491845532146, 770.6609091999502, 9729.854052189223, 9915.256355773347, 10094.596216151418, 10117.59529618807, 10668.519916603771, 802.1497212954287, 813.8372325534916, 815.4169768615468, 819.8934138562068, 846.1834329871704, 4564.178447879413, 4709.693869898446, 4835.516448355207, 4851.417829860368, 4891.266310053449, 78515.21484785079, 83042.58478707568, 83437.0, 84967.0, 86113.56943215244, 47478.52521474741, 61924.69037654873, 63754.36245637577, 73343.63328183324, 73728.26271737322, 64536.354636453034, 67485.0, 67632.0, 68271.0, 69356.999999999, 9929.40423574559, 10248.282620216512, 10370.429150279482, 10513.579456821948, 10601.575936962436, 47166.0, 47185.0, 47698.52301476941, 47919.5208047929, 48969.0, 55805.441945581646, 63463.682681586295, 63694.36305636884, 64088.67955660192, 65585.67207163933, 12304.384780761106, 12658.416209915136, 12758.61724148277, 13058.0, 13596.320183990958, 13694.794578081137, 14160.150390976574, 14332.283385830875, 14359.353829077507, 15363.462278820187, 13220.867791321964, 13349.265790381622, 13910.652233694238, 13987.580372588838, 14107.858921411065, 13371.866281337452, 14014.534331610885, 14033.29833508341, 14797.556073317817, 14977.625559361104, 12563.560275390317, 12833.807492887801, 12867.22796632205, 12871.485140594272, 13100.541481048118, 10333.74165645865, 10337.0, 10399.792004160026, 10652.733681658021, 11166.441677916235, 10722.624708135178, 10936.014060873847, 10950.616728414467, 11013.669589912315, 11072.224944254147], "value": 7366.14633664904, "unit": "score"}], "name": "dromaeo_css", "value": 7295.496747420411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 110.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 124.0, 155.0, 124.0, 119.0, 118.0, 118.0, 155.0, 117.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 108.0, 76.0, 76.0, 75.0, 78.0, 117.0, 77.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 117.0, 81.0, 82.0, 81.0, 97.0, 82.0, 81.0, 111.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 49.0, 62.0, 50.0, 50.0, 49.0, 49.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 74.0, 75.0, 79.0, 76.0, 76.0, 74.0, 74.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 135.0, 122.0, 125.0, 123.0, 120.0, 121.0, 162.0, 128.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 152.0, 152.0, 152.0, 153.0, 153.0, 151.0, 155.0, 165.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 64.0, 63.0, 67.0, 63.0, 62.0, 66.0, 62.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1450.9, "alertThreshold": 2.0}]} 08:43:26 INFO - Return code: 0 08:43:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:26 INFO - # TBPL SUCCESS # 08:43:26 INFO - Running post-action listener: _resource_record_post_action 08:43:26 INFO - [mozharness: 2016-12-16 16:43:26.424171Z] Finished run-tests step (success) 08:43:26 INFO - Running post-run listener: _resource_record_post_run 08:43:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356118528; Read time: 28; Write time: 236772 08:43:26 INFO - TinderboxPrint: CPU usage
13.0% 08:43:26 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 08:43:26 INFO - TinderboxPrint: I/O write bytes / time
356,118,528 / 236,772 08:43:26 INFO - TinderboxPrint: CPU idle
8,279.3 (87.0%) 08:43:26 INFO - TinderboxPrint: CPU user
1,189.6 (12.5%) 08:43:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108146688; Read time: 0; Write time: 117512 08:43:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247971840; Read time: 16; Write time: 119260 08:43:27 INFO - Running post-run listener: _upload_blobber_files 08:43:27 INFO - Blob upload gear active. 08:43:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:43:27 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:27 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:30 INFO - (blobuploader) - INFO - Done attempting. 08:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:31 INFO - (blobuploader) - INFO - Done attempting. 08:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:43:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:32 INFO - (blobuploader) - INFO - Done attempting. 08:43:32 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:32 INFO - Return code: 0 08:43:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34d20db6e6244f991ba5a318aec440542445fd7b12c8ab47a33739ea23952e42d26218cdb743fae9917d6ff376c60252ee7d3c5a76484d34872f6d99eb12515a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e3674428e4895404ae3e1a5ae63998dbf3cce124c7309f645da5d5f36b0e5cc915925fbb1c23822775a5947ec859fa8dade37baa611ff299b8e807d3da762d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/770b2100d6e20e5308bdef1b131f4840b7eb039ac0fc890b432c5fd2163318a5b4a368791b99e619a57d7017135b001d6fa9bed8e17a7c5150a5fb767885ce7a"} 08:43:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:32 INFO - Contents: 08:43:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34d20db6e6244f991ba5a318aec440542445fd7b12c8ab47a33739ea23952e42d26218cdb743fae9917d6ff376c60252ee7d3c5a76484d34872f6d99eb12515a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e3674428e4895404ae3e1a5ae63998dbf3cce124c7309f645da5d5f36b0e5cc915925fbb1c23822775a5947ec859fa8dade37baa611ff299b8e807d3da762d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/770b2100d6e20e5308bdef1b131f4840b7eb039ac0fc890b432c5fd2163318a5b4a368791b99e619a57d7017135b001d6fa9bed8e17a7c5150a5fb767885ce7a"} 08:43:32 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:32 INFO - Copying logs to upload dir... 08:43:32 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.467672 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-16 08:43:32.077724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 08:43:32.081437) ========= 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=8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34d20db6e6244f991ba5a318aec440542445fd7b12c8ab47a33739ea23952e42d26218cdb743fae9917d6ff376c60252ee7d3c5a76484d34872f6d99eb12515a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e3674428e4895404ae3e1a5ae63998dbf3cce124c7309f645da5d5f36b0e5cc915925fbb1c23822775a5947ec859fa8dade37baa611ff299b8e807d3da762d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/770b2100d6e20e5308bdef1b131f4840b7eb039ac0fc890b432c5fd2163318a5b4a368791b99e619a57d7017135b001d6fa9bed8e17a7c5150a5fb767885ce7a"} build_url:https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/CCeH7TM1RbOK_DI5enYqIw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/34d20db6e6244f991ba5a318aec440542445fd7b12c8ab47a33739ea23952e42d26218cdb743fae9917d6ff376c60252ee7d3c5a76484d34872f6d99eb12515a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e3674428e4895404ae3e1a5ae63998dbf3cce124c7309f645da5d5f36b0e5cc915925fbb1c23822775a5947ec859fa8dade37baa611ff299b8e807d3da762d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/770b2100d6e20e5308bdef1b131f4840b7eb039ac0fc890b432c5fd2163318a5b4a368791b99e619a57d7017135b001d6fa9bed8e17a7c5150a5fb767885ce7a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 08:43:32.109826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:43:32.110150) ========= 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=8887e36bb8e381bfd44124ac000001a8-1481905277.263838-2145741299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 08:43:32.194872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 08:43:32.195193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 08:43:32.195514) ========= ========= Total master_lag: 0.18 =========