builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1486669170.49 results: success (0) buildid: 20170209094120 builduid: 1d71f35064d24a19a906379ddedd53ff revision: dbd0fa47f7a2970bbe4842e3cef7cec3101fe01a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.490970) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.491409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.491681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.507740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.508036) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 11:39:31-- 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% 42.5M=0s 2017-02-09 11:39:31 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132202 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.653334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.653641) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018445 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:30.705690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 11:39:30.707608) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dbd0fa47f7a2970bbe4842e3cef7cec3101fe01a --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-beta --rev dbd0fa47f7a2970bbe4842e3cef7cec3101fe01a --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=934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 11:39:31,317 truncating revision to first 12 chars 2017-02-09 11:39:31,317 Setting DEBUG logging. 2017-02-09 11:39:31,317 attempt 1/10 2017-02-09 11:39:31,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dbd0fa47f7a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 11:39:32,561 unpacking tar archive at: mozilla-beta-dbd0fa47f7a2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.568404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 11:39:32.288892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:32.289271) ========= script_repo_revision: dbd0fa47f7a2970bbe4842e3cef7cec3101fe01a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:32.289700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:32.289962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 11:39:32.298959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-09 11:39:32.299268) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:39:33 INFO - MultiFileLogger online at 20170209 11:39:33 in /builds/slave/test 11:39:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:39:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:39:33 INFO - {'append_to_log': False, 11:39:33 INFO - 'base_work_dir': '/builds/slave/test', 11:39:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:39:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:39:33 INFO - 'branch': 'Mozilla-Beta', 11:39:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:39:33 INFO - 'config_files': ('talos/linux_config.py',), 11:39:33 INFO - 'default_actions': ('clobber', 11:39:33 INFO - 'read-buildbot-config', 11:39:33 INFO - 'download-and-extract', 11:39:33 INFO - 'populate-webroot', 11:39:33 INFO - 'create-virtualenv', 11:39:33 INFO - 'install', 11:39:33 INFO - 'run-tests'), 11:39:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:39:33 INFO - 'download_minidump_stackwalk': True, 11:39:33 INFO - 'download_symbols': 'ondemand', 11:39:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:39:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:39:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:39:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:39:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:39:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:39:33 INFO - 'installer_path': 'installer.exe', 11:39:33 INFO - 'log_level': 'info', 11:39:33 INFO - 'log_name': 'talos', 11:39:33 INFO - 'log_to_console': True, 11:39:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:39:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:39:33 INFO - 'opt_config_files': (), 11:39:33 INFO - 'pip_index': False, 11:39:33 INFO - 'sps_profile': False, 11:39:33 INFO - 'sps_profile_interval': 0, 11:39:33 INFO - 'suite': 'dromaeojs', 11:39:33 INFO - 'system_bits': '32', 11:39:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:39:33 INFO - 'title': 'talos-linux64-ix-057', 11:39:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:39:33 INFO - 'use_talos_json': True, 11:39:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:39:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:39:33 INFO - 'work_dir': 'build'} 11:39:33 INFO - [mozharness: 2017-02-09 19:39:33.012528Z] Running clobber step. 11:39:33 INFO - Running pre-action listener: _resource_record_pre_action 11:39:33 INFO - Running main action method: clobber 11:39:33 INFO - rmtree: /builds/slave/test/build 11:39:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:39:33 INFO - Running post-action listener: _resource_record_post_action 11:39:33 INFO - [mozharness: 2017-02-09 19:39:33.542632Z] Finished clobber step (success) 11:39:33 INFO - [mozharness: 2017-02-09 19:39:33.542732Z] Running read-buildbot-config step. 11:39:33 INFO - Running pre-action listener: _resource_record_pre_action 11:39:33 INFO - Running main action method: read_buildbot_config 11:39:33 INFO - Using buildbot properties: 11:39:33 INFO - { 11:39:33 INFO - "project": "", 11:39:33 INFO - "product": "firefox", 11:39:33 INFO - "script_repo_revision": "production", 11:39:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:39:33 INFO - "repository": "", 11:39:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:39:33 INFO - "buildid": "20170209094120", 11:39:33 INFO - "pgo_build": "True", 11:39:33 INFO - "basedir": "/builds/slave/test", 11:39:33 INFO - "buildnumber": 12, 11:39:33 INFO - "slavename": "talos-linux64-ix-057", 11:39:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:39:33 INFO - "platform": "ubuntu64_hw", 11:39:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:39:33 INFO - "branch": "mozilla-beta", 11:39:33 INFO - "repo_path": "releases/mozilla-beta", 11:39:33 INFO - "revision": "dbd0fa47f7a2970bbe4842e3cef7cec3101fe01a", 11:39:33 INFO - "stage_platform": "linux64-pgo", 11:39:33 INFO - "builduid": "1d71f35064d24a19a906379ddedd53ff", 11:39:33 INFO - "slavebuilddir": "test" 11:39:33 INFO - } 11:39:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 11:39:33 INFO - Running post-action listener: _resource_record_post_action 11:39:33 INFO - [mozharness: 2017-02-09 19:39:33.545131Z] Finished read-buildbot-config step (success) 11:39:33 INFO - [mozharness: 2017-02-09 19:39:33.545218Z] Running download-and-extract step. 11:39:33 INFO - Running pre-action listener: _resource_record_pre_action 11:39:33 INFO - Running main action method: download_and_extract 11:39:33 INFO - mkdir: /builds/slave/test/build/tests 11:39: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')]} 11:39:33 INFO - trying https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:39:33 INFO - Downloading https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:39:34 INFO - Downloaded 1327 bytes. 11:39:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:39:34 INFO - Using the following test package requirements: 11:39:34 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:39:34 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:39:34 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 11:39:34 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'jsshell-linux-x86_64.zip'], 11:39:34 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:39:34 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:39:34 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 11:39:34 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 11:39:34 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:39:34 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:39:34 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:39:34 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:39:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:39:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:39:34 INFO - Fetch https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:39:34 INFO - Http code: 200 11:39:34 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 11:39:34 INFO - x-amz-cf-id: HiPey8VzL1BqCpaOczyd8MuE7HxZoynxCAAE-yjRDXVcETUlfapCMg== 11:39:34 INFO - x-amz-version-id: CJ9kvlDroJ3a2cf4yxbNGmzP7saX8Nn5 11:39:35 INFO - Expected file size: 21958928 11:39:35 INFO - Obtained file size: 21958928 11:39:39 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:39:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:39:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:39:39 INFO - Fetch https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:39:39 INFO - Http code: 200 11:39:39 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 11:39:39 INFO - x-amz-cf-id: NhgTkUtWy0sUUs_rxsVYYKqeKtipT-UjoaY63MF93FYMGo2BwR6ttA== 11:39:39 INFO - x-amz-version-id: CJ9kvlDroJ3a2cf4yxbNGmzP7saX8Nn5 11:39:39 INFO - Expected file size: 21958928 11:39:39 INFO - Obtained file size: 21958928 11:39:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 11:39:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:39:44 INFO - Fetch https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 11:39:44 INFO - Http code: 200 11:39:44 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 11:39:44 INFO - x-amz-cf-id: ffSrHw6HNDujnorUCg810UpoyrB46dtue5Zw8plJjTdDmYLfE4hxgg== 11:39:44 INFO - x-amz-version-id: Dyt34CL3XOJpK8yEJkf_yAwvvZraaBZG 11:39:44 INFO - Expected file size: 14403005 11:39:44 INFO - Obtained file size: 14403005 11:39:45 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')]} 11:39:45 INFO - trying https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:39:45 INFO - Downloading https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:39:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:39:46 INFO - Downloaded 57720133 bytes. 11:39:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:39:46 INFO - mkdir: /builds/slave/test/properties 11:39:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:46 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:46 INFO - Contents: 11:39:46 INFO - build_url:https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:39:47 INFO - Running post-action listener: _resource_record_post_action 11:39:47 INFO - Running post-action listener: set_extra_try_arguments 11:39:47 INFO - [mozharness: 2017-02-09 19:39:47.009493Z] Finished download-and-extract step (success) 11:39:47 INFO - [mozharness: 2017-02-09 19:39:47.009720Z] Running populate-webroot step. 11:39:47 INFO - Running pre-action listener: _resource_record_pre_action 11:39:47 INFO - Running main action method: populate_webroot 11:39:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:47 INFO - '--tppagecycles', 11:39:47 INFO - '7'], 11:39:47 INFO - 'tests': ['tsvgm']}}, 11:39:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['damp', 'tps']}, 11:39:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'tests': ['damp', 'tps']}, 11:39:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['dromaeo_dom']}, 11:39:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['basic_compositor_video']}, 11:39:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:39:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['a11yr', 11:39:47 INFO - 'ts_paint', 11:39:47 INFO - 'tpaint', 11:39:47 INFO - 'sessionrestore', 11:39:47 INFO - 'sessionrestore_no_auto_restore', 11:39:47 INFO - 'tabpaint']}, 11:39:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:47 INFO - 'ts_paint', 11:39:47 INFO - 'tpaint', 11:39:47 INFO - 'sessionrestore', 11:39:47 INFO - 'sessionrestore_no_auto_restore', 11:39:47 INFO - 'tabpaint']}, 11:39:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:39:47 INFO - 'ts_paint', 11:39:47 INFO - 'tpaint', 11:39:47 INFO - 'sessionrestore', 11:39:47 INFO - 'sessionrestore_no_auto_restore', 11:39:47 INFO - 'tabpaint']}, 11:39:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:39:47 INFO - 'ts_paint', 11:39:47 INFO - 'tpaint', 11:39:47 INFO - 'sessionrestore', 11:39:47 INFO - 'sessionrestore_no_auto_restore', 11:39:47 INFO - 'tabpaint']}, 11:39:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['a11yr', 11:39:47 INFO - 'ts_paint', 11:39:47 INFO - 'tpaint', 11:39:47 INFO - 'sessionrestore', 11:39:47 INFO - 'sessionrestore_no_auto_restore', 11:39:47 INFO - 'tabpaint']}, 11:39:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['a11yr', 11:39:47 INFO - 'ts_paint', 11:39:47 INFO - 'tpaint', 11:39:47 INFO - 'sessionrestore', 11:39:47 INFO - 'sessionrestore_no_auto_restore', 11:39:47 INFO - 'tabpaint']}, 11:39:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['tsvgx', 11:39:47 INFO - 'tsvgr_opacity', 11:39:47 INFO - 'tart', 11:39:47 INFO - 'tscrollx', 11:39:47 INFO - 'cart']}, 11:39:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:47 INFO - 'tsvgr_opacity', 11:39:47 INFO - 'tart', 11:39:47 INFO - 'tscrollx', 11:39:47 INFO - 'cart']}, 11:39:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'talos_options': ['--disable-e10s'], 11:39:47 INFO - 'tests': ['tp5o']}, 11:39:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'tests': ['tp5o']}, 11:39:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'talos_options': ['--disable-e10s', 11:39:47 INFO - '--xperf_path', 11:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:47 INFO - 'tests': ['tp5n']}, 11:39:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:47 INFO - 'talos_options': ['--xperf_path', 11:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:47 INFO - 'tests': ['tp5n']}}, 11:39:47 INFO - 'talos.zip': {'path': '', 11:39:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:47 INFO - Running post-action listener: _resource_record_post_action 11:39:47 INFO - [mozharness: 2017-02-09 19:39:47.025171Z] Finished populate-webroot step (success) 11:39:47 INFO - [mozharness: 2017-02-09 19:39:47.025257Z] Running create-virtualenv step. 11:39:47 INFO - Running pre-action listener: _resource_record_pre_action 11:39:47 INFO - Running main action method: create_virtualenv 11:39:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:47 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 11:39:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:47 INFO - Using real prefix '/usr' 11:39:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:49 INFO - Installing pip.................done. 11:39:49 INFO - Return code: 0 11:39:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:39:49 INFO - Reading from file tmpfile_stdout 11:39:49 INFO - Output received: 11:39:49 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) 11:39:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:49 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:39:49 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 11:39:49 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 11:39:49 INFO - Using env: {'DISPLAY': ':0', 11:39:49 INFO - 'HOME': '/home/cltbld', 11:39:49 INFO - 'LANG': 'en_US.UTF-8', 11:39:49 INFO - 'LANGUAGE': 'en_US:en', 11:39:49 INFO - 'LOGNAME': 'cltbld', 11:39:49 INFO - 'MAIL': '/var/mail/cltbld', 11:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:49 INFO - 'MOZ_NO_REMOTE': '1', 11:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:49 INFO - 'NO_EM_RESTART': '1', 11:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:49 INFO - 'PWD': '/builds/slave/test', 11:39:49 INFO - 'SHELL': '/bin/bash', 11:39:49 INFO - 'SHLVL': '1', 11:39:49 INFO - 'TERM': 'linux', 11:39:49 INFO - 'TMOUT': '86400', 11:39:49 INFO - 'USER': 'cltbld', 11:39:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:49 INFO - '_': '/tools/buildbot/bin/python'} 11:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:50 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 11:39:50 INFO - Cleaning up... 11:39:50 INFO - Return code: 0 11:39:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:50 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:39:50 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 11:39:50 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 11:39:50 INFO - Using env: {'DISPLAY': ':0', 11:39:50 INFO - 'HOME': '/home/cltbld', 11:39:50 INFO - 'LANG': 'en_US.UTF-8', 11:39:50 INFO - 'LANGUAGE': 'en_US:en', 11:39:50 INFO - 'LOGNAME': 'cltbld', 11:39:50 INFO - 'MAIL': '/var/mail/cltbld', 11:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:50 INFO - 'MOZ_NO_REMOTE': '1', 11:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:50 INFO - 'NO_EM_RESTART': '1', 11:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:50 INFO - 'PWD': '/builds/slave/test', 11:39:50 INFO - 'SHELL': '/bin/bash', 11:39:50 INFO - 'SHLVL': '1', 11:39:50 INFO - 'TERM': 'linux', 11:39:50 INFO - 'TMOUT': '86400', 11:39:50 INFO - 'USER': 'cltbld', 11:39:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:50 INFO - '_': '/tools/buildbot/bin/python'} 11:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:50 INFO - Downloading/unpacking psutil>=3.1.1 11:39:50 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 11:39:50 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 11:39:50 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 11:39:50 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 11:39:50 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 11:39:50 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 11:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:52 INFO - Installing collected packages: psutil 11:39:52 INFO - Running setup.py install for psutil 11:39:52 INFO - building 'psutil._psutil_linux' extension 11:39:52 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 11:39:52 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 11:39:52 INFO - building 'psutil._psutil_posix' extension 11:39:52 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 11:39:52 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 11:39:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:52 INFO - Successfully installed psutil 11:39:52 INFO - Cleaning up... 11:39:52 INFO - Return code: 0 11:39:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39:52 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')]} 11:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:52 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')]} 11:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:52 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:39:52 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 11:39:52 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 11:39:52 INFO - Using env: {'DISPLAY': ':0', 11:39:52 INFO - 'HOME': '/home/cltbld', 11:39:52 INFO - 'LANG': 'en_US.UTF-8', 11:39:52 INFO - 'LANGUAGE': 'en_US:en', 11:39:52 INFO - 'LOGNAME': 'cltbld', 11:39:52 INFO - 'MAIL': '/var/mail/cltbld', 11:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:52 INFO - 'MOZ_NO_REMOTE': '1', 11:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:52 INFO - 'NO_EM_RESTART': '1', 11:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:52 INFO - 'PWD': '/builds/slave/test', 11:39:52 INFO - 'SHELL': '/bin/bash', 11:39:52 INFO - 'SHLVL': '1', 11:39:52 INFO - 'TERM': 'linux', 11:39:52 INFO - 'TMOUT': '86400', 11:39:52 INFO - 'USER': 'cltbld', 11:39:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:52 INFO - '_': '/tools/buildbot/bin/python'} 11:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39:53 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 11:39:53 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 11:39:53 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 11:39:53 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 11:39:53 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 11:39:53 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 11:39:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:39:55 INFO - Installing collected packages: mozsystemmonitor 11:39:55 INFO - Running setup.py install for mozsystemmonitor 11:39:55 INFO - Successfully installed mozsystemmonitor 11:39:55 INFO - Cleaning up... 11:39:55 INFO - Return code: 0 11:39:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:55 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:39:55 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 11:39:55 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 11:39:55 INFO - Using env: {'DISPLAY': ':0', 11:39:55 INFO - 'HOME': '/home/cltbld', 11:39:55 INFO - 'LANG': 'en_US.UTF-8', 11:39:55 INFO - 'LANGUAGE': 'en_US:en', 11:39:55 INFO - 'LOGNAME': 'cltbld', 11:39:55 INFO - 'MAIL': '/var/mail/cltbld', 11:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:55 INFO - 'MOZ_NO_REMOTE': '1', 11:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:55 INFO - 'NO_EM_RESTART': '1', 11:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:55 INFO - 'PWD': '/builds/slave/test', 11:39:55 INFO - 'SHELL': '/bin/bash', 11:39:55 INFO - 'SHLVL': '1', 11:39:55 INFO - 'TERM': 'linux', 11:39:55 INFO - 'TMOUT': '86400', 11:39:55 INFO - 'USER': 'cltbld', 11:39:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:55 INFO - '_': '/tools/buildbot/bin/python'} 11:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:39:55 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 11:39:55 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 11:39:55 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 11:39:55 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 11:39:55 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 11:39:55 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 11:39:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39:57 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 11:39:57 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 11:39:57 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 11:39:57 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 11:39:57 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 11:39:57 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 11:39:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:57 INFO - warning: no files found matching '*.txt' 11:39:57 INFO - no previously-included directories found matching 'build' 11:39:57 INFO - no previously-included directories found matching 'dist' 11:39:57 INFO - no previously-included directories found matching '.git*' 11:39:57 INFO - Installing collected packages: jsonschema, functools32 11:39:57 INFO - Running setup.py install for functools32 11:39:58 INFO - warning: no files found matching '*.txt' 11:39:58 INFO - no previously-included directories found matching 'build' 11:39:58 INFO - no previously-included directories found matching 'dist' 11:39:58 INFO - no previously-included directories found matching '.git*' 11:39:58 INFO - Successfully installed jsonschema functools32 11:39:58 INFO - Cleaning up... 11:39:58 INFO - Return code: 0 11:39:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:58 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:39:58 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 11:39:58 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 11:39:58 INFO - Using env: {'DISPLAY': ':0', 11:39:58 INFO - 'HOME': '/home/cltbld', 11:39:58 INFO - 'LANG': 'en_US.UTF-8', 11:39:58 INFO - 'LANGUAGE': 'en_US:en', 11:39:58 INFO - 'LOGNAME': 'cltbld', 11:39:58 INFO - 'MAIL': '/var/mail/cltbld', 11:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:58 INFO - 'MOZ_NO_REMOTE': '1', 11:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:58 INFO - 'NO_EM_RESTART': '1', 11:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:58 INFO - 'PWD': '/builds/slave/test', 11:39:58 INFO - 'SHELL': '/bin/bash', 11:39:58 INFO - 'SHLVL': '1', 11:39:58 INFO - 'TERM': 'linux', 11:39:58 INFO - 'TMOUT': '86400', 11:39:58 INFO - 'USER': 'cltbld', 11:39:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:58 INFO - '_': '/tools/buildbot/bin/python'} 11:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:39:58 INFO - Cleaning up... 11:39:58 INFO - Return code: 0 11:39:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:58 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:39:58 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 11:39:58 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 11:39:58 INFO - Using env: {'DISPLAY': ':0', 11:39:58 INFO - 'HOME': '/home/cltbld', 11:39:58 INFO - 'LANG': 'en_US.UTF-8', 11:39:58 INFO - 'LANGUAGE': 'en_US:en', 11:39:58 INFO - 'LOGNAME': 'cltbld', 11:39:58 INFO - 'MAIL': '/var/mail/cltbld', 11:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:58 INFO - 'MOZ_NO_REMOTE': '1', 11:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:58 INFO - 'NO_EM_RESTART': '1', 11:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:58 INFO - 'PWD': '/builds/slave/test', 11:39:58 INFO - 'SHELL': '/bin/bash', 11:39:58 INFO - 'SHLVL': '1', 11:39:58 INFO - 'TERM': 'linux', 11:39:58 INFO - 'TMOUT': '86400', 11:39:58 INFO - 'USER': 'cltbld', 11:39:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:58 INFO - '_': '/tools/buildbot/bin/python'} 11:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:39:58 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 11:39:58 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 11:39:58 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 11:39:58 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 11:39:58 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 11:39:58 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 11:40:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40:00 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 11:40:00 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 11:40:00 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 11:40:00 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 11:40:00 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 11:40:00 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 11:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:01 INFO - Downloading docopt-0.6.1.tar.gz 11:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:01 INFO - Running setup.py install for blobuploader 11:40:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:01 INFO - Running setup.py install for requests 11:40:01 INFO - Running setup.py install for docopt 11:40:01 INFO - Successfully installed blobuploader requests docopt 11:40:01 INFO - Cleaning up... 11:40:01 INFO - Return code: 0 11:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:40:01 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 11:40:01 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 11:40:01 INFO - Using env: {'DISPLAY': ':0', 11:40:01 INFO - 'HOME': '/home/cltbld', 11:40:01 INFO - 'LANG': 'en_US.UTF-8', 11:40:01 INFO - 'LANGUAGE': 'en_US:en', 11:40:01 INFO - 'LOGNAME': 'cltbld', 11:40:01 INFO - 'MAIL': '/var/mail/cltbld', 11:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:01 INFO - 'MOZ_NO_REMOTE': '1', 11:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:01 INFO - 'NO_EM_RESTART': '1', 11:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:01 INFO - 'PWD': '/builds/slave/test', 11:40:01 INFO - 'SHELL': '/bin/bash', 11:40:01 INFO - 'SHLVL': '1', 11:40:01 INFO - 'TERM': 'linux', 11:40:01 INFO - 'TMOUT': '86400', 11:40:01 INFO - 'USER': 'cltbld', 11:40:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:01 INFO - '_': '/tools/buildbot/bin/python'} 11:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:02 INFO - Running setup.py (path:/tmp/pip-8XwVnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:02 INFO - Running setup.py (path:/tmp/pip-t3R8KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:02 INFO - Running setup.py (path:/tmp/pip-W2p657-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:02 INFO - Running setup.py (path:/tmp/pip-zyQQSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:02 INFO - Running setup.py (path:/tmp/pip-Cu8mZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:02 INFO - Running setup.py (path:/tmp/pip-Glvnwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:02 INFO - Running setup.py (path:/tmp/pip-m6Y1vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:02 INFO - Running setup.py (path:/tmp/pip-guvsBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:02 INFO - Running setup.py (path:/tmp/pip-gbkDNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:02 INFO - Running setup.py (path:/tmp/pip-aUybRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:02 INFO - Running setup.py (path:/tmp/pip-6x6Q2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:02 INFO - Running setup.py (path:/tmp/pip-HfmkRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:03 INFO - Running setup.py (path:/tmp/pip-MVzeqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:03 INFO - Running setup.py (path:/tmp/pip-aL18GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:03 INFO - Running setup.py (path:/tmp/pip-RT6yRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:03 INFO - Running setup.py (path:/tmp/pip-HsSGTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:03 INFO - Running setup.py (path:/tmp/pip-Co58IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:03 INFO - Running setup.py install for manifestparser 11:40:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Running setup.py install for mozcrash 11:40:03 INFO - Running setup.py install for mozdebug 11:40:03 INFO - Running setup.py install for mozdevice 11:40:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Running setup.py install for mozfile 11:40:03 INFO - Running setup.py install for mozhttpd 11:40:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Running setup.py install for mozinfo 11:40:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Running setup.py install for mozInstall 11:40:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Running setup.py install for mozleak 11:40:04 INFO - Running setup.py install for mozlog 11:40:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Running setup.py install for moznetwork 11:40:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Running setup.py install for mozprocess 11:40:04 INFO - Running setup.py install for mozprofile 11:40:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Running setup.py install for mozrunner 11:40:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:40:04 INFO - Running setup.py install for mozscreenshot 11:40:04 INFO - Running setup.py install for moztest 11:40:05 INFO - Running setup.py install for mozversion 11:40:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:40:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:40:05 INFO - Cleaning up... 11:40:05 INFO - Return code: 0 11:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:05 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:40:05 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 11:40:05 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 11:40:05 INFO - Using env: {'DISPLAY': ':0', 11:40:05 INFO - 'HOME': '/home/cltbld', 11:40:05 INFO - 'LANG': 'en_US.UTF-8', 11:40:05 INFO - 'LANGUAGE': 'en_US:en', 11:40:05 INFO - 'LOGNAME': 'cltbld', 11:40:05 INFO - 'MAIL': '/var/mail/cltbld', 11:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:05 INFO - 'MOZ_NO_REMOTE': '1', 11:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:05 INFO - 'NO_EM_RESTART': '1', 11:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:05 INFO - 'PWD': '/builds/slave/test', 11:40:05 INFO - 'SHELL': '/bin/bash', 11:40:05 INFO - 'SHLVL': '1', 11:40:05 INFO - 'TERM': 'linux', 11:40:05 INFO - 'TMOUT': '86400', 11:40:05 INFO - 'USER': 'cltbld', 11:40:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:05 INFO - '_': '/tools/buildbot/bin/python'} 11:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:05 INFO - Running setup.py (path:/tmp/pip-fkPcbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:05 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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:05 INFO - Running setup.py (path:/tmp/pip-Ve7qH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:05 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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:05 INFO - Running setup.py (path:/tmp/pip-Pjg_Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:05 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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:05 INFO - Running setup.py (path:/tmp/pip-ccKDO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:05 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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:05 INFO - Running setup.py (path:/tmp/pip-nBeP1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:05 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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:05 INFO - Running setup.py (path:/tmp/pip-6pxI6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:05 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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:05 INFO - Running setup.py (path:/tmp/pip-0XbJ6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:05 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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:05 INFO - Running setup.py (path:/tmp/pip-5tbbyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:06 INFO - Running setup.py (path:/tmp/pip-S8QxWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:06 INFO - Running setup.py (path:/tmp/pip-tWRbYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:06 INFO - Running setup.py (path:/tmp/pip-1tAd5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:06 INFO - Running setup.py (path:/tmp/pip-jLjwGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:06 INFO - Running setup.py (path:/tmp/pip-Io1ejK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:06 INFO - Running setup.py (path:/tmp/pip-IyGtij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:06 INFO - Running setup.py (path:/tmp/pip-RYetRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:06 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:06 INFO - Running setup.py (path:/tmp/pip-XLcgBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:06 INFO - Running setup.py (path:/tmp/pip-j7jPPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:06 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)) 11:40:06 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)) 11:40:06 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)) 11:40:06 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)) 11:40:06 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)) 11:40:06 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)) 11:40:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40:06 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 11:40:06 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 11:40:06 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 11:40:06 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 11:40:06 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 11:40:06 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 11:40:08 INFO - Downloading blessings-1.6.tar.gz 11:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:40:08 INFO - Installing collected packages: blessings 11:40:08 INFO - Running setup.py install for blessings 11:40:08 INFO - Successfully installed blessings 11:40:08 INFO - Cleaning up... 11:40:08 INFO - Return code: 0 11:40:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:09 INFO - Reading from file tmpfile_stdout 11:40:09 INFO - Current package versions: 11:40:09 INFO - argparse == 1.2.1 11:40:09 INFO - blessings == 1.6 11:40:09 INFO - blobuploader == 1.2.4 11:40:09 INFO - docopt == 0.6.1 11:40:09 INFO - functools32 == 3.2.3-2 11:40:09 INFO - jsonschema == 2.5.1 11:40:09 INFO - manifestparser == 1.1 11:40:09 INFO - mozInstall == 1.12 11:40:09 INFO - mozcrash == 1.0 11:40:09 INFO - mozdebug == 0.1 11:40:09 INFO - mozdevice == 0.48 11:40:09 INFO - mozfile == 1.2 11:40:09 INFO - mozhttpd == 0.7 11:40:09 INFO - mozinfo == 0.9 11:40:09 INFO - mozleak == 0.1 11:40:09 INFO - mozlog == 3.4 11:40:09 INFO - moznetwork == 0.27 11:40:09 INFO - mozprocess == 0.23 11:40:09 INFO - mozprofile == 0.28 11:40:09 INFO - mozrunner == 6.13 11:40:09 INFO - mozscreenshot == 0.1 11:40:09 INFO - mozsystemmonitor == 0.3 11:40:09 INFO - moztest == 0.8 11:40:09 INFO - mozversion == 1.4 11:40:09 INFO - psutil == 3.1.1 11:40:09 INFO - requests == 1.2.3 11:40:09 INFO - wsgiref == 0.1.2 11:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:09 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 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:40:09 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 11:40:09 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 11:40:09 INFO - Using env: {'DISPLAY': ':0', 11:40:09 INFO - 'HOME': '/home/cltbld', 11:40:09 INFO - 'LANG': 'en_US.UTF-8', 11:40:09 INFO - 'LANGUAGE': 'en_US:en', 11:40:09 INFO - 'LOGNAME': 'cltbld', 11:40:09 INFO - 'MAIL': '/var/mail/cltbld', 11:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:09 INFO - 'MOZ_NO_REMOTE': '1', 11:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:09 INFO - 'NO_EM_RESTART': '1', 11:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:09 INFO - 'PWD': '/builds/slave/test', 11:40:09 INFO - 'SHELL': '/bin/bash', 11:40:09 INFO - 'SHLVL': '1', 11:40:09 INFO - 'TERM': 'linux', 11:40:09 INFO - 'TMOUT': '86400', 11:40:09 INFO - 'USER': 'cltbld', 11:40:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:09 INFO - '_': '/tools/buildbot/bin/python'} 11:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 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)) 11:40:09 INFO - Cleaning up... 11:40:09 INFO - Return code: 0 11:40:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe33f7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', '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 11:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:40:09 INFO - Using env: {'DISPLAY': ':0', 11:40:09 INFO - 'HOME': '/home/cltbld', 11:40:09 INFO - 'LANG': 'en_US.UTF-8', 11:40:09 INFO - 'LANGUAGE': 'en_US:en', 11:40:09 INFO - 'LOGNAME': 'cltbld', 11:40:09 INFO - 'MAIL': '/var/mail/cltbld', 11:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:09 INFO - 'MOZ_NO_REMOTE': '1', 11:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:09 INFO - 'NO_EM_RESTART': '1', 11:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:09 INFO - 'PWD': '/builds/slave/test', 11:40:09 INFO - 'SHELL': '/bin/bash', 11:40:09 INFO - 'SHLVL': '1', 11:40:09 INFO - 'TERM': 'linux', 11:40:09 INFO - 'TMOUT': '86400', 11:40:09 INFO - 'USER': 'cltbld', 11:40:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:09 INFO - '_': '/tools/buildbot/bin/python'} 11:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:40:09 INFO - Cleaning up... 11:40:09 INFO - Return code: 0 11:40:09 INFO - Running post-action listener: _resource_record_post_action 11:40:09 INFO - Running post-action listener: _start_resource_monitoring 11:40:09 INFO - Starting resource monitoring. 11:40:09 INFO - [mozharness: 2017-02-09 19:40:09.649171Z] Finished create-virtualenv step (success) 11:40:09 INFO - [mozharness: 2017-02-09 19:40:09.649724Z] Running install step. 11:40:09 INFO - Running pre-action listener: _resource_record_pre_action 11:40:09 INFO - Running main action method: install 11:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:09 INFO - Reading from file tmpfile_stdout 11:40:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:40:09 INFO - Reading from file tmpfile_stdout 11:40:09 INFO - Output received: 11:40:09 INFO - Usage: mozinstall [options] installer 11:40:09 INFO - Options: 11:40:09 INFO - -h, --help show this help message and exit 11:40:09 INFO - -d DEST, --destination=DEST 11:40:09 INFO - Directory to install application into. [default: 11:40:09 INFO - "/builds/slave/test"] 11:40:09 INFO - --app=APP Application being installed. [default: firefox] 11:40:09 INFO - mkdir: /builds/slave/test/build/application 11:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:40:23 INFO - Reading from file tmpfile_stdout 11:40:23 INFO - Output received: 11:40:23 INFO - /builds/slave/test/build/application/firefox/firefox 11:40:23 INFO - Running post-action listener: _resource_record_post_action 11:40:23 INFO - [mozharness: 2017-02-09 19:40:23.586916Z] Finished install step (success) 11:40:23 INFO - [mozharness: 2017-02-09 19:40:23.587158Z] Running run-tests step. 11:40:23 INFO - Running pre-action listener: _resource_record_pre_action 11:40:23 INFO - Running main action method: run_tests 11:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:40:23 INFO - Python 2.7.3 11:40:23 INFO - Return code: 0 11:40:23 INFO - grabbing minidump binary from tooltool 11:40: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')]} 11:40:23 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 0x2b14f60>, '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 0x2b15d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b161d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:40:23 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 11:40:23 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 11:40:23 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 11:40:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:40:23 INFO - Return code: 0 11:40:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:40:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:40:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:40:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:40:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 11:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 11:40:23 INFO - Using env: {'DISPLAY': ':0', 11:40:23 INFO - 'HOME': '/home/cltbld', 11:40:23 INFO - 'LANG': 'en_US.UTF-8', 11:40:23 INFO - 'LANGUAGE': 'en_US:en', 11:40:23 INFO - 'LOGNAME': 'cltbld', 11:40:23 INFO - 'MAIL': '/var/mail/cltbld', 11:40:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:23 INFO - 'MOZ_NO_REMOTE': '1', 11:40:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:23 INFO - 'NO_EM_RESTART': '1', 11:40:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:23 INFO - 'PWD': '/builds/slave/test', 11:40:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:23 INFO - 'SHELL': '/bin/bash', 11:40:23 INFO - 'SHLVL': '1', 11:40:23 INFO - 'TERM': 'linux', 11:40:23 INFO - 'TMOUT': '86400', 11:40:23 INFO - 'USER': 'cltbld', 11:40:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206', 11:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:23 INFO - '_': '/tools/buildbot/bin/python'} 11:40:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 11:40:23 INFO - mozversion application_buildid: 20170209094120 11:40:23 INFO - mozversion application_changeset: dbd0fa47f7a2970bbe4842e3cef7cec3101fe01a 11:40:23 INFO - mozversion application_display_name: Firefox 11:40:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:40:23 INFO - mozversion application_name: Firefox 11:40:23 INFO - mozversion application_remotingname: firefox 11:40:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:40:23 INFO - mozversion application_vendor: Mozilla 11:40:23 INFO - mozversion application_version: 52.0 11:40:23 INFO - mozversion platform_buildid: 20170209094120 11:40:23 INFO - mozversion platform_changeset: dbd0fa47f7a2970bbe4842e3cef7cec3101fe01a 11:40:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:40:23 INFO - mozversion platform_version: 52.0 11:40:23 INFO - using testdate: 1486669223 11:40:23 INFO - actual date: 1486669223 11:40:23 INFO - starting webserver on 'localhost:44992' 11:40:23 INFO - SUITE-START | Running 2 tests 11:40:23 INFO - TEST-START | dromaeo_css 11:40:23 INFO - operating with platform_type : linux_ 11:40:23 INFO - Initialising browser for dromaeo_css test... 11:40:23 INFO - TEST-INFO | started process 3023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPaqeOZ/profile http://localhost:44992/getInfo.html) 11:40:28 INFO - PROCESS | 3023 | __metrics Screen width/height:1600/1200 11:40:28 INFO - PROCESS | 3023 | colorDepth:24 11:40:28 INFO - PROCESS | 3023 | Browser inner width/height: 1024/697 11:40:28 INFO - PROCESS | 3023 | __metrics 11:40:28 INFO - PROCESS | 3023 | 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" 11:40:28 INFO - PROCESS | 3023 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:29 INFO - PROCESS | 3023 | console.error: PushService: 11:40:29 INFO - PROCESS | 3023 | stateChangeProcessEnqueue: Error transitioning state 11:40:29 INFO - PROCESS | 3023 | UnknownError 11:40:29 INFO - TEST-INFO | 3023: exit 0 11:40:29 INFO - Browser initialized. 11:40:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:40:29 INFO - TEST-INFO | started process 3116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPaqeOZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:41 INFO - PROCESS | 3116 | RSS: Main: 141774848 11:40:41 INFO - PROCESS | 3116 | 11:43:42 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:44992/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44992/tests/dromaeo/cssquery-ext.html) 11:43:44 INFO - PROCESS | 3116 | RSS: Main: 281608192 11:43:44 INFO - PROCESS | 3116 | 11:46:46 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:44992/tests/dromaeo/cssquery-ext.html (next: http://localhost:44992/tests/dromaeo/cssquery-jquery.html) 11:46:47 INFO - PROCESS | 3116 | RSS: Main: 244940800 11:46:47 INFO - PROCESS | 3116 | 11:49:49 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:44992/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44992/tests/dromaeo/cssquery-mootools.html) 11:49:49 INFO - PROCESS | 3116 | RSS: Main: 175566848 11:49:49 INFO - PROCESS | 3116 | 11:52:51 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:44992/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44992/tests/dromaeo/cssquery-prototype.html) 11:52:52 INFO - PROCESS | 3116 | RSS: Main: 219508736 11:52:52 INFO - PROCESS | 3116 | 11:55:54 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:44992/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44992/tests/dromaeo/cssquery-yui.html) 11:55:55 INFO - PROCESS | 3116 | RSS: Main: 178270208 11:55:55 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:44992/tests/dromaeo/cssquery-yui.html (next: http://localhost:44992/tests/dromaeo/cssquery-dojo.html) 11:58:57 INFO - PROCESS | 3116 | RSS: Main: 267923456 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | __start_tp_report 11:58:57 INFO - PROCESS | 3116 | _x_x_mozilla_page_load 11:58:57 INFO - PROCESS | 3116 | _x_x_mozilla_page_load_details 11:58:57 INFO - PROCESS | 3116 | |i|pagename|runs| 11:58:57 INFO - PROCESS | 3116 | |0;dojo.html;3281.5898012748407;3298.389797887391;3302.686244806743;3319.7842140260896;3344.6822551857563;5608.691521966291;5685.147227915814;5697.259356283677;5714.685692286923;5736.799212027575;5629.35262444819;5659.6321239119425;5660.433956604337;5666.9433305666935;5700.344460387057;5062.999999999991;5106.617003724736;5108.8211912583065;5131.409887862887;5178.042062218502;5066.695998240099;5181.689098654074;5195.974020129913;5197.324347834776;5205.791768329281;5045.0666626674;5075.873103172414;5130;5131.050755610224;5167.354080739908;5192.948070519285;5207.687538747668;5273.578113750891;5273.6572122811895;5293.682379057231;4891.755412229374;5074.162763144077;5161.612879034087;5218.452062533455;5224.764885580158;5471.398146203915;5549.1676248562635;5554.638948468377;5630.887382252332;5648.8870222595315;6088.391160883921;6093.207882975229;6103.908441373383;6104.725287362079;6110.327863934964;5955.880882382371;6150.753969841201;6155.692215389213;6162.291336496315;6168.290646575611;5592.636478628876;5610.915836262459;5675.659460432387;5679.943200567942;5761.5102716269585;6207.596506227081;6228.22147231596;6230.314665386803;6237;6244.718987645567;5810.215620891126;5985.521158307325;5986.102084687332;5986.341502434729;6011.699415029231;5881.470667639933;6035.517158627299;6054.878902421927;6057.939420605826;6064.605800622945;5947.910781338283;5975.67133807636;6034.909476357858;6039.335673075958;6057.970145075347;6121.066629478717;6123.709696704001;6126.820694372973;6129.278400901762;6131.113028989343;4660.161170989254;4696.88257793551;4698.389209402756;4711.717296962193;4711.717296962193;4094.754314741125;4118.4440100586635;4137.97931010349;4192.434021407071;4207.431996680471;5688.317401911714;5759.65442073477;5762.827115186551;5766.769329226868;5794.1308803679785;6053.576249662481;6059.303180134253;6073.817785466443;6075.726592303357;6077.817665470043;5543.889122217533;5601.747921343549;5681.715914204273;5686.175504551817;5688.345840228427;5218.947810521922;5264.52619264268;5268.841934741964;5317.601179911522;5351.357837059578;6336.303006669263;6345.111684364193;6347;6349.365063493706;6357.4914006879335;5877.0302900021015;6135.202423684892;6147.016477363601;6148.877022459436;6150.876982460415;6074.997625391761;6125.019996800491;6134.04922237054;6134.130457564626;6231.5637905348;5891.852703682443;5898.4101589840675;5945.019071853096;5950.285965684146;5983.311919129356;6013.067974463965;6019.428154325332;6027.427394397525;6032.366601506778;6050.6369617823075;5730.770769169187;5794.015017447128;5812.070068788974;5835;5874.530037597067;5912.142739302863;5914.053751399755;5923.49650279731;5930.525557955267;5944.3164036136395;5870.090136028923;5872.442117998783;5875.236219291465;5875.73559189846;5884.499817515559;5693.829185124453;5854.034084376201;5881.5588830838715;5900.852478687895;5927.377625349449;5717.285339332583;5793.304803423616;5821.912671310019;5824.825255242349;5850.151727999501 11:58:57 INFO - PROCESS | 3116 | |1;ext.html;547.3717312473589;597.0894386061256;610.9786157484488;633.2717375018727;639.9424051835334;32947.505787413174;42180.156396872044;43055.35416968748;43137.78431107848;43257.99999999996;44873.551264487425;45342.546574534244;45411;45457.31814022792;45476.545234547724;8371.539565323905;8966.506842123681;9100.226480749112;9113.498757568332;9126.178643922045;8554.828903421927;10644.14846812257;10894.400807955599;10897.67306980792;11210.831837522444;10953.123750100012;11021.779564408707;11028.724281892937;11036.834447483294;11040.447977601129;10861.83707244392;10873.456327183689;10893.509792059376;10904.400257985808;10917.617883374123;10810.29733067348;10887.455627218607;10890.128789696806;10893.673189804318;10896.782064358747;43973.34039989403;44354.55645443536;44373.11253774906;44395.334069988974;44410.555894440964;3744.1762812181278;3856.8071596420345;3948.2893079245723;4163.2298024865195;4291.291936830419;32714.345713085844;33052.1736956578;33271.83364083164;34221.828890855635;34316.48525272123;4111.09555897702;4200.159968006411;4301.698881078326;4330.805113769888;4338.023944612469;339472;341471.2926435377;341803;342110;343530;62902.68548657227;63019.6849015752;63062;63181.420464487834;63300.683496583144;65987.67006164939;66268.6686566564;66307;66357;66473.66763166153;18832.34086806955;19092.71360929587;19093.713594296096;19114.80885191158;19153.52116197106;13519.256440895648;13639.931800341134;13906.791398129037;14527.78208326876;14643.85356146425;17458.825411745973;18020.279188832563;18218.45344639663;18221.63556728858;18227.17977691007;5842.853928651818;5994.790182343684;6066.969665151646;6121.632702037892;6172.259328880563;982.0523195116747;1018.3533456255183;1051.9953444460523;1103.2442776697987;1126.2848091461817;31134.844325778227;32241.838790805898;32853.207477364216;34905.47641785375;36614.8169259152;1075.8332458468794;1110.4780753046055;1112.2714621922653;1148.4659633270403;1206.6319772469305;15934.681306373808;16553.172341383124;16892.493225203263;17059;17122.82877171237;461892;464570;465099;465902;466648;57967;58213.70893145507;58340.12489812656;58412;58442.70778646079;1313.4614807928895;1333.06019256424;1363.0935427940508;1425.8574142585658;1464.8022516960286;30688.693113069476;32147;33909;34135;34432;50872.74563627158;51417.22874156816;51474.22788658248;51521.22718159306;51701.22448163356;362898;363559;364011;365134;365473;26810.463790724465;26960.730392695823;29742;29823.10530684083;31272;47261.52738472571;47405.76297118492;47441.52558474371;47577.76211118922;47855.76072119617;40344;40836;42186;42435.787821060694;42586;41961.370579441944;42320;42378.06695142496;42515;42604.612417129865;40582.39126413047;40795.59204407918;40947;41137.79431102825;41163.794181028905;33274.66725332812;36512.45231321586;36513.81743091268;36900.446493302086;36916;27733.722662773922;27842.860785696754;27913.302167445163;27979.58030629583;28043 11:58:57 INFO - PROCESS | 3116 | |2;jquery.html;414.9564295748946;417.75770053369047;418.76130605554835;427.9743215407075;441.77690266415453;18079.81920180798;18935.242590296388;19404.805951940478;19481.51296217595;19600.215991360346;19532.21871125153;19905.502362440948;19912.40262792115;20139.194432222692;20314.593708125827;5196.558292545129;5414.214938833867;5457.617966742329;5519.227308176858;5534.612577119603;5450.836474905739;5467.781288748465;5488.5609151268;5489.176623506466;5535.529479994185;5812.273465816773;5834.912476312858;5836.649801011953;5839.299284085894;5844.620099693507;5770.13447982806;5801.680907550083;5815.73829177688;5824.504917082032;5977.880442391128;5473.452654734535;5476.205950137248;5478.397376288645;5483.8080667176855;5484.7531861066345;14408.423663053465;14441.205733684643;14509.347079381347;14537.273136343141;14539.927300363537;2291.6104262275285;2419.9516009679883;2544.2367289812983;3047.649520305149;3160.604924384452;9923.553440095213;10441.947790261;10772.08437282824;10930.56277748897;10997.285176463503;1779.234928980538;1925.913333899978;1927.4121392975137;1950.9562384124424;1975.5555000125;79925;84242;84306.57846710789;85319;87590;10978.451077446096;11187.160962927814;11256.380899050631;11293.265937714023;11777;15216.163111028778;15293.6176595586;15300.693986120437;15317.080975141527;15337.539873803804;8269.503829770232;8276.793080173044;8754.343424243207;8790.120987901159;8877.73366798997;8608.354373422018;8643.611037503328;8666.653333866701;8851.69019084342;8875.28997680184;4542.9772851136195;4625.514320996314;4684.461286951976;4761.642876784185;5179.974100129475;1962.9661046549193;1974.1807150032862;1991.860569760132;2038;2104.2109209046607;800.3077338102615;898.1691934960136;926.5830376330678;1006.9899301006897;1040.5005597313332;18518.44444666662;19155.233790648217;19451.3192038278;19489.902550487157;19905.203791848453;997.7006897930592;1011.585250047477;1016.3800081950004;1017.2624846985876;1048.1405247696969;10690.412027338416;10915.290506117077;10923.617673381394;10934.234603577674;10977.83533247002;355637;358768;359869;476483;483777;54482.72758636181;67074;88066.55966720125;89910;92470.53764731133;1040.453761775074;1062.1078294232882;1075.596651255779;1078.6224821312635;1083.4745148602922;16735.665286694442;17420.912895435442;17518.211680474153;17746.378876739767;18001.63996720032;42611.7869410651;42639.7868010658;43177.13645727131;43312.133757324045;44230;50695.2395714072;56265;56767.432325676215;56864;57709.42290577209;8360.958195208985;8476.830463390821;8613.00950390688;8649.524276164871;8963.327750418875;12710.36448177606;13181.40683669218;13463.528776493167;13679.931600341935;13888.444462221398;11530.82703759461;11591.594294199662;11731.35477548743;11759.941200293944;12023.398830058288;11665.766684666429;11874.16880818369;11881.524739010689;11920.225185362924;12124.27254364741;11679.240849344766;11878.703032424259;11971.64085077449;11974.22167559106;12078.879211207775;7485.625718714152;7707.383409327128;8242.629081691219;8483.363747718822;8851.64593416282;10858.294210876267;11188.888111118784;11275.154363422613;11325.377104259345;11326.83009754871 11:58:57 INFO - PROCESS | 3116 | |3;mootools.html;1518.2257048905058;1525.687234117006;1662.3516828436905;1792.3099606651435;1799.7750281214849;8551.230389264965;9048.547572621375;9053.185213330798;9056.320775941798;9057.320700947423;7749;7945.086315073769;7952.602369881512;8448.281896038829;8931.776705582364;2453.0923558283416;2516.584763514027;2517.0183628384943;2518.2067648690695;2518.848869067853;2459.8401103928186;2500.9124680636182;2542.0975553678454;2542.38982644165;2550.7321731218235;2477.7150627677865;2484.776370126688;2501.537215615108;2518.26970178648;2521.8991240350365;2463.470353873926;2471.530409222251;2488.340589743719;2489.265666628349;2491.7383674714074;2453.595156799126;2457.754224577528;2482.1064416809936;2482.453860150764;2485.42835147917;8739;8769.473831570062;8850.911490885137;8858.512781796999;8859.689910853089;5456.645318054314;5591.10542313228;5595.496405323541;5601.103823388279;5611.2144299798065;3458.2161360105106;3484.0593039879345;3548.1661809474754;3553.342631613134;3588.67701906827;1106.778644271149;1112.474682470795;1140.7433327501328;1152.613874352093;1153.757710880716;12436.316002619853;12442.75114497705;12479.812802807965;12493.312867792269;12508.624741257778;4716.981132075472;4825.3485779419325;4890.119778439915;4916.237983112624;5017.3226614406585;10618.628348007936;10624.893751062391;10628.09661178793;10628.46857657114;10629.84055239172;5600.523955463831;5620.522255608237;5620.662760234399;5622.690752008597;5628.240187574625;4890.975545122323;5000.599952003831;5043.167877300278;5044.394672639233;5163.40620828602;3912.56961734209;3984.5019372578427;4046.2716710992304;4069.9796501017304;4079.6532294754684;1200.885915837994;1208.9032877369789;1212.2968678166642;1223.7552489501957;1226.7730469863104;864.4899509289423;922.5387306346827;965.8068386322623;976.1263669016332;988.9653862114792;5777.277840269966;5799.5650326225705;5859.296884373817;5870.7945221917025;6090.177825993523;484.85939077667786;496.0451131571782;502.0285747079413;502.9698218106925;503.25518233015345;3808.980955095207;4025.6175663311938;4029.6977726670616;4036.858709945138;4066.6543343816106;10810.135189184846;11086.722831929104;11178.608748693756;11187.049100826358;11199.944000279946;11090.112790976702;11096.223264371416;11101.056410205061;11162.274452160746;11166;7909.367250620052;8307.376946728898;8416.663333466715;8423.241908228289;8428.199321064489;5934.584579079596;6020.578559500793;6089.634621922699;6108.419700128481;6109.480694141048;9722.319437639297;9960.252981026597;9985;9993.150582200304;10038.598456061676;9084.364094513585;10095.343802652804;10128.189744820249;10217.642382516577;10347;7290.599017053901;7712.38300935935;7862.764117076496;7905.723299684483;8125.4718443301;8729.083446238054;8749.256313213447;8787.033426323227;8854.734357969272;8911.955440222757;7539.246075392417;7577.696892124253;7592.8861067082935;7604.8479030420185;7731.188225236494;7689.23107689249;7812.101608315116;7821.100573434128;7840.411969102226;7900;6941.514094013371;7280.453965952469;7280.635968201463;7282.6722797473185;7286.562806231643;4898.510148985073;4973.47778483254;5082.923756143587;5086.593072554113;5120.897582048413;4997.475265097112;5212.895742085061;5250.448702886142;5285.048691235615;5400.135978243619 11:58:57 INFO - PROCESS | 3116 | |4;prototype.html;340.5980942487865;347.4926607153556;354.964503549645;359.83627449510476;360.5979333043657;5379.166229234465;5411.161270003146;5438.265834112393;5452.263944367509;5494.340679118512;5087.364079490064;5153.974230128853;5211.609129315298;5251.55361794248;5307.65500242484;4172.707910446255;4197.614787120258;4210.557891421403;4212.55768144345;4217.915641687172;4182.100848317611;4195.7063005589625;4209.095044565418;4215.156968606276;4215.43091682622;4024.9472768887786;4148.419221309019;4168.312228482297;4180.163967206556;4191.643710284629;4145.875623731293;4151.958480415187;4154.771487568182;4156.168766246763;4157.251694694954;3713.1459764254373;3718.4980027696183;3721.0883333583174;3736.4582135590185;3744.363458212083;5076.974615126901;5129.435762066169;5164.92252616211;5214.165733482625;5214.582833373321;4786.21027530457;4792.257200133985;4796.858057972034;4801.423829140525;4810.975945120287;5537.252470916415;5556.249906262643;5557.666540007613;5572.86067848303;5583.274174357348;3953.743006704555;4107.199096176247;4115.5678653741525;4117.876463706094;4138.737685006072;5719.799807006776;5731.824975879935;5757.251557297566;5785.82642520725;5800.187973683687;4167.395727619478;4183.222130594485;4191.455110835572;4195;4197.685173611992;4186.0809111752205;4222.9577704223175;4228.583424552748;4244.193603215379;4254.787260636956;4741.866160227912;4747.477777444478;4758.2386818108935;4772.665913386099;4797.856064318076;5573.27547418833;5574.247476590689;5598.964191624481;5601.60788744784;5603.719814009283;1399.4466142581725;1422.950196743109;1437.23826372023;1437.6765227823655;1439.8344190418027;1010.7473131717071;1015.6597539824094;1022.616518805448;1028.187731691955;1028.388109075099;5245.790168393298;5257.395399529103;5277.416774967494;5281;5294.708791016454;5468.398476167618;5494.406622079552;5515.889682206333;5545.584081193927;5571.16151669948;5210.609204309616;5248.868778280574;5261;5317.41508434072;5489.478499542537;2970.5098658721067;2970.673225945144;2976.64280286367;2980.672126066131;2990.8654110565076;5817.621854579439;5831.329397119385;5844.347282948157;5889.056611318255;5930.673812940244;5356.625036247503;5643.322801263793;5676.943230567642;5690.77236910519;5699.059655156935;5679.858003549862;5733.512651424676;5754.827355179351;5809.448102430262;5814.534837213013;5395.78416863321;5535.557155427476;5547.389787123494;5568.6658800472105;5657.236273103243;5553.389517040013;5595.349371935207;5612.943870561242;5617.4101719320515;5617.775288988558;5837.322486833268;5866.064198814296;5880.294364676266;5896.616719913192;5915.881682366243;3929.6070392960473;4015.056461731432;4025.3961905714377;4035.757854528738;4053.9391909120795;5522.751476183501;5639.577031722555;5660.575456840671;5793.79721709755;5808.709564521672;5649.887002260014;5663.801766938137;5669.376368599368;5669.546436285004;5672.14917762339;5475.67145971243;5649.350324712546;5655.575831812713;5664.207011018379;5689.516391106802;5555.861103472445;5626.521745651666;5626.774929002794;5633.492985631313;5654.46282603152;5668.461496157858;5671.376148623565;5674.829755107354;5683.232763576864;5685.34618518859;5343.519083282367;5496.268675367247;5540.612157148961;5541.702686901287;5557.888842223214 11:58:57 INFO - PROCESS | 3116 | |5;yui.html;732.2384719891313;733.1458850439238;764.7973287078921;791.9762407127787;814.2997022560597;13819.861801381983;14306.856931430695;14310.427582896684;14357.138571685706;14373.856261437382;12731.745365092693;12823.42294596743;12841.165324253918;12870.356482175901;12873.485060597564;704.5314865614373;739.5193124469112;742.4691345687833;744.4825846037006;826.6032304493847;852.6759831264142;853.9487630742144;866.1338661338661;866.3156106675718;866.5320726807516;924.7087167542203;926.3098991251527;926.4580220570974;926.4765407544716;927.248928368024;923.1045885491063;923.422860712055;924.0713083351222;924.7595625137445;925.8379783537921;679.1442782094547;680.384252251713;680.9455243580502;680.9591424514545;681.0363335879724;13648.181109133484;13835.515756948458;13881.930590347085;13996.090254133449;14094.50669226572;14800.555983320517;15622.218889055503;15628.14045227512;15796.289166987513;15962.281697323648;12058.638240852788;12153.513859445611;12215.93892030543;12233.082518811125;12248.44881980313;3518.612952575215;3526.3828829954655;3536.8938931832085;3563.768355056913;3632.1827588792576;69174;71344;71520;71695;73795.63102184454;10863.18526110545;11154;11333.546658133582;11756.706082347839;12154.088443366783;20960.95195240232;20991.895040524698;21014.684779728315;21020.474488137614;21032.15871365159;8318.251357377865;8513.914860851311;8742.344324175712;8785.956070219609;8865.069167737423;4408.206522825923;4551.135284295973;4559.566841150086;4581.244094724333;4626.167289887852;3278.5246139309666;3396.456566949326;3397.7111945484417;3399.337129259771;3402.914927126792;587.8148383259345;587.9970600146972;594.3580932592789;600.0009983377628;617.3024482334932;592.0645380299117;614.6926536731634;638.4541217259176;688.5283580747205;697.2295613347279;8362.782676309691;8697.869531957025;8721.56392180401;8756.912430875736;9151.98656295614;689.1282527602486;689.7918731417245;692.5533031194851;699.3529490877006;707.3280383635464;4001.47980762499;4164.541900390955;4254.744715317029;4296.0548679290505;4297.312430011183;88301.55849220713;89422;92018;92149;92642.53678731564;77614;78276;78509.60745196238;79102;80638.5968070156;57754.7112264436;67786.32213677898;68377;68685.65657171683;69128.30871691219;7874.606269686378;7954.602269886367;8111.594420278844;8278.461899976483;8347.248747612744;47324;47560;47779.52220477751;48356;49278;58539.4146058551;64812.0278195818;65337;65718.67140664266;66327;11285.887141128484;11427.200095993534;11810.940945295219;11842.76314473723;11914.702132446411;11395.544178232778;11733.354665493138;12031.75936481283;12426.62720118398;12953.740925181632;10874.510647020745;11090.334579925231;11316.9434152832;11650.30098194111;12533.122681412213;11491.482883270106;11708.590199342982;11741.823872642088;11825.231359961575;12326.876731232573;11563.71090722705;11775.352355620524;11840.70398240051;11969.982551483221;11972.221805582609;10450;10520;10619.469026548488;10947.671569852917;11046.944765276443;10192.439415832201;10581.947090264499;10626.52180651857;10704.464776760975;10725.731856703645 11:58:57 INFO - PROCESS | 3116 | __end_tp_report 11:58:57 INFO - PROCESS | 3116 | __start_cc_report 11:58:57 INFO - PROCESS | 3116 | _x_x_mozilla_cycle_collect,1348 11:58:57 INFO - PROCESS | 3116 | __end_cc_report 11:58:57 INFO - PROCESS | 3116 | __startTimestamp1486670337729__endTimestamp 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | ------- Summary: start ------- 11:58:57 INFO - PROCESS | 3116 | Number of tests: 6 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | [#0] dojo.html Cycles:165 Average:5624.65 Median:5821.91 stddev:629.38 (10.8%) stddev-sans-first:603.88 11:58:57 INFO - PROCESS | 3116 | Values: 3281.6 3298.4 3302.7 3319.8 3344.7 5608.7 5685.1 5697.3 5714.7 5736.8 5629.4 5659.6 5660.4 5666.9 5700.3 5063.0 5106.6 5108.8 5131.4 5178.0 5066.7 5181.7 5196.0 5197.3 5205.8 5045.1 5075.9 5130.0 5131.1 5167.4 5192.9 5207.7 5273.6 5273.7 5293.7 4891.8 5074.2 5161.6 5218.5 5224.8 5471.4 5549.2 5554.6 5630.9 5648.9 6088.4 6093.2 6103.9 6104.7 6110.3 5955.9 6150.8 6155.7 6162.3 6168.3 5592.6 5610.9 5675.7 5679.9 5761.5 6207.6 6228.2 6230.3 6237.0 6244.7 5810.2 5985.5 5986.1 5986.3 6011.7 5881.5 6035.5 6054.9 6057.9 6064.6 5947.9 5975.7 6034.9 6039.3 6058.0 6121.1 6123.7 6126.8 6129.3 6131.1 4660.2 4696.9 4698.4 4711.7 4711.7 4094.8 4118.4 4138.0 4192.4 4207.4 5688.3 5759.7 5762.8 5766.8 5794.1 6053.6 6059.3 6073.8 6075.7 6077.8 5543.9 5601.7 5681.7 5686.2 5688.3 5218.9 5264.5 5268.8 5317.6 5351.4 6336.3 6345.1 6347.0 6349.4 6357.5 5877.0 6135.2 6147.0 6148.9 6150.9 6075.0 6125.0 6134.0 6134.1 6231.6 5891.9 5898.4 5945.0 5950.3 5983.3 6013.1 6019.4 6027.4 6032.4 6050.6 5730.8 5794.0 5812.1 5835.0 5874.5 5912.1 5914.1 5923.5 5930.5 5944.3 5870.1 5872.4 5875.2 5875.7 5884.5 5693.8 5854.0 5881.6 5900.9 5927.4 5717.3 5793.3 5821.9 5824.8 5850.2 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | [#1] ext.html Cycles:180 Average:56783.48 Median:201043.91 stddev:103705.11 (51.6%) stddev-sans-first:103910.07 11:58:57 INFO - PROCESS | 3116 | Values: 547.4 597.1 611.0 633.3 639.9 32947.5 42180.2 43055.4 43137.8 43258.0 44873.6 45342.5 45411.0 45457.3 45476.5 8371.5 8966.5 9100.2 9113.5 9126.2 8554.8 10644.1 10894.4 10897.7 11210.8 10953.1 11021.8 11028.7 11036.8 11040.4 10861.8 10873.5 10893.5 10904.4 10917.6 10810.3 10887.5 10890.1 10893.7 10896.8 43973.3 44354.6 44373.1 44395.3 44410.6 3744.2 3856.8 3948.3 4163.2 4291.3 32714.3 33052.2 33271.8 34221.8 34316.5 4111.1 4200.2 4301.7 4330.8 4338.0 339472.0 341471.3 341803.0 342110.0 343530.0 62902.7 63019.7 63062.0 63181.4 63300.7 65987.7 66268.7 66307.0 66357.0 66473.7 18832.3 19092.7 19093.7 19114.8 19153.5 13519.3 13639.9 13906.8 14527.8 14643.9 17458.8 18020.3 18218.5 18221.6 18227.2 5842.9 5994.8 6067.0 6121.6 6172.3 982.1 1018.4 1052.0 1103.2 1126.3 31134.8 32241.8 32853.2 34905.5 36614.8 1075.8 1110.5 1112.3 1148.5 1206.6 15934.7 16553.2 16892.5 17059.0 17122.8 461892.0 464570.0 465099.0 465902.0 466648.0 57967.0 58213.7 58340.1 58412.0 58442.7 1313.5 1333.1 1363.1 1425.9 1464.8 30688.7 32147.0 33909.0 34135.0 34432.0 50872.7 51417.2 51474.2 51521.2 51701.2 362898.0 363559.0 364011.0 365134.0 365473.0 26810.5 26960.7 29742.0 29823.1 31272.0 47261.5 47405.8 47441.5 47577.8 47855.8 40344.0 40836.0 42186.0 42435.8 42586.0 41961.4 42320.0 42378.1 42515.0 42604.6 40582.4 40795.6 40947.0 41137.8 41163.8 33274.7 36512.5 36513.8 36900.4 36916.0 27733.7 27842.9 27913.3 27979.6 28043.0 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | [#2] jquery.html Cycles:180 Average:26221.09 Median:2355.78 stddev:68159.10 (2893.3%) stddev-sans-first:68322.76 11:58:57 INFO - PROCESS | 3116 | Values: 415.0 417.8 418.8 428.0 441.8 18079.8 18935.2 19404.8 19481.5 19600.2 19532.2 19905.5 19912.4 20139.2 20314.6 5196.6 5414.2 5457.6 5519.2 5534.6 5450.8 5467.8 5488.6 5489.2 5535.5 5812.3 5834.9 5836.6 5839.3 5844.6 5770.1 5801.7 5815.7 5824.5 5977.9 5473.5 5476.2 5478.4 5483.8 5484.8 14408.4 14441.2 14509.3 14537.3 14539.9 2291.6 2420.0 2544.2 3047.6 3160.6 9923.6 10441.9 10772.1 10930.6 10997.3 1779.2 1925.9 1927.4 1951.0 1975.6 79925.0 84242.0 84306.6 85319.0 87590.0 10978.5 11187.2 11256.4 11293.3 11777.0 15216.2 15293.6 15300.7 15317.1 15337.5 8269.5 8276.8 8754.3 8790.1 8877.7 8608.4 8643.6 8666.7 8851.7 8875.3 4543.0 4625.5 4684.5 4761.6 5180.0 1963.0 1974.2 1991.9 2038.0 2104.2 800.3 898.2 926.6 1007.0 1040.5 18518.4 19155.2 19451.3 19489.9 19905.2 997.7 1011.6 1016.4 1017.3 1048.1 10690.4 10915.3 10923.6 10934.2 10977.8 355637.0 358768.0 359869.0 476483.0 483777.0 54482.7 67074.0 88066.6 89910.0 92470.5 1040.5 1062.1 1075.6 1078.6 1083.5 16735.7 17420.9 17518.2 17746.4 18001.6 42611.8 42639.8 43177.1 43312.1 44230.0 50695.2 56265.0 56767.4 56864.0 57709.4 8361.0 8476.8 8613.0 8649.5 8963.3 12710.4 13181.4 13463.5 13679.9 13888.4 11530.8 11591.6 11731.4 11759.9 12023.4 11665.8 11874.2 11881.5 11920.2 12124.3 11679.2 11878.7 11971.6 11974.2 12078.9 7485.6 7707.4 8242.6 8483.4 8851.6 10858.3 11188.9 11275.2 11325.4 11326.8 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | [#3] mootools.html Cycles:180 Average:5874.21 Median:5008.96 stddev:3313.03 (66.1%) stddev-sans-first:3306.15 11:58:57 INFO - PROCESS | 3116 | Values: 1518.2 1525.7 1662.4 1792.3 1799.8 8551.2 9048.5 9053.2 9056.3 9057.3 7749.0 7945.1 7952.6 8448.3 8931.8 2453.1 2516.6 2517.0 2518.2 2518.8 2459.8 2500.9 2542.1 2542.4 2550.7 2477.7 2484.8 2501.5 2518.3 2521.9 2463.5 2471.5 2488.3 2489.3 2491.7 2453.6 2457.8 2482.1 2482.5 2485.4 8739.0 8769.5 8850.9 8858.5 8859.7 5456.6 5591.1 5595.5 5601.1 5611.2 3458.2 3484.1 3548.2 3553.3 3588.7 1106.8 1112.5 1140.7 1152.6 1153.8 12436.3 12442.8 12479.8 12493.3 12508.6 4717.0 4825.3 4890.1 4916.2 5017.3 10618.6 10624.9 10628.1 10628.5 10629.8 5600.5 5620.5 5620.7 5622.7 5628.2 4891.0 5000.6 5043.2 5044.4 5163.4 3912.6 3984.5 4046.3 4070.0 4079.7 1200.9 1208.9 1212.3 1223.8 1226.8 864.5 922.5 965.8 976.1 989.0 5777.3 5799.6 5859.3 5870.8 6090.2 484.9 496.0 502.0 503.0 503.3 3809.0 4025.6 4029.7 4036.9 4066.7 10810.1 11086.7 11178.6 11187.0 11199.9 11090.1 11096.2 11101.1 11162.3 11166.0 7909.4 8307.4 8416.7 8423.2 8428.2 5934.6 6020.6 6089.6 6108.4 6109.5 9722.3 9960.3 9985.0 9993.2 10038.6 9084.4 10095.3 10128.2 10217.6 10347.0 7290.6 7712.4 7862.8 7905.7 8125.5 8729.1 8749.3 8787.0 8854.7 8912.0 7539.2 7577.7 7592.9 7604.8 7731.2 7689.2 7812.1 7821.1 7840.4 7900.0 6941.5 7280.5 7280.6 7282.7 7286.6 4898.5 4973.5 5082.9 5086.6 5120.9 4997.5 5212.9 5250.4 5285.0 5400.1 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | [#4] prototype.html Cycles:180 Average:4697.46 Median:5287.85 stddev:1358.08 (25.7%) stddev-sans-first:1321.93 11:58:57 INFO - PROCESS | 3116 | Values: 340.6 347.5 355.0 359.8 360.6 5379.2 5411.2 5438.3 5452.3 5494.3 5087.4 5154.0 5211.6 5251.6 5307.7 4172.7 4197.6 4210.6 4212.6 4217.9 4182.1 4195.7 4209.1 4215.2 4215.4 4024.9 4148.4 4168.3 4180.2 4191.6 4145.9 4152.0 4154.8 4156.2 4157.3 3713.1 3718.5 3721.1 3736.5 3744.4 5077.0 5129.4 5164.9 5214.2 5214.6 4786.2 4792.3 4796.9 4801.4 4811.0 5537.3 5556.2 5557.7 5572.9 5583.3 3953.7 4107.2 4115.6 4117.9 4138.7 5719.8 5731.8 5757.3 5785.8 5800.2 4167.4 4183.2 4191.5 4195.0 4197.7 4186.1 4223.0 4228.6 4244.2 4254.8 4741.9 4747.5 4758.2 4772.7 4797.9 5573.3 5574.2 5599.0 5601.6 5603.7 1399.4 1423.0 1437.2 1437.7 1439.8 1010.7 1015.7 1022.6 1028.2 1028.4 5245.8 5257.4 5277.4 5281.0 5294.7 5468.4 5494.4 5515.9 5545.6 5571.2 5210.6 5248.9 5261.0 5317.4 5489.5 2970.5 2970.7 2976.6 2980.7 2990.9 5817.6 5831.3 5844.3 5889.1 5930.7 5356.6 5643.3 5676.9 5690.8 5699.1 5679.9 5733.5 5754.8 5809.4 5814.5 5395.8 5535.6 5547.4 5568.7 5657.2 5553.4 5595.3 5612.9 5617.4 5617.8 5837.3 5866.1 5880.3 5896.6 5915.9 3929.6 4015.1 4025.4 4035.8 4053.9 5522.8 5639.6 5660.6 5793.8 5808.7 5649.9 5663.8 5669.4 5669.5 5672.1 5475.7 5649.4 5655.6 5664.2 5689.5 5555.9 5626.5 5626.8 5633.5 5654.5 5668.5 5671.4 5674.8 5683.2 5685.3 5343.5 5496.3 5540.6 5541.7 5557.9 11:58:57 INFO - PROCESS | 3116 | 11:58:57 INFO - PROCESS | 3116 | [#5] yui.html Cycles:180 Average:18032.10 Median:47442.00 stddev:24491.90 (51.6%) stddev-sans-first:24526.16 11:58:57 INFO - PROCESS | 3116 | Values: 732.2 733.1 764.8 792.0 814.3 13819.9 14306.9 14310.4 14357.1 14373.9 12731.7 12823.4 12841.2 12870.4 12873.5 704.5 739.5 742.5 744.5 826.6 852.7 853.9 866.1 866.3 866.5 924.7 926.3 926.5 926.5 927.2 923.1 923.4 924.1 924.8 925.8 679.1 680.4 680.9 681.0 681.0 13648.2 13835.5 13881.9 13996.1 14094.5 14800.6 15622.2 15628.1 15796.3 15962.3 12058.6 12153.5 12215.9 12233.1 12248.4 3518.6 3526.4 3536.9 3563.8 3632.2 69174.0 71344.0 71520.0 71695.0 73795.6 10863.2 11154.0 11333.5 11756.7 12154.1 20961.0 20991.9 21014.7 21020.5 21032.2 8318.3 8513.9 8742.3 8786.0 8865.1 4408.2 4551.1 4559.6 4581.2 4626.2 3278.5 3396.5 3397.7 3399.3 3402.9 587.8 588.0 594.4 600.0 617.3 592.1 614.7 638.5 688.5 697.2 8362.8 8697.9 8721.6 8756.9 9152.0 689.1 689.8 692.6 699.4 707.3 4001.5 4164.5 4254.7 4296.1 4297.3 88301.6 89422.0 92018.0 92149.0 92642.5 77614.0 78276.0 78509.6 79102.0 80638.6 57754.7 67786.3 68377.0 68685.7 69128.3 7874.6 7954.6 8111.6 8278.5 8347.2 47324.0 47560.0 47779.5 48356.0 49278.0 58539.4 64812.0 65337.0 65718.7 66327.0 11285.9 11427.2 11810.9 11842.8 11914.7 11395.5 11733.4 12031.8 12426.6 12953.7 10874.5 11090.3 11316.9 11650.3 12533.1 11491.5 11708.6 11741.8 11825.2 12326.9 11563.7 11775.4 11840.7 11970.0 11972.2 10450.0 10520.0 10619.5 10947.7 11046.9 10192.4 10581.9 10626.5 10704.5 10725.7 11:58:57 INFO - PROCESS | 3116 | -------- Summary: end -------- 11:58:57 INFO - PROCESS | 3116 | 11:58:58 INFO - TEST-INFO | 3116: exit 0 11:58:58 INFO - TEST-OK | dromaeo_css | took 1114641ms 11:58:58 INFO - TEST-START | kraken 11:58:58 INFO - operating with platform_type : linux_ 11:58:58 INFO - Initialising browser for kraken test... 11:58:58 INFO - TEST-INFO | started process 3423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphUeBNd/profile http://localhost:44992/getInfo.html) 11:59:02 INFO - PROCESS | 3423 | __metrics Screen width/height:1600/1200 11:59:02 INFO - PROCESS | 3423 | colorDepth:24 11:59:02 INFO - PROCESS | 3423 | Browser inner width/height: 1024/697 11:59:02 INFO - PROCESS | 3423 | __metrics 11:59:03 INFO - PROCESS | 3423 | 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" 11:59:03 INFO - PROCESS | 3423 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:59:03 INFO - PROCESS | 3423 | console.error: PushService: 11:59:03 INFO - PROCESS | 3423 | stateChangeProcessEnqueue: Error transitioning state 11:59:03 INFO - PROCESS | 3423 | UnknownError 11:59:04 INFO - TEST-INFO | 3423: exit 0 11:59:04 INFO - Browser initialized. 11:59:04 INFO - Running cycle 1/1 for kraken test... 11:59:04 INFO - TEST-INFO | started process 3517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphUeBNd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:16 INFO - PROCESS | 3517 | RSS: Main: 141905920 11:59:16 INFO - PROCESS | 3517 | 11:59:18 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44992/tests/kraken/driver.html?testName=audio-beat-detection) 11:59:19 INFO - PROCESS | 3517 | RSS: Main: 183463936 11:59:19 INFO - PROCESS | 3517 | 11:59:21 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44992/tests/kraken/driver.html?testName=audio-dft) 11:59:22 INFO - PROCESS | 3517 | RSS: Main: 173506560 11:59:22 INFO - PROCESS | 3517 | 11:59:25 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44992/tests/kraken/driver.html?testName=audio-fft) 11:59:25 INFO - PROCESS | 3517 | RSS: Main: 264507392 11:59:25 INFO - PROCESS | 3517 | 11:59:28 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44992/tests/kraken/driver.html?testName=audio-oscillator) 11:59:28 INFO - PROCESS | 3517 | RSS: Main: 171479040 11:59:28 INFO - PROCESS | 3517 | 11:59:30 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44992/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:31 INFO - PROCESS | 3517 | RSS: Main: 173576192 11:59:31 INFO - PROCESS | 3517 | 11:59:34 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44992/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:34 INFO - PROCESS | 3517 | RSS: Main: 208961536 11:59:34 INFO - PROCESS | 3517 | 11:59:38 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44992/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:38 INFO - PROCESS | 3517 | RSS: Main: 211902464 11:59:38 INFO - PROCESS | 3517 | 11:59:41 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44992/tests/kraken/driver.html?testName=json-parse-financial) 11:59:41 INFO - PROCESS | 3517 | RSS: Main: 209743872 11:59:41 INFO - PROCESS | 3517 | 11:59:43 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44992/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:44 INFO - PROCESS | 3517 | RSS: Main: 172449792 11:59:44 INFO - PROCESS | 3517 | 11:59:45 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:59:46 INFO - PROCESS | 3517 | RSS: Main: 178987008 11:59:46 INFO - PROCESS | 3517 | 11:59:48 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:48 INFO - PROCESS | 3517 | RSS: Main: 189030400 11:59:48 INFO - PROCESS | 3517 | 11:59:51 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:59:52 INFO - PROCESS | 3517 | RSS: Main: 197390336 11:59:52 INFO - PROCESS | 3517 | 11:59:54 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:55 INFO - PROCESS | 3517 | RSS: Main: 193482752 11:59:55 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | Cycle 1(1): loaded http://localhost:44992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44992/tests/kraken/driver.html?testName=ai-astar) 11:59:57 INFO - PROCESS | 3517 | RSS: Main: 245551104 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | __start_tp_report 11:59:57 INFO - PROCESS | 3517 | _x_x_mozilla_page_load 11:59:57 INFO - PROCESS | 3517 | _x_x_mozilla_page_load_details 11:59:57 INFO - PROCESS | 3517 | |i|pagename|runs| 11:59:57 INFO - PROCESS | 3517 | |0;ai-astar;101;110;108;110;110;110;109;109;110;108 11:59:57 INFO - PROCESS | 3517 | |1;audio-beat-detection;144;117;117;153;118;120;123;118;153;119 11:59:57 INFO - PROCESS | 3517 | |2;audio-dft;162;161;160;159;160;160;162;161;160;159 11:59:57 INFO - PROCESS | 3517 | |3;audio-fft;75;76;76;131;75;76;76;76;96;75 11:59:57 INFO - PROCESS | 3517 | |4;audio-oscillator;82;82;121;82;82;81;98;82;81;118 11:59:57 INFO - PROCESS | 3517 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 11:59:57 INFO - PROCESS | 3517 | |6;imaging-darkroom;146;145;146;146;146;148;146;146;146;145 11:59:57 INFO - PROCESS | 3517 | |7;imaging-desaturate;86;85;84;84;84;85;84;85;85;84 11:59:57 INFO - PROCESS | 3517 | |8;json-parse-financial;53;52;53;53;51;52;53;51;60;51 11:59:57 INFO - PROCESS | 3517 | |9;json-stringify-tinderbox;58;59;59;59;60;60;59;60;60;60 11:59:57 INFO - PROCESS | 3517 | |10;stanford-crypto-aes;75;74;75;75;74;74;74;77;73;75 11:59:57 INFO - PROCESS | 3517 | |11;stanford-crypto-ccm;124;122;132;124;121;123;133;123;156;133 11:59:57 INFO - PROCESS | 3517 | |12;stanford-crypto-pbkdf2;158;156;159;160;155;157;155;157;153;154 11:59:57 INFO - PROCESS | 3517 | |13;stanford-crypto-sha256-iterative;64;71;65;62;62;62;62;62;67;61 11:59:57 INFO - PROCESS | 3517 | __end_tp_report 11:59:57 INFO - PROCESS | 3517 | __start_cc_report 11:59:57 INFO - PROCESS | 3517 | _x_x_mozilla_cycle_collect,1554 11:59:57 INFO - PROCESS | 3517 | __end_cc_report 11:59:57 INFO - PROCESS | 3517 | __startTimestamp1486670397386__endTimestamp 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | ------- Summary: start ------- 11:59:57 INFO - PROCESS | 3517 | Number of tests: 14 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 11:59:57 INFO - PROCESS | 3517 | Values: 101.0 110.0 108.0 110.0 110.0 110.0 109.0 109.0 110.0 108.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:121.50 stddev:15.34 (12.6%) stddev-sans-first:15.17 11:59:57 INFO - PROCESS | 3517 | Values: 144.0 117.0 117.0 153.0 118.0 120.0 123.0 118.0 153.0 119.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 11:59:57 INFO - PROCESS | 3517 | Values: 162.0 161.0 160.0 159.0 160.0 160.0 162.0 161.0 160.0 159.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:17.98 (23.7%) stddev-sans-first:18.82 11:59:57 INFO - PROCESS | 3517 | Values: 75.0 76.0 76.0 131.0 75.0 76.0 76.0 76.0 96.0 75.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:15.93 (19.4%) stddev-sans-first:16.56 11:59:57 INFO - PROCESS | 3517 | Values: 82.0 82.0 121.0 82.0 82.0 81.0 98.0 82.0 81.0 118.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:59:57 INFO - PROCESS | 3517 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 11:59:57 INFO - PROCESS | 3517 | Values: 146.0 145.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 145.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 11:59:57 INFO - PROCESS | 3517 | Values: 86.0 85.0 84.0 84.0 84.0 85.0 84.0 85.0 85.0 84.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:2.64 (5.0%) stddev-sans-first:2.80 11:59:57 INFO - PROCESS | 3517 | Values: 53.0 52.0 53.0 53.0 51.0 52.0 53.0 51.0 60.0 51.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.53 11:59:57 INFO - PROCESS | 3517 | Values: 58.0 59.0 59.0 59.0 60.0 60.0 59.0 60.0 60.0 60.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:1.07 (1.4%) stddev-sans-first:1.13 11:59:57 INFO - PROCESS | 3517 | Values: 75.0 74.0 75.0 75.0 74.0 74.0 74.0 77.0 73.0 75.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:128.00 stddev:10.57 (8.3%) stddev-sans-first:11.05 11:59:57 INFO - PROCESS | 3517 | Values: 124.0 122.0 132.0 124.0 121.0 123.0 133.0 123.0 156.0 133.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:157.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 11:59:57 INFO - PROCESS | 3517 | Values: 158.0 156.0 159.0 160.0 155.0 157.0 155.0 157.0 153.0 154.0 11:59:57 INFO - PROCESS | 3517 | 11:59:57 INFO - PROCESS | 3517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:3.12 (5.0%) stddev-sans-first:3.31 11:59:57 INFO - PROCESS | 3517 | Values: 64.0 71.0 65.0 62.0 62.0 62.0 62.0 62.0 67.0 61.0 11:59:57 INFO - PROCESS | 3517 | -------- Summary: end -------- 11:59:57 INFO - PROCESS | 3517 | 11:59:58 INFO - TEST-INFO | 3517: exit 0 11:59:58 INFO - TEST-OK | kraken | took 59918ms 11:59:58 INFO - SUITE-END | took 1174s 11:59:58 INFO - Completed test suite (00:19:34) 11:59:58 INFO - javascript benchmark 11:59:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.5898012748407, 3298.389797887391, 3302.686244806743, 3319.7842140260896, 3344.6822551857563, 5608.691521966291, 5685.147227915814, 5697.259356283677, 5714.685692286923, 5736.799212027575, 5629.35262444819, 5659.6321239119425, 5660.433956604337, 5666.9433305666935, 5700.344460387057, 5062.999999999991, 5106.617003724736, 5108.8211912583065, 5131.409887862887, 5178.042062218502, 5066.695998240099, 5181.689098654074, 5195.974020129913, 5197.324347834776, 5205.791768329281, 5045.0666626674, 5075.873103172414, 5130.0, 5131.050755610224, 5167.354080739908, 5192.948070519285, 5207.687538747668, 5273.578113750891, 5273.6572122811895, 5293.682379057231, 4891.755412229374, 5074.162763144077, 5161.612879034087, 5218.452062533455, 5224.764885580158, 5471.398146203915, 5549.1676248562635, 5554.638948468377, 5630.887382252332, 5648.8870222595315, 6088.391160883921, 6093.207882975229, 6103.908441373383, 6104.725287362079, 6110.327863934964, 5955.880882382371, 6150.753969841201, 6155.692215389213, 6162.291336496315, 6168.290646575611, 5592.636478628876, 5610.915836262459, 5675.659460432387, 5679.943200567942, 5761.5102716269585, 6207.596506227081, 6228.22147231596, 6230.314665386803, 6237.0, 6244.718987645567, 5810.215620891126, 5985.521158307325, 5986.102084687332, 5986.341502434729, 6011.699415029231, 5881.470667639933, 6035.517158627299, 6054.878902421927, 6057.939420605826, 6064.605800622945, 5947.910781338283, 5975.67133807636, 6034.909476357858, 6039.335673075958, 6057.970145075347, 6121.066629478717, 6123.709696704001, 6126.820694372973, 6129.278400901762, 6131.113028989343, 4660.161170989254, 4696.88257793551, 4698.389209402756, 4711.717296962193, 4711.717296962193, 4094.754314741125, 4118.4440100586635, 4137.97931010349, 4192.434021407071, 4207.431996680471, 5688.317401911714, 5759.65442073477, 5762.827115186551, 5766.769329226868, 5794.1308803679785, 6053.576249662481, 6059.303180134253, 6073.817785466443, 6075.726592303357, 6077.817665470043, 5543.889122217533, 5601.747921343549, 5681.715914204273, 5686.175504551817, 5688.345840228427, 5218.947810521922, 5264.52619264268, 5268.841934741964, 5317.601179911522, 5351.357837059578, 6336.303006669263, 6345.111684364193, 6347.0, 6349.365063493706, 6357.4914006879335, 5877.0302900021015, 6135.202423684892, 6147.016477363601, 6148.877022459436, 6150.876982460415, 6074.997625391761, 6125.019996800491, 6134.04922237054, 6134.130457564626, 6231.5637905348, 5891.852703682443, 5898.4101589840675, 5945.019071853096, 5950.285965684146, 5983.311919129356, 6013.067974463965, 6019.428154325332, 6027.427394397525, 6032.366601506778, 6050.6369617823075, 5730.770769169187, 5794.015017447128, 5812.070068788974, 5835.0, 5874.530037597067, 5912.142739302863, 5914.053751399755, 5923.49650279731, 5930.525557955267, 5944.3164036136395, 5870.090136028923, 5872.442117998783, 5875.236219291465, 5875.73559189846, 5884.499817515559, 5693.829185124453, 5854.034084376201, 5881.5588830838715, 5900.852478687895, 5927.377625349449, 5717.285339332583, 5793.304803423616, 5821.912671310019, 5824.825255242349, 5850.151727999501], "value": 5582.955209091272, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3717312473589, 597.0894386061256, 610.9786157484488, 633.2717375018727, 639.9424051835334, 32947.505787413174, 42180.156396872044, 43055.35416968748, 43137.78431107848, 43257.99999999996, 44873.551264487425, 45342.546574534244, 45411.0, 45457.31814022792, 45476.545234547724, 8371.539565323905, 8966.506842123681, 9100.226480749112, 9113.498757568332, 9126.178643922045, 8554.828903421927, 10644.14846812257, 10894.400807955599, 10897.67306980792, 11210.831837522444, 10953.123750100012, 11021.779564408707, 11028.724281892937, 11036.834447483294, 11040.447977601129, 10861.83707244392, 10873.456327183689, 10893.509792059376, 10904.400257985808, 10917.617883374123, 10810.29733067348, 10887.455627218607, 10890.128789696806, 10893.673189804318, 10896.782064358747, 43973.34039989403, 44354.55645443536, 44373.11253774906, 44395.334069988974, 44410.555894440964, 3744.1762812181278, 3856.8071596420345, 3948.2893079245723, 4163.2298024865195, 4291.291936830419, 32714.345713085844, 33052.1736956578, 33271.83364083164, 34221.828890855635, 34316.48525272123, 4111.09555897702, 4200.159968006411, 4301.698881078326, 4330.805113769888, 4338.023944612469, 339472.0, 341471.2926435377, 341803.0, 342110.0, 343530.0, 62902.68548657227, 63019.6849015752, 63062.0, 63181.420464487834, 63300.683496583144, 65987.67006164939, 66268.6686566564, 66307.0, 66357.0, 66473.66763166153, 18832.34086806955, 19092.71360929587, 19093.713594296096, 19114.80885191158, 19153.52116197106, 13519.256440895648, 13639.931800341134, 13906.791398129037, 14527.78208326876, 14643.85356146425, 17458.825411745973, 18020.279188832563, 18218.45344639663, 18221.63556728858, 18227.17977691007, 5842.853928651818, 5994.790182343684, 6066.969665151646, 6121.632702037892, 6172.259328880563, 982.0523195116747, 1018.3533456255183, 1051.9953444460523, 1103.2442776697987, 1126.2848091461817, 31134.844325778227, 32241.838790805898, 32853.207477364216, 34905.47641785375, 36614.8169259152, 1075.8332458468794, 1110.4780753046055, 1112.2714621922653, 1148.4659633270403, 1206.6319772469305, 15934.681306373808, 16553.172341383124, 16892.493225203263, 17059.0, 17122.82877171237, 461892.0, 464570.0, 465099.0, 465902.0, 466648.0, 57967.0, 58213.70893145507, 58340.12489812656, 58412.0, 58442.70778646079, 1313.4614807928895, 1333.06019256424, 1363.0935427940508, 1425.8574142585658, 1464.8022516960286, 30688.693113069476, 32147.0, 33909.0, 34135.0, 34432.0, 50872.74563627158, 51417.22874156816, 51474.22788658248, 51521.22718159306, 51701.22448163356, 362898.0, 363559.0, 364011.0, 365134.0, 365473.0, 26810.463790724465, 26960.730392695823, 29742.0, 29823.10530684083, 31272.0, 47261.52738472571, 47405.76297118492, 47441.52558474371, 47577.76211118922, 47855.76072119617, 40344.0, 40836.0, 42186.0, 42435.787821060694, 42586.0, 41961.370579441944, 42320.0, 42378.06695142496, 42515.0, 42604.612417129865, 40582.39126413047, 40795.59204407918, 40947.0, 41137.79431102825, 41163.794181028905, 33274.66725332812, 36512.45231321586, 36513.81743091268, 36900.446493302086, 36916.0, 27733.722662773922, 27842.860785696754, 27913.302167445163, 27979.58030629583, 28043.0], "value": 20666.10899797805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.9564295748946, 417.75770053369047, 418.76130605554835, 427.9743215407075, 441.77690266415453, 18079.81920180798, 18935.242590296388, 19404.805951940478, 19481.51296217595, 19600.215991360346, 19532.21871125153, 19905.502362440948, 19912.40262792115, 20139.194432222692, 20314.593708125827, 5196.558292545129, 5414.214938833867, 5457.617966742329, 5519.227308176858, 5534.612577119603, 5450.836474905739, 5467.781288748465, 5488.5609151268, 5489.176623506466, 5535.529479994185, 5812.273465816773, 5834.912476312858, 5836.649801011953, 5839.299284085894, 5844.620099693507, 5770.13447982806, 5801.680907550083, 5815.73829177688, 5824.504917082032, 5977.880442391128, 5473.452654734535, 5476.205950137248, 5478.397376288645, 5483.8080667176855, 5484.7531861066345, 14408.423663053465, 14441.205733684643, 14509.347079381347, 14537.273136343141, 14539.927300363537, 2291.6104262275285, 2419.9516009679883, 2544.2367289812983, 3047.649520305149, 3160.604924384452, 9923.553440095213, 10441.947790261, 10772.08437282824, 10930.56277748897, 10997.285176463503, 1779.234928980538, 1925.913333899978, 1927.4121392975137, 1950.9562384124424, 1975.5555000125, 79925.0, 84242.0, 84306.57846710789, 85319.0, 87590.0, 10978.451077446096, 11187.160962927814, 11256.380899050631, 11293.265937714023, 11777.0, 15216.163111028778, 15293.6176595586, 15300.693986120437, 15317.080975141527, 15337.539873803804, 8269.503829770232, 8276.793080173044, 8754.343424243207, 8790.120987901159, 8877.73366798997, 8608.354373422018, 8643.611037503328, 8666.653333866701, 8851.69019084342, 8875.28997680184, 4542.9772851136195, 4625.514320996314, 4684.461286951976, 4761.642876784185, 5179.974100129475, 1962.9661046549193, 1974.1807150032862, 1991.860569760132, 2038.0, 2104.2109209046607, 800.3077338102615, 898.1691934960136, 926.5830376330678, 1006.9899301006897, 1040.5005597313332, 18518.44444666662, 19155.233790648217, 19451.3192038278, 19489.902550487157, 19905.203791848453, 997.7006897930592, 1011.585250047477, 1016.3800081950004, 1017.2624846985876, 1048.1405247696969, 10690.412027338416, 10915.290506117077, 10923.617673381394, 10934.234603577674, 10977.83533247002, 355637.0, 358768.0, 359869.0, 476483.0, 483777.0, 54482.72758636181, 67074.0, 88066.55966720125, 89910.0, 92470.53764731133, 1040.453761775074, 1062.1078294232882, 1075.596651255779, 1078.6224821312635, 1083.4745148602922, 16735.665286694442, 17420.912895435442, 17518.211680474153, 17746.378876739767, 18001.63996720032, 42611.7869410651, 42639.7868010658, 43177.13645727131, 43312.133757324045, 44230.0, 50695.2395714072, 56265.0, 56767.432325676215, 56864.0, 57709.42290577209, 8360.958195208985, 8476.830463390821, 8613.00950390688, 8649.524276164871, 8963.327750418875, 12710.36448177606, 13181.40683669218, 13463.528776493167, 13679.931600341935, 13888.444462221398, 11530.82703759461, 11591.594294199662, 11731.35477548743, 11759.941200293944, 12023.398830058288, 11665.766684666429, 11874.16880818369, 11881.524739010689, 11920.225185362924, 12124.27254364741, 11679.240849344766, 11878.703032424259, 11971.64085077449, 11974.22167559106, 12078.879211207775, 7485.625718714152, 7707.383409327128, 8242.629081691219, 8483.363747718822, 8851.64593416282, 10858.294210876267, 11188.888111118784, 11275.154363422613, 11325.377104259345, 11326.83009754871], "value": 9128.338793620589, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.2257048905058, 1525.687234117006, 1662.3516828436905, 1792.3099606651435, 1799.7750281214849, 8551.230389264965, 9048.547572621375, 9053.185213330798, 9056.320775941798, 9057.320700947423, 7749.0, 7945.086315073769, 7952.602369881512, 8448.281896038829, 8931.776705582364, 2453.0923558283416, 2516.584763514027, 2517.0183628384943, 2518.2067648690695, 2518.848869067853, 2459.8401103928186, 2500.9124680636182, 2542.0975553678454, 2542.38982644165, 2550.7321731218235, 2477.7150627677865, 2484.776370126688, 2501.537215615108, 2518.26970178648, 2521.8991240350365, 2463.470353873926, 2471.530409222251, 2488.340589743719, 2489.265666628349, 2491.7383674714074, 2453.595156799126, 2457.754224577528, 2482.1064416809936, 2482.453860150764, 2485.42835147917, 8739.0, 8769.473831570062, 8850.911490885137, 8858.512781796999, 8859.689910853089, 5456.645318054314, 5591.10542313228, 5595.496405323541, 5601.103823388279, 5611.2144299798065, 3458.2161360105106, 3484.0593039879345, 3548.1661809474754, 3553.342631613134, 3588.67701906827, 1106.778644271149, 1112.474682470795, 1140.7433327501328, 1152.613874352093, 1153.757710880716, 12436.316002619853, 12442.75114497705, 12479.812802807965, 12493.312867792269, 12508.624741257778, 4716.981132075472, 4825.3485779419325, 4890.119778439915, 4916.237983112624, 5017.3226614406585, 10618.628348007936, 10624.893751062391, 10628.09661178793, 10628.46857657114, 10629.84055239172, 5600.523955463831, 5620.522255608237, 5620.662760234399, 5622.690752008597, 5628.240187574625, 4890.975545122323, 5000.599952003831, 5043.167877300278, 5044.394672639233, 5163.40620828602, 3912.56961734209, 3984.5019372578427, 4046.2716710992304, 4069.9796501017304, 4079.6532294754684, 1200.885915837994, 1208.9032877369789, 1212.2968678166642, 1223.7552489501957, 1226.7730469863104, 864.4899509289423, 922.5387306346827, 965.8068386322623, 976.1263669016332, 988.9653862114792, 5777.277840269966, 5799.5650326225705, 5859.296884373817, 5870.7945221917025, 6090.177825993523, 484.85939077667786, 496.0451131571782, 502.0285747079413, 502.9698218106925, 503.25518233015345, 3808.980955095207, 4025.6175663311938, 4029.6977726670616, 4036.858709945138, 4066.6543343816106, 10810.135189184846, 11086.722831929104, 11178.608748693756, 11187.049100826358, 11199.944000279946, 11090.112790976702, 11096.223264371416, 11101.056410205061, 11162.274452160746, 11166.0, 7909.367250620052, 8307.376946728898, 8416.663333466715, 8423.241908228289, 8428.199321064489, 5934.584579079596, 6020.578559500793, 6089.634621922699, 6108.419700128481, 6109.480694141048, 9722.319437639297, 9960.252981026597, 9985.0, 9993.150582200304, 10038.598456061676, 9084.364094513585, 10095.343802652804, 10128.189744820249, 10217.642382516577, 10347.0, 7290.599017053901, 7712.38300935935, 7862.764117076496, 7905.723299684483, 8125.4718443301, 8729.083446238054, 8749.256313213447, 8787.033426323227, 8854.734357969272, 8911.955440222757, 7539.246075392417, 7577.696892124253, 7592.8861067082935, 7604.8479030420185, 7731.188225236494, 7689.23107689249, 7812.101608315116, 7821.100573434128, 7840.411969102226, 7900.0, 6941.514094013371, 7280.453965952469, 7280.635968201463, 7282.6722797473185, 7286.562806231643, 4898.510148985073, 4973.47778483254, 5082.923756143587, 5086.593072554113, 5120.897582048413, 4997.475265097112, 5212.895742085061, 5250.448702886142, 5285.048691235615, 5400.135978243619], "value": 4652.061293259421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.5980942487865, 347.4926607153556, 354.964503549645, 359.83627449510476, 360.5979333043657, 5379.166229234465, 5411.161270003146, 5438.265834112393, 5452.263944367509, 5494.340679118512, 5087.364079490064, 5153.974230128853, 5211.609129315298, 5251.55361794248, 5307.65500242484, 4172.707910446255, 4197.614787120258, 4210.557891421403, 4212.55768144345, 4217.915641687172, 4182.100848317611, 4195.7063005589625, 4209.095044565418, 4215.156968606276, 4215.43091682622, 4024.9472768887786, 4148.419221309019, 4168.312228482297, 4180.163967206556, 4191.643710284629, 4145.875623731293, 4151.958480415187, 4154.771487568182, 4156.168766246763, 4157.251694694954, 3713.1459764254373, 3718.4980027696183, 3721.0883333583174, 3736.4582135590185, 3744.363458212083, 5076.974615126901, 5129.435762066169, 5164.92252616211, 5214.165733482625, 5214.582833373321, 4786.21027530457, 4792.257200133985, 4796.858057972034, 4801.423829140525, 4810.975945120287, 5537.252470916415, 5556.249906262643, 5557.666540007613, 5572.86067848303, 5583.274174357348, 3953.743006704555, 4107.199096176247, 4115.5678653741525, 4117.876463706094, 4138.737685006072, 5719.799807006776, 5731.824975879935, 5757.251557297566, 5785.82642520725, 5800.187973683687, 4167.395727619478, 4183.222130594485, 4191.455110835572, 4195.0, 4197.685173611992, 4186.0809111752205, 4222.9577704223175, 4228.583424552748, 4244.193603215379, 4254.787260636956, 4741.866160227912, 4747.477777444478, 4758.2386818108935, 4772.665913386099, 4797.856064318076, 5573.27547418833, 5574.247476590689, 5598.964191624481, 5601.60788744784, 5603.719814009283, 1399.4466142581725, 1422.950196743109, 1437.23826372023, 1437.6765227823655, 1439.8344190418027, 1010.7473131717071, 1015.6597539824094, 1022.616518805448, 1028.187731691955, 1028.388109075099, 5245.790168393298, 5257.395399529103, 5277.416774967494, 5281.0, 5294.708791016454, 5468.398476167618, 5494.406622079552, 5515.889682206333, 5545.584081193927, 5571.16151669948, 5210.609204309616, 5248.868778280574, 5261.0, 5317.41508434072, 5489.478499542537, 2970.5098658721067, 2970.673225945144, 2976.64280286367, 2980.672126066131, 2990.8654110565076, 5817.621854579439, 5831.329397119385, 5844.347282948157, 5889.056611318255, 5930.673812940244, 5356.625036247503, 5643.322801263793, 5676.943230567642, 5690.77236910519, 5699.059655156935, 5679.858003549862, 5733.512651424676, 5754.827355179351, 5809.448102430262, 5814.534837213013, 5395.78416863321, 5535.557155427476, 5547.389787123494, 5568.6658800472105, 5657.236273103243, 5553.389517040013, 5595.349371935207, 5612.943870561242, 5617.4101719320515, 5617.775288988558, 5837.322486833268, 5866.064198814296, 5880.294364676266, 5896.616719913192, 5915.881682366243, 3929.6070392960473, 4015.056461731432, 4025.3961905714377, 4035.757854528738, 4053.9391909120795, 5522.751476183501, 5639.577031722555, 5660.575456840671, 5793.79721709755, 5808.709564521672, 5649.887002260014, 5663.801766938137, 5669.376368599368, 5669.546436285004, 5672.14917762339, 5475.67145971243, 5649.350324712546, 5655.575831812713, 5664.207011018379, 5689.516391106802, 5555.861103472445, 5626.521745651666, 5626.774929002794, 5633.492985631313, 5654.46282603152, 5668.461496157858, 5671.376148623565, 5674.829755107354, 5683.232763576864, 5685.34618518859, 5343.519083282367, 5496.268675367247, 5540.612157148961, 5541.702686901287, 5557.888842223214], "value": 4273.474532774606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.2384719891313, 733.1458850439238, 764.7973287078921, 791.9762407127787, 814.2997022560597, 13819.861801381983, 14306.856931430695, 14310.427582896684, 14357.138571685706, 14373.856261437382, 12731.745365092693, 12823.42294596743, 12841.165324253918, 12870.356482175901, 12873.485060597564, 704.5314865614373, 739.5193124469112, 742.4691345687833, 744.4825846037006, 826.6032304493847, 852.6759831264142, 853.9487630742144, 866.1338661338661, 866.3156106675718, 866.5320726807516, 924.7087167542203, 926.3098991251527, 926.4580220570974, 926.4765407544716, 927.248928368024, 923.1045885491063, 923.422860712055, 924.0713083351222, 924.7595625137445, 925.8379783537921, 679.1442782094547, 680.384252251713, 680.9455243580502, 680.9591424514545, 681.0363335879724, 13648.181109133484, 13835.515756948458, 13881.930590347085, 13996.090254133449, 14094.50669226572, 14800.555983320517, 15622.218889055503, 15628.14045227512, 15796.289166987513, 15962.281697323648, 12058.638240852788, 12153.513859445611, 12215.93892030543, 12233.082518811125, 12248.44881980313, 3518.612952575215, 3526.3828829954655, 3536.8938931832085, 3563.768355056913, 3632.1827588792576, 69174.0, 71344.0, 71520.0, 71695.0, 73795.63102184454, 10863.18526110545, 11154.0, 11333.546658133582, 11756.706082347839, 12154.088443366783, 20960.95195240232, 20991.895040524698, 21014.684779728315, 21020.474488137614, 21032.15871365159, 8318.251357377865, 8513.914860851311, 8742.344324175712, 8785.956070219609, 8865.069167737423, 4408.206522825923, 4551.135284295973, 4559.566841150086, 4581.244094724333, 4626.167289887852, 3278.5246139309666, 3396.456566949326, 3397.7111945484417, 3399.337129259771, 3402.914927126792, 587.8148383259345, 587.9970600146972, 594.3580932592789, 600.0009983377628, 617.3024482334932, 592.0645380299117, 614.6926536731634, 638.4541217259176, 688.5283580747205, 697.2295613347279, 8362.782676309691, 8697.869531957025, 8721.56392180401, 8756.912430875736, 9151.98656295614, 689.1282527602486, 689.7918731417245, 692.5533031194851, 699.3529490877006, 707.3280383635464, 4001.47980762499, 4164.541900390955, 4254.744715317029, 4296.0548679290505, 4297.312430011183, 88301.55849220713, 89422.0, 92018.0, 92149.0, 92642.53678731564, 77614.0, 78276.0, 78509.60745196238, 79102.0, 80638.5968070156, 57754.7112264436, 67786.32213677898, 68377.0, 68685.65657171683, 69128.30871691219, 7874.606269686378, 7954.602269886367, 8111.594420278844, 8278.461899976483, 8347.248747612744, 47324.0, 47560.0, 47779.52220477751, 48356.0, 49278.0, 58539.4146058551, 64812.0278195818, 65337.0, 65718.67140664266, 66327.0, 11285.887141128484, 11427.200095993534, 11810.940945295219, 11842.76314473723, 11914.702132446411, 11395.544178232778, 11733.354665493138, 12031.75936481283, 12426.62720118398, 12953.740925181632, 10874.510647020745, 11090.334579925231, 11316.9434152832, 11650.30098194111, 12533.122681412213, 11491.482883270106, 11708.590199342982, 11741.823872642088, 11825.231359961575, 12326.876731232573, 11563.71090722705, 11775.352355620524, 11840.70398240051, 11969.982551483221, 11972.221805582609, 10450.0, 10520.0, 10619.469026548488, 10947.671569852917, 11046.944765276443, 10192.439415832201, 10581.947090264499, 10626.52180651857, 10704.464776760975, 10725.731856703645], "value": 7050.173648139692, "unit": "score"}], "name": "dromaeo_css", "value": 7269.941485802834, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 108.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 108.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 117.0, 153.0, 118.0, 120.0, 123.0, 118.0, 153.0, 119.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 159.0, 160.0, 160.0, 162.0, 161.0, 160.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 131.0, 75.0, 76.0, 76.0, 76.0, 96.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 121.0, 82.0, 82.0, 81.0, 98.0, 82.0, 81.0, 118.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 51.0, 52.0, 53.0, 51.0, 60.0, 51.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 74.0, 74.0, 74.0, 77.0, 73.0, 75.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 132.0, 124.0, 121.0, 123.0, 133.0, 123.0, 156.0, 133.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 159.0, 160.0, 155.0, 157.0, 155.0, 157.0, 153.0, 154.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 65.0, 62.0, 62.0, 62.0, 62.0, 62.0, 67.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1454.8999999999999, "alertThreshold": 2.0}]} 11:59:58 INFO - Return code: 0 11:59:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:58 INFO - # TBPL SUCCESS # 11:59:58 INFO - Running post-action listener: _resource_record_post_action 11:59:58 INFO - [mozharness: 2017-02-09 19:59:58.684314Z] Finished run-tests step (success) 11:59:58 INFO - Running post-run listener: _resource_record_post_run 11:59:58 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 319475712; Read time: 212; Write time: 178496 11:59:58 INFO - TinderboxPrint: CPU usage
13.0% 11:59:58 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 212 11:59:58 INFO - TinderboxPrint: I/O write bytes / time
319,475,712 / 178,496 11:59:58 INFO - TinderboxPrint: CPU idle
8,252.7 (87.0%) 11:59:58 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 11:59:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:59:58 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101269504; Read time: 0; Write time: 58108 11:59:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 218206208; Read time: 212; Write time: 120388 11:59:59 INFO - Running post-run listener: _upload_blobber_files 11:59:59 INFO - Blob upload gear active. 11:59:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:59 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 11:59:59 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:59:59 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:59:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:00 INFO - (blobuploader) - INFO - Done attempting. 12:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:04 INFO - (blobuploader) - INFO - Done attempting. 12:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:05 INFO - (blobuploader) - INFO - Done attempting. 12:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:05 INFO - Return code: 0 12:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a817c7de74841959c7011047bfce1e5a0cce1b992627b432c0033cd2ff83c04a5d73e60a8d8e235f835591557eb6f0cf799a9cd45d545e73af7adf593d9c5e13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f8a5485d1e81e908c66fd21cd6eff6178ce36cda9d9c5abafe4f167358b3e3ec452c34c9b4c8b18a3202643b7b38dcfe97f9b2cedcb1c4be3a9982e77c70d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85835401ea0d2c169f206a8f061af3dc0d453558131b84ed5d37a16a1454d30e73d23e1e36f3c17a1b1bc5f027e53d9e6045e83f6b46fd091205387375238cf"} 12:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:05 INFO - Contents: 12:00:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a817c7de74841959c7011047bfce1e5a0cce1b992627b432c0033cd2ff83c04a5d73e60a8d8e235f835591557eb6f0cf799a9cd45d545e73af7adf593d9c5e13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f8a5485d1e81e908c66fd21cd6eff6178ce36cda9d9c5abafe4f167358b3e3ec452c34c9b4c8b18a3202643b7b38dcfe97f9b2cedcb1c4be3a9982e77c70d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85835401ea0d2c169f206a8f061af3dc0d453558131b84ed5d37a16a1454d30e73d23e1e36f3c17a1b1bc5f027e53d9e6045e83f6b46fd091205387375238cf"} 12:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:05 INFO - Copying logs to upload dir... 12:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.614668 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-09 12:00:04.939568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 12:00:04.944438) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206 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-Beta/sha512/a817c7de74841959c7011047bfce1e5a0cce1b992627b432c0033cd2ff83c04a5d73e60a8d8e235f835591557eb6f0cf799a9cd45d545e73af7adf593d9c5e13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f8a5485d1e81e908c66fd21cd6eff6178ce36cda9d9c5abafe4f167358b3e3ec452c34c9b4c8b18a3202643b7b38dcfe97f9b2cedcb1c4be3a9982e77c70d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85835401ea0d2c169f206a8f061af3dc0d453558131b84ed5d37a16a1454d30e73d23e1e36f3c17a1b1bc5f027e53d9e6045e83f6b46fd091205387375238cf"} build_url:https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/E1OG5v4ZQmucv5WPwm4eLw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a817c7de74841959c7011047bfce1e5a0cce1b992627b432c0033cd2ff83c04a5d73e60a8d8e235f835591557eb6f0cf799a9cd45d545e73af7adf593d9c5e13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f8a5485d1e81e908c66fd21cd6eff6178ce36cda9d9c5abafe4f167358b3e3ec452c34c9b4c8b18a3202643b7b38dcfe97f9b2cedcb1c4be3a9982e77c70d33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b85835401ea0d2c169f206a8f061af3dc0d453558131b84ed5d37a16a1454d30e73d23e1e36f3c17a1b1bc5f027e53d9e6045e83f6b46fd091205387375238cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 12:00:04.971653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 12:00:04.971994) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1486669170.420968-1748740206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 12:00:05.051906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 12:00:05.055256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 12:00:05.055581) ========= ========= Total master_lag: 0.18 =========